Daily Usenet report

Jul 17 04:15:05 -- Jul 18 04:15:04

Unknown entries from news log file:

First 20 / 20 lines (100.0%)

Jul 17 06:17:55 newsfeed overchan[7208]: input line too long, skipping
Jul 17 06:27:27 newsfeed overchan[7208]: input line too long, skipping
Jul 17 10:31:11 newsfeed overchan[7208]: input line too long, skipping
Jul 17 11:26:58 newsfeed overchan[7208]: input line too long, skipping
Jul 17 11:34:19 newsfeed overchan[7208]: input line too long, skipping
Jul 17 11:37:08 newsfeed overchan[7208]: input line too long, skipping
Jul 17 11:41:10 newsfeed overchan[7208]: input line too long, skipping
Jul 17 11:47:42 newsfeed nnrpd[3809]: SERVER perl filter not defined
Jul 17 11:50:09 newsfeed nnrpd[4241]: SERVER perl filter not defined
Jul 17 12:23:56 newsfeed overchan[7208]: input line too long, skipping
Jul 17 15:10:59 newsfeed nnrpd[31205]: SERVER perl filter not defined
Jul 17 17:34:47 newsfeed overchan[7208]: input line too long, skipping
Jul 17 17:43:33 newsfeed overchan[7208]: input line too long, skipping
Jul 17 19:50:15 newsfeed overchan[7208]: input line too long, skipping
Jul 17 19:58:37 newsfeed overchan[7208]: input line too long, skipping
Jul 17 20:01:15 newsfeed overchan[7208]: input line too long, skipping
Jul 17 20:06:07 newsfeed overchan[7208]: input line too long, skipping
Jul 17 20:35:07 newsfeed overchan[7208]: input line too long, skipping
Jul 17 23:20:02 newsfeed overchan[7208]: input line too long, skipping
Jul 17 23:56:11 newsfeed overchan[7208]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 493340 92.4%54.1 MB 91.7%
innfeed 27709 5.2%3.2 MB 5.5%
innd 7911 1.5%1.2 MB 2.0%
nnrpd 4882 0.9%508.2 KB 0.8%
overchan 18 0.0%2.8 KB 0.0%
controlchan 3 0.0%0.5 KB 0.0%
TOTAL: 6 533863 100.0%59.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 490557 99.2%
Negative hits 3506 0.7%
Positive hits 257 0.1%
Cache misses 16 0.0%
TOTAL: 4 494336 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.675 0.0%44 0.000 60.795 448.000
article cleanup00:00:07.139 0.0%492631 0.009 0.014 0.020
article logging00:00:27.951 0.0%493069 0.039 0.057 0.434
article parse00:14:08.910 1.0%31655588 0.018 0.027 0.034
article write00:06:22.767 0.4%492291 0.543 0.778 2.760
artlog/artcncl00:00:00.001 0.0%44 0.000 0.023 0.333
data move00:00:33.052 0.0%35129585 0.001 0.001 0.002
hisgrep/artcncl00:00:00.249 0.0%44 0.000 5.659 18.000
hishave/artcncl00:00:00.195 0.0%44 0.000 4.432 21.667
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup02:06:41.029 8.8%496623 5.537 15.305 46.749
history sync00:00:00.012 0.0%290 0.000 0.041 0.500
history write02:13:12.991 9.3%492568 8.444 16.227 65.757
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle17:35:05.231 73.3%30748303 1.569 2.059 2.793
nntp read00:26:12.398 1.8%31293343 0.036 0.050 0.063
overview write00:00:02.576 0.0%492291 0.002 0.005 0.009
perl filter01:06:37.710 4.6%492568 5.368 8.116 9.874
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:30.020 0.0%998969 0.021 0.030 0.038
TOTAL: 24:00:04.84423:50:04.906 99.3%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.151 0.0%38411 0.000 0.004 0.019
article prepare00:00:00.000 0.0%876 0.000 0.000 0.000
article read00:00:14.101 0.0%219 0.000 64.388 702.333
backlog stats00:00:00.074 0.0%86881 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.953 0.0%45223 0.005 0.021 0.051
data write00:00:02.114 0.0%31002 0.008 0.068 0.119
idle23:54:04.884100.0%86881 677.070 990.376 2119.838
status file00:00:16.733 0.0%9275 0.571 1.804 62.533
TOTAL: 23:54:43.83023:54:39.010100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:19.434 63.1%3050 0.000 6.372 745.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.242 0.8%6726 0.000 0.036 0.667
readart00:00:00.003 0.0%24 0.000 0.125 0.500
TOTAL: 00:00:30.82200:00:19.679 63.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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
news@sfere.anjou.terraraq.org.uk001001
TOTAL001001

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 68 492533 492229 0 304 99%65:46:31
2news.icm.edu.pl 50 258 56 166 36 21%16:20:14
3localhost 1444 3 3 0 0 100%00:00:11
TOTAL: 3 1562 492794 492288 166 340 99%82:06:56
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl229.6 GB3.4 MB4.0 MB229.6 GB 99%488.7 KB
2news.icm.edu.pl2.1 MB124.1 KB2.1 MB4.4 MB 48%48.4 KB
3localhost4.2 KB0.0 KB0.0 KB4.2 KB100%1.4 KB
TOTAL: 3229.6 GB3.5 MB6.2 MB229.6 GB 99%488.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 17 04:15:05 - 04:59:59 12091 2.5% 4.496.2 GB 2.7%2399.65
Jul 17 05:00:00 - 05:59:59 14713 3.0% 4.097.6 GB 3.3%2210.57
Jul 17 06:00:00 - 06:59:59 18733 3.8% 5.208.0 GB 3.5%2339.25
Jul 17 07:00:00 - 07:59:59 17803 3.6% 4.959.5 GB 4.1%2757.05
Jul 17 08:00:00 - 08:59:59 18991 3.9% 5.289.7 GB 4.2%2830.97
Jul 17 09:00:00 - 09:59:59 19402 3.9% 5.399.3 GB 4.0%2705.44
Jul 17 10:00:00 - 10:59:59 23327 4.7% 6.4811.4 GB 5.0%3330.49
Jul 17 11:00:00 - 11:59:59 22636 4.6% 6.2910.9 GB 4.7%3162.18
Jul 17 12:00:00 - 12:59:59 20438 4.1% 5.689.6 GB 4.2%2789.36
Jul 17 13:00:00 - 13:59:59 20686 4.2% 5.759.5 GB 4.1%2771.48
Jul 17 14:00:00 - 14:59:59 21191 4.3% 5.899.5 GB 4.1%2762.03
Jul 17 15:00:00 - 15:59:59 22159 4.5% 6.169.5 GB 4.1%2755.88
Jul 17 16:00:00 - 16:59:59 21429 4.4% 5.959.5 GB 4.1%2777.65
Jul 17 17:00:00 - 17:59:59 21761 4.4% 6.049.6 GB 4.2%2808.86
Jul 17 18:00:00 - 18:59:59 22538 4.6% 6.269.7 GB 4.2%2814.50
Jul 17 19:00:00 - 19:59:59 21566 4.4% 5.999.7 GB 4.2%2818.16
Jul 17 20:00:00 - 20:59:59 21174 4.3% 5.889.8 GB 4.3%2849.98
Jul 17 21:00:00 - 21:59:59 20648 4.2% 5.749.8 GB 4.3%2859.02
Jul 17 22:00:00 - 22:59:59 22500 4.6% 6.2510.3 GB 4.5%2987.90
Jul 17 23:00:00 - 23:59:59 20667 4.2% 5.749.9 GB 4.3%2894.09
Jul 18 00:00:00 - 00:59:59 21295 4.3% 5.9210.0 GB 4.3%2911.20
Jul 18 01:00:00 - 01:59:59 21494 4.4% 5.979.9 GB 4.3%2871.82
Jul 18 02:00:00 - 02:59:59 19995 4.1% 5.558.9 GB 3.9%2606.24
Jul 18 03:00:00 - 03:59:59 20761 4.2% 5.7710.2 GB 4.4%2964.57
Jul 18 04:00:00 - 04:15:04 4519 0.9% 5.002.2 GB 1.0%2577.90
TOTAL: 23:59:59 492517 100.0% 5.70230.1 GB 100.0%2792.63
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 740 245 0 55 4 0 0 0 436
2news.icm.edu.pl 37 0 0 9 0 0 0 0 28
TOTAL: 2 777 245 0 64 4 0 0 0 464

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 111
it.comp.os.win.windows10 64
it.tlc.cellulari.android 34
comp.mobile.android 20
comp.sys.raspberry-pi 8
nl.comp.os.linux.techniek 5
de.comm.software.mailreader 1
de.comp.office-pakete.ms-office.excel 1
it.comp.os.win.windows7 1
TOTAL: 9 245

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

GroupsCount
pl.praca.oferowana 2
pl.sci.matematyka 2
TOTAL: 2 4

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 28
TOTAL: 1 28

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 436
TOTAL: 1 436
TOTAL: 1 436

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 17508 81 14168 6 0 0 0%23:59:55
2panorama 24689 29 9499 36 0 29004 0%23:59:56
3poznan 55 0 41 0 0 0 0%05:55:02
4okapi 0 0 0 0 0 874 0%23:57:48
5nask 0 0 0 0 0 9917 0%23:57:48
TOTAL: 5 42252 110 23708 42 0 39795 0%101:50:29
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm231.8 KB17.0 KB248.8 KB0.0 KB/s2.9 KB23:59:55
2panorama78.2 KB162.4 KB240.6 KB0.0 KB/s3.7 KB23:59:56
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s005:55:02
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
TOTAL: 5310.0 KB179.4 KB489.4 KB0.0 KB/s3.2 KB101:50:29
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 2421.7 KB 11 0 000:00:20
2isvcs01.man.lodz.pl 3 00.0 KB 0 3 000:00:01
TOTAL: 2 291 2421.7 KB 11 3 000:00:30

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 579 2421.7 KB 11 3 000:00:24
2*.sfj.censys-scanner.com 1 00.0 KB 0 0 000:00:01
3unresolved 101 00.0 KB 0 0 000:00:04
TOTAL: 3 681 2421.7 KB 11 3 000:00:30

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.576 2.556 0.00000:00:20
mon.man.lodz.pl 1.316 2.152 0.00000:00:03
80.111.142.213 0.028 0.032 0.00000:00:02
isvcs01.man.lodz.pl 0.040 0.032 0.00000:00:01
worker-18.sfj.censys-scanner.com 0.000 0.020 0.00000:00:01
212.51.192.185 0.460 0.760 0.00000:00:00
122.228.19.80 0.008 0.004 0.00000:00:00
TOTAL: 7 3.428 5.556 0.00000:00:30

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
122.228.19.80 1
worker-18.sfj.censys-scanner.com 1
TOTAL: 5 390

NNRP unrecognized commands (by host):

SystemConn
122.228.19.80 5
TOTAL: 1 5

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 1
Host: 212.191.2.21:119 1
Accept: */* 1
User-Agent: Mozilla/5.0 (Macintosh; Inte... 1
Connection: keep-alive 1
TOTAL: 5 5

NNRP client timeouts [Top 20]:

SystemConnPeer
worker-18.sfj.censys-scanner.com 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 24100.0%
TOTAL: 1 24100.0%

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

NewsgroupCount
1pl.comp.pecet 24
TOTAL: 1 24