Daily Usenet report

Oct 10 04:15:02 -- Oct 11 04:15:02

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Oct 10 04:20:44 newsfeed nnrpd[7233]: mon.man.lodz.pl rejected Expiring process 7141
Oct 10 08:35:39 newsfeed overchan[6906]: input line too long, skipping
Oct 10 08:56:16 newsfeed nnrpd[17852]: SERVER perl filter not defined
Oct 10 15:14:01 newsfeed overchan[6906]: input line too long, skipping
Oct 10 18:14:19 newsfeed overchan[6906]: input line too long, skipping
Oct 10 18:30:08 newsfeed nnrpd[4669]: SERVER perl filter not defined
Oct 10 18:35:23 newsfeed overchan[6906]: input line too long, skipping
Oct 10 18:40:28 newsfeed overchan[6906]: input line too long, skipping
Oct 10 19:30:20 newsfeed overchan[6906]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn1859671 96.7%214.2 MB 96.4%
innfeed 46808 2.4%5.5 MB 2.5%
innd 10698 0.6%1.9 MB 0.8%
nnrpd 5904 0.3%628.3 KB 0.3%
overchan 7 0.0%1.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 61923089 100.0%222.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1854830 99.5%
Negative hits 8949 0.5%
Positive hits 228 0.0%
Cache misses 36 0.0%
TOTAL: 4 1864043 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.181 0.0%98 0.000 12.051 218.000
article cleanup00:00:26.226 0.0%1858945 0.010 0.014 0.021
article logging00:01:25.775 0.1%1859375 0.031 0.046 0.069
article parse00:26:56.224 1.9%54602348 0.015 0.030 0.046
article write00:11:43.512 0.8%1858640 0.156 0.379 0.858
artlog/artcncl00:00:00.003 0.0%98 0.000 0.031 1.000
data move00:01:07.194 0.1%63432880 0.001 0.001 0.002
hisgrep/artcncl00:00:00.182 0.0%94 0.000 1.936 19.000
hishave/artcncl00:00:00.087 0.0%98 0.000 0.888 9.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:40:17.759 2.8%1868405 0.047 1.294 9.308
history sync00:00:00.021 0.0%291 0.000 0.072 2.000
history write00:59:51.405 4.2%1858917 0.167 1.932 9.602
hiswrite/artcncl00:00:00.011 0.0%4 0.000 2.750 9.000
idle17:18:24.324 72.1%48940606 0.503 1.273 2.459
nntp read00:44:48.175 3.1%53123228 0.033 0.051 0.068
overview write00:00:10.757 0.0%1858640 0.004 0.006 0.009
perl filter03:11:56.283 13.3%1858917 3.910 6.195 10.726
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:01:49.557 0.1%3732047 0.022 0.029 0.039
TOTAL: 24:00:04.07723:38:58.676 98.5%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.171 0.0%51729 0.000 0.003 0.015
article prepare00:00:00.003 0.0%4656 0.000 0.001 0.042
article read00:00:16.736 0.0%1161 0.000 14.415 227.750
backlog stats00:00:00.144 0.0%123783 0.000 0.001 0.006
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:01.367 0.0%60580 0.006 0.023 0.049
data write00:00:03.423 0.0%45895 0.027 0.075 0.175
idle23:53:45.289 99.9%123783 497.948 694.969 1265.525
status file00:00:19.128 0.0%16469 0.717 1.161 3.240
TOTAL: 23:54:33.23023:54:26.261100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:19:41.050 98.9%3358 0.000 351.712344791.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.307 0.0%7542 0.000 0.041 0.667
readart00:00:00.000 0.0%34 0.000 0.000 0.000
TOTAL: 00:19:53.97600:19:41.357 98.9%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 139 18590241858735 0 289 99%87:49:55
2news.icm.edu.pl 42 189 30 143 16 15%13:22:56
3localhost 3 2 2 0 0 100%00:00:00
TOTAL: 3 184 18592151858767 143 305 99%101:12:51
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl375.3 GB2.0 MB2.6 MB375.3 GB 99%211.7 KB
2news.icm.edu.pl1.1 MB29.2 KB414.4 KB1.5 MB 71%33.5 KB
3localhost2.9 KB0.0 KB0.0 KB2.9 KB100%1.5 KB
TOTAL: 3375.3 GB2.0 MB3.0 MB375.3 GB 99%211.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 10 04:15:02 - 04:59:59 31860 1.7% 11.819.6 GB 2.6%3745.05
Oct 10 05:00:00 - 05:59:59 49799 2.7% 13.8314.0 GB 3.7%4066.66
Oct 10 06:00:00 - 06:59:59 65913 3.5% 18.3113.5 GB 3.6%3927.70
Oct 10 07:00:00 - 07:59:59 34016 1.8% 9.4510.9 GB 2.9%3163.70
Oct 10 08:00:00 - 08:59:59 30278 1.6% 8.4112.4 GB 3.3%3603.89
Oct 10 09:00:00 - 09:59:59 36330 2.0% 10.0911.0 GB 2.9%3214.88
Oct 10 10:00:00 - 10:59:59 36446 2.0% 10.1210.4 GB 2.8%3037.61
Oct 10 11:00:00 - 11:59:59 38350 2.1% 10.6512.6 GB 3.3%3667.73
Oct 10 12:00:00 - 12:59:59 59155 3.2% 16.4313.3 GB 3.5%3879.83
Oct 10 13:00:00 - 13:59:59 195912 10.5% 54.4221.5 GB 5.7%6269.12
Oct 10 14:00:00 - 14:59:59 115458 6.2% 32.0718.9 GB 5.0%5503.89
Oct 10 15:00:00 - 15:59:59 119237 6.4% 33.1219.0 GB 5.0%5540.53
Oct 10 16:00:00 - 16:59:59 90949 4.9% 25.2617.2 GB 4.6%4995.98
Oct 10 17:00:00 - 17:59:59 91511 4.9% 25.4216.3 GB 4.3%4739.68
Oct 10 18:00:00 - 18:59:59 68421 3.7% 19.0116.5 GB 4.4%4791.90
Oct 10 19:00:00 - 19:59:59 71624 3.9% 19.9020.0 GB 5.3%5819.83
Oct 10 20:00:00 - 20:59:59 71738 3.9% 19.9313.5 GB 3.6%3929.54
Oct 10 21:00:00 - 21:59:59 99412 5.3% 27.6114.4 GB 3.8%4185.56
Oct 10 22:00:00 - 22:59:59 79643 4.3% 22.1227.1 GB 7.2%7880.96
Oct 10 23:00:00 - 23:59:59 84260 4.5% 23.4123.0 GB 6.1%6700.99
Oct 11 00:00:00 - 00:59:59 71349 3.8% 19.8214.9 GB 4.0%4350.25
Oct 11 01:00:00 - 01:59:59 60555 3.3% 16.8212.1 GB 3.2%3529.97
Oct 11 02:00:00 - 02:59:59 153382 8.3% 42.6117.5 GB 4.6%5102.33
Oct 11 03:00:00 - 03:59:59 79649 4.3% 22.1213.8 GB 3.7%4010.05
Oct 11 04:00:00 - 04:15:02 23591 1.3% 26.153.6 GB 0.9%4130.74
TOTAL: 24:00:00 1858838 100.0% 21.51376.8 GB 100.0%4573.09
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 719 258 0 25 6 0 0 0 430
2news.icm.edu.pl 16 0 0 3 0 0 0 0 13
TOTAL: 2 735 258 0 28 6 0 0 0 443

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 169
it.tlc.cellulari.android 33
comp.mobile.ipad 22
it.comp.os.win.windows10 20
comp.mobile.android 9
de.comp.office-pakete.ms-office.word 2
comp.sys.raspberry-pi 1
de.rec.sf.startrek 1
de.comp.lang.vbclassic 1
TOTAL: 9 258

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

GroupsCount
pl.praca.oferowana 6
TOTAL: 1 6

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 11
Binary in non-binary group 1
Scoring filter (8) 1
TOTAL: 3 13

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 430
TOTAL: 1 430
TOTAL: 1 430

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 23111 345 14209 16 0 2 1%23:59:58
2panorama 40651 252 13063 87 4 38541 0%23:59:58
3poznan 37 0 26 0 0 0 0%03:16:13
4okapi 0 0 0 0 0 1103 0%23:57:50
5nask 0 0 0 0 0 9687 0%23:57:50
TOTAL: 5 63799 597 27298 103 4 49333 0%99:11:49
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm938.8 KB74.6 KB1013.4 KB0.0 KB/s2.8 KB23:59:58
2panorama672.6 KB268.5 KB941.1 KB0.0 KB/s2.8 KB23:59:58
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s003:16:13
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:50
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:50
TOTAL: 51.6 MB343.1 KB1.9 MB0.0 KB/s2.8 KB99:11:49
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 3435.1 KB 17 0 000:00:15
2isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:00
TOTAL: 2 290 3435.1 KB 17 2 000:19:53

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 579 3435.1 KB 17 2 000:00:19
2*.hsd1.ca.comcast.net 1 00.0 KB 0 0 000:00:31
3*.hsd1.tx.comcast.net 1 00.0 KB 0 0 000:00:31
4unresolved 293 00.0 KB 0 0 000:00:45
5*.core.ynet.pl 1 00.0 KB 0 0 000:17:14
6*.telpol.net.pl 1 00.0 KB 0 0 000:00:31
TOTAL: 6 876 3435.1 KB 17 2 000:19:53

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
dezerter-58.core.ynet.pl 0.032 0.012 0.00000:17:14
60.48.82.143 0.008 0.016 0.00000:00:32
c-73-55-128-179.hsd1.tx.comcast.net 0.000 0.024 0.00000:00:31
c-76-20-82-50.hsd1.ca.comcast.net 0.000 0.024 0.00000:00:31
host-n4-89-241.telpol.net.pl 0.000 0.012 0.00000:00:31
web.man.lodz.pl 1.712 4.256 0.00000:00:15
92.116.39.188 0.680 2.080 0.00000:00:09
mon.man.lodz.pl 1.536 4.312 0.00000:00:03
80.111.142.213 0.024 0.060 0.00000:00:02
212.51.192.185 0.404 1.368 0.00000:00:00
isvcs01.man.lodz.pl 0.020 0.040 0.00000:00:00
185.175.93.106 0.008 0.032 0.00000:00:00
? 0.008 0.012 0.00000:00:00
TOTAL: 13 4.432 12.248 0.00000:19:53

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 289
92.116.39.188 190
212.51.192.185 96
80.111.142.213 4
185.175.93.106 2
dezerter-58.core.ynet.pl 1
c-76-20-82-50.hsd1.ca.comcast.net 1
host-n4-89-241.telpol.net.pl 1
60.48.82.143 1
c-73-55-128-179.hsd1.tx.comcast.net 1
TOTAL: 10 586

NNRP gethostbyaddr failures [Top 20]:

SystemConn
? (can't getpeername) 1
TOTAL: 1 1

NNRP unrecognized commands (by host):

SystemConn
c-73-55-128-179.hsd1.tx.comcast.net 10
60.48.82.143 10
host-n4-89-241.telpol.net.pl 10
c-76-20-82-50.hsd1.ca.comcast.net 10
185.175.93.106 2
TOTAL: 5 42

NNRP unrecognized commands (by command):

CommandCount
Authorization: Basic YWRtaW46ezEyMjEzQkQ... 4
Connection: close 4
Content-Length: 586 4
Cache-Control: max-age=0 4
Accept-Language: en-us 4
Accept: */* 4
User-Agent: ApiTool 4
Content-Type: text/xml 4
Accept-Encoding: identity 4
Host: 212.191.2.21 2
#003 2
Host: 112.169.10.186 1
Host: 193.92.77.136 1
TOTAL: 13 42

NNRP client timeouts [Top 20]:

SystemConnPeer
185.175.93.106 2 2
TOTAL: 1 2 2

Newsgroup request counts (by category):

CategoryCountPct
1pl 34100.0%
TOTAL: 1 34100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 22
2pl.comp.pecet 12
TOTAL: 2 34