Daily Usenet report

Jun 6 04:15:02 -- Jun 7 04:15:02

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

Jun 6 07:15:10 newsfeed overchan[7351]: input line too long, skipping
Jun 6 07:30:35 newsfeed overchan[7351]: input line too long, skipping
Jun 6 07:31:28 newsfeed overchan[7351]: input line too long, skipping
Jun 6 10:05:51 newsfeed nnrpd[20687]: SERVER perl filter not defined
Jun 6 10:09:49 newsfeed nnrpd[20742]: SERVER perl filter not defined
Jun 6 10:12:33 newsfeed nnrpd[20951]: SERVER perl filter not defined
Jun 6 10:13:04 newsfeed nnrpd[20964]: SERVER perl filter not defined
Jun 6 10:18:12 newsfeed overchan[7351]: input line too long, skipping
Jun 6 15:43:09 newsfeed overchan[7351]: input line too long, skipping
Jun 6 15:49:01 newsfeed overchan[7351]: input line too long, skipping
Jun 6 19:57:27 newsfeed overchan[7351]: input line too long, skipping
Jun 6 20:09:42 newsfeed overchan[7351]: input line too long, skipping
Jun 6 20:47:31 newsfeed overchan[7351]: input line too long, skipping
Jun 7 00:08:32 newsfeed nnrpd[18804]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn2341740 97.6%267.6 MB 97.3%
innfeed 30959 1.3%3.7 MB 1.4%
innd 20741 0.9%3.3 MB 1.2%
nnrpd 4908 0.2%517.9 KB 0.2%
overchan 10 0.0%1.7 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 62398359 100.0%275.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2277408 60.8%
Negative hits 1293990 34.5%
Positive hits 176705 4.7%
Cache misses 495 0.0%
TOTAL: 4 3748598 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:03.651 0.0%244 0.000 14.963 102.250
article cleanup00:00:31.513 0.0%2340982 0.010 0.013 0.017
article logging00:01:57.064 0.1%2341593 0.035 0.050 0.155
article parse00:49:41.072 3.5%82732776 0.023 0.036 0.044
article write00:19:20.438 1.3%2281640 0.268 0.509 1.271
artlog/artcncl00:00:00.013 0.0%241 0.000 0.054 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:03:51.554 0.3%97070480 0.001 0.002 0.003
hisgrep/artcncl00:00:01.416 0.0%227 0.000 6.238 58.357
hishave/artcncl00:00:00.445 0.0%244 0.000 1.824 26.714
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:37:38.351 2.6%3758226 0.092 0.601 4.998
history sync00:00:00.022 0.0%290 0.000 0.076 0.500
history write02:12:52.274 9.2%2285212 0.635 3.489 10.279
hiswrite/artcncl00:00:00.038 0.0%17 0.000 2.235 5.833
idle13:16:10.667 55.3%65431172 0.484 0.730 2.910
nntp read01:08:30.805 4.8%81639928 0.038 0.050 0.062
overview write00:00:12.986 0.0%2281640 0.004 0.006 0.008
perl filter04:52:24.696 20.3%2285205 4.992 7.678 9.766
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:05:56.441 0.4%4941934 0.048 0.072 0.089
TOTAL: 24:00:03.61723:29:13.446 97.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:02.038 0.0%771565 0.000 0.003 0.013
article prepare00:00:00.044 0.0%185348 0.000 0.000 0.004
article read00:00:20.239 0.0%35475 0.000 0.571 62.500
backlog stats00:00:01.546 0.0%2140492 0.000 0.001 0.002
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:26.793 0.0%1338547 0.012 0.020 0.035
data write00:02:06.125 0.1%1012876 0.040 0.125 0.341
idle23:47:27.454 99.7%2140492 17.712 40.013 1003.294
status file00:00:12.115 0.0%10573 0.850 1.146 1.517
TOTAL: 23:51:32.68423:50:36.354 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:03:20.384 90.2%3239 0.000 61.866 18580.600
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.790 2.2%188748 0.000 0.025 9.333
readart00:00:00.184 0.1%118 0.000 1.559 3.000
TOTAL: 00:03:42.07600:03:25.358 92.5%----

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 1174 22794552174966 51645 52844 95%440:01:41
2news.nask.pl 97 182569 106553 69476 6540 58%39:21:07
3news.icm.edu.pl 43 235 46 178 11 19%17:11:35
4localhost 6 5 5 0 0 100%00:00:01
TOTAL: 4 1320 24622642281570 121299 59395 92%496:34:24
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl621.6 GB18.4 GB18.4 GB658.3 GB 94%309.9 KB
2news.nask.pl36.3 GB1.0 GB1.1 GB38.4 GB 94%356.3 KB
3news.icm.edu.pl910.2 KB31.2 KB219.3 KB1.1 MB 78%20.4 KB
4localhost7.5 KB0.0 KB0.0 KB7.5 KB100%1.5 KB
TOTAL: 4657.9 GB19.4 GB19.5 GB696.8 GB 94%312.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 6 04:15:02 - 04:59:59 55038 2.4% 20.4014.9 GB 2.3%5782.03
Jun 6 05:00:00 - 05:59:59 96506 4.2% 26.8126.8 GB 4.1%7806.80
Jun 6 06:00:00 - 06:59:59 105505 4.6% 29.3130.7 GB 4.7%8929.52
Jun 6 07:00:00 - 07:59:59 92694 4.1% 25.7528.2 GB 4.3%8217.98
Jun 6 08:00:00 - 08:59:59 87050 3.8% 24.1828.5 GB 4.3%8303.48
Jun 6 09:00:00 - 09:59:59 93081 4.1% 25.8629.5 GB 4.5%8584.93
Jun 6 10:00:00 - 10:59:59 86668 3.8% 24.0725.6 GB 3.9%7442.36
Jun 6 11:00:00 - 11:59:59 51287 2.2% 14.2517.6 GB 2.7%5112.84
Jun 6 12:00:00 - 12:59:59 94457 4.1% 26.2431.0 GB 4.7%9042.31
Jun 6 13:00:00 - 13:59:59 94136 4.1% 26.1527.8 GB 4.2%8090.69
Jun 6 14:00:00 - 14:59:59 91461 4.0% 25.4128.8 GB 4.4%8374.38
Jun 6 15:00:00 - 15:59:59 89385 3.9% 24.8326.6 GB 4.0%7761.17
Jun 6 16:00:00 - 16:59:59 92804 4.1% 25.7827.0 GB 4.1%7861.99
Jun 6 17:00:00 - 17:59:59 98914 4.3% 27.4831.3 GB 4.8%9112.89
Jun 6 18:00:00 - 18:59:59 137452 6.0% 38.1829.5 GB 4.5%8580.79
Jun 6 19:00:00 - 19:59:59 131969 5.8% 36.6626.0 GB 3.9%7562.87
Jun 6 20:00:00 - 20:59:59 80457 3.5% 22.3523.0 GB 3.5%6699.32
Jun 6 21:00:00 - 21:59:59 99829 4.4% 27.7326.9 GB 4.1%7822.64
Jun 6 22:00:00 - 22:59:59 108325 4.7% 30.0929.0 GB 4.4%8446.72
Jun 6 23:00:00 - 23:59:59 101701 4.5% 28.2529.9 GB 4.5%8700.06
Jun 7 00:00:00 - 00:59:59 87220 3.8% 24.2325.5 GB 3.9%7412.91
Jun 7 01:00:00 - 01:59:59 100402 4.4% 27.8930.0 GB 4.5%8725.85
Jun 7 02:00:00 - 02:59:59 101178 4.4% 28.1130.4 GB 4.6%8852.03
Jun 7 03:00:00 - 03:59:59 88464 3.9% 24.5729.5 GB 4.5%8596.35
Jun 7 04:00:00 - 04:15:02 15542 0.7% 17.234.9 GB 0.7%5711.82
TOTAL: 24:00:00 2281525 100.0% 26.41658.5 GB 100.0%7991.89
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 53289 168 0 52557 5 0 0 0 559
2news.nask.pl 6672 23 0 3234 2 0 0 0 3413
3news.icm.edu.pl 13 0 0 2 0 0 0 0 11
TOTAL: 3 59974 191 0 55793 7 0 0 0 3983

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 105
comp.mobile.android 32
it.comp.os.win.windows10 22
it.tlc.cellulari.android 16
nl.comp.os.linux.techniek 5
it.comp.os.win.windows7 4
comp.sys.raspberry-pi 4
comp.mobile.ipad 1
de.comp.lang.vbclassic 1
it.comp.os.linux.ubuntu 1
TOTAL: 10 191

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) 3164
Binary in non-binary group 152
Scoring filter (8) 17
Scoring filter (9) 12
EMP (phl) 11
HTML post 3
Scoring filter (10) 2
Scoring filter (11) 2
EMP (fsl) 1
Too many newsgroups 1
TOTAL: 10 3365

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
newsfeed.pionier.net.pl 7
TOTAL: 1 7
Including strange strings
newsfeed.pionier.net.pl 445
news.nask.pl 164
news.icm.edu.pl 2
TOTAL: 3 611
TOTAL: 2 618

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nask 317682 19508 244426 41 0 6 6%23:59:58
2icm 457834 2487 354627 21308 0 8 0%23:59:58
3panorama 409535 1979 387116 857 4 384559 0%23:59:58
4poznan 10544 128 6750 13 0 0 1%23:59:46
5okapi 0 0 0 0 0 1061 0%23:57:51
TOTAL: 51195595 24102 992919 22219 4 385634 2%119:57:31
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask7.0 GB13.9 MB7.0 GB85.1 KB/s376.3 KB23:59:58
2icm929.0 MB7.5 GB8.5 GB102.6 KB/s372.5 KB23:59:58
3panorama575.7 MB140.1 MB715.8 MB8.5 KB/s258.4 KB23:59:58
4poznan1.2 MB44.6 KB1.2 MB0.0 KB/s8.7 KB23:59:46
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
TOTAL: 58.5 GB7.7 GB16.2 GB39.3 KB/s366.0 KB119:57:31
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ool-4578089a.dyn.optonline.net 1 5836.7 KB 1 0 000:00:10
2web.man.lodz.pl 288 3028.0 KB 15 0 000:00:23
30890788407.static.corbina.ru 9 1522.4 KB 2 0 000:01:21
4isvcs01.man.lodz.pl 5 00.0 KB 0 5 000:00:01
TOTAL: 4 303 10387.1 KB 18 5 000:03:41

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dyn.optonline.net 1 5836.7 KB 1 0 000:00:10
2*.man.lodz.pl 677 3028.0 KB 15 5 000:00:29
3*.static.corbina.ru 9 1522.4 KB 2 0 000:01:21
4*.p.lodz.pl 1 00.0 KB 0 0 000:01:38
5*.us-west-1.compute.amazonaws.com 1 00.0 KB 0 0 000:00:00
TOTAL: 5 689 10387.1 KB 18 5 000:03:41

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
pc-212-191-92-135.p.lodz.pl 1.280 1.120 0.00000:01:38
0890788407.static.corbina.ru 0.044 0.192 0.00000:01:21
web.man.lodz.pl 1.764 5.932 0.00000:00:23
ool-4578089a.dyn.optonline.net 0.064 0.044 0.00000:00:10
mon.man.lodz.pl 1.476 5.156 0.00000:00:04
isvcs01.man.lodz.pl 0.056 0.096 0.00000:00:01
david.man.lodz.pl 0.480 1.768 0.00000:00:01
ec2-13-57-224-199.us-west-1.compute.amazonaws.com 0.000 0.012 0.00000:00:00
TOTAL: 8 5.164 14.320 0.00000:03:41

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
ec2-13-57-224-199.us-west-1.compute.amazonaws.com 1
pc-212-191-92-135.p.lodz.pl 1
TOTAL: 4 386

Newsgroup request counts (by category):

CategoryCountPct
1lodman 73 70.9%
2pl 30 29.1%
TOTAL: 2 103100.0%

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

NewsgroupCount
1lodman.info 73
2pl.comp.os.ms-windows.winnt 18
3pl.comp.pecet 12
TOTAL: 3 103