Daily Usenet report

Apr 29 04:15:05 -- Apr 30 04:15:02

Unknown entries from news log file:

First 17 / 17 lines (100.0%)

Apr 29 09:30:07 newsfeed nnrpd[25494]: SERVER perl filter not defined
Apr 29 11:33:30 newsfeed overchan[13273]: input line too long, skipping
Apr 29 20:33:33 newsfeed overchan[13273]: input line too long, skipping
Apr 29 20:33:56 newsfeed overchan[13273]: input line too long, skipping
Apr 29 20:34:15 newsfeed overchan[13273]: input line too long, skipping
Apr 29 20:34:34 newsfeed overchan[13273]: input line too long, skipping
Apr 29 20:34:55 newsfeed overchan[13273]: input line too long, skipping
Apr 29 20:35:34 newsfeed overchan[13273]: input line too long, skipping
Apr 29 20:35:56 newsfeed overchan[13273]: input line too long, skipping
Apr 29 20:36:20 newsfeed overchan[13273]: input line too long, skipping
Apr 29 20:36:43 newsfeed overchan[13273]: input line too long, skipping
Apr 29 20:39:41 newsfeed overchan[13273]: input line too long, skipping
Apr 29 20:40:05 newsfeed overchan[13273]: input line too long, skipping
Apr 29 20:40:23 newsfeed overchan[13273]: input line too long, skipping
Apr 30 01:23:57 newsfeed overchan[13273]: input line too long, skipping
Apr 30 01:24:47 newsfeed overchan[13273]: input line too long, skipping
Apr 30 01:28:27 newsfeed overchan[13273]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2353159 96.6%274.6 MB 96.4%
innfeed 45646 1.9%5.4 MB 1.9%
innd 31112 1.3%4.3 MB 1.5%
nnrpd 4794 0.2%505.2 KB 0.2%
overchan 17 0.0%2.9 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 62434729 100.0%284.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2324663 97.2%
Negative hits 54966 2.3%
Positive hits 12533 0.5%
Cache misses 100 0.0%
TOTAL: 4 2392262 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.491 0.0%214 0.000 6.967 361.500
article cleanup00:00:29.265 0.0%2352929 0.009 0.012 0.017
article logging00:01:26.254 0.1%2353445 0.027 0.037 0.149
article parse00:50:33.547 3.5%204223901 0.010 0.015 0.038
article write00:25:46.763 1.8%2332191 0.423 0.663 3.707
artlog/artcncl00:00:00.007 0.0%197 0.000 0.036 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:02:38.392 0.2%218995178 0.000 0.001 0.003
hisgrep/artcncl00:00:00.922 0.0%190 0.000 4.853 361.500
hishave/artcncl00:00:00.018 0.0%214 0.000 0.084 0.444
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:04:13.705 0.3%2416953 0.049 0.105 0.257
history sync00:00:00.013 0.0%290 0.000 0.045 0.500
history write01:48:54.281 7.6%2346958 0.247 2.784 11.312
hiswrite/artcncl00:00:00.054 0.0%24 0.000 2.250 5.500
idle14:47:19.370 61.6%160728480 0.178 0.331 0.529
nntp read01:06:45.008 4.6%202410269 0.016 0.020 0.028
overview write00:00:11.628 0.0%2332191 0.003 0.005 0.007
perl filter04:03:53.933 16.9%2346934 5.597 6.235 7.047
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:03:28.721 0.2%4693570 0.033 0.044 0.068
TOTAL: 24:00:03.03823:15:43.372 96.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.192 0.0%81297 0.000 0.002 0.011
article prepare00:00:00.014 0.0%46786 0.000 0.000 0.012
article read00:01:19.244 0.1%11686 0.098 6.781 157.529
backlog stats00:00:00.222 0.0%237484 0.000 0.001 0.004
callbacks00:00:00.000 0.0%7 0.000 0.000 0.000
data read00:00:02.089 0.0%123479 0.005 0.017 0.062
data write00:00:14.196 0.0%104300 0.034 0.136 0.347
idle23:51:47.322 99.9%237484 98.717 361.739 755.643
status file00:00:13.430 0.0%16048 0.603 0.837 1.822
TOTAL: 23:53:49.13323:53:36.709100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:02:25.690 91.8%3057 0.000 47.658 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.137 0.1%6846 0.000 0.020 0.500
readart00:00:00.075 0.0%77 0.000 0.974 10.000
TOTAL: 00:02:38.71200:02:25.902 91.9%----

Control commands to INND:

CommandNumber
L 1
flush 27
flushlogs 2
go 2
logmode 2
mode 149
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 193

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 998 23327622324925 1388 6449 99%343:43:27
2news.nask.pl 2 26002 6868 4919 14215 26%23:58:59
3news.icm.edu.pl 39 328 16 273 39 4%16:59:52
4localhost 2 1 1 0 0 100%00:00:00
TOTAL: 4 1041 23590932331810 6580 20703 98%384:42:18
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl687.6 GB174.6 MB347.5 MB688.1 GB 99%309.5 KB
2news.nask.pl145.0 MB2.1 MB182.4 MB329.5 MB 44%16.0 KB
3news.icm.edu.pl432.5 KB76.4 KB2.4 MB2.9 MB 14%54.8 KB
4localhost1.3 KB0.0 KB0.0 KB1.3 KB100%1.3 KB
TOTAL: 4687.7 GB176.8 MB532.3 MB688.4 GB 99%306.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 29 04:15:05 - 04:59:59 101473 4.4% 37.6529.0 GB 4.2%11271.33
Apr 29 05:00:00 - 05:59:59 130306 5.6% 36.2037.7 GB 5.5%10977.73
Apr 29 06:00:00 - 06:59:59 127234 5.5% 35.3437.9 GB 5.5%11038.03
Apr 29 07:00:00 - 07:59:59 137347 5.9% 38.1540.0 GB 5.8%11660.14
Apr 29 08:00:00 - 08:59:59 140534 6.0% 39.0440.7 GB 5.9%11864.34
Apr 29 09:00:00 - 09:59:59 132656 5.7% 36.8539.2 GB 5.7%11412.51
Apr 29 10:00:00 - 10:59:59 96617 4.1% 26.8428.4 GB 4.1%8282.00
Apr 29 11:00:00 - 11:59:59 129253 5.5% 35.9037.8 GB 5.5%10996.45
Apr 29 12:00:00 - 12:59:59 79109 3.4% 21.9724.1 GB 3.5%7025.87
Apr 29 13:00:00 - 13:59:59 51966 2.2% 14.4415.8 GB 2.3%4600.44
Apr 29 14:00:00 - 14:59:59 58885 2.5% 16.3617.5 GB 2.6%5105.02
Apr 29 15:00:00 - 15:59:59 67588 2.9% 18.7719.9 GB 2.9%5781.79
Apr 29 16:00:00 - 16:59:59 69516 3.0% 19.3120.5 GB 3.0%5983.96
Apr 29 17:00:00 - 17:59:59 64656 2.8% 17.9619.0 GB 2.8%5527.49
Apr 29 18:00:00 - 18:59:59 67818 2.9% 18.8419.4 GB 2.8%5653.95
Apr 29 19:00:00 - 19:59:59 59253 2.5% 16.4616.6 GB 2.4%4823.45
Apr 29 20:00:00 - 20:59:59 60073 2.6% 16.6918.0 GB 2.6%5241.80
Apr 29 21:00:00 - 21:59:59 67480 2.9% 18.7420.2 GB 2.9%5884.50
Apr 29 22:00:00 - 22:59:59 68903 3.0% 19.1421.6 GB 3.1%6295.22
Apr 29 23:00:00 - 23:59:59 106073 4.5% 29.4632.8 GB 4.8%9554.10
Apr 30 00:00:00 - 00:59:59 113368 4.9% 31.4934.3 GB 5.0%9987.89
Apr 30 01:00:00 - 01:59:59 136654 5.9% 37.9639.4 GB 5.7%11471.37
Apr 30 02:00:00 - 02:59:59 118119 5.1% 32.8133.9 GB 4.9%9886.82
Apr 30 03:00:00 - 03:59:59 114340 4.9% 31.7633.4 GB 4.9%9726.53
Apr 30 04:00:00 - 04:15:02 32521 1.4% 36.059.5 GB 1.4%11063.07
TOTAL: 23:59:57 2331742 100.0% 26.99686.6 GB 100.0%8333.25
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 14339 25 0 474 4 0 0 013836
2newsfeed.pionier.net.pl 6850 52 0 5480 3 0 0 0 1315
3news.icm.edu.pl 31 0 0 3 0 0 0 0 28
TOTAL: 3 21220 77 0 5957 7 0 0 015179

Unwanted newsgroups [Top 20]:

NewsgroupCount
comp.mobile.android 36
uk.railway 24
it.comp.os.win.windows10 8
it.comp.os.win.windows7 2
de.comm.software.mailreader 2
comp.sys.raspberry-pi 2
it.tlc.cellulari.android 1
hr.ponuda.hardver.komponente 1
de.comp.lang.vbclassic 1
TOTAL: 9 77

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

GroupsCount
pl.praca.oferowana 5
bit.listserv.catholic 1
pl.sci.matematyka 1
TOTAL: 3 7

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 13239
Binary in non-binary group 1211
Scoring filter (8) 60
Scoring filter (9) 31
Poison newsgroup 18
EMP (phl) 17
Too many newsgroups 16
Scoring filter (10) 16
Scoring filter (11) 14
Scoring filter (12) 6
Scoring filter (13) 4
HTML post 3
Excessively crossposted test article 2
Scoring filter (14) 1
Scoring filter (15) 1
Scoring filter (18) 1
Malformed article 1
Scoring filter (17) 1
TOTAL: 18 14642

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 405
news.nask.pl 110
news.icm.edu.pl 1
TOTAL: 3 516
TOTAL: 1 516

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 34736 3363 18630 6744 0 0 9%23:59:49
2panorama 58019 642 30372 298 21 50085 1%23:59:55
3poznan 9992 48 6229 61 0 1 0%23:59:54
4nask 9726 15 6072 0 0 0 0%23:59:55
5okapi 0 0 0 0 0 1199 0%23:57:47
TOTAL: 5 112473 4068 61303 7103 21 51285 3%119:57:20
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm607.4 MB1.8 GB2.4 GB29.2 KB/s249.7 KB23:59:49
2panorama3.2 MB1.0 MB4.2 MB0.0 KB/s4.6 KB23:59:55
3nask862.7 KB0.0 KB862.7 KB0.0 KB/s57.5 KB23:59:55
4poznan352.9 KB179.6 KB532.6 KB0.0 KB/s4.9 KB23:59:54
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
TOTAL: 5611.7 MB1.8 GB2.4 GB5.9 KB/s226.4 KB119:57:20
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 291 7051.7 KB 30 0 000:00:22
2159-205-128-224.adsl.inetia.pl 2 75.9 KB 2 0 000:02:08
3isvcs01.man.lodz.pl 1 00.0 KB 0 1 000:00:00
TOTAL: 3 294 7757.6 KB 32 1 000:02:38

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 676 7051.7 KB 30 1 000:00:29
2*.adsl.inetia.pl 2 75.9 KB 2 0 000:02:08
TOTAL: 2 678 7757.6 KB 32 1 000:02:38

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
159-205-128-224.adsl.inetia.pl 0.012 0.012 0.00000:02:08
web.man.lodz.pl 1.192 3.240 0.00000:00:22
mon.man.lodz.pl 1.064 2.972 0.00000:00:04
david.man.lodz.pl 0.284 1.052 0.00000:00:01
isvcs01.man.lodz.pl 0.004 0.020 0.00000:00:00
TOTAL: 5 2.556 7.296 0.00000:02:38

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
TOTAL: 2 384

Newsgroup request counts (by category):

CategoryCountPct
1pl 70 90.9%
2lodz 7 9.1%
TOTAL: 2 77100.0%

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

NewsgroupCount
1pl.comp.pecet 70
2lodz.test 7
TOTAL: 2 77