Daily Usenet report

Jan 12 04:15:02 -- Jan 13 04:15:02

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Jan 12 09:49:31 newsfeed nnrpd[26366]: SERVER perl filter not defined
Jan 12 15:55:33 newsfeed overchan[1294]: input line too long, skipping
Jan 12 16:24:30 newsfeed overchan[1294]: input line too long, skipping
Jan 12 17:10:24 newsfeed overchan[1294]: input line too long, skipping
Jan 12 17:24:06 newsfeed overchan[1294]: input line too long, skipping
Jan 12 17:25:52 newsfeed nnrpd[5412]: SERVER perl filter not defined
Jan 12 18:26:36 newsfeed overchan[1294]: input line too long, skipping
Jan 12 19:58:11 newsfeed overchan[1294]: input line too long, skipping
Jan 12 20:09:29 newsfeed overchan[1294]: input line too long, skipping
Jan 12 20:18:05 newsfeed overchan[1294]: input line too long, skipping
Jan 12 20:22:22 newsfeed overchan[1294]: input line too long, skipping
Jan 12 20:25:11 newsfeed overchan[1294]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 702797 92.4%77.0 MB 91.6%
innfeed 44502 5.8%5.2 MB 6.2%
innd 9453 1.2%1.4 MB 1.7%
nnrpd 4245 0.6%427.4 KB 0.5%
overchan 10 0.0%1.9 KB 0.0%
controlchan 2 0.0%0.1 KB 0.0%
TOTAL: 6 761009 100.0%84.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 693170 99.3%
Negative hits 4482 0.6%
Positive hits 213 0.0%
Cache misses 31 0.0%
TOTAL: 4 697896 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.191 0.0%68 0.000 32.221 281.000
article cleanup00:00:09.376 0.0%696505 0.009 0.013 0.018
article logging00:00:33.868 0.0%697048 0.038 0.049 0.063
article parse00:21:35.706 1.5%68637432 0.011 0.019 0.028
article write00:08:08.241 0.6%696210 0.504 0.701 1.279
artlog/artcncl00:00:00.004 0.0%67 0.000 0.060 1.000
data move00:00:52.843 0.1%73584074 0.000 0.001 0.001
hisgrep/artcncl00:00:00.343 0.0%68 0.000 5.044 56.000
hishave/artcncl00:00:00.063 0.0%68 0.000 0.926 6.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:25:13.571 1.8%701130 0.428 2.159 10.025
history sync00:00:00.016 0.0%288 0.000 0.056 1.000
history write00:39:44.431 2.8%696470 1.077 3.424 10.959
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle20:05:41.302 84.3%67848814 0.829 1.066 1.477
nntp read00:41:30.950 2.9%68275302 0.024 0.036 0.047
overview write00:00:03.924 0.0%696210 0.003 0.006 0.009
perl filter01:13:56.732 5.2%696470 4.762 6.370 7.807
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:37.838 0.0%1407984 0.020 0.027 0.034
TOTAL: 23:50:03.30023:38:11.399 99.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.143 0.0%52994 0.000 0.003 0.017
article prepare00:00:00.003 0.0%9352 0.000 0.000 0.018
article read00:00:18.073 0.0%2335 0.000 7.740 67.450
backlog stats00:00:00.112 0.0%127883 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.150 0.0%63162 0.004 0.018 0.037
data write00:00:03.073 0.0%48381 0.028 0.064 0.110
idle23:52:15.740 99.9%127883 476.933 671.987 1090.611
status file00:01:00.536 0.1%16695 0.783 3.626 143.443
TOTAL: 23:53:47.14023:53:38.830100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:03:12.679 93.3%3083 0.000 62.497 30995.800
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.216 0.1%6842 0.000 0.032 0.500
readart00:00:00.004 0.0%36 0.000 0.111 0.500
TOTAL: 00:03:26.51800:03:12.899 93.4%----

Control commands to INND:

CommandNumber
L 1
flush 27
flushlogs 2
go 2
logmode 2
mode 150
name 3
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 195

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 194 701917 701643 0 274 99%86:00:28
2news.icm.edu.pl 46 194 34 137 23 17%15:17:42
3localhost 1442 2 2 0 0 100%00:00:01
TOTAL: 3 1682 702113 701679 137 297 99%101:18:11
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl305.8 GB1.7 MB2.3 MB305.8 GB 99%456.8 KB
2news.icm.edu.pl1.6 MB51.4 KB351.2 KB1.9 MB 79%34.9 KB
3localhost2.8 KB0.0 KB0.0 KB2.8 KB100%1.4 KB
TOTAL: 3305.8 GB1.8 MB2.6 MB305.8 GB 99%456.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 12 04:15:02 - 04:59:59 17427 2.5% 6.468.9 GB 2.9%3446.66
Jan 12 05:00:00 - 05:59:59 24317 3.5% 6.7511.8 GB 3.9%3444.20
Jan 12 06:00:00 - 06:59:59 25851 3.7% 7.1812.5 GB 4.1%3649.30
Jan 12 07:00:00 - 07:59:59 26317 3.7% 7.3111.3 GB 3.7%3283.01
Jan 12 08:00:00 - 08:59:59 34820 5.0% 9.6711.9 GB 3.9%3478.97
Jan 12 09:00:00 - 09:59:59 35258 5.0% 9.7912.6 GB 4.1%3658.68
Jan 12 10:00:00 - 10:59:59 31947 4.6% 8.8711.7 GB 3.8%3407.29
Jan 12 11:00:00 - 11:59:59 28630 4.1% 7.9511.9 GB 3.9%3452.06
Jan 12 12:00:00 - 12:59:59 34472 4.9% 9.5813.9 GB 4.5%4039.86
Jan 12 13:00:00 - 13:59:59 27053 3.9% 7.5112.5 GB 4.1%3635.30
Jan 12 14:00:00 - 14:59:59 28547 4.1% 7.9313.8 GB 4.5%4022.34
Jan 12 15:00:00 - 15:59:59 27702 3.9% 7.7013.2 GB 4.3%3854.16
Jan 12 16:00:00 - 16:59:59 27242 3.9% 7.5713.9 GB 4.5%4044.41
Jan 12 17:00:00 - 17:59:59 24604 3.5% 6.8311.9 GB 3.9%3453.87
Jan 12 18:00:00 - 18:59:59 26262 3.7% 7.2912.5 GB 4.1%3647.77
Jan 12 19:00:00 - 19:59:59 26445 3.8% 7.3512.4 GB 4.1%3620.68
Jan 12 20:00:00 - 20:59:59 28924 4.1% 8.0313.0 GB 4.2%3772.99
Jan 12 21:00:00 - 21:59:59 30764 4.4% 8.5513.5 GB 4.4%3927.18
Jan 12 22:00:00 - 22:59:59 30878 4.4% 8.5814.4 GB 4.7%4193.52
Jan 12 23:00:00 - 23:59:59 27415 3.9% 7.6213.0 GB 4.2%3789.75
Jan 13 00:00:00 - 00:59:59 28949 4.1% 8.0413.9 GB 4.5%4050.25
Jan 13 01:00:00 - 01:59:59 30851 4.4% 8.5712.9 GB 4.2%3757.37
Jan 13 02:00:00 - 02:59:59 33937 4.8% 9.4312.5 GB 4.1%3643.04
Jan 13 03:00:00 - 03:59:59 34114 4.9% 9.4813.0 GB 4.3%3797.18
Jan 13 04:00:00 - 04:15:02 9157 1.3% 10.153.3 GB 1.1%3853.70
TOTAL: 24:00:00 701883 100.0% 8.12306.1 GB 100.0%3715.49
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 820 230 0 30 13 0 0 0 547
2news.icm.edu.pl 24 0 0 5 0 0 0 0 19
TOTAL: 2 844 230 0 35 13 0 0 0 566

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 83
comp.sys.raspberry-pi 50
it.tlc.cellulari.android 31
it.comp.os.win.windows10 29
comp.mobile.android 19
nl.comp.os.linux.techniek 7
de.rec.sf.startrek 7
de.comp.lang.php 4
TOTAL: 8 230

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

GroupsCount
pl.praca.oferowana 8
pl.sci.matematyka 5
TOTAL: 2 13

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 14
EMP (md5) 2
Scoring filter (8) 1
Scoring filter (10) 1
Too many newsgroups 1
TOTAL: 5 19

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 23441 565 14429 410 0 1 2%23:58:48
2panorama 42378 559 14061 171 2 38408 1%23:59:17
3poznan 30 0 24 0 0 0 0%03:01:52
4nask 0 0 0 0 0 9899 0%23:47:48
5okapi 0 0 0 0 0 971 0%23:40:01
TOTAL: 5 65849 1124 28514 581 2 49279 1%98:27:46
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm1.8 MB128.0 MB129.9 MB1.5 KB/s136.4 KB23:58:48
2panorama1.4 MB948.0 KB2.4 MB0.0 KB/s3.3 KB23:59:17
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s003:01:52
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:47:48
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:40:01
TOTAL: 53.3 MB129.0 MB132.2 MB0.4 KB/s79.4 KB98:27:46
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 3634.9 KB 15 0 000:00:23
2isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:00
TOTAL: 2 290 3634.9 KB 15 2 000:03:26

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 578 3634.9 KB 15 2 000:00:27
2*.dynamic.chello.pl 1 00.0 KB 0 0 000:00:03
3*.adsl.inetia.pl 1 00.0 KB 0 0 000:02:35
4unresolved 104 00.0 KB 0 0 000:00:16
5*.toya.net.pl 1 00.0 KB 0 0 000:00:01
6*.internet-census.org 6 00.0 KB 0 0 000:00:01
TOTAL: 6 691 3634.9 KB 15 2 000:03:26

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
159-205-32-188.adsl.inetia.pl 0.025 0.012 0.00000:02:35
web.man.lodz.pl 1.573 3.020 0.00000:00:23
192.241.214.99 0.003 0.013 0.00000:00:09
80.111.142.213 0.017 0.051 0.00000:00:04
mon.man.lodz.pl 1.554 2.561 0.00000:00:03
89-66-122-58.dynamic.chello.pl 0.006 0.009 0.00000:00:03
staticline18679.toya.net.pl 0.009 0.005 0.00000:00:01
212.51.192.185 0.496 0.821 0.00000:00:01
sh-chi-us-gp1-wk102.internet-census.org 0.017 0.050 0.00000:00:01
117.50.6.160 0.004 0.004 0.00000:00:00
isvcs01.man.lodz.pl 0.026 0.030 0.00000:00:00
87.251.75.34 0.000 0.010 0.00000:00:00
45.146.165.32 0.006 0.009 0.00000:00:00
TOTAL: 13 3.736 6.595 0.00000:03:26

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
sh-chi-us-gp1-wk102.internet-census.org 6
80.111.142.213 4
192.241.214.99 1
159-205-32-188.adsl.inetia.pl 1
45.146.165.32 1
87.251.75.34 1
89-66-122-58.dynamic.chello.pl 1
staticline18679.toya.net.pl 1
117.50.6.160 1
TOTAL: 11 401

NNRP unrecognized commands (by host):

SystemConn
sh-chi-us-gp1-wk102.internet-census.org 11
45.146.165.32 1
TOTAL: 2 12

NNRP unrecognized commands (by command):

CommandCount
#001 2
#026#003#001 2
#003 1
Host: 212.191.2.21:119 1
Accept-Encoding: gzip 1
SSH-2.0-Go 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
Accept: */* 1
€.#001 1
GET / HTTP/1.1 1
TOTAL: 10 12

NNRP client timeouts [Top 20]:

SystemConnPeer
45.146.165.32 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 36100.0%
TOTAL: 1 36100.0%

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

NewsgroupCount
1pl.comp.pecet 26
2pl.comp.os.ms-windows.winnt 10
TOTAL: 2 36