Daily Usenet report

Jul 10 04:15:03 -- Jul 11 04:15:04

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Jul 10 09:57:35 newsfeed nnrpd[14697]: SERVER perl filter not defined
Jul 10 10:00:14 newsfeed nnrpd[14783]: SERVER perl filter not defined
Jul 10 10:02:05 newsfeed nnrpd[14815]: SERVER perl filter not defined
Jul 10 10:06:43 newsfeed nnrpd[14909]: SERVER perl filter not defined
Jul 10 10:08:20 newsfeed nnrpd[15053]: SERVER perl filter not defined
Jul 10 10:19:34 newsfeed nnrpd[15402]: SERVER perl filter not defined
Jul 10 13:20:59 newsfeed nnrpd[21463]: SERVER perl filter not defined
Jul 10 13:51:12 newsfeed nnrpd[22449]: SERVER perl filter not defined
Jul 10 14:12:24 newsfeed nnrpd[23132]: SERVER perl filter not defined
Jul 10 18:50:03 newsfeed controlchan[2225]: Multiple control headers in article <nCpHI-3cB-11@gated-at.bofh.it>

Log entries by program:

Program nameLines%LinesSize%Size
inn1903127 97.9%218.8 MB 97.4%
innd 22114 1.1%3.4 MB 1.5%
nnrpd 12285 0.6%1.4 MB 0.6%
innfeed 6892 0.4%1.0 MB 0.4%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 51944419 100.0%224.6 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1897869 95.8%
Negative hits 63663 3.2%
Positive hits 18956 1.0%
Cache misses 142 0.0%
TOTAL: 4 1980630 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:07.558 0.0%307 0.000 24.619 720.000
article cleanup00:00:28.646 0.0%1903427 0.000 0.015 0.032
article logging00:00:49.805 0.1%1903550 0.008 0.026 0.285
article parse01:13:26.491 5.1%204852890 0.008 0.022 0.077
article write00:19:03.129 1.3%1893219 0.228 0.604 2.904
artlog/artcncl00:00:00.003 0.0%300 0.000 0.010 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:04:03.255 0.3%217380546 0.000 0.001 0.012
hisgrep/artcncl00:00:01.844 0.0%249 0.000 7.406 253.000
hishave/artcncl00:00:01.488 0.0%307 0.000 4.847 188.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup02:45:01.169 11.5%1982531 0.005 4.994 13.717
history sync00:00:00.016 0.0%292 0.000 0.055 1.000
history write03:49:16.611 15.9%1899459 2.707 7.242 20.499
hiswrite/artcncl00:00:00.573 0.0%58 0.000 9.879 121.000
idle09:40:27.537 40.3%145224424 0.140 0.240 1.006
nntp read01:05:52.016 4.6%203480535 0.008 0.019 0.043
overview write00:00:11.401 0.0%1893219 0.000 0.006 0.018
perl filter04:19:24.668 18.0%1899459 5.303 8.194 11.266
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:03:41.806 0.3%3836769 0.024 0.058 0.086
TOTAL: 24:00:32.69723:21:58.016 97.3%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.162 0.0%50328 0.000 0.003 0.111
article prepare00:00:00.009 0.0%24732 0.000 0.000 0.125
article read00:00:01.935 0.0%5702 0.000 0.339 27.000
backlog stats00:00:00.193 0.0%334025 0.000 0.001 0.017
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.881 0.0%187875 0.000 0.010 0.058
data write00:00:06.254 0.0%157186 0.000 0.040 12.000
idle23:59:40.980100.0%334025 0.000 258.606 28951.000
status file00:00:00.510 0.0%192 0.000 2.656 153.000
TOTAL: 23:59:59.02823:59:51.924100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:11:14.692 98.8%18071 0.000 236.550 20459.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.774 0.0%39241 0.000 0.020 2.667
readart00:00:00.710 0.0%419 0.000 1.695 31.923
TOTAL: 01:12:07.03801:11:16.176 98.8%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 841 18978941888087 661 9146 99%318:49:43
2news.nask.pl 2 19510 4431 14011 1068 22%24:01:34
3localhost 10 9 9 0 0 100%00:00:01
4news.icm.edu.pl 39 243 3 236 4 1%18:22:27
TOTAL: 4 892 19176561892530 14908 10218 98%361:13:45
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl610.9 GB11.4 MB968.5 MB611.9 GB 99%338.2 KB
2news.nask.pl21.2 MB3.0 MB3.0 MB27.2 MB 77%5.1 KB
3news.icm.edu.pl67.7 KB0.0 KB222.4 KB290.1 KB 23%41.4 KB
4localhost12.8 KB0.0 KB0.0 KB12.8 KB100%1.4 KB
TOTAL: 4611.0 GB14.4 MB971.8 MB611.9 GB 99%337.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 10 04:15:03 - 04:59:59 51485 2.7% 19.0920.6 GB 3.4%8012.44
Jul 10 05:00:00 - 05:59:59 65616 3.5% 18.2326.4 GB 4.3%7696.44
Jul 10 06:00:00 - 06:59:59 69644 3.7% 19.3527.9 GB 4.6%8128.81
Jul 10 07:00:00 - 07:59:59 74376 3.9% 20.6628.2 GB 4.6%8206.27
Jul 10 08:00:00 - 08:59:59 69612 3.7% 19.3425.6 GB 4.2%7451.16
Jul 10 09:00:00 - 09:59:59 74273 3.9% 20.6327.4 GB 4.5%7980.57
Jul 10 10:00:00 - 10:59:59 88464 4.7% 24.5731.3 GB 5.1%9128.94
Jul 10 11:00:00 - 11:59:59 70033 3.7% 19.4525.3 GB 4.1%7354.79
Jul 10 12:00:00 - 12:59:59 75652 4.0% 21.0128.3 GB 4.6%8255.14
Jul 10 13:00:00 - 13:59:59 96141 5.1% 26.7132.3 GB 5.3%9403.58
Jul 10 14:00:00 - 14:59:59 95346 5.0% 26.4831.3 GB 5.1%9122.56
Jul 10 15:00:00 - 15:59:59 69736 3.7% 19.3725.6 GB 4.2%7450.61
Jul 10 16:00:00 - 16:59:59 68280 3.6% 18.9724.6 GB 4.0%7160.54
Jul 10 17:00:00 - 17:59:59 57095 3.0% 15.8620.6 GB 3.4%6008.81
Jul 10 18:00:00 - 18:59:59 51032 2.7% 14.1816.5 GB 2.7%4808.11
Jul 10 19:00:00 - 19:59:59 64347 3.4% 17.8717.5 GB 2.9%5094.37
Jul 10 20:00:00 - 20:59:59 62179 3.3% 17.2717.4 GB 2.8%5072.92
Jul 10 21:00:00 - 21:59:59 75046 4.0% 20.8517.9 GB 2.9%5216.82
Jul 10 22:00:00 - 22:59:59 93493 4.9% 25.9719.3 GB 3.2%5623.74
Jul 10 23:00:00 - 23:59:59 91356 4.8% 25.3819.0 GB 3.1%5541.17
Jul 11 00:00:00 - 00:59:59 112003 5.9% 31.1125.5 GB 4.2%7433.41
Jul 11 01:00:00 - 01:59:59 102206 5.4% 28.3932.3 GB 5.3%9412.67
Jul 11 02:00:00 - 02:59:59 102288 5.4% 28.4133.7 GB 5.5%9824.26
Jul 11 03:00:00 - 03:59:59 86941 4.6% 24.1528.9 GB 4.7%8421.87
Jul 11 04:00:00 - 04:15:04 25853 1.4% 28.608.0 GB 1.3%9236.10
TOTAL: 24:00:01 1892497 100.0% 21.90611.5 GB 100.0%7421.56
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 9258 232 0 2917 0 0 0 0 6109
2news.nask.pl 1068 5 0 1050 0 0 0 0 13
3news.icm.edu.pl 4 0 0 0 0 0 0 0 4
TOTAL: 3 10330 237 0 3967 0 0 0 0 6126

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 84
it.tlc.cellulari.android 55
it.comp.os.win.windows7 22
nl.comp.sys.android 14
de.comp.lang.php 13
nl.comp.os.linux.techniek 9
uk.rec.cycling.moderated 7
it.comp.os.win.windows8 7
comp.mobile.ipad 6
comp.sys.raspberry-pi 4
it.tlc.cellulari.iphone 3
alt.sex.telephones 3
hr.ponuda.hardver.komponente 3
hr.ponuda.hardver.periferije 2
comp.mobile.android 2
nl.wetenschap.regulier 1
it.discussioni.energia 1
hr.alt.cellular.gsm.iphone 1
TOTAL: 18 237

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 5994
EMP (md5) 3
HTML post 3
Scoring filter (8) 2
EMP (fsl) 1
TOTAL: 5 6003

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 55336 1658 48222 358 0 0 2%23:53:30
2icm 54721 1417 28096 1871 2 6 2%23:58:02
3nask 27624 504 16320 321 0 0 1%24:00:30
4poznan 5683 54 4089 24 0 0 0%23:52:07
5okapi 0 0 0 0 0 2734 0%24:00:01
TOTAL: 5 143364 3633 96727 2574 2 2740 2%119:44:10
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm85.1 MB552.1 MB637.2 MB7.6 KB/s198.5 KB23:58:02
2nask55.4 MB80.3 MB135.7 MB1.6 KB/s168.5 KB24:00:30
3panorama6.1 MB5.9 MB12.0 MB0.1 KB/s6.1 KB23:53:30
4poznan216.4 KB102.2 KB318.6 KB0.0 KB/s4.1 KB23:52:07
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
TOTAL: 5146.8 MB638.4 MB785.2 MB1.9 KB/s129.5 KB119:44:10
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1pc-skrzep2.cm.p.lodz.pl 287 375528.3 KB 287 0 000:00:12
2web.man.lodz.pl 288 4440.0 KB 19 0 000:00:23
3isvcs01.man.lodz.pl 9 00.0 KB 0 9 000:00:02
TOTAL: 3 584 419568.3 KB 306 9 001:12:04

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 287 375528.3 KB 287 0 000:00:12
2*.man.lodz.pl 681 4440.0 KB 19 9 000:00:32
3*.pa.nsw.optusnet.com.au1269 00.0 KB 0 0 000:35:04
4unresolved 4 00.0 KB 0 0 000:04:10
5*.206.15.62.static.jazztel.es 6 00.0 KB 0 0 000:31:55
6*.toya.net.pl 83 00.0 KB 0 0 000:00:09
TOTAL: 62330 419568.3 KB 306 9 001:12:04

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
pa49-181-247-58.pa.nsw.optusnet.com.au 3.480 11.664 0.00000:35:04
229.206.15.62.static.jazztel.es 0.400 0.648 0.00000:31:55
194.33.77.50 0.016 0.024 0.00000:04:10
web.man.lodz.pl 0.676 2.596 0.00000:00:23
pc-skrzep2.cm.p.lodz.pl 0.760 2.656 0.00000:00:12
staticline41435.toya.net.pl 0.228 0.800 0.00000:00:09
mon.man.lodz.pl 0.584 2.380 0.00000:00:04
isvcs01.man.lodz.pl 0.056 0.116 0.00000:00:02
david.man.lodz.pl 0.164 0.900 0.00000:00:01
TOTAL: 9 6.364 21.784 0.00001:12:04

Curious NNRP server explorers [Top 20]:

SystemConn
pa49-181-247-58.pa.nsw.optusnet.com.au 1269
mon.man.lodz.pl 288
david.man.lodz.pl 96
staticline41435.toya.net.pl 83
229.206.15.62.static.jazztel.es 6
194.33.77.50 4
TOTAL: 6 1746

NNRP client timeouts [Top 20]:

SystemConnPeer
229.206.15.62.static.jazztel.es 2 0
TOTAL: 1 2 0

Newsgroup request counts (by category):

CategoryCountPct
1lodman 375 89.5%
2pl 44 10.5%
TOTAL: 2 419100.0%

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

NewsgroupCount
1lodman.info 375
2pl.comp.pecet 34
3pl.comp.os.ms-windows.winnt 10
TOTAL: 3 419