Daily Usenet report

Nov 29 04:15:02 -- Nov 30 04:15:02

Unknown entries from news log file:

First 11 / 11 lines (100.0%)

Nov 29 09:08:11 newsfeed overchan[783308]: input line too long, skipping
Nov 29 09:39:50 newsfeed overchan[783308]: input line too long, skipping
Nov 29 11:09:50 newsfeed overchan[783308]: input line too long, skipping
Nov 29 11:12:41 newsfeed overchan[783308]: input line too long, skipping
Nov 29 13:53:21 newsfeed pgpverify[814115]: pgpverify: /usr/bin/gpg1: no such file
Nov 29 13:54:48 newsfeed pgpverify[814160]: pgpverify: /usr/bin/gpg1: no such file
Nov 29 13:55:09 newsfeed pgpverify[814253]: pgpverify: /usr/bin/gpg1: no such file
Nov 29 16:43:45 newsfeed overchan[783308]: input line too long, skipping
Nov 29 17:26:56 newsfeed overchan[783308]: input line too long, skipping
Nov 29 19:27:35 newsfeed overchan[783308]: input line too long, skipping
Nov 29 22:06:37 newsfeed overchan[783308]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 860444 95.8%94.5 MB 95.3%
innfeed 23488 2.6%2.8 MB 2.8%
innd 10448 1.2%1.6 MB 1.6%
nnrpd 3336 0.4%323.8 KB 0.3%
overchan 9 0.0%1.4 KB 0.0%
controlchan 4 0.0%0.3 KB 0.0%
pgpverify 3 0.0%0.5 KB 0.0%
TOTAL: 7 897732 100.0%99.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 855048 99.6%
Negative hits 3034 0.4%
Positive hits 107 0.0%
Cache misses 22 0.0%
TOTAL: 4 858211 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.499 0.0%38 0.000 13.132 66.000
article cleanup00:00:05.717 0.0%860812 0.004 0.007 0.010
article logging00:00:18.532 0.0%861200 0.016 0.022 0.027
article parse00:09:27.436 0.7%140424292 0.003 0.004 0.007
article write00:06:19.722 0.4%860525 0.249 0.441 0.685
artlog/artcncl00:00:00.002 0.0%38 0.000 0.053 0.500
data move00:00:36.919 0.0%147054056 0.000 0.000 0.000
hisgrep/artcncl00:00:00.046 0.0%38 0.000 1.211 5.000
hishave/artcncl00:00:00.031 0.0%38 0.000 0.816 17.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:06:33.925 0.5%864303 0.173 0.456 4.400
history sync00:00:00.013 0.0%291 0.000 0.045 0.500
history write00:09:10.909 0.6%860806 0.241 0.640 6.789
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle22:00:36.997 91.7%138609372 0.408 0.572 1.736
nntp read00:26:51.744 1.9%139842330 0.007 0.012 0.017
overview write00:00:02.478 0.0%860525 0.001 0.003 0.005
perl filter00:43:23.046 3.0%860806 2.281 3.024 3.585
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:22.361 0.0%1731289 0.010 0.013 0.016
TOTAL: 24:00:00.98523:43:50.377 98.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.047 0.0%29220 0.000 0.002 0.012
article prepare00:00:00.002 0.0%20116 0.000 0.000 0.006
article read00:00:07.338 0.0%5054 0.000 1.452 15.400
backlog stats00:00:00.046 0.0%82746 0.000 0.001 0.004
callbacks00:00:00.000 0.0%22 0.000 0.000 0.000
data read00:00:00.380 0.0%40467 0.000 0.009 0.030
data write00:00:00.900 0.0%30708 0.000 0.029 0.062
idle23:56:00.530100.0%82746 561.700 1041.265 2611.691
status file00:00:06.111 0.0%7681 0.368 0.796 9.961
TOTAL: 23:56:17.43623:56:15.354100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:18.806 75.1%2760 0.000 6.814 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.065 0.3%5905 0.000 0.011 0.158
readart00:00:00.003 0.0%44 0.000 0.068 0.500
TOTAL: 00:00:25.05200:00:18.874 75.3%----

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
control@usenet-fr.news.eu.org000300
TOTAL000300

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 225 859889 859607 0 282 99%99:11:52
2news.icm.edu.pl 44 219 127 87 5 57%10:42:48
3localhost 1437 0 0 0 0 0%00:00:00
TOTAL: 3 1706 860108 859734 87 287 99%109:54:40
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl381.2 GB328.6 KB3.8 MB381.2 GB 99%464.9 KB
2news.icm.edu.pl3.6 MB0.0 KB76.6 KB3.7 MB 97%28.4 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 3381.2 GB328.6 KB3.8 MB381.2 GB 99%464.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 29 04:15:02 - 04:59:59 20870 2.4% 7.7410.6 GB 2.8%4137.92
Nov 29 05:00:00 - 05:59:59 25995 3.0% 7.2214.4 GB 3.8%4203.23
Nov 29 06:00:00 - 06:59:59 27743 3.2% 7.7115.6 GB 4.1%4535.49
Nov 29 07:00:00 - 07:59:59 30996 3.6% 8.6116.1 GB 4.2%4697.06
Nov 29 08:00:00 - 08:59:59 31077 3.6% 8.6317.0 GB 4.5%4953.53
Nov 29 09:00:00 - 09:59:59 28760 3.3% 7.9916.0 GB 4.2%4647.76
Nov 29 10:00:00 - 10:59:59 31532 3.7% 8.7616.8 GB 4.4%4897.90
Nov 29 11:00:00 - 11:59:59 29329 3.4% 8.1515.5 GB 4.1%4525.96
Nov 29 12:00:00 - 12:59:59 34266 4.0% 9.5213.7 GB 3.6%3999.90
Nov 29 13:00:00 - 13:59:59 33944 3.9% 9.4315.3 GB 4.0%4454.41
Nov 29 14:00:00 - 14:59:59 40648 4.7% 11.2916.0 GB 4.2%4669.64
Nov 29 15:00:00 - 15:59:59 45012 5.2% 12.5016.0 GB 4.2%4668.88
Nov 29 16:00:00 - 16:59:59 39267 4.6% 10.9115.8 GB 4.1%4605.93
Nov 29 17:00:00 - 17:59:59 46018 5.4% 12.7816.1 GB 4.2%4697.29
Nov 29 18:00:00 - 18:59:59 53988 6.3% 15.0017.0 GB 4.5%4950.16
Nov 29 19:00:00 - 19:59:59 43322 5.0% 12.0316.7 GB 4.4%4854.46
Nov 29 20:00:00 - 20:59:59 32232 3.7% 8.9516.5 GB 4.3%4799.13
Nov 29 21:00:00 - 21:59:59 33881 3.9% 9.4115.0 GB 3.9%4369.30
Nov 29 22:00:00 - 22:59:59 51729 6.0% 14.3717.3 GB 4.5%5042.46
Nov 29 23:00:00 - 23:59:59 36307 4.2% 10.0916.8 GB 4.4%4890.73
Nov 30 00:00:00 - 00:59:59 40655 4.7% 11.2916.1 GB 4.2%4702.92
Nov 30 01:00:00 - 01:59:59 30605 3.6% 8.5016.2 GB 4.3%4731.66
Nov 30 02:00:00 - 02:59:59 31030 3.6% 8.6214.6 GB 3.8%4251.26
Nov 30 03:00:00 - 03:59:59 33703 3.9% 9.3616.1 GB 4.2%4678.46
Nov 30 04:00:00 - 04:15:02 6825 0.8% 7.573.9 GB 1.0%4478.00
TOTAL: 24:00:00 859734 100.0% 9.95381.3 GB 100.0%4627.11
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 667 166 0 6 1 0 0 0 494
2news.icm.edu.pl 5 0 0 0 0 0 0 0 5
TOTAL: 2 672 166 0 6 1 0 0 0 499

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 118
it.comp.os.win.windows10 17
it.comp.os.linux.ubuntu 7
it.tlc.cellulari.android 6
alt.comp.software.seamonkey 6
comp.mobile.android 6
de.comp.lang.php 2
de.comm.software.mailreader 2
alt.comp.software.firefox 1
it.discussioni.energia 1
TOTAL: 10 166

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

GroupsCount
pl.praca.oferowana 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 112
Too many newsgroups 2
TOTAL: 2 114

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 14725 4117 5273 376 0 0 27%23:59:57
2panorama 19287 152 6400 136 50 22540 0%23:59:58
3poznan 133 0 126 0 0 0 0%02:17:53
4nask 0 0 0 0 0 6916 0%23:57:47
5okapi 0 0 0 0 0 953 0%23:57:47
TOTAL: 5 34145 4269 11799 512 50 30409 12%98:13:22
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm14.8 MB20.6 MB35.4 MB0.4 KB/s8.1 KB23:59:57
2panorama630.2 KB871.2 KB1.5 MB0.0 KB/s5.2 KB23:59:58
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:17:53
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
TOTAL: 515.4 MB21.4 MB36.9 MB0.1 KB/s7.9 KB98:13:22
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 4448.8 KB 22 0 000:00:08
TOTAL: 1 288 4448.8 KB 22 0 000:00:25

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 288 4448.8 KB 22 0 000:00:08
2*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
3*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
4unresolved 101 00.0 KB 0 0 000:00:13
TOTAL: 4 391 4448.8 KB 22 0 000:00:25

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
192.3.251.169 0.005 0.003 0.00000:00:10
web.man.lodz.pl 0.924 1.620 0.00000:00:08
80.111.142.213 0.015 0.023 0.00000:00:02
eloquent.monitoring.internet-measurement.com 0.003 0.007 0.00000:00:02
212.51.192.185 0.309 0.474 0.00000:00:01
scanner-26.ch1.censys-scanner.com 0.006 0.006 0.00000:00:00
TOTAL: 6 1.262 2.133 0.00000:00:25

Curious NNRP server explorers [Top 20]:

SystemConn
212.51.192.185 96
80.111.142.213 4
eloquent.monitoring.internet-measurement.com 1
192.3.251.169 1
scanner-26.ch1.censys-scanner.com 1
TOTAL: 5 103

NNRP unrecognized commands (by host):

SystemConn
scanner-26.ch1.censys-scanner.com 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
EHLO www.censys.io 1
TOTAL: 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 44100.0%
TOTAL: 1 44100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 42
2pl.comp.pecet 2
TOTAL: 2 44