Daily Usenet report

Aug 30 04:15:01 -- Aug 31 04:15:01

Unknown entries from news log file:

First 21 / 21 lines (100.0%)

Aug 30 04:16:52 newsfeed overchan[828696]: input line too long, skipping
Aug 30 04:22:05 newsfeed overchan[828696]: input line too long, skipping
Aug 30 04:30:58 newsfeed overchan[828696]: input line too long, skipping
Aug 30 07:19:19 newsfeed overchan[828696]: input line too long, skipping
Aug 30 07:19:33 newsfeed overchan[828696]: input line too long, skipping
Aug 30 08:55:49 newsfeed overchan[828696]: input line too long, skipping
Aug 30 10:58:11 newsfeed overchan[828696]: input line too long, skipping
Aug 30 15:52:00 newsfeed overchan[828696]: input line too long, skipping
Aug 30 15:52:45 newsfeed overchan[828696]: input line too long, skipping
Aug 30 16:38:58 newsfeed overchan[828696]: input line too long, skipping
Aug 30 17:01:35 newsfeed nnrpd[863538]: SERVER perl filter not defined
Aug 30 17:25:13 newsfeed overchan[828696]: input line too long, skipping
Aug 30 20:21:03 newsfeed overchan[828696]: input line too long, skipping
Aug 30 20:50:37 newsfeed overchan[828696]: input line too long, skipping
Aug 30 21:54:01 newsfeed overchan[828696]: input line too long, skipping
Aug 30 21:54:15 newsfeed overchan[828696]: input line too long, skipping
Aug 30 21:56:04 newsfeed overchan[828696]: input line too long, skipping
Aug 30 22:40:38 newsfeed overchan[828696]: input line too long, skipping
Aug 30 22:45:35 newsfeed overchan[828696]: input line too long, skipping
Aug 30 22:45:52 newsfeed overchan[828696]: input line too long, skipping
Aug 31 03:56:55 newsfeed overchan[828696]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 151266 93.2%17.1 MB 93.8%
nnrpd 7641 4.7%759.0 KB 4.1%
innd 2016 1.2%240.9 KB 1.3%
innfeed 1391 0.9%158.4 KB 0.8%
overchan 21 0.0%2.3 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 162336 100.0%18.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 150923 98.2%
Negative hits 1851 1.2%
Positive hits 881 0.6%
Cache misses 39 0.0%
TOTAL: 4 153694 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.990 0.0%80 0.000 12.375 30.571
article cleanup00:00:00.787 0.0%151162 0.000 0.005 0.033
article logging00:00:03.343 0.0%151179 0.010 0.022 0.038
article parse00:00:03.870 0.0%677324 0.002 0.006 0.009
article write00:00:25.995 0.0%150956 0.041 0.172 6.098
artlog/artcncl00:00:00.001 0.0%74 0.000 0.014 1.000
data move00:00:00.703 0.0%899794 0.000 0.001 0.003
hisgrep/artcncl00:00:00.228 0.0%79 0.000 2.886 9.000
hishave/artcncl00:00:00.179 0.0%80 0.000 2.237 6.545
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:09:42.638 0.7%153950 1.416 3.785 27.506
history sync00:00:00.016 0.0%301 0.000 0.053 1.000
history write00:07:30.451 0.5%151148 1.380 2.980 18.735
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:39:43.525 98.6%799696 19.123 106.520 340.889
nntp read00:00:09.351 0.0%667183 0.008 0.014 0.023
overview write00:00:00.451 0.0%150956 0.000 0.003 0.009
perl filter00:02:04.132 0.1%151148 0.514 0.821 1.168
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:04.016 0.0%314022 0.006 0.013 0.022
TOTAL: 24:00:18.29023:59:50.676100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.031 0.0%12100 0.000 0.003 0.025
article prepare00:00:00.000 0.0%144 0.000 0.000 0.000
article read00:00:00.002 0.0%36 0.000 0.056 1.000
backlog stats00:00:00.039 0.0%58525 0.000 0.001 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.306 0.0%30134 0.000 0.010 0.027
data write00:00:00.768 0.0%18121 0.000 0.042 0.169
idle23:58:24.116100.0%58525 678.112 1474.654 2743.913
status file00:00:00.332 0.0%379 0.000 0.876 50.000
TOTAL: 23:58:26.49823:58:25.594100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:19.630 54.5%4173 0.000 4.704 9771.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.142 0.4%10099 0.000 0.014 0.500
readart00:00:00.001 0.0%6 0.000 0.167 0.500
TOTAL: 00:00:36.02800:00:19.773 54.9%----

Control commands to INND:

CommandNumber
flush 27
flushlogs 2
go 2
logmode 2
lowmark 1
mode 149
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 193

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 106 150980 150855 7 118 99%45:41:51
2news.icm.edu.pl 19 901 33 784 84 3%20:58:38
3localhost 2 1 1 0 0 100%00:00:00
TOTAL: 3 127 151882 150889 791 202 99%66:40:29
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl1.6 GB530.6 KB761.6 KB1.6 GB 99%10.8 KB
2news.icm.edu.pl1.5 MB0.0 KB1.2 MB2.7 MB 54%23.9 KB
3localhost1.4 KB0.0 KB0.0 KB1.4 KB100%1.4 KB
TOTAL: 31.6 GB530.6 KB2.0 MB1.6 GB 99%10.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 30 04:15:01 - 04:59:59 3220 2.1% 1.1925.3 MB 1.6% 9.60
Aug 30 05:00:00 - 05:59:59 4928 3.3% 1.3740.3 MB 2.5% 11.48
Aug 30 06:00:00 - 06:59:59 5271 3.5% 1.4647.0 MB 3.0% 13.38
Aug 30 07:00:00 - 07:59:59 5595 3.7% 1.5551.0 MB 3.2% 14.50
Aug 30 08:00:00 - 08:59:59 4905 3.2% 1.3651.0 MB 3.2% 14.51
Aug 30 09:00:00 - 09:59:59 6532 4.3% 1.8191.2 MB 5.7% 25.93
Aug 30 10:00:00 - 10:59:59 6066 4.0% 1.6982.7 MB 5.2% 23.52
Aug 30 11:00:00 - 11:59:59 6854 4.5% 1.90118.6 MB 7.4% 33.74
Aug 30 12:00:00 - 12:59:59 6042 4.0% 1.68120.2 MB 7.5% 34.18
Aug 30 13:00:00 - 13:59:59 6498 4.3% 1.8067.6 MB 4.2% 19.24
Aug 30 14:00:00 - 14:59:59 5788 3.8% 1.6159.2 MB 3.7% 16.83
Aug 30 15:00:00 - 15:59:59 5718 3.8% 1.5968.9 MB 4.3% 19.61
Aug 30 16:00:00 - 16:59:59 19900 13.2% 5.53120.7 MB 7.6% 34.32
Aug 30 17:00:00 - 17:59:59 20587 13.6% 5.72149.3 MB 9.4% 42.46
Aug 30 18:00:00 - 18:59:59 5106 3.4% 1.4264.5 MB 4.0% 18.33
Aug 30 19:00:00 - 19:59:59 5121 3.4% 1.4269.8 MB 4.4% 19.87
Aug 30 20:00:00 - 20:59:59 5042 3.3% 1.4057.0 MB 3.6% 16.22
Aug 30 21:00:00 - 21:59:59 4079 2.7% 1.1346.3 MB 2.9% 13.17
Aug 30 22:00:00 - 22:59:59 5065 3.4% 1.4158.8 MB 3.7% 16.72
Aug 30 23:00:00 - 23:59:59 3784 2.5% 1.0540.0 MB 2.5% 11.37
Aug 31 00:00:00 - 00:59:59 3235 2.1% 0.9037.2 MB 2.3% 10.58
Aug 31 01:00:00 - 01:59:59 3047 2.0% 0.8534.5 MB 2.2% 9.82
Aug 31 02:00:00 - 02:59:59 3698 2.4% 1.0348.7 MB 3.1% 13.87
Aug 31 03:00:00 - 03:59:59 4135 2.7% 1.1536.1 MB 2.3% 10.27
Aug 31 04:00:00 - 04:15:01 753 0.5% 0.848.0 MB 0.5% 9.08
TOTAL: 24:00:00 150969 100.0% 1.751.6 GB 100.0% 18.89
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 134 104 0 14 0 0 0 0 16
2news.icm.edu.pl 89 0 0 0 0 0 0 0 89
TOTAL: 2 223 104 0 14 0 0 0 0 105

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 40
it.tlc.cellulari.android 22
nl.comp.os.linux.techniek 16
comp.sys.raspberry-pi 14
comp.mobile.android 6
de.comm.software.mailreader 3
comp.mobile.ipad 1
alt.comp.software.firefox 1
it.comp.os.win.windows10 1
TOTAL: 9 104

INND Perl filter [Top 20]:

ReasonCount
Scoring filter (8) 45
Binary in non-binary group 22
Scoring filter (9) 17
Scoring filter (10) 2
Scoring filter (16) 1
Scoring filter (12) 1
TOTAL: 6 88

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 17934 24 11881 12 0 0 0%23:50:01
2okapi 0 0 0 0 0 653 0%23:57:48
3panorama 0 0 0 0 0 12075 0%23:50:03
4poznan 48 0 33 0 0 0 0%04:04:31
5nask 0 0 0 0 0 8190 0%23:50:03
TOTAL: 5 17982 24 11914 12 0 20918 0%99:32:26
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm244.6 KB27.9 KB272.4 KB0.0 KB/s7.6 KB23:50:01
2okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
3panorama0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:03
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s004:04:31
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:03
TOTAL: 5244.6 KB27.9 KB272.4 KB0.0 KB/s7.6 KB99:32:26
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama976.7 KB
okapi488.4 KB
TOTAL: 21.4 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 64.7 KB 3 0 000:00:08
2isvcs01.man.lodz.pl 1 00.0 KB 0 1 000:00:00
TOTAL: 2 289 64.7 KB 3 1 000:00:36

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1729 64.7 KB 3 1 000:00:22
2*.census.shodan.io 1 00.0 KB 0 0 000:00:00
3unresolved 104 00.0 KB 0 0 000:00:13
TOTAL: 31834 64.7 KB 3 1 000:00:36

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
nms2.man.lodz.pl 3.765 6.498 0.00000:00:13
192.241.203.69 0.000 0.010 0.00000:00:09
web.man.lodz.pl 0.788 1.328 0.00000:00:08
80.111.142.213 0.003 0.030 0.00000:00:01
212.51.192.185 0.251 0.399 0.00000:00:00
hat.census.shodan.io 0.004 0.007 0.00000:00:00
183.136.225.32 0.000 0.013 0.00000:00:00
137.184.255.7 0.000 0.009 0.00000:00:00
isvcs01.man.lodz.pl 0.006 0.006 0.00000:00:00
80.66.88.211 0.005 0.000 0.00000:00:00
TOTAL: 10 4.822 8.300 0.00000:00:36

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1440
212.51.192.185 96
80.111.142.213 4
hat.census.shodan.io 1
80.66.88.211 1
137.184.255.7 1
183.136.225.32 1
192.241.203.69 1
TOTAL: 8 1545

NNRP unrecognized commands (by host):

SystemConn
183.136.225.32 5
137.184.255.7 1
80.66.88.211 1
TOTAL: 3 7

NNRP unrecognized commands (by command):

CommandCount
User-Agent: Mozilla/5.0 (Macintosh; Inte... 1
Connection: keep-alive 1
#003 1
Accept: */* 1
GET / HTTP/1.1 1
Host: 212.191.2.21:119 1
MGLNDD_212.191.2.21_119 1
TOTAL: 7 7

NNRP client timeouts [Top 20]:

SystemConnPeer
80.66.88.211 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 6100.0%
TOTAL: 1 6100.0%

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

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