Daily Usenet report

May 25 04:15:02 -- May 26 04:15:02

Unknown entries from news log file:

First 16 / 16 lines (100.0%)

May 25 08:38:23 newsfeed overchan[14076]: input line too long, skipping
May 25 08:49:22 newsfeed overchan[14076]: input line too long, skipping
May 25 11:14:32 newsfeed nnrpd[5991]: SERVER perl filter not defined
May 25 12:45:58 newsfeed nnrpd[18161]: SERVER perl filter not defined
May 25 13:06:18 newsfeed nnrpd[20893]: SERVER perl filter not defined
May 25 15:59:36 newsfeed overchan[14076]: input line too long, skipping
May 25 16:23:34 newsfeed overchan[14076]: input line too long, skipping
May 25 16:27:19 newsfeed overchan[14076]: input line too long, skipping
May 25 17:41:04 newsfeed overchan[14076]: input line too long, skipping
May 25 17:45:13 newsfeed overchan[14076]: input line too long, skipping
May 25 18:02:12 newsfeed overchan[14076]: input line too long, skipping
May 25 19:14:47 newsfeed overchan[14076]: input line too long, skipping
May 25 20:04:44 newsfeed overchan[14076]: input line too long, skipping
May 25 20:14:26 newsfeed overchan[14076]: input line too long, skipping
May 25 20:22:31 newsfeed overchan[14076]: input line too long, skipping
May 25 21:56:59 newsfeed overchan[14076]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 531083 90.0%58.0 MB 89.1%
innfeed 45532 7.7%5.3 MB 8.2%
innd 8328 1.4%1.3 MB 2.0%
nnrpd 4936 0.8%524.4 KB 0.8%
overchan 14 0.0%2.4 KB 0.0%
controlchan 3 0.0%0.5 KB 0.0%
TOTAL: 6 589896 100.0%65.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 526868 99.0%
Negative hits 4944 0.9%
Positive hits 336 0.1%
Cache misses 41 0.0%
TOTAL: 4 532189 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:10.184 0.0%127 0.000 80.189 1742.000
article cleanup00:00:07.334 0.0%531158 0.006 0.014 0.022
article logging00:00:27.487 0.0%531618 0.034 0.052 0.185
article parse00:14:39.462 1.0%42866035 0.012 0.021 0.031
article write00:07:27.442 0.5%530898 0.523 0.843 5.089
artlog/artcncl00:00:00.003 0.0%127 0.000 0.024 1.000
data move00:00:35.108 0.0%46698275 0.000 0.001 0.001
hisgrep/artcncl00:00:00.469 0.0%125 0.000 3.752 34.000
hishave/artcncl00:00:00.229 0.0%127 0.000 1.803 17.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup01:50:31.788 7.7%536338 5.396 12.365 69.274
history sync00:00:00.028 0.0%291 0.000 0.096 0.500
history write02:41:38.925 11.2%531099 11.752 18.262 124.781
hiswrite/artcncl00:00:00.014 0.0%2 0.000 7.000 14.000
idle17:14:21.178 71.8%41964121 0.961 1.479 9.283
nntp read00:29:56.580 2.1%42583381 0.030 0.042 0.056
overview write00:00:02.901 0.0%530898 0.002 0.005 0.009
perl filter01:07:51.799 4.7%531099 5.744 7.667 9.634
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:31.716 0.0%1077812 0.021 0.029 0.040
TOTAL: 24:00:20.52023:48:22.647 99.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.152 0.0%55680 0.000 0.003 0.052
article prepare00:00:00.001 0.0%3626 0.000 0.000 0.021
article read00:00:18.641 0.0%909 0.000 20.507 277.455
backlog stats00:00:00.093 0.0%116872 0.000 0.001 0.004
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:01.118 0.0%59786 0.005 0.019 0.045
data write00:00:02.795 0.0%43905 0.021 0.064 0.113
idle23:53:34.488 99.9%116872 473.826 735.972 1353.412
status file00:00:46.453 0.1%17227 0.602 2.697 141.300
TOTAL: 23:54:49.99023:54:43.741100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:17:24.504 98.8%3122 0.000 334.562 70507.286
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.253 0.0%6990 0.000 0.036 0.667
readart00:00:00.106 0.0%82 0.000 1.293 9.400
TOTAL: 00:17:36.66800:17:24.863 98.9%----

Control commands to INND:

CommandNumber
L 1
flush 27
flushlogs 2
go 2
logmode 2
mode 149
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 193

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
news@sfere.anjou.terraraq.org.uk001001
TOTAL001001

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 123 530614 530377 4 233 99%96:30:48
2news.icm.edu.pl 43 253 39 187 27 15%15:55:16
3localhost 1443 3 3 0 0 100%00:00:02
TOTAL: 3 1609 530870 530419 191 260 99%112:26:06
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl229.1 GB2.8 MB3.3 MB229.1 GB 99%452.7 KB
2news.icm.edu.pl1.1 MB217.8 KB358.9 KB1.7 MB 66%25.9 KB
3localhost4.1 KB0.0 KB0.0 KB4.1 KB100%1.4 KB
TOTAL: 3229.1 GB3.0 MB3.7 MB229.1 GB 99%452.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 25 04:15:02 - 04:59:59 16320 3.1% 6.057.5 GB 3.3%2906.73
May 25 05:00:00 - 05:59:59 22185 4.2% 6.1610.3 GB 4.5%3003.44
May 25 06:00:00 - 06:59:59 19103 3.6% 5.318.6 GB 3.7%2502.57
May 25 07:00:00 - 07:59:59 19489 3.7% 5.419.3 GB 4.1%2717.81
May 25 08:00:00 - 08:59:59 21174 4.0% 5.8810.5 GB 4.6%3051.65
May 25 09:00:00 - 09:59:59 23659 4.5% 6.5710.2 GB 4.4%2966.90
May 25 10:00:00 - 10:59:59 23525 4.4% 6.5310.0 GB 4.4%2916.03
May 25 11:00:00 - 11:59:59 25669 4.8% 7.1311.1 GB 4.8%3227.57
May 25 12:00:00 - 12:59:59 24511 4.6% 6.819.8 GB 4.3%2855.85
May 25 13:00:00 - 13:59:59 23745 4.5% 6.609.1 GB 4.0%2655.08
May 25 14:00:00 - 14:59:59 23190 4.4% 6.449.5 GB 4.1%2753.24
May 25 15:00:00 - 15:59:59 21285 4.0% 5.918.6 GB 3.8%2518.40
May 25 16:00:00 - 16:59:59 24640 4.6% 6.8410.0 GB 4.3%2904.15
May 25 17:00:00 - 17:59:59 26456 5.0% 7.3510.5 GB 4.6%3066.95
May 25 18:00:00 - 18:59:59 24265 4.6% 6.749.7 GB 4.2%2827.38
May 25 19:00:00 - 19:59:59 23882 4.5% 6.6310.5 GB 4.6%3065.41
May 25 20:00:00 - 20:59:59 22439 4.2% 6.239.8 GB 4.3%2861.80
May 25 21:00:00 - 21:59:59 22406 4.2% 6.229.7 GB 4.2%2821.67
May 25 22:00:00 - 22:59:59 21360 4.0% 5.939.6 GB 4.2%2785.52
May 25 23:00:00 - 23:59:59 19755 3.7% 5.498.2 GB 3.6%2398.08
May 26 00:00:00 - 00:59:59 22366 4.2% 6.219.5 GB 4.1%2755.02
May 26 01:00:00 - 01:59:59 19419 3.7% 5.398.4 GB 3.7%2450.16
May 26 02:00:00 - 02:59:59 16134 3.0% 4.487.4 GB 3.2%2158.19
May 26 03:00:00 - 03:59:59 18504 3.5% 5.149.0 GB 3.9%2623.40
May 26 04:00:00 - 04:15:02 4753 0.9% 5.272.5 GB 1.1%2930.46
TOTAL: 24:00:00 530234 100.0% 6.14229.3 GB 100.0%2783.29
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 690 187 0 44 3 0 0 0 456
2news.icm.edu.pl 28 0 0 16 0 0 0 0 12
TOTAL: 2 718 187 0 60 3 0 0 0 468

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 112
it.tlc.cellulari.android 32
comp.sys.raspberry-pi 15
comp.mobile.android 14
nl.comp.os.linux.techniek 7
de.comp.office-pakete.ms-office.outlook 3
it.comp.os.win.windows10 2
it.comp.os.win.windows7 1
hr.ponuda.hardver.komponente 1
TOTAL: 9 187

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
pl.praca.oferowana 3
TOTAL: 1 3

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 8
Too many newsgroups 1
EMP (md5) 1
Scoring filter (9) 1
TOTAL: 4 11

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 456
news.icm.edu.pl 1
TOTAL: 2 457
TOTAL: 1 457

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 43970 361 14985 164 5 40352 0%23:59:58
2icm 19657 51 15395 3 0 0 0%24:04:47
3poznan 34 0 25 0 0 0 0%03:48:44
4nask 0 0 0 0 0 10587 0%24:05:39
5okapi 0 0 0 0 0 1017 0%23:57:51
TOTAL: 5 63661 412 30405 167 5 51956 0%99:56:59
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama1014.5 KB553.7 KB1.5 MB0.0 KB/s3.0 KB23:59:58
2icm194.4 KB21.8 KB216.2 KB0.0 KB/s4.0 KB24:04:47
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s003:48:44
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:39
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
TOTAL: 51.2 MB575.6 KB1.7 MB0.0 KB/s3.1 KB99:56:59
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 7297.8 KB 26 0 000:00:29
2user-5-173-181-26.play-internet.pl 2 1013.1 KB 1 0 000:16:27
3isvcs01.man.lodz.pl 3 00.0 KB 0 3 000:00:00
TOTAL: 3 293 82111.0 KB 27 3 000:17:36

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 579 7297.8 KB 26 3 000:00:32
2*.play-internet.pl 2 1013.1 KB 1 0 000:16:27
3unresolved 101 00.0 KB 0 0 000:00:14
4*.bstnma.fios.verizon.net 3 00.0 KB 0 0 000:00:22
TOTAL: 4 685 82111.0 KB 27 3 000:17:36

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
user-5-173-181-26.play-internet.pl 0.020 0.016 0.00000:16:27
web.man.lodz.pl 1.380 2.476 0.00000:00:29
pool-173-48-57-54.bstnma.fios.verizon.net 0.028 0.028 0.00000:00:22
162.243.144.26 0.004 0.008 0.00000:00:09
80.111.142.213 0.028 0.040 0.00000:00:03
mon.man.lodz.pl 1.296 2.024 0.00000:00:02
212.51.192.185 0.432 0.704 0.00000:00:00
isvcs01.man.lodz.pl 0.040 0.036 0.00000:00:00
TOTAL: 8 3.228 5.332 0.00000:17:36

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
pool-173-48-57-54.bstnma.fios.verizon.net 3
162.243.144.26 1
TOTAL: 5 392

NNRP client timeouts [Top 20]:

SystemConnPeer
pool-173-48-57-54.bstnma.fios.verizon.net 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 72 87.8%
2lodman 10 12.2%
TOTAL: 2 82100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

NewsgroupCount
1pl.comp.pecet 64
2lodman.info 10
3pl.comp.os.ms-windows.winnt 6
4pl.internet.polip 2
TOTAL: 4 82