Daily Usenet report

Jan 31 04:15:02 -- Feb 1 04:15:53

Unknown entries from news log file:

First 17 / 17 lines (100.0%)

Jan 31 04:20:34 newsfeed overchan[603]: input line too long, skipping
Jan 31 10:07:08 newsfeed overchan[603]: input line too long, skipping
Jan 31 10:23:01 newsfeed nnrpd[25637]: unable to get certificate from '/etc/news/cert.pem'
Jan 31 10:23:01 newsfeed nnrpd[25637]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Jan 31 11:11:21 newsfeed overchan[603]: input line too long, skipping
Jan 31 11:56:37 newsfeed overchan[603]: input line too long, skipping
Jan 31 15:46:23 newsfeed overchan[603]: input line too long, skipping
Jan 31 17:22:48 newsfeed overchan[603]: input line too long, skipping
Jan 31 17:44:59 newsfeed overchan[603]: input line too long, skipping
Jan 31 19:36:48 newsfeed overchan[603]: input line too long, skipping
Jan 31 19:39:28 newsfeed overchan[603]: input line too long, skipping
Jan 31 21:41:01 newsfeed overchan[603]: input line too long, skipping
Jan 31 22:51:36 newsfeed overchan[603]: input line too long, skipping
Jan 31 23:01:22 newsfeed overchan[603]: input line too long, skipping
Feb 1 01:04:02 newsfeed pgpverify[32014]: pgpverify: verification failed
Feb 1 03:30:40 newsfeed overchan[603]: input line too long, skipping
Feb 1 03:58:15 newsfeed overchan[603]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 706887 91.8%77.2 MB 91.0%
innfeed 48678 6.3%5.7 MB 6.7%
innd 9810 1.3%1.5 MB 1.8%
nnrpd 4271 0.6%429.5 KB 0.5%
controlchan 22 0.0%5.2 KB 0.0%
overchan 15 0.0%2.5 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 7 769684 100.0%84.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 702914 99.2%
Negative hits 5706 0.8%
Positive hits 249 0.0%
Cache misses 22 0.0%
TOTAL: 4 708891 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.870 0.0%75 0.000 11.600 91.000
article cleanup00:00:09.465 0.0%706122 0.010 0.013 0.019
article logging00:00:34.618 0.0%706518 0.040 0.049 0.061
article parse00:21:31.846 1.5%49289025 0.018 0.026 0.030
article write00:09:02.152 0.6%705940 0.434 0.768 4.041
artlog/artcncl00:00:00.003 0.0%75 0.000 0.040 1.000
data move00:00:51.783 0.1%54118385 0.001 0.001 0.001
hisgrep/artcncl00:00:00.175 0.0%73 0.000 2.397 33.500
hishave/artcncl00:00:00.040 0.0%75 0.000 0.533 4.200
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:41:14.257 2.9%712410 0.360 3.473 26.289
history sync00:00:00.020 0.0%290 0.000 0.069 0.500
history write00:22:36.496 1.6%706075 0.463 1.921 27.492
hiswrite/artcncl00:00:00.001 0.0%2 0.000 0.500 1.000
idle20:14:02.054 84.3%41179123 1.350 1.769 4.217
nntp read00:38:53.847 2.7%48827650 0.035 0.048 0.055
overview write00:00:04.331 0.0%705940 0.004 0.006 0.010
perl filter01:18:00.099 5.4%706075 4.011 6.628 8.034
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:37.932 0.0%1424947 0.020 0.027 0.031
TOTAL: 24:00:04.70823:47:39.989 99.1%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.145 0.0%49099 0.000 0.003 0.012
article prepare00:00:00.002 0.0%3804 0.000 0.001 0.125
article read00:00:24.474 0.0%949 0.000 25.789 7361.000
backlog stats00:00:00.079 0.0%100095 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.974 0.0%50334 0.004 0.019 0.035
data write00:00:02.196 0.0%37454 0.016 0.059 0.102
idle23:45:46.556 99.3%100095 569.172 854.654 1370.236
status file00:09:08.872 0.6%16716 0.815 32.835 1898.828
TOTAL: 23:55:31.12023:55:23.298100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:24.335 66.7%3164 0.000 7.691 148.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.241 0.7%7230 0.000 0.033 0.667
readart00:00:00.004 0.0%156 0.000 0.026 0.500
TOTAL: 00:00:36.49900:00:24.580 67.3%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
news@sfere.anjou.terraraq.org.uk001001
us-control@lists.killfile.org000100
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 271 706710 706591 1 118 99%138:22:19
2news.icm.edu.pl 42 264 49 151 64 18%15:49:42
3localhost 1441 0 0 0 0 0%00:00:01
TOTAL: 3 1754 706974 706640 152 182 99%154:12:02
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl304.7 GB3.0 MB3.2 MB304.7 GB 99%452.1 KB
2news.icm.edu.pl3.7 MB56.1 KB2.2 MB5.9 MB 61%53.7 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 3304.7 GB3.1 MB5.5 MB304.7 GB 99%452.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 31 04:15:02 - 04:59:59 18566 2.6% 6.889.6 GB 3.2%3738.47
Jan 31 05:00:00 - 05:59:59 21720 3.1% 6.0310.6 GB 3.5%3098.70
Jan 31 06:00:00 - 06:59:59 24391 3.5% 6.7811.5 GB 3.8%3348.36
Jan 31 07:00:00 - 07:59:59 24819 3.5% 6.8912.8 GB 4.2%3730.21
Jan 31 08:00:00 - 08:59:59 27748 3.9% 7.7112.9 GB 4.2%3769.03
Jan 31 09:00:00 - 09:59:59 27278 3.9% 7.5812.3 GB 4.0%3570.85
Jan 31 10:00:00 - 10:59:59 26775 3.8% 7.4411.8 GB 3.9%3440.46
Jan 31 11:00:00 - 11:59:59 29218 4.1% 8.1213.1 GB 4.3%3809.95
Jan 31 12:00:00 - 12:59:59 30066 4.3% 8.3511.6 GB 3.8%3380.76
Jan 31 13:00:00 - 13:59:59 29670 4.2% 8.2413.3 GB 4.4%3865.75
Jan 31 14:00:00 - 14:59:59 31430 4.5% 8.7312.8 GB 4.2%3727.62
Jan 31 15:00:00 - 15:59:59 27508 3.9% 7.6411.7 GB 3.8%3395.30
Jan 31 16:00:00 - 16:59:59 31148 4.4% 8.6514.4 GB 4.7%4183.84
Jan 31 17:00:00 - 17:59:59 28729 4.1% 7.9813.0 GB 4.3%3800.08
Jan 31 18:00:00 - 18:59:59 32855 4.7% 9.1314.5 GB 4.8%4214.35
Jan 31 19:00:00 - 19:59:59 32469 4.6% 9.0214.2 GB 4.7%4127.36
Jan 31 20:00:00 - 20:59:59 35168 5.0% 9.7715.5 GB 5.1%4526.76
Jan 31 21:00:00 - 21:59:59 34927 4.9% 9.7014.6 GB 4.8%4254.92
Jan 31 22:00:00 - 22:59:59 33983 4.8% 9.4413.8 GB 4.5%4018.80
Jan 31 23:00:00 - 23:59:59 33113 4.7% 9.2013.6 GB 4.5%3953.57
Feb 1 00:00:00 - 00:59:59 31510 4.5% 8.7513.4 GB 4.4%3906.12
Feb 1 01:00:00 - 01:59:59 25563 3.6% 7.109.9 GB 3.3%2883.46
Feb 1 02:00:00 - 02:59:59 28151 4.0% 7.8210.8 GB 3.6%3151.80
Feb 1 03:00:00 - 03:59:59 32854 4.7% 9.1310.2 GB 3.4%2974.63
Feb 1 04:00:00 - 04:15:53 6575 0.9% 6.902.6 GB 0.9%2883.45
TOTAL: 24:00:51 706234 100.0% 8.17304.5 GB 100.0%3693.56
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 514 72 0 45 1 0 0 0 396
2news.icm.edu.pl 64 0 0 2 0 0 0 0 62
TOTAL: 2 578 72 0 47 1 0 0 0 458

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 44
comp.mobile.android 12
it.tlc.cellulari.android 9
comp.sys.raspberry-pi 4
nl.comp.os.linux.techniek 2
it.comp.os.win.windows10 1
TOTAL: 6 72

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

GroupsCount
pl.sci.matematyka 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 56
Scoring filter (9) 3
Binary in non-binary group 3
TOTAL: 3 62

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 38242 374 10118 113 2 38640 0%24:00:30
2icm 15648 67 12876 4 0 0 0%24:00:30
3okapi 0 0 0 0 0 1159 0%23:58:20
4nask 0 0 0 0 0 8708 0%23:58:20
5poznan 34 0 27 0 0 0 0%03:29:55
TOTAL: 5 53924 441 23021 117 2 48507 0%99:27:35
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama1.0 MB448.2 KB1.5 MB0.0 KB/s3.1 KB24:00:30
2icm190.9 KB10.5 KB201.5 KB0.0 KB/s2.8 KB24:00:30
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:20
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:20
5poznan0.0 KB0.0 KB0.0 KB0.0 KB/s003:29:55
TOTAL: 51.2 MB458.7 KB1.7 MB0.0 KB/s3.1 KB99:27:35
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 156157.8 KB 56 0 000:00:26
TOTAL: 1 288 156157.8 KB 56 0 000:00:36

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 576 156157.8 KB 56 0 000:00:30
2*.security.ipip.net 1 00.0 KB 0 0 000:00:00
3unresolved 100 00.0 KB 0 0 000:00:04
4*.ch1.censys-scanner.com 3 00.0 KB 0 0 000:00:01
TOTAL: 4 680 156157.8 KB 56 0 000:00:36

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.813 3.264 0.00000:00:26
mon.man.lodz.pl 1.662 3.263 0.00000:00:04
80.111.142.213 0.030 0.051 0.00000:00:03
212.51.192.185 0.519 0.972 0.00000:00:01
scanner-04.ch1.censys-scanner.com 0.008 0.032 0.00000:00:00
scan-141.security.ipip.net 0.009 0.007 0.00000:00:00
scanner-21.ch1.censys-scanner.com 0.006 0.011 0.00000:00:00
TOTAL: 7 4.047 7.600 0.00000:00:36

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
scanner-04.ch1.censys-scanner.com 2
scanner-21.ch1.censys-scanner.com 1
scan-141.security.ipip.net 1
TOTAL: 6 392

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 4
scanner-04.ch1.censys-scanner.com 1
TOTAL: 2 5

NNRP unrecognized commands (by command):

CommandCount
User-Agent: HTTP Banner Detection (https... 1
EHLO www.censys.io 1
Host: 212.191.2.21:119 1
Connection: close 1
GET / HTTP/1.1 1
TOTAL: 5 5

NNRP client timeouts [Top 20]:

SystemConnPeer
scanner-21.ch1.censys-scanner.com 1 1
TOTAL: 1 1 2

Newsgroup request counts (by category):

CategoryCountPct
1pl 156100.0%
TOTAL: 1 156100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 88
2pl.comp.pecet 68
TOTAL: 2 156