Daily Usenet report

Jan 17 04:15:02 -- Jan 18 04:15:02

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Jan 17 04:20:01 newsfeed nnrpd[1273]: web.man.lodz.pl rejected Expiring process 1256
Jan 17 04:20:01 newsfeed nnrpd[1274]: web.man.lodz.pl rejected Expiring process 1256
Jan 17 04:20:01 newsfeed nnrpd[1275]: web.man.lodz.pl rejected Expiring process 1256
Jan 17 04:20:01 newsfeed nnrpd[1279]: web.man.lodz.pl rejected Expiring process 1256
Jan 17 04:20:01 newsfeed nnrpd[1292]: web.man.lodz.pl rejected Expiring process 1256
Jan 17 04:20:02 newsfeed nnrpd[1301]: web.man.lodz.pl rejected Expiring process 1256
Jan 17 04:20:02 newsfeed nnrpd[1305]: web.man.lodz.pl rejected Expiring process 1256
Jan 17 13:10:01 newsfeed pgpverify[20947]: pgpverify: verification failed
Jan 17 17:06:01 newsfeed overchan[986]: input line too long, skipping
Jan 17 20:06:21 newsfeed overchan[986]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2016585 96.9%234.3 MB 96.6%
innfeed 40020 1.9%4.7 MB 1.9%
innd 16349 0.8%2.7 MB 1.1%
nnrpd 7153 0.3%803.3 KB 0.3%
controlchan 4 0.0%0.5 KB 0.0%
overchan 3 0.0%0.7 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 72080115 100.0%242.4 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2006353 98.5%
Negative hits 19297 0.9%
Positive hits 10506 0.5%
Cache misses 464 0.0%
TOTAL: 4 2036620 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:03.116 0.0%147 0.000 21.197 48.667
article cleanup00:00:21.270 0.0%2010178 0.000 0.011 0.026
article logging00:01:13.389 0.1%2010704 0.000 0.036 0.968
article parse00:24:45.837 1.7%64329238 0.000 0.023 0.056
article write00:10:21.786 0.7%2004300 0.152 0.310 1.898
artlog/artcncl00:00:00.007 0.0%143 0.000 0.049 0.500
data move00:00:59.059 0.1%74990086 0.000 0.001 0.021
hisgrep/artcncl00:00:00.714 0.0%145 0.000 4.924 36.000
hishave/artcncl00:00:00.174 0.0%147 0.000 1.184 8.133
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:41:18.432 2.9%2036526 0.028 1.217 23.827
history sync00:00:00.024 0.0%301 0.000 0.080 1.000
history write00:44:52.945 3.1%2006359 0.128 1.342 16.231
hiswrite/artcncl00:00:00.021 0.0%2 0.000 10.500 21.000
idle18:23:09.753 76.6%51026929 0.759 1.297 5078.042
nntp read00:40:01.256 2.8%62649533 0.019 0.038 0.129
overview write00:00:08.618 0.0%2004300 0.000 0.004 0.033
perl filter02:31:22.785 10.5%2006359 1.323 4.527 19.667
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:03:32.725 0.2%4025751 0.008 0.053 0.078
TOTAL: 24:00:05.68523:42:11.911 98.8%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.172 0.0%108510 0.000 0.002 0.009
article prepare00:00:00.002 0.0%10302 0.000 0.000 0.001
article read00:00:15.746 0.0%2565 0.000 6.139 254.800
backlog stats00:00:00.236 0.0%519167 0.000 0.000 0.004
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:03.567 0.0%264372 0.002 0.013 0.032
data write00:00:05.055 0.0%243568 0.008 0.021 0.089
idle23:52:49.255 99.9%519167 17.188 165.591 1295.361
status file00:00:12.871 0.0%13411 0.000 0.960 2.458
TOTAL: 23:53:39.08223:53:26.904100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:40.197 0.0%504200 0.000 0.080 178.000
idle262:48:09.359100.0%507750 0.000 1863.298901971.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:27.566 0.0%1016413 0.000 0.027 1.000
readart00:00:00.469 0.0%67 0.000 7.000 89.000
TOTAL: 262:50:35.170262:49:17.591100.0%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
newsmaster@carnet.hr000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 886 20097762007652 751 1373 99%244:40:28
2news.nask.pl 2 12320 1960 5939 4421 15%23:38:04
3news.icm.edu.pl 42 300 78 207 15 26%15:56:58
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 931 20223962009690 6897 5809 99%284:15:30
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl494.8 GB12.6 MB12.9 MB494.8 GB 99%258.2 KB
2news.nask.pl14.5 MB11.3 MB21.6 MB47.4 MB 30%7.6 KB
3news.icm.edu.pl2.1 MB85.1 KB326.6 KB2.5 MB 84%27.7 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 4494.8 GB23.9 MB34.9 MB494.8 GB 99%257.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 17 04:15:02 - 04:59:59 211 0.0% 0.08716.2 KB 0.0% 0.27
Jan 17 05:00:00 - 05:59:59 317 0.0% 0.091.3 MB 0.0% 0.38
Jan 17 06:00:00 - 06:59:59 30253 1.5% 8.407.5 GB 1.5%2176.31
Jan 17 07:00:00 - 07:59:59 64700 3.2% 17.9721.9 GB 4.4%6373.29
Jan 17 08:00:00 - 08:59:59 68482 3.4% 19.0222.7 GB 4.6%6623.31
Jan 17 09:00:00 - 09:59:59 84349 4.2% 23.4323.1 GB 4.7%6730.46
Jan 17 10:00:00 - 10:59:59 106343 5.3% 29.5421.1 GB 4.3%6154.43
Jan 17 11:00:00 - 11:59:59 83954 4.2% 23.3221.9 GB 4.4%6367.32
Jan 17 12:00:00 - 12:59:59 82802 4.1% 23.0020.3 GB 4.1%5903.52
Jan 17 13:00:00 - 13:59:59 131845 6.6% 36.6227.6 GB 5.6%8026.76
Jan 17 14:00:00 - 14:59:59 117485 5.8% 32.6325.0 GB 5.1%7296.13
Jan 17 15:00:00 - 15:59:59 92569 4.6% 25.7124.6 GB 5.0%7166.76
Jan 17 16:00:00 - 16:59:59 76419 3.8% 21.2321.9 GB 4.4%6386.71
Jan 17 17:00:00 - 17:59:59 86953 4.3% 24.1528.1 GB 5.7%8179.14
Jan 17 18:00:00 - 18:59:59 85681 4.3% 23.8024.3 GB 4.9%7068.47
Jan 17 19:00:00 - 19:59:59 77436 3.9% 21.5122.1 GB 4.5%6437.55
Jan 17 20:00:00 - 20:59:59 79430 4.0% 22.0623.4 GB 4.7%6806.57
Jan 17 21:00:00 - 21:59:59 73184 3.6% 20.3321.0 GB 4.2%6103.36
Jan 17 22:00:00 - 22:59:59 109559 5.5% 30.4322.3 GB 4.5%6501.81
Jan 17 23:00:00 - 23:59:59 144151 7.2% 40.0422.1 GB 4.5%6441.80
Jan 18 00:00:00 - 00:59:59 108919 5.4% 30.2616.4 GB 3.3%4782.92
Jan 18 01:00:00 - 01:59:59 99973 5.0% 27.7724.7 GB 5.0%7199.53
Jan 18 02:00:00 - 02:59:59 99772 5.0% 27.7125.9 GB 5.2%7548.61
Jan 18 03:00:00 - 03:59:59 84585 4.2% 23.5021.1 GB 4.3%6134.16
Jan 18 04:00:00 - 04:15:02 20648 1.0% 22.895.7 GB 1.2%6648.43
TOTAL: 24:00:00 2010020 100.0% 23.26494.6 GB 100.0%6003.14
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 4553 9 0 2578 0 0 0 0 1966
2newsfeed.pionier.net.pl 1851 117 0 1244 2 0 0 0 488
3news.icm.edu.pl 18 0 0 6 0 0 0 0 12
TOTAL: 3 6422 126 0 3828 2 0 0 0 2466

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 40
it.comp.os.win.windows10 23
comp.sys.raspberry-pi 19
comp.mobile.android 17
it.comp.os.win.windows7 11
it.tlc.cellulari.android 9
it.discussioni.energia 3
it.comp.os.linux.ubuntu 2
it.tlc.cellulari.iphone 1
uk.rec.cycling.moderated 1
TOTAL: 10 126

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

GroupsCount
pl.praca.oferowana 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1797
Binary in non-binary group 47
EMP (phl) 45
Scoring filter (8) 17
HTML post 10
Scoring filter (11) 9
Scoring filter (12) 6
Scoring filter (18) 3
Too many newsgroups 2
Scoring filter (9) 2
Scoring filter (10) 2
Scoring filter (13) 1
TOTAL: 12 1941

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 478
news.nask.pl 45
news.icm.edu.pl 2
TOTAL: 3 525
TOTAL: 1 525

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 38160 1266 14227 355 5 36508 3%23:59:58
2poznan 311037 186 2278 4 0 55963 0%23:55:40
3icm 24803 116 16667 6 0 0 0%23:59:57
4nask 10495 7 8992 3 0 0 0%22:52:03
5okapi 0 0 0 0 0 1158 0%23:57:51
TOTAL: 5 384495 1575 42164 368 5 93629 0%118:45:29
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama4.8 MB1.9 MB6.6 MB0.1 KB/s4.2 KB23:59:58
2icm1.7 MB788.6 KB2.4 MB0.0 KB/s20.5 KB23:59:57
3poznan739.0 KB5.1 KB744.1 KB0.0 KB/s3.9 KB23:55:40
4nask147.2 KB6.0 KB153.2 KB0.0 KB/s15.3 KB22:52:03
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
TOTAL: 57.3 MB2.6 MB10.0 MB0.0 KB/s5.3 KB118:45:29
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 294 2424.8 KB 12 0 000:00:16
2az1-ss13.a2hosting.com 2 10.7 KB 1 0 000:00:12
TOTAL: 2 296 2525.5 KB 13 0 0262:50:34

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 582 2424.8 KB 12 0 000:00:21
2*.a2hosting.com 2 10.7 KB 1 0 000:00:12
3unresolved 97 00.0 KB 0 0 000:00:10
4*.consolidated.net 515 00.0 KB 0 0 0262:49:50
TOTAL: 41196 2525.5 KB 13 0 0262:50:34

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
client-66-116-14-174.consolidated.net 29.396 60.460 0.000262:49:50
web.man.lodz.pl 1.244 3.124 0.00000:00:16
az1-ss13.a2hosting.com 0.020 0.012 0.00000:00:12
104.131.145.69 0.008 0.000 0.00000:00:09
mon.man.lodz.pl 1.000 2.672 0.00000:00:04
212.51.192.185 0.348 0.952 0.00000:00:01
TOTAL: 6 32.016 67.220 0.000262:50:34

Curious NNRP server explorers [Top 20]:

SystemConn
client-66-116-14-174.consolidated.net 515
mon.man.lodz.pl 288
212.51.192.185 96
104.131.145.69 1
TOTAL: 4 900

NNRP client timeouts [Top 20]:

SystemConnPeer
client-66-116-14-174.consolidated.net 214 8
TOTAL: 1 214 8

Newsgroup request counts (by category):

CategoryCountPct
1pl 24 96.0%
2lodzman 1 4.0%
TOTAL: 2 25100.0%

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

NewsgroupCount
1pl.comp.pecet 14
2pl.comp.os.ms-windows.winnt 10
3lodzman.test 1
TOTAL: 3 25