Daily Usenet report

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

Unknown entries from news log file:

First 11 / 11 lines (100.0%)

Jun 6 07:01:25 newsfeed overchan[21920]: input line too long, skipping
Jun 6 07:01:48 newsfeed overchan[21920]: input line too long, skipping
Jun 6 07:03:32 newsfeed overchan[21920]: input line too long, skipping
Jun 6 07:03:47 newsfeed overchan[21920]: input line too long, skipping
Jun 6 07:04:50 newsfeed overchan[21920]: input line too long, skipping
Jun 6 07:10:48 newsfeed overchan[21920]: input line too long, skipping
Jun 6 19:33:55 newsfeed nnrpd[24562]: SERVER perl filter not defined
Jun 6 23:10:36 newsfeed overchan[21920]: input line too long, skipping
Jun 6 23:10:59 newsfeed overchan[21920]: input line too long, skipping
Jun 6 23:11:51 newsfeed overchan[21920]: input line too long, skipping
Jun 7 03:27:19 newsfeed overchan[21920]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn3213428 97.7%376.2 MB 97.5%
innfeed 45113 1.4%5.3 MB 1.4%
innd 25040 0.8%4.0 MB 1.0%
nnrpd 4783 0.1%503.4 KB 0.1%
overchan 12 0.0%2.2 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 63288377 100.0%386.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 3195798 96.8%
Negative hits 91294 2.8%
Positive hits 12667 0.4%
Cache misses 122 0.0%
TOTAL: 4 3299881 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:04.712 0.0%273 0.000 17.260 993.000
article cleanup00:00:44.474 0.1%3212844 0.010 0.014 0.019
article logging00:02:03.641 0.1%3213410 0.028 0.038 0.110
article parse01:15:10.231 5.2%191875300 0.014 0.024 0.037
article write00:24:27.697 1.7%3204109 0.370 0.458 0.856
artlog/artcncl00:00:00.008 0.0%254 0.000 0.031 1.000
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:03:07.781 0.2%211176646 0.001 0.001 0.001
hisgrep/artcncl00:00:01.101 0.0%256 0.000 4.301 68.923
hishave/artcncl00:00:00.024 0.0%273 0.000 0.088 1.200
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:40:02.319 2.8%3313485 0.056 0.725 4.440
history sync00:00:00.021 0.0%290 0.000 0.072 1.000
history write02:01:58.817 8.5%3209236 0.236 2.281 9.086
hiswrite/artcncl00:00:00.043 0.0%17 0.000 2.529 8.400
idle11:38:00.729 48.5%110193482 0.245 0.380 0.526
nntp read01:16:03.219 5.3%189104452 0.016 0.024 0.032
overview write00:00:17.195 0.0%3204109 0.004 0.005 0.007
perl filter05:51:29.064 24.4%3209234 5.775 6.571 7.710
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:05:04.936 0.4%6434239 0.037 0.047 0.063
TOTAL: 24:00:04.50323:18:36.012 97.1%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.156 0.0%64509 0.000 0.002 0.009
article prepare00:00:00.007 0.0%19854 0.000 0.000 0.031
article read00:00:40.573 0.0%4973 0.000 8.159 201.923
backlog stats00:00:00.186 0.0%200579 0.000 0.001 0.005
callbacks00:00:00.000 0.0%19 0.000 0.000 0.000
data read00:00:02.470 0.0%102341 0.006 0.024 0.044
data write00:00:12.147 0.0%94536 0.018 0.128 0.414
idle23:53:11.250 99.9%200579 84.383 428.715 994.745
status file00:00:13.781 0.0%16073 0.560 0.857 5.844
TOTAL: 23:54:36.64623:54:20.570100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:25:29.696 99.8%16933 0.000 515.543600117.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.882 0.0%34555 0.000 0.026 1.000
readart00:00:00.002 0.0%38 0.000 0.053 0.500
TOTAL: 02:25:47.48802:25:30.580 99.8%----

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 834 32044433194271 6505 3667 99%488:09:08
2news.nask.pl 2 17545 10218 2278 5049 58%24:07:34
3news.icm.edu.pl 46 246 34 208 4 13%17:18:49
4localhost 2 1 1 0 0 100%00:00:00
TOTAL: 4 884 32222353204524 8991 8720 99%529:35:31
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl975.2 GB23.9 MB46.0 MB975.2 GB 99%319.8 KB
2news.nask.pl48.8 MB576.6 KB24.9 MB74.3 MB 65%5.0 KB
3news.icm.edu.pl634.3 KB23.3 KB88.7 KB746.2 KB 85%19.6 KB
4localhost2.4 KB0.0 KB0.0 KB2.4 KB100%2.4 KB
TOTAL: 4975.2 GB24.5 MB71.0 MB975.3 GB 99%318.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 6 04:15:02 - 04:59:59 101864 3.2% 37.7630.6 GB 3.1%11898.48
Jun 6 05:00:00 - 05:59:59 116911 3.6% 32.4836.2 GB 3.7%10551.51
Jun 6 06:00:00 - 06:59:59 111400 3.5% 30.9434.0 GB 3.5%9912.01
Jun 6 07:00:00 - 07:59:59 136880 4.3% 38.0242.1 GB 4.3%12275.41
Jun 6 08:00:00 - 08:59:59 134073 4.2% 37.2439.7 GB 4.1%11558.56
Jun 6 09:00:00 - 09:59:59 116870 3.6% 32.4637.3 GB 3.8%10852.79
Jun 6 10:00:00 - 10:59:59 137577 4.3% 38.2243.0 GB 4.4%12518.40
Jun 6 11:00:00 - 11:59:59 113226 3.5% 31.4535.7 GB 3.7%10384.28
Jun 6 12:00:00 - 12:59:59 135327 4.2% 37.5942.2 GB 4.3%12277.32
Jun 6 13:00:00 - 13:59:59 137989 4.3% 38.3341.7 GB 4.3%12131.53
Jun 6 14:00:00 - 14:59:59 138815 4.3% 38.5642.5 GB 4.4%12376.30
Jun 6 15:00:00 - 15:59:59 144102 4.5% 40.0343.8 GB 4.5%12766.59
Jun 6 16:00:00 - 16:59:59 144769 4.5% 40.2144.0 GB 4.5%12825.56
Jun 6 17:00:00 - 17:59:59 124586 3.9% 34.6138.8 GB 4.0%11315.35
Jun 6 18:00:00 - 18:59:59 125630 3.9% 34.9039.4 GB 4.0%11477.80
Jun 6 19:00:00 - 19:59:59 127526 4.0% 35.4239.6 GB 4.1%11546.11
Jun 6 20:00:00 - 20:59:59 140756 4.4% 39.1042.9 GB 4.4%12507.25
Jun 6 21:00:00 - 21:59:59 148457 4.6% 41.2444.1 GB 4.5%12836.70
Jun 6 22:00:00 - 22:59:59 146312 4.6% 40.6443.4 GB 4.5%12652.36
Jun 6 23:00:00 - 23:59:59 144723 4.5% 40.2042.8 GB 4.4%12466.04
Jun 7 00:00:00 - 00:59:59 123665 3.9% 34.3535.4 GB 3.6%10316.48
Jun 7 01:00:00 - 01:59:59 141045 4.4% 39.1842.0 GB 4.3%12241.66
Jun 7 02:00:00 - 02:59:59 144208 4.5% 40.0643.2 GB 4.4%12579.83
Jun 7 03:00:00 - 03:59:59 133179 4.2% 36.9939.1 GB 4.0%11379.98
Jun 7 04:00:00 - 04:15:02 33977 1.1% 37.6710.2 GB 1.1%11904.42
TOTAL: 24:00:00 3203867 100.0% 37.08973.8 GB 100.0%11818.74
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 5312 17 0 245 8 0 0 0 5042
2newsfeed.pionier.net.pl 3989 159 0 3354 4 0 0 0 472
3news.icm.edu.pl 6 0 0 1 0 0 0 0 5
TOTAL: 3 9307 176 0 3600 12 0 0 0 5519

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 67
it.comp.os.win.windows10 63
comp.mobile.android 18
it.tlc.cellulari.android 14
nl.comp.os.linux.techniek 9
comp.mobile.ipad 3
uk.rec.cycling.moderated 1
alt.sex.telephones 1
TOTAL: 8 176

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

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

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4600
Binary in non-binary group 177
EMP (phl) 78
Scoring filter (8) 42
HTML post 17
Scoring filter (9) 13
Scoring filter (15) 7
Scoring filter (14) 5
Scoring filter (11) 3
Scoring filter (12) 2
EMP (fsl) 1
Scoring filter (10) 1
Excessively crossposted test article 1
Scoring filter (13) 1
TOTAL: 14 4948

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 322
news.nask.pl 245
news.icm.edu.pl 2
TOTAL: 3 569
TOTAL: 1 569

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 43681 717 15902 285 47 47608 1%24:00:16
2poznan 15296 193 9946 44 0 0 1%24:00:35
3icm 26605 72 22188 587 0 0 0%24:09:50
4nask 7904 6 4254 2382 0 0 0%24:04:25
5okapi 0 0 0 0 0 2274 0%24:05:41
TOTAL: 5 93486 988 52290 3298 47 49882 1%120:20:47
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm5.3 MB197.7 MB203.0 MB2.4 KB/s315.4 KB24:09:50
2panorama2.1 MB956.2 KB3.0 MB0.0 KB/s3.1 KB24:00:16
3poznan1.0 MB175.3 KB1.2 MB0.0 KB/s5.2 KB24:00:35
4nask8.9 KB1.6 GB1.6 GB19.7 KB/s716.5 KB24:04:25
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:41
TOTAL: 58.5 MB1.8 GB1.8 GB4.4 KB/s448.7 KB120:20:47
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 3839.6 KB 11 0 000:00:23
2isvcs01.man.lodz.pl 1 00.0 KB 0 1 000:00:00
TOTAL: 2 289 3839.6 KB 11 1 002:25:46

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 673 3839.6 KB 11 1 000:00:30
2*.neo.res.rr.com 1 00.0 KB 0 0 000:00:01
3unresolved 3 00.0 KB 0 0 000:26:13
4*.toya.net.pl 4 00.0 KB 0 0 001:58:59
5*.lightspeed.gdrpmi.sbcglobal.net 1 00.0 KB 0 0 000:00:02
TOTAL: 5 682 3839.6 KB 11 1 002:25:46

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
staticline2732.toya.net.pl 0.032 0.056 0.00001:58:59
185.48.192.3 0.772 1.664 0.00000:26:07
web.man.lodz.pl 1.136 4.356 0.00000:00:23
mon.man.lodz.pl 0.980 3.960 0.00000:00:05
45.55.11.229 0.008 0.008 0.00000:00:04
99-44-179-2.lightspeed.gdrpmi.sbcglobal.net 0.008 0.008 0.00000:00:02
cpe-24-210-204-30.neo.res.rr.com 0.020 0.016 0.00000:00:01
david.man.lodz.pl 0.284 1.296 0.00000:00:01
125.64.94.200 0.000 0.012 0.00000:00:00
isvcs01.man.lodz.pl 0.012 0.020 0.00000:00:00
TOTAL: 10 3.252 11.396 0.00002:25:46

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
staticline2732.toya.net.pl 4
cpe-24-210-204-30.neo.res.rr.com 1
185.48.192.3 1
125.64.94.200 1
99-44-179-2.lightspeed.gdrpmi.sbcglobal.net 1
45.55.11.229 1
TOTAL: 8 393

NNRP client timeouts [Top 20]:

SystemConnPeer
staticline2732.toya.net.pl 3 0
TOTAL: 1 3 0

Newsgroup request counts (by category):

CategoryCountPct
1pl 38100.0%
TOTAL: 1 38100.0%

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

NewsgroupCount
1pl.comp.pecet 22
2pl.comp.os.ms-windows.winnt 16
TOTAL: 2 38