Daily Usenet report

Oct 16 04:15:02 -- Oct 17 04:15:04

Unknown entries from news log file:

First 18 / 18 lines (100.0%)

Oct 16 08:50:09 newsfeed overchan[2219]: input line too long, skipping
Oct 16 09:09:42 newsfeed nnrpd[17504]: SERVER perl filter not defined
Oct 16 10:51:33 newsfeed nnrpd[20688]: SERVER perl filter not defined
Oct 16 11:48:35 newsfeed nnrpd[22360]: SERVER perl filter not defined
Oct 16 14:55:43 newsfeed nnrpd[32596]: SERVER perl filter not defined
Oct 16 15:05:01 newsfeed nnrpd[433]: SERVER perl filter not defined
Oct 16 15:06:00 newsfeed nnrpd[487]: SERVER perl filter not defined
Oct 16 15:06:49 newsfeed nnrpd[489]: SERVER perl filter not defined
Oct 16 15:07:24 newsfeed nnrpd[640]: SERVER perl filter not defined
Oct 16 20:02:26 newsfeed overchan[2219]: input line too long, skipping
Oct 16 22:48:41 newsfeed overchan[2219]: input line too long, skipping
Oct 16 23:11:32 newsfeed overchan[2219]: input line too long, skipping
Oct 16 23:28:39 newsfeed overchan[2219]: input line too long, skipping
Oct 17 01:11:32 newsfeed overchan[2219]: input line too long, skipping
Oct 17 01:50:03 newsfeed overchan[2219]: input line too long, skipping
Oct 17 02:59:57 newsfeed overchan[2219]: input line too long, skipping
Oct 17 03:12:46 newsfeed overchan[2219]: input line too long, skipping
Oct 17 03:23:41 newsfeed overchan[2219]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn1439035 97.8%164.0 MB 97.4%
innd 13294 0.9%2.2 MB 1.3%
nnrpd 11516 0.8%1.2 MB 0.7%
innfeed 6987 0.5%1.0 MB 0.6%
overchan 10 0.0%1.6 KB 0.0%
TOTAL: 51470842 100.0%168.4 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1431352 93.7%
Negative hits 55064 3.6%
Positive hits 40379 2.6%
Cache misses 263 0.0%
TOTAL: 4 1527058 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:09.385 0.0%331 0.000 28.353 599.000
article cleanup00:00:19.866 0.0%1438230 0.002 0.014 0.029
article logging00:00:49.816 0.1%1438381 0.014 0.035 0.759
article parse00:43:21.812 3.0%50721089 0.020 0.051 0.097
article write00:18:00.375 1.3%1431147 0.397 0.755 2.536
artlog/artcncl00:00:00.008 0.0%327 0.000 0.024 1.000
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:01:13.662 0.1%59499513 0.000 0.001 0.004
hisgrep/artcncl00:00:01.956 0.0%294 0.000 6.653 268.000
hishave/artcncl00:00:01.830 0.0%331 0.000 5.529 97.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup03:11:28.461 13.3%1528826 0.389 7.515 27.859
history sync00:00:00.013 0.0%291 0.000 0.045 1.000
history write03:57:39.095 16.5%1433281 1.147 9.949 44.813
hiswrite/artcncl00:00:00.602 0.0%37 0.000 16.270 102.667
idle11:12:50.201 46.7%32058784 0.248 1.259 9.783
nntp read00:26:26.199 1.8%49633517 0.017 0.032 0.054
overview write00:00:09.035 0.0%1431147 0.000 0.006 0.017
perl filter03:45:53.448 15.7%1433279 5.609 9.456 11.541
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:02:49.908 0.2%2910177 0.018 0.058 0.090
TOTAL: 24:00:01.74823:41:15.672 98.7%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.154 0.0%47893 0.000 0.003 0.200
article prepare00:00:00.011 0.0%45666 0.000 0.000 0.042
article read00:00:01.757 0.0%11073 0.000 0.159 3.833
backlog stats00:00:00.279 0.0%338663 0.000 0.001 0.022
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.209 0.0%196540 0.000 0.011 1.000
data write00:00:06.937 0.0%172960 0.000 0.040 4.000
idle24:00:12.153100.0%338663 0.000 255.157 12060.000
status file00:00:00.916 0.0%224 0.000 4.089 178.000
TOTAL: 24:00:31.37824:00:24.416100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle51:07:34.860100.0%7955 0.000 23137.003600055.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.344 0.0%18865 0.000 0.018 0.667
readart00:00:02.797 0.0%654 0.000 4.277 34.647
TOTAL: 51:08:19.86351:07:38.001100.0%----

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 505 14250541420567 1053 3434 99%285:57:19
2news.task.gda.pl 14 30715 6539 22818 1358 21%45:51:44
3news.nask.pl 2 17731 4298 11144 2289 24%24:21:41
4news.icm.edu.pl 44 215 10 196 9 4%17:07:03
5localhost 9 8 8 0 0 100%00:00:00
TOTAL: 5 574 14737231431422 35211 7090 97%373:17:47
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl523.7 GB10.2 MB17.6 MB523.7 GB 99%385.6 KB
2news.nask.pl14.6 MB6.1 MB6.2 MB26.9 MB 54%4.2 KB
3news.task.gda.pl14.3 MB85.7 KB4.0 MB18.5 MB 77%2.4 KB
4news.icm.edu.pl460.2 KB53.4 KB175.3 KB688.9 KB 66%36.3 KB
5localhost14.0 KB0.0 KB0.0 KB14.0 KB100%1.8 KB
TOTAL: 5523.7 GB16.5 MB28.1 MB523.8 GB 99%381.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 16 04:15:02 - 04:59:59 64849 4.5% 24.0424.9 GB 4.8%9671.63
Oct 16 05:00:00 - 05:59:59 87633 6.1% 24.3434.4 GB 6.6%10025.88
Oct 16 06:00:00 - 06:59:59 71890 5.0% 19.9727.8 GB 5.3%8084.70
Oct 16 07:00:00 - 07:59:59 75593 5.3% 21.0028.7 GB 5.5%8367.11
Oct 16 08:00:00 - 08:59:59 49401 3.5% 13.7220.7 GB 3.9%6017.61
Oct 16 09:00:00 - 09:59:59 44483 3.1% 12.3616.7 GB 3.2%4873.82
Oct 16 10:00:00 - 10:59:59 48309 3.4% 13.4218.0 GB 3.4%5244.35
Oct 16 11:00:00 - 11:59:59 42460 3.0% 11.7916.4 GB 3.1%4770.07
Oct 16 12:00:00 - 12:59:59 41324 2.9% 11.4815.7 GB 3.0%4564.65
Oct 16 13:00:00 - 13:59:59 41647 2.9% 11.5714.7 GB 2.8%4274.01
Oct 16 14:00:00 - 14:59:59 44507 3.1% 12.3613.6 GB 2.6%3966.51
Oct 16 15:00:00 - 15:59:59 48270 3.4% 13.4115.1 GB 2.9%4404.00
Oct 16 16:00:00 - 16:59:59 44951 3.1% 12.4914.6 GB 2.8%4255.54
Oct 16 17:00:00 - 17:59:59 48233 3.4% 13.4017.1 GB 3.3%4972.59
Oct 16 18:00:00 - 18:59:59 44795 3.1% 12.4415.1 GB 2.9%4401.59
Oct 16 19:00:00 - 19:59:59 45901 3.2% 12.7516.8 GB 3.2%4905.56
Oct 16 20:00:00 - 20:59:59 44151 3.1% 12.2616.4 GB 3.1%4776.97
Oct 16 21:00:00 - 21:59:59 45857 3.2% 12.7417.2 GB 3.3%5009.82
Oct 16 22:00:00 - 22:59:59 43999 3.1% 12.2216.0 GB 3.1%4667.54
Oct 16 23:00:00 - 23:59:59 47458 3.3% 13.1816.8 GB 3.2%4886.77
Oct 17 00:00:00 - 00:59:59 86437 6.0% 24.0131.4 GB 6.0%9145.52
Oct 17 01:00:00 - 01:59:59 109597 7.7% 30.4439.7 GB 7.6%11560.86
Oct 17 02:00:00 - 02:59:59 82521 5.8% 22.9230.8 GB 5.9%8980.98
Oct 17 03:00:00 - 03:59:59 100977 7.1% 28.0535.7 GB 6.8%10406.91
Oct 17 04:00:00 - 04:15:04 26229 1.8% 29.019.2 GB 1.8%10721.52
TOTAL: 24:00:02 1431472 100.0% 16.57523.6 GB 100.0%6354.19
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 3561 214 0 2681 2 0 0 0 664
2news.nask.pl 2261 2 0 2226 1 0 0 0 32
3news.task.gda.pl 1405 1195 0 43 0 0 0 0 167
4news.icm.edu.pl 9 0 0 3 0 0 0 0 6
TOTAL: 4 7236 1411 0 4953 3 0 0 0 869

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 132
mailing.freebsd.svn-ports-all 126
mailing.freebsd.svn-ports-head 126
mailing.gcc.gcc-cvs 99
fr.usenet.abus.nocem 56
mailing.freebsd.svn-src-all 54
fa.freebsd.cvs-all 54
mailing.freebsd.ports-bugs 50
mailing.freebsd.svn-src-head 45
mozilla.dev.platform 37
gmane.linux.alsa.devel 36
mailing.openbsd.ports-changes 35
mailing.unix.samba 34
it.tlc.cellulari.android 27
mailing.database.pgsql-general 26
mailing.unix.spamassassin-talk 25
mailing.unix.samba-technical 24
24hoursupport.helpdesk 22
mailing.openbsd.misc 22
mailing.www.horde-bugs 21
TOTAL: 83 1411

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

GroupsCount
pl.sci.historia 3
TOTAL: 1 3

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 538
EMP (fsl) 129
EMP (md5) 25
HTML post 19
Scoring filter (8) 2
Scoring filter (12) 1
Scoring filter (10) 1
Scoring filter (9) 1
TOTAL: 8 716

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 59753 4098 31615 4524 9 0 6%23:56:20
2panorama 49722 1974 45302 597 0 0 3%23:56:36
3task 2247 139 1096 8 0 0 6%22:50:37
4poznan 11767 36 10499 19 0 0 0%24:02:55
5nask 20701 17 14242 1 0 1 0%24:07:16
6okapi 0 0 0 0 0 3092 0%24:00:01
TOTAL: 6 144190 6264 102754 5149 9 3093 4%142:53:45
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm27.9 MB1.8 GB1.8 GB22.3 KB/s223.3 KB23:56:20
2panorama5.2 MB2.5 MB7.8 MB0.1 KB/s3.1 KB23:56:36
3task288.2 KB11.9 KB300.1 KB0.0 KB/s2.0 KB22:50:37
4poznan101.7 KB210.0 KB311.7 KB0.0 KB/s5.7 KB24:02:55
5nask57.4 KB2.4 KB59.8 KB0.0 KB/s3.3 KB24:07:16
6okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
TOTAL: 633.5 MB1.8 GB1.8 GB3.8 KB/s169.5 KB142:53:45
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 352548.3 KB 288 0 000:00:09
2212.191.78.190 305 145298.8 KB 44 1 047:23:29
3web.man.lodz.pl 289 96104.0 KB 41 0 000:00:24
4lze200.lze.lodz.pl 8 5693.5 KB 6 0 000:59:05
5ip-176.105.135.22.tvsat364.lodz.pl 7 34.6 KB 3 0 002:18:33
6router2.cbmm.lodz.pl 3 23.3 KB 2 0 000:13:01
7kujawiak.man.lodz.pl 7 00.0 KB 0 7 000:00:01
TOTAL: 7 907 6541.0 MB 384 8 051:08:18

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 288 352548.3 KB 288 0 000:00:09
2unresolved 510 145298.8 KB 44 1 047:30:56
3*.man.lodz.pl 680 96104.0 KB 41 7 000:00:33
4*.lze.lodz.pl 8 5693.5 KB 6 0 000:59:05
5*.105.135.22.tvsat364.lodz.pl 7 34.6 KB 3 0 002:18:33
6*.cbmm.lodz.pl 3 23.3 KB 2 0 000:13:01
7*.191.14.62.static.jazztel.es 3 00.0 KB 0 0 000:00:41
8*.neoplus.adsl.tpnet.pl 1 00.0 KB 0 0 000:00:01
9*.lodz.mm.pl 2 00.0 KB 0 0 000:05:07
10*.internetdsl.tpnet.pl 2 00.0 KB 0 0 000:00:00
11*.toya.net.pl 97 00.0 KB 0 0 000:00:07
TOTAL: 111601 6541.0 MB 384 8 051:08:18

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
212.191.78.190 0.816 4.808 0.00047:23:29
ip-176.105.135.22.tvsat364.lodz.pl 0.008 0.124 0.00002:18:33
lze200.lze.lodz.pl 0.032 0.144 0.00000:59:05
router2.cbmm.lodz.pl 0.004 0.056 0.00000:13:01
122.150.18.254 0.488 2.956 0.00000:07:11
host-89-228-165-199.lodz.mm.pl 0.004 0.036 0.00000:05:07
16.191.14.62.static.jazztel.es 0.012 0.044 0.00000:00:41
web.man.lodz.pl 0.804 4.708 0.00000:00:24
212.51.203.199 0.012 0.020 0.00000:00:15
vegas.cm.p.lodz.pl 0.616 4.728 0.00000:00:09
staticline41435.toya.net.pl 0.296 1.628 0.00000:00:07
f-oper-v100.man.lodz.pl 0.768 4.784 0.00000:00:05
david.man.lodz.pl 0.240 1.560 0.00000:00:02
dzk50.neoplus.adsl.tpnet.pl 0.004 0.012 0.00000:00:01
kujawiak.man.lodz.pl 0.040 0.104 0.00000:00:01
gcq193.internetdsl.tpnet.pl 0.004 0.032 0.00000:00:00
TOTAL: 16 4.148 25.744 0.00051:08:18

Curious NNRP server explorers [Top 20]:

SystemConn
f-oper-v100.man.lodz.pl 288
122.150.18.254 203
staticline41435.toya.net.pl 97
david.man.lodz.pl 96
16.191.14.62.static.jazztel.es 3
host-89-228-165-199.lodz.mm.pl 2
gcq193.internetdsl.tpnet.pl 2
212.51.203.199 2
dzk50.neoplus.adsl.tpnet.pl 1
TOTAL: 9 694

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1lodman 352 53.8%
2pl 302 46.2%
TOTAL: 2 654100.0%

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

NewsgroupCount
1lodman.info 352
2pl.comp.pecet 76
3pl.rec.rowery 57
4pl.misc.telefonia.gsm 38
5pl.soc.prawo 33
6pl.comp.os.ms-windows.winnt 33
7pl.misc.kolej 30
8pl.regionalne.warszawa 14
9pl.rec.gory 8
10pl.regionalne.lodz 8
11pl.comp.os.linux.sieci 5
TOTAL: 11 654