Daily Usenet report

Jul 2 04:15:02 -- Jul 3 04:15:02

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

Jul 2 04:20:02 newsfeed nnrpd[11833]: web.man.lodz.pl rejected Expiring process 11784
Jul 2 04:20:02 newsfeed nnrpd[11836]: web.man.lodz.pl rejected Expiring process 11784
Jul 2 04:20:02 newsfeed nnrpd[11839]: web.man.lodz.pl rejected Expiring process 11784
Jul 2 04:20:02 newsfeed nnrpd[11840]: web.man.lodz.pl rejected Expiring process 11784
Jul 2 04:20:02 newsfeed nnrpd[11841]: web.man.lodz.pl rejected Expiring process 11784
Jul 2 04:20:02 newsfeed nnrpd[11844]: web.man.lodz.pl rejected Expiring process 11784
Jul 2 04:20:02 newsfeed nnrpd[11847]: web.man.lodz.pl rejected Expiring process 11784
Jul 2 09:18:20 newsfeed overchan[11488]: input line too long, skipping
Jul 2 09:57:28 newsfeed nnrpd[24952]: SERVER perl filter not defined
Jul 2 12:03:04 newsfeed nnrpd[29622]: SERVER perl filter not defined
Jul 2 12:03:46 newsfeed nnrpd[29624]: SERVER perl filter not defined
Jul 2 14:09:44 newsfeed overchan[11488]: input line too long, skipping
Jul 2 15:25:09 newsfeed nnrpd[4878]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn2137576 96.8%245.9 MB 96.4%
innfeed 46490 2.1%5.5 MB 2.2%
innd 20051 0.9%3.2 MB 1.2%
nnrpd 4805 0.2%506.6 KB 0.2%
overchan 3 0.0%0.5 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 62208926 100.0%255.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2120312 97.0%
Negative hits 55075 2.5%
Positive hits 10710 0.5%
Cache misses 89 0.0%
TOTAL: 4 2186186 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:04.338 0.0%435 0.000 9.972 36.000
article cleanup00:00:27.915 0.0%2131241 0.010 0.013 0.018
article logging00:01:13.733 0.1%2131776 0.026 0.035 0.079
article parse00:49:10.406 3.4%186313246 0.010 0.016 0.026
article write00:20:21.988 1.4%2121599 0.404 0.576 1.049
artlog/artcncl00:00:00.007 0.0%435 0.000 0.016 0.500
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:03:04.884 0.2%199879961 0.001 0.001 0.001
hisgrep/artcncl00:00:00.237 0.0%120 0.000 1.975 14.000
hishave/artcncl00:00:01.506 0.0%435 0.000 3.462 6.333
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:51:41.544 3.6%2192451 0.076 1.415 9.084
history sync00:00:00.014 0.0%290 0.000 0.048 1.000
history write02:12:49.040 9.2%2126271 0.367 3.748 10.911
hiswrite/artcncl00:00:02.164 0.0%315 0.000 6.870 7.102
idle14:04:39.976 58.7%158946906 0.213 0.319 0.521
nntp read01:07:12.339 4.7%184668446 0.016 0.022 0.033
overview write00:00:10.668 0.0%2121599 0.003 0.005 0.007
perl filter03:44:22.719 15.6%2126271 5.083 6.332 8.100
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:03:09.441 0.2%4264384 0.036 0.044 0.070
TOTAL: 24:00:04.99423:18:32.919 97.1%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.168 0.0%61032 0.000 0.003 0.012
article prepare00:00:00.005 0.0%23216 0.000 0.000 0.010
article read00:00:51.800 0.1%5799 0.143 8.933 148.639
backlog stats00:00:00.113 0.0%176795 0.000 0.001 0.003
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:01.751 0.0%93621 0.004 0.019 0.038
data write00:00:06.859 0.0%73948 0.017 0.093 0.204
idle23:52:33.681 99.9%176795 309.617 486.177 930.255
status file00:00:12.355 0.0%16481 0.550 0.750 1.050
TOTAL: 23:54:03.75623:53:46.732100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:09:34.885 99.6%28626 0.000 145.842 968.750
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.200 0.0%57910 0.000 0.021 14.000
readart00:00:00.001 0.0%26 0.000 0.038 0.500
TOTAL: 01:09:49.80801:09:36.086 99.7%----

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 1045 21271912120234 2110 4847 99%366:25:26
2news.nask.pl 2 14491 6304 3409 4778 43%23:40:12
3news.icm.edu.pl 49 221 9 201 11 4%15:27:54
4localhost 5 4 4 0 0 100%00:00:00
TOTAL: 4 1101 21419072126551 5720 9636 99%405:33:32
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl651.2 GB272.4 MB285.9 MB651.7 GB 99%321.6 KB
2news.nask.pl28.3 MB1016.1 KB23.4 MB52.8 MB 53%4.9 KB
3news.icm.edu.pl257.0 KB0.0 KB451.1 KB708.1 KB 36%35.4 KB
4localhost5.5 KB0.0 KB0.0 KB5.5 KB100%1.4 KB
TOTAL: 4651.2 GB273.4 MB309.8 MB651.8 GB 99%319.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 2 04:15:02 - 04:59:59 35009 1.6% 12.9812.5 GB 1.9%4874.54
Jul 2 05:00:00 - 05:59:59 54886 2.6% 15.2517.3 GB 2.7%5038.82
Jul 2 06:00:00 - 06:59:59 58969 2.8% 16.3818.6 GB 2.9%5412.81
Jul 2 07:00:00 - 07:59:59 54772 2.6% 15.2117.5 GB 2.7%5109.54
Jul 2 08:00:00 - 08:59:59 57568 2.7% 15.9918.9 GB 2.9%5503.78
Jul 2 09:00:00 - 09:59:59 62300 2.9% 17.3119.5 GB 3.0%5682.22
Jul 2 10:00:00 - 10:59:59 49505 2.3% 13.7515.7 GB 2.4%4566.20
Jul 2 11:00:00 - 11:59:59 41997 2.0% 11.6712.6 GB 1.9%3663.10
Jul 2 12:00:00 - 12:59:59 50580 2.4% 14.0517.5 GB 2.7%5097.32
Jul 2 13:00:00 - 13:59:59 59474 2.8% 16.5219.3 GB 3.0%5626.45
Jul 2 14:00:00 - 14:59:59 64194 3.0% 17.8320.4 GB 3.1%5952.96
Jul 2 15:00:00 - 15:59:59 61814 2.9% 17.1720.3 GB 3.1%5904.83
Jul 2 16:00:00 - 16:59:59 110092 5.2% 30.5833.9 GB 5.2%9864.68
Jul 2 17:00:00 - 17:59:59 133331 6.3% 37.0439.3 GB 6.1%11452.35
Jul 2 18:00:00 - 18:59:59 118163 5.6% 32.8235.5 GB 5.5%10348.24
Jul 2 19:00:00 - 19:59:59 117005 5.5% 32.5035.4 GB 5.4%10314.95
Jul 2 20:00:00 - 20:59:59 98791 4.6% 27.4431.2 GB 4.8%9082.42
Jul 2 21:00:00 - 21:59:59 133897 6.3% 37.1939.2 GB 6.0%11408.59
Jul 2 22:00:00 - 22:59:59 138402 6.5% 38.4539.9 GB 6.1%11622.93
Jul 2 23:00:00 - 23:59:59 135558 6.4% 37.6640.1 GB 6.2%11669.34
Jul 3 00:00:00 - 00:59:59 114558 5.4% 31.8234.0 GB 5.2%9899.38
Jul 3 01:00:00 - 01:59:59 113856 5.4% 31.6333.6 GB 5.2%9787.41
Jul 3 02:00:00 - 02:59:59 129153 6.1% 35.8837.9 GB 5.8%11029.01
Jul 3 03:00:00 - 03:59:59 106073 5.0% 29.4631.6 GB 4.9%9206.81
Jul 3 04:00:00 - 04:15:02 27029 1.3% 29.978.2 GB 1.3%9499.48
TOTAL: 24:00:00 2126976 100.0% 24.62649.8 GB 100.0%7886.56
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 5296 127 0 4564 0 0 0 0 605
2news.nask.pl 4855 56 0 398 1 0 0 0 4400
3news.icm.edu.pl 14 0 0 0 0 0 0 0 14
TOTAL: 3 10165 183 0 4962 1 0 0 0 5019

Unwanted newsgroups [Top 20]:

NewsgroupCount
comp.mobile.android 71
uk.railway 65
it.tlc.cellulari.android 10
it.comp.os.win.windows10 9
comp.mobile.ipad 8
de.comp.lang.php 5
comp.sys.raspberry-pi 5
uk.rec.cycling.moderated 4
it.comp.os.win.windows7 3
comp.sys.mac.vintage 2
nl.comp.sys.android 1
TOTAL: 11 183

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4092
Binary in non-binary group 188
EMP (phl) 92
Scoring filter (8) 59
Scoring filter (9) 22
Scoring filter (10) 15
Scoring filter (15) 5
Scoring filter (19) 2
HTML post 2
Excessively crossposted test article 1
Scoring filter (12) 1
Scoring filter (18) 1
Too many newsgroups 1
TOTAL: 13 4481

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 452
news.nask.pl 86
TOTAL: 2 538
TOTAL: 1 538

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 44128 417 16022 260 8 44466 0%24:00:22
2poznan 10076 284 6086 20 0 1 2%23:59:55
3icm 27441 66 16639 4286 0 1 0%24:02:15
4nask 6648 2 4511 2 0 0 0%24:08:16
5okapi 0 0 0 0 0 1244 0%24:05:40
TOTAL: 5 88293 769 43258 4568 8 45712 0%120:16:28
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama1.2 MB841.2 KB2.0 MB0.0 KB/s3.0 KB24:00:22
2poznan1.1 MB49.9 KB1.1 MB0.0 KB/s3.7 KB23:59:55
3icm1016.8 KB922.2 MB923.2 MB10.9 KB/s217.2 KB24:02:15
4nask5.0 KB205.3 KB210.3 KB0.0 KB/s52.6 KB24:08:16
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:40
TOTAL: 53.2 MB923.2 MB926.5 MB2.2 KB/s177.8 KB120:16:28
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 294 2627.8 KB 13 0 000:00:25
2isvcs01.man.lodz.pl 4 00.0 KB 0 4 000:00:00
TOTAL: 2 298 2627.8 KB 13 4 001:09:49

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 682 2627.8 KB 13 4 000:00:31
2*.dyn.optonline.net 1 00.0 KB 0 0 000:00:00
3unresolved 3 00.0 KB 0 0 001:09:17
TOTAL: 3 686 2627.8 KB 13 4 001:09:49

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
89.38.41.49 1.444 2.064 0.00001:08:59
web.man.lodz.pl 1.136 3.816 0.00000:00:25
176.221.123.9 0.464 0.180 0.00000:00:17
mon.man.lodz.pl 1.048 3.404 0.00000:00:03
david.man.lodz.pl 0.404 1.164 0.00000:00:01
ool-457809ae.dyn.optonline.net 0.028 0.020 0.00000:00:00
isvcs01.man.lodz.pl 0.024 0.056 0.00000:00:00
TOTAL: 7 4.548 10.704 0.00001:09:49

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
176.221.123.9 2
89.38.41.49 1
ool-457809ae.dyn.optonline.net 1
TOTAL: 5 388

Newsgroup request counts (by category):

CategoryCountPct
1pl 26100.0%
TOTAL: 1 26100.0%

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

NewsgroupCount
1pl.comp.pecet 14
2pl.comp.os.ms-windows.winnt 12
TOTAL: 2 26