Daily Usenet report

May 21 04:15:01 -- May 22 04:15:01

Unknown entries from news log file:

First 15 / 15 lines (100.0%)

May 21 06:34:20 newsfeed overchan[13805]: input line too long, skipping
May 21 08:30:03 newsfeed pgpverify[26304]: pgpverify: verification failed
May 21 08:30:03 newsfeed pgpverify[26312]: pgpverify: verification failed
May 21 08:45:02 newsfeed pgpverify[26905]: pgpverify: verification failed
May 21 14:36:00 newsfeed overchan[13805]: input line too long, skipping
May 21 15:31:05 newsfeed overchan[13805]: input line too long, skipping
May 21 15:50:31 newsfeed overchan[13805]: input line too long, skipping
May 21 17:18:53 newsfeed overchan[13805]: input line too long, skipping
May 21 19:07:36 newsfeed overchan[13805]: input line too long, skipping
May 21 19:18:41 newsfeed overchan[13805]: input line too long, skipping
May 21 19:20:14 newsfeed overchan[13805]: input line too long, skipping
May 21 19:53:05 newsfeed overchan[13805]: input line too long, skipping
May 21 20:20:01 newsfeed overchan[13805]: input line too long, skipping
May 21 20:24:26 newsfeed overchan[13805]: input line too long, skipping
May 21 21:24:31 newsfeed overchan[13805]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 968296 93.8%108.2 MB 93.1%
innfeed 49105 4.8%5.8 MB 5.0%
innd 11893 1.2%1.9 MB 1.6%
nnrpd 3339 0.3%313.4 KB 0.3%
overchan 12 0.0%2.3 KB 0.0%
controlchan 4 0.0%0.3 KB 0.0%
pgpverify 3 0.0%0.3 KB 0.0%
TOTAL: 71032652 100.0%116.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 963374 99.4%
Negative hits 5785 0.6%
Positive hits 169 0.0%
Cache misses 24 0.0%
TOTAL: 4 969352 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.076 0.0%63 0.000 17.079 128.000
article cleanup00:00:06.186 0.0%966988 0.004 0.006 0.010
article logging00:00:20.911 0.0%967272 0.017 0.022 0.033
article parse00:09:57.552 0.7%146105991 0.003 0.004 0.005
article write00:05:13.084 0.4%966897 0.194 0.324 0.675
artlog/artcncl00:00:00.002 0.0%63 0.000 0.032 1.000
data move00:01:52.188 0.1%152573721 0.001 0.001 0.001
hisgrep/artcncl00:00:00.276 0.0%61 0.000 4.525 40.000
hishave/artcncl00:00:00.076 0.0%63 0.000 1.206 5.143
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:18:43.041 1.3%973008 0.113 1.154 8.188
history sync00:00:00.019 0.0%290 0.000 0.066 3.500
history write00:40:02.521 2.8%966972 0.220 2.485 12.747
hiswrite/artcncl00:00:00.001 0.0%2 0.500 0.500 0.500
idle21:00:56.397 87.6%144098156 0.389 0.525 0.956
nntp read00:28:25.560 2.0%145550633 0.008 0.012 0.014
overview write00:00:03.083 0.0%966897 0.002 0.003 0.005
perl filter00:47:45.398 3.3%966972 2.404 2.963 3.993
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:23.383 0.0%1942747 0.010 0.012 0.015
TOTAL: 24:00:03.36823:33:50.754 98.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.084 0.0%48480 0.000 0.002 0.007
article prepare00:00:00.012 0.0%13358 0.000 0.001 0.031
article read00:00:12.115 0.0%3358 0.000 3.608 39.531
backlog stats00:00:00.124 0.0%103407 0.000 0.001 0.005
callbacks00:00:00.000 0.0%15 0.000 0.000 0.000
data read00:00:00.461 0.0%48499 0.000 0.010 0.023
data write00:00:01.009 0.0%39782 0.007 0.025 0.050
idle23:54:07.594 99.9%103407 592.529 832.125 1185.694
status file00:00:59.275 0.1%16950 0.367 3.497 268.463
TOTAL: 23:55:23.82823:55:20.674100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:17:00.268 98.5%2730 0.000 373.725328058.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.098 0.0%5769 0.000 0.017 0.500
readart00:00:00.000 0.0%2 0.000 0.000 0.000
TOTAL: 00:17:16.16400:17:00.366 98.5%----

Control commands to INND:

CommandNumber
L 1
flush 27
flushlogs 2
go 2
logmode 2
mode 148
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 192

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de000300
TOTAL000300

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 484 968063 967983 0 80 99%125:41:19
2news.icm.edu.pl 46 152 15 126 11 9%13:07:58
3localhost 1441 0 0 0 0 0%00:00:00
TOTAL: 3 1971 968215 967998 126 91 99%138:49:17
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl341.7 GB760.7 KB904.0 KB341.7 GB 99%370.1 KB
2news.icm.edu.pl640.2 KB0.0 KB146.7 KB786.9 KB 81%30.3 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 3341.7 GB760.7 KB1.0 MB341.7 GB 99%370.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 21 04:15:01 - 04:59:59 25550 2.6% 9.4710.7 GB 3.1%4142.28
May 21 05:00:00 - 05:59:59 32619 3.4% 9.0613.3 GB 3.9%3866.87
May 21 06:00:00 - 06:59:59 31852 3.3% 8.8512.4 GB 3.6%3607.07
May 21 07:00:00 - 07:59:59 30331 3.1% 8.4311.9 GB 3.5%3463.10
May 21 08:00:00 - 08:59:59 34418 3.6% 9.5614.3 GB 4.2%4176.81
May 21 09:00:00 - 09:59:59 33776 3.5% 9.3813.4 GB 3.9%3896.56
May 21 10:00:00 - 10:59:59 34606 3.6% 9.6112.2 GB 3.6%3555.56
May 21 11:00:00 - 11:59:59 42730 4.4% 11.8713.9 GB 4.1%4054.64
May 21 12:00:00 - 12:59:59 55627 5.7% 15.4513.8 GB 4.0%4023.71
May 21 13:00:00 - 13:59:59 39940 4.1% 11.0914.2 GB 4.2%4145.34
May 21 14:00:00 - 14:59:59 42449 4.4% 11.7914.6 GB 4.3%4260.00
May 21 15:00:00 - 15:59:59 37773 3.9% 10.4914.5 GB 4.2%4230.52
May 21 16:00:00 - 16:59:59 36266 3.7% 10.0714.0 GB 4.1%4076.07
May 21 17:00:00 - 17:59:59 36756 3.8% 10.2113.7 GB 4.0%4000.13
May 21 18:00:00 - 18:59:59 41068 4.2% 11.4115.0 GB 4.4%4369.74
May 21 19:00:00 - 19:59:59 41342 4.3% 11.4815.6 GB 4.6%4534.69
May 21 20:00:00 - 20:59:59 35627 3.7% 9.9016.2 GB 4.8%4731.32
May 21 21:00:00 - 21:59:59 32805 3.4% 9.1114.8 GB 4.3%4309.63
May 21 22:00:00 - 22:59:59 42636 4.4% 11.8416.3 GB 4.8%4756.38
May 21 23:00:00 - 23:59:59 65721 6.8% 18.2616.7 GB 4.9%4870.05
May 22 00:00:00 - 00:59:59 53048 5.5% 14.7414.8 GB 4.3%4305.10
May 22 01:00:00 - 01:59:59 34685 3.6% 9.6312.9 GB 3.8%3762.67
May 22 02:00:00 - 02:59:59 33729 3.5% 9.3713.9 GB 4.1%4035.43
May 22 03:00:00 - 03:59:59 54350 5.6% 15.1014.7 GB 4.3%4283.61
May 22 04:00:00 - 04:15:01 18154 1.9% 20.154.0 GB 1.2%4709.37
TOTAL: 24:00:00 967858 100.0% 11.20341.9 GB 100.0%4149.97
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 364 63 0 16 1 0 0 0 284
2news.icm.edu.pl 11 0 0 0 0 0 0 0 11
TOTAL: 2 375 63 0 16 1 0 0 0 295

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 32
alt.comp.software.seamonkey 12
it.comp.os.win.windows10 8
comp.mobile.android 7
it.tlc.cellulari.android 2
it.comp.os.linux.ubuntu 2
TOTAL: 6 63

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

GroupsCount
pl.praca.oferowana 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 7
EMP (md5) 2
Too many newsgroups 1
Scoring filter (10) 1
TOTAL: 4 11

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 14033 2433 5971 93 1 0 17%23:50:02
2panorama 41366 224 12839 171 44 35356 0%23:59:55
3poznan 18 1 10 0 0 0 5%01:28:13
4nask 0 0 0 0 0 6406 0%23:50:02
5okapi 0 0 0 0 0 640 0%23:50:02
TOTAL: 5 55417 2658 18820 264 45 42402 4%96:58:14
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm8.4 MB329.9 KB8.7 MB0.1 KB/s3.5 KB23:50:02
2panorama887.9 KB2.1 MB3.0 MB0.0 KB/s7.7 KB23:59:55
3poznan8.2 KB0.0 KB8.2 KB0.0 KB/s8.2 KB01:28:13
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:02
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:02
TOTAL: 59.3 MB2.4 MB11.7 MB0.0 KB/s4.1 KB96:58:14
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 22.3 KB 1 0 000:00:18
TOTAL: 1 288 22.3 KB 1 0 000:17:16

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 288 22.3 KB 1 0 000:00:18
2unresolved 108 00.0 KB 0 0 000:16:56
3*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 3 397 22.3 KB 1 0 000:17:16

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
27.115.124.106 0.000 0.015 0.00000:16:34
web.man.lodz.pl 0.880 1.887 0.00000:00:18
27.115.124.43 0.007 0.000 0.00000:00:10
157.245.10.25 0.000 0.008 0.00000:00:06
80.111.142.213 0.005 0.033 0.00000:00:02
27.115.124.44 0.007 0.000 0.00000:00:02
212.51.192.185 0.260 0.504 0.00000:00:00
scanner-26.ch1.censys-scanner.com 0.009 0.003 0.00000:00:00
192.241.219.70 0.004 0.004 0.00000:00:00
31.43.185.19 0.007 0.007 0.00000:00:00
? 0.003 0.003 0.00000:00:00
TOTAL: 11 1.182 2.464 0.00000:17:16

Curious NNRP server explorers [Top 20]:

SystemConn
212.51.192.185 96
80.111.142.213 4
27.115.124.106 2
31.43.185.19 2
192.241.219.70 1
157.245.10.25 1
27.115.124.44 1
scanner-26.ch1.censys-scanner.com 1
27.115.124.43 1
TOTAL: 9 109

NNRP gethostbyaddr failures [Top 20]:

SystemConn
? (can't getpeername) 1
TOTAL: 1 1

NNRP unrecognized commands (by host):

SystemConn
27.115.124.44 3
27.115.124.106 2
31.43.185.19 2
scanner-26.ch1.censys-scanner.com 1
192.241.219.70 1
TOTAL: 5 9

NNRP unrecognized commands (by command):

CommandCount
#003 2
#026#003#001 2
#001 2
EHLO www.censys.io 1
ÃyY9…Faö¿?#021ÿ¦÷¦í‚îÙ#035óÐX6,ê-¥ 1
MGLNDD_212.191.2.21_119 1
TOTAL: 6 9

NNRP client timeouts [Top 20]:

SystemConnPeer
31.43.185.19 2 2
27.115.124.106 1 0
27.115.124.44 1 1
TOTAL: 3 4 3

Newsgroup request counts (by category):

CategoryCountPct
1pl 2100.0%
TOTAL: 1 2100.0%

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

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