Daily Usenet report

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

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Aug 31 08:18:12 newsfeed nnrpd[24931]: SERVER perl filter not defined
Aug 31 16:24:21 newsfeed overchan[20526]: input line too long, skipping
Aug 31 16:52:02 newsfeed overchan[20526]: input line too long, skipping
Aug 31 16:52:03 newsfeed overchan[20526]: message repeated 4 times: [ input line too long, skipping]
Aug 31 16:52:33 newsfeed overchan[20526]: input line too long, skipping
Aug 31 20:01:26 newsfeed overchan[20526]: input line too long, skipping
Aug 31 20:08:59 newsfeed overchan[20526]: input line too long, skipping
Sep 1 02:04:28 newsfeed pgpverify[22723]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 405283 87.3%44.5 MB 86.1%
innfeed 47970 10.3%5.7 MB 11.0%
innd 7379 1.6%1.1 MB 2.2%
nnrpd 3376 0.7%318.8 KB 0.6%
controlchan 22 0.0%5.2 KB 0.0%
overchan 8 0.0%1.2 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 7 464039 100.0%51.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 403051 99.4%
Negative hits 2032 0.5%
Positive hits 326 0.1%
Cache misses 27 0.0%
TOTAL: 4 405436 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.503 0.0%61 0.000 24.639 95.000
article cleanup00:00:03.504 0.0%404834 0.003 0.009 0.014
article logging00:00:10.204 0.0%405190 0.014 0.025 0.131
article parse00:05:31.393 0.4%53579191 0.004 0.006 0.008
article write00:02:44.552 0.2%404592 0.241 0.407 3.151
artlog/artcncl00:00:00.000 0.0%60 0.000 0.000 0.000
data move00:00:21.961 0.0%56448220 0.000 0.000 0.001
hisgrep/artcncl00:00:00.301 0.0%61 0.000 4.934 23.000
hishave/artcncl00:00:00.017 0.0%61 0.000 0.279 12.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:47.348 0.2%407269 0.159 0.411 7.934
history sync00:00:00.014 0.0%290 0.000 0.048 0.500
history write00:09:18.276 0.6%404788 0.333 1.379 11.186
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle22:52:03.967 95.3%53027468 0.610 1.552 2.039
nntp read00:14:56.996 1.0%53303391 0.012 0.017 0.019
overview write00:00:01.163 0.0%404592 0.000 0.003 0.006
perl filter00:23:35.321 1.6%404788 2.848 3.496 4.467
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:10.835 0.0%821592 0.008 0.013 0.020
TOTAL: 24:00:00.42723:51:47.355 99.4%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.053 0.0%46926 0.000 0.001 0.007
article prepare00:00:00.002 0.0%7708 0.000 0.000 0.019
article read00:00:13.567 0.0%1923 0.000 7.055 94.267
backlog stats00:00:00.054 0.0%105791 0.000 0.001 0.005
callbacks00:00:00.000 0.0%2 0.000 0.000 0.000
data read00:00:00.416 0.0%51680 0.000 0.008 0.019
data write00:00:01.095 0.0%39469 0.005 0.028 0.072
idle23:54:23.372 99.9%105791 405.571 813.523 1334.121
status file00:00:49.882 0.1%16644 0.388 2.997 146.879
TOTAL: 23:55:31.53523:55:28.441100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:30:47.967 99.2%2765 0.000 668.342900050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.080 0.0%5925 0.000 0.014 0.500
readart00:00:00.000 0.0%22 0.000 0.000 0.000
TOTAL: 00:31:03.74700:30:48.047 99.2%----

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
news@sfere.anjou.terraraq.org.uk001001
us-control@lists.killfile.org000100
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 64 404579 404349 1 229 99%57:38:41
2news.icm.edu.pl 37 339 76 250 13 22%18:16:19
3localhost 1442 1 1 0 0 100%00:00:00
TOTAL: 3 1543 404919 404426 251 242 99%75:55:00
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl162.7 GB3.7 MB4.2 MB162.8 GB 99%421.8 KB
2news.icm.edu.pl5.9 MB12.4 KB212.5 KB6.1 MB 96%69.9 KB
3localhost1.8 KB0.0 KB0.0 KB1.8 KB100%1.8 KB
TOTAL: 3162.7 GB3.7 MB4.4 MB162.8 GB 99%421.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 31 04:15:01 - 04:59:59 9832 2.4% 3.644.6 GB 2.8%1793.23
Aug 31 05:00:00 - 05:59:59 13227 3.3% 3.676.3 GB 3.9%1830.68
Aug 31 06:00:00 - 06:59:59 13540 3.3% 3.766.3 GB 3.8%1825.47
Aug 31 07:00:00 - 07:59:59 15534 3.8% 4.326.4 GB 3.9%1860.85
Aug 31 08:00:00 - 08:59:59 32753 8.1% 9.109.6 GB 5.9%2805.92
Aug 31 09:00:00 - 09:59:59 21099 5.2% 5.867.7 GB 4.7%2248.19
Aug 31 10:00:00 - 10:59:59 21995 5.4% 6.117.8 GB 4.8%2266.07
Aug 31 11:00:00 - 11:59:59 14926 3.7% 4.156.3 GB 3.9%1848.11
Aug 31 12:00:00 - 12:59:59 20643 5.1% 5.736.3 GB 3.9%1842.90
Aug 31 13:00:00 - 13:59:59 16470 4.1% 4.586.3 GB 3.9%1847.60
Aug 31 14:00:00 - 14:59:59 16941 4.2% 4.716.3 GB 3.9%1848.87
Aug 31 15:00:00 - 15:59:59 17947 4.4% 4.996.4 GB 3.9%1871.08
Aug 31 16:00:00 - 16:59:59 15339 3.8% 4.266.4 GB 3.9%1857.10
Aug 31 17:00:00 - 17:59:59 15411 3.8% 4.286.4 GB 3.9%1856.73
Aug 31 18:00:00 - 18:59:59 14769 3.7% 4.106.4 GB 3.9%1861.03
Aug 31 19:00:00 - 19:59:59 14126 3.5% 3.926.4 GB 3.9%1862.86
Aug 31 20:00:00 - 20:59:59 14149 3.5% 3.936.4 GB 3.9%1853.96
Aug 31 21:00:00 - 21:59:59 15711 3.9% 4.366.5 GB 4.0%1880.23
Aug 31 22:00:00 - 22:59:59 14618 3.6% 4.066.4 GB 3.9%1863.99
Aug 31 23:00:00 - 23:59:59 15543 3.8% 4.326.4 GB 3.9%1862.81
Sep 1 00:00:00 - 00:59:59 15582 3.9% 4.336.3 GB 3.9%1845.50
Sep 1 01:00:00 - 01:59:59 14538 3.6% 4.046.4 GB 3.9%1857.22
Sep 1 02:00:00 - 02:59:59 17011 4.2% 4.736.4 GB 3.9%1859.89
Sep 1 03:00:00 - 03:59:59 19564 4.8% 5.4310.6 GB 6.5%3077.13
Sep 1 04:00:00 - 04:15:02 3358 0.8% 3.721.7 GB 1.0%1950.21
TOTAL: 24:00:01 404626 100.0% 4.68163.0 GB 100.0%1977.78
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 582 172 0 45 12 0 0 0 353
2news.icm.edu.pl 15 0 0 1 0 0 0 0 14
TOTAL: 2 597 172 0 46 12 0 0 0 367

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 63
comp.mobile.android 58
alt.comp.software.firefox 17
it.comp.os.win.windows10 11
alt.comp.software.seamonkey 10
it.tlc.cellulari.android 9
de.comp.lang.vbclassic 2
de.comm.provider.telefonie 1
it.discussioni.energia 1
TOTAL: 9 172

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

GroupsCount
pl.sci.historia 9
pl.praca.oferowana 3
TOTAL: 2 12

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 6
Too many newsgroups 4
Scoring filter (10) 2
TOTAL: 3 12

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 353
news.icm.edu.pl 2
TOTAL: 2 355
TOTAL: 1 355

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 17116 916 11063 56 0 1 5%23:58:47
2panorama 37259 331 9405 109 4 37199 0%23:59:50
3okapi 0 0 0 0 0 884 0%23:57:49
4poznan 85 0 64 0 0 0 0%06:42:56
5nask 0 0 0 0 0 8294 0%23:57:49
TOTAL: 5 54460 1247 20532 165 4 46378 2%102:37:11
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm2.8 MB156.3 KB3.0 MB0.0 KB/s3.1 KB23:58:47
2panorama1.0 MB398.3 KB1.4 MB0.0 KB/s3.3 KB23:59:50
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:49
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s006:42:56
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:49
TOTAL: 53.9 MB554.6 KB4.4 MB0.0 KB/s3.2 KB102:37:11
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 292 2224.2 KB 11 0 000:00:09
2isvcs01.man.lodz.pl 1 00.0 KB 0 1 000:00:00
TOTAL: 2 293 2224.2 KB 11 1 000:31:03

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 293 2224.2 KB 11 1 000:00:09
2*.neoplus.adsl.tpnet.pl 1 00.0 KB 0 0 000:00:24
3*.internet-census.org 8 00.0 KB 0 0 000:00:06
4unresolved 102 00.0 KB 0 0 000:30:23
TOTAL: 4 404 2224.2 KB 11 1 000:31:03

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
125.64.94.144 0.000 0.007 0.00000:30:10
alz28.neoplus.adsl.tpnet.pl 0.011 0.011 0.00000:00:24
165.227.221.108 0.000 0.008 0.00000:00:10
web.man.lodz.pl 0.789 1.653 0.00000:00:09
zl-dal-us-gp1-wk134.internet-census.org 0.024 0.031 0.00000:00:06
80.111.142.213 0.020 0.021 0.00000:00:02
212.51.192.185 0.259 0.474 0.00000:00:00
isvcs01.man.lodz.pl 0.004 0.011 0.00000:00:00
TOTAL: 8 1.107 2.216 0.00000:31:03

Curious NNRP server explorers [Top 20]:

SystemConn
212.51.192.185 96
zl-dal-us-gp1-wk134.internet-census.org 8
80.111.142.213 4
alz28.neoplus.adsl.tpnet.pl 1
125.64.94.144 1
165.227.221.108 1
TOTAL: 6 111

NNRP unrecognized commands (by host):

SystemConn
zl-dal-us-gp1-wk134.internet-census.org 14
TOTAL: 1 14

NNRP unrecognized commands (by command):

CommandCount
#026#003#001 2
À#007À#021 1
À$À#À 1
SSH-2.0-Go 1
Accept-Encoding: gzip 1
#001 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
À#011À#010À(À'À#024À#023À#022 1
GET / HTTP/1.1 1
Accept: */* 1
Host: 212.191.2.21:119 1
€.#001 1
˜V‰!&&¥#Ù#013؃P#004y #023äÝPÎ,ŽÎ 1
TOTAL: 13 14

NNRP client timeouts [Top 20]:

SystemConnPeer
125.64.94.144 1 0
TOTAL: 1 1 0

Newsgroup request counts (by category):

CategoryCountPct
1pl 22100.0%
TOTAL: 1 22100.0%

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

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