Daily Usenet report

Sep 8 04:15:03 -- Sep 9 04:15:05

Unknown entries from news log file:

First 18 / 18 lines (100.0%)

Sep 8 07:27:35 newsfeed overchan[29061]: input line too long, skipping
Sep 8 07:56:01 newsfeed overchan[29061]: input line too long, skipping
Sep 8 09:56:10 newsfeed nnrpd[9728]: SERVER perl filter not defined
Sep 8 14:43:34 newsfeed nnrpd[20246]: SERVER perl filter not defined
Sep 8 16:31:58 newsfeed overchan[29061]: input line too long, skipping
Sep 8 16:42:58 newsfeed overchan[29061]: input line too long, skipping
Sep 8 17:16:13 newsfeed overchan[29061]: input line too long, skipping
Sep 8 17:24:10 newsfeed overchan[29061]: input line too long, skipping
Sep 8 17:34:37 newsfeed overchan[29061]: input line too long, skipping
Sep 8 20:43:53 newsfeed overchan[29061]: input line too long, skipping
Sep 8 21:01:14 newsfeed overchan[29061]: input line too long, skipping
Sep 8 22:04:35 newsfeed overchan[29061]: input line too long, skipping
Sep 8 22:04:54 newsfeed overchan[29061]: input line too long, skipping
Sep 8 22:40:23 newsfeed overchan[29061]: input line too long, skipping
Sep 9 02:05:34 newsfeed overchan[29061]: input line too long, skipping
Sep 9 02:11:02 newsfeed overchan[29061]: input line too long, skipping
Sep 9 03:41:26 newsfeed overchan[29061]: input line too long, skipping
Sep 9 04:06:53 newsfeed overchan[29061]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn3011653 97.5%347.6 MB 97.2%
innfeed 46268 1.5%5.5 MB 1.5%
innd 24866 0.8%4.0 MB 1.1%
nnrpd 4762 0.2%495.9 KB 0.1%
overchan 17 0.0%3.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 63087567 100.0%357.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2991182 97.3%
Negative hits 70887 2.3%
Positive hits 12293 0.4%
Cache misses 115 0.0%
TOTAL: 4 3074477 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.434 0.0%173 0.000 8.289 81.000
article cleanup00:00:43.368 0.1%3010880 0.010 0.014 0.020
article logging00:01:57.761 0.1%3011384 0.030 0.039 0.122
article parse01:07:11.868 4.7%151933903 0.016 0.027 0.040
article write00:24:45.207 1.7%3000107 0.241 0.495 1.349
artlog/artcncl00:00:00.006 0.0%173 0.000 0.035 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:03:09.506 0.2%169340514 0.001 0.001 0.003
hisgrep/artcncl00:00:00.283 0.0%169 0.000 1.675 6.923
hishave/artcncl00:00:00.041 0.0%173 0.000 0.237 1.769
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:30:05.095 2.1%3089997 0.028 0.584 5.638
history sync00:00:00.025 0.0%290 0.000 0.086 1.000
history write01:18:15.304 5.4%3004638 0.115 1.563 7.403
hiswrite/artcncl00:00:00.009 0.0%4 0.000 2.250 7.000
idle12:36:28.428 52.5%107123978 0.225 0.424 0.870
nntp read01:19:24.728 5.5%149898383 0.023 0.032 0.041
overview write00:00:17.759 0.0%3000107 0.005 0.006 0.009
perl filter05:45:12.778 24.0%3004638 4.540 6.894 8.823
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:05:20.439 0.4%6034262 0.043 0.053 0.073
TOTAL: 24:00:02.15623:12:54.039 96.7%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.269 0.0%87582 0.000 0.003 0.014
article prepare00:00:00.017 0.0%58098 0.000 0.000 0.025
article read00:00:18.108 0.0%14514 0.000 1.248 2049.000
backlog stats00:00:00.264 0.0%269166 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:03.629 0.0%136649 0.007 0.027 0.046
data write00:00:24.237 0.0%124891 0.018 0.194 0.502
idle23:51:31.984 99.9%269166 88.515 319.104 679.830
status file00:00:29.327 0.0%16952 0.683 1.730 97.050
TOTAL: 23:53:08.31723:52:47.835100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:17.620 56.8%3032 0.000 5.811 56.889
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.190 0.6%6717 0.000 0.028 0.667
readart00:00:00.003 0.0%42 0.000 0.071 1.000
TOTAL: 00:00:31.00700:00:17.813 57.4%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 1214 30002232989602 4446 6175 99%358:07:15
2news.nask.pl 2 16698 10868 1339 4491 65%23:59:20
3news.icm.edu.pl 30 339 43 293 3 12%19:35:51
4localhost 3 2 2 0 0 100%00:00:00
TOTAL: 4 1249 30172623000515 6078 10669 99%401:42:26
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl757.6 GB56.5 MB57.2 MB757.7 GB 99%265.2 KB
2news.nask.pl43.9 MB838.5 KB25.6 MB70.3 MB 62%4.7 KB
3news.icm.edu.pl983.1 KB0.0 KB88.2 KB1.0 MB 91%23.3 KB
4localhost2.6 KB0.0 KB0.0 KB2.6 KB100%1.3 KB
TOTAL: 4757.6 GB57.4 MB82.8 MB757.8 GB 99%263.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 8 04:15:03 - 04:59:59 82455 2.7% 30.5728.4 GB 3.8%11041.84
Sep 8 05:00:00 - 05:59:59 112301 3.7% 31.1938.1 GB 5.0%11087.23
Sep 8 06:00:00 - 06:59:59 111198 3.7% 30.8937.5 GB 5.0%10914.57
Sep 8 07:00:00 - 07:59:59 94069 3.1% 26.1330.0 GB 4.0%8733.24
Sep 8 08:00:00 - 08:59:59 88409 2.9% 24.5628.1 GB 3.7%8175.78
Sep 8 09:00:00 - 09:59:59 57917 1.9% 16.0919.6 GB 2.6%5698.59
Sep 8 10:00:00 - 10:59:59 99553 3.3% 27.6518.5 GB 2.4%5382.72
Sep 8 11:00:00 - 11:59:59 74530 2.5% 20.7017.5 GB 2.3%5083.28
Sep 8 12:00:00 - 12:59:59 122285 4.1% 33.9717.7 GB 2.3%5159.55
Sep 8 13:00:00 - 13:59:59 95079 3.2% 26.4123.9 GB 3.2%6949.41
Sep 8 14:00:00 - 14:59:59 142257 4.7% 39.5239.5 GB 5.2%11513.98
Sep 8 15:00:00 - 15:59:59 163625 5.5% 45.4532.3 GB 4.3%9411.86
Sep 8 16:00:00 - 16:59:59 182956 6.1% 50.8238.5 GB 5.1%11215.70
Sep 8 17:00:00 - 17:59:59 175410 5.8% 48.7340.1 GB 5.3%11683.65
Sep 8 18:00:00 - 18:59:59 157116 5.2% 43.6430.5 GB 4.0%8876.99
Sep 8 19:00:00 - 19:59:59 147055 4.9% 40.8529.0 GB 3.8%8450.91
Sep 8 20:00:00 - 20:59:59 173294 5.8% 48.1435.3 GB 4.7%10278.96
Sep 8 21:00:00 - 21:59:59 133363 4.4% 37.0536.2 GB 4.8%10550.69
Sep 8 22:00:00 - 22:59:59 140454 4.7% 39.0238.0 GB 5.0%11065.85
Sep 8 23:00:00 - 23:59:59 147889 4.9% 41.0839.9 GB 5.3%11621.13
Sep 9 00:00:00 - 00:59:59 114384 3.8% 31.7732.0 GB 4.2%9306.80
Sep 9 01:00:00 - 01:59:59 107559 3.6% 29.8829.0 GB 3.8%8439.96
Sep 9 02:00:00 - 02:59:59 131578 4.4% 36.5535.4 GB 4.7%10318.37
Sep 9 03:00:00 - 03:59:59 115162 3.8% 31.9931.8 GB 4.2%9260.10
Sep 9 04:00:00 - 04:15:05 30303 1.0% 33.488.9 GB 1.2%10313.71
TOTAL: 24:00:02 3000201 100.0% 34.72755.5 GB 100.0%9168.30
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 6504 168 0 5970 1 0 0 0 365
2news.nask.pl 4765 26 0 272 6 0 0 0 4461
3news.icm.edu.pl 10 0 0 0 0 0 0 0 10
TOTAL: 3 11279 194 0 6242 7 0 0 0 4836

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 93
it.comp.os.win.windows7 29
it.tlc.cellulari.android 22
comp.mobile.android 16
it.comp.os.win.windows10 10
de.comp.lang.php 8
nl.comp.sys.android 7
hr.ponuda.hardver.komponente 2
uk.rec.cycling.moderated 1
it.tlc.cellulari.iphone 1
it.discussioni.energia 1
de.rec.sf.startrek 1
hr.ponuda.hardver.konfiguracije 1
de.comp.lang.vbclassic 1
it.comp.os.win.windows8 1
TOTAL: 15 194

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

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

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4117
Binary in non-binary group 124
Scoring filter (8) 43
Scoring filter (9) 25
Scoring filter (10) 5
Scoring filter (11) 5
Too many newsgroups 4
Scoring filter (12) 4
Scoring filter (19) 1
Angle-bracket bot 1
Poison newsgroup 1
Too many newsgroups (low_xpost) 1
Scoring filter (13) 1
TOTAL: 13 4332

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 317
news.nask.pl 180
news.icm.edu.pl 7
TOTAL: 3 504
TOTAL: 1 504

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1poznan 18319 496 10309 56 0 4 2%23:59:59
2panorama 58550 215 30042 41 1 57520 0%23:59:59
3icm 37839 69 19102 13545 0 3 0%23:59:59
4nask 3015 10 2023 0 0 0 0%23:58:36
5okapi 0 0 0 0 0 2092 0%23:57:52
TOTAL: 5 117723 790 61476 13642 1 59619 0%119:56:25
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm6.4 MB5.0 GB5.0 GB60.4 KB/s383.1 KB23:59:59
2poznan2.0 MB224.5 KB2.2 MB0.0 KB/s4.1 KB23:59:59
3panorama753.1 KB411.3 KB1.1 MB0.0 KB/s4.5 KB23:59:59
4nask21.9 KB0.0 KB21.9 KB0.0 KB/s2.2 KB23:58:36
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:52
TOTAL: 59.2 MB5.0 GB5.0 GB12.1 KB/s361.6 KB119:56:25
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 4242.6 KB 21 0 000:00:24
2isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:00
TOTAL: 2 290 4242.6 KB 21 2 000:00:30

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 673 4242.6 KB 21 2 000:00:30
2*.us-west-1.compute.amazonaws.com 1 00.0 KB 0 0 000:00:00
TOTAL: 2 674 4242.6 KB 21 2 000:00:30

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.428 4.340 0.00000:00:24
mon.man.lodz.pl 1.352 4.664 0.00000:00:04
david.man.lodz.pl 0.344 1.488 0.00000:00:01
isvcs01.man.lodz.pl 0.020 0.048 0.00000:00:00
ec2-54-67-9-227.us-west-1.compute.amazonaws.com 0.000 0.012 0.00000:00:00
TOTAL: 5 3.144 10.552 0.00000:00:30

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 95
ec2-54-67-9-227.us-west-1.compute.amazonaws.com 1
TOTAL: 3 384

Newsgroup request counts (by category):

CategoryCountPct
1pl 42100.0%
TOTAL: 1 42100.0%

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

NewsgroupCount
1pl.comp.pecet 38
2pl.comp.os.ms-windows.winnt 4
TOTAL: 2 42