Daily Usenet report

May 8 04:15:02 -- May 9 04:15:01

Unknown entries from news log file:

First 17 / 17 lines (100.0%)

May 8 11:10:23 newsfeed overchan[384194]: input line too long, skipping
May 8 12:04:18 newsfeed nnrpd[406106]: SERVER perl filter not defined
May 8 13:14:53 newsfeed overchan[384194]: input line too long, skipping
May 8 16:38:46 newsfeed overchan[384194]: input line too long, skipping
May 8 17:11:57 newsfeed overchan[384194]: input line too long, skipping
May 8 17:19:14 newsfeed nnrpd[421443]: SERVER perl filter not defined
May 8 17:19:32 newsfeed nnrpd[421446]: SERVER perl filter not defined
May 8 17:20:43 newsfeed nnrpd[421551]: SERVER perl filter not defined
May 8 17:22:33 newsfeed overchan[384194]: input line too long, skipping
May 8 18:18:19 newsfeed overchan[384194]: input line too long, skipping
May 8 19:01:21 newsfeed overchan[384194]: input line too long, skipping
May 8 21:03:22 newsfeed nnrpd[431243]: SERVER perl filter not defined
May 8 21:04:53 newsfeed nnrpd[431274]: SERVER perl filter not defined
May 8 21:16:38 newsfeed nnrpd[431964]: SERVER perl filter not defined
May 8 22:36:23 newsfeed pgpverify[435469]: pgpverify: /usr/bin/gpg1: no such file
May 8 22:38:08 newsfeed pgpverify[435494]: pgpverify: /usr/bin/gpg1: no such file
May 9 01:30:27 newsfeed nnrpd[443837]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn1352062 97.2%148.1 MB 96.8%
innfeed 22294 1.6%2.6 MB 1.7%
innd 8743 0.6%1.4 MB 0.9%
nnrpd 7700 0.6%853.4 KB 0.5%
controlchan 13 0.0%2.9 KB 0.0%
overchan 8 0.0%1.5 KB 0.0%
pgpverify 2 0.0%0.4 KB 0.0%
TOTAL: 71390822 100.0%153.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1348535 99.7%
Negative hits 3876 0.3%
Positive hits 212 0.0%
Cache misses 19 0.0%
TOTAL: 4 1352642 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.644 0.0%41 0.000 15.707 123.000
article cleanup00:00:04.624 0.0%1351184 0.002 0.003 0.007
article logging00:00:17.944 0.0%1351521 0.010 0.013 0.023
article parse00:05:25.634 0.4%151564737 0.002 0.002 0.003
article write00:04:16.069 0.3%1350959 0.124 0.190 0.487
artlog/artcncl00:00:00.000 0.0%41 0.000 0.000 0.000
data move00:00:26.039 0.0%157792823 0.000 0.000 0.000
hisgrep/artcncl00:00:00.175 0.0%41 0.000 4.268 27.000
hishave/artcncl00:00:00.002 0.0%41 0.000 0.049 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:15:42.896 1.1%1355781 0.073 0.695 10.122
history sync00:00:00.005 0.0%290 0.000 0.017 0.500
history write00:32:45.013 2.3%1351142 0.133 1.454 18.076
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle22:08:34.029 92.3%150314179 0.323 0.530 0.817
nntp read00:14:06.083 1.0%150916518 0.005 0.006 0.007
overview write00:00:02.528 0.0%1350959 0.001 0.002 0.004
perl filter00:26:56.409 1.9%1351142 0.859 1.196 2.080
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:21.324 0.0%2711698 0.006 0.008 0.011
TOTAL: 24:00:02.28423:48:59.418 99.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.029 0.0%27264 0.000 0.001 0.016
article prepare00:00:00.000 0.0%2670 0.000 0.000 0.000
article read00:00:13.812 0.0%686 0.000 20.134 116.333
backlog stats00:00:00.038 0.0%74370 0.000 0.001 0.017
callbacks00:00:00.000 0.0%21 0.000 0.000 0.000
data read00:00:00.201 0.0%35724 0.000 0.006 0.025
data write00:00:00.507 0.0%26076 0.000 0.019 0.053
idle23:57:25.798100.0%74370 698.750 1159.685 2850.730
status file00:00:07.982 0.0%7341 0.194 1.087 17.092
TOTAL: 23:57:49.98223:57:48.367100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:08:20.044 89.1%4250 0.000 117.657 62666.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.099 0.0%10240 0.000 0.010 0.500
readart00:00:00.001 0.0%12 0.000 0.083 0.500
TOTAL: 00:09:21.42000:08:20.144 89.1%----

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
control@usenet-fr.news.eu.org001201
TOTAL001201

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 291 13515921351382 0 210 99%110:52:28
2news.icm.edu.pl 44 232 70 147 15 30%15:04:05
3localhost 9 8 8 0 0 100%00:00:00
TOTAL: 3 344 13518321351460 147 225 99%125:56:33
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl299.1 GB2.3 MB2.8 MB299.1 GB 99%232.0 KB
2news.icm.edu.pl2.9 MB36.7 KB175.2 KB3.1 MB 93%37.5 KB
3localhost12.7 KB0.0 KB0.0 KB12.7 KB100%1.6 KB
TOTAL: 3299.1 GB2.3 MB2.9 MB299.1 GB 99%232.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 8 04:15:02 - 04:59:59 31378 2.3% 11.639.0 GB 3.0%3506.29
May 8 05:00:00 - 05:59:59 47303 3.5% 13.1412.3 GB 4.1%3576.21
May 8 06:00:00 - 06:59:59 56217 4.2% 15.6212.7 GB 4.2%3704.41
May 8 07:00:00 - 07:59:59 62645 4.6% 17.4013.1 GB 4.4%3822.48
May 8 08:00:00 - 08:59:59 59893 4.4% 16.6412.4 GB 4.1%3615.32
May 8 09:00:00 - 09:59:59 33610 2.5% 9.3411.4 GB 3.8%3323.69
May 8 10:00:00 - 10:59:59 75240 5.6% 20.9013.0 GB 4.3%3789.50
May 8 11:00:00 - 11:59:59 81272 6.0% 22.5812.9 GB 4.3%3746.26
May 8 12:00:00 - 12:59:59 79982 5.9% 22.2213.5 GB 4.5%3918.93
May 8 13:00:00 - 13:59:59 74474 5.5% 20.6912.3 GB 4.1%3570.68
May 8 14:00:00 - 14:59:59 70836 5.2% 19.6811.6 GB 3.9%3379.78
May 8 15:00:00 - 15:59:59 38258 2.8% 10.6311.2 GB 3.7%3253.94
May 8 16:00:00 - 16:59:59 24958 1.8% 6.9310.5 GB 3.5%3063.28
May 8 17:00:00 - 17:59:59 22799 1.7% 6.3311.0 GB 3.7%3214.86
May 8 18:00:00 - 18:59:59 24174 1.8% 6.7110.2 GB 3.4%2965.82
May 8 19:00:00 - 19:59:59 41307 3.1% 11.4710.7 GB 3.6%3106.63
May 8 20:00:00 - 20:59:59 36883 2.7% 10.2510.6 GB 3.6%3099.45
May 8 21:00:00 - 21:59:59 35704 2.6% 9.9210.0 GB 3.3%2914.97
May 8 22:00:00 - 22:59:59 54022 4.0% 15.0112.3 GB 4.1%3572.04
May 8 23:00:00 - 23:59:59 50378 3.7% 13.9912.2 GB 4.1%3565.60
May 9 00:00:00 - 00:59:59 76105 5.6% 21.1413.8 GB 4.6%4012.01
May 9 01:00:00 - 01:59:59 87281 6.5% 24.2417.3 GB 5.8%5026.20
May 9 02:00:00 - 02:59:59 86980 6.4% 24.1617.3 GB 5.8%5024.70
May 9 03:00:00 - 03:59:59 76746 5.7% 21.3214.4 GB 4.8%4185.77
May 9 04:00:00 - 04:15:01 23015 1.7% 25.544.1 GB 1.4%4828.72
TOTAL: 23:59:59 1351460 100.0% 15.64299.7 GB 100.0%3637.08
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 541 171 0 39 0 0 0 0 331
2news.icm.edu.pl 20 0 0 3 0 0 0 0 17
TOTAL: 2 561 171 0 42 0 0 0 0 348

Unwanted newsgroups [Top 20]:

NewsgroupCount
comp.mobile.android 82
uk.railway 71
it.tlc.cellulari.android 10
it.comp.os.win.windows10 2
de.comm.software.mailreader 2
alt.comp.software.firefox 2
it.comp.virtualizzazione 1
de.comp.lang.perl 1
TOTAL: 8 171

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 9
Binary in non-binary group 3
TOTAL: 2 12

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 331
news.icm.edu.pl 5
TOTAL: 2 336
TOTAL: 1 336

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 17764 163 5514 131 39 21459 0%23:59:57
2icm 15354 39 9292 4 0 1 0%23:59:57
3okapi 0 0 0 0 0 559 0%23:57:46
4poznan 62 0 57 0 0 0 0%03:51:54
5nask 0 0 0 0 0 6714 0%23:57:46
TOTAL: 5 33180 202 14863 135 39 28733 0%99:47:20
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama625.1 KB1.2 MB1.8 MB0.0 KB/s6.2 KB23:59:57
2icm139.4 KB727.7 KB867.0 KB0.0 KB/s20.2 KB23:59:57
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:46
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s003:51:54
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:46
TOTAL: 5764.4 KB1.9 MB2.6 MB0.0 KB/s7.9 KB99:47:20
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 1216.2 KB 5 0 000:00:09
2isvcs01.man.lodz.pl 8 00.0 KB 0 8 000:00:00
TOTAL: 2 296 1216.2 KB 5 8 000:09:22

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1734 1216.2 KB 5 8 000:00:47
2unresolved 106 00.0 KB 0 0 000:03:48
3*.internetdsl.tpnet.pl 2 00.0 KB 0 0 000:01:37
4*.httpx.pl 1 00.0 KB 0 0 000:03:08
TOTAL: 41843 1216.2 KB 5 8 000:09:22

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
78.31.90.129 0.007 0.005 0.00000:03:25
tor.httpx.pl 0.006 0.013 0.00000:03:08
aod145.internetdsl.tpnet.pl 0.010 0.002 0.00000:01:37
nms1.man.lodz.pl 1.668 5.804 0.00000:00:33
212.51.192.174 0.005 0.003 0.00000:00:20
web.man.lodz.pl 0.555 1.985 0.00000:00:09
nms2.man.lodz.pl 0.809 3.001 0.00000:00:04
80.111.142.213 0.015 0.017 0.00000:00:02
212.51.192.185 0.149 0.575 0.00000:00:00
198.20.101.106 0.000 0.023 0.00000:00:00
isvcs01.man.lodz.pl 0.022 0.062 0.00000:00:00
TOTAL: 11 3.246 11.490 0.00000:09:22

Curious NNRP server explorers [Top 20]:

SystemConn
nms1.man.lodz.pl 965
nms2.man.lodz.pl 473
212.51.192.185 96
80.111.142.213 4
198.20.101.106 3
78.31.90.129 2
aod145.internetdsl.tpnet.pl 2
212.51.192.174 1
tor.httpx.pl 1
TOTAL: 9 1547

NNRP unrecognized commands (by host):

SystemConn
198.20.101.106 7
TOTAL: 1 7

NNRP unrecognized commands (by command):

CommandCount
Accept: */* 1
#023#003#023#001#023#002#001 1
Accept-Encoding: gzip 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
GET / HTTP/1.1 1
Host: 212.191.2.21:119 1
#026#003#001 1
TOTAL: 7 7

Newsgroup request counts (by category):

CategoryCountPct
1pl 12100.0%
TOTAL: 1 12100.0%

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

NewsgroupCount
1pl.comp.pecet 12
TOTAL: 1 12