Daily Usenet report

Dec 1 04:15:02 -- Dec 1 19:16:30

Unknown entries from news log file:

First 11 / 11 lines (100.0%)

Dec 1 19:16:27
Dec 1 04:15:02 newsfeed nnrpd[27477]: web.man.lodz.pl rejected Flushing log and syslog files
Dec 1 04:15:02 newsfeed nnrpd[27485]: web.man.lodz.pl rejected Flushing log and syslog files
Dec 1 07:04:08 newsfeed pgpverify[17655]: pgpverify: verification failed
Dec 1 09:46:00 newsfeed nnrpd[23228]: SERVER perl filter not defined
Dec 1 09:55:42 newsfeed nnrpd[23566]: SERVER perl filter not defined
Dec 1 09:57:32 newsfeed nnrpd[23580]: SERVER perl filter not defined
Dec 1 10:06:10 newsfeed nnrpd[23850]: message repeated 6 times: [ wireless.ics.p.lodz.pl group lodz.test 0]
Dec 1 10:10:22 newsfeed nnrpd[23850]: SERVER perl filter not defined
Dec 1 13:34:25 newsfeed nnrpd[31114]: message repeated 2 times: [ 212.51.207.190 group pl.test 0]
Dec 1 14:31:19 newsfeed nnrpd[793]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn1735964 97.3%199.9 MB 96.8%
innfeed 31049 1.7%3.7 MB 1.8%
innd 14054 0.8%2.4 MB 1.2%
nnrpd 3417 0.2%372.4 KB 0.2%
controlchan 3 0.0%0.4 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 61784488 100.0%206.4 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1730950 97.9%
Negative hits 27031 1.5%
Positive hits 9703 0.5%
Cache misses 104 0.0%
TOTAL: 4 1767788 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:04.489 0.0%221 0.000 20.312 247.000
article cleanup00:00:28.966 0.1%1735155 0.008 0.017 0.028
article logging00:00:48.898 0.1%1735455 0.015 0.028 0.212
article parse00:50:14.706 5.6%164090395 0.008 0.018 0.075
article write00:32:56.491 3.7%1731735 0.418 1.141 6.593
artlog/artcncl00:00:00.004 0.0%204 0.000 0.020 1.000
artlog/artparse00:00:00.000 0.0%28 0.000 0.000 0.000
data move00:02:24.841 0.3%175166894 0.000 0.001 0.006
hisgrep/artcncl00:00:00.422 0.0%197 0.000 2.142 14.909
hishave/artcncl00:00:00.061 0.0%221 0.000 0.276 17.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:30:58.453 3.4%1769463 0.143 1.050 20.350
history sync00:00:00.010 0.0%182 0.000 0.055 1.000
history write00:43:19.484 4.8%1732735 0.215 1.500 36.449
hiswrite/artcncl00:00:00.027 0.0%24 0.000 1.125 9.000
idle07:18:39.584 48.7%108396100 0.089 0.243 0.369
nntp read00:47:24.843 5.3%162688058 0.009 0.017 0.036
overview write00:00:09.840 0.0%1731735 0.002 0.006 0.017
perl filter03:37:37.092 24.1%1732708 4.253 7.536 10.627
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:03:19.675 0.4%3573579 0.023 0.056 0.101
TOTAL: 15:01:10.91614:28:27.886 96.4%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.500 0.0%225701 0.000 0.002 0.032
article prepare00:00:00.005 0.0%13670 0.000 0.000 0.250
article read00:00:41.997 0.1%3406 0.000 12.330 1048.000
backlog stats00:00:00.238 0.0%304999 0.000 0.001 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.362 0.0%201182 0.000 0.012 0.062
data write00:00:03.611 0.0%92068 0.000 0.039 0.274
idle15:01:18.492 99.9%304999 67.409 177.307 953.072
status file00:00:08.891 0.0%10370 0.231 0.857 70.333
TOTAL: 15:02:26.35315:02:16.096100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle09:36:30.962 99.9%2877 0.000 12023.275600069.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:15.597 0.0%612412 0.000 0.025 2.308
readart00:00:12.974 0.0%701 0.000 18.508 31.077
TOTAL: 09:37:15.09609:36:59.533100.0%----

Control commands to INND:

CommandNumber
L 1
flush 15
go 2
logmode 1
mode 93
name 1
pause 1
paused 1
reserve 2
TOTAL: 9 117

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
us-control@lists.killfile.org000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 643 17320371728357 710 2970 99%230:50:29
2news.nask.pl 2 10222 3183 6627 412 31%15:49:26
3news.icm.edu.pl 28 195 48 81 66 24%09:54:15
4localhost 6 5 5 0 0 100%00:00:00
TOTAL: 4 679 17424591731593 7418 3448 99%256:34:10
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl519.6 GB17.4 MB175.3 MB519.8 GB 99%314.8 KB
2news.nask.pl11.0 MB1.1 MB1.4 MB13.6 MB 81%3.9 KB
3news.icm.edu.pl2.9 MB21.6 KB2.0 MB4.9 MB 58%43.7 KB
4localhost6.4 KB0.0 KB0.0 KB6.4 KB100%1.3 KB
TOTAL: 4519.6 GB18.6 MB178.7 MB519.8 GB 99%314.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 1 04:15:02 - 04:59:59 83368 4.8% 30.9020.8 GB 4.0%8085.77
Dec 1 05:00:00 - 05:59:59 122723 7.1% 34.0931.2 GB 6.0%9101.75
Dec 1 06:00:00 - 06:59:59 145527 8.4% 40.4238.5 GB 7.4%11225.54
Dec 1 07:00:00 - 07:59:59 115602 6.7% 32.1138.3 GB 7.4%11162.88
Dec 1 08:00:00 - 08:59:59 111995 6.5% 31.1137.5 GB 7.2%10916.62
Dec 1 09:00:00 - 09:59:59 114976 6.6% 31.9435.7 GB 6.9%10407.41
Dec 1 10:00:00 - 10:59:59 124155 7.2% 34.4931.9 GB 6.1%9297.35
Dec 1 11:00:00 - 11:59:59 132903 7.7% 36.9234.4 GB 6.6%10009.79
Dec 1 12:00:00 - 12:59:59 132319 7.6% 36.7636.4 GB 7.0%10593.75
Dec 1 13:00:00 - 13:59:59 85863 5.0% 23.8531.8 GB 6.1%9267.35
Dec 1 14:00:00 - 14:59:59 92928 5.4% 25.8134.7 GB 6.7%10094.22
Dec 1 15:00:00 - 15:59:59 112480 6.5% 31.2436.1 GB 7.0%10511.67
Dec 1 16:00:00 - 16:59:59 110466 6.4% 30.6835.7 GB 6.9%10391.02
Dec 1 17:00:00 - 17:59:59 96685 5.6% 26.8630.0 GB 5.8%8746.00
Dec 1 18:00:00 - 18:59:59 117944 6.8% 32.7635.8 GB 6.9%10435.69
Dec 1 19:00:00 - 19:16:30 32075 1.9% 32.4010.2 GB 2.0%10842.62
TOTAL: 15:01:28 1732009 100.0% 32.02519.1 GB 100.0%10063.77
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 3244 225 0 2056 3 0 0 0 960
2news.nask.pl 431 2 0 388 5 0 0 0 36
3news.icm.edu.pl 76 0 0 3 1 0 0 0 72
TOTAL: 3 3751 227 0 2447 9 0 0 0 1068

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 103
it.tlc.cellulari.android 62
it.comp.os.win.windows10 27
it.comp.os.win.windows7 11
uk.rec.cycling.moderated 4
hr.alt.cellular.gsm.iphone 4
comp.mobile.ipad 3
de.comp.lang.vbclassic 3
gmane.comp.gis.openstreetmap.devel 2
nl.comp.os.linux.techniek 2
comp.mobile.android 2
de.rec.sf.startrek 1
comp.sys.raspberry-pi 1
alt.windows7.general 1
hr.rec.glazba.hifi 1
TOTAL: 15 227

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

GroupsCount
pl.sci.historia 6
pl.praca.oferowana 2
bit.listserv.catholic 1
TOTAL: 3 9

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 663
EMP (md5) 62
Too many newsgroups 9
HTML post 4
Scoring filter (8) 1
TOTAL: 5 739

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 122540 1075 103795 457 1 120130 0%15:01:43
2icm 28660 474 18076 1079 0 6 1%15:06:38
3poznan 4606 96 2978 22 0 0 2%15:10:01
4nask 0 0 0 0 0 8395 0%15:00:01
5okapi 0 0 0 0 0 1613 0%15:00:01
TOTAL: 5 155806 1645 124849 1558 1 130144 1%75:18:24
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm7.9 MB253.1 MB261.1 MB4.9 KB/s172.1 KB15:06:38
2panorama4.0 MB3.8 MB7.8 MB0.1 KB/s5.2 KB15:01:43
3poznan439.1 KB40.5 KB479.7 KB0.0 KB/s4.1 KB15:10:01
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s015:00:01
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s015:00:01
TOTAL: 512.4 MB257.0 MB269.3 MB1.0 KB/s86.1 KB75:18:24
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama2.4 MB
TOTAL: 12.4 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1dmcs2.p.lodz.pl 11 400935.9 KB 6 0 003:01:39
2lze200.lze.lodz.pl 7 126230.5 KB 9 0 001:40:43
3pc-212-51-218-225.p.lodz.pl 4 125285.1 KB 5 0 001:23:58
4web.man.lodz.pl 183 2221.5 KB 11 0 000:00:18
5212.51.207.190 10 1536.4 KB 5 0 1600:43:28
6wireless.ics.p.lodz.pl 5 1124.4 KB 4 1 000:54:53
7212.191.87.58 9 22.0 KB 2 0 001:11:00
8isvcs01.man.lodz.pl 4 00.0 KB 0 4 000:00:01
9staticline-31-183-0-70.toya.net.pl 3 00.0 KB 0 0 300:03:56
TOTAL: 9 236 7011.5 MB 42 5 1909:37:14

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.p.lodz.pl 15 5251.2 MB 11 0 004:25:37
2*.lze.lodz.pl 7 126230.5 KB 9 0 001:40:43
3*.man.lodz.pl 427 2221.5 KB 11 4 000:00:22
4unresolved 22 1738.3 KB 7 0 1602:18:44
5*.ics.p.lodz.pl 5 1124.4 KB 4 1 000:54:53
6*.toya.net.pl 4 00.0 KB 0 0 300:16:52
TOTAL: 6 480 7011.5 MB 42 5 1909:37:14

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
dmcs2.p.lodz.pl 0.068 0.261 0.00003:01:39
lze200.lze.lodz.pl 0.038 0.136 0.00001:40:43
pc-212-51-218-225.p.lodz.pl 0.019 0.082 0.00001:23:58
212.191.87.58 1.090 0.679 0.00001:11:00
wireless.ics.p.lodz.pl 0.235 0.135 0.00000:54:53
212.51.207.190 1.092 0.574 0.00000:43:28
78.10.54.195 0.000 0.014 0.00000:23:59
staticline-31-183-19-236.toya.net.pl 0.000 0.014 0.00000:12:55
staticline-31-183-0-70.toya.net.pl 0.031 0.045 0.00000:03:56
web.man.lodz.pl 0.596 2.746 0.00000:00:18
212.51.203.199 0.008 0.029 0.00000:00:16
mon.man.lodz.pl 0.622 2.454 0.00000:00:01
isvcs01.man.lodz.pl 0.020 0.064 0.00000:00:01
david.man.lodz.pl 0.187 0.818 0.00000:00:00
? 0.012 0.035 0.00000:00:00
TOTAL: 15 4.018 8.086 0.00009:37:14

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 180
david.man.lodz.pl 60
212.51.203.199 2
78.10.54.195 1
staticline-31-183-19-236.toya.net.pl 1
TOTAL: 5 244

NNRP gethostbyaddr failures [Top 20]:

SystemConn
? (can't getpeername) 3
TOTAL: 1 3

NNRP client timeouts [Top 20]:

SystemConnPeer
lze200.lze.lodz.pl 2 0
pc-212-51-218-225.p.lodz.pl 2 0
wireless.ics.p.lodz.pl 1 0
dmcs2.p.lodz.pl 1 0
212.191.87.58 1 0
TOTAL: 5 7 0

Newsgroup request counts (by category):

CategoryCountPct
1pl 701100.0%
TOTAL: 1 701100.0%

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

NewsgroupCount
1pl.misc.elektronika 272
2pl.misc.kolej 253
3pl.comp.pecet 50
4pl.comp.os.ms-windows.winnt 38
5pl.test 28
6pl.rec.kuchnia 18
7pl.rec.dom 15
8pl.misc.telefonia.gsm 15
9pl.comp.os.linux 12
TOTAL: 9 701