Daily Usenet report

May 30 04:15:02 -- May 31 04:15:02

Unknown entries from news log file:

First 16 / 16 lines (100.0%)

May 30 07:04:43 newsfeed overchan[6656]: input line too long, skipping
May 30 07:33:07 newsfeed overchan[6656]: input line too long, skipping
May 30 10:02:00 newsfeed overchan[6656]: input line too long, skipping
May 30 10:21:59 newsfeed overchan[6656]: input line too long, skipping
May 30 11:01:28 newsfeed overchan[6656]: input line too long, skipping
May 30 11:10:07 newsfeed overchan[6656]: input line too long, skipping
May 30 15:49:39 newsfeed overchan[6656]: input line too long, skipping
May 30 15:59:44 newsfeed overchan[6656]: input line too long, skipping
May 30 16:31:30 newsfeed overchan[6656]: input line too long, skipping
May 30 17:02:00 newsfeed overchan[6656]: input line too long, skipping
May 30 18:58:48 newsfeed nnrpd[28081]: SERVER perl filter not defined
May 30 19:20:26 newsfeed nnrpd[31140]: SERVER perl filter not defined
May 30 20:02:37 newsfeed overchan[6656]: input line too long, skipping
May 30 20:17:01 newsfeed overchan[6656]: input line too long, skipping
May 30 20:56:53 newsfeed overchan[6656]: input line too long, skipping
May 30 21:54:07 newsfeed overchan[6656]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 553819 92.6%60.4 MB 91.8%
innfeed 29376 4.9%3.4 MB 5.2%
innd 9767 1.6%1.4 MB 2.2%
nnrpd 4877 0.8%520.6 KB 0.8%
overchan 15 0.0%2.5 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 597855 100.0%65.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 550603 98.9%
Negative hits 5441 1.0%
Positive hits 505 0.1%
Cache misses 86 0.0%
TOTAL: 4 556635 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:06.317 0.0%187 0.000 33.781 385.000
article cleanup00:00:07.948 0.0%553437 0.010 0.014 0.020
article logging00:00:29.630 0.0%553874 0.040 0.053 0.067
article parse00:16:26.612 1.1%41124966 0.018 0.024 0.029
article write00:07:17.940 0.5%552935 0.577 0.792 1.365
artlog/artcncl00:00:00.013 0.0%186 0.000 0.070 1.000
data move00:00:54.676 0.1%45167193 0.001 0.001 0.016
hisgrep/artcncl00:00:01.336 0.0%183 0.000 7.301 31.000
hishave/artcncl00:00:00.622 0.0%187 0.000 3.326 22.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup02:09:57.997 9.0%559365 6.581 13.941 25.919
history sync00:00:00.025 0.0%290 0.000 0.086 1.000
history write02:32:38.356 10.6%553352 10.796 16.551 25.615
hiswrite/artcncl00:00:00.014 0.0%4 0.000 3.500 13.000
idle16:47:23.526 70.0%39863080 1.151 1.516 2.411
nntp read00:31:39.876 2.2%40820145 0.037 0.047 0.055
overview write00:00:03.062 0.0%552935 0.003 0.006 0.010
perl filter01:17:46.815 5.4%553352 6.854 8.434 10.276
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:33.980 0.0%1120483 0.024 0.030 0.037
TOTAL: 24:00:06.75223:45:28.745 99.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.126 0.0%41423 0.000 0.003 0.015
article prepare00:00:00.000 0.0%2050 0.000 0.000 0.000
article read00:00:25.200 0.0%512 0.000 49.219 975.500
backlog stats00:00:00.091 0.0%91923 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.996 0.0%47669 0.003 0.021 0.080
data write00:00:02.398 0.0%33185 0.030 0.072 0.114
idle23:54:52.096 99.9%91923 496.514 936.568 1923.846
status file00:00:09.763 0.0%9973 0.688 0.979 7.632
TOTAL: 23:55:37.93323:55:30.670100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:31:03.083 99.4%3053 0.000 610.247900094.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.245 0.0%6764 0.000 0.036 0.500
readart00:00:00.001 0.0%32 0.000 0.031 0.250
TOTAL: 00:31:13.54100:31:03.329 99.5%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 430 552957 552658 0 299 99%170:15:47
2news.icm.edu.pl 39 618 65 334 219 10%20:19:49
3localhost 1443 2 2 0 0 100%00:00:00
TOTAL: 3 1912 553577 552725 334 518 99%190:35:36
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl249.7 GB1.7 MB2.3 MB249.7 GB 99%473.5 KB
2news.icm.edu.pl1.8 MB453.9 KB5.7 MB7.9 MB 22%28.5 KB
3localhost2.7 KB0.0 KB0.0 KB2.7 KB100%1.3 KB
TOTAL: 3249.7 GB2.1 MB8.0 MB249.7 GB 99%473.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 30 04:15:02 - 04:59:59 15121 2.7% 5.607.3 GB 2.9%2840.56
May 30 05:00:00 - 05:59:59 18983 3.4% 5.279.6 GB 3.8%2804.46
May 30 06:00:00 - 06:59:59 19050 3.4% 5.299.6 GB 3.8%2786.37
May 30 07:00:00 - 07:59:59 20987 3.8% 5.839.9 GB 4.0%2892.86
May 30 08:00:00 - 08:59:59 21339 3.9% 5.939.2 GB 3.7%2685.87
May 30 09:00:00 - 09:59:59 22365 4.0% 6.219.8 GB 3.9%2860.83
May 30 10:00:00 - 10:59:59 20358 3.7% 5.668.9 GB 3.6%2592.90
May 30 11:00:00 - 11:59:59 22676 4.1% 6.3010.3 GB 4.1%3008.80
May 30 12:00:00 - 12:59:59 23919 4.3% 6.6410.1 GB 4.0%2939.58
May 30 13:00:00 - 13:59:59 23971 4.3% 6.6611.2 GB 4.5%3252.12
May 30 14:00:00 - 14:59:59 23790 4.3% 6.6111.1 GB 4.5%3244.88
May 30 15:00:00 - 15:59:59 23112 4.2% 6.4211.0 GB 4.4%3198.87
May 30 16:00:00 - 16:59:59 21871 4.0% 6.0810.1 GB 4.0%2953.08
May 30 17:00:00 - 17:59:59 22802 4.1% 6.3310.9 GB 4.4%3175.92
May 30 18:00:00 - 18:59:59 25074 4.5% 6.9612.2 GB 4.9%3547.48
May 30 19:00:00 - 19:59:59 22745 4.1% 6.3211.0 GB 4.4%3206.15
May 30 20:00:00 - 20:59:59 25733 4.7% 7.1511.5 GB 4.6%3338.06
May 30 21:00:00 - 21:59:59 26783 4.8% 7.4411.2 GB 4.5%3271.59
May 30 22:00:00 - 22:59:59 24671 4.5% 6.8510.7 GB 4.3%3116.22
May 30 23:00:00 - 23:59:59 23712 4.3% 6.599.9 GB 4.0%2894.51
May 31 00:00:00 - 00:59:59 24223 4.4% 6.7310.7 GB 4.3%3117.32
May 31 01:00:00 - 01:59:59 25530 4.6% 7.0910.9 GB 4.4%3182.21
May 31 02:00:00 - 02:59:59 26338 4.8% 7.3211.3 GB 4.5%3296.97
May 31 03:00:00 - 03:59:59 22955 4.2% 6.3810.0 GB 4.0%2901.72
May 31 04:00:00 - 04:15:02 4588 0.8% 5.091.8 GB 0.7%2072.18
TOTAL: 24:00:00 552696 100.0% 6.40250.3 GB 100.0%3038.20
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 736 235 0 63 1 0 0 0 437
2news.icm.edu.pl 201 0 0 22 0 0 0 0 179
TOTAL: 2 937 235 0 85 1 0 0 0 616

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 139
it.comp.os.win.windows10 39
it.tlc.cellulari.android 31
comp.mobile.android 19
comp.sys.raspberry-pi 4
it.comp.os.linux.ubuntu 2
it.discussioni.energia 1
TOTAL: 7 235

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

GroupsCount
pl.sci.matematyka 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 54
Scoring filter (8) 34
Scoring filter (9) 32
Scoring filter (10) 21
Scoring filter (11) 18
Scoring filter (12) 12
Scoring filter (13) 3
Too many newsgroups 2
Scoring filter (15) 1
Scoring filter (14) 1
Binary in non-binary group 1
TOTAL: 11 179

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 27954 163 11420 85 1 29841 0%23:59:20
2icm 17913 53 14319 2 0 0 0%23:55:50
3nask 0 0 0 0 0 10066 0%23:50:02
4okapi 0 0 0 0 0 914 0%23:50:02
5poznan 60 0 42 0 0 0 0%05:15:20
TOTAL: 5 45927 216 25781 87 1 40821 0%100:50:34
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama607.5 KB366.0 KB973.5 KB0.0 KB/s3.9 KB23:59:20
2icm282.1 KB3.2 KB285.3 KB0.0 KB/s5.2 KB23:55:50
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:02
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:02
5poznan0.0 KB0.0 KB0.0 KB0.0 KB/s005:15:20
TOTAL: 5889.5 KB369.3 KB1.2 MB0.0 KB/s4.2 KB100:50:34
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 3230.6 KB 16 0 000:00:19
2isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:00
TOTAL: 2 290 3230.6 KB 16 2 000:31:13

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 578 3230.6 KB 16 2 000:00:23
2*.dynamic.gprs.plus.pl 1 00.0 KB 0 0 000:00:32
3*.bstnma.fios.verizon.net 1 00.0 KB 0 0 000:30:00
4unresolved 101 00.0 KB 0 0 000:00:17
TOTAL: 4 681 3230.6 KB 16 2 000:31:13

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
pool-173-48-57-54.bstnma.fios.verizon.net 0.016 0.012 0.00000:30:00
apn-46-76-183-250.dynamic.gprs.plus.pl 0.036 0.012 0.00000:00:32
web.man.lodz.pl 1.468 2.808 0.00000:00:19
124.156.200.106 0.000 0.008 0.00000:00:14
mon.man.lodz.pl 1.344 2.588 0.00000:00:02
80.111.142.213 0.024 0.028 0.00000:00:02
212.51.192.185 0.320 0.924 0.00000:00:00
isvcs01.man.lodz.pl 0.032 0.020 0.00000:00:00
TOTAL: 8 3.240 6.400 0.00000:31:13

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
apn-46-76-183-250.dynamic.gprs.plus.pl 1
pool-173-48-57-54.bstnma.fios.verizon.net 1
124.156.200.106 1
TOTAL: 6 391

NNRP unrecognized commands (by host):

SystemConn
124.156.200.106 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.0 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
pool-173-48-57-54.bstnma.fios.verizon.net 1 0
TOTAL: 1 1 0

Newsgroup request counts (by category):

CategoryCountPct
1pl 32100.0%
TOTAL: 1 32100.0%

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

NewsgroupCount
1pl.comp.pecet 24
2pl.comp.os.ms-windows.winnt 8
TOTAL: 2 32