Daily Usenet report

Oct 13 04:15:02 -- Oct 14 04:15:02

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Oct 13 07:22:35 newsfeed overchan[25150]: input line too long, skipping
Oct 13 08:50:17 newsfeed nnrpd[2799]: SERVER perl filter not defined
Oct 13 08:50:35 newsfeed nnrpd[2801]: SERVER perl filter not defined
Oct 13 08:50:56 newsfeed nnrpd[2802]: SERVER perl filter not defined
Oct 13 13:56:37 newsfeed overchan[25150]: input line too long, skipping
Oct 13 14:14:15 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:149 checkpoint seconds 5 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 21299200 duplicate size 0 rejected size 0]
Oct 13 14:15:21 newsfeed nnrpd[13577]: SERVER perl filter not defined
Oct 13 14:37:31 newsfeed overchan[25150]: input line too long, skipping
Oct 13 14:56:18 newsfeed nnrpd[14889]: SERVER perl filter not defined
Oct 13 16:25:51 newsfeed overchan[25150]: input line too long, skipping
Oct 13 23:44:02 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:149 checkpoint seconds 5 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13107200 duplicate size 0 rejected size 0]
Oct 14 02:02:47 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:149 checkpoint seconds 4 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13107200 duplicate size 0 rejected size 0]

Log entries by program:

Program nameLines%LinesSize%Size
inn1475424 96.3%168.3 MB 95.9%
innfeed 42699 2.8%5.0 MB 2.8%
innd 9693 0.6%1.6 MB 0.9%
nnrpd 4963 0.3%536.9 KB 0.3%
overchan 5 0.0%1.1 KB 0.0%
controlchan 3 0.0%0.4 KB 0.0%
TOTAL: 61532787 100.0%175.4 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1467176 99.4%
Negative hits 9018 0.6%
Positive hits 281 0.0%
Cache misses 33 0.0%
TOTAL: 4 1476508 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.306 0.0%140 0.000 9.329 65.000
article cleanup00:00:15.612 0.0%1475403 0.005 0.011 0.016
article logging00:00:53.979 0.1%1475796 0.026 0.037 0.054
article parse00:13:26.316 0.9%37170576 0.012 0.022 0.029
article write00:06:33.205 0.5%1475215 0.124 0.267 0.576
artlog/artcncl00:00:00.000 0.0%139 0.000 0.000 0.000
data move00:00:37.654 0.0%44412252 0.001 0.001 0.002
hisgrep/artcncl00:00:00.251 0.0%134 0.000 1.873 16.000
hishave/artcncl00:00:00.003 0.0%140 0.000 0.021 0.333
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:08:22.780 0.6%1485094 0.045 0.339 1.037
history sync00:00:00.020 0.0%309 0.000 0.065 1.000
history write00:58:26.633 4.1%1475378 0.173 2.377 9.574
hiswrite/artcncl00:00:00.022 0.0%6 0.000 3.667 21.000
idle20:12:32.612 84.2%34127371 0.749 2.132 111.888
nntp read00:22:56.931 1.6%36182584 0.030 0.038 0.045
overview write00:00:06.503 0.0%1475215 0.001 0.004 0.010
perl filter01:43:24.045 7.2%1475378 2.491 4.205 7.161
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:01:07.327 0.1%2964355 0.015 0.023 0.031
TOTAL: 24:00:15.82123:48:45.199 99.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.084 0.0%49294 0.000 0.002 0.012
article prepare00:00:00.000 0.0%4612 0.000 0.000 0.000
article read00:00:04.257 0.0%1157 0.000 3.679 24.000
backlog stats00:00:00.075 0.0%122372 0.000 0.001 0.003
callbacks00:00:00.000 0.0%3 0.000 0.000 0.000
data read00:00:00.939 0.0%59632 0.003 0.016 0.038
data write00:00:02.404 0.0%45778 0.016 0.053 0.129
idle23:53:36.754100.0%122372 414.643 702.912 1293.321
status file00:00:15.502 0.0%17206 0.565 0.901 2.618
TOTAL: 23:54:05.30123:54:00.015100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:31:29.799 99.4%3095 0.000 610.597900022.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.210 0.0%6880 0.000 0.031 0.500
readart00:00:00.002 0.0%42 0.000 0.048 0.500
TOTAL: 00:31:41.02900:31:30.011 99.4%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
usenet@novabbs.com001001
TOTAL001001

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 344 14736831473542 0 141 99%122:06:26
2news.icm.edu.pl 44 236 22 161 53 9%16:22:22
3localhost 6 5 5 0 0 100%00:00:00
TOTAL: 3 394 14739241473569 161 194 99%138:28:48
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl273.5 GB1.3 MB1.6 MB273.5 GB 99%194.6 KB
2news.icm.edu.pl407.7 KB40.2 KB2.5 MB3.0 MB 13%40.4 KB
3localhost6.6 KB0.0 KB0.0 KB6.6 KB100%1.3 KB
TOTAL: 3273.5 GB1.3 MB4.1 MB273.5 GB 99%194.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 13 04:15:02 - 04:59:59 86012 5.8% 31.8814.7 GB 5.4%5701.79
Oct 13 05:00:00 - 05:59:59 39006 2.6% 10.8414.6 GB 5.3%4257.99
Oct 13 06:00:00 - 06:59:59 47415 3.2% 13.1713.8 GB 5.0%4007.72
Oct 13 07:00:00 - 07:59:59 38486 2.6% 10.6912.1 GB 4.4%3520.64
Oct 13 08:00:00 - 08:59:59 48387 3.3% 13.4421.8 GB 8.0%6351.83
Oct 13 09:00:00 - 09:59:59 67288 4.6% 18.6916.7 GB 6.1%4858.23
Oct 13 10:00:00 - 10:59:59 27185 1.8% 7.557.5 GB 2.8%2196.73
Oct 13 11:00:00 - 11:59:59 60562 4.1% 16.8215.1 GB 5.5%4385.17
Oct 13 12:00:00 - 12:59:59 64637 4.4% 17.9516.3 GB 6.0%4749.40
Oct 13 13:00:00 - 13:59:59 112443 7.6% 31.2314.8 GB 5.4%4301.91
Oct 13 14:00:00 - 14:59:59 82442 5.6% 22.907.7 GB 2.8%2233.62
Oct 13 15:00:00 - 15:59:59 57066 3.9% 15.8510.8 GB 4.0%3157.76
Oct 13 16:00:00 - 16:59:59 56983 3.9% 15.8311.4 GB 4.2%3334.42
Oct 13 17:00:00 - 17:59:59 118209 8.0% 32.8419.3 GB 7.1%5629.53
Oct 13 18:00:00 - 18:59:59 101520 6.9% 28.2025.1 GB 9.2%7322.31
Oct 13 19:00:00 - 19:59:59 99647 6.8% 27.6813.0 GB 4.7%3779.97
Oct 13 20:00:00 - 20:59:59 33803 2.3% 9.397.4 GB 2.7%2157.14
Oct 13 21:00:00 - 21:59:59 35864 2.4% 9.963.2 GB 1.2% 928.74
Oct 13 22:00:00 - 22:59:59 41139 2.8% 11.4312.7 GB 4.6%3693.19
Oct 13 23:00:00 - 23:59:59 149546 10.1% 41.549.2 GB 3.4%2689.29
Oct 14 00:00:00 - 00:59:59 7236 0.5% 2.01411.0 MB 0.1% 116.91
Oct 14 01:00:00 - 01:59:59 6559 0.4% 1.82541.8 MB 0.2% 154.12
Oct 14 02:00:00 - 02:59:59 34631 2.3% 9.622.0 GB 0.7% 596.09
Oct 14 03:00:00 - 03:59:59 56100 3.8% 15.583.4 GB 1.2% 992.62
Oct 14 04:00:00 - 04:15:02 2538 0.2% 2.81295.4 MB 0.1% 335.39
TOTAL: 24:00:00 1474704 100.0% 17.07273.9 GB 100.0%3323.86
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 534 115 0 23 3 0 0 0 393
2news.icm.edu.pl 47 0 0 2 0 0 0 0 45
TOTAL: 2 581 115 0 25 3 0 0 0 438

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 87
it.comp.os.win.windows10 17
it.tlc.cellulari.android 8
de.comp.lang.perl 2
comp.sys.raspberry-pi 1
TOTAL: 5 115

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

GroupsCount
pl.sci.matematyka 3
TOTAL: 1 3

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 29
Scoring filter (8) 14
Binary in non-binary group 2
TOTAL: 3 45

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 40562 373 11540 151 8 37384 0%23:59:58
2icm 22940 234 13596 13 0 1 1%23:59:58
3poznan 32 0 21 0 0 0 0%02:56:10
4okapi 0 0 0 0 0 866 0%23:57:51
5nask 0 0 0 0 0 9144 0%23:57:51
TOTAL: 5 63534 607 25157 164 8 47395 0%98:51:48
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama1.0 MB571.2 KB1.6 MB0.0 KB/s3.1 KB23:59:58
2icm724.1 KB36.4 KB760.5 KB0.0 KB/s3.1 KB23:59:58
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:56:10
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
TOTAL: 51.7 MB607.6 KB2.3 MB0.0 KB/s3.1 KB98:51:48
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 4250.2 KB 19 0 000:00:16
2isvcs01.man.lodz.pl 5 00.0 KB 0 5 000:00:00
3mob-5-90-120-148.net.vodafone.it 1 00.0 KB 0 0 100:00:01
TOTAL: 3 294 4250.2 KB 19 5 100:31:40

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 581 4250.2 KB 19 5 000:00:19
2unresolved 104 00.0 KB 0 0 000:30:46
3*.directtelecominc.com 1 00.0 KB 0 0 000:00:31
4*.208-100-26.static.steadfastdns.net 2 00.0 KB 0 0 000:00:01
5*.net.vodafone.it 1 00.0 KB 0 0 100:00:01
TOTAL: 5 689 4250.2 KB 19 5 100:31:40

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
218.75.40.149 0.004 0.008 0.00000:30:00
88.249.102.179 0.004 0.016 0.00000:00:32
mailing.directtelecominc.com 0.000 0.012 0.00000:00:31
web.man.lodz.pl 1.248 3.608 0.00000:00:16
201.103.120.187 0.004 0.020 0.00000:00:11
mon.man.lodz.pl 1.116 3.288 0.00000:00:02
80.111.142.213 0.008 0.064 0.00000:00:01
ip229.208-100-26.static.steadfastdns.net 0.004 0.020 0.00000:00:01
mob-5-90-120-148.net.vodafone.it 0.008 0.016 0.00000:00:01
212.51.192.185 0.420 1.016 0.00000:00:00
isvcs01.man.lodz.pl 0.024 0.048 0.00000:00:00
185.234.218.237 0.004 0.004 0.00000:00:00
TOTAL: 12 2.844 8.120 0.00000:31:40

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
ip229.208-100-26.static.steadfastdns.net 2
201.103.120.187 1
185.234.218.237 1
mailing.directtelecominc.com 1
88.249.102.179 1
218.75.40.149 1
TOTAL: 9 395

NNRP unrecognized commands (by host):

SystemConn
mailing.directtelecominc.com 10
88.249.102.179 10
185.234.218.237 4
mob-5-90-120-148.net.vodafone.it 1
218.75.40.149 1
TOTAL: 5 26

NNRP unrecognized commands (by command):

CommandCount
Accept: */* 3
Connection: close 2
User-Agent: ApiTool 2
Authorization: Basic YWRtaW46ezEyMjEzQkQ... 2
Content-Length: 586 2
Content-Type: text/xml 2
Accept-Language: en-us 2
Host: 212.191.2.21 2
Cache-Control: max-age=0 2
Accept-Encoding: identity 2
. 1
User-Agent: commonscan.org/1.0.0 1
GET / HTTP/1.0 1
Host: 218.189.104.54 1
GET / HTTP/1.1 1
TOTAL: 15 26

NNRP client timeouts [Top 20]:

SystemConnPeer
218.75.40.149 1 0
TOTAL: 1 1 0

Newsgroup request counts (by category):

CategoryCountPct
1pl 42100.0%
TOTAL: 1 42100.0%

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

NewsgroupCount
1pl.comp.pecet 24
2pl.comp.os.ms-windows.winnt 18
TOTAL: 2 42