Daily Usenet report

Oct 17 04:15:02 -- Oct 18 04:15:02

Unknown entries from news log file:

First 15 / 15 lines (100.0%)

Oct 17 08:56:01 newsfeed nnrpd[1373]: SERVER perl filter not defined
Oct 17 13:10:06 newsfeed pgpverify[10668]: pgpverify: verification failed
Oct 17 13:21:00 newsfeed nnrpd[11057]: SERVER perl filter not defined
Oct 17 13:23:31 newsfeed nnrpd[11099]: SERVER perl filter not defined
Oct 17 13:24:30 newsfeed nnrpd[11112]: SERVER perl filter not defined
Oct 17 14:57:29 newsfeed overchan[22543]: input line too long, skipping
Oct 17 15:21:49 newsfeed nnrpd[15559]: SERVER perl filter not defined
Oct 17 15:41:33 newsfeed overchan[22543]: input line too long, skipping
Oct 17 16:14:01 newsfeed overchan[22543]: input line too long, skipping
Oct 17 16:15:55 newsfeed overchan[22543]: input line too long, skipping
Oct 17 16:20:30 newsfeed overchan[22543]: input line too long, skipping
Oct 17 18:35:24 newsfeed overchan[22543]: input line too long, skipping
Oct 17 18:53:49 newsfeed overchan[22543]: input line too long, skipping
Oct 17 20:54:55 newsfeed overchan[22543]: input line too long, skipping
Oct 17 21:03:05 newsfeed overchan[22543]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2571018 97.2%290.8 MB 96.8%
innfeed 49107 1.9%5.9 MB 1.9%
innd 19099 0.7%3.2 MB 1.1%
nnrpd 4932 0.2%521.6 KB 0.2%
overchan 10 0.0%1.6 KB 0.0%
controlchan 4 0.0%0.5 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 72644171 100.0%300.3 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2552369 92.6%
Negative hits 105193 3.8%
Positive hits 96013 3.5%
Cache misses 1345 0.0%
TOTAL: 4 2754920 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:03.391 0.0%98 0.000 34.602 113.000
article cleanup00:00:34.698 0.0%2571485 0.010 0.013 0.022
article logging00:01:53.084 0.1%2571950 0.031 0.044 0.083
article parse00:45:41.021 3.2%84313972 0.020 0.033 0.047
article write00:17:46.747 1.2%2560784 0.289 0.417 0.658
artlog/artcncl00:00:00.001 0.0%96 0.000 0.010 0.250
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:02:26.256 0.2%98253495 0.001 0.001 0.003
hisgrep/artcncl00:00:00.841 0.0%96 0.000 8.760 85.000
hishave/artcncl00:00:00.097 0.0%98 0.000 0.990 5.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup01:45:48.063 7.3%2767011 0.641 2.294 6.024
history sync00:00:00.025 0.0%291 0.000 0.086 1.000
history write03:45:23.232 15.7%2563543 1.830 5.275 11.170
hiswrite/artcncl00:00:00.001 0.0%2 0.000 0.500 1.000
idle11:17:08.516 47.0%58431132 0.269 0.695 1.327
nntp read01:05:05.458 4.5%82445843 0.036 0.047 0.064
overview write00:00:13.470 0.0%2560784 0.003 0.005 0.008
perl filter04:23:50.783 18.3%2563543 3.814 6.175 9.254
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:05:15.009 0.4%5287428 0.048 0.060 0.074
TOTAL: 24:00:05.21523:31:10.693 98.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:01.050 0.0%359211 0.000 0.003 0.006
article prepare00:00:00.071 0.0%269394 0.000 0.000 0.004
article read00:02:10.709 0.2%60570 0.000 2.158 22.997
backlog stats00:00:01.455 0.0%1396567 0.000 0.001 0.003
callbacks00:00:00.000 0.0%4 0.000 0.000 0.000
data read00:00:13.935 0.0%650089 0.010 0.021 0.033
data write00:03:57.256 0.3%769148 0.057 0.308 0.628
idle23:43:30.679 99.5%1396567 22.837 61.158 312.228
status file00:00:21.355 0.0%17203 0.800 1.241 3.057
TOTAL: 23:51:01.93023:50:16.510 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:12:16.133 97.9%3116 0.000 236.243 43054.714
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.345 0.0%6980 0.000 0.049 2.111
readart00:00:00.019 0.0%77 0.000 0.247 13.000
TOTAL: 00:12:31.72400:12:16.497 98.0%----

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
newsmaster@carnet.hr000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 804 25597942552830 3107 3857 99%505:01:09
2news.nask.pl 2 100719 6735 87167 6817 6%24:05:59
3news.icm.edu.pl 37 271 116 117 38 42%16:37:58
4localhost 6 5 5 0 0 100%00:00:00
TOTAL: 4 849 26607892559686 90391 10712 96%545:45:06
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl701.1 GB274.7 MB443.1 MB701.8 GB 99%287.8 KB
2news.nask.pl845.6 MB1.5 GB1.5 GB3.8 GB 22%290.3 KB
3news.icm.edu.pl2.1 MB72.3 KB1.2 MB3.3 MB 62%22.0 KB
4localhost7.9 KB0.0 KB0.0 KB7.9 KB100%1.6 KB
TOTAL: 4702.0 GB1.7 GB1.9 GB705.6 GB 99%287.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 17 04:15:02 - 04:59:59 80024 3.1% 29.6624.7 GB 3.5%9590.74
Oct 17 05:00:00 - 05:59:59 107926 4.2% 29.9831.0 GB 4.4%9039.85
Oct 17 06:00:00 - 06:59:59 110270 4.3% 30.6332.2 GB 4.6%9371.17
Oct 17 07:00:00 - 07:59:59 103139 4.0% 28.6531.4 GB 4.5%9155.04
Oct 17 08:00:00 - 08:59:59 94019 3.7% 26.1229.3 GB 4.2%8534.18
Oct 17 09:00:00 - 09:59:59 111284 4.3% 30.9131.3 GB 4.5%9105.80
Oct 17 10:00:00 - 10:59:59 97367 3.8% 27.0525.5 GB 3.6%7430.99
Oct 17 11:00:00 - 11:59:59 122404 4.8% 34.0033.0 GB 4.7%9601.18
Oct 17 12:00:00 - 12:59:59 167610 6.5% 46.5635.6 GB 5.1%10370.20
Oct 17 13:00:00 - 13:59:59 167086 6.5% 46.4137.4 GB 5.3%10892.93
Oct 17 14:00:00 - 14:59:59 89768 3.5% 24.9424.1 GB 3.4%7019.02
Oct 17 15:00:00 - 15:59:59 143872 5.6% 39.9639.9 GB 5.7%11607.33
Oct 17 16:00:00 - 16:59:59 154793 6.0% 43.0040.7 GB 5.8%11854.14
Oct 17 17:00:00 - 17:59:59 122536 4.8% 34.0432.0 GB 4.6%9334.17
Oct 17 18:00:00 - 18:59:59 96018 3.8% 26.6726.7 GB 3.8%7767.79
Oct 17 19:00:00 - 19:59:59 87353 3.4% 24.2625.7 GB 3.7%7474.04
Oct 17 20:00:00 - 20:59:59 77666 3.0% 21.5722.2 GB 3.2%6469.91
Oct 17 21:00:00 - 21:59:59 105483 4.1% 29.3029.0 GB 4.1%8449.83
Oct 17 22:00:00 - 22:59:59 85755 3.4% 23.8223.5 GB 3.3%6846.52
Oct 17 23:00:00 - 23:59:59 70118 2.7% 19.4818.6 GB 2.7%5422.68
Oct 18 00:00:00 - 00:59:59 111325 4.3% 30.9230.0 GB 4.3%8749.08
Oct 18 01:00:00 - 01:59:59 96380 3.8% 26.7728.9 GB 4.1%8412.40
Oct 18 02:00:00 - 02:59:59 56895 2.2% 15.8016.8 GB 2.4%4895.57
Oct 18 03:00:00 - 03:59:59 80777 3.2% 22.4425.9 GB 3.7%7533.24
Oct 18 04:00:00 - 04:15:02 19910 0.8% 22.076.6 GB 0.9%7727.86
TOTAL: 24:00:00 2559778 100.0% 29.63702.0 GB 100.0%8519.21
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 6885 16 0 5351 2 0 0 0 1516
2newsfeed.pionier.net.pl 4225 220 0 2576 0 0 0 0 1429
3news.icm.edu.pl 34 0 0 2 0 0 0 0 32
TOTAL: 3 11144 236 0 7929 2 0 0 0 2977

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 128
it.comp.os.win.windows10 53
comp.mobile.android 17
it.tlc.cellulari.android 13
comp.mobile.ipad 9
it.comp.os.win.windows7 6
uk.rec.cycling.moderated 4
nl.comp.os.linux.techniek 3
de.comm.software.mailreader 2
nl.comp.sys.android 1
TOTAL: 10 236

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

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

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1236
Binary in non-binary group 1131
EMP (phl) 56
Scoring filter (16) 25
Poison newsgroup 22
Scoring filter (8) 21
Scoring filter (9) 10
Too many newsgroups 4
Scoring filter (11) 2
Scoring filter (18) 2
Scoring filter (10) 2
EMP (fsl) 1
HTML post 1
TOTAL: 13 2513

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 371
news.nask.pl 93
TOTAL: 2 464
TOTAL: 1 464

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nask 214132 56110 96152 402 0 5266 26%23:59:58
2panorama 199593 861 170288 194 5 184209 0%23:59:58
3poznan 7145 71 5025 16 0 0 0%23:59:13
4icm 188214 36 155249 9909 0 0 0%23:59:58
5okapi 0 0 0 0 0 1005 0%23:57:51
TOTAL: 5 609084 57078 426714 10521 5 190480 9%119:56:58
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask29.0 GB148.2 MB29.2 GB354.3 KB/s541.6 KB23:59:58
2panorama9.5 MB2.5 MB11.9 MB0.1 KB/s11.6 KB23:59:58
3icm3.3 MB5.4 GB5.4 GB65.5 KB/s568.7 KB23:59:58
4poznan301.4 KB60.8 KB362.2 KB0.0 KB/s4.2 KB23:59:13
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
TOTAL: 529.1 GB5.5 GB34.6 GB84.0 KB/s536.6 KB119:56:58
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 7673.4 KB 34 0 000:00:25
287-205-226-145.adsl.inetia.pl 2 11.5 KB 1 0 000:09:46
3isvcs01.man.lodz.pl 5 00.0 KB 0 5 000:00:01
TOTAL: 3 295 7774.9 KB 35 5 000:12:30

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 581 7673.4 KB 34 5 000:00:30
2*.adsl.inetia.pl 2 11.5 KB 1 0 000:09:46
3unresolved 97 00.0 KB 0 0 000:02:13
TOTAL: 3 680 7774.9 KB 35 5 000:12:30

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
87-205-226-145.adsl.inetia.pl 0.044 0.108 0.00000:09:46
91.234.126.166 0.064 0.048 0.00000:02:12
web.man.lodz.pl 1.532 7.028 0.00000:00:25
mon.man.lodz.pl 1.356 6.684 0.00000:00:04
isvcs01.man.lodz.pl 0.032 0.168 0.00000:00:01
212.51.192.185 0.392 2.124 0.00000:00:01
TOTAL: 6 3.420 16.160 0.00000:12:30

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
91.234.126.166 1
TOTAL: 3 385

Newsgroup request counts (by category):

CategoryCountPct
1pl 76 98.7%
2lodman 1 1.3%
TOTAL: 2 77100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 48
2pl.comp.pecet 28
3lodman.info 1
TOTAL: 3 77