Daily Usenet report

Oct 31 04:15:02 -- Nov 1 04:15:02

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

Oct 31 10:16:57 newsfeed overchan[865067]: input line too long, skipping
Oct 31 10:19:13 newsfeed overchan[865067]: input line too long, skipping
Oct 31 11:02:14 newsfeed nnrpd[886041]: SERVER perl filter not defined
Oct 31 11:14:20 newsfeed nnrpd[886564]: SERVER perl filter not defined
Oct 31 12:51:10 newsfeed nnrpd[891549]: SERVER perl filter not defined
Oct 31 15:16:58 newsfeed overchan[865067]: input line too long, skipping
Oct 31 15:55:11 newsfeed overchan[865067]: input line too long, skipping
Oct 31 16:34:57 newsfeed overchan[865067]: input line too long, skipping
Oct 31 16:56:27 newsfeed overchan[865067]: input line too long, skipping
Oct 31 17:49:02 newsfeed overchan[865067]: input line too long, skipping
Oct 31 18:43:19 newsfeed nnrpd[909169]: SERVER perl filter not defined
Oct 31 18:43:52 newsfeed nnrpd[909174]: SERVER perl filter not defined
Oct 31 19:18:12 newsfeed overchan[865067]: input line too long, skipping
Nov 1 01:04:02 newsfeed pgpverify[928508]: pgpverify: /usr/bin/gpg1: no such file

Log entries by program:

Program nameLines%LinesSize%Size
inn 558719 94.2%61.6 MB 93.5%
innfeed 23119 3.9%2.7 MB 4.2%
innd 8085 1.4%1.2 MB 1.9%
nnrpd 3424 0.6%326.9 KB 0.5%
controlchan 12 0.0%2.8 KB 0.0%
overchan 9 0.0%1.5 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 7 593369 100.0%65.9 MB100.0%

History cache:

ReasonCount%Count
Do not exist 556001 99.7%
Negative hits 1592 0.3%
Positive hits 119 0.0%
Cache misses 20 0.0%
TOTAL: 4 557732 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.666 0.0%39 0.000 17.077 91.000
article cleanup00:00:03.796 0.0%558049 0.004 0.007 0.012
article logging00:00:13.221 0.0%558396 0.018 0.024 0.031
article parse00:07:08.168 0.5%119746262 0.003 0.004 0.005
article write00:04:46.663 0.3%557892 0.354 0.514 0.660
artlog/artcncl00:00:00.002 0.0%39 0.000 0.051 1.000
data move00:00:28.858 0.0%124470874 0.000 0.000 0.000
hisgrep/artcncl00:00:00.106 0.0%38 0.000 2.789 19.000
hishave/artcncl00:00:00.039 0.0%39 0.000 1.000 3.889
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:24:07.649 1.7%560221 0.286 2.584 18.485
history sync00:00:00.013 0.0%290 0.000 0.045 0.500
history write00:15:21.224 1.1%558033 0.395 1.651 6.580
hiswrite/artcncl00:00:00.001 0.0%1 1.000 1.000 1.000
idle21:57:00.796 91.5%119525423 0.492 0.661 1.093
nntp read00:23:37.899 1.6%119435445 0.010 0.012 0.014
overview write00:00:01.630 0.0%557892 0.001 0.003 0.006
perl filter00:30:50.589 2.1%558033 2.374 3.316 3.779
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:15.690 0.0%1125481 0.011 0.014 0.019
TOTAL: 24:00:04.64923:43:57.010 98.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.040 0.0%28470 0.000 0.001 0.013
article prepare00:00:00.000 0.0%15460 0.000 0.000 0.000
article read00:00:11.700 0.0%3881 0.000 3.015 151.429
backlog stats00:00:00.050 0.0%80874 0.000 0.001 0.005
callbacks00:00:00.000 0.0%13 0.000 0.000 0.000
data read00:00:00.333 0.0%38900 0.000 0.009 0.030
data write00:00:00.941 0.0%29763 0.000 0.032 0.069
idle23:55:54.068100.0%80874 605.337 1065.288 2682.101
status file00:00:04.987 0.0%7544 0.355 0.661 4.733
TOTAL: 23:56:14.38023:56:12.119100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:56.773 74.5%2788 0.000 41.884 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.086 0.1%5864 0.000 0.015 0.500
readart00:00:00.000 0.0%6 0.000 0.000 0.000
TOTAL: 00:02:36.83300:01:56.859 74.5%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
us-control@lists.killfile.org000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 44 558211 558088 0 123 99%55:04:12
2news.icm.edu.pl 37 158 38 86 34 24%09:45:14
3localhost 1446 5 5 0 0 100%00:00:00
TOTAL: 3 1527 558374 558131 86 157 99%64:49:26
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl282.4 GB1.3 MB1.6 MB282.4 GB 99%530.5 KB
2news.icm.edu.pl1.8 MB0.0 KB552.1 KB2.3 MB 76%33.0 KB
3localhost7.2 KB0.0 KB0.0 KB7.2 KB100%1.4 KB
TOTAL: 3282.4 GB1.3 MB2.1 MB282.4 GB 99%530.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 31 04:15:02 - 04:59:59 16737 3.0% 6.209.1 GB 3.2%3532.73
Oct 31 05:00:00 - 05:59:59 21414 3.8% 5.9511.2 GB 4.0%3256.78
Oct 31 06:00:00 - 06:59:59 22622 4.1% 6.2812.1 GB 4.3%3533.24
Oct 31 07:00:00 - 07:59:59 21386 3.8% 5.9410.9 GB 3.9%3178.54
Oct 31 08:00:00 - 08:59:59 22919 4.1% 6.3711.9 GB 4.2%3464.72
Oct 31 09:00:00 - 09:59:59 22257 4.0% 6.1811.2 GB 4.0%3275.43
Oct 31 10:00:00 - 10:59:59 21420 3.8% 5.9510.8 GB 3.8%3146.18
Oct 31 11:00:00 - 11:59:59 22588 4.0% 6.2711.3 GB 4.0%3282.55
Oct 31 12:00:00 - 12:59:59 22632 4.1% 6.2911.7 GB 4.1%3400.18
Oct 31 13:00:00 - 13:59:59 26375 4.7% 7.3311.8 GB 4.2%3426.88
Oct 31 14:00:00 - 14:59:59 26167 4.7% 7.2713.2 GB 4.6%3830.24
Oct 31 15:00:00 - 15:59:59 22934 4.1% 6.3711.5 GB 4.1%3355.94
Oct 31 16:00:00 - 16:59:59 24829 4.4% 6.9012.2 GB 4.3%3564.50
Oct 31 17:00:00 - 17:59:59 21817 3.9% 6.0611.0 GB 3.9%3203.25
Oct 31 18:00:00 - 18:59:59 21840 3.9% 6.0711.4 GB 4.0%3320.02
Oct 31 19:00:00 - 19:59:59 21852 3.9% 6.0711.3 GB 4.0%3292.45
Oct 31 20:00:00 - 20:59:59 23842 4.3% 6.6211.5 GB 4.1%3359.62
Oct 31 21:00:00 - 21:59:59 25232 4.5% 7.0111.9 GB 4.2%3475.99
Oct 31 22:00:00 - 22:59:59 25760 4.6% 7.1611.9 GB 4.2%3476.89
Oct 31 23:00:00 - 23:59:59 24177 4.3% 6.7212.8 GB 4.5%3736.96
Nov 1 00:00:00 - 00:59:59 24801 4.4% 6.8912.7 GB 4.5%3700.39
Nov 1 01:00:00 - 01:59:59 24083 4.3% 6.6912.7 GB 4.5%3711.68
Nov 1 02:00:00 - 02:59:59 22782 4.1% 6.3312.1 GB 4.3%3537.69
Nov 1 03:00:00 - 03:59:59 20946 3.8% 5.8211.2 GB 4.0%3258.39
Nov 1 04:00:00 - 04:15:02 6764 1.2% 7.503.5 GB 1.2%4034.27
TOTAL: 24:00:00 558176 100.0% 6.46283.1 GB 100.0%3435.29
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 470 104 0 16 3 0 0 0 347
2news.icm.edu.pl 34 0 0 0 0 0 0 0 34
TOTAL: 2 504 104 0 16 3 0 0 0 381

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 64
it.tlc.cellulari.android 13
alt.comp.software.firefox 9
comp.sys.raspberry-pi 6
it.comp.os.linux.ubuntu 4
de.comm.provider.telefonie 3
comp.mobile.android 2
it.comp.os.win.windows7 1
uk.rec.cycling.moderated 1
alt.comp.software.seamonkey 1
TOTAL: 10 104

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

GroupsCount
pl.praca.oferowana 3
TOTAL: 1 3

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups (low_xpost) 20
EMP (md5) 8
Binary in non-binary group 3
Scoring filter (8) 2
Too many newsgroups 1
TOTAL: 5 34

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 14855 3048 5880 308 0 0 20%23:59:56
2panorama 19156 141 6494 119 34 21748 0%23:59:57
3poznan 31 0 26 0 0 0 0%01:15:07
4nask 0 0 0 0 0 6575 0%23:57:48
5okapi 0 0 0 0 0 897 0%23:57:48
TOTAL: 5 34042 3189 12400 427 34 29220 9%97:10:36
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm10.8 MB47.3 MB58.1 MB0.7 KB/s17.7 KB23:59:56
2panorama570.1 KB1.7 MB2.3 MB0.0 KB/s9.0 KB23:59:57
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:15:07
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
TOTAL: 511.3 MB49.1 MB60.4 MB0.2 KB/s17.1 KB97:10:36
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 66.6 KB 3 0 000:00:09
2isvcs01.man.lodz.pl 5 00.0 KB 0 5 000:00:00
TOTAL: 2 293 66.6 KB 3 5 000:02:36

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 293 66.6 KB 3 5 000:00:09
2unresolved 108 00.0 KB 0 0 000:00:58
3*.ip.linodeusercontent.com 14 00.0 KB 0 0 000:01:28
4*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 4 416 66.6 KB 3 5 000:02:36

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
80-85-85-235.ip.linodeusercontent.com 0.058 0.059 0.00000:01:28
185.156.72.12 0.000 0.024 0.00000:00:30
23.224.189.3 0.003 0.018 0.00000:00:14
192.241.199.206 0.008 0.000 0.00000:00:09
web.man.lodz.pl 0.838 1.610 0.00000:00:09
80.111.142.213 0.008 0.032 0.00000:00:02
212.51.192.185 0.273 0.471 0.00000:00:01
scanner-26.ch1.censys-scanner.com 0.007 0.004 0.00000:00:00
192.241.218.17 0.005 0.003 0.00000:00:00
isvcs01.man.lodz.pl 0.018 0.039 0.00000:00:00
109.205.214.13 0.003 0.006 0.00000:00:00
TOTAL: 11 1.221 2.266 0.00000:02:36

Curious NNRP server explorers [Top 20]:

SystemConn
212.51.192.185 96
80-85-85-235.ip.linodeusercontent.com 14
80.111.142.213 4
185.156.72.12 3
23.224.189.3 2
192.241.218.17 1
109.205.214.13 1
scanner-26.ch1.censys-scanner.com 1
192.241.199.206 1
TOTAL: 9 123

NNRP unrecognized commands (by host):

SystemConn
185.156.72.12 3
23.224.189.3 2
192.241.218.17 1
109.205.214.13 1
scanner-26.ch1.censys-scanner.com 1
TOTAL: 5 8

NNRP unrecognized commands (by command):

CommandCount
#003 4
MGLNDD_212.191.2.21_119 1
#001 1
EHLO www.censys.io 1
#026#003#001 1
TOTAL: 5 8

NNRP client timeouts [Top 20]:

SystemConnPeer
185.156.72.12 3 3
109.205.214.13 1 1
23.224.189.3 1 1
TOTAL: 3 5 5

Newsgroup request counts (by category):

CategoryCountPct
1pl 6100.0%
TOTAL: 1 6100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 4
2pl.comp.pecet 2
TOTAL: 2 6
Valid XHTML 1.1 Strict CSS is valid!
innreport 3.1.0 (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>