Daily Usenet report

Apr 7 04:15:02 -- Apr 8 04:15:02

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Apr 7 05:56:06 newsfeed overchan[448992]: input line too long, skipping
Apr 7 14:40:40 newsfeed nnrpd[477402]: SERVER perl filter not defined
Apr 7 14:45:02 newsfeed overchan[448992]: input line too long, skipping
Apr 7 15:06:48 newsfeed overchan[448992]: input line too long, skipping
Apr 7 15:13:03 newsfeed overchan[448992]: input line too long, skipping
Apr 7 16:56:26 newsfeed nnrpd[483420]: SERVER perl filter not defined
Apr 7 17:16:31 newsfeed overchan[448992]: input line too long, skipping
Apr 7 18:43:57 newsfeed pgpverify[488689]: pgpverify: /usr/bin/gpg1: no such file
Apr 7 20:06:20 newsfeed overchan[448992]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn1098473 96.6%120.4 MB 96.1%
innfeed 23035 2.0%2.7 MB 2.2%
innd 8138 0.7%1.3 MB 1.0%
nnrpd 7665 0.7%858.7 KB 0.7%
controlchan 21 0.0%5.2 KB 0.0%
overchan 7 0.0%0.9 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 71137340 100.0%125.3 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1096609 99.7%
Negative hits 3119 0.3%
Positive hits 259 0.0%
Cache misses 26 0.0%
TOTAL: 4 1100013 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.723 0.0%40 0.000 18.075 103.000
article cleanup00:00:04.144 0.0%1098157 0.002 0.004 0.006
article logging00:00:15.367 0.0%1098468 0.010 0.014 0.024
article parse00:06:08.404 0.4%169253677 0.002 0.002 0.003
article write00:04:36.146 0.3%1097929 0.105 0.252 0.624
artlog/artcncl00:00:00.001 0.0%39 0.000 0.026 0.111
data move00:00:28.683 0.0%176718536 0.000 0.000 0.000
hisgrep/artcncl00:00:00.141 0.0%40 0.000 3.525 14.000
hishave/artcncl00:00:00.026 0.0%40 0.000 0.650 2.667
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:14:12.162 1.0%1101869 0.085 0.773 14.611
history sync00:00:00.005 0.0%290 0.000 0.017 0.500
history write00:19:13.835 1.3%1098091 0.119 1.051 14.298
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle22:14:42.275 92.7%168211903 0.296 0.476 0.639
nntp read00:16:13.438 1.1%168617154 0.004 0.006 0.007
overview write00:00:02.093 0.0%1097929 0.001 0.002 0.004
perl filter00:31:29.183 2.2%1098091 1.228 1.720 2.247
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:18.170 0.0%2204502 0.006 0.008 0.011
TOTAL: 24:00:03.42823:47:44.796 99.1%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.028 0.0%28975 0.000 0.001 0.011
article prepare00:00:00.000 0.0%3008 0.000 0.000 0.000
article read00:00:11.481 0.0%779 0.000 14.738 98.500
backlog stats00:00:00.036 0.0%72927 0.000 0.000 0.004
callbacks00:00:00.000 0.0%26 0.000 0.000 0.000
data read00:00:00.224 0.0%34682 0.000 0.006 0.055
data write00:00:00.507 0.0%26181 0.000 0.019 0.050
idle23:56:28.308100.0%72927 570.695 1181.844 2620.258
status file00:00:06.204 0.0%7516 0.161 0.825 19.567
TOTAL: 23:56:48.56523:56:46.788100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:11.911 43.2%4193 0.000 2.841 1826.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.122 0.4%10203 0.000 0.012 0.500
readart00:00:00.000 0.0%24 0.000 0.000 0.000
TOTAL: 00:00:27.57600:00:12.033 43.6%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
bofh-control@killfile.org001001
us-control@lists.killfile.org000100
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 455 10978631097673 0 190 99%121:23:40
2news.icm.edu.pl 40 283 65 179 39 22%17:41:53
3localhost 3 2 2 0 0 100%00:00:00
TOTAL: 3 498 10981481097740 179 229 99%139:05:33
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl345.8 GB4.1 MB4.5 MB345.8 GB 99%330.3 KB
2news.icm.edu.pl3.9 MB10.4 KB573.4 KB4.5 MB 87%44.2 KB
3localhost2.6 KB0.0 KB0.0 KB2.6 KB100%1.3 KB
TOTAL: 3345.8 GB4.1 MB5.0 MB345.8 GB 99%330.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 7 04:15:02 - 04:59:59 31145 2.8% 11.5412.3 GB 3.6%4798.97
Apr 7 05:00:00 - 05:59:59 37989 3.5% 10.5517.4 GB 5.0%5069.05
Apr 7 06:00:00 - 06:59:59 36383 3.3% 10.1116.0 GB 4.6%4668.77
Apr 7 07:00:00 - 07:59:59 35451 3.2% 9.8516.9 GB 4.9%4914.36
Apr 7 08:00:00 - 08:59:59 38594 3.5% 10.7217.5 GB 5.0%5085.43
Apr 7 09:00:00 - 09:59:59 41394 3.8% 11.5016.4 GB 4.7%4779.86
Apr 7 10:00:00 - 10:59:59 105554 9.6% 29.3218.9 GB 5.5%5508.12
Apr 7 11:00:00 - 11:59:59 105554 9.6% 29.3217.2 GB 5.0%5006.31
Apr 7 12:00:00 - 12:59:59 50050 4.6% 13.9013.2 GB 3.8%3833.15
Apr 7 13:00:00 - 13:59:59 29762 2.7% 8.2711.7 GB 3.4%3393.98
Apr 7 14:00:00 - 14:59:59 35163 3.2% 9.7712.9 GB 3.7%3746.85
Apr 7 15:00:00 - 15:59:59 29424 2.7% 8.1712.2 GB 3.5%3552.05
Apr 7 16:00:00 - 16:59:59 30975 2.8% 8.6012.0 GB 3.5%3481.45
Apr 7 17:00:00 - 17:59:59 47400 4.3% 13.1712.9 GB 3.7%3743.46
Apr 7 18:00:00 - 18:59:59 33221 3.0% 9.2312.8 GB 3.7%3717.63
Apr 7 19:00:00 - 19:59:59 27429 2.5% 7.6211.9 GB 3.4%3469.66
Apr 7 20:00:00 - 20:59:59 28266 2.6% 7.8512.1 GB 3.5%3526.02
Apr 7 21:00:00 - 21:59:59 31669 2.9% 8.8011.8 GB 3.4%3438.53
Apr 7 22:00:00 - 22:59:59 56704 5.2% 15.7513.1 GB 3.8%3805.98
Apr 7 23:00:00 - 23:59:59 86041 7.8% 23.9015.2 GB 4.4%4429.34
Apr 8 00:00:00 - 00:59:59 35969 3.3% 9.9912.0 GB 3.5%3487.06
Apr 8 01:00:00 - 01:59:59 47601 4.3% 13.2214.4 GB 4.2%4193.30
Apr 8 02:00:00 - 02:59:59 42751 3.9% 11.8815.5 GB 4.5%4518.68
Apr 8 03:00:00 - 03:59:59 43496 4.0% 12.0816.0 GB 4.6%4674.52
Apr 8 04:00:00 - 04:15:02 9909 0.9% 10.994.0 GB 1.2%4697.66
TOTAL: 24:00:00 1097894 100.0% 12.71346.1 GB 100.0%4200.71
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 499 116 0 66 8 0 0 0 309
2news.icm.edu.pl 41 0 0 1 0 0 0 0 40
TOTAL: 2 540 116 0 67 8 0 0 0 349

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 76
it.tlc.cellulari.android 18
comp.mobile.android 11
de.comm.provider.telefonie 5
de.comp.office-pakete.ms-office.outlook 3
alt.comp.software.seamonkey 2
de.rec.sf.startrek 1
TOTAL: 7 116

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

GroupsCount
pl.praca.oferowana 8
TOTAL: 1 8

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 25
Binary in non-binary group 12
Scoring filter (11) 1
TOTAL: 3 38

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 309
news.icm.edu.pl 2
TOTAL: 2 311
TOTAL: 1 311

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 20542 182 7910 186 54 20711 0%23:59:57
2icm 14037 70 8411 2 0 0 0%23:59:55
3poznan 67 1 47 0 0 0 1%05:03:20
4okapi 0 0 0 0 0 571 0%23:57:48
5nask 0 0 0 0 0 6263 0%23:57:48
TOTAL: 5 34646 253 16368 188 54 27545 0%100:58:48
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama542.8 KB1.4 MB1.9 MB0.0 KB/s5.3 KB23:59:57
2icm217.7 KB5.5 KB223.2 KB0.0 KB/s3.1 KB23:59:55
3poznan9.6 KB0.0 KB9.6 KB0.0 KB/s9.6 KB05:03:20
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
TOTAL: 5770.1 KB1.4 MB2.1 MB0.0 KB/s4.9 KB100:58:48
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 290 2421.5 KB 11 0 000:00:09
2isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:00
TOTAL: 2 292 2421.5 KB 11 2 000:00:28

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1731 2421.5 KB 11 2 000:00:21
2*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
3*.ch1.censys-scanner.com 2 00.0 KB 0 0 000:00:00
4unresolved 102 00.0 KB 0 0 000:00:03
5*.45.111.203.116.clients.your-server.de 2 00.0 KB 0 0 000:00:00
TOTAL: 51838 2421.5 KB 11 2 000:00:28

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
nms1.man.lodz.pl 1.966 16.484 0.00000:00:10
web.man.lodz.pl 0.517 4.421 0.00000:00:09
nms2.man.lodz.pl 0.487 4.180 0.00000:00:02
80.111.142.213 0.004 0.074 0.00000:00:02
proud.monitoring.internet-measurement.com 0.004 0.012 0.00000:00:01
212.51.192.185 0.136 1.390 0.00000:00:00
scanner-05.ch1.censys-scanner.com 0.000 0.031 0.00000:00:00
static.45.111.203.116.clients.your-server.de 0.021 0.028 0.00000:00:00
198.199.96.214 0.000 0.015 0.00000:00:00
isvcs01.man.lodz.pl 0.007 0.028 0.00000:00:00
185.73.124.50 0.005 0.010 0.00000:00:00
TOTAL: 11 3.147 26.673 0.00000:00:28

Curious NNRP server explorers [Top 20]:

SystemConn
nms1.man.lodz.pl 1141
nms2.man.lodz.pl 298
212.51.192.185 96
80.111.142.213 4
scanner-05.ch1.censys-scanner.com 2
static.45.111.203.116.clients.your-server.de 2
proud.monitoring.internet-measurement.com 1
198.199.96.214 1
185.73.124.50 1
TOTAL: 9 1546

NNRP unrecognized commands (by host):

SystemConn
scanner-05.ch1.censys-scanner.com 1
185.73.124.50 1
198.199.96.214 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
185.73.124.50 1 1
TOTAL: 1 1 2

Newsgroup request counts (by category):

CategoryCountPct
1pl 24100.0%
TOTAL: 1 24100.0%

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

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