Daily Usenet report

Jul 31 04:15:01 -- Aug 1 04:15:02

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

Jul 31 07:23:22 newsfeed overchan[7338]: input line too long, skipping
Jul 31 08:55:51 newsfeed overchan[7338]: input line too long, skipping
Jul 31 08:56:19 newsfeed overchan[7338]: input line too long, skipping
Jul 31 12:07:08 newsfeed nnrpd[25309]: SERVER perl filter not defined
Jul 31 12:17:24 newsfeed nnrpd[25681]: SERVER perl filter not defined
Jul 31 12:59:42 newsfeed nnrpd[27131]: SERVER perl filter not defined
Jul 31 17:50:42 newsfeed overchan[7338]: input line too long, skipping
Jul 31 18:38:44 newsfeed overchan[7338]: input line too long, skipping
Jul 31 18:46:56 newsfeed overchan[7338]: input line too long, skipping
Jul 31 19:16:27 newsfeed overchan[7338]: input line too long, skipping
Jul 31 19:38:50 newsfeed overchan[7338]: input line too long, skipping
Jul 31 19:41:21 newsfeed overchan[7338]: input line too long, skipping
Aug 1 01:30:03 newsfeed pgpverify[22679]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn2452906 97.7%282.6 MB 97.5%
innfeed 29433 1.2%3.5 MB 1.2%
innd 21280 0.8%3.2 MB 1.1%
nnrpd 5894 0.2%646.0 KB 0.2%
overchan 10 0.0%1.7 KB 0.0%
controlchan 4 0.0%0.4 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 72509528 100.0%290.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2439973 89.1%
Positive hits 226212 8.3%
Negative hits 69837 2.6%
Cache misses 1636 0.1%
TOTAL: 4 2737658 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.657 0.0%91 0.000 29.198 250.250
article cleanup00:00:24.515 0.0%2451110 0.004 0.010 0.017
article logging00:01:27.317 0.1%2451856 0.015 0.036 0.107
article parse00:36:00.890 2.5%98303530 0.014 0.022 0.043
article write00:14:17.467 1.0%2443943 0.177 0.351 0.685
artlog/artcncl00:00:00.002 0.0%90 0.000 0.022 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:01:22.748 0.1%112926600 0.000 0.001 0.001
hisgrep/artcncl00:00:00.401 0.0%91 0.000 4.407 54.000
hishave/artcncl00:00:00.016 0.0%91 0.000 0.176 1.800
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:09:54.159 0.7%2746562 0.100 0.216 0.539
history sync00:00:00.018 0.0%290 0.000 0.062 1.000
history write01:27:48.461 6.1%2446871 0.171 2.153 11.424
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle16:37:49.888 69.3%81764311 0.560 0.732 3.154
nntp read00:48:42.955 3.4%96735624 0.019 0.030 0.055
overview write00:00:10.580 0.0%2443943 0.002 0.004 0.008
perl filter03:32:43.436 14.8%2446869 3.231 5.216 9.425
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:03:58.657 0.3%5195812 0.026 0.046 0.085
TOTAL: 24:00:00.99023:34:44.167 98.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:01.283 0.0%546652 0.001 0.002 0.009
article prepare00:00:00.108 0.0%509116 0.000 0.000 0.003
article read00:10:54.178 0.8%137715 0.068 4.750 19.416
backlog stats00:00:01.704 0.0%2364560 0.000 0.001 0.002
callbacks00:00:00.065 0.0%12774 0.000 0.005 0.250
data read00:00:15.631 0.0%1138287 0.007 0.014 0.027
data write00:05:43.047 0.4%1188935 0.114 0.289 0.826
idle23:32:24.479 98.7%2364560 11.387 35.839 203.974
status file00:00:08.213 0.0%11177 0.333 0.735 2.250
TOTAL: 23:50:17.91323:49:28.708 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:12.467 83.9%3297 0.000 21.980 11629.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.216 0.2%7478 0.000 0.029 0.500
readart00:00:00.007 0.0%6 0.000 1.167 3.500
TOTAL: 00:01:26.40400:01:12.690 84.1%----

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.de000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 1407 24461792439649 3512 3018 99%352:47:29
2news.nask.pl 4 225422 5301 216069 4052 2%23:55:28
3news.icm.edu.pl 49 231 117 91 23 50%16:20:11
4localhost 4 3 3 0 0 100%00:00:00
TOTAL: 4 1464 26718352445070 219672 7093 91%393:03:08
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl705.0 GB39.8 MB246.9 MB705.3 GB 99%302.7 KB
2news.nask.pl363.9 MB422.0 MB438.5 MB1.2 GB 29%134.0 KB
3news.icm.edu.pl2.1 MB0.0 KB541.7 KB2.6 MB 79%19.0 KB
4localhost4.0 KB0.0 KB0.0 KB4.0 KB100%1.3 KB
TOTAL: 4705.3 GB461.8 MB685.9 MB706.4 GB 99%302.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 31 04:15:01 - 04:59:59 51049 2.1% 18.9118.5 GB 2.6%7181.03
Jul 31 05:00:00 - 05:59:59 83141 3.4% 23.0926.4 GB 3.7%7680.06
Jul 31 06:00:00 - 06:59:59 77530 3.2% 21.5423.4 GB 3.3%6803.06
Jul 31 07:00:00 - 07:59:59 54986 2.2% 15.2716.4 GB 2.3%4783.19
Jul 31 08:00:00 - 08:59:59 73923 3.0% 20.5322.0 GB 3.1%6400.11
Jul 31 09:00:00 - 09:59:59 75693 3.1% 21.0324.5 GB 3.5%7137.85
Jul 31 10:00:00 - 10:59:59 82739 3.4% 22.9825.6 GB 3.6%7468.16
Jul 31 11:00:00 - 11:59:59 71841 2.9% 19.9624.6 GB 3.5%7173.07
Jul 31 12:00:00 - 12:59:59 69474 2.8% 19.3021.0 GB 3.0%6129.89
Jul 31 13:00:00 - 13:59:59 96504 3.9% 26.8129.1 GB 4.1%8463.27
Jul 31 14:00:00 - 14:59:59 115444 4.7% 32.0733.1 GB 4.7%9642.93
Jul 31 15:00:00 - 15:59:59 95998 3.9% 26.6729.0 GB 4.1%8451.49
Jul 31 16:00:00 - 16:59:59 101936 4.2% 28.3232.5 GB 4.6%9474.46
Jul 31 17:00:00 - 17:59:59 134983 5.5% 37.5035.8 GB 5.1%10428.00
Jul 31 18:00:00 - 18:59:59 129674 5.3% 36.0235.9 GB 5.1%10462.30
Jul 31 19:00:00 - 19:59:59 136764 5.6% 37.9936.9 GB 5.2%10761.86
Jul 31 20:00:00 - 20:59:59 136596 5.6% 37.9436.5 GB 5.2%10619.58
Jul 31 21:00:00 - 21:59:59 137359 5.6% 38.1638.0 GB 5.4%11069.49
Jul 31 22:00:00 - 22:59:59 136861 5.6% 38.0238.1 GB 5.4%11084.53
Jul 31 23:00:00 - 23:59:59 121715 5.0% 33.8132.7 GB 4.6%9526.63
Aug 1 00:00:00 - 00:59:59 92115 3.8% 25.5923.7 GB 3.4%6895.94
Aug 1 01:00:00 - 01:59:59 111708 4.6% 31.0330.4 GB 4.3%8859.50
Aug 1 02:00:00 - 02:59:59 115722 4.7% 32.1531.4 GB 4.5%9138.51
Aug 1 03:00:00 - 03:59:59 114309 4.7% 31.7530.5 GB 4.3%8884.39
Aug 1 04:00:00 - 04:15:02 26834 1.1% 29.758.0 GB 1.1%9333.54
TOTAL: 24:00:01 2444898 100.0% 28.30704.0 GB 100.0%8544.09
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 4316 18 0 2527 2 0 0 0 1769
2newsfeed.pionier.net.pl 3584 165 0 1714 5 0 0 0 1700
3news.icm.edu.pl 18 0 0 0 0 0 0 0 18
TOTAL: 3 7918 183 0 4241 7 0 0 0 3487

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 96
it.comp.os.win.windows10 23
comp.sys.raspberry-pi 19
it.tlc.cellulari.android 12
comp.mobile.android 11
uk.rec.cycling.moderated 9
de.comp.office-pakete.ms-office.outlook 4
de.comp.lang.perl 4
it.comp.os.linux.ubuntu 2
hr.ponuda.hardver.komponente 1
de.rec.sf.startrek 1
uk.net.providers.gradwell 1
TOTAL: 12 183

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

GroupsCount
pl.praca.oferowana 6
bit.listserv.catholic 1
TOTAL: 2 7

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1349
Binary in non-binary group 1255
EMP (phl) 36
Poison newsgroup 28
Scoring filter (8) 27
Scoring filter (9) 14
Scoring filter (18) 8
HTML post 6
Scoring filter (10) 4
EMP (fsl) 3
Scoring filter (11) 3
Scoring filter (13) 1
Too many newsgroups 1
Scoring filter (16) 1
TOTAL: 14 2736

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 566
news.nask.pl 182
news.icm.edu.pl 1
TOTAL: 3 749
TOTAL: 1 749

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nask 435669 71013 224815 246 0 104 16%23:59:58
2panorama 282249 29977 203104 1978 27584 286368 10%23:59:58
3icm 395070 120 297061 10022 0 8 0%23:59:58
4poznan 6597 85 4723 10 0 1 1%23:59:06
5okapi 0 0 0 0 0 1156 0%23:57:51
TOTAL: 51119585 101195 729703 12256 27584 287637 9%119:56:51
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask37.7 GB77.3 MB37.7 GB458.1 KB/s555.4 KB23:59:58
2panorama14.8 GB229.6 MB15.1 GB182.8 KB/s494.4 KB23:59:58
3icm7.1 MB4.6 GB4.6 GB55.8 KB/s475.7 KB23:59:58
4poznan265.9 KB35.3 KB301.2 KB0.0 KB/s3.2 KB23:59:06
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
TOTAL: 552.5 GB4.9 GB57.4 GB139.4 KB/s530.6 KB119:56:51
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama7.2 MB
TOTAL: 17.2 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 68.1 KB 3 0 000:00:19
2isvcs01.man.lodz.pl 3 00.0 KB 0 3 000:00:00
TOTAL: 2 291 68.1 KB 3 3 000:01:25

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 963 68.1 KB 3 3 000:00:27
2*.icpnet.pl 1 00.0 KB 0 0 000:00:58
3*.census.shodan.io 1 00.0 KB 0 0 000:00:00
TOTAL: 3 965 68.1 KB 3 3 000:01:25

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
d92-233.icpnet.pl 0.032 0.020 0.00000:00:58
web.man.lodz.pl 1.292 4.888 0.00000:00:19
mon.man.lodz.pl 2.212 8.060 0.00000:00:06
david.man.lodz.pl 0.368 1.172 0.00000:00:01
isvcs01.man.lodz.pl 0.008 0.044 0.00000:00:00
sky.census.shodan.io 0.004 0.008 0.00000:00:00
TOTAL: 6 3.916 14.192 0.00000:01:25

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 576
david.man.lodz.pl 96
d92-233.icpnet.pl 1
sky.census.shodan.io 1
TOTAL: 4 674

Newsgroup request counts (by category):

CategoryCountPct
1pl 6100.0%
TOTAL: 1 6100.0%

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

NewsgroupCount
1pl.comp.pecet 6
TOTAL: 1 6