Daily Usenet report

Jun 10 04:15:01 -- Jun 11 04:15:01

Unknown entries from news log file:

First 19 / 19 lines (100.0%)

Jun 10 06:58:50 newsfeed overchan[480996]: input line too long, skipping
Jun 10 11:12:45 newsfeed pgpverify[500551]: pgpverify: /usr/bin/gpg1: no such file
Jun 10 11:13:27 newsfeed pgpverify[500564]: pgpverify: /usr/bin/gpg1: no such file
Jun 10 11:14:09 newsfeed pgpverify[500579]: pgpverify: /usr/bin/gpg1: no such file
Jun 10 11:14:51 newsfeed pgpverify[500608]: pgpverify: /usr/bin/gpg1: no such file
Jun 10 11:15:33 newsfeed pgpverify[500706]: pgpverify: /usr/bin/gpg1: no such file
Jun 10 11:16:16 newsfeed pgpverify[500724]: pgpverify: /usr/bin/gpg1: no such file
Jun 10 11:16:57 newsfeed pgpverify[500738]: pgpverify: /usr/bin/gpg1: no such file
Jun 10 11:17:40 newsfeed pgpverify[500753]: pgpverify: /usr/bin/gpg1: no such file
Jun 10 11:18:22 newsfeed pgpverify[500770]: pgpverify: /usr/bin/gpg1: no such file
Jun 10 11:19:04 newsfeed pgpverify[500785]: pgpverify: /usr/bin/gpg1: no such file
Jun 10 11:19:46 newsfeed pgpverify[500811]: pgpverify: /usr/bin/gpg1: no such file
Jun 10 11:20:28 newsfeed pgpverify[500908]: pgpverify: /usr/bin/gpg1: no such file
Jun 10 11:21:10 newsfeed pgpverify[500923]: pgpverify: /usr/bin/gpg1: no such file
Jun 10 11:24:43 newsfeed pgpverify[501108]: pgpverify: /usr/bin/gpg1: no such file
Jun 10 12:23:35 newsfeed overchan[480996]: input line too long, skipping
Jun 10 14:46:31 newsfeed overchan[480996]: input line too long, skipping
Jun 10 14:56:31 newsfeed overchan[480996]: input line too long, skipping
Jun 10 17:10:17 newsfeed overchan[480996]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 105407 75.3%13.1 MB 76.4%
innfeed 25142 18.0%2.9 MB 17.1%
nnrpd 7666 5.5%867.5 KB 5.0%
innd 1722 1.2%259.5 KB 1.5%
controlchan 25 0.0%3.6 KB 0.0%
pgpverify 14 0.0%2.7 KB 0.0%
overchan 6 0.0%0.9 KB 0.0%
TOTAL: 7 139982 100.0%17.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 104968 98.8%
Negative hits 1111 1.0%
Positive hits 191 0.2%
Cache misses 21 0.0%
TOTAL: 4 106291 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.774 0.0%34 0.000 22.765 54.500
article cleanup00:00:00.548 0.0%105121 0.000 0.005 0.022
article logging00:00:02.269 0.0%105365 0.005 0.022 0.046
article parse00:00:05.735 0.0%1458471 0.001 0.004 0.011
article write00:00:15.083 0.0%104977 0.041 0.144 5.661
artlog/artcncl00:00:00.001 0.0%34 0.000 0.029 0.200
data move00:00:00.863 0.0%1782978 0.000 0.000 0.002
hisgrep/artcncl00:00:00.351 0.0%34 0.000 10.324 21.500
hishave/artcncl00:00:00.124 0.0%34 0.000 3.647 8.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:09:34.410 0.7%106407 2.191 5.398 23.762
history sync00:00:00.012 0.0%300 0.000 0.040 0.500
history write00:12:14.505 0.8%105117 4.009 6.987 24.386
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:34:49.441 98.2%1528231 0.945 55.548 611.457
nntp read00:00:13.331 0.0%1446781 0.004 0.009 0.024
overview write00:00:00.247 0.0%104977 0.000 0.002 0.014
perl filter00:02:09.963 0.2%105117 0.770 1.236 2.187
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:02.612 0.0%218313 0.002 0.012 0.028
TOTAL: 24:00:16.61123:59:30.269 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.039 0.0%30334 0.000 0.001 0.016
article prepare00:00:00.002 0.0%3326 0.000 0.001 0.042
article read00:00:14.400 0.0%833 1.625 17.287 49.000
backlog stats00:00:00.048 0.0%66926 0.000 0.001 0.006
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:00.278 0.0%32695 0.000 0.009 0.036
data write00:00:00.679 0.0%24463 0.000 0.028 0.087
idle23:57:28.516100.0%66926 747.623 1288.715 2634.716
status file00:00:06.555 0.0%8399 0.222 0.780 9.857
TOTAL: 23:57:52.50923:57:50.517100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:29.503 64.8%4191 0.000 7.040 10002.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.128 0.3%10167 0.000 0.013 0.500
readart00:00:00.000 0.0%18 0.000 0.000 0.000
TOTAL: 00:00:45.51500:00:29.631 65.1%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
control@usenet-fr.news.eu.org0011401
TOTAL0011401

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 93 105147 105007 1 139 99%39:48:44
2news.icm.edu.pl 41 176 3 168 5 1%14:21:31
3localhost 1 0 0 0 0 0%00:00:00
TOTAL: 3 135 105323 105010 169 144 99%54:10:15
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl3.7 GB60.2 KB465.1 KB3.7 GB 99%36.7 KB
2news.icm.edu.pl154.4 KB25.5 KB58.5 KB238.4 KB 64%29.8 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 33.7 GB85.7 KB523.6 KB3.7 GB 99%36.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 10 04:15:01 - 04:59:59 1207 1.1% 0.4514.7 MB 0.4% 5.59
Jun 10 05:00:00 - 05:59:59 2149 2.0% 0.6022.6 MB 0.6% 6.44
Jun 10 06:00:00 - 06:59:59 2731 2.6% 0.7628.0 MB 0.7% 7.97
Jun 10 07:00:00 - 07:59:59 2036 1.9% 0.5726.3 MB 0.7% 7.47
Jun 10 08:00:00 - 08:59:59 5883 5.6% 1.6373.2 MB 1.9% 20.83
Jun 10 09:00:00 - 09:59:59 2088 2.0% 0.5828.0 MB 0.7% 7.96
Jun 10 10:00:00 - 10:59:59 3620 3.4% 1.0189.7 MB 2.4% 25.52
Jun 10 11:00:00 - 11:59:59 31468 30.0% 8.742.6 GB 69.7% 747.40
Jun 10 12:00:00 - 12:59:59 3556 3.4% 0.9949.5 MB 1.3% 14.07
Jun 10 13:00:00 - 13:59:59 2010 1.9% 0.5630.3 MB 0.8% 8.62
Jun 10 14:00:00 - 14:59:59 2829 2.7% 0.7943.1 MB 1.1% 12.26
Jun 10 15:00:00 - 15:59:59 3300 3.1% 0.9262.4 MB 1.7% 17.74
Jun 10 16:00:00 - 16:59:59 4937 4.7% 1.37172.8 MB 4.6% 49.16
Jun 10 17:00:00 - 17:59:59 2914 2.8% 0.8137.2 MB 1.0% 10.58
Jun 10 18:00:00 - 18:59:59 3846 3.7% 1.0762.9 MB 1.7% 17.89
Jun 10 19:00:00 - 19:59:59 2675 2.5% 0.7440.5 MB 1.1% 11.53
Jun 10 20:00:00 - 20:59:59 2297 2.2% 0.6435.2 MB 0.9% 10.01
Jun 10 21:00:00 - 21:59:59 2766 2.6% 0.7738.3 MB 1.0% 10.89
Jun 10 22:00:00 - 22:59:59 3699 3.5% 1.0364.2 MB 1.7% 18.26
Jun 10 23:00:00 - 23:59:59 3310 3.2% 0.9239.3 MB 1.0% 11.19
Jun 11 00:00:00 - 00:59:59 5986 5.7% 1.6674.8 MB 2.0% 21.28
Jun 11 01:00:00 - 01:59:59 5312 5.1% 1.4858.5 MB 1.6% 16.63
Jun 11 02:00:00 - 02:59:59 1917 1.8% 0.5319.9 MB 0.5% 5.66
Jun 11 03:00:00 - 03:59:59 1888 1.8% 0.5222.0 MB 0.6% 6.24
Jun 11 04:00:00 - 04:15:01 561 0.5% 0.629.2 MB 0.2% 10.42
TOTAL: 24:00:00 104985 100.0% 1.223.7 GB 100.0% 44.68
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 383 135 0 2 2 0 0 0 244
2news.icm.edu.pl 5 0 0 2 0 0 0 0 3
TOTAL: 2 388 135 0 4 2 0 0 0 247

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 68
comp.mobile.android 25
alt.comp.software.firefox 13
it.comp.os.win.windows10 11
alt.comp.software.seamonkey 6
de.comp.lang.perl 4
comp.sys.mac.vintage 2
it.tlc.cellulari.android 2
de.comm.provider.telefonie 2
comp.sys.raspberry-pi 1
it.comp.os.linux.ubuntu 1
TOTAL: 11 135

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

GroupsCount
soc.culture.jewish.holocaust 1
pl.sci.matematyka 1
TOTAL: 2 2

INND Perl filter [Top 20]:

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

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 22627 201 8401 237 3 21520 0%23:59:50
2icm 11108 10 8277 0 0 0 0%24:05:12
3poznan 5 0 3 0 0 0 0%00:37:42
4okapi 0 0 0 0 0 338 0%23:57:52
5nask 0 0 0 0 0 5637 0%23:57:52
TOTAL: 5 33740 211 16681 237 3 27495 0%96:38:28
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama500.4 KB3.2 MB3.7 MB0.0 KB/s8.6 KB23:59:50
2icm30.4 KB0.0 KB30.4 KB0.0 KB/s3.0 KB24:05:12
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s000:37:42
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:52
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:52
TOTAL: 5530.8 KB3.2 MB3.7 MB0.0 KB/s8.5 KB96:38:28
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 289 1819.6 KB 9 0 000:00:08
TOTAL: 1 289 1819.6 KB 9 0 000:00:46

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1729 1819.6 KB 9 0 000:00:21
2*.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
3unresolved 105 00.0 KB 0 0 000:00:23
4*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 41836 1819.6 KB 9 0 000:00:46

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
nms2.man.lodz.pl 2.524 28.683 0.00000:00:13
8.218.132.187 0.000 0.039 0.00000:00:10
192.241.223.20 0.000 0.025 0.00000:00:09
web.man.lodz.pl 0.522 6.039 0.00000:00:08
80.111.142.213 0.004 0.097 0.00000:00:02
212.51.192.185 0.185 1.929 0.00000:00:00
scanner-09.ch1.censys-scanner.com 0.004 0.022 0.00000:00:00
192.241.202.239 0.003 0.024 0.00000:00:00
249.211.203.35.bc.googleusercontent.com 0.000 0.020 0.00000:00:00
80.66.88.204 0.000 0.025 0.00000:00:00
TOTAL: 10 3.242 36.903 0.00000:00:46

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1440
212.51.192.185 96
80.111.142.213 4
8.218.132.187 2
192.241.202.239 1
scanner-09.ch1.censys-scanner.com 1
192.241.223.20 1
249.211.203.35.bc.googleusercontent.com 1
80.66.88.204 1
TOTAL: 9 1547

NNRP unrecognized commands (by host):

SystemConn
8.218.132.187 3
249.211.203.35.bc.googleusercontent.com 3
192.241.202.239 1
scanner-09.ch1.censys-scanner.com 1
80.66.88.204 1
TOTAL: 5 9

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 1
User-Agent: Expanse, a Palo Alto Network... 1
#026#003#001#001#011#001 1
L#011#034¾¬±î[#017±¼ˆ/¼j“–»è#001F¿ 1
#003 1
Host: 212.191.2.21:119 1
MGLNDD_212.191.2.21_119 1
#023#003#023#001#023#002#001 1
EHLO www.censys.io 1
TOTAL: 9 9

NNRP client timeouts [Top 20]:

SystemConnPeer
80.66.88.204 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 18100.0%
TOTAL: 1 18100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 12
2pl.comp.pecet 6
TOTAL: 2 18