Daily Usenet report

Feb 5 04:15:02 -- Feb 6 04:15:02

Unknown entries from news log file:

First 50 / 1956 lines (2.6%)

Feb 5 15:42:55 newsfeed overchan[636037]: input line too long, skipping
Feb 5 16:06:43 newsfeed overchan[636037]: input line too long, skipping
Feb 5 17:12:45 newsfeed overchan[636037]: input line too long, skipping
Feb 5 18:47:15 newsfeed innfeed[1446]: CNFS: Mismatch 3: read BUF04 for cycbuff BUF03
Feb 5 18:47:15 newsfeed innfeed[1446]: SM: storage method 'cnfs' failed initialization
Feb 5 18:47:15 newsfeed innfeed[1446]: SM: one or more storage methods failed initialization
Feb 5 18:47:15 newsfeed innfeed[1446]: Storage manager initialization failed -- it is OK after a change in storage methods
Feb 5 18:47:15 newsfeed innd: CNFS: Mismatch 3: read BUF04 for cycbuff BUF03
Feb 5 18:47:15 newsfeed innd: SM: storage method 'cnfs' failed initialization
Feb 5 18:47:15 newsfeed innd: SM: one or more storage methods failed initialization
Feb 5 19:02:27 newsfeed nnrpd[1787]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 5 19:02:27 newsfeed nnrpd[1788]: news.icm.edu.pl noperm ihave without permission
Feb 5 19:02:57 newsfeed nnrpd[1796]: news.icm.edu.pl noperm ihave without permission
Feb 5 19:02:57 newsfeed nnrpd[1797]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 5 19:03:27 newsfeed nnrpd[1802]: news.icm.edu.pl noperm ihave without permission
Feb 5 19:03:27 newsfeed nnrpd[1803]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 5 19:03:57 newsfeed nnrpd[1810]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 5 19:03:57 newsfeed nnrpd[1811]: news.icm.edu.pl noperm ihave without permission
Feb 5 19:04:27 newsfeed nnrpd[1817]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 5 19:04:27 newsfeed nnrpd[1818]: news.icm.edu.pl noperm ihave without permission
Feb 5 19:04:57 newsfeed nnrpd[1838]: news.icm.edu.pl noperm ihave without permission
Feb 5 19:04:58 newsfeed nnrpd[1837]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 5 19:05:27 newsfeed nnrpd[1925]: news.icm.edu.pl noperm ihave without permission
Feb 5 19:05:29 newsfeed nnrpd[1926]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 5 19:05:56 newsfeed nnrpd[1789]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 5 19:05:57 newsfeed nnrpd[1933]: news.icm.edu.pl noperm ihave without permission
Feb 5 19:06:00 newsfeed nnrpd[1934]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 5 19:06:27 newsfeed nnrpd[1939]: news.icm.edu.pl noperm ihave without permission
Feb 5 19:06:31 newsfeed nnrpd[1940]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 5 19:06:57 newsfeed nnrpd[1947]: news.icm.edu.pl noperm ihave without permission
Feb 5 19:07:01 newsfeed nnrpd[1949]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 5 19:07:27 newsfeed nnrpd[1953]: news.icm.edu.pl noperm ihave without permission
Feb 5 19:07:32 newsfeed nnrpd[1954]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 5 19:07:57 newsfeed nnrpd[1968]: news.icm.edu.pl noperm ihave without permission
Feb 5 19:08:04 newsfeed nnrpd[1969]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 5 19:08:27 newsfeed nnrpd[1974]: news.icm.edu.pl noperm ihave without permission
Feb 5 19:08:36 newsfeed nnrpd[1975]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 5 19:08:58 newsfeed nnrpd[1982]: news.icm.edu.pl noperm ihave without permission
Feb 5 19:09:08 newsfeed nnrpd[1983]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 5 19:09:28 newsfeed nnrpd[2133]: news.icm.edu.pl noperm ihave without permission
Feb 5 19:09:40 newsfeed nnrpd[2135]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 5 19:09:59 newsfeed nnrpd[2154]: news.icm.edu.pl noperm ihave without permission
Feb 5 19:10:12 newsfeed nnrpd[2239]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 5 19:10:29 newsfeed nnrpd[2242]: news.icm.edu.pl noperm ihave without permission
Feb 5 19:10:42 newsfeed nnrpd[2243]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 5 19:10:59 newsfeed nnrpd[2250]: news.icm.edu.pl noperm ihave without permission
Feb 5 19:11:12 newsfeed nnrpd[2252]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 5 19:11:29 newsfeed nnrpd[2255]: news.icm.edu.pl noperm ihave without permission
Feb 5 19:11:44 newsfeed nnrpd[2256]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 5 19:11:59 newsfeed nnrpd[2263]: news.icm.edu.pl noperm ihave without permission

Log entries by program:

Program nameLines%LinesSize%Size
inn 210045 91.7%23.4 MB 92.6%
nnrpd 15404 6.7%1.5 MB 5.8%
innd 2120 0.9%240.1 KB 0.9%
innfeed 1493 0.7%165.5 KB 0.6%
overchan 5 0.0%0.6 KB 0.0%
controlchan 3 0.0%0.2 KB 0.0%
TOTAL: 6 229070 100.0%25.3 MB100.0%

History cache:

ReasonCount%Count
Do not exist 206644 99.2%
Negative hits 1025 0.5%
Positive hits 671 0.3%
Cache misses 15 0.0%
TOTAL: 4 208355 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.504 0.0%34 0.000 14.824 78.000
article cleanup00:00:01.224 0.0%208122 0.002 0.006 0.010
article logging00:00:05.123 0.0%208127 0.018 0.025 0.040
article parse00:00:05.558 0.0%483313 0.004 0.011 0.016
article write00:00:20.304 0.0%207730 0.053 0.098 0.330
artlog/artcncl00:00:00.002 0.0%34 0.000 0.059 0.200
data move00:00:00.740 0.0%622834 0.000 0.001 0.003
hisgrep/artcncl00:00:00.265 0.0%34 0.000 7.794 30.000
hishave/artcncl00:00:00.107 0.0%34 0.000 3.147 12.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:26:17.401 1.9%209733 3.802 7.521 15.335
history sync00:00:00.015 0.0%349 0.000 0.043 0.500
history write00:26:35.738 1.9%207903 4.735 7.675 12.712
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle22:42:52.685 95.9%585216 34.214 139.731 7604.165
nntp read00:00:10.413 0.0%439163 0.014 0.024 0.030
overview write00:00:00.673 0.0%207730 0.001 0.003 0.007
perl filter00:03:25.791 0.2%207903 0.554 0.990 1.275
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:07.392 0.0%439369 0.010 0.017 0.024
TOTAL: 23:40:42.64623:40:03.935100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.055 0.0%23888 0.000 0.002 0.016
article prepare00:00:00.000 0.0%248 0.000 0.000 0.000
article read00:00:00.013 0.0%62 0.000 0.210 2.200
backlog stats00:00:00.041 0.0%57811 0.000 0.001 0.067
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.454 0.0%37071 0.000 0.012 0.029
data write00:00:00.618 0.0%13392 0.000 0.046 0.107
idle23:36:02.247100.0%57811 277.505 1469.655 20998.467
status file00:00:00.260 0.0%439 0.000 0.592 2.000
TOTAL: 23:36:04.87023:36:03.688100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle05:07:59.008 99.8%10005 0.000 1846.977300509.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.322 0.0%21782 0.000 0.015 0.500
readart00:00:00.000 0.0%4 0.000 0.000 0.000
TOTAL: 05:08:30.07205:07:59.330 99.8%----

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 69 209357 209110 1 246 99%27:06:00
2news.icm.edu.pl 3 1334 474 695 165 35%21:57:48
3localhost 1 0 0 0 0 0%00:00:00
TOTAL: 3 73 210691 209584 696 411 99%49:03:48
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl1.3 GB1.4 MB1.6 MB1.3 GB 99%6.6 KB
2news.icm.edu.pl7.0 MB1016.9 KB2.0 MB10.0 MB 69%16.1 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 31.3 GB2.4 MB3.7 MB1.3 GB 99%6.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 5 04:15:02 - 04:59:59 8473 4.0% 3.1451.2 MB 0.0% 19.42
Feb 5 05:00:00 - 05:59:59 12548 6.0% 3.4973.1 MB 0.0% 20.80
Feb 5 06:00:00 - 06:59:59 13021 6.2% 3.6290.7 MB 0.0% 25.80
Feb 5 07:00:00 - 07:59:59 14625 7.0% 4.0690.5 MB 0.0% 25.74
Feb 5 08:00:00 - 08:59:59 13270 6.3% 3.6973.1 MB 0.0% 20.80
Feb 5 09:00:00 - 09:59:59 12197 5.8% 3.3966.0 MB 0.0% 18.76
Feb 5 10:00:00 - 10:59:59 11761 5.6% 3.2771.7 MB 0.0% 20.40
Feb 5 11:00:00 - 11:59:59 14462 6.9% 4.02116.3 MB 0.0% 33.07
Feb 5 12:00:00 - 12:59:59 12041 5.7% 3.3476.3 MB 88.8% 21.69
Feb 5 13:00:00 - 13:59:59 13052 6.2% 3.6385.9 MB 100.0% 24.43
Feb 5 14:00:00 - 14:59:59 13702 6.5% 3.8198.7 MB 114.9% 28.07
Feb 5 15:00:00 - 15:59:59 12712 6.1% 3.5380.7 MB 93.9% 22.95
Feb 5 16:00:00 - 16:59:59 14841 7.1% 4.1297.9 MB 114.0% 27.86
Feb 5 17:00:00 - 17:59:59 13190 6.3% 3.6674.3 MB 86.5% 21.13
Feb 5 18:00:00 - 18:59:59 11520 5.5% 3.2088.7 MB 103.2% 25.22
Feb 5 19:00:00 - 19:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Feb 5 20:00:00 - 20:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Feb 5 21:00:00 - 21:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Feb 5 22:00:00 - 22:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Feb 5 23:00:00 - 23:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Feb 6 00:00:00 - 00:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Feb 6 01:00:00 - 01:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Feb 6 02:00:00 - 02:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Feb 6 03:00:00 - 03:59:59 14504 6.9% 4.0396.3 MB 112.1% 27.39
Feb 6 04:00:00 - 04:15:02 3693 1.8% 4.0922.2 MB 25.8% 25.15
TOTAL: 24:00:00 209612 100.0% 2.4385.9 MB 100.0% 1.02
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 252 108 0 138 1 0 0 0 5
2news.icm.edu.pl 147 1 0 83 1 0 0 0 62
TOTAL: 2 399 109 0 221 2 0 0 0 67

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 18
it.tlc.cellulari.android 13
comp.mobile.android 13
comp.sys.raspberry-pi 12
fr.misc.actualite.covid19 9
rocksolid.nodes.help 6
eternal-september.support 6
comp.infosystems.gemini 6
eternal-september.newusers 4
eternal-september.talk 4
fr.comp.sys.raspberry-pi 4
eternal-september.config 3
eternal-september.grouprequests 3
nl.comp.os.linux.techniek 2
xs4all.general 2
grisbi.user.french 1
grisbi.bugsreports 1
it.comp.os.linux.ubuntu 1
aioe.test 1
TOTAL: 19 109

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

GroupsCount
pl.sci.historia 1
fr.comp.securite 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
Scoring filter (8) 31
Scoring filter (9) 11
EMP (md5) 9
Binary in non-binary group 8
Scoring filter (10) 2
Scoring filter (11) 1
TOTAL: 6 62

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 12949 51 10068 11 0 0 0%15:52:47
2okapi 0 0 0 0 0 648 0%23:34:24
3poznan 241 0 221 0 0 0 0%12:23:09
4nask 0 0 0 0 0 20849 0%23:34:24
5panorama 0 0 0 0 0 23997 0%23:34:24
TOTAL: 5 13190 51 10289 11 0 45494 0%98:59:08
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm239.3 KB138.0 KB377.3 KB0.0 KB/s6.1 KB15:52:47
2okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:34:24
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s012:23:09
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:34:24
5panorama0.0 KB0.0 KB0.0 KB0.0 KB/s023:34:24
TOTAL: 5239.3 KB138.0 KB377.3 KB0.0 KB/s6.1 KB98:59:08
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama2.4 MB
TOTAL: 12.4 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 286 42.7 KB 2 0 000:00:08
TOTAL: 1 286 42.7 KB 2 0 005:08:30

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1714 42.7 KB 2 0 000:00:21
2*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
3*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
4unresolved 104 00.0 KB 0 0 000:00:14
5*.icm.edu.pl 958 00.0 KB 0 0 000:00:23
6*.pionier.net.pl1002 00.0 KB 0 0 005:07:16
7*.internet-census.org 1 00.0 KB 0 0 000:00:10
TOTAL: 73781 42.7 KB 2 0 005:08:30

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
newsfeed.pionier.net.pl 4.150 5.181 0.00005:07:16
news.icm.edu.pl 3.887 4.996 0.00000:00:23
nms2.man.lodz.pl 5.432 7.797 0.00000:00:13
sh-phx-us-gp1-wk108a.internet-census.org 0.007 0.004 0.00000:00:10
162.243.147.7 0.006 0.004 0.00000:00:09
web.man.lodz.pl 0.998 1.592 0.00000:00:08
80.111.142.213 0.014 0.030 0.00000:00:02
astounding.monitoring.internet-measurement.com 0.006 0.006 0.00000:00:01
212.51.192.185 0.372 0.581 0.00000:00:01
71.6.134.233 0.003 0.010 0.00000:00:00
scanner-29.ch1.censys-scanner.com 0.002 0.005 0.00000:00:00
71.6.134.232 0.006 0.006 0.00000:00:00
162.243.144.11 0.000 0.011 0.00000:00:00
80.66.88.204 0.008 0.004 0.00000:00:00
TOTAL: 14 14.891 20.227 0.00005:08:30

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1428
newsfeed.pionier.net.pl 1002
news.icm.edu.pl 958
212.51.192.185 95
80.111.142.213 4
scanner-29.ch1.censys-scanner.com 1
71.6.134.233 1
astounding.monitoring.internet-measurement.com 1
80.66.88.204 1
162.243.144.11 1
71.6.134.232 1
162.243.147.7 1
sh-phx-us-gp1-wk108a.internet-census.org 1
TOTAL: 13 3495

NNRP unrecognized commands (by host):

SystemConn
162.243.144.11 1
80.66.88.204 1
scanner-29.ch1.censys-scanner.com 1
TOTAL: 3 3

NNRP unrecognized commands (by command):

CommandCount
MGLNDD_212.191.2.21_119 1
#003 1
EHLO www.censys.io 1
TOTAL: 3 3

NNRP client timeouts [Top 20]:

SystemConnPeer
80.66.88.204 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 4100.0%
TOTAL: 1 4100.0%

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

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