Daily Usenet report

Sep 24 04:15:01 -- Sep 25 04:15:01

Unknown entries from news log file:

First 50 / 66 lines (75.8%)

Sep 24 05:36:02 newsfeed overchan[13648]: input line too long, skipping
Sep 24 05:36:08 newsfeed overchan[13648]: input line too long, skipping
Sep 24 07:14:37 newsfeed overchan[13648]: input line too long, skipping
Sep 24 12:54:26 newsfeed overchan[13648]: input line too long, skipping
Sep 24 13:19:44 newsfeed overchan[13648]: input line too long, skipping
Sep 24 13:47:38 newsfeed overchan[13648]: input line too long, skipping
Sep 24 13:54:06 newsfeed overchan[13648]: input line too long, skipping
Sep 24 13:58:22 newsfeed overchan[13648]: input line too long, skipping
Sep 24 14:02:55 newsfeed overchan[13648]: input line too long, skipping
Sep 24 14:05:03 newsfeed overchan[13648]: input line too long, skipping
Sep 24 14:29:08 newsfeed overchan[13648]: input line too long, skipping
Sep 24 14:32:48 newsfeed overchan[13648]: input line too long, skipping
Sep 24 14:56:36 newsfeed overchan[13648]: input line too long, skipping
Sep 24 15:08:38 newsfeed overchan[13648]: input line too long, skipping
Sep 24 15:12:58 newsfeed overchan[13648]: input line too long, skipping
Sep 24 15:21:07 newsfeed overchan[13648]: input line too long, skipping
Sep 24 15:25:28 newsfeed overchan[13648]: input line too long, skipping
Sep 24 15:30:35 newsfeed overchan[13648]: input line too long, skipping
Sep 24 15:34:44 newsfeed overchan[13648]: input line too long, skipping
Sep 24 15:37:44 newsfeed overchan[13648]: input line too long, skipping
Sep 24 15:48:28 newsfeed overchan[13648]: input line too long, skipping
Sep 24 15:56:56 newsfeed overchan[13648]: input line too long, skipping
Sep 24 16:07:56 newsfeed overchan[13648]: input line too long, skipping
Sep 24 16:10:32 newsfeed overchan[13648]: input line too long, skipping
Sep 24 16:23:03 newsfeed overchan[13648]: input line too long, skipping
Sep 24 16:24:40 newsfeed overchan[13648]: input line too long, skipping
Sep 24 16:27:35 newsfeed overchan[13648]: input line too long, skipping
Sep 24 16:32:31 newsfeed overchan[13648]: input line too long, skipping
Sep 24 16:37:41 newsfeed overchan[13648]: input line too long, skipping
Sep 24 16:41:09 newsfeed overchan[13648]: input line too long, skipping
Sep 24 16:43:04 newsfeed overchan[13648]: input line too long, skipping
Sep 24 16:49:50 newsfeed overchan[13648]: input line too long, skipping
Sep 24 16:56:22 newsfeed overchan[13648]: input line too long, skipping
Sep 24 17:01:49 newsfeed overchan[13648]: input line too long, skipping
Sep 24 17:03:56 newsfeed overchan[13648]: input line too long, skipping
Sep 24 17:05:48 newsfeed overchan[13648]: input line too long, skipping
Sep 24 17:07:49 newsfeed overchan[13648]: input line too long, skipping
Sep 24 17:08:47 newsfeed overchan[13648]: input line too long, skipping
Sep 24 17:11:12 newsfeed overchan[13648]: input line too long, skipping
Sep 24 17:16:30 newsfeed overchan[13648]: input line too long, skipping
Sep 24 17:24:41 newsfeed overchan[13648]: input line too long, skipping
Sep 24 17:26:50 newsfeed overchan[13648]: input line too long, skipping
Sep 24 17:33:03 newsfeed overchan[13648]: input line too long, skipping
Sep 24 19:27:43 newsfeed overchan[13648]: input line too long, skipping
Sep 24 19:50:25 newsfeed overchan[13648]: input line too long, skipping
Sep 24 19:56:51 newsfeed overchan[13648]: input line too long, skipping
Sep 24 20:47:30 newsfeed overchan[13648]: input line too long, skipping
Sep 24 21:10:39 newsfeed overchan[13648]: input line too long, skipping
Sep 24 21:23:28 newsfeed overchan[13648]: input line too long, skipping
Sep 24 21:27:35 newsfeed overchan[13648]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 591650 90.7%64.4 MB 89.7%
innfeed 48038 7.4%5.7 MB 7.9%
innd 8500 1.3%1.3 MB 1.9%
nnrpd 4210 0.6%418.6 KB 0.6%
overchan 67 0.0%11.6 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 652466 100.0%71.9 MB100.0%

History cache:

ReasonCount%Count
Do not exist 590204 99.5%
Negative hits 2351 0.4%
Positive hits 310 0.1%
Cache misses 38 0.0%
TOTAL: 4 592903 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.153 0.0%75 0.000 28.707 153.000
article cleanup00:00:08.880 0.0%591172 0.010 0.015 0.020
article logging00:00:29.130 0.0%591592 0.034 0.049 0.065
article parse00:20:36.023 1.4%47969307 0.017 0.026 0.031
article write00:07:20.456 0.5%590972 0.515 0.745 0.940
artlog/artcncl00:00:00.007 0.0%75 0.000 0.093 1.000
data move00:00:45.114 0.1%52289168 0.001 0.001 0.001
hisgrep/artcncl00:00:00.582 0.0%66 0.000 8.818 122.000
hishave/artcncl00:00:00.158 0.0%75 0.000 2.107 11.800
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:33:46.029 2.3%594085 0.467 3.410 13.418
history sync00:00:00.023 0.0%291 0.000 0.079 1.000
history write00:21:03.304 1.5%591147 0.610 2.137 9.800
hiswrite/artcncl00:00:00.000 0.0%9 0.000 0.000 0.000
idle20:41:34.487 86.2%47632733 1.305 1.564 1.912
nntp read00:38:09.244 2.6%47680833 0.034 0.048 0.057
overview write00:00:03.394 0.0%590972 0.003 0.006 0.009
perl filter01:03:05.464 4.4%591147 4.717 6.404 7.685
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:32.851 0.0%1196836 0.018 0.027 0.035
TOTAL: 24:00:05.73123:47:37.299 99.1%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.159 0.0%53978 0.000 0.003 0.011
article prepare00:00:00.000 0.0%6528 0.000 0.000 0.000
article read00:00:11.194 0.0%1631 0.000 6.863 58.600
backlog stats00:00:00.113 0.0%126303 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.133 0.0%61730 0.004 0.018 0.043
data write00:00:02.961 0.0%47271 0.023 0.063 0.104
idle23:52:57.876 99.9%126303 465.824 680.727 1216.658
status file00:01:16.800 0.1%16957 0.805 4.529 256.809
TOTAL: 23:54:36.61723:54:30.236100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:19.034 61.3%3049 0.000 6.243 259.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.238 0.8%6778 0.000 0.035 1.000
readart00:00:00.006 0.0%44 0.000 0.136 0.500
TOTAL: 00:00:31.04600:00:19.278 62.1%----

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 100 591329 591145 0 184 99%63:41:39
2news.icm.edu.pl 42 315 42 257 16 13%17:23:25
3localhost 1441 0 0 0 0 0%00:00:00
TOTAL: 3 1583 591644 591187 257 200 99%81:05:04
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl262.9 GB938.7 KB1.3 MB262.9 GB 99%466.2 KB
2news.icm.edu.pl1.0 MB21.6 KB172.2 KB1.2 MB 84%21.4 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 3262.9 GB960.3 KB1.5 MB262.9 GB 99%466.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 24 04:15:01 - 04:59:59 15951 2.7% 5.918.0 GB 3.0%3098.45
Sep 24 05:00:00 - 05:59:59 22526 3.8% 6.269.8 GB 3.7%2848.69
Sep 24 06:00:00 - 06:59:59 22701 3.8% 6.3110.0 GB 3.8%2926.73
Sep 24 07:00:00 - 07:59:59 25266 4.3% 7.0212.0 GB 4.6%3506.84
Sep 24 08:00:00 - 08:59:59 23521 4.0% 6.5310.6 GB 4.0%3085.85
Sep 24 09:00:00 - 09:59:59 23559 4.0% 6.5410.0 GB 3.8%2902.60
Sep 24 10:00:00 - 10:59:59 27259 4.6% 7.5712.4 GB 4.7%3598.56
Sep 24 11:00:00 - 11:59:59 24402 4.1% 6.7811.4 GB 4.3%3326.14
Sep 24 12:00:00 - 12:59:59 25541 4.3% 7.0911.1 GB 4.2%3231.01
Sep 24 13:00:00 - 13:59:59 28892 4.9% 8.0312.3 GB 4.7%3574.61
Sep 24 14:00:00 - 14:59:59 29044 4.9% 8.0712.2 GB 4.6%3547.86
Sep 24 15:00:00 - 15:59:59 26733 4.5% 7.4311.1 GB 4.2%3224.17
Sep 24 16:00:00 - 16:59:59 24543 4.2% 6.8210.8 GB 4.1%3150.20
Sep 24 17:00:00 - 17:59:59 23269 3.9% 6.469.5 GB 3.6%2754.94
Sep 24 18:00:00 - 18:59:59 26437 4.5% 7.3411.7 GB 4.4%3412.37
Sep 24 19:00:00 - 19:59:59 27547 4.7% 7.6511.9 GB 4.5%3466.56
Sep 24 20:00:00 - 20:59:59 22664 3.8% 6.309.7 GB 3.7%2835.18
Sep 24 21:00:00 - 21:59:59 23648 4.0% 6.5710.2 GB 3.9%2977.25
Sep 24 22:00:00 - 22:59:59 25392 4.3% 7.0511.3 GB 4.3%3288.36
Sep 24 23:00:00 - 23:59:59 25983 4.4% 7.2210.4 GB 4.0%3035.76
Sep 25 00:00:00 - 00:59:59 26711 4.5% 7.4211.1 GB 4.2%3220.46
Sep 25 01:00:00 - 01:59:59 24800 4.2% 6.8911.0 GB 4.2%3198.39
Sep 25 02:00:00 - 02:59:59 22046 3.7% 6.1211.9 GB 4.5%3475.12
Sep 25 03:00:00 - 03:59:59 17916 3.0% 4.9810.6 GB 4.0%3076.47
Sep 25 04:00:00 - 04:15:01 4604 0.8% 5.112.7 GB 1.0%3167.08
TOTAL: 24:00:00 590955 100.0% 6.84263.6 GB 100.0%3199.16
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 603 149 0 23 10 0 0 0 421
2news.icm.edu.pl 17 0 0 2 0 0 0 0 15
TOTAL: 2 620 149 0 25 10 0 0 0 436

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 97
it.tlc.cellulari.android 21
it.comp.os.win.windows10 13
comp.mobile.android 10
comp.sys.raspberry-pi 4
de.comp.lang.php 2
it.comp.dotnet 1
it.comp.os.win.windows7 1
TOTAL: 8 149

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

GroupsCount
pl.praca.oferowana 10
TOTAL: 1 10

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 13
Scoring filter (10) 1
Scoring filter (12) 1
Binary in non-binary group 1
TOTAL: 4 16

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 23168 931 13551 116 0 0 4%23:59:57
2panorama 42094 134 13815 104 0 40094 0%23:59:57
3nask 0 0 0 0 0 10258 0%23:57:42
4poznan 48 0 40 0 0 0 0%03:36:20
5okapi 0 0 0 0 0 731 0%23:57:42
TOTAL: 5 65310 1065 27406 220 0 51083 1%99:31:38
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm2.7 MB7.4 MB10.1 MB0.1 KB/s9.9 KB23:59:57
2panorama333.8 KB1.3 MB1.6 MB0.0 KB/s7.0 KB23:59:57
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:42
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s003:36:20
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:42
TOTAL: 53.0 MB8.7 MB11.8 MB0.0 KB/s9.4 KB99:31:38
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 289 4438.8 KB 22 0 000:00:20
TOTAL: 1 289 4438.8 KB 22 0 000:00:30

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 577 4438.8 KB 22 0 000:00:24
2*.security.ipip.net 1 00.0 KB 0 0 000:00:00
3unresolved 102 00.0 KB 0 0 000:00:05
TOTAL: 3 680 4438.8 KB 22 0 000:00:30

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.624 3.316 0.00000:00:20
80.111.142.213 0.013 0.054 0.00000:00:04
mon.man.lodz.pl 1.546 2.635 0.00000:00:03
212.51.192.185 0.454 0.818 0.00000:00:01
scan-141.security.ipip.net 0.009 0.009 0.00000:00:00
45.93.201.126 0.015 0.008 0.00000:00:00
TOTAL: 6 3.661 6.840 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
45.93.201.126 2
scan-141.security.ipip.net 1
TOTAL: 5 391

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 4
45.93.201.126 2
TOTAL: 2 6

NNRP unrecognized commands (by command):

CommandCount
#003 2
Host: 212.191.2.21:119 1
User-Agent: HTTP Banner Detection (https... 1
GET / HTTP/1.1 1
Connection: close 1
TOTAL: 5 6

NNRP client timeouts [Top 20]:

SystemConnPeer
45.93.201.126 2 2
TOTAL: 1 2 2

Newsgroup request counts (by category):

CategoryCountPct
1pl 44100.0%
TOTAL: 1 44100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 24
2pl.comp.pecet 20
TOTAL: 2 44
Valid XHTML 1.1 Strict CSS is valid!
innreport 3.1.0 (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>