Daily Usenet report

Jun 1 04:15:17 -- Jun 2 04:15:02

Unknown entries from news log file:

First 15 / 15 lines (100.0%)

Jun 1 04:50:04 newsfeed nnrpd[25377]: web.man.lodz.pl rejected Expiring process 20909
Jun 1 04:50:04 newsfeed nnrpd[25382]: web.man.lodz.pl rejected Expiring process 20909
Jun 1 04:50:04 newsfeed nnrpd[25387]: web.man.lodz.pl rejected Expiring process 20909
Jun 1 04:50:04 newsfeed nnrpd[25393]: web.man.lodz.pl rejected Expiring process 20909
Jun 1 04:50:04 newsfeed nnrpd[25394]: web.man.lodz.pl rejected Expiring process 20909
Jun 1 04:50:04 newsfeed nnrpd[25395]: web.man.lodz.pl rejected Expiring process 20909
Jun 1 04:50:04 newsfeed nnrpd[25396]: web.man.lodz.pl rejected Expiring process 20909
Jun 1 04:52:06 newsfeed nnrpd[25647]: mon.man.lodz.pl rejected Expiring process 20909
Jun 1 07:41:30 newsfeed overchan[20451]: input line too long, skipping
Jun 1 09:34:25 newsfeed nnrpd[4414]: SERVER perl filter not defined
Jun 1 15:18:36 newsfeed overchan[20451]: input line too long, skipping
Jun 1 15:33:03 newsfeed nnrpd[27404]: unable to get certificate from '/etc/news/cert.pem'
Jun 1 15:33:03 newsfeed nnrpd[27404]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Jun 1 15:59:15 newsfeed overchan[20451]: input line too long, skipping
Jun 2 00:15:07 newsfeed pgpverify[10198]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 458179 94.3%49.7 MB 93.7%
innfeed 15643 3.2%1.9 MB 3.5%
innd 7810 1.6%1.1 MB 2.1%
nnrpd 4265 0.9%414.8 KB 0.8%
controlchan 11 0.0%2.4 KB 0.0%
overchan 4 0.0%0.8 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 7 485913 100.0%53.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 455954 97.5%
Negative hits 11519 2.5%
Positive hits 244 0.1%
Cache misses 32 0.0%
TOTAL: 4 467749 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.713 0.0%52 0.000 32.942 242.000
article cleanup00:00:06.284 0.0%457123 0.005 0.014 0.026
article logging00:01:45.255 0.1%457576 0.021 0.230 1.529
article parse00:13:01.466 0.9%16035182 0.026 0.049 0.090
article write19:45:17.315 82.5%456804 76.078 155.685 4216.293
artlog/artcncl00:00:00.002 0.0%51 0.000 0.039 0.500
data move00:00:49.579 0.1%18191430 0.001 0.003 0.028
hisgrep/artcncl00:00:00.270 0.0%44 0.000 6.136 28.000
hishave/artcncl00:00:00.027 0.0%52 0.000 0.519 9.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:04:16.537 0.3%469131 0.006 0.547 4.060
history sync00:00:03.013 0.0%289 0.000 10.426 105.500
history write01:38:33.350 6.9%456925 4.616 12.942 1885.586
hiswrite/artcncl00:00:00.000 0.0%8 0.000 0.000 0.000
idle00:43:19.666 3.0%4286874 0.226 0.606 59.291
nntp read00:13:07.045 0.9%15601745 0.033 0.050 0.100
overview write00:00:03.415 0.0%456804 0.000 0.007 0.182
perl filter00:53:52.864 3.8%456925 3.440 7.075 9.351
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:25.681 0.0%926046 0.011 0.028 0.040
TOTAL: 23:56:44.61423:34:43.482 98.5%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.100 0.0%23023 0.000 0.004 0.035
article prepare00:00:00.001 0.0%812 0.000 0.001 0.083
article read00:00:02.581 0.0%202 0.000 12.777 121.000
backlog stats00:00:00.064 0.0%56098 0.000 0.001 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.785 0.0%30828 0.000 0.025 0.074
data write00:00:01.280 0.0%18771 0.017 0.068 0.184
idle23:50:06.579 99.4%56098 949.765 1529.584 3897.143
status file00:07:34.879 0.5%5311 0.000 85.648 1768.667
TOTAL: 23:58:54.05323:57:46.269 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:28.477 69.8%3034 0.000 9.386 10035.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.255 0.6%6677 0.000 0.038 0.500
readart00:00:00.000 0.0%4 0.000 0.000 0.000
TOTAL: 00:00:40.78100:00:28.732 70.5%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de001101
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 116 457252 456942 4 306 99%557:27:40
2news.icm.edu.pl 40 256 211 30 15 82%15:42:31
3localhost 1444 1 1 0 0 100%00:10:47
TOTAL: 3 1600 457509 457154 34 321 99%573:20:58
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl170.3 GB4.0 MB4.3 MB170.3 GB 99%390.5 KB
2news.icm.edu.pl5.5 MB162.4 KB289.1 KB5.9 MB 92%26.9 KB
3localhost1.3 KB0.0 KB0.0 KB1.3 KB100%1.3 KB
TOTAL: 3170.3 GB4.2 MB4.6 MB170.3 GB 99%390.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 1 04:15:17 - 04:59:59 1453 0.3% 0.54314.8 MB 0.2% 120.13
Jun 1 05:00:00 - 05:59:59 9671 2.1% 2.694.2 GB 2.5%1235.00
Jun 1 06:00:00 - 06:59:59 21593 4.7% 6.009.6 GB 5.7%2805.73
Jun 1 07:00:00 - 07:59:59 20045 4.4% 5.579.7 GB 5.7%2819.42
Jun 1 08:00:00 - 08:59:59 22187 4.9% 6.169.8 GB 5.8%2862.26
Jun 1 09:00:00 - 09:59:59 20040 4.4% 5.579.5 GB 5.6%2769.22
Jun 1 10:00:00 - 10:59:59 20176 4.4% 5.609.0 GB 5.3%2626.97
Jun 1 11:00:00 - 11:59:59 19599 4.3% 5.448.7 GB 5.1%2539.03
Jun 1 12:00:00 - 12:59:59 19446 4.3% 5.408.7 GB 5.1%2547.44
Jun 1 13:00:00 - 13:59:59 19751 4.3% 5.499.2 GB 5.4%2683.54
Jun 1 14:00:00 - 14:59:59 20049 4.4% 5.578.6 GB 5.0%2497.98
Jun 1 15:00:00 - 15:59:59 24941 5.5% 6.938.9 GB 5.2%2582.11
Jun 1 16:00:00 - 16:59:59 22120 4.8% 6.147.8 GB 4.6%2260.38
Jun 1 17:00:00 - 17:59:59 26333 5.8% 7.318.7 GB 5.1%2521.46
Jun 1 18:00:00 - 18:59:59 22556 4.9% 6.277.3 GB 4.3%2131.20
Jun 1 19:00:00 - 19:59:59 30681 6.7% 8.527.9 GB 4.6%2298.13
Jun 1 20:00:00 - 20:59:59 23163 5.1% 6.437.6 GB 4.4%2203.26
Jun 1 21:00:00 - 21:59:59 25867 5.7% 7.196.9 GB 4.1%2013.74
Jun 1 22:00:00 - 22:59:59 20463 4.5% 5.686.1 GB 3.6%1763.90
Jun 1 23:00:00 - 23:59:59 17838 3.9% 4.966.1 GB 3.6%1763.16
Jun 2 00:00:00 - 00:59:59 13511 3.0% 3.753.8 GB 2.2%1096.48
Jun 2 01:00:00 - 01:59:59 11376 2.5% 3.162.9 GB 1.7% 848.38
Jun 2 02:00:00 - 02:59:59 11096 2.4% 3.084.1 GB 2.4%1182.24
Jun 2 03:00:00 - 03:59:59 9680 2.1% 2.693.4 GB 2.0% 980.68
Jun 2 04:00:00 - 04:15:02 3718 0.8% 4.121.8 GB 1.0%2055.77
TOTAL: 23:59:45 457353 100.0% 5.29170.4 GB 100.0%2068.54
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 760 114 0 187 5 0 0 0 454
2news.icm.edu.pl 15 0 0 11 0 0 0 0 4
TOTAL: 2 775 114 0 198 5 0 0 0 458

Unwanted newsgroups [Top 20]:

NewsgroupCount
it.tlc.cellulari.android 26
alt.comp.software.firefox 24
uk.railway 21
it.comp.os.win.windows10 18
alt.comp.software.seamonkey 15
comp.mobile.android 7
it.comp.os.linux.ubuntu 2
de.rec.sf.startrek 1
TOTAL: 8 114

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

GroupsCount
pl.praca.oferowana 5
TOTAL: 1 5

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2
Binary in non-binary group 2
TOTAL: 2 4

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 10907 40 2749 33 0 20201 0%23:59:36
2icm 12170 13 11947 6 0 1 0%23:57:45
3nask 0 0 0 0 0 8308 0%23:57:26
4okapi 0 0 0 0 0 613 0%22:22:49
5poznan 42 0 41 0 0 0 0%04:41:19
TOTAL: 5 23119 53 14737 39 0 29123 0%98:58:55
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama120.9 KB196.5 KB317.4 KB0.0 KB/s4.3 KB23:59:36
2icm31.1 KB124.3 KB155.4 KB0.0 KB/s8.2 KB23:57:45
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:26
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s022:22:49
5poznan0.0 KB0.0 KB0.0 KB0.0 KB/s004:41:19
TOTAL: 5152.0 KB320.8 KB472.8 KB0.0 KB/s5.1 KB98:58:55
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 294 44.3 KB 2 0 000:00:20
2isvcs01.man.lodz.pl 1 00.0 KB 0 1 000:00:00
TOTAL: 2 295 44.3 KB 2 1 000:00:40

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 599 44.3 KB 2 1 000:00:24
2unresolved 101 00.0 KB 0 0 000:00:13
3*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
4*.security.ipip.net 1 00.0 KB 0 0 000:00:00
5*.internet-census.org 5 00.0 KB 0 0 000:00:01
TOTAL: 5 707 44.3 KB 2 1 000:00:40

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 2.146 6.367 0.00000:00:20
159.65.242.123 0.000 0.024 0.00000:00:10
mon.man.lodz.pl 1.551 5.455 0.00000:00:03
80.111.142.213 0.035 0.098 0.00000:00:02
212.51.192.185 0.572 1.840 0.00000:00:01
sh-phx-us-gp1-wk106.internet-census.org 0.051 0.084 0.00000:00:01
scanner-06.ch1.censys-scanner.com 0.006 0.012 0.00000:00:00
scan-141.security.ipip.net 0.000 0.012 0.00000:00:00
isvcs01.man.lodz.pl 0.009 0.031 0.00000:00:00
TOTAL: 9 4.370 13.923 0.00000:00:40

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 304
212.51.192.185 96
sh-phx-us-gp1-wk106.internet-census.org 5
80.111.142.213 4
scanner-06.ch1.censys-scanner.com 1
159.65.242.123 1
scan-141.security.ipip.net 1
TOTAL: 7 412

NNRP unrecognized commands (by host):

SystemConn
sh-phx-us-gp1-wk106.internet-census.org 10
scan-141.security.ipip.net 4
scanner-06.ch1.censys-scanner.com 1
TOTAL: 3 15

NNRP unrecognized commands (by command):

CommandCount
Host: 212.191.2.21:119 2
GET / HTTP/1.1 2
#026#003#001 2
#001 2
EHLO www.censys.io 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
Connection: close 1
Accept-Encoding: gzip 1
User-Agent: HTTP Banner Detection (https... 1
Accept: */* 1
SSH-2.0-Go 1
TOTAL: 11 15

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
Valid XHTML 1.1 Strict CSS is valid!
innreport 3.1.0 (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>