Daily Usenet report

Aug 25 04:15:01 -- Aug 26 04:15:02

Unknown entries from news log file:

First 31 / 31 lines (100.0%)

Aug 25 06:00:05 newsfeed overchan[503989]: input line too long, skipping
Aug 25 10:41:54 newsfeed overchan[503989]: input line too long, skipping
Aug 25 11:15:06 newsfeed overchan[503989]: input line too long, skipping
Aug 25 11:15:21 newsfeed overchan[503989]: input line too long, skipping
Aug 25 11:16:36 newsfeed overchan[503989]: input line too long, skipping
Aug 25 11:17:12 newsfeed overchan[503989]: input line too long, skipping
Aug 25 12:39:14 newsfeed nnrpd[527214]: SERVER perl filter not defined
Aug 25 13:01:51 newsfeed overchan[503989]: input line too long, skipping
Aug 25 14:45:34 newsfeed nnrpd[532891]: SERVER perl filter not defined
Aug 25 14:59:17 newsfeed nnrpd[533360]: SERVER perl filter not defined
Aug 25 15:09:54 newsfeed overchan[503989]: input line too long, skipping
Aug 25 15:44:18 newsfeed overchan[503989]: input line too long, skipping
Aug 25 15:48:23 newsfeed overchan[503989]: input line too long, skipping
Aug 25 15:58:43 newsfeed overchan[503989]: input line too long, skipping
Aug 25 16:24:41 newsfeed overchan[503989]: input line too long, skipping
Aug 25 16:44:45 newsfeed overchan[503989]: input line too long, skipping
Aug 25 18:46:25 newsfeed nnrpd[543423]: SERVER perl filter not defined
Aug 25 19:01:13 newsfeed overchan[503989]: input line too long, skipping
Aug 25 21:25:15 newsfeed overchan[503989]: input line too long, skipping
Aug 25 21:25:37 newsfeed overchan[503989]: input line too long, skipping
Aug 25 22:35:34 newsfeed overchan[503989]: input line too long, skipping
Aug 25 23:13:45 newsfeed nnrpd[555175]: SERVER perl filter not defined
Aug 26 00:10:14 newsfeed overchan[503989]: input line too long, skipping
Aug 26 00:10:27 newsfeed overchan[503989]: input line too long, skipping
Aug 26 00:10:41 newsfeed overchan[503989]: input line too long, skipping
Aug 26 01:06:04 newsfeed overchan[503989]: input line too long, skipping
Aug 26 01:06:17 newsfeed overchan[503989]: input line too long, skipping
Aug 26 01:06:32 newsfeed overchan[503989]: input line too long, skipping
Aug 26 01:51:31 newsfeed overchan[503989]: input line too long, skipping
Aug 26 01:52:57 newsfeed overchan[503989]: input line too long, skipping
Aug 26 03:10:43 newsfeed overchan[503989]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 177356 94.0%20.5 MB 94.6%
nnrpd 7671 4.1%773.1 KB 3.5%
innd 2167 1.1%254.8 KB 1.1%
innfeed 1440 0.8%165.5 KB 0.7%
overchan 28 0.0%2.9 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 188663 100.0%21.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 176386 98.4%
Negative hits 2435 1.4%
Positive hits 407 0.2%
Cache misses 39 0.0%
TOTAL: 4 179267 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.057 0.0%74 0.000 14.284 38.333
article cleanup00:00:00.956 0.0%176725 0.000 0.005 0.022
article logging00:00:03.713 0.0%177042 0.011 0.021 0.046
article parse00:00:06.038 0.0%1157742 0.002 0.005 0.009
article write00:00:21.379 0.0%176599 0.039 0.121 1.974
artlog/artcncl00:00:00.005 0.0%72 0.000 0.069 0.333
data move00:00:00.973 0.0%1508012 0.000 0.001 0.003
hisgrep/artcncl00:00:00.280 0.0%73 0.000 3.836 12.667
hishave/artcncl00:00:00.177 0.0%74 0.000 2.392 8.333
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:07:19.789 0.5%179657 0.697 2.448 26.372
history sync00:00:00.023 0.0%305 0.000 0.075 1.000
history write00:07:50.031 0.5%176694 1.136 2.660 27.937
hiswrite/artcncl00:00:00.001 0.0%1 1.000 1.000 1.000
idle23:41:04.903 98.7%1303453 5.341 65.415 307.896
nntp read00:00:14.468 0.0%1146071 0.009 0.013 0.020
overview write00:00:00.445 0.0%176599 0.000 0.003 0.007
perl filter00:02:36.394 0.2%176694 0.466 0.885 1.402
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:04.543 0.0%365389 0.006 0.012 0.022
TOTAL: 24:00:17.20323:59:45.175100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.026 0.0%12175 0.000 0.002 0.028
article prepare00:00:00.000 0.0%232 0.000 0.000 0.000
article read00:00:00.001 0.0%58 0.000 0.017 0.200
backlog stats00:00:00.029 0.0%62712 0.000 0.000 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.283 0.0%31686 0.000 0.009 0.030
data write00:00:00.784 0.0%19573 0.000 0.040 0.117
idle23:57:19.653100.0%62712 840.430 1375.170 3278.262
status file00:00:00.475 0.0%389 0.000 1.221 12.733
TOTAL: 23:57:22.15823:57:21.251100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:30.649 65.5%4207 0.000 7.285 10002.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.155 0.3%10131 0.000 0.015 0.500
readart00:00:00.000 0.0%2 0.000 0.000 0.000
TOTAL: 00:00:46.80900:00:30.804 65.8%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 103 176908 176791 3 114 99%46:01:18
2news.icm.edu.pl 41 408 47 350 11 11%20:26:49
3localhost 6 5 5 0 0 100%00:00:00
TOTAL: 3 150 177321 176843 353 125 99%66:28:07
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl2.8 GB1.1 MB1.3 MB2.8 GB 99%16.4 KB
2news.icm.edu.pl1.8 MB0.0 KB255.1 KB2.0 MB 87%36.0 KB
3localhost7.1 KB0.0 KB0.0 KB7.1 KB100%1.4 KB
TOTAL: 32.8 GB1.1 MB1.6 MB2.8 GB 99%16.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 25 04:15:01 - 04:59:59 2462 1.4% 0.9123.5 MB 0.8% 8.91
Aug 25 05:00:00 - 05:59:59 6929 3.9% 1.9253.8 MB 1.9% 15.31
Aug 25 06:00:00 - 06:59:59 8193 4.6% 2.2874.1 MB 2.6% 21.08
Aug 25 07:00:00 - 07:59:59 6006 3.4% 1.67139.0 MB 4.9% 39.55
Aug 25 08:00:00 - 08:59:59 6451 3.6% 1.79128.8 MB 4.6% 36.65
Aug 25 09:00:00 - 09:59:59 5205 2.9% 1.4551.9 MB 1.8% 14.76
Aug 25 10:00:00 - 10:59:59 15074 8.5% 4.19541.3 MB 19.1% 153.98
Aug 25 11:00:00 - 11:59:59 9177 5.2% 2.55205.1 MB 7.2% 58.35
Aug 25 12:00:00 - 12:59:59 13464 7.6% 3.74252.7 MB 8.9% 71.88
Aug 25 13:00:00 - 13:59:59 12968 7.3% 3.60216.5 MB 7.6% 61.58
Aug 25 14:00:00 - 14:59:59 9805 5.5% 2.7287.6 MB 3.1% 24.92
Aug 25 15:00:00 - 15:59:59 8221 4.6% 2.2871.0 MB 2.5% 20.20
Aug 25 16:00:00 - 16:59:59 5807 3.3% 1.6156.8 MB 2.0% 16.15
Aug 25 17:00:00 - 17:59:59 4919 2.8% 1.3759.9 MB 2.1% 17.03
Aug 25 18:00:00 - 18:59:59 5299 3.0% 1.4791.6 MB 3.2% 26.05
Aug 25 19:00:00 - 19:59:59 5357 3.0% 1.4964.6 MB 2.3% 18.38
Aug 25 20:00:00 - 20:59:59 6265 3.5% 1.7467.4 MB 2.4% 19.18
Aug 25 21:00:00 - 21:59:59 6785 3.8% 1.88111.7 MB 3.9% 31.77
Aug 25 22:00:00 - 22:59:59 7711 4.4% 2.14113.2 MB 4.0% 32.20
Aug 25 23:00:00 - 23:59:59 4615 2.6% 1.2856.1 MB 2.0% 15.94
Aug 26 00:00:00 - 00:59:59 7117 4.0% 1.98135.0 MB 4.8% 38.40
Aug 26 01:00:00 - 01:59:59 5625 3.2% 1.5681.0 MB 2.9% 23.05
Aug 26 02:00:00 - 02:59:59 5403 3.1% 1.5064.2 MB 2.3% 18.26
Aug 26 03:00:00 - 03:59:59 6073 3.4% 1.6966.9 MB 2.4% 19.02
Aug 26 04:00:00 - 04:15:02 1911 1.1% 2.1216.9 MB 0.6% 19.16
TOTAL: 24:00:01 176842 100.0% 2.052.8 GB 100.0% 33.55
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 431 84 0 30 0 0 0 0 317
2news.icm.edu.pl 11 0 0 0 0 0 0 0 11
TOTAL: 2 442 84 0 30 0 0 0 0 328

Unwanted newsgroups [Top 20]:

NewsgroupCount
it.tlc.cellulari.android 30
uk.railway 24
comp.sys.raspberry-pi 15
comp.mobile.android 9
alt.comp.software.firefox 2
de.comp.lang.vbclassic 2
comp.mobile.ipad 1
alt.comp.software.seamonkey 1
TOTAL: 8 84

INND Perl filter [Top 20]:

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

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 19416 43 11943 14 0 1 0%23:52:07
2poznan 73 1 46 0 0 0 1%05:11:43
3nask 0 0 0 0 0 8452 0%23:57:47
4okapi 0 0 0 0 0 626 0%24:05:34
5panorama 0 0 0 0 0 12242 0%24:05:34
TOTAL: 5 19489 44 11989 14 0 21321 0%101:12:45
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm153.6 KB31.6 KB185.2 KB0.0 KB/s3.2 KB23:52:07
2poznan24.0 KB0.0 KB24.0 KB0.0 KB/s24.0 KB05:11:43
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:34
5panorama0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:34
TOTAL: 5177.5 KB31.6 KB209.1 KB0.0 KB/s3.6 KB101:12:45
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama1.4 MB
TOTAL: 11.4 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 289 22.3 KB 1 0 000:00:08
2isvcs01.man.lodz.pl 5 00.0 KB 0 5 000:00:00
TOTAL: 2 294 22.3 KB 1 5 000:00:47

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1734 22.3 KB 1 5 000:00:21
2*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
3unresolved 104 00.0 KB 0 0 000:00:23
TOTAL: 31839 22.3 KB 1 5 000:00:47

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
nms2.man.lodz.pl 3.624 5.979 0.00000:00:13
45.79.173.230 0.000 0.011 0.00000:00:10
192.241.237.38 0.000 0.006 0.00000:00:09
web.man.lodz.pl 0.683 1.248 0.00000:00:08
80.111.142.213 0.012 0.022 0.00000:00:02
ecstatic.monitoring.internet-measurement.com 0.000 0.006 0.00000:00:01
212.51.192.185 0.190 0.493 0.00000:00:01
198.199.106.142 0.006 0.000 0.00000:00:00
isvcs01.man.lodz.pl 0.020 0.036 0.00000:00:00
80.66.88.211 0.003 0.003 0.00000:00:00
TOTAL: 10 4.538 7.804 0.00000:00:47

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1440
212.51.192.185 96
80.111.142.213 4
192.241.237.38 1
ecstatic.monitoring.internet-measurement.com 1
80.66.88.211 1
198.199.106.142 1
45.79.173.230 1
TOTAL: 8 1545

NNRP unrecognized commands (by host):

SystemConn
80.66.88.211 1
198.199.106.142 1
TOTAL: 2 2

NNRP unrecognized commands (by command):

CommandCount
#003 1
MGLNDD_212.191.2.21_119 1
TOTAL: 2 2

NNRP client timeouts [Top 20]:

SystemConnPeer
80.66.88.211 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 2100.0%
TOTAL: 1 2100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 2
TOTAL: 1 2