Daily Usenet report

Jul 29 04:15:01 -- Jul 30 04:15:01

Unknown entries from news log file:

First 21 / 21 lines (100.0%)

Jul 29 05:48:00 newsfeed overchan[110456]: input line too long, skipping
Jul 29 08:43:38 newsfeed nnrpd[123935]: SERVER perl filter not defined
Jul 29 12:58:38 newsfeed overchan[110456]: input line too long, skipping
Jul 29 14:17:21 newsfeed overchan[110456]: input line too long, skipping
Jul 29 15:21:27 newsfeed overchan[110456]: input line too long, skipping
Jul 29 15:59:53 newsfeed overchan[110456]: input line too long, skipping
Jul 29 17:21:36 newsfeed overchan[110456]: input line too long, skipping
Jul 29 17:27:18 newsfeed overchan[110456]: input line too long, skipping
Jul 29 17:44:32 newsfeed overchan[110456]: input line too long, skipping
Jul 29 17:45:30 newsfeed overchan[110456]: input line too long, skipping
Jul 29 17:50:39 newsfeed overchan[110456]: input line too long, skipping
Jul 29 20:54:10 newsfeed overchan[110456]: input line too long, skipping
Jul 29 21:40:59 newsfeed overchan[110456]: input line too long, skipping
Jul 29 22:09:30 newsfeed overchan[110456]: input line too long, skipping
Jul 29 22:20:00 newsfeed overchan[110456]: input line too long, skipping
Jul 30 00:15:26 newsfeed overchan[110456]: input line too long, skipping
Jul 30 00:26:37 newsfeed overchan[110456]: input line too long, skipping
Jul 30 00:33:39 newsfeed overchan[110456]: input line too long, skipping
Jul 30 00:37:43 newsfeed overchan[110456]: input line too long, skipping
Jul 30 00:40:34 newsfeed overchan[110456]: input line too long, skipping
Jul 30 00:41:52 newsfeed overchan[110456]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 85313 88.6%9.8 MB 90.0%
nnrpd 7643 7.9%743.6 KB 6.7%
innd 1973 2.0%212.2 KB 1.9%
innfeed 1347 1.4%150.8 KB 1.4%
overchan 22 0.0%2.5 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 96299 100.0%10.9 MB100.0%

History cache:

ReasonCount%Count
Do not exist 84701 98.6%
Negative hits 941 1.1%
Positive hits 265 0.3%
Cache misses 16 0.0%
TOTAL: 4 85923 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.659 0.0%25 0.000 26.360 119.000
article cleanup00:00:00.614 0.0%85784 0.000 0.007 0.023
article logging00:00:02.379 0.0%85921 0.000 0.028 0.057
article parse00:00:03.893 0.0%449361 0.002 0.009 0.015
article write00:00:16.333 0.0%85663 0.059 0.191 1.930
artlog/artcncl00:00:00.000 0.0%25 0.000 0.000 0.000
data move00:00:00.730 0.0%640211 0.000 0.001 0.004
hisgrep/artcncl00:00:00.300 0.0%25 0.000 12.000 35.000
hishave/artcncl00:00:00.090 0.0%25 0.000 3.600 31.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:05:24.604 0.4%86976 1.673 3.732 18.401
history sync00:00:00.026 0.0%385 0.000 0.068 0.667
history write00:12:02.132 0.8%85761 5.364 8.420 27.288
idle23:40:41.149 98.6%527184 16.171 161.691 815.004
nntp read00:00:08.676 0.0%446460 0.009 0.019 0.031
overview write00:00:00.328 0.0%85663 0.000 0.004 0.026
perl filter00:01:49.897 0.1%85761 0.764 1.281 1.737
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:03.238 0.0%180282 0.009 0.018 0.034
TOTAL: 24:00:55.72124:00:35.048100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.027 0.0%8879 0.000 0.003 0.033
article prepare00:00:00.000 0.0%28 0.000 0.000 0.000
article read00:00:00.001 0.0%7 0.000 0.143 1.000
backlog stats00:00:00.026 0.0%41036 0.000 0.001 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.273 0.0%20967 0.000 0.013 0.320
data write00:00:00.570 0.0%12232 0.000 0.047 0.109
idle23:49:54.088100.0%41036 1131.290 2090.703 4463.448
status file00:00:04.301 0.0%346 0.000 12.431 283.500
TOTAL: 23:50:00.10323:49:59.286100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:10.358 35.5%4170 0.000 2.484 138.167
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.149 0.5%10086 0.000 0.015 0.667
readart00:00:00.001 0.0%4 0.000 0.250 0.500
TOTAL: 00:00:29.18000:00:10.508 36.0%----

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 86 85108 85000 5 103 99%41:24:36
2news.icm.edu.pl 40 281 27 236 18 9%15:46:00
3localhost 2 1 1 0 0 100%00:00:00
TOTAL: 3 128 85390 85028 241 121 99%57:10:36
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl1.2 GB453.8 KB677.1 KB1.2 GB 99%14.7 KB
2news.icm.edu.pl916.7 KB49.1 KB435.4 KB1.4 MB 65%31.1 KB
3localhost1.9 KB0.0 KB0.0 KB1.9 KB100%1.9 KB
TOTAL: 31.2 GB502.9 KB1.1 MB1.2 GB 99%14.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 29 04:15:01 - 04:59:59 3536 4.2% 1.3132.5 MB 2.7% 12.33
Jul 29 05:00:00 - 05:59:59 1921 2.3% 0.5320.9 MB 1.7% 5.93
Jul 29 06:00:00 - 06:59:59 1855 2.2% 0.5223.7 MB 1.9% 6.75
Jul 29 07:00:00 - 07:59:59 1747 2.1% 0.4923.1 MB 1.9% 6.57
Jul 29 08:00:00 - 08:59:59 3372 4.0% 0.9448.2 MB 3.9% 13.71
Jul 29 09:00:00 - 09:59:59 3274 3.9% 0.9143.5 MB 3.6% 12.37
Jul 29 10:00:00 - 10:59:59 3273 3.8% 0.9146.4 MB 3.8% 13.21
Jul 29 11:00:00 - 11:59:59 2544 3.0% 0.7134.7 MB 2.8% 9.88
Jul 29 12:00:00 - 12:59:59 3428 4.0% 0.9549.1 MB 4.0% 13.97
Jul 29 13:00:00 - 13:59:59 6035 7.1% 1.68144.1 MB 11.8% 40.98
Jul 29 14:00:00 - 14:59:59 3101 3.6% 0.8638.3 MB 3.1% 10.90
Jul 29 15:00:00 - 15:59:59 5769 6.8% 1.6077.0 MB 6.3% 21.89
Jul 29 16:00:00 - 16:59:59 3538 4.2% 0.9852.9 MB 4.3% 15.04
Jul 29 17:00:00 - 17:59:59 3121 3.7% 0.8744.5 MB 3.6% 12.65
Jul 29 18:00:00 - 18:59:59 4290 5.0% 1.1957.5 MB 4.7% 16.35
Jul 29 19:00:00 - 19:59:59 7251 8.5% 2.0192.9 MB 7.6% 26.43
Jul 29 20:00:00 - 20:59:59 4695 5.5% 1.3064.2 MB 5.3% 18.27
Jul 29 21:00:00 - 21:59:59 2608 3.1% 0.7241.3 MB 3.4% 11.76
Jul 29 22:00:00 - 22:59:59 3607 4.2% 1.0063.1 MB 5.2% 17.96
Jul 29 23:00:00 - 23:59:59 4465 5.3% 1.2459.4 MB 4.9% 16.89
Jul 30 00:00:00 - 00:59:59 2787 3.3% 0.7739.7 MB 3.3% 11.28
Jul 30 01:00:00 - 01:59:59 2392 2.8% 0.6632.4 MB 2.7% 9.22
Jul 30 02:00:00 - 02:59:59 3130 3.7% 0.8745.7 MB 3.7% 13.01
Jul 30 03:00:00 - 03:59:59 2938 3.5% 0.8241.0 MB 3.4% 11.66
Jul 30 04:00:00 - 04:15:01 352 0.4% 0.393.9 MB 0.3% 4.47
TOTAL: 24:00:00 85029 100.0% 0.981.2 GB 100.0% 14.46
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 241 83 0 20 0 0 0 0 138
2news.icm.edu.pl 18 0 0 3 0 0 0 0 15
TOTAL: 2 259 83 0 23 0 0 0 0 153

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 29
comp.sys.raspberry-pi 19
comp.mobile.android 12
alt.comp.software.firefox 8
it.comp.os.win.windows10 8
alt.comp.software.seamonkey 2
de.comm.software.mailreader 2
it.tlc.cellulari.android 2
it.discussioni.energia 1
TOTAL: 9 83

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 15
TOTAL: 1 15

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 12191 7 8866 1 0 2 0%24:09:52
2poznan 34 0 26 0 0 0 0%03:11:09
3panorama 0 0 0 0 0 8985 0%24:05:31
4nask 0 0 0 0 0 6293 0%24:05:31
5okapi 0 0 0 0 0 597 0%24:05:31
TOTAL: 5 12225 7 8892 1 0 15877 0%99:37:34
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm22.3 KB2.2 KB24.5 KB0.0 KB/s3.1 KB24:09:52
2poznan0.0 KB0.0 KB0.0 KB0.0 KB/s003:11:09
3panorama0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:31
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:31
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:31
TOTAL: 522.3 KB2.2 KB24.5 KB0.0 KB/s3.1 KB99:37:34
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama976.7 KB
TOTAL: 1976.7 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 290 42.6 KB 2 0 000:00:09
2isvcs01.man.lodz.pl 1 00.0 KB 0 1 000:00:00
TOTAL: 2 291 42.6 KB 2 1 000:00:29

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1731 42.6 KB 2 1 000:00:23
2unresolved 102 00.0 KB 0 0 000:00:04
3*.150.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
4*.ch1.censys-scanner.com 2 00.0 KB 0 0 000:00:00
TOTAL: 41836 42.6 KB 2 1 000:00:29

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
nms2.man.lodz.pl 5.045 7.315 0.00000:00:14
web.man.lodz.pl 1.091 1.473 0.00000:00:09
80.111.142.213 0.015 0.033 0.00000:00:02
212.51.192.185 0.282 0.571 0.00000:00:01
80.66.88.211 0.006 0.006 0.00000:00:00
scanner-04.ch1.censys-scanner.com 0.011 0.016 0.00000:00:00
192.241.228.21 0.000 0.010 0.00000:00:00
48.150.216.162.bc.googleusercontent.com 0.000 0.010 0.00000:00:00
isvcs01.man.lodz.pl 0.000 0.009 0.00000:00:00
TOTAL: 9 6.450 9.443 0.00000:00:29

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1440
212.51.192.185 96
80.111.142.213 4
scanner-04.ch1.censys-scanner.com 2
80.66.88.211 1
192.241.228.21 1
48.150.216.162.bc.googleusercontent.com 1
TOTAL: 7 1545

NNRP unrecognized commands (by host):

SystemConn
48.150.216.162.bc.googleusercontent.com 3
192.241.228.21 1
80.66.88.211 1
scanner-04.ch1.censys-scanner.com 1
TOTAL: 4 6

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 1
Host: 212.191.2.21:119 1
User-Agent: Expanse, a Palo Alto Network... 1
EHLO www.censys.io 1
#003 1
MGLNDD_212.191.2.21_119 1
TOTAL: 6 6

NNRP client timeouts [Top 20]:

SystemConnPeer
80.66.88.211 1 1
TOTAL: 1 1 2

Newsgroup request counts (by category):

CategoryCountPct
1pl 4100.0%
TOTAL: 1 4100.0%

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

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