Daily Usenet report

Oct 15 04:15:02 -- Oct 16 04:15:03

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Oct 15 09:43:27 newsfeed nnrpd[11380]: message repeated 4 times: [ 212.51.192.171 group alt.binaries.pictures.erotica 1]
Oct 15 17:00:06 newsfeed pgpverify[27229]: pgpverify: verification failed
Oct 15 21:33:31 newsfeed overchan[31210]: input line too long, skipping
Oct 15 21:47:21 newsfeed overchan[31210]: input line too long, skipping
Oct 15 21:51:17 newsfeed overchan[31210]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2712118 97.6%320.0 MB 97.3%
innfeed 41636 1.5%5.0 MB 1.5%
innd 21212 0.8%3.5 MB 1.1%
nnrpd 4846 0.2%512.2 KB 0.2%
overchan 4 0.0%0.5 KB 0.0%
controlchan 4 0.0%0.4 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 72779821 100.0%328.9 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2641672 88.6%
Negative hits 218630 7.3%
Positive hits 116148 3.9%
Cache misses 6311 0.2%
TOTAL: 4 2982761 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.130 0.0%160 0.000 13.312 137.000
article cleanup00:00:42.928 0.0%2712634 0.012 0.016 0.022
article logging00:02:04.924 0.1%2713182 0.032 0.046 0.455
article parse01:12:54.827 5.1%187438628 0.013 0.023 0.046
article write00:21:56.000 1.5%2662669 0.370 0.494 0.819
artlog/artcncl00:00:00.001 0.0%156 0.000 0.006 0.500
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:03:40.949 0.3%205068382 0.001 0.001 0.005
hisgrep/artcncl00:00:00.448 0.0%157 0.000 2.854 22.000
hishave/artcncl00:00:00.117 0.0%160 0.000 0.731 4.833
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:41:50.631 2.9%3008345 0.127 0.835 4.351
history sync00:00:00.022 0.0%290 0.000 0.076 1.000
history write02:03:16.761 8.6%2666167 0.476 2.774 8.385
hiswrite/artcncl00:00:00.016 0.0%3 0.000 5.333 16.000
idle11:35:20.528 48.3%126985467 0.185 0.329 0.795
nntp read01:26:54.234 6.0%185512074 0.019 0.028 0.042
overview write00:00:15.110 0.0%2662669 0.004 0.006 0.007
perl filter05:38:51.176 23.5%2666166 6.542 7.626 9.156
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:45.991 0.3%5483074 0.042 0.052 0.070
TOTAL: 24:00:03.20923:12:36.793 96.7%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.801 0.0%262846 0.000 0.003 0.017
article prepare00:00:00.017 0.0%53522 0.000 0.000 0.004
article read00:00:24.940 0.0%12498 0.000 1.996 302.833
backlog stats00:00:00.593 0.0%912030 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:10.412 0.0%562791 0.007 0.019 0.083
data write00:00:38.433 0.0%414527 0.011 0.093 0.152
idle23:50:31.335 99.9%912030 29.106 94.110 1624.708
status file00:00:14.795 0.0%14131 0.629 1.047 17.787
TOTAL: 23:52:32.32223:52:01.326100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:32:10.838 98.9%3181 0.000 606.991164515.545
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.332 0.0%9883 0.000 0.034 0.932
readart00:00:04.429 0.2%122 0.000 36.303 971.000
TOTAL: 00:32:31.35300:32:15.599 99.2%----

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
group-admin@isc.org000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 904 26667072609685 10711 46311 97%409:00:32
2news.nask.pl 2 121961 50988 66577 4396 41%24:06:00
3news.icm.edu.pl 46 224 15 193 16 6%16:48:25
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 953 27888922660688 77481 50723 95%449:54:57
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl846.2 GB14.1 GB14.1 GB874.3 GB 96%345.2 KB
2news.nask.pl14.3 GB173.2 MB194.0 MB14.6 GB 97%277.0 KB
3news.icm.edu.pl221.1 KB0.0 KB1.1 MB1.4 MB 15%44.8 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 4860.5 GB14.2 GB14.3 GB889.0 GB 96%343.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 15 04:15:02 - 04:59:59 90612 3.4% 33.5831.5 GB 3.7%12255.24
Oct 15 05:00:00 - 05:59:59 122110 4.6% 33.9241.7 GB 4.8%12132.93
Oct 15 06:00:00 - 06:59:59 119450 4.5% 33.1841.2 GB 4.8%12005.49
Oct 15 07:00:00 - 07:59:59 100299 3.8% 27.8634.6 GB 4.0%10089.49
Oct 15 08:00:00 - 08:59:59 109118 4.1% 30.3138.8 GB 4.5%11310.58
Oct 15 09:00:00 - 09:59:59 97138 3.7% 26.9835.2 GB 4.1%10262.66
Oct 15 10:00:00 - 10:59:59 100345 3.8% 27.8732.5 GB 3.8%9477.42
Oct 15 11:00:00 - 11:59:59 117934 4.4% 32.7632.5 GB 3.8%9467.60
Oct 15 12:00:00 - 12:59:59 131527 4.9% 36.5436.2 GB 4.2%10557.05
Oct 15 13:00:00 - 13:59:59 143301 5.4% 39.8142.6 GB 5.0%12420.60
Oct 15 14:00:00 - 14:59:59 144979 5.4% 40.2743.2 GB 5.0%12592.90
Oct 15 15:00:00 - 15:59:59 140776 5.3% 39.1043.1 GB 5.0%12559.59
Oct 15 16:00:00 - 16:59:59 134426 5.1% 37.3441.0 GB 4.8%11928.64
Oct 15 17:00:00 - 17:59:59 136655 5.1% 37.9642.3 GB 4.9%12313.78
Oct 15 18:00:00 - 18:59:59 132946 5.0% 36.9342.1 GB 4.9%12276.79
Oct 15 19:00:00 - 19:59:59 123373 4.6% 34.2741.4 GB 4.8%12061.96
Oct 15 20:00:00 - 20:59:59 125887 4.7% 34.9742.4 GB 4.9%12347.19
Oct 15 21:00:00 - 21:59:59 66317 2.5% 18.4223.1 GB 2.7%6731.50
Oct 15 22:00:00 - 22:59:59 54155 2.0% 15.0418.4 GB 2.1%5353.29
Oct 15 23:00:00 - 23:59:59 50689 1.9% 14.0816.9 GB 2.0%4930.41
Oct 16 00:00:00 - 00:59:59 91241 3.4% 25.3428.1 GB 3.3%8173.67
Oct 16 01:00:00 - 01:59:59 111162 4.2% 30.8837.2 GB 4.3%10840.25
Oct 16 02:00:00 - 02:59:59 96621 3.6% 26.8431.9 GB 3.7%9288.15
Oct 16 03:00:00 - 03:59:59 93268 3.5% 25.9132.6 GB 3.8%9502.74
Oct 16 04:00:00 - 04:15:03 26370 1.0% 29.209.2 GB 1.1%10648.12
TOTAL: 24:00:01 2660699 100.0% 30.79860.0 GB 100.0%10436.55
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 46634 122 0 46125 0 0 0 0 387
2news.nask.pl 4612 31 0 1074 1 0 0 0 3506
3news.icm.edu.pl 17 0 0 0 0 0 0 0 17
TOTAL: 3 51263 153 0 47199 1 0 0 0 3910

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 54
it.comp.os.win.windows10 25
it.tlc.cellulari.android 18
comp.mobile.android 15
comp.sys.raspberry-pi 13
de.rec.sf.startrek 10
it.comp.os.win.windows7 10
uk.rec.cycling.moderated 3
de.comp.office-pakete.ms-office.outlook 2
it.discussioni.energia 1
nl.comp.sys.android 1
nl.comp.os.linux.techniek 1
TOTAL: 12 153

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3140
Binary in non-binary group 125
Scoring filter (9) 48
Scoring filter (10) 24
Scoring filter (8) 15
Scoring filter (11) 5
HTML post 1
Scoring filter (12) 1
EMP (fsl) 1
TOTAL: 9 3360

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 330
news.nask.pl 219
TOTAL: 2 549
TOTAL: 1 549

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nask 165931 11398 93114 0 0 14 6%23:57:29
2panorama 109893 251 86121 60 1 180833 0%23:59:58
3poznan 14402 183 8599 14 0 1 1%23:59:58
4icm 186891 33 158970 1521 0 155 0%23:59:58
5okapi 0 0 0 0 0 946 0%23:57:51
TOTAL: 5 477117 11865 346804 1595 1 181949 2%119:55:14
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask3.8 GB0.0 KB3.8 GB46.7 KB/s353.6 KB23:57:29
2panorama7.0 MB2.7 MB9.7 MB0.1 KB/s31.9 KB23:59:58
3poznan645.9 KB153.6 KB799.6 KB0.0 KB/s4.1 KB23:59:58
4icm189.0 KB523.5 MB523.7 MB6.2 KB/s345.1 KB23:59:58
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
TOTAL: 53.9 GB526.4 MB4.4 GB10.6 KB/s340.0 KB119:55:14
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama1.9 MB
TOTAL: 11.9 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 8087.3 KB 37 0 000:00:25
2212.51.192.171 6 428.3 MB 10 0 000:31:59
TOTAL: 2 294 1228.4 MB 47 0 000:32:30

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 672 8087.3 KB 37 0 000:00:30
2unresolved 6 428.3 MB 10 0 000:31:59
TOTAL: 2 678 1228.4 MB 47 0 000:32:30

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
212.51.192.171 0.060 0.336 0.00000:31:59
web.man.lodz.pl 1.460 10.332 0.00000:00:25
mon.man.lodz.pl 1.220 10.444 0.00000:00:03
david.man.lodz.pl 0.352 3.248 0.00000:00:01
TOTAL: 4 3.092 24.360 0.00000:32:30

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
TOTAL: 2 384

NNRP client timeouts [Top 20]:

SystemConnPeer
212.51.192.171 1 0
TOTAL: 1 1 0

Newsgroup request counts (by category):

CategoryCountPct
1pl 80 67.8%
2alt 38 32.2%
TOTAL: 2 118100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 70
2alt.binaries.pictures.erotica 30
3pl.comp.pecet 10
4alt.binaries.pictures.erotica.amateur 8
TOTAL: 4 118