Daily Usenet report

May 31 04:15:01 -- Jun 1 04:15:01

Unknown entries from news log file:

First 21 / 21 lines (100.0%)

May 31 05:09:58 newsfeed overchan[215483]: input line too long, skipping
May 31 07:00:53 newsfeed overchan[215483]: input line too long, skipping
May 31 08:23:12 newsfeed overchan[215483]: input line too long, skipping
May 31 10:45:29 newsfeed overchan[215483]: input line too long, skipping
May 31 11:31:13 newsfeed overchan[215483]: input line too long, skipping
May 31 11:34:44 newsfeed nnrpd[236319]: SERVER perl filter not defined
May 31 12:02:53 newsfeed nnrpd[237648]: SERVER perl filter not defined
May 31 12:03:17 newsfeed nnrpd[237653]: SERVER perl filter not defined
May 31 12:27:17 newsfeed overchan[215483]: input line too long, skipping
May 31 15:43:39 newsfeed overchan[215483]: input line too long, skipping
May 31 15:54:56 newsfeed overchan[215483]: input line too long, skipping
May 31 16:33:41 newsfeed overchan[215483]: input line too long, skipping
May 31 17:36:03 newsfeed overchan[215483]: input line too long, skipping
May 31 19:42:50 newsfeed overchan[215483]: input line too long, skipping
May 31 19:59:05 newsfeed overchan[215483]: input line too long, skipping
May 31 20:14:18 newsfeed overchan[215483]: input line too long, skipping
May 31 20:23:45 newsfeed overchan[215483]: input line too long, skipping
May 31 20:27:01 newsfeed overchan[215483]: input line too long, skipping
May 31 20:29:36 newsfeed overchan[215483]: input line too long, skipping
May 31 20:36:19 newsfeed overchan[215483]: input line too long, skipping
Jun 1 02:04:02 newsfeed pgpverify[275650]: pgpverify: /usr/bin/gpg1: no such file

Log entries by program:

Program nameLines%LinesSize%Size
inn 300648 89.8%42.3 MB 91.3%
innfeed 23704 7.1%2.8 MB 6.0%
nnrpd 7675 2.3%858.0 KB 1.8%
innd 2849 0.9%449.8 KB 0.9%
controlchan 22 0.0%5.3 KB 0.0%
overchan 17 0.0%2.6 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 7 334916 100.0%46.4 MB100.0%

History cache:

ReasonCount%Count
Do not exist 300107 99.4%
Negative hits 1463 0.5%
Positive hits 258 0.1%
Cache misses 33 0.0%
TOTAL: 4 301861 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.675 0.0%49 0.000 13.776 87.000
article cleanup00:00:01.273 0.0%300472 0.000 0.004 0.013
article logging00:00:05.024 0.0%300707 0.004 0.017 0.041
article parse00:00:21.896 0.0%5880753 0.001 0.004 0.010
article write00:00:29.667 0.0%300357 0.036 0.099 1.372
artlog/artcncl00:00:00.001 0.0%49 0.000 0.020 0.100
data move00:00:02.259 0.0%6999690 0.000 0.000 0.005
hisgrep/artcncl00:00:00.092 0.0%49 0.000 1.878 41.000
hishave/artcncl00:00:00.123 0.0%49 0.000 2.510 10.667
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:08:35.516 0.6%302165 0.461 1.706 49.456
history sync00:00:00.006 0.0%300 0.000 0.020 0.500
history write00:04:15.203 0.3%300458 0.196 0.849 13.778
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:38:53.206 98.5%6108861 4.055 13.936 587.283
nntp read00:00:50.272 0.1%5853540 0.007 0.009 0.022
overview write00:00:00.658 0.0%300357 0.000 0.002 0.016
perl filter00:05:34.947 0.4%300458 0.670 1.115 1.477
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:06.098 0.0%609926 0.000 0.010 0.021
TOTAL: 24:00:15.14023:59:16.916 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.027 0.0%28299 0.000 0.001 0.012
article prepare00:00:00.000 0.0%2896 0.000 0.000 0.000
article read00:00:11.298 0.0%731 0.000 15.456 65.000
backlog stats00:00:00.056 0.0%75068 0.000 0.001 0.007
callbacks00:00:00.000 0.0%7 0.000 0.000 0.000
data read00:00:00.275 0.0%35765 0.000 0.008 0.034
data write00:00:00.742 0.0%26669 0.000 0.028 0.078
idle23:55:19.450100.0%75068 715.412 1147.219 2151.814
status file00:00:07.746 0.0%7670 0.255 1.010 21.504
TOTAL: 23:55:41.46023:55:39.594100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:01:07.365 99.5%4208 0.000 871.522227558.250
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.129 0.0%10177 0.000 0.013 0.500
readart00:00:00.000 0.0%18 0.000 0.000 0.000
TOTAL: 01:01:25.25001:01:07.494 99.5%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
bofh-control@killfile.org001001
us-control@lists.killfile.org000100
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 110 300309 300205 2 102 99%53:18:09
2news.icm.edu.pl 48 259 14 232 13 5%17:19:18
3localhost 4 3 3 0 0 100%00:00:00
TOTAL: 3 162 300571 300222 234 115 99%70:37:27
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl14.0 GB559.0 KB760.4 KB14.0 GB 99%49.0 KB
2news.icm.edu.pl633.4 KB11.5 KB174.4 KB819.3 KB 77%30.3 KB
3localhost4.1 KB0.0 KB0.0 KB4.1 KB100%1.4 KB
TOTAL: 314.0 GB570.4 KB934.8 KB14.0 GB 99%49.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 31 04:15:01 - 04:59:59 1632 0.5% 0.6016.9 MB 0.1% 6.42
May 31 05:00:00 - 05:59:59 3836 1.3% 1.07103.6 MB 0.7% 29.47
May 31 06:00:00 - 06:59:59 2636 0.9% 0.7329.3 MB 0.2% 8.33
May 31 07:00:00 - 07:59:59 2291 0.8% 0.6425.9 MB 0.2% 7.36
May 31 08:00:00 - 08:59:59 4364 1.5% 1.2137.4 MB 0.3% 10.63
May 31 09:00:00 - 09:59:59 3352 1.1% 0.9351.1 MB 0.4% 14.55
May 31 10:00:00 - 10:59:59 9979 3.3% 2.77401.9 MB 2.8% 114.33
May 31 11:00:00 - 11:59:59 18448 6.1% 5.12975.8 MB 6.8% 277.57
May 31 12:00:00 - 12:59:59 10668 3.6% 2.96540.2 MB 3.8% 153.65
May 31 13:00:00 - 13:59:59 10657 3.5% 2.96497.4 MB 3.5% 141.48
May 31 14:00:00 - 14:59:59 22376 7.5% 6.221.1 GB 8.1% 330.45
May 31 15:00:00 - 15:59:59 29178 9.7% 8.111.6 GB 11.1% 454.52
May 31 16:00:00 - 16:59:59 20687 6.9% 5.751007.4 MB 7.0% 286.54
May 31 17:00:00 - 17:59:59 17981 6.0% 4.99789.3 MB 5.5% 224.51
May 31 18:00:00 - 18:59:59 18074 6.0% 5.02836.6 MB 5.8% 237.96
May 31 19:00:00 - 19:59:59 24112 8.0% 6.701.3 GB 9.3% 377.82
May 31 20:00:00 - 20:59:59 25836 8.6% 7.181.4 GB 10.3% 419.25
May 31 21:00:00 - 21:59:59 17514 5.8% 4.87838.7 MB 5.8% 238.57
May 31 22:00:00 - 22:59:59 19122 6.4% 5.31959.3 MB 6.7% 272.88
May 31 23:00:00 - 23:59:59 14993 5.0% 4.16737.0 MB 5.1% 209.63
Jun 1 00:00:00 - 00:59:59 4344 1.4% 1.21109.9 MB 0.8% 31.25
Jun 1 01:00:00 - 01:59:59 6144 2.0% 1.71295.4 MB 2.1% 84.02
Jun 1 02:00:00 - 02:59:59 9372 3.1% 2.60481.9 MB 3.4% 137.08
Jun 1 03:00:00 - 03:59:59 2364 0.8% 0.6658.2 MB 0.4% 16.54
Jun 1 04:00:00 - 04:15:01 287 0.1% 0.323.1 MB 0.0% 3.50
TOTAL: 24:00:00 300247 100.0% 3.4814.0 GB 100.0% 170.17
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 339 89 0 13 0 0 0 0 237
2news.icm.edu.pl 13 0 0 1 0 0 0 0 12
TOTAL: 2 352 89 0 14 0 0 0 0 249

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 39
it.tlc.cellulari.android 17
de.rec.sf.startrek 9
it.comp.os.win.windows10 9
comp.sys.raspberry-pi 6
alt.comp.software.seamonkey 6
de.comm.provider.telefonie 2
comp.mobile.android 1
TOTAL: 8 89

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 11
Scoring filter (8) 1
TOTAL: 2 12

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 19269 136 6406 175 14 21659 0%23:59:57
2icm 15247 39 9086 1 0 0 0%23:59:32
3poznan 24 0 14 0 0 0 0%02:00:55
4nask 0 0 0 0 0 6507 0%23:57:46
5okapi 0 0 0 0 0 479 0%23:57:46
TOTAL: 5 34540 175 15506 176 14 28645 0%97:55:56
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama365.4 KB3.7 MB4.0 MB0.0 KB/s13.3 KB23:59:57
2icm106.7 KB1.6 KB108.3 KB0.0 KB/s2.7 KB23:59:32
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:00:55
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:46
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:46
TOTAL: 5472.1 KB3.7 MB4.2 MB0.0 KB/s12.1 KB97:55:56
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 287 1818.6 KB 8 0 000:00:08
2isvcs01.man.lodz.pl 3 00.0 KB 0 3 000:00:00
TOTAL: 2 290 1818.6 KB 8 3 001:01:25

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1732 1818.6 KB 8 3 001:01:03
2*.for-privacy.net 1 00.0 KB 0 0 000:00:00
3unresolved 105 00.0 KB 0 0 000:00:19
4*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
TOTAL: 41839 1818.6 KB 8 3 001:01:25

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
pc-tom.man.lodz.pl 0.000 0.013 0.00001:00:40
nms1.man.lodz.pl 3.331 5.517 0.00000:00:13
107.170.240.23 0.000 0.007 0.00000:00:09
web.man.lodz.pl 0.736 1.210 0.00000:00:08
107.170.80.30 0.000 0.005 0.00000:00:05
tranquil.monitoring.internet-measurement.com 0.004 0.001 0.00000:00:02
80.111.142.213 0.000 0.036 0.00000:00:02
212.51.192.185 0.209 0.398 0.00000:00:00
144.172.118.36 0.004 0.006 0.00000:00:00
tor-exit-36.for-privacy.net 0.000 0.006 0.00000:00:00
185.220.101.157 0.000 0.010 0.00000:00:00
isvcs01.man.lodz.pl 0.016 0.007 0.00000:00:00
109.98.208.42 0.000 0.010 0.00000:00:00
TOTAL: 13 4.300 7.226 0.00001:01:25

Curious NNRP server explorers [Top 20]:

SystemConn
nms1.man.lodz.pl 1440
212.51.192.185 96
80.111.142.213 4
pc-tom.man.lodz.pl 2
107.170.80.30 1
109.98.208.42 1
tranquil.monitoring.internet-measurement.com 1
144.172.118.36 1
107.170.240.23 1
tor-exit-36.for-privacy.net 1
185.220.101.157 1
TOTAL: 11 1549

NNRP client timeouts [Top 20]:

SystemConnPeer
pc-tom.man.lodz.pl 2 0
TOTAL: 1 2 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 18100.0%
TOTAL: 1 18100.0%

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

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