Daily Usenet report

Aug 15 04:15:01 -- Aug 16 04:15:02

Unknown entries from news log file:

First 19 / 19 lines (100.0%)

Aug 15 07:12:44 newsfeed overchan[1235760]: input line too long, skipping
Aug 15 07:13:02 newsfeed overchan[1235760]: input line too long, skipping
Aug 15 07:13:17 newsfeed overchan[1235760]: input line too long, skipping
Aug 15 09:10:46 newsfeed overchan[1235760]: input line too long, skipping
Aug 15 09:11:01 newsfeed overchan[1235760]: input line too long, skipping
Aug 15 09:53:41 newsfeed overchan[1235760]: input line too long, skipping
Aug 15 13:07:50 newsfeed overchan[1235760]: input line too long, skipping
Aug 15 14:53:06 newsfeed overchan[1235760]: input line too long, skipping
Aug 15 15:58:23 newsfeed overchan[1235760]: input line too long, skipping
Aug 15 16:05:31 newsfeed overchan[1235760]: input line too long, skipping
Aug 15 17:00:05 newsfeed pgpverify[1276652]: pgpverify: /usr/bin/gpg1: no such file
Aug 15 17:00:11 newsfeed pgpverify[1276665]: pgpverify: /usr/bin/gpg1: no such file
Aug 15 17:02:38 newsfeed overchan[1235760]: input line too long, skipping
Aug 15 17:22:06 newsfeed overchan[1235760]: input line too long, skipping
Aug 15 20:27:55 newsfeed overchan[1235760]: input line too long, skipping
Aug 15 22:35:30 newsfeed overchan[1235760]: input line too long, skipping
Aug 15 22:56:24 newsfeed overchan[1235760]: input line too long, skipping
Aug 15 22:57:25 newsfeed overchan[1235760]: input line too long, skipping
Aug 16 00:56:38 newsfeed overchan[1235760]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 117508 91.6%13.0 MB 92.3%
nnrpd 7658 6.0%752.7 KB 5.2%
innd 1670 1.3%208.0 KB 1.4%
innfeed 1336 1.0%149.9 KB 1.0%
controlchan 23 0.0%4.9 KB 0.0%
overchan 19 0.0%1.8 KB 0.0%
pgpverify 2 0.0%0.4 KB 0.0%
TOTAL: 7 128216 100.0%14.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 116918 98.9%
Negative hits 880 0.7%
Positive hits 345 0.3%
Cache misses 34 0.0%
TOTAL: 4 118177 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.040 0.0%56 0.000 18.571 111.000
article cleanup00:00:00.803 0.0%117309 0.000 0.007 0.017
article logging00:00:02.945 0.0%117520 0.011 0.025 0.055
article parse00:00:04.710 0.0%592397 0.002 0.008 0.014
article write00:00:20.592 0.0%117168 0.055 0.176 1.749
artlog/artcncl00:00:00.003 0.0%55 0.000 0.055 0.500
data move00:00:00.714 0.0%850703 0.000 0.001 0.003
hisgrep/artcncl00:00:00.301 0.0%56 0.000 5.375 24.500
hishave/artcncl00:00:00.193 0.0%56 0.000 3.446 11.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:09:04.898 0.6%118499 1.985 4.598 35.495
history sync00:00:00.012 0.0%300 0.000 0.040 0.500
history write00:07:45.900 0.5%117294 2.173 3.972 20.157
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:39:49.225 98.6%681315 14.752 125.036 513.377
nntp read00:00:11.159 0.0%581028 0.009 0.019 0.031
overview write00:00:00.407 0.0%117168 0.000 0.003 0.011
perl filter00:02:24.580 0.2%117294 0.719 1.233 1.858
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:03.925 0.0%245770 0.004 0.016 0.026
TOTAL: 24:00:23.88623:59:51.407100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.023 0.0%11429 0.000 0.002 0.020
article prepare00:00:00.000 0.0%112 0.000 0.000 0.000
article read00:00:00.000 0.0%28 0.000 0.000 0.000
backlog stats00:00:00.039 0.0%51994 0.000 0.001 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.280 0.0%27225 0.000 0.010 0.032
data write00:00:00.718 0.0%15916 0.000 0.045 0.136
idle23:58:12.205100.0%51994 1042.853 1659.657 4764.246
status file00:00:02.540 0.0%348 0.000 7.299 76.000
TOTAL: 23:58:16.77023:58:15.805100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:22.373 54.2%4177 0.000 5.356 9765.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.189 0.5%10088 0.000 0.019 0.500
TOTAL: 00:00:41.26800:00:22.562 54.7%----

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
group-admin@isc.org002202
TOTAL002202

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 66 117220 117088 7 125 99%40:34:39
2news.icm.edu.pl 39 378 17 341 20 4%21:07:18
3localhost 1 0 0 0 0 0%00:00:00
TOTAL: 3 106 117598 117105 348 145 99%61:41:57
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl1.6 GB196.4 KB514.2 KB1.6 GB 99%14.2 KB
2news.icm.edu.pl897.6 KB32.8 KB435.3 KB1.3 MB 65%36.9 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 31.6 GB229.3 KB949.5 KB1.6 GB 99%14.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 15 04:15:01 - 04:59:59 3629 3.1% 1.3455.4 MB 3.4% 21.01
Aug 15 05:00:00 - 05:59:59 2369 2.0% 0.6628.4 MB 1.7% 8.07
Aug 15 06:00:00 - 06:59:59 4554 3.9% 1.2660.2 MB 3.7% 17.13
Aug 15 07:00:00 - 07:59:59 2766 2.4% 0.7743.9 MB 2.7% 12.49
Aug 15 08:00:00 - 08:59:59 3183 2.7% 0.8846.9 MB 2.9% 13.35
Aug 15 09:00:00 - 09:59:59 3042 2.6% 0.8446.8 MB 2.9% 13.31
Aug 15 10:00:00 - 10:59:59 5722 4.9% 1.5990.7 MB 5.6% 25.80
Aug 15 11:00:00 - 11:59:59 14230 12.2% 3.95168.2 MB 10.4% 47.85
Aug 15 12:00:00 - 12:59:59 14464 12.4% 4.02157.8 MB 9.7% 44.88
Aug 15 13:00:00 - 13:59:59 4359 3.7% 1.21137.8 MB 8.5% 39.19
Aug 15 14:00:00 - 14:59:59 2795 2.4% 0.7838.3 MB 2.4% 10.91
Aug 15 15:00:00 - 15:59:59 3428 2.9% 0.9549.7 MB 3.1% 14.15
Aug 15 16:00:00 - 16:59:59 2884 2.5% 0.8041.8 MB 2.6% 11.89
Aug 15 17:00:00 - 17:59:59 2986 2.5% 0.8346.9 MB 2.9% 13.34
Aug 15 18:00:00 - 18:59:59 3563 3.0% 0.9947.2 MB 2.9% 13.43
Aug 15 19:00:00 - 19:59:59 4719 4.0% 1.3163.1 MB 3.9% 17.95
Aug 15 20:00:00 - 20:59:59 3173 2.7% 0.8838.2 MB 2.4% 10.88
Aug 15 21:00:00 - 21:59:59 4164 3.6% 1.1655.1 MB 3.4% 15.68
Aug 15 22:00:00 - 22:59:59 3480 3.0% 0.9739.4 MB 2.4% 11.21
Aug 15 23:00:00 - 23:59:59 3815 3.3% 1.0650.4 MB 3.1% 14.35
Aug 16 00:00:00 - 00:59:59 8881 7.6% 2.47112.4 MB 6.9% 31.96
Aug 16 01:00:00 - 01:59:59 5882 5.0% 1.6370.7 MB 4.4% 20.10
Aug 16 02:00:00 - 02:59:59 3869 3.3% 1.0747.1 MB 2.9% 13.39
Aug 16 03:00:00 - 03:59:59 4559 3.9% 1.2778.4 MB 4.8% 22.31
Aug 16 04:00:00 - 04:15:02 584 0.5% 0.658.1 MB 0.5% 9.23
TOTAL: 24:00:01 117100 100.0% 1.361.6 GB 100.0% 19.24
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 337 111 0 13 1 0 0 0 212
2news.icm.edu.pl 16 0 0 2 0 0 0 0 14
TOTAL: 2 353 111 0 15 1 0 0 0 226

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 88
comp.mobile.android 16
comp.sys.raspberry-pi 6
alt.comp.software.seamonkey 1
TOTAL: 4 111

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

GroupsCount
alt.penthouse.sex.spanking 1
TOTAL: 1 1

INND Perl filter [Top 20]:

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

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 15826 21 11262 6 0 1 0%23:59:59
2poznan 26 1 16 0 0 0 3%02:42:22
3nask 0 0 0 0 0 8386 0%23:57:48
4okapi 0 0 0 0 0 875 0%23:57:48
5panorama 0 0 0 0 0 11436 0%23:57:48
TOTAL: 5 15852 22 11278 6 0 20698 0%98:35:45
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm140.0 KB13.8 KB153.9 KB0.0 KB/s5.7 KB23:59:59
2poznan9.4 KB0.0 KB9.4 KB0.0 KB/s9.4 KB02:42:22
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
5panorama0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
TOTAL: 5149.4 KB13.8 KB163.3 KB0.0 KB/s5.8 KB98:35:45
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama976.8 KB
TOTAL: 1976.8 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1glorious.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
2212.51.192.185 96 00.0 KB 0 0 000:00:01
350.31.21.10 2 00.0 KB 0 0 000:00:01
4web.man.lodz.pl 289 00.0 KB 0 0 000:00:08
5194.165.16.73 1 00.0 KB 0 0 000:00:00
662-210-206-207.rev.poneytelecom.eu 2 00.0 KB 0 0 000:00:00
7198.199.119.64 1 00.0 KB 0 0 000:00:09
8scanner-27.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
962.122.184.32 1 00.0 KB 0 0 000:00:00
1080.111.142.213 4 00.0 KB 0 0 000:00:02
11nms2.man.lodz.pl1440 00.0 KB 0 0 000:00:14
12192.241.207.88 1 00.0 KB 0 0 000:00:00
TOTAL: 121839 00.0 KB 0 0 000:00:41

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
2unresolved 106 00.0 KB 0 0 000:00:15
3*.man.lodz.pl1729 00.0 KB 0 0 000:00:23
4*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
5*.rev.poneytelecom.eu 2 00.0 KB 0 0 000:00:00
TOTAL: 51839 00.0 KB 0 0 000:00:41

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
nms2.man.lodz.pl 4.840 8.924 0.00000:00:14
198.199.119.64 0.003 0.003 0.00000:00:09
web.man.lodz.pl 0.990 1.853 0.00000:00:08
80.111.142.213 0.010 0.040 0.00000:00:02
glorious.monitoring.internet-measurement.com 0.004 0.008 0.00000:00:02
50.31.21.10 0.013 0.010 0.00000:00:01
212.51.192.185 0.363 0.611 0.00000:00:01
scanner-27.ch1.censys-scanner.com 0.000 0.018 0.00000:00:00
194.165.16.73 0.000 0.013 0.00000:00:00
192.241.207.88 0.004 0.007 0.00000:00:00
62-210-206-207.rev.poneytelecom.eu 0.015 0.008 0.00000:00:00
62.122.184.32 0.003 0.003 0.00000:00:00
TOTAL: 12 6.245 11.498 0.00000:00:41

NNRP unrecognized commands (by host):

SystemConn
scanner-27.ch1.censys-scanner.com 1
192.241.207.88 1
62.122.184.32 1
194.165.16.73 1
TOTAL: 4 4

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

SystemConnPeer
62.122.184.32 1 1
194.165.16.73 1 1
TOTAL: 2 2 4
Valid XHTML 1.1 Strict CSS is valid!
innreport 3.1.0 (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>