Daily Usenet report

Sep 27 04:15:01 -- Sep 28 04:15:02

Unknown entries from news log file:

First 15 / 15 lines (100.0%)

Sep 27 07:17:34 newsfeed overchan[439266]: input line too long, skipping
Sep 27 11:55:34 newsfeed nnrpd[460219]: SERVER perl filter not defined
Sep 27 12:50:53 newsfeed overchan[439266]: input line too long, skipping
Sep 27 12:51:13 newsfeed overchan[439266]: input line too long, skipping
Sep 27 12:51:31 newsfeed overchan[439266]: input line too long, skipping
Sep 27 12:51:45 newsfeed overchan[439266]: input line too long, skipping
Sep 27 13:28:47 newsfeed overchan[439266]: input line too long, skipping
Sep 27 13:29:07 newsfeed overchan[439266]: input line too long, skipping
Sep 27 15:15:59 newsfeed nnrpd[469040]: SERVER perl filter not defined
Sep 27 17:01:45 newsfeed overchan[439266]: input line too long, skipping
Sep 27 19:22:14 newsfeed overchan[439266]: input line too long, skipping
Sep 27 20:02:22 newsfeed overchan[439266]: input line too long, skipping
Sep 27 20:44:56 newsfeed overchan[439266]: input line too long, skipping
Sep 27 22:17:41 newsfeed nnrpd[487681]: SERVER perl filter not defined
Sep 28 00:42:52 newsfeed overchan[439266]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 138270 91.6%16.1 MB 92.3%
nnrpd 7762 5.1%784.2 KB 4.4%
innd 3651 2.4%462.8 KB 2.6%
innfeed 1309 0.9%127.6 KB 0.7%
overchan 12 0.0%1.4 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 151005 100.0%17.4 MB100.0%

History cache:

ReasonCount%Count
Do not exist 136801 94.6%
Negative hits 6996 4.8%
Positive hits 760 0.5%
Cache misses 19 0.0%
TOTAL: 4 144576 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.616 0.0%45 0.000 13.689 38.000
article cleanup00:00:00.931 0.0%136979 0.002 0.007 0.016
article logging00:00:03.240 0.0%136986 0.013 0.024 0.043
article parse00:00:06.538 0.0%878308 0.004 0.007 0.016
article write00:00:17.253 0.0%134954 0.061 0.128 1.798
artlog/artcncl00:00:00.000 0.0%45 0.000 0.000 0.000
data move00:00:00.979 0.0%1107070 0.000 0.001 0.006
hisgrep/artcncl00:00:00.221 0.0%33 0.000 6.697 19.000
hishave/artcncl00:00:00.161 0.0%45 0.000 3.578 11.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:11:12.720 0.8%144765 2.352 4.647 9.298
history sync00:00:00.013 0.0%305 0.000 0.043 0.500
history write00:13:11.925 0.9%136957 3.522 5.782 11.099
hiswrite/artcncl00:00:00.073 0.0%12 0.000 6.083 7.444
idle23:21:47.129 98.0%983355 16.912 85.531 634.033
nntp read00:00:13.168 0.0%871835 0.010 0.015 0.027
overview write00:00:00.452 0.0%134954 0.000 0.003 0.010
perl filter00:02:49.769 0.2%136957 0.828 1.240 1.865
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:04.428 0.0%282519 0.009 0.016 0.023
TOTAL: 23:50:20.90523:49:49.616100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.025 0.0%12651 0.000 0.002 0.037
article prepare00:00:00.000 0.0%204 0.000 0.000 0.000
article read00:00:00.007 0.0%51 0.000 0.137 1.000
backlog stats00:00:00.024 0.0%52939 0.000 0.000 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.265 0.0%28601 0.000 0.009 0.035
data write00:00:00.716 0.0%16070 0.000 0.045 0.130
idle23:59:21.126100.0%52939 272.972 1631.333 4088.687
status file00:00:00.212 0.0%343 0.000 0.618 1.815
TOTAL: 23:59:23.23723:59:22.375100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:02:25.141 82.4%4224 0.000 34.361 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.164 0.1%10207 0.000 0.016 0.500
readart00:00:00.000 0.0%12 0.000 0.000 0.000
TOTAL: 00:02:56.05100:02:25.305 82.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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 87 136356 136244 0 112 99%47:13:04
2news.icm.edu.pl 8 2666 18 768 1880 0%23:28:25
3localhost 4 3 3 0 0 100%00:00:00
TOTAL: 3 99 139025 136265 768 1992 98%70:41:29
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl2.1 GB231.3 KB533.7 KB2.1 GB 99%16.2 KB
2news.icm.edu.pl347.4 KB70.3 KB21.6 MB22.0 MB 1%11.9 KB
3localhost4.3 KB0.0 KB0.0 KB4.3 KB100%1.4 KB
TOTAL: 32.1 GB301.6 KB22.1 MB2.1 GB 98%16.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 27 04:15:01 - 04:59:59 1876 1.4% 0.7026.9 MB 1.2% 10.21
Sep 27 05:00:00 - 05:59:59 2922 2.1% 0.8120.0 MB 0.9% 5.69
Sep 27 06:00:00 - 06:59:59 4805 3.5% 1.3365.5 MB 3.0% 18.63
Sep 27 07:00:00 - 07:59:59 4104 3.0% 1.1461.5 MB 2.9% 17.50
Sep 27 08:00:00 - 08:59:59 8289 6.1% 2.30194.6 MB 9.0% 55.36
Sep 27 09:00:00 - 09:59:59 8596 6.3% 2.39206.8 MB 9.6% 58.81
Sep 27 10:00:00 - 10:59:59 8057 5.9% 2.2496.6 MB 4.5% 27.47
Sep 27 11:00:00 - 11:59:59 7305 5.4% 2.0395.3 MB 4.4% 27.11
Sep 27 12:00:00 - 12:59:59 6922 5.1% 1.9298.7 MB 4.6% 28.08
Sep 27 13:00:00 - 13:59:59 6693 4.9% 1.86152.5 MB 7.1% 43.37
Sep 27 14:00:00 - 14:59:59 4449 3.3% 1.2462.6 MB 2.9% 17.80
Sep 27 15:00:00 - 15:59:59 4828 3.5% 1.3468.0 MB 3.2% 19.33
Sep 27 16:00:00 - 16:59:59 5653 4.2% 1.5781.8 MB 3.8% 23.26
Sep 27 17:00:00 - 17:59:59 5815 4.3% 1.6278.0 MB 3.6% 22.18
Sep 27 18:00:00 - 18:59:59 7490 5.5% 2.08110.9 MB 5.1% 31.55
Sep 27 19:00:00 - 19:59:59 7039 5.2% 1.9682.7 MB 3.8% 23.52
Sep 27 20:00:00 - 20:59:59 4351 3.2% 1.2174.8 MB 3.5% 21.27
Sep 27 21:00:00 - 21:59:59 4693 3.4% 1.3065.9 MB 3.1% 18.75
Sep 27 22:00:00 - 22:59:59 5359 3.9% 1.4982.9 MB 3.8% 23.58
Sep 27 23:00:00 - 23:59:59 5856 4.3% 1.6387.3 MB 4.1% 24.83
Sep 28 00:00:00 - 00:59:59 5879 4.3% 1.6391.2 MB 4.2% 25.94
Sep 28 01:00:00 - 01:59:59 4743 3.5% 1.3292.6 MB 4.3% 26.33
Sep 28 02:00:00 - 02:59:59 3725 2.7% 1.0366.9 MB 3.1% 19.04
Sep 28 03:00:00 - 03:59:59 5087 3.7% 1.4172.3 MB 3.4% 20.55
Sep 28 04:00:00 - 04:15:02 1637 1.2% 1.8118.8 MB 0.9% 21.36
TOTAL: 24:00:01 136173 100.0% 1.582.1 GB 100.0% 25.54
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.icm.edu.pl 1933 0 0 8 0 0 0 0 1925
2newsfeed.pionier.net.pl 119 97 0 14 1 0 0 0 7
TOTAL: 2 2052 97 0 22 1 0 0 0 1932

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 33
comp.mobile.android 23
alt.comp.software.seamonkey 13
comp.sys.raspberry-pi 12
it.comp.os.win.windows10 4
alt.comp.software.firefox 4
comp.mobile.ipad 4
nl.comp.os.linux.techniek 2
it.tlc.cellulari.android 1
de.rec.sf.startrek 1
TOTAL: 10 97

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

GroupsCount
pl.sci.matematyka 1
TOTAL: 1 1

INND Perl filter [Top 20]:

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

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 15974 39 11935 12 0 1 0%23:59:58
2panorama 0 0 0 0 0 12657 0%23:57:48
3nask 0 0 0 0 0 8435 0%23:57:48
4poznan 19 0 17 0 0 0 0%02:04:49
5okapi 0 0 0 0 0 722 0%23:57:48
TOTAL: 5 15993 39 11952 12 0 21815 0%97:58:11
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm201.8 KB80.4 KB282.1 KB0.0 KB/s5.5 KB23:59:58
2panorama0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:04:49
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
TOTAL: 5201.8 KB80.4 KB282.1 KB0.0 KB/s5.5 KB97:58:11
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama976.8 KB
TOTAL: 1976.8 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 1212.0 KB 6 0 000:00:09
2isvcs01.man.lodz.pl 3 00.0 KB 0 3 000:00:00
TOTAL: 2 291 1212.0 KB 6 3 000:02:56

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1731 1212.0 KB 6 3 000:00:24
2unresolved 105 00.0 KB 0 0 000:00:25
3*.ip.linodeusercontent.com 27 00.0 KB 0 0 000:02:04
4*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
5*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 51865 1212.0 KB 6 3 000:02:56

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
178-79-139-171.ip.linodeusercontent.com 0.134 0.161 0.00000:02:04
nms2.man.lodz.pl 4.893 8.141 0.00000:00:14
194.165.16.72 0.000 0.007 0.00000:00:10
104.152.52.163 0.005 0.002 0.00000:00:10
web.man.lodz.pl 0.867 1.603 0.00000:00:09
80.111.142.213 0.026 0.025 0.00000:00:02
admirable.monitoring.internet-measurement.com 0.008 0.004 0.00000:00:01
212.51.192.185 0.323 0.537 0.00000:00:01
45.125.65.22 0.000 0.011 0.00000:00:00
scanner-29.ch1.censys-scanner.com 0.007 0.000 0.00000:00:00
162.243.145.16 0.006 0.006 0.00000:00:00
104.152.52.201 0.000 0.009 0.00000:00:00
isvcs01.man.lodz.pl 0.004 0.031 0.00000:00:00
TOTAL: 13 6.273 10.537 0.00000:02:56

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1440
212.51.192.185 96
178-79-139-171.ip.linodeusercontent.com 27
80.111.142.213 4
45.125.65.22 1
admirable.monitoring.internet-measurement.com 1
104.152.52.163 1
104.152.52.201 1
162.243.145.16 1
scanner-29.ch1.censys-scanner.com 1
194.165.16.72 1
TOTAL: 11 1574

NNRP unrecognized commands (by host):

SystemConn
194.165.16.72 1
45.125.65.22 1
162.243.145.16 1
scanner-29.ch1.censys-scanner.com 1
TOTAL: 4 4

NNRP unrecognized commands (by command):

CommandCount
#003 2
MGLNDD_212.191.2.21_119 1
EHLO www.censys.io 1
TOTAL: 3 4

NNRP client timeouts [Top 20]:

SystemConnPeer
45.125.65.22 1 1
194.165.16.72 1 1
TOTAL: 2 2 3

Newsgroup request counts (by category):

CategoryCountPct
1pl 12100.0%
TOTAL: 1 12100.0%

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

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