Daily Usenet report

May 5 04:15:02 -- May 6 04:15:02

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

May 5 08:21:35 newsfeed overchan[2311]: input line too long, skipping
May 5 13:26:33 newsfeed overchan[2311]: input line too long, skipping
May 5 13:55:33 newsfeed innd: getaddrinfo failed: Name or service not known
May 5 18:23:38 newsfeed overchan[2286]: input line too long, skipping
May 5 22:15:19 newsfeed nnrpd[19886]: SERVER perl filter not defined
May 5 23:08:08 newsfeed nnrpd[21755]: SERVER perl filter not defined
May 6 01:50:30 newsfeed nnrpd[27349]: SERVER perl filter not defined
May 6 01:53:18 newsfeed nnrpd[27353]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn1485036 98.1%170.8 MB 97.6%
innd 14293 0.9%2.3 MB 1.3%
innfeed 7752 0.5%1.1 MB 0.6%
nnrpd 7051 0.5%750.1 KB 0.4%
overchan 3 0.0%0.4 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 61514136 100.0%174.9 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1480532 97.6%
Positive hits 18872 1.2%
Negative hits 17375 1.1%
Cache misses 116 0.0%
TOTAL: 4 1516895 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.984 0.0%282 0.000 3.489 121.000
article cleanup00:00:17.687 0.0%1484318 0.000 0.012 0.041
article logging00:00:46.803 0.1%1484454 0.009 0.032 0.102
article parse00:32:57.200 2.3%72682569 0.017 0.027 0.049
article write00:14:05.339 1.0%1479662 0.197 0.571 2.201
artlog/artcncl00:00:00.005 0.0%273 0.000 0.018 1.000
data move00:00:59.330 0.1%81898531 0.000 0.001 0.003
hisgrep/artcncl00:00:00.263 0.0%253 0.000 1.040 43.000
hishave/artcncl00:00:00.067 0.0%282 0.000 0.238 9.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:08:28.948 0.6%1517387 0.019 0.335 5.658
history sync00:00:00.020 0.0%355 0.000 0.056 1.000
history write00:13:41.577 1.0%1481269 0.100 0.555 8.388
hiswrite/artcncl00:00:00.004 0.0%29 0.000 0.138 1.000
idle18:46:38.331 78.3%62307725 0.515 1.085 47.096
nntp read00:27:49.406 1.9%71664939 0.017 0.023 0.037
overview write00:00:09.908 0.0%1479662 0.000 0.007 0.030
perl filter03:18:19.592 13.8%1481269 4.511 8.033 11.634
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:03:11.969 0.2%3008970 0.043 0.064 0.140
TOTAL: 23:59:26.98923:47:27.433 99.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.206 0.0%49629 0.000 0.004 1.000
article prepare00:00:00.009 0.0%47340 0.000 0.000 0.062
article read00:00:01.581 0.0%11452 0.000 0.138 1.000
backlog stats00:00:00.215 0.0%349859 0.000 0.001 1.000
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.564 0.0%206482 0.000 0.012 1.000
data write00:00:09.719 0.0%165232 0.000 0.059 2.500
idle23:57:38.332100.0%349859 0.000 246.552 14070.000
status file00:00:00.247 0.0%307 0.000 0.805 2.500
TOTAL: 23:58:00.33623:57:52.873100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.007 0.0%50 0.067 0.140 0.250
idle02:21:10.283 99.7%43769 0.000 193.522450029.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.762 0.0%89370 0.000 0.020 0.500
readart00:00:00.498 0.0%445 0.000 1.119 15.750
TOTAL: 02:21:34.13202:21:12.550 99.7%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 455 14805831475950 286 4347 99%138:28:20
2news.nask.pl 3 18674 3579 14796 299 19%23:31:11
3news.icm.edu.pl 38 309 31 262 16 10%18:08:55
4localhost 5 4 4 0 0 100%00:00:00
TOTAL: 4 501 14995701479564 15344 4662 98%180:08:26
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl445.0 GB11.6 MB229.5 MB445.3 GB 99%315.4 KB
2news.nask.pl13.6 MB749.0 KB867.9 KB15.2 MB 89%4.0 KB
3news.icm.edu.pl754.3 KB444.6 KB621.5 KB1.8 MB 41%38.7 KB
4localhost6.4 KB0.0 KB0.0 KB6.4 KB100%1.6 KB
TOTAL: 4445.1 GB12.7 MB230.9 MB445.3 GB 99%314.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 5 04:15:02 - 04:59:59 41861 2.8% 15.5214.6 GB 3.3%5684.69
May 5 05:00:00 - 05:59:59 33712 2.3% 9.3610.0 GB 2.2%2911.88
May 5 06:00:00 - 06:59:59 44213 3.0% 12.2815.3 GB 3.4%4458.41
May 5 07:00:00 - 07:59:59 66493 4.5% 18.4723.7 GB 5.3%6909.83
May 5 08:00:00 - 08:59:59 64244 4.3% 17.8523.0 GB 5.2%6701.18
May 5 09:00:00 - 09:59:59 25486 1.7% 7.088.6 GB 1.9%2491.47
May 5 10:00:00 - 10:59:59 11049 0.7% 3.071.7 GB 0.4% 483.68
May 5 11:00:00 - 11:59:59 11951 0.8% 3.321.6 GB 0.4% 465.41
May 5 12:00:00 - 12:59:59 12190 0.8% 3.392.0 GB 0.4% 581.19
May 5 13:00:00 - 13:59:59 39162 2.6% 10.8811.5 GB 2.6%3358.30
May 5 14:00:00 - 14:59:59 52720 3.6% 14.6416.3 GB 3.7%4756.00
May 5 15:00:00 - 15:59:59 76232 5.2% 21.1824.1 GB 5.4%7005.11
May 5 16:00:00 - 16:59:59 70295 4.7% 19.5324.0 GB 5.4%6993.44
May 5 17:00:00 - 17:59:59 81487 5.5% 22.6425.8 GB 5.8%7527.66
May 5 18:00:00 - 18:59:59 84616 5.7% 23.5026.8 GB 6.0%7816.76
May 5 19:00:00 - 19:59:59 92496 6.2% 25.6926.8 GB 6.0%7811.45
May 5 20:00:00 - 20:59:59 98245 6.6% 27.2926.7 GB 6.0%7778.92
May 5 21:00:00 - 21:59:59 99139 6.7% 27.5426.7 GB 6.0%7775.61
May 5 22:00:00 - 22:59:59 68502 4.6% 19.0319.4 GB 4.4%5663.33
May 5 23:00:00 - 23:59:59 64145 4.3% 17.8217.4 GB 3.9%5067.82
May 6 00:00:00 - 00:59:59 79313 5.4% 22.0320.5 GB 4.6%5980.99
May 6 01:00:00 - 01:59:59 104245 7.0% 28.9628.3 GB 6.4%8248.28
May 6 02:00:00 - 02:59:59 56223 3.8% 15.6216.8 GB 3.8%4887.16
May 6 03:00:00 - 03:59:59 81142 5.5% 22.5426.1 GB 5.9%7615.54
May 6 04:00:00 - 04:15:02 20808 1.4% 23.076.6 GB 1.5%7701.93
TOTAL: 24:00:00 1479969 100.0% 17.13444.5 GB 100.0%5394.98
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 4472 168 0 2781 1 0 0 0 1522
2news.nask.pl 306 16 0 261 7 0 0 0 22
3news.icm.edu.pl 16 0 0 9 0 0 0 0 7
TOTAL: 3 4794 184 0 3051 8 0 0 0 1551

Unwanted newsgroups [Top 20]:

NewsgroupCount
it.tlc.cellulari.android 50
uk.railway 40
comp.mobile.ipad 31
comp.mobile.android 17
it.comp.os.win.windows7 8
uk.rec.cycling.moderated 7
it.comp.os.win.windows8 6
alt.sex.telephones 5
hr.ponuda.hardver.komponente 5
de.rec.sf.startrek 4
nl.actueel 4
hr.alt.cellular.gsm.android 3
comp.sys.raspberry-pi 2
hr.ponuda.hardver.periferije 1
nl.comp.sys.android 1
TOTAL: 15 184

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

GroupsCount
pl.sci.historia 7
pl.praca.oferowana 1
TOTAL: 2 8

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 1393
EMP (md5) 12
HTML post 4
Scoring filter (8) 2
Too many newsgroups 2
EMP (fsl) 1
Attached HTML file 1
TOTAL: 7 1415

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 49060 2762 30062 4452 0 9 5%23:43:58
2panorama 61294 2752 46338 325 0 0 4%23:47:46
3nask 31895 270 16465 1091 0 0 0%23:41:21
4poznan 5439 89 3483 42 0 0 1%23:46:49
5okapi 0 0 0 0 0 3315 0%23:50:01
TOTAL: 5 147688 5873 96348 5910 0 3324 3%118:49:55
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm290.1 MB894.2 MB1.2 GB14.2 KB/s168.1 KB23:43:58
2panorama10.5 MB1.5 MB12.1 MB0.1 KB/s4.0 KB23:47:46
3nask2.3 MB267.7 MB270.0 MB3.2 KB/s203.2 KB23:41:21
4poznan461.8 KB115.5 KB577.2 KB0.0 KB/s4.4 KB23:46:49
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:01
TOTAL: 5303.3 MB1.1 GB1.4 GB3.5 KB/s127.5 KB118:49:55
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1pc-skrzep2.cm.p.lodz.pl 288 336465.5 KB 288 0 000:00:06
2auriga.rz.izeto.pl 2 58129.9 KB 2 0 000:02:04
3web.man.lodz.pl 288 4641.5 KB 21 0 000:00:30
4pc-vicki.man.lodz.pl 3 58.2 KB 2 0 001:00:36
5isvcs01.man.lodz.pl 4 00.0 KB 0 4 000:00:00
TOTAL: 5 585 445645.1 KB 313 4 002:21:33

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 288 336465.5 KB 288 0 000:00:06
2*.rz.izeto.pl 2 58129.9 KB 2 0 000:02:04
3*.man.lodz.pl 679 5149.7 KB 23 4 001:01:11
4*.elsnet.pl 2 00.0 KB 0 0 000:00:14
5unresolved 4 00.0 KB 0 0 001:17:53
6*.toya.net.pl 46 00.0 KB 0 0 000:00:02
TOTAL: 61021 445645.1 KB 313 4 002:21:33

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
89.38.41.242 2.287 3.019 0.00001:17:53
pc-vicki.man.lodz.pl 0.011 0.026 0.00001:00:36
auriga.rz.izeto.pl 0.016 0.035 0.00000:02:04
web.man.lodz.pl 1.210 2.670 0.00000:00:30
host227.elsnet.pl 0.007 0.021 0.00000:00:14
pc-skrzep2.cm.p.lodz.pl 1.048 2.700 0.00000:00:06
mon.man.lodz.pl 1.135 2.368 0.00000:00:03
staticline41435.toya.net.pl 0.225 0.407 0.00000:00:02
david.man.lodz.pl 0.372 0.786 0.00000:00:01
isvcs01.man.lodz.pl 0.032 0.040 0.00000:00:00
? 0.003 0.027 0.00000:00:00
TOTAL: 11 6.346 12.099 0.00002:21:33

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
staticline41435.toya.net.pl 46
89.38.41.242 4
host227.elsnet.pl 2
TOTAL: 5 436

NNRP gethostbyaddr failures [Top 20]:

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

NNRP client timeouts [Top 20]:

SystemConnPeer
pc-vicki.man.lodz.pl 2 1
TOTAL: 1 2 1

Newsgroup request counts (by category):

CategoryCountPct
1lodman 394 88.5%
2pl 51 11.5%
TOTAL: 2 445100.0%

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

NewsgroupCount
1lodman.info 394
2pl.comp.pecet 24
3pl.comp.os.ms-windows.winnt 22
4pl.sci.medycyna 5
TOTAL: 4 445