Daily Usenet report

Jan 6 04:15:02 -- Jan 7 04:15:27

Unknown entries from news log file:

First 33 / 33 lines (100.0%)

Jan 6 15:19:25 newsfeed nnrpd[18488]: unable to get certificate from '/etc/news/cert.pem'
Jan 6 15:19:25 newsfeed nnrpd[18488]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Jan 6 18:29:52 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 2 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1280000 duplicate size 0 rejected size 0]
Jan 6 18:55:32 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1321984 duplicate size 0 rejected size 0]
Jan 6 19:10:17 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1310720 duplicate size 0 rejected size 0]
Jan 6 19:42:11 newsfeed overchan[15241]: input line too long, skipping
Jan 6 19:44:11 newsfeed overchan[15241]: input line too long, skipping
Jan 6 19:54:09 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]
Jan 6 19:56:24 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]
Jan 6 19:57:50 newsfeed innd: message repeated 3 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]
Jan 6 19:58:06 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]
Jan 6 19:59:36 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]
Jan 6 20:00:34 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]
Jan 6 20:00:52 newsfeed innd: message repeated 3 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]
Jan 6 20:27:11 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]
Jan 6 20:33:40 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]
Jan 6 20:36:15 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]
Jan 6 20:47:06 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]
Jan 6 20:55:45 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]
Jan 6 21:06:54 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]
Jan 6 21:11:34 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]
Jan 6 21:13:43 newsfeed innd: message repeated 4 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]
Jan 6 21:16:39 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]
Jan 6 21:26:22 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]
Jan 6 21:26:33 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]
Jan 6 21:26:55 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]
Jan 6 21:27:11 newsfeed innd: message repeated 3 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]
Jan 6 21:30:47 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]
Jan 6 21:32:26 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]
Jan 6 21:33:36 newsfeed innd: message repeated 6 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]
Jan 6 21:33:43 newsfeed innd: message repeated 3 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]
Jan 6 21:39:20 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]
Jan 6 21:41:02 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:50 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1228800 duplicate size 0 rejected size 0]

Log entries by program:

Program nameLines%LinesSize%Size
inn3979274 98.2%420.3 MB 97.7%
innfeed 44810 1.1%5.3 MB 1.2%
innd 25664 0.6%4.3 MB 1.0%
nnrpd 3406 0.1%321.2 KB 0.1%
overchan 3 0.0%0.4 KB 0.0%
controlchan 2 0.0%0.1 KB 0.0%
TOTAL: 64053159 100.0%430.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 3977985 99.8%
Negative hits 7272 0.2%
Positive hits 279 0.0%
Cache misses 44 0.0%
TOTAL: 4 3985580 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.701 0.0%82 0.000 8.549 33.222
article cleanup00:00:09.148 0.0%3978785 0.002 0.002 0.008
article logging00:00:39.953 0.0%3979154 0.007 0.010 1.061
article parse00:07:15.029 0.5%125878985 0.003 0.003 0.007
article write00:06:34.909 0.5%3978531 0.021 0.099 13.948
artlog/artcncl00:00:00.000 0.0%82 0.000 0.000 0.000
data move00:00:25.077 0.0%128673374 0.000 0.000 0.000
hisgrep/artcncl00:00:00.276 0.0%80 0.000 3.450 20.333
hishave/artcncl00:00:00.001 0.0%82 0.000 0.012 0.111
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:26:38.909 1.9%3986602 0.001 0.401 49.674
history sync00:00:00.004 0.0%296 0.000 0.014 0.500
history write01:00:58.174 4.2%3978757 0.016 0.919 72.881
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle21:18:19.498 88.8%124679109 0.163 0.615 1.157
nntp read00:12:46.973 0.9%123746338 0.005 0.006 0.009
overview write00:00:04.486 0.0%3978531 0.000 0.001 0.004
perl filter00:38:23.381 2.7%3978757 0.266 0.579 4.128
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:45.899 0.1%7969458 0.005 0.006 0.011
TOTAL: 24:00:13.63523:53:02.418 99.5%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.046 0.0%47516 0.000 0.001 0.009
article prepare00:00:00.000 0.0%6458 0.000 0.000 0.000
article read00:00:59.601 0.1%1606 0.000 37.111 11030.000
backlog stats00:00:00.067 0.0%118113 0.000 0.001 0.007
callbacks00:00:00.000 0.0%3 0.000 0.000 0.000
data read00:00:00.346 0.0%55815 0.000 0.006 0.017
data write00:00:00.786 0.0%44309 0.000 0.018 0.058
idle23:24:51.202 97.9%118113 455.135 713.649 1108.418
status file00:29:12.404 2.0%16599 0.225 105.573 4649.463
TOTAL: 23:55:06.59423:55:04.452100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:30:19.664 99.4%2752 0.000 661.215600128.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.041 0.0%5923 0.000 0.007 0.500
readart00:00:00.001 0.0%16 0.000 0.062 0.500
TOTAL: 00:30:31.52300:30:19.706 99.4%----

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 152 39652483965003 0 245 99%84:27:29
2news.icm.edu.pl 55 243 18 215 10 7%16:05:56
3localhost 1441 0 0 0 0 0%00:00:04
TOTAL: 3 1648 39654913965021 215 255 99%100:33:29
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl280.4 GB2.5 MB13.7 MB280.4 GB 99%74.2 KB
2news.icm.edu.pl721.2 KB121.5 KB200.1 KB1.0 MB 69%37.2 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 3280.4 GB2.6 MB13.9 MB280.4 GB 99%74.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 6 04:15:02 - 04:59:59 16747 0.4% 6.218.5 GB 3.0%3293.38
Jan 6 05:00:00 - 05:59:59 24539 0.6% 6.8211.3 GB 4.0%3295.50
Jan 6 06:00:00 - 06:59:59 19194 0.5% 5.339.5 GB 3.4%2755.41
Jan 6 07:00:00 - 07:59:59 20066 0.5% 5.579.8 GB 3.5%2847.06
Jan 6 08:00:00 - 08:59:59 22921 0.6% 6.3711.2 GB 4.0%3259.10
Jan 6 09:00:00 - 09:59:59 26139 0.7% 7.2612.5 GB 4.4%3634.72
Jan 6 10:00:00 - 10:59:59 25036 0.6% 6.9510.9 GB 3.9%3181.82
Jan 6 11:00:00 - 11:59:59 29744 0.7% 8.2611.7 GB 4.1%3394.64
Jan 6 12:00:00 - 12:59:59 25824 0.6% 7.1710.7 GB 3.8%3116.58
Jan 6 13:00:00 - 13:59:59 24428 0.6% 6.7911.7 GB 4.1%3397.63
Jan 6 14:00:00 - 14:59:59 23660 0.6% 6.5710.9 GB 3.9%3162.48
Jan 6 15:00:00 - 15:59:59 22621 0.6% 6.2810.8 GB 3.8%3154.93
Jan 6 16:00:00 - 16:59:59 21455 0.5% 5.9610.5 GB 3.7%3052.59
Jan 6 17:00:00 - 17:59:59 23341 0.6% 6.4811.2 GB 4.0%3250.41
Jan 6 18:00:00 - 18:59:59 414855 10.4% 115.2412.6 GB 4.5%3662.26
Jan 6 19:00:00 - 19:59:59 1082127 27.2% 300.5915.2 GB 5.4%4436.35
Jan 6 20:00:00 - 20:59:59 958789 24.1% 266.3315.1 GB 5.3%4387.48
Jan 6 21:00:00 - 21:59:59 1015642 25.5% 282.1216.3 GB 5.8%4743.26
Jan 6 22:00:00 - 22:59:59 49718 1.2% 13.8111.8 GB 4.2%3450.33
Jan 6 23:00:00 - 23:59:59 24148 0.6% 6.7110.7 GB 3.8%3113.01
Jan 7 00:00:00 - 00:59:59 30171 0.8% 8.3812.7 GB 4.5%3684.75
Jan 7 01:00:00 - 01:59:59 28123 0.7% 7.8111.8 GB 4.2%3447.68
Jan 7 02:00:00 - 02:59:59 21707 0.5% 6.0310.4 GB 3.7%3028.01
Jan 7 03:00:00 - 03:59:59 21233 0.5% 5.9011.1 GB 4.0%3246.09
Jan 7 04:00:00 - 04:15:27 6340 0.2% 6.843.1 GB 1.1%3507.57
TOTAL: 24:00:25 3978568 100.0% 46.03281.8 GB 100.0%3418.74
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 614 219 0 23 3 0 0 0 369
2news.icm.edu.pl 10 0 0 6 0 0 0 0 4
TOTAL: 2 624 219 0 29 3 0 0 0 373

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 99
comp.mobile.android 39
alt.binaries.666 18
alt.comp.software.seamonkey 15
it.comp.os.win.windows10 13
it.tlc.cellulari.android 10
comp.sys.raspberry-pi 10
nl.comp.os.linux.techniek 8
alt.comp.software.firefox 3
de.rec.sf.startrek 2
it.comp.os.linux.ubuntu 1
de.comp.lang.vbclassic 1
TOTAL: 12 219

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

GroupsCount
pl.praca.oferowana 3
TOTAL: 1 3

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 2
Scoring filter (8) 1
EMP (md5) 1
TOTAL: 3 4

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 38958 423 10835 210 4 36163 1%24:00:19
2icm 21994 299 11663 108 1 0 1%24:00:19
3nask 0 0 0 0 0 8287 0%23:58:09
4poznan 10 0 9 0 0 0 0%01:22:20
5okapi 0 0 0 0 0 663 0%23:58:09
TOTAL: 5 60962 722 22507 318 5 45113 1%97:19:16
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm2.8 MB18.4 MB21.2 MB0.3 KB/s53.3 KB24:00:19
2panorama1.3 MB754.1 KB2.0 MB0.0 KB/s3.2 KB24:00:19
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:09
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:22:20
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:09
TOTAL: 54.0 MB19.2 MB23.2 MB0.1 KB/s22.8 KB97:19:16
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 292 1614.0 KB 8 0 000:00:09
TOTAL: 1 292 1614.0 KB 8 0 000:30:31

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 292 1614.0 KB 8 0 000:00:09
2*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
3unresolved 111 00.0 KB 0 0 000:30:21
TOTAL: 3 404 1614.0 KB 8 0 000:30:31

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
185.135.2.84 0.009 0.004 0.00000:30:01
104.152.52.145 0.005 0.000 0.00000:00:10
web.man.lodz.pl 0.588 2.667 0.00000:00:09
212.51.192.185 0.194 0.814 0.00000:00:05
80.111.142.213 0.013 0.026 0.00000:00:02
143.244.188.249 0.003 0.149 0.00000:00:01
104.152.52.150 0.004 0.015 0.00000:00:00
scanner-07.ch1.censys-scanner.com 0.000 0.006 0.00000:00:00
TOTAL: 8 0.816 3.681 0.00000:30:31

Curious NNRP server explorers [Top 20]:

SystemConn
212.51.192.185 96
143.244.188.249 8
80.111.142.213 4
185.135.2.84 1
scanner-07.ch1.censys-scanner.com 1
104.152.52.150 1
104.152.52.145 1
TOTAL: 7 112

NNRP unrecognized commands (by host):

SystemConn
143.244.188.249 42
scanner-07.ch1.censys-scanner.com 1
TOTAL: 2 43

NNRP unrecognized commands (by command):

CommandCount
Host: 212.191.2.21:119 7
Accept-Encoding: gzip, deflate 7
Accept: */* 7
Connection: keep-alive 7
User-Agent: Mozilla/5.0 (Windows NT 10.0... 6
GET /stalker_portal/c/version.js HTTP/1.... 1
GET / HTTP/1.1 1
GET /c/version.js HTTP/1.1 1
GET /flu/403.html HTTP/1.1 1
GET /streaming/clients_live.php HTTP/1.1 1
User-Agent: Roku/DVP-9.10 (289.10E04111A... 1
GET /system_api.php HTTP/1.1 1
EHLO www.censys.io 1
GET /stream/live.php HTTP/1.1 1
TOTAL: 14 43

NNRP client timeouts [Top 20]:

SystemConnPeer
185.135.2.84 1 0
TOTAL: 1 1 0

Newsgroup request counts (by category):

CategoryCountPct
1pl 16100.0%
TOTAL: 1 16100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 12
2pl.comp.pecet 4
TOTAL: 2 16