Daily Usenet report

Aug 21 04:15:02 -- Aug 22 04:15:01

Unknown entries from news log file:

First 50 / 74 lines (67.6%)

Aug 21 05:41:04 newsfeed innd: message repeated 3 times: [ newsfeed.pionier.net.pl:74 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Aug 21 05:41:04 newsfeed innd: message repeated 3 times: [ newsfeed.pionier.net.pl:74 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Aug 21 07:06:48 newsfeed innd: message repeated 3 times: [ newsfeed.pionier.net.pl:74 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 358400 duplicate size 0 rejected size 0]
Aug 21 07:06:48 newsfeed innd: message repeated 3 times: [ newsfeed.pionier.net.pl:74 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 358400 duplicate size 0 rejected size 0]
Aug 21 08:29:16 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:74 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 384000 duplicate size 0 rejected size 0]
Aug 21 08:29:16 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:74 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 384000 duplicate size 0 rejected size 0]
Aug 21 09:33:35 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:74 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 358400 duplicate size 0 rejected size 0]
Aug 21 09:33:35 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:74 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 358400 duplicate size 0 rejected size 0]
Aug 21 09:33:38 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:74 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 358400 duplicate size 0 rejected size 0]
Aug 21 09:33:38 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:74 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 358400 duplicate size 0 rejected size 0]
Aug 21 09:33:42 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:74 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 358400 duplicate size 0 rejected size 0]
Aug 21 09:33:42 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:74 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 358400 duplicate size 0 rejected size 0]
Aug 21 10:54:37 newsfeed innd: message repeated 4 times: [ newsfeed.pionier.net.pl:74 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 358400 duplicate size 0 rejected size 0]
Aug 21 10:54:37 newsfeed innd: message repeated 4 times: [ newsfeed.pionier.net.pl:74 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 358400 duplicate size 0 rejected size 0]
Aug 21 12:08:02 newsfeed nnrpd[527989]: SERVER perl filter not defined
Aug 21 12:08:02 newsfeed nnrpd[527989]: SERVER perl filter not defined
Aug 21 12:13:09 newsfeed nnrpd[528596]: SERVER perl filter not defined
Aug 21 12:13:09 newsfeed nnrpd[528596]: SERVER perl filter not defined
Aug 21 12:30:11 newsfeed nnrpd[530535]: SERVER perl filter not defined
Aug 21 12:30:11 newsfeed nnrpd[530535]: SERVER perl filter not defined
Aug 21 12:57:39 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:74 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 358400 duplicate size 0 rejected size 0]
Aug 21 12:57:39 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:74 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 358400 duplicate size 0 rejected size 0]
Aug 21 13:05:10 newsfeed pgpverify[534716]: pgpverify: verification failed
Aug 21 13:05:10 newsfeed pgpverify[534716]: pgpverify: verification failed
Aug 21 13:24:13 newsfeed innd: message repeated 3 times: [ newsfeed.pionier.net.pl:74 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 358400 duplicate size 0 rejected size 0]
Aug 21 13:24:13 newsfeed innd: message repeated 3 times: [ newsfeed.pionier.net.pl:74 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 358400 duplicate size 0 rejected size 0]
Aug 21 13:27:25 newsfeed nnrpd[537600]: SERVER perl filter not defined
Aug 21 13:27:25 newsfeed nnrpd[537600]: SERVER perl filter not defined
Aug 21 13:39:20 newsfeed innd: message repeated 3 times: [ newsfeed.pionier.net.pl:74 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 358400 duplicate size 0 rejected size 0]
Aug 21 13:39:20 newsfeed innd: message repeated 3 times: [ newsfeed.pionier.net.pl:74 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 358400 duplicate size 0 rejected size 0]
Aug 21 14:30:03 newsfeed nnrpd[544810]: SERVER perl filter not defined
Aug 21 14:30:03 newsfeed nnrpd[544810]: SERVER perl filter not defined
Aug 21 14:31:34 newsfeed nnrpd[545089]: SERVER perl filter not defined
Aug 21 14:31:34 newsfeed nnrpd[545089]: SERVER perl filter not defined
Aug 21 16:28:56 newsfeed nnrpd[559796]: SERVER perl filter not defined
Aug 21 16:28:56 newsfeed nnrpd[559796]: SERVER perl filter not defined
Aug 21 16:31:16 newsfeed nnrpd[560128]: SERVER perl filter not defined
Aug 21 16:31:16 newsfeed nnrpd[560128]: SERVER perl filter not defined
Aug 21 16:33:05 newsfeed nnrpd[560143]: SERVER perl filter not defined
Aug 21 16:33:05 newsfeed nnrpd[560143]: SERVER perl filter not defined
Aug 21 16:36:48 newsfeed nnrpd[560880]: SERVER perl filter not defined
Aug 21 16:36:48 newsfeed nnrpd[560880]: SERVER perl filter not defined
Aug 21 16:38:40 newsfeed nnrpd[560894]: SERVER perl filter not defined
Aug 21 16:38:40 newsfeed nnrpd[560894]: SERVER perl filter not defined
Aug 21 16:43:18 newsfeed nnrpd[561501]: SERVER perl filter not defined
Aug 21 16:43:18 newsfeed nnrpd[561501]: SERVER perl filter not defined
Aug 21 16:44:53 newsfeed nnrpd[561527]: SERVER perl filter not defined
Aug 21 16:44:53 newsfeed nnrpd[561527]: SERVER perl filter not defined
Aug 21 16:46:38 newsfeed nnrpd[561978]: SERVER perl filter not defined
Aug 21 16:46:38 newsfeed nnrpd[561978]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn 900907 95.3%95.9 MB 95.2%
innd 26896 2.8%3.1 MB 3.1%
nnrpd 16278 1.7%1.6 MB 1.5%
innfeed 1260 0.1%167.3 KB 0.2%
controlchan 24 0.0%5.3 KB 0.0%
pgpverify 2 0.0%0.1 KB 0.0%
overchan 2 0.0%0.2 KB 0.0%
TOTAL: 7 945369 100.0%100.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1796994 99.9%
Negative hits 1572 0.1%
Cache misses 196 0.0%
Positive hits 190 0.0%
TOTAL: 4 1798952 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.088 0.0%128 0.000 0.688 5.000
article cleanup00:00:03.666 0.0%1806272 0.001 0.002 0.004
article logging00:00:19.452 0.0%1806382 0.007 0.011 0.017
article parse00:00:27.210 0.0%5685264 0.003 0.005 0.007
article write00:00:45.524 0.0%1806072 0.016 0.025 0.051
artlog/artcncl00:00:00.000 0.0%26 0.000 0.000 0.000
data move00:00:18.784 0.0%7559846 0.000 0.002 0.004
hisgrep/artcncl00:00:00.058 0.0%154 0.000 0.377 1.000
hishave/artcncl00:00:00.000 0.0%26 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:55.296 0.0%1808008 0.000 0.031 0.215
history sync00:00:00.028 0.0%756 0.000 0.037 0.500
history write00:02:13.044 0.1%1806072 0.022 0.074 0.359
idle47:40:56.560 99.3%6466136 11.718 26.547 56.145
nntp read00:00:43.936 0.0%5069942 0.007 0.009 0.011
overview write00:00:01.858 0.0%1806072 0.000 0.001 0.003
perl filter00:12:40.454 0.4%1806072 0.273 0.421 0.623
python filter00:00:00.238 0.0%1806110 0.000 0.000 0.001
site send00:00:20.250 0.0%3625056 0.004 0.006 0.008
TOTAL: 48:01:41.33247:59:46.446 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.014 0.0%12880 0.000 0.001 0.038
article prepare00:00:00.000 0.0%2464 0.000 0.000 0.000
article read00:00:00.016 0.0%616 0.000 0.026 1.000
backlog stats00:00:00.024 0.0%80584 0.000 0.000 0.010
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.332 0.0%37582 0.000 0.009 0.073
data write00:00:00.790 0.0%24508 0.000 0.032 0.129
idle47:41:12.122100.0%80584 1130.647 2130.350 7092.694
status file00:00:00.186 0.0%324 0.000 0.574 4.000
TOTAL: 47:41:14.39247:41:13.484100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:02:59.820 83.6%9200 0.143 19.546 5264.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.190 0.1%30676 0.000 0.006 0.667
TOTAL: 00:03:35.20800:03:00.010 83.6%----

Control commands to INND:

CommandNumber
flush 54
flushlogs 4
go 4
logmode 4
lowmark 2
mode 296
name 4
pause 4
paused 4
reload 4
reserve 4
TOTAL: 11 384

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
nl-admin@nic.surfnet.nl002202
TOTAL002202

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 160 17840261783830 4 192 99%72:04:20
2localhost 40 38 38 0 0 100%00:00:00
3news.icm.edu.pl 68 172 8 156 8 4%16:39:22
TOTAL: 3 268 17842361783876 160 200 99%88:43:42
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl14.1 GB681.5 KB0.0 KB14.1 GB 99%8.3 KB
2news.icm.edu.pl234.4 KB177.8 KB0.0 KB412.2 KB 56%25.8 KB
3localhost66.2 KB0.0 KB0.0 KB66.2 KB100%1.7 KB
TOTAL: 314.1 GB859.3 KB0.0 KB14.1 GB 99%8.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 21 04:15:02 - 04:59:59 31453 3.5% 11.66240.4 MB 3.3% 91.22
Aug 21 05:00:00 - 05:59:59 43201 4.8% 12.00283.6 MB 3.9% 80.67
Aug 21 06:00:00 - 06:59:59 44505 4.9% 12.36350.5 MB 4.9% 99.71
Aug 21 07:00:00 - 07:59:59 36701 4.1% 10.19305.5 MB 4.2% 86.90
Aug 21 08:00:00 - 08:59:59 64852 7.2% 18.01382.1 MB 5.3% 108.70
Aug 21 09:00:00 - 09:59:59 70331 7.8% 19.54432.9 MB 6.0% 123.15
Aug 21 10:00:00 - 10:59:59 57688 6.4% 16.02404.2 MB 5.6% 114.97
Aug 21 11:00:00 - 11:59:59 38526 4.3% 10.70312.2 MB 4.3% 88.81
Aug 21 12:00:00 - 12:59:59 43584 4.8% 12.11358.4 MB 5.0% 101.96
Aug 21 13:00:00 - 13:59:59 43023 4.8% 11.95331.5 MB 4.6% 94.28
Aug 21 14:00:00 - 14:59:59 38295 4.3% 10.64335.2 MB 4.6% 95.35
Aug 21 15:00:00 - 15:59:59 53739 6.0% 14.93413.7 MB 5.7% 117.66
Aug 21 16:00:00 - 16:59:59 44746 5.0% 12.43363.2 MB 5.0% 103.30
Aug 21 17:00:00 - 17:59:59 44790 5.0% 12.44313.6 MB 4.3% 89.19
Aug 21 18:00:00 - 18:59:59 37062 4.1% 10.29295.1 MB 4.1% 83.94
Aug 21 19:00:00 - 19:59:59 28680 3.2% 7.97269.9 MB 3.7% 76.77
Aug 21 20:00:00 - 20:59:59 24620 2.7% 6.84216.6 MB 3.0% 61.61
Aug 21 21:00:00 - 21:59:59 19668 2.2% 5.46232.8 MB 3.2% 66.22
Aug 21 22:00:00 - 22:59:59 20420 2.3% 5.67238.7 MB 3.3% 67.91
Aug 21 23:00:00 - 23:59:59 20281 2.3% 5.63225.0 MB 3.1% 64.01
Aug 22 00:00:00 - 00:59:59 19525 2.2% 5.42195.2 MB 2.7% 55.52
Aug 22 01:00:00 - 01:59:59 29145 3.2% 8.10208.6 MB 2.9% 59.34
Aug 22 02:00:00 - 02:59:59 19222 2.1% 5.34198.0 MB 2.7% 56.33
Aug 22 03:00:00 - 03:59:59 23135 2.6% 6.43262.3 MB 3.6% 74.61
Aug 22 04:00:00 - 04:15:01 3547 0.4% 3.9440.7 MB 0.6% 46.26
TOTAL: 23:59:59 900739 100.0% 10.437.0 GB 100.0% 85.45
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 151 0 0 96 0 0 0 0 55
2news.icm.edu.pl 4 0 0 4 0 0 0 0 0
TOTAL: 2 155 0 0 100 0 0 0 0 55

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 24672 520 12286 98 0 0 2%47:59:54
2poznan 14 0 8 0 0 0 0%01:34:54
TOTAL: 2 24686 520 12294 98 0 0 2%49:34:48
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm1.2 MB1.6 MB2.9 MB0.0 KB/s4.7 KB47:59:54
2poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:34:54
TOTAL: 21.2 MB1.6 MB2.9 MB0.0 KB/s4.7 KB49:34:48
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
131-14-254-91.infrawat.ch 2 00.0 KB 0 0 000:00:00
2isvcs01.man.lodz.pl 38 00.0 KB 0 38 000:00:01
3hoffman.probe.onyphe.net 2 00.0 KB 0 0 000:00:05
4zl-laxc-us-gp1-wk126c.internet-census.org 2 00.0 KB 0 0 000:00:21
5nms2.man.lodz.pl2880 00.0 KB 0 0 000:00:27
680.111.142.213 8 00.0 KB 0 0 000:00:05
7ada.probe.onyphe.net 2 00.0 KB 0 0 000:00:00
8193-32-209-232.infrawat.ch 2 00.0 KB 0 0 000:00:00
9o007.scanner.modat.io 2 00.0 KB 0 0 000:00:00
1046.195.132.66.censys-scanner.com 2 00.0 KB 0 0 000:00:02
11zl-laxd-us-cpp-wk111.internet-census.org 2 00.0 KB 0 0 000:00:05
1247.251.253.192 8 00.0 KB 0 0 000:00:24
13150.255.36.147 2 00.0 KB 0 0 000:00:00
14198.235.24.109 2 00.0 KB 0 0 000:00:00
15sh-chi-us-cpp-wk106.internet-census.org 4 00.0 KB 0 0 000:00:08
16sh-ams-nl-cpp-wk104.internet-census.org 4 00.0 KB 0 0 000:00:08
1766.61.98.95 32 00.0 KB 0 0 000:00:29
18zl-laxd-us-cpp-wk110.internet-census.org 2 00.0 KB 0 0 000:00:04
19172.16.2.4 576 00.0 KB 0 0 000:00:38
2062.146.94.167.censys-scanner.com 6 00.0 KB 0 0 000:00:04
21r5-93-5d.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:03
22zl-laxk-us-gp1-wk132a.internet-census.org 2 00.0 KB 0 0 000:00:21
TOTAL: 223582 00.0 KB 0 38 000:03:35

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 628 00.0 KB 0 0 000:01:38
2*.internet-census.org 16 00.0 KB 0 0 000:01:09
3*.infrawat.ch 4 00.0 KB 0 0 000:00:00
4*.scanner.modat.io 2 00.0 KB 0 0 000:00:00
5*.probe.onyphe.net 4 00.0 KB 0 0 000:00:06
6*.146.94.167.censys-scanner.com 6 00.0 KB 0 0 000:00:04
7*.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:03
8*.195.132.66.censys-scanner.com 2 00.0 KB 0 0 000:00:02
9*.man.lodz.pl2918 00.0 KB 0 38 000:00:29
TOTAL: 93582 00.0 KB 0 38 000:03:35

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
172.16.2.4 1.650 3.900 0.00000:00:38
66.61.98.95 0.078 0.226 0.00000:00:29
nms2.man.lodz.pl 8.028 19.568 0.00000:00:27
47.251.253.192 0.014 0.058 0.00000:00:24
zl-laxk-us-gp1-wk132a.internet-census.org 0.006 0.014 0.00000:00:21
zl-laxc-us-gp1-wk126c.internet-census.org 0.010 0.010 0.00000:00:21
sh-chi-us-cpp-wk106.internet-census.org 0.012 0.028 0.00000:00:08
sh-ams-nl-cpp-wk104.internet-census.org 0.006 0.032 0.00000:00:08
hoffman.probe.onyphe.net 0.004 0.016 0.00000:00:05
zl-laxd-us-cpp-wk111.internet-census.org 0.006 0.012 0.00000:00:05
80.111.142.213 0.020 0.062 0.00000:00:05
zl-laxd-us-cpp-wk110.internet-census.org 0.004 0.012 0.00000:00:04
62.146.94.167.censys-scanner.com 0.066 0.036 0.00000:00:04
r5-93-5d.monitoring.internet-measurement.com 0.002 0.018 0.00000:00:03
46.195.132.66.censys-scanner.com 0.052 0.018 0.00000:00:02
isvcs01.man.lodz.pl 0.136 0.280 0.00000:00:01
150.255.36.147 0.006 0.012 0.00000:00:00
ada.probe.onyphe.net 0.000 0.022 0.00000:00:00
198.235.24.109 0.006 0.012 0.00000:00:00
31-14-254-91.infrawat.ch 0.000 0.016 0.00000:00:00
TOTAL: 22 10.116 24.384 0.00000:03:35

NNRP unrecognized commands (by host) [Top 20]:

SystemConn
47.251.253.192 14
ada.probe.onyphe.net 4
46.195.132.66.censys-scanner.com 2
62.146.94.167.censys-scanner.com 2
TOTAL: 4 22

NNRP unrecognized commands (by command) [Top 20]:

CommandCount
EHLO www.censys.io 4
#026#003#003#002a#001 2
À$À­À¯À,ÀrÀsÌ©#023#002#023#001Ì#024À#007À#022À#023À'À/À#024À(À0À`Àa... 2
À#024 2
#026#003#001 2
User-Agent: curl/7.64.1 2
Host: 212.191.2.21:119 2
Accept: */* 2
#023#001#023#002#023#003#001 2
GET / HTTP/1.1 2
TOTAL: 10 22

NNRP client timeouts [Top 20]:

SystemConnPeer
47.251.253.192 6 8
62.146.94.167.censys-scanner.com 2 4
31-14-254-91.infrawat.ch 2 2
TOTAL: 3 10 18