Daily Usenet report

Oct 6 04:15:01 -- Oct 7 04:15:02

Unknown entries from news log file:

First 25 / 25 lines (100.0%)

Oct 6 06:12:45 newsfeed overchan[27909]: input line too long, skipping
Oct 6 06:18:57 newsfeed overchan[27909]: input line too long, skipping
Oct 6 07:27:20 newsfeed overchan[27909]: input line too long, skipping
Oct 6 07:38:18 newsfeed overchan[27909]: input line too long, skipping
Oct 6 07:49:41 newsfeed overchan[27909]: input line too long, skipping
Oct 6 07:58:57 newsfeed overchan[27909]: input line too long, skipping
Oct 6 09:41:45 newsfeed nnrpd[14375]: SERVER perl filter not defined
Oct 6 09:43:00 newsfeed nnrpd[14509]: SERVER perl filter not defined
Oct 6 15:28:07 newsfeed overchan[27909]: input line too long, skipping
Oct 6 16:44:44 newsfeed overchan[27909]: input line too long, skipping
Oct 6 16:47:32 newsfeed overchan[27909]: input line too long, skipping
Oct 6 17:15:04 newsfeed overchan[27909]: input line too long, skipping
Oct 6 17:53:02 newsfeed overchan[27909]: input line too long, skipping
Oct 6 17:58:07 newsfeed overchan[27909]: input line too long, skipping
Oct 6 19:47:12 newsfeed overchan[27909]: input line too long, skipping
Oct 6 20:31:21 newsfeed overchan[27909]: input line too long, skipping
Oct 6 21:07:53 newsfeed overchan[27909]: input line too long, skipping
Oct 6 21:21:24 newsfeed overchan[27909]: input line too long, skipping
Oct 6 21:31:38 newsfeed overchan[27909]: input line too long, skipping
Oct 6 21:36:00 newsfeed overchan[27909]: input line too long, skipping
Oct 6 21:42:50 newsfeed overchan[27909]: input line too long, skipping
Oct 6 22:45:21 newsfeed overchan[27909]: input line too long, skipping
Oct 7 01:41:44 newsfeed overchan[27909]: input line too long, skipping
Oct 7 02:53:22 newsfeed overchan[27909]: input line too long, skipping
Oct 7 03:29:15 newsfeed overchan[27909]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 529637 89.6%58.1 MB 88.6%
innfeed 49213 8.3%5.8 MB 8.9%
innd 7993 1.4%1.2 MB 1.9%
nnrpd 4186 0.7%425.1 KB 0.6%
overchan 24 0.0%4.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 591054 100.0%65.6 MB100.0%

History cache:

ReasonCount%Count
Do not exist 524502 99.7%
Negative hits 1389 0.3%
Positive hits 192 0.0%
Cache misses 49 0.0%
TOTAL: 4 526132 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.966 0.0%93 0.000 21.140 84.000
article cleanup00:00:08.682 0.0%528322 0.010 0.016 0.022
article logging00:00:28.998 0.0%528714 0.039 0.055 0.067
article parse00:19:01.056 1.3%73594711 0.009 0.016 0.029
article write00:07:24.393 0.5%528142 0.590 0.841 1.011
artlog/artcncl00:00:00.005 0.0%92 0.000 0.054 1.000
data move00:00:51.719 0.1%77836588 0.000 0.001 0.001
hisgrep/artcncl00:00:00.549 0.0%91 0.000 6.033 29.000
hishave/artcncl00:00:00.029 0.0%93 0.000 0.312 1.143
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:07:11.567 0.5%529990 0.634 0.814 6.025
history sync00:00:00.029 0.0%290 0.000 0.100 0.500
history write00:41:30.621 2.9%528301 0.862 4.714 11.380
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle20:34:02.452 85.7%73280263 0.751 1.010 2.584
nntp read00:45:43.435 3.2%73323659 0.024 0.037 0.046
overview write00:00:03.008 0.0%528142 0.003 0.006 0.010
perl filter01:03:54.848 4.4%528301 5.021 7.259 8.648
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:32.209 0.0%1078166 0.022 0.030 0.038
TOTAL: 24:00:02.83323:40:55.566 98.7%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.227 0.0%69593 0.000 0.003 0.013
article prepare00:00:00.001 0.0%12880 0.000 0.000 0.042
article read00:00:36.267 0.0%3221 0.257 11.260 364.167
backlog stats00:00:00.142 0.0%150040 0.000 0.001 0.005
callbacks00:00:00.000 0.0%4 0.000 0.000 0.000
data read00:00:01.657 0.0%78021 0.005 0.021 0.041
data write00:00:03.555 0.0%56358 0.013 0.063 0.100
idle23:52:10.258 99.9%150040 116.139 572.716 1641.017
status file00:00:45.199 0.1%16875 1.017 2.678 77.089
TOTAL: 23:53:44.75023:53:37.306100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:18.819 59.0%3038 0.000 6.195 350.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.228 0.7%6699 0.000 0.034 1.000
readart00:00:00.002 0.0%20 0.000 0.100 0.500
TOTAL: 00:00:31.91200:00:19.049 59.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 58 528986 528836 0 150 99%56:44:39
2news.icm.edu.pl 40 183 25 128 30 13%11:46:43
3localhost 1443 2 2 0 0 100%00:00:00
TOTAL: 3 1541 529171 528863 128 180 99%68:31:22
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl259.0 GB1.0 MB1.3 MB259.0 GB 99%513.4 KB
2news.icm.edu.pl1.4 MB12.3 KB1.4 MB2.8 MB 49%51.7 KB
3localhost3.1 KB0.0 KB0.0 KB3.1 KB100%1.5 KB
TOTAL: 3259.0 GB1.0 MB2.7 MB259.0 GB 99%513.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 6 04:15:01 - 04:59:59 14104 2.7% 5.237.1 GB 2.7%2774.93
Oct 6 05:00:00 - 05:59:59 19141 3.6% 5.3210.0 GB 3.9%2924.82
Oct 6 06:00:00 - 06:59:59 24616 4.7% 6.8412.4 GB 4.8%3607.34
Oct 6 07:00:00 - 07:59:59 23776 4.5% 6.6011.9 GB 4.6%3475.71
Oct 6 08:00:00 - 08:59:59 21220 4.0% 5.899.4 GB 3.6%2735.08
Oct 6 09:00:00 - 09:59:59 20521 3.9% 5.7010.1 GB 3.9%2928.51
Oct 6 10:00:00 - 10:59:59 23271 4.4% 6.4610.2 GB 3.9%2963.75
Oct 6 11:00:00 - 11:59:59 24506 4.6% 6.819.7 GB 3.7%2825.78
Oct 6 12:00:00 - 12:59:59 20290 3.8% 5.649.4 GB 3.6%2732.80
Oct 6 13:00:00 - 13:59:59 25553 4.8% 7.1011.4 GB 4.4%3311.33
Oct 6 14:00:00 - 14:59:59 23412 4.4% 6.5010.6 GB 4.1%3085.47
Oct 6 15:00:00 - 15:59:59 22040 4.2% 6.1210.8 GB 4.1%3137.68
Oct 6 16:00:00 - 16:59:59 23235 4.4% 6.4512.0 GB 4.6%3480.69
Oct 6 17:00:00 - 17:59:59 19500 3.7% 5.429.8 GB 3.8%2868.37
Oct 6 18:00:00 - 18:59:59 20200 3.8% 5.619.9 GB 3.8%2888.20
Oct 6 19:00:00 - 19:59:59 21215 4.0% 5.8910.7 GB 4.1%3102.97
Oct 6 20:00:00 - 20:59:59 21004 4.0% 5.8310.0 GB 3.9%2917.57
Oct 6 21:00:00 - 21:59:59 23554 4.5% 6.5411.1 GB 4.3%3233.58
Oct 6 22:00:00 - 22:59:59 24732 4.7% 6.8712.7 GB 4.9%3709.42
Oct 6 23:00:00 - 23:59:59 20907 4.0% 5.8110.8 GB 4.1%3139.22
Oct 7 00:00:00 - 00:59:59 21233 4.0% 5.9011.4 GB 4.4%3306.61
Oct 7 01:00:00 - 01:59:59 23577 4.5% 6.5513.2 GB 5.1%3837.36
Oct 7 02:00:00 - 02:59:59 19357 3.7% 5.3810.0 GB 3.9%2927.04
Oct 7 03:00:00 - 03:59:59 21852 4.1% 6.0711.8 GB 4.6%3446.33
Oct 7 04:00:00 - 04:15:02 6156 1.2% 6.823.4 GB 1.3%3962.11
TOTAL: 24:00:01 528972 100.0% 6.12259.8 GB 100.0%3152.41
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 542 126 0 20 4 0 0 0 392
2news.icm.edu.pl 31 0 0 1 0 0 0 0 30
TOTAL: 2 573 126 0 21 4 0 0 0 422

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 79
it.tlc.cellulari.android 18
comp.sys.raspberry-pi 8
nl.comp.sys.android 7
comp.mobile.android 6
it.comp.os.win.windows10 4
de.comm.software.mailreader 2
it.comp.os.win.windows7 1
nl.comp.os.linux.techniek 1
TOTAL: 9 126

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

GroupsCount
pl.praca.oferowana 4
TOTAL: 1 4

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 23
Binary in non-binary group 4
Too many newsgroups 1
Scoring filter (11) 1
TOTAL: 4 29

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 392
news.icm.edu.pl 1
TOTAL: 2 393
TOTAL: 1 393

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 29338 1391 20153 141 4 1870 4%23:55:37
2panorama 48517 906 19593 177 6 47258 1%24:00:00
3okapi 0 0 0 0 0 796 0%24:05:30
4poznan 19 0 16 0 0 0 0%02:15:50
5nask 0 0 0 0 0 17527 0%23:57:44
TOTAL: 5 77874 2297 39762 318 10 67451 2%98:14:41
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm4.7 MB9.8 MB14.5 MB0.2 KB/s9.7 KB23:55:37
2panorama1.6 MB711.5 KB2.3 MB0.0 KB/s2.2 KB24:00:00
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:30
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:15:50
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:44
TOTAL: 56.3 MB10.5 MB16.8 MB0.0 KB/s6.6 KB98:14:41
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 2030.0 KB 10 0 000:00:18
2isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:00
TOTAL: 2 290 2030.0 KB 10 2 000:00:31

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 578 2030.0 KB 10 2 000:00:23
2unresolved 101 00.0 KB 0 0 000:00:08
TOTAL: 2 679 2030.0 KB 10 2 000:00:31

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.634 3.458 0.00000:00:18
80.111.142.213 0.020 0.069 0.00000:00:06
mon.man.lodz.pl 1.444 3.269 0.00000:00:03
212.51.192.185 0.549 0.989 0.00000:00:01
isvcs01.man.lodz.pl 0.032 0.026 0.00000:00:00
8.12.22.245 0.008 0.008 0.00000:00:00
TOTAL: 6 3.687 7.819 0.00000:00:31

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
8.12.22.245 1
TOTAL: 4 389

NNRP unrecognized commands (by host):

SystemConn
8.12.22.245 6
TOTAL: 1 6

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 1
Connection: keep-alive 1
Accept-Encoding: gzip, deflate 1
Host: 212.191.2.21:119 1
Accept: text/html,application/xhtml+xml,... 1
User-Agent: Mozilla/5.0 (Macintosh; Inte... 1
TOTAL: 6 6

Newsgroup request counts (by category):

CategoryCountPct
1pl 20100.0%
TOTAL: 1 20100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 10
2pl.comp.pecet 10
TOTAL: 2 20