Daily Usenet report

Dec 28 04:15:02 -- Dec 29 04:15:03

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Dec 28 09:26:37 newsfeed nnrpd[2602]: SERVER perl filter not defined
Dec 28 10:06:11 newsfeed nnrpd[3905]: SERVER perl filter not defined
Dec 28 11:06:45 newsfeed nnrpd[5867]: SERVER perl filter not defined
Dec 28 18:38:35 newsfeed nnrpd[20680]: SERVER perl filter not defined
Dec 28 22:45:39 newsfeed nnrpd[28669]: SERVER perl filter not defined
Dec 29 01:28:05 newsfeed pgpverify[1640]: pgpverify: verification failed
Dec 29 02:38:08 newsfeed nnrpd[3989]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn2234941 98.5%260.1 MB 98.1%
innd 18111 0.8%3.1 MB 1.2%
nnrpd 7958 0.4%820.1 KB 0.3%
innfeed 7025 0.3%1.1 MB 0.4%
controlchan 1 0.0%0.1 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 62268037 100.0%265.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2228398 96.0%
Negative hits 61119 2.6%
Positive hits 30323 1.3%
Cache misses 859 0.0%
TOTAL: 4 2320699 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:10.525 0.0%281 0.000 37.456 724.000
article cleanup00:00:34.814 0.0%2235096 0.004 0.016 0.028
article logging00:01:05.565 0.1%2235198 0.011 0.029 0.346
article parse01:13:13.455 5.1%177412006 0.006 0.025 0.063
article write00:18:16.370 1.3%2227965 0.285 0.492 1.567
artlog/artcncl00:00:00.005 0.0%280 0.000 0.018 1.000
artlog/artparse00:00:00.000 0.0%7 0.000 0.000 0.000
data move00:02:45.092 0.2%191418394 0.000 0.001 0.002
hisgrep/artcncl00:00:01.445 0.0%226 0.000 6.394 68.750
hishave/artcncl00:00:01.036 0.0%281 0.000 3.687 137.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup02:57:42.065 12.3%2321700 1.291 4.592 12.663
history sync00:00:00.015 0.0%294 0.000 0.051 1.000
history write02:53:15.675 12.0%2229272 2.481 4.663 30.160
hiswrite/artcncl00:00:00.155 0.0%55 0.000 2.818 42.500
idle09:46:42.778 40.7%108751249 0.169 0.324 1.263
nntp read00:59:52.560 4.2%175737250 0.008 0.020 0.035
overview write00:00:14.171 0.0%2227965 0.001 0.006 0.015
perl filter05:02:41.773 21.0%2229265 5.038 8.147 10.117
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:34.181 0.3%4492345 0.020 0.061 0.087
TOTAL: 24:00:32.82423:21:11.680 97.3%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.144 0.0%36623 0.000 0.004 0.125
article prepare00:00:00.014 0.0%48752 0.000 0.000 0.062
article read00:00:04.076 0.0%12009 0.000 0.339 144.500
backlog stats00:00:00.208 0.0%277028 0.000 0.001 0.017
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.904 0.0%159127 0.000 0.012 0.088
data write00:00:08.965 0.0%140523 0.000 0.064 3.000
idle23:59:06.076100.0%277028 0.000 311.687 21099.000
status file00:00:00.703 0.0%276 0.000 2.547 127.000
TOTAL: 23:59:29.10623:59:22.090100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle16:01:28.007 99.9%4869 0.000 11848.020568848.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.303 0.0%11600 0.000 0.026 2.556
readart00:00:01.940 0.0%390 0.000 4.974 251.000
TOTAL: 16:02:04.71716:01:30.250 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
moderator@dana.de000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 787 22233042216587 1134 5583 99%383:40:59
2news.task.gda.pl 22 23468 6411 16245 812 27%44:41:43
3news.nask.pl 3 13762 5919 7131 712 43%24:04:26
4localhost 7 6 6 0 0 100%00:00:00
5news.icm.edu.pl 44 195 3 188 4 1%16:22:58
TOTAL: 5 863 22607352228926 24698 7111 98%468:50:06
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl685.7 GB52.9 MB62.7 MB685.8 GB 99%323.6 KB
2news.nask.pl20.0 MB1.8 MB1.8 MB23.7 MB 84%3.7 KB
3news.task.gda.pl11.8 MB25.4 KB2.2 MB14.0 MB 84%2.0 KB
4news.icm.edu.pl81.5 KB55.8 KB111.4 KB248.6 KB 32%35.5 KB
5localhost8.5 KB0.0 KB0.0 KB8.5 KB100%1.4 KB
TOTAL: 5685.7 GB54.8 MB66.8 MB685.8 GB 99%321.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 28 04:15:02 - 04:59:59 62334 2.8% 23.1018.6 GB 2.7%7215.05
Dec 28 05:00:00 - 05:59:59 107499 4.8% 29.8632.9 GB 4.8%9594.23
Dec 28 06:00:00 - 06:59:59 92842 4.2% 25.7928.6 GB 4.2%8336.68
Dec 28 07:00:00 - 07:59:59 104451 4.7% 29.0133.1 GB 4.8%9642.62
Dec 28 08:00:00 - 08:59:59 105787 4.7% 29.3933.6 GB 4.9%9799.45
Dec 28 09:00:00 - 09:59:59 96642 4.3% 26.8430.0 GB 4.4%8744.21
Dec 28 10:00:00 - 10:59:59 86756 3.9% 24.1025.9 GB 3.8%7550.85
Dec 28 11:00:00 - 11:59:59 74766 3.4% 20.7722.4 GB 3.3%6533.90
Dec 28 12:00:00 - 12:59:59 99727 4.5% 27.7031.1 GB 4.5%9044.49
Dec 28 13:00:00 - 13:59:59 87890 3.9% 24.4126.9 GB 3.9%7839.73
Dec 28 14:00:00 - 14:59:59 90196 4.0% 25.0528.3 GB 4.1%8242.97
Dec 28 15:00:00 - 15:59:59 94154 4.2% 26.1528.0 GB 4.1%8153.31
Dec 28 16:00:00 - 16:59:59 80305 3.6% 22.3124.1 GB 3.5%7030.44
Dec 28 17:00:00 - 17:59:59 98231 4.4% 27.2930.6 GB 4.5%8912.87
Dec 28 18:00:00 - 18:59:59 83460 3.7% 23.1824.6 GB 3.6%7159.61
Dec 28 19:00:00 - 19:59:59 91693 4.1% 25.4726.7 GB 3.9%7767.46
Dec 28 20:00:00 - 20:59:59 107774 4.8% 29.9430.2 GB 4.4%8785.30
Dec 28 21:00:00 - 21:59:59 89034 4.0% 24.7326.9 GB 3.9%7827.55
Dec 28 22:00:00 - 22:59:59 78795 3.5% 21.8924.3 GB 3.5%7072.29
Dec 28 23:00:00 - 23:59:59 89008 4.0% 24.7228.8 GB 4.2%8385.81
Dec 29 00:00:00 - 00:59:59 75199 3.4% 20.8924.0 GB 3.5%6994.08
Dec 29 01:00:00 - 01:59:59 96431 4.3% 26.7929.5 GB 4.3%8582.08
Dec 29 02:00:00 - 02:59:59 104990 4.7% 29.1633.9 GB 5.0%9874.21
Dec 29 03:00:00 - 03:59:59 103367 4.6% 28.7133.3 GB 4.9%9710.60
Dec 29 04:00:00 - 04:15:03 26094 1.2% 28.908.5 GB 1.2%9846.08
TOTAL: 24:00:01 2227425 100.0% 25.78684.8 GB 100.0%8310.81
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 5655 224 0 5111 0 0 0 0 320
2news.task.gda.pl 834 660 0 14 1 0 0 0 159
3news.nask.pl 743 8 0 702 0 0 0 0 33
4news.icm.edu.pl 4 0 0 1 0 0 0 0 3
TOTAL: 4 7236 892 0 5828 1 0 0 0 515

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 131
mailing.freebsd.svn-ports-all 111
mailing.freebsd.svn-ports-head 104
mailing.freebsd.ports-bugs 53
mailing.openbsd.source-changes 49
mailing.freebsd.svn-src-all 33
fa.freebsd.cvs-all 33
fr.usenet.abus.nocem 31
mailing.freebsd.svn-src-head 27
mailing.freebsd.ports 25
it.tlc.cellulari.android 21
it.comp.os.win.windows7 19
mailing.freebsd.tinderbox 19
alt.politics.scorched-earth 18
24hoursupport.helpdesk 16
mailing.openbsd.ports-changes 13
comp.mobile.android 13
it.comp.os.win.windows8 12
alt.windows7.general 12
mailing.postfix.users 10
TOTAL: 64 892

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

GroupsCount
fr.comp.applications.libres 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 248
EMP (fsl) 131
EMP (phl) 11
EMP (md5) 8
Attached HTML file 5
HTML post 3
TOTAL: 6 406

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 52195 5098 27212 3636 0 219 9%24:02:36
2panorama 38504 2752 33064 587 0 0 7%23:59:29
3poznan 14869 77 12213 65 0 0 0%23:58:11
4task 1435 14 761 2 0 0 0%21:34:50
5nask 12626 9 8345 1 0 0 0%24:02:06
6okapi 0 0 0 0 0 1869 0%24:00:01
TOTAL: 6 119629 7950 81595 4291 0 2088 6%141:37:13
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm833.0 MB981.2 MB1.8 GB21.5 KB/s212.7 KB24:02:36
2panorama9.3 MB2.9 MB12.2 MB0.1 KB/s3.7 KB23:59:29
3poznan217.9 KB127.9 KB345.8 KB0.0 KB/s2.4 KB23:58:11
4task30.5 KB2.7 KB33.1 KB0.0 KB/s2.1 KB21:34:50
5nask19.1 KB2.0 KB21.1 KB0.0 KB/s2.1 KB24:02:06
6okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
TOTAL: 6842.5 MB984.3 MB1.8 GB3.7 KB/s152.8 KB141:37:13
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1vegas.cm.p.lodz.pl 288 360529.0 KB 288 0 000:00:17
2web.man.lodz.pl 288 2831.7 KB 14 0 000:00:24
3h59ec3930.dkkosun.dyn.perspektivbredband.net 2 10.8 KB 1 0 000:00:02
4kujawiak.man.lodz.pl 6 00.0 KB 0 6 000:00:01
TOTAL: 4 584 389561.5 KB 303 6 016:02:04

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 288 360529.0 KB 288 0 000:00:17
2*.man.lodz.pl 678 2831.7 KB 14 6 000:00:32
3*.dkkosun.dyn.perspektivbredband.net 2 10.8 KB 1 0 000:00:02
4unresolved 95 00.0 KB 0 0 014:32:05
5*.105.135.22.tvsat364.lodz.pl 4 00.0 KB 0 0 001:29:00
6*.toya.net.pl 48 00.0 KB 0 0 000:00:06
TOTAL: 61115 389561.5 KB 303 6 016:02:04

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
212.191.78.190 0.248 1.792 0.00014:32:03
ip-176.105.135.22.tvsat364.lodz.pl 0.000 0.080 0.00001:29:00
web.man.lodz.pl 0.652 5.512 0.00000:00:24
vegas.cm.p.lodz.pl 0.596 5.872 0.00000:00:17
staticline41435.toya.net.pl 0.100 0.916 0.00000:00:06
mon.man.lodz.pl 0.508 5.340 0.00000:00:05
91.90.59.186 0.004 0.020 0.00000:00:02
h59ec3930.dkkosun.dyn.perspektivbredband.net 0.012 0.040 0.00000:00:02
david.man.lodz.pl 0.196 1.780 0.00000:00:01
kujawiak.man.lodz.pl 0.040 0.148 0.00000:00:01
TOTAL: 10 2.356 21.500 0.00016:02:04

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
212.191.78.190 94
staticline41435.toya.net.pl 48
ip-176.105.135.22.tvsat364.lodz.pl 4
91.90.59.186 1
TOTAL: 6 531

NNRP client timeouts [Top 20]:

SystemConnPeer
ip-176.105.135.22.tvsat364.lodz.pl 2 0
TOTAL: 1 2 0

Newsgroup request counts (by category):

CategoryCountPct
1lodman 360 92.5%
2pl 28 7.2%
3lodz 1 0.3%
TOTAL: 3 389100.0%

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

NewsgroupCount
1lodman.info 360
2pl.comp.pecet 20
3pl.comp.os.ms-windows.winnt 8
4lodz.test 1
TOTAL: 4 389