Daily Usenet report

Sep 15 04:15:02 -- Sep 16 04:15:03

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Sep 15 11:48:54 newsfeed overchan[4683]: input line too long, skipping
Sep 15 11:49:23 newsfeed overchan[4683]: input line too long, skipping
Sep 15 14:54:11 newsfeed overchan[4683]: input line too long, skipping
Sep 15 17:00:05 newsfeed pgpverify[1641]: pgpverify: verification failed
Sep 15 17:07:37 newsfeed overchan[4683]: input line too long, skipping
Sep 15 17:33:13 newsfeed overchan[4683]: input line too long, skipping
Sep 15 17:41:31 newsfeed overchan[4683]: input line too long, skipping
Sep 15 19:27:35 newsfeed overchan[4683]: input line too long, skipping
Sep 15 19:57:08 newsfeed overchan[4683]: input line too long, skipping
Sep 15 19:58:49 newsfeed overchan[4683]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn1818432 96.6%211.1 MB 96.3%
innfeed 43821 2.3%5.2 MB 2.4%
innd 15478 0.8%2.5 MB 1.1%
nnrpd 5509 0.3%582.1 KB 0.3%
overchan 10 0.0%1.9 KB 0.0%
controlchan 4 0.0%0.5 KB 0.0%
pgpverify 1 0.0%0.0 KB 0.0%
TOTAL: 71883255 100.0%219.3 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1802894 85.9%
Positive hits 213658 10.2%
Negative hits 76805 3.7%
Cache misses 5599 0.3%
TOTAL: 4 2098956 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.453 0.0%63 0.000 38.937 317.000
article cleanup00:00:28.854 0.0%1814172 0.011 0.016 0.020
article logging00:01:40.350 0.1%1814706 0.038 0.055 0.085
article parse00:48:54.284 3.4%74364788 0.019 0.039 0.073
article write00:20:27.270 1.4%1803907 0.227 0.680 1.662
artlog/artcncl00:00:00.003 0.0%62 0.000 0.048 0.333
artlog/artparse00:00:00.001 0.0%13 0.077 0.077 0.077
data move00:02:20.716 0.2%85877780 0.001 0.002 0.004
hisgrep/artcncl00:00:00.530 0.0%54 0.000 9.815 43.000
hishave/artcncl00:00:00.060 0.0%63 0.000 0.952 15.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup01:41:06.166 7.0%2105483 1.102 2.881 100.860
history sync00:00:00.015 0.0%290 0.000 0.052 0.500
history write04:04:01.984 16.9%1805768 3.279 8.108 83.734
hiswrite/artcncl00:00:00.002 0.0%9 0.000 0.222 0.500
idle10:56:53.225 45.6%52208658 0.104 0.755 3.205
nntp read01:09:12.976 4.8%73111098 0.035 0.057 0.068
overview write00:00:10.734 0.0%1803907 0.004 0.006 0.008
perl filter04:24:54.033 18.4%1805768 5.460 8.802 11.331
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:47.122 0.3%3906293 0.046 0.074 0.090
TOTAL: 24:00:03.36523:35:00.778 98.3%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:01.982 0.0%613884 0.001 0.003 0.008
article prepare00:00:00.106 0.0%324064 0.000 0.000 0.002
article read00:28:47.993 2.0%78125 0.000 22.118 597.667
backlog stats00:00:02.408 0.0%2175923 0.000 0.001 0.002
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:26.784 0.0%1040178 0.011 0.026 0.044
data write00:05:16.589 0.4%1169928 0.074 0.271 0.700
idle23:12:35.602 97.3%2175923 16.256 38.400 272.530
status file00:02:17.866 0.2%16844 0.636 8.185 1123.250
TOTAL: 23:50:43.59623:49:29.330 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:29.711 61.8%3317 0.000 8.957 192.444
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.491 1.0%7429 0.000 0.066 5.000
readart00:00:00.007 0.0%58 0.000 0.121 3.000
TOTAL: 00:00:48.09300:00:30.209 62.8%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 921 18031421799718 1470 1954 99%401:43:52
2news.nask.pl 35 231314 7917 215063 8334 3%31:37:54
3news.icm.edu.pl 37 303 129 113 61 42%17:39:56
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 994 20347591807764 216646 10349 88%451:01:42
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl653.7 GB240.7 MB252.5 MB654.2 GB 99%380.7 KB
2news.nask.pl3.0 GB2.8 GB2.8 GB8.6 GB 34%555.4 KB
3news.icm.edu.pl2.4 MB100.9 KB3.4 MB5.9 MB 40%32.0 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 4656.7 GB3.1 GB3.1 GB662.8 GB 99%382.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 15 04:15:02 - 04:59:59 46210 2.6% 17.1320.7 GB 3.2%8049.16
Sep 15 05:00:00 - 05:59:59 65705 3.6% 18.2529.4 GB 4.5%8557.24
Sep 15 06:00:00 - 06:59:59 64014 3.5% 17.7828.3 GB 4.3%8239.99
Sep 15 07:00:00 - 07:59:59 66986 3.7% 18.6129.5 GB 4.5%8578.95
Sep 15 08:00:00 - 08:59:59 57896 3.2% 16.0824.1 GB 3.7%7033.56
Sep 15 09:00:00 - 09:59:59 59915 3.3% 16.6421.0 GB 3.2%6110.29
Sep 15 10:00:00 - 10:59:59 64561 3.6% 17.9325.6 GB 3.9%7442.89
Sep 15 11:00:00 - 11:59:59 72955 4.0% 20.2731.4 GB 4.8%9158.65
Sep 15 12:00:00 - 12:59:59 70451 3.9% 19.5730.9 GB 4.7%9001.19
Sep 15 13:00:00 - 13:59:59 49547 2.7% 13.7620.6 GB 3.1%5992.23
Sep 15 14:00:00 - 14:59:59 62074 3.4% 17.2422.8 GB 3.5%6644.06
Sep 15 15:00:00 - 15:59:59 78558 4.3% 21.8228.8 GB 4.4%8375.37
Sep 15 16:00:00 - 16:59:59 52153 2.9% 14.4920.9 GB 3.2%6091.85
Sep 15 17:00:00 - 17:59:59 71369 3.9% 19.8226.0 GB 4.0%7572.54
Sep 15 18:00:00 - 18:59:59 78626 4.3% 21.8430.8 GB 4.7%8985.35
Sep 15 19:00:00 - 19:59:59 96709 5.4% 26.8636.4 GB 5.5%10594.60
Sep 15 20:00:00 - 20:59:59 117836 6.5% 32.7336.5 GB 5.6%10629.89
Sep 15 21:00:00 - 21:59:59 93788 5.2% 26.0530.0 GB 4.6%8737.76
Sep 15 22:00:00 - 22:59:59 83680 4.6% 23.2422.3 GB 3.4%6487.17
Sep 15 23:00:00 - 23:59:59 67536 3.7% 18.7611.3 GB 1.7%3294.01
Sep 16 00:00:00 - 00:59:59 84505 4.7% 23.4722.1 GB 3.4%6447.71
Sep 16 01:00:00 - 01:59:59 87727 4.9% 24.3731.4 GB 4.8%9151.88
Sep 16 02:00:00 - 02:59:59 85102 4.7% 23.6432.8 GB 5.0%9545.73
Sep 16 03:00:00 - 03:59:59 104685 5.8% 29.0834.3 GB 5.2%9988.09
Sep 16 04:00:00 - 04:15:03 24972 1.4% 27.658.5 GB 1.3%9815.17
TOTAL: 24:00:01 1807560 100.0% 20.92656.3 GB 100.0%7964.72
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 8349 5 0 6584 4 0 0 0 1756
2newsfeed.pionier.net.pl 2394 71 0 1807 4 0 0 0 512
3news.icm.edu.pl 67 0 0 9 0 0 0 0 58
TOTAL: 3 10810 76 0 8400 8 0 0 0 2326

Unwanted newsgroups [Top 20]:

NewsgroupCount
it.comp.os.win.windows10 21
uk.railway 18
comp.sys.raspberry-pi 9
it.tlc.cellulari.android 9
de.comp.lang.perl 6
uk.rec.cycling.moderated 3
comp.sys.mac.vintage 3
nl.comp.os.linux.techniek 3
comp.mobile.ipad 2
de.comm.software.mailreader 1
it.discussioni.energia 1
TOTAL: 11 76

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

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

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1557
Binary in non-binary group 116
EMP (phl) 64
Scoring filter (8) 16
Scoring filter (16) 9
Too many newsgroups 9
Scoring filter (9) 5
Scoring filter (10) 2
HTML post 1
Scoring filter (11) 1
TOTAL: 10 1780

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad command received
news.nask.pl 208
TOTAL: 1 208
Including strange strings
newsfeed.pionier.net.pl 444
news.nask.pl 83
news.icm.edu.pl 6
TOTAL: 3 533
TOTAL: 2 741

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nask 387305 63351 214120 7981 0 26133 16%23:59:59
2panorama 310047 1454 280285 157 2 308436 0%23:59:59
3poznan 4011 80 2917 14 0 0 1%23:51:54
4icm 339012 30 289546 8391 0 4 0%23:59:59
5okapi 0 0 0 0 0 801 0%23:57:52
TOTAL: 51040375 64915 786868 16543 2 335374 6%119:49:43
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask38.2 GB4.8 GB43.0 GB522.1 KB/s632.4 KB23:59:59
2panorama644.5 MB41.0 MB685.5 MB8.1 KB/s435.7 KB23:59:59
3icm558.8 KB4.6 GB4.6 GB56.4 KB/s578.4 KB23:59:59
4poznan280.0 KB35.7 KB315.7 KB0.0 KB/s3.4 KB23:51:54
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:52
TOTAL: 538.8 GB9.5 GB48.3 GB117.5 KB/s622.2 KB119:49:43
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama2.9 MB
TOTAL: 12.9 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 5852.7 KB 27 0 000:00:31
TOTAL: 1 288 5852.7 KB 27 0 000:00:47

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 672 5852.7 KB 27 0 000:00:37
2*.versanet.de 188 00.0 KB 0 0 000:00:09
TOTAL: 2 860 5852.7 KB 27 0 000:00:47

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.652 5.828 0.00000:00:31
i59f67e4e.versanet.de 0.716 2.556 0.00000:00:09
mon.man.lodz.pl 1.600 4.996 0.00000:00:04
david.man.lodz.pl 0.508 1.716 0.00000:00:01
TOTAL: 4 4.476 15.096 0.00000:00:47

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
i59f67e4e.versanet.de 188
david.man.lodz.pl 96
TOTAL: 3 572

Newsgroup request counts (by category):

CategoryCountPct
1pl 58100.0%
TOTAL: 1 58100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 34
2pl.comp.pecet 24
TOTAL: 2 58