Daily Usenet report

Jul 28 04:15:02 -- Jul 29 04:15:02

Unknown entries from news log file:

First 15 / 15 lines (100.0%)

Jul 28 04:20:01 newsfeed nnrpd[28330]: web.man.lodz.pl rejected Expiring process 28301
Jul 28 04:20:01 newsfeed nnrpd[28331]: web.man.lodz.pl rejected Expiring process 28301
Jul 28 04:20:01 newsfeed nnrpd[28332]: web.man.lodz.pl rejected Expiring process 28301
Jul 28 04:20:01 newsfeed nnrpd[28333]: web.man.lodz.pl rejected Expiring process 28301
Jul 28 04:20:01 newsfeed nnrpd[28334]: web.man.lodz.pl rejected Expiring process 28301
Jul 28 04:20:01 newsfeed nnrpd[28335]: web.man.lodz.pl rejected Expiring process 28301
Jul 28 04:20:01 newsfeed nnrpd[28339]: web.man.lodz.pl rejected Expiring process 28301
Jul 28 09:06:50 newsfeed nnrpd[24495]: SERVER perl filter not defined
Jul 28 10:02:40 newsfeed nnrpd[26322]: SERVER perl filter not defined
Jul 28 10:03:52 newsfeed nnrpd[26343]: SERVER perl filter not defined
Jul 28 12:46:48 newsfeed nnrpd[32072]: SERVER perl filter not defined
Jul 28 13:45:36 newsfeed nnrpd[1680]: SERVER perl filter not defined
Jul 28 13:48:46 newsfeed nnrpd[1709]: SERVER perl filter not defined
Jul 28 15:23:26 newsfeed pgpverify[4959]: pgpverify: verification failed
Jul 28 20:11:19 newsfeed nnrpd[15005]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn2340314 97.6%271.2 MB 97.2%
innfeed 32450 1.4%3.9 MB 1.4%
innd 19268 0.8%3.3 MB 1.2%
nnrpd 5235 0.2%566.7 KB 0.2%
controlchan 3 0.0%0.4 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 62397271 100.0%279.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2335529 98.4%
Negative hits 22333 0.9%
Positive hits 16489 0.7%
Cache misses 95 0.0%
TOTAL: 4 2374446 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.767 0.0%178 0.000 4.309 88.000
article cleanup00:00:30.060 0.0%2339470 0.000 0.013 0.027
article logging00:01:14.048 0.1%2339948 0.016 0.032 0.220
article parse00:56:41.868 3.9%104046972 0.000 0.033 0.049
article write00:38:58.894 2.7%2335694 0.000 1.001 3.509
artlog/artcncl00:00:00.003 0.0%167 0.000 0.018 0.056
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:01:41.864 0.1%118445640 0.000 0.001 0.001
hisgrep/artcncl00:00:00.208 0.0%154 0.000 1.351 26.000
hishave/artcncl00:00:00.115 0.0%178 0.000 0.646 13.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:20:45.333 1.4%2374959 0.146 0.524 11.303
history sync00:00:00.014 0.0%294 0.000 0.048 2.000
history write00:27:08.622 1.9%2336165 0.279 0.697 9.205
hiswrite/artcncl00:00:00.044 0.0%24 0.000 1.833 10.000
idle14:42:53.420 61.3%79569889 0.457 0.666 2093.655
nntp read00:45:47.968 3.2%102230014 0.020 0.027 0.056
overview write00:00:14.449 0.0%2335694 0.000 0.006 0.016
perl filter05:25:35.914 22.6%2336165 1.625 8.362 12.062
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:32.983 0.3%4855920 0.037 0.056 0.086
TOTAL: 24:00:12.72123:26:06.574 97.6%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.756 0.0%276958 0.000 0.003 0.054
article prepare00:00:00.024 0.0%79980 0.000 0.000 0.083
article read00:00:36.288 0.0%19970 0.000 1.817 394.333
backlog stats00:00:00.363 0.0%457308 0.000 0.001 0.017
callbacks00:00:00.000 0.0%3 0.000 0.000 0.000
data read00:00:03.961 0.0%311155 0.000 0.013 0.077
data write00:00:12.583 0.0%132089 0.000 0.095 0.406
idle23:58:41.298 99.9%457308 24.093 188.760 1824.273
status file00:00:08.526 0.0%10563 0.000 0.807 3.000
TOTAL: 24:00:00.01623:59:43.799100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.740 0.0%4874 0.120 0.152 2.969
idle04:05:34.132 99.9%30645 0.000 480.801 76000.750
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.235 0.0%62229 0.000 0.020 1.000
readart00:00:02.276 0.0%4907 0.000 0.464 12.344
TOTAL: 04:05:54.07404:05:38.383 99.9%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
gcn@news.nic.it000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 1022 23358742332117 330 3427 99%266:59:00
2news.nask.pl 2 16559 3845 12381 333 23%23:22:21
3news.icm.edu.pl 41 216 20 181 15 9%16:30:33
4localhost 8 7 7 0 0 100%00:00:00
TOTAL: 4 1073 23526562335989 12892 3775 99%306:51:54
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl727.2 GB17.4 MB21.9 MB727.3 GB 99%326.5 KB
2news.nask.pl24.3 MB1.1 MB1.2 MB26.7 MB 91%6.5 KB
3news.icm.edu.pl345.0 KB60.1 KB471.4 KB876.5 KB 39%25.0 KB
4localhost11.9 KB0.0 KB0.0 KB11.9 KB100%1.7 KB
TOTAL: 4727.3 GB18.6 MB23.6 MB727.3 GB 99%325.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 28 04:15:02 - 04:59:59 37997 1.6% 14.0814.8 GB 2.0%5750.17
Jul 28 05:00:00 - 05:59:59 70639 3.0% 19.6226.1 GB 3.6%7597.15
Jul 28 06:00:00 - 06:59:59 46548 2.0% 12.9318.5 GB 2.5%5390.92
Jul 28 07:00:00 - 07:59:59 94171 4.0% 26.1629.7 GB 4.1%8641.93
Jul 28 08:00:00 - 08:59:59 94899 4.1% 26.3628.5 GB 3.9%8308.35
Jul 28 09:00:00 - 09:59:59 74699 3.2% 20.7523.4 GB 3.2%6816.66
Jul 28 10:00:00 - 10:59:59 119855 5.1% 33.2934.3 GB 4.7%9995.54
Jul 28 11:00:00 - 11:59:59 120218 5.1% 33.3934.1 GB 4.7%9927.54
Jul 28 12:00:00 - 12:59:59 106172 4.5% 29.4932.2 GB 4.4%9376.78
Jul 28 13:00:00 - 13:59:59 97799 4.2% 27.1731.9 GB 4.4%9298.88
Jul 28 14:00:00 - 14:59:59 100002 4.3% 27.7832.0 GB 4.4%9325.91
Jul 28 15:00:00 - 15:59:59 86776 3.7% 24.1029.2 GB 4.0%8503.97
Jul 28 16:00:00 - 16:59:59 107926 4.6% 29.9832.5 GB 4.5%9474.13
Jul 28 17:00:00 - 17:59:59 118340 5.1% 32.8734.6 GB 4.8%10068.79
Jul 28 18:00:00 - 18:59:59 106900 4.6% 29.6933.1 GB 4.6%9638.46
Jul 28 19:00:00 - 19:59:59 100067 4.3% 27.8032.4 GB 4.5%9431.55
Jul 28 20:00:00 - 20:59:59 116609 5.0% 32.3936.6 GB 5.0%10653.42
Jul 28 21:00:00 - 21:59:59 128978 5.5% 35.8337.9 GB 5.2%11050.28
Jul 28 22:00:00 - 22:59:59 123735 5.3% 34.3737.7 GB 5.2%10970.92
Jul 28 23:00:00 - 23:59:59 112230 4.8% 31.1835.4 GB 4.9%10297.47
Jul 29 00:00:00 - 00:59:59 83809 3.6% 23.2826.3 GB 3.6%7647.98
Jul 29 01:00:00 - 01:59:59 114419 4.9% 31.7832.3 GB 4.4%9407.54
Jul 29 02:00:00 - 02:59:59 92186 3.9% 25.6127.5 GB 3.8%8004.99
Jul 29 03:00:00 - 03:59:59 58563 2.5% 16.2718.8 GB 2.6%5480.44
Jul 29 04:00:00 - 04:15:02 22357 1.0% 24.796.3 GB 0.9%7359.67
TOTAL: 24:00:00 2335894 100.0% 27.04726.0 GB 100.0%8810.96
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 3850 271 0 3002 9 0 0 0 568
2news.nask.pl 385 18 0 300 15 0 0 0 52
3news.icm.edu.pl 18 0 0 2 0 0 0 0 16
TOTAL: 3 4253 289 0 3304 24 0 0 0 636

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 126
de.comp.lang.php 35
it.comp.os.win.windows10 26
comp.mobile.android 24
it.tlc.cellulari.android 20
it.comp.os.win.windows7 19
hr.alt.cellular.gsm.iphone 9
alt.sex.telephones 7
uk.rec.cycling.moderated 7
nl.comp.os.linux.techniek 4
comp.sys.raspberry-pi 3
hr.alt.cellular.gsm.android 3
nl.actueel 3
it.comp.virtualizzazione 2
it.discussioni.energia 1
TOTAL: 15 289

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

GroupsCount
pl.praca.oferowana 13
pl.sci.matematyka 6
pl.sci.historia 5
TOTAL: 3 24

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 143
EMP (md5) 12
Scoring filter (9) 1
EMP (fsl) 1
Scoring filter (8) 1
TOTAL: 5 158

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 103133 2249 82586 812 8 191143 2%23:59:56
2icm 53174 1449 25333 14679 0 141 2%23:56:23
3poznan 5916 102 3767 41 0 0 1%23:54:29
4okapi 0 0 0 0 0 2716 0%24:00:02
5nask 0 0 0 0 0 13149 0%24:00:02
TOTAL: 5 162223 3800 111686 15532 8 207149 2%119:50:52
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm14.4 MB3.5 GB3.6 GB43.2 KB/s231.1 KB23:56:23
2panorama9.2 MB4.5 MB13.6 MB0.2 KB/s4.6 KB23:59:56
3poznan5.9 MB658.5 KB6.6 MB0.1 KB/s47.2 KB23:54:29
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:02
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:02
TOTAL: 529.5 MB3.5 GB3.6 GB8.7 KB/s193.9 KB119:50:52
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama10.5 MB
okapi488.3 KB
TOTAL: 211.0 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1lze200.lze.lodz.pl 4 62111.8 KB 6 0 000:20:53
2web.man.lodz.pl 294 5265.7 KB 23 0 000:00:29
3212.51.203.199 2 17.9 KB 1 0 000:02:10
4isvcs01.man.lodz.pl 7 00.0 KB 0 7 000:00:00
TOTAL: 4 307 115185.3 KB 30 7 004:05:53

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.lze.lodz.pl 4 62111.8 KB 6 0 000:20:53
2*.man.lodz.pl 685 5265.7 KB 23 7 000:00:33
3unresolved 11 17.9 KB 1 0 003:44:22
4*.toya.net.pl 75 00.0 KB 0 0 000:00:04
TOTAL: 4 775 115185.3 KB 30 7 004:05:53

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
185.48.195.24 1.295 2.284 0.00002:19:58
185.48.194.160 0.168 0.400 0.00000:47:01
185.48.195.94 0.486 0.658 0.00000:35:11
lze200.lze.lodz.pl 0.023 0.091 0.00000:20:53
212.51.203.199 0.004 0.039 0.00000:02:10
web.man.lodz.pl 1.067 4.892 0.00000:00:29
staticline41435.toya.net.pl 0.305 1.298 0.00000:00:04
mon.man.lodz.pl 0.965 5.235 0.00000:00:03
david.man.lodz.pl 0.304 1.658 0.00000:00:00
isvcs01.man.lodz.pl 0.043 0.141 0.00000:00:00
TOTAL: 10 4.660 16.696 0.00004:05:53

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
staticline41435.toya.net.pl 75
185.48.195.24 5
185.48.195.94 2
185.48.194.160 2
TOTAL: 6 468

NNRP client timeouts [Top 20]:

SystemConnPeer
185.48.195.94 1 0
185.48.194.160 1 0
185.48.195.24 1 0
TOTAL: 3 3 0

Newsgroup request counts (by category):

CategoryCountPct
1pl 115100.0%
TOTAL: 1 115100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 62
2pl.comp.os.linux 24
3pl.comp.pecet 17
4pl.misc.telefonia.gsm 7
5pl.rec.kuchnia 4
6pl.rec.radio.amatorskie 1
TOTAL: 6 115