Daily Usenet report

Jan 23 03:00:02 -- Jan 24 03:00:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jan 23 03:20:44 news innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 249663 66.7%32.3 MB 70.8%
innd 122116 32.6%13.0 MB 28.5%
innfeed 2437 0.7%270.1 KB 0.6%
nnrpd 205 0.1%21.0 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 374422 100.0%45.6 MB100.0%

History cache:

ReasonCount%Count
Do not exist 249455 49.8%
Negative hits 246211 49.2%
Cache misses 4694 0.9%
Positive hits 319 0.1%
TOTAL: 4 500679 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.274 0.0%33 0.000 8.303 77.000
article cleanup00:00:01.074 0.0%249608 0.000 0.004 0.153
article logging00:00:03.801 0.0%249671 0.000 0.015 0.074
article parse00:00:02.258 0.0%749227 0.000 0.003 0.014
article write00:03:12.603 0.2%136223 0.000 1.414 38.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
artlog/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.275 0.0%766320 0.000 0.000 0.006
hisgrep/artcncl00:00:00.085 0.0%33 0.000 2.576 30.000
hishave/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
hissync/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:12:41.830 0.9%501037 0.000 1.521 9.729
history sync00:00:00.016 0.0%305 0.000 0.052 1.000
history write00:05:36.632 0.4%249607 0.000 1.349 9.838
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:31:12.690 98.1%754712 28.058 112.192 60060.000
nntp read00:00:05.604 0.0%754508 0.000 0.007 0.145
overview write00:00:20.718 0.0%136223 0.000 0.152 34.000
perl filter00:05:06.817 0.4%249607 0.378 1.229 4.427
python filter00:00:13.767 0.0%500736 0.000 0.027 0.366
site send00:00:01.229 0.0%136223 0.000 0.009 0.074
TOTAL: 23:59:13.99623:58:39.673100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.189 0.0%136212 0.000 0.001 0.037
article prepare00:00:00.028 0.0%527292 0.000 0.000 0.005
article read00:00:11.625 0.0%131823 0.000 0.088 1.643
backlog stats00:00:00.156 0.0%649789 0.000 0.000 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.587 0.0%390553 0.000 0.007 0.057
data write00:00:03.979 0.0%254410 0.000 0.016 0.083
idle23:58:43.213100.0%649789 39.928 132.848 30100.000
status file00:00:00.103 0.0%205 0.000 0.502 10.667
TOTAL: 23:59:08.47923:59:01.880100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:54.776 45.0%75 110.000 730.347 4536.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.0%355 0.000 0.003 0.018
readart00:00:00.046 0.0%7 4.500 6.571 13.000
TOTAL: 00:02:01.81400:00:54.823 45.0%----

Control commands to INND:

CommandNumber
flush 4
flushlogs 4
go 2
logmode 3
lowmark 1
mode 146
name 3
pause 3
paused 3
reload 2
reserve 2
TOTAL: 11 173

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1chimia.se 2 251336 132740 5200 113396 52%23:50:55
2news.sklaffkom.se 2 3504 3504 0 0 100%24:02:07
3localhost 25 0 0 0 0 0%00:00:00
TOTAL: 3 29 254840 136244 5200 113396 53%47:53:02
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1chimia.se319.6 MB2.5 KB228.3 MB547.8 MB 58%2.3 KB
2news.sklaffkom.se4.8 MB0.0 KB0.0 KB4.8 MB100%1.4 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 3324.4 MB2.5 KB228.3 MB552.7 MB 58%2.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 23 03:00:02 - 03:59:59 4743 3.5% 1.3211.0 MB 3.4% 3.14
Jan 23 04:00:00 - 04:59:59 5254 3.9% 1.4611.5 MB 3.5% 3.26
Jan 23 05:00:00 - 05:59:59 6771 5.0% 1.8813.1 MB 4.1% 3.74
Jan 23 06:00:00 - 06:59:59 6039 4.4% 1.6811.7 MB 3.6% 3.34
Jan 23 07:00:00 - 07:59:59 5154 3.8% 1.439.8 MB 3.0% 2.77
Jan 23 08:00:00 - 08:59:59 4263 3.1% 1.187.7 MB 2.4% 2.20
Jan 23 09:00:00 - 09:59:59 3729 2.7% 1.047.1 MB 2.2% 2.02
Jan 23 10:00:00 - 10:59:59 4260 3.1% 1.188.3 MB 2.6% 2.37
Jan 23 11:00:00 - 11:59:59 4934 3.6% 1.379.4 MB 2.9% 2.66
Jan 23 12:00:00 - 12:59:59 5987 4.4% 1.6611.5 MB 3.6% 3.28
Jan 23 13:00:00 - 13:59:59 4747 3.5% 1.329.2 MB 2.8% 2.63
Jan 23 14:00:00 - 14:59:59 4359 3.2% 1.218.1 MB 2.5% 2.29
Jan 23 15:00:00 - 15:59:59 4243 3.1% 1.188.2 MB 2.5% 2.33
Jan 23 16:00:00 - 16:59:59 4790 3.5% 1.3310.0 MB 3.1% 2.85
Jan 23 17:00:00 - 17:59:59 5034 3.7% 1.4011.0 MB 3.4% 3.13
Jan 23 18:00:00 - 18:59:59 4586 3.4% 1.2710.1 MB 3.1% 2.88
Jan 23 19:00:00 - 19:59:59 6861 5.0% 1.9120.9 MB 6.4% 5.95
Jan 23 20:00:00 - 20:59:59 5849 4.3% 1.6221.7 MB 6.7% 6.17
Jan 23 21:00:00 - 21:59:59 7799 5.7% 2.1719.5 MB 6.0% 5.54
Jan 23 22:00:00 - 22:59:59 8072 5.9% 2.2426.7 MB 8.2% 7.58
Jan 23 23:00:00 - 23:59:59 5879 4.3% 1.6320.0 MB 6.2% 5.68
Jan 24 00:00:00 - 00:59:59 6992 5.1% 1.9417.4 MB 5.4% 4.94
Jan 24 01:00:00 - 01:59:59 8541 6.3% 2.3723.4 MB 7.2% 6.65
Jan 24 02:00:00 - 02:59:59 7332 5.4% 2.0417.1 MB 5.3% 4.86
Jan 24 03:00:00 - 03:00:02 5 0.0% 2.504.5 KB 0.0% 2.26
TOTAL: 24:00:00 136223 100.0% 1.58324.4 MB 100.0% 3.84
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1chimia.se113440 0 0 1 2 0 0 0113437
TOTAL: 1113440 0 0 1 2 0 0 0113437

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

GroupsCount
news.newusers.questions 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 50388
EMP (phn nph) 40466
EMP (phl) 15690
EMP (phr path) 3433
EMP (md5) 1205
EMP (phr nph) 855
HTML Multipart 400
Subject Rejected 379
Too many newsgroups (low_xpost) 241
Too many newsgroups (meow) 144
MI5 Filter 68
Too many newsgroups 27
EMP (fsl) 22
Scoring filter 17
HTML post 14
Binary Image: misplaced gif 11
Binary: misplaced binary 3
PFM bot misc 3
HTML Image Tags 1
Poison newsgroup 1
TOTAL: 27 113375

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
chimia.se 18
TOTAL: 1 18
Including strange strings
chimia.se 63
TOTAL: 1 63
TOTAL: 2 81

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1sklaffkom.se 133000 1966 875130158 0 0 1%23:56:28
2sklaff.dev 0 0 0 0 0 136868 0%24:05:30
3thebunker.nu 0 0 0 0 0 137035 0%24:09:55
4usenet.blueworldhosting.com 0 0 0 0 0 43751 0%24:09:55
TOTAL: 4 133000 1966 875130158 0 317654 1%96:21:48
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1sklaffkom.se4.9 MB312.4 MB317.3 MB3.8 KB/s2.5 KB23:56:28
2sklaff.dev0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:30
3thebunker.nu0.0 KB0.0 KB0.0 KB0.0 KB/s024:09:55
4usenet.blueworldhosting.com0.0 KB0.0 KB0.0 KB0.0 KB/s024:09:55
TOTAL: 44.9 MB312.4 MB317.3 MB0.9 KB/s2.5 KB96:21:48
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
166.61.98.95 10 732.4 KB 4 0 000:00:49
TOTAL: 1 10 732.4 KB 4 0 000:02:01

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 14 732.4 KB 4 0 000:00:58
2*.149.216.162.bc.googleusercontent.com 5 00.0 KB 0 0 000:00:32
3*.150.216.162.bc.googleusercontent.com 4 00.0 KB 0 0 000:00:25
4*.125.142.162.censys-scanner.com 3 00.0 KB 0 0 000:00:05
TOTAL: 4 26 732.4 KB 4 0 000:02:01

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
66.61.98.95 0.098 0.060 0.00000:00:49
147.149.216.162.bc.googleusercontent.com 0.171 0.013 0.00000:00:32
17.150.216.162.bc.googleusercontent.com 0.165 0.017 0.00000:00:25
196.125.142.162.censys-scanner.com 0.053 0.017 0.00000:00:05
147.185.133.246 0.040 0.006 0.00000:00:05
198.235.24.83 0.005 0.005 0.00000:00:01
205.210.31.102 0.006 0.007 0.00000:00:01
135.149.216.162.bc.googleusercontent.com 0.041 0.006 0.00000:00:00
192.227.206.227 0.007 0.005 0.00000:00:00
TOTAL: 9 0.586 0.136 0.00000:02:01

Curious NNRP server explorers [Top 20]:

SystemConn
147.149.216.162.bc.googleusercontent.com 4
17.150.216.162.bc.googleusercontent.com 4
196.125.142.162.censys-scanner.com 3
135.149.216.162.bc.googleusercontent.com 1
147.185.133.246 1
192.227.206.227 1
198.235.24.83 1
205.210.31.102 1
TOTAL: 8 16

NNRP gethostbyaddr failures [Top 20]:

SystemConn
? (can't getpeername) 5
TOTAL: 1 5

NNRP unrecognized commands (by host) [Top 20]:

SystemConn
147.149.216.162.bc.googleusercontent.com 8
17.150.216.162.bc.googleusercontent.com 8
135.149.216.162.bc.googleusercontent.com 4
147.185.133.246 4
196.125.142.162.censys-scanner.com 1
TOTAL: 5 25

NNRP unrecognized commands (by command) [Top 20]:

CommandCount
GET / HTTP/1.1 6
Host: 109.238.130.155:563 6
Accept: */* 4
User-Agent: curl/7.68.0 4
Accept-Encoding: gzip 2
User-Agent: Hello from Palo Alto Network... 2
EHLO www.censys.io 1
TOTAL: 7 25

NNRP client timeouts [Top 20]:

SystemConnPeer
147.149.216.162.bc.googleusercontent.com 2 2
17.150.216.162.bc.googleusercontent.com 2 4
135.149.216.162.bc.googleusercontent.com 1 1
147.185.133.246 1 1
196.125.142.162.censys-scanner.com 1 2
TOTAL: 5 7 12

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1alt 4 57.1%
2comp 3 42.9%
TOTAL: 2 7100.0%

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

NewsgroupCount
1alt.cellular.gsm 2
2alt.fan.jeremy-reimer 2
3comp.software.licensing 2
4comp.sys.ibm.pc.games.announce 1
TOTAL: 4 7