Daily Usenet report

Mar 2 04:15:01 -- Mar 3 04:15:02

Unknown entries from news log file:

First 50 / 149 lines (33.6%)

Mar 2 04:15:10 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:15:44 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:16:08 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:16:18 newsfeed overchan[2906]: message repeated 4 times: [ input line too long, skipping]
Mar 2 04:16:50 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:16:57 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:17:02 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:17:05 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:17:25 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:17:45 newsfeed overchan[2906]: message repeated 3 times: [ input line too long, skipping]
Mar 2 04:18:17 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:18:31 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:18:45 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:18:51 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:19:30 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:19:43 newsfeed overchan[2906]: message repeated 2 times: [ input line too long, skipping]
Mar 2 04:19:56 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:20:03 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:20:04 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:20:04 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:20:10 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:20:11 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:20:17 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:20:18 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:20:31 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:20:33 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:20:34 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:20:39 newsfeed overchan[2906]: message repeated 2 times: [ input line too long, skipping]
Mar 2 04:20:57 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:21:04 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:21:04 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:21:31 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:21:32 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:21:43 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:21:48 newsfeed overchan[2906]: message repeated 4 times: [ input line too long, skipping]
Mar 2 04:21:54 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:22:16 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:22:18 newsfeed overchan[2906]: message repeated 2 times: [ input line too long, skipping]
Mar 2 04:22:21 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:22:34 newsfeed overchan[2906]: message repeated 5 times: [ input line too long, skipping]
Mar 2 04:22:52 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:22:57 newsfeed overchan[2906]: message repeated 4 times: [ input line too long, skipping]
Mar 2 04:23:08 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:23:08 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:23:39 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:23:44 newsfeed overchan[2906]: message repeated 8 times: [ input line too long, skipping]
Mar 2 04:23:47 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:23:59 newsfeed overchan[2906]: message repeated 3 times: [ input line too long, skipping]
Mar 2 04:24:04 newsfeed overchan[2906]: input line too long, skipping
Mar 2 04:24:04 newsfeed overchan[2906]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 696282 94.2%75.8 MB 93.5%
innfeed 29025 3.9%3.4 MB 4.2%
innd 9599 1.3%1.5 MB 1.8%
nnrpd 4213 0.6%413.5 KB 0.5%
overchan 151 0.0%17.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 739271 100.0%81.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 692288 99.0%
Negative hits 6735 1.0%
Positive hits 338 0.0%
Cache misses 31 0.0%
TOTAL: 4 699392 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.621 0.0%71 0.000 22.831 99.333
article cleanup00:00:10.220 0.0%694709 0.010 0.015 0.021
article logging00:00:39.632 0.0%695143 0.041 0.057 0.505
article parse00:21:57.318 1.5%67855727 0.009 0.019 0.026
article write00:08:40.493 0.6%694471 0.420 0.749 2.269
artlog/artcncl00:00:00.005 0.0%70 0.000 0.071 0.500
data move00:00:59.416 0.1%72621081 0.001 0.001 0.001
hisgrep/artcncl00:00:00.526 0.0%68 0.000 7.735 75.667
hishave/artcncl00:00:00.121 0.0%71 0.000 1.704 7.800
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:47:34.761 3.3%701704 0.295 4.068 28.277
history sync00:00:00.023 0.0%291 0.000 0.079 0.500
history write01:02:37.017 4.3%694641 0.490 5.409 33.580
hiswrite/artcncl00:00:00.001 0.0%3 0.000 0.333 1.000
idle19:18:27.091 80.4%59430729 0.764 1.170 2.486
nntp read00:42:34.196 3.0%67423033 0.021 0.038 0.049
overview write00:00:04.097 0.0%694471 0.002 0.006 0.009
perl filter01:15:59.495 5.3%694641 4.024 6.564 8.611
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:39.919 0.0%1401903 0.021 0.028 0.036
TOTAL: 24:00:02.30623:40:25.952 98.6%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.104 0.0%39492 0.000 0.003 0.022
article prepare00:00:00.001 0.0%5980 0.000 0.000 0.021
article read00:00:38.599 0.0%1497 0.000 25.784 1891.600
backlog stats00:00:00.080 0.0%84489 0.000 0.001 0.006
callbacks00:00:00.000 0.0%2 0.000 0.000 0.000
data read00:00:00.887 0.0%43667 0.005 0.020 0.045
data write00:00:01.966 0.0%30851 0.021 0.064 0.122
idle23:49:47.041 99.6%84489 588.210 1015.363 2012.550
status file00:05:28.077 0.4%9744 0.733 33.670 1891.917
TOTAL: 23:56:01.43323:55:56.755100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:30:34.043 98.4%3086 0.000 594.311900029.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.304 0.0%6947 0.000 0.044 0.789
readart00:00:00.028 0.0%79 0.000 0.354 5.200
TOTAL: 00:31:03.78400:30:34.375 98.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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 246 695735 695522 0 213 99%140:21:53
2news.icm.edu.pl 41 328 67 235 26 20%16:48:19
3localhost 1441 0 0 0 0 0%00:00:01
TOTAL: 3 1728 696063 695589 235 239 99%157:10:13
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl293.0 GB1.6 MB2.0 MB293.0 GB 99%441.7 KB
2news.icm.edu.pl1.7 MB105.8 KB673.6 KB2.4 MB 68%26.6 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 3293.0 GB1.7 MB2.7 MB293.1 GB 99%441.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 2 04:15:01 - 04:59:59 17873 2.6% 6.628.6 GB 2.9%3330.55
Mar 2 05:00:00 - 05:59:59 22616 3.3% 6.2811.0 GB 3.7%3199.11
Mar 2 06:00:00 - 06:59:59 20853 3.0% 5.7911.5 GB 3.9%3336.50
Mar 2 07:00:00 - 07:59:59 21423 3.1% 5.9510.5 GB 3.6%3060.99
Mar 2 08:00:00 - 08:59:59 23246 3.3% 6.4611.3 GB 3.9%3288.72
Mar 2 09:00:00 - 09:59:59 22204 3.2% 6.1710.5 GB 3.6%3057.63
Mar 2 10:00:00 - 10:59:59 24832 3.6% 6.9010.6 GB 3.6%3090.76
Mar 2 11:00:00 - 11:59:59 27227 3.9% 7.5611.2 GB 3.8%3272.98
Mar 2 12:00:00 - 12:59:59 24177 3.5% 6.7210.4 GB 3.6%3043.59
Mar 2 13:00:00 - 13:59:59 25383 3.6% 7.0511.4 GB 3.9%3313.76
Mar 2 14:00:00 - 14:59:59 25952 3.7% 7.2112.1 GB 4.1%3535.26
Mar 2 15:00:00 - 15:59:59 27484 4.0% 7.6312.0 GB 4.1%3485.46
Mar 2 16:00:00 - 16:59:59 29346 4.2% 8.1512.7 GB 4.3%3709.19
Mar 2 17:00:00 - 17:59:59 33932 4.9% 9.4313.5 GB 4.6%3939.15
Mar 2 18:00:00 - 18:59:59 30043 4.3% 8.3513.4 GB 4.6%3906.35
Mar 2 19:00:00 - 19:59:59 30154 4.3% 8.3812.6 GB 4.3%3677.00
Mar 2 20:00:00 - 20:59:59 33915 4.9% 9.4212.8 GB 4.4%3742.73
Mar 2 21:00:00 - 21:59:59 37356 5.4% 10.3814.4 GB 4.9%4184.11
Mar 2 22:00:00 - 22:59:59 37888 5.4% 10.5212.8 GB 4.4%3713.77
Mar 2 23:00:00 - 23:59:59 38955 5.6% 10.8214.3 GB 4.9%4165.67
Mar 3 00:00:00 - 00:59:59 36205 5.2% 10.0614.3 GB 4.9%4174.90
Mar 3 01:00:00 - 01:59:59 31054 4.5% 8.6312.1 GB 4.1%3537.91
Mar 3 02:00:00 - 02:59:59 32552 4.7% 9.0412.4 GB 4.2%3605.04
Mar 3 03:00:00 - 03:59:59 31969 4.6% 8.8812.6 GB 4.3%3675.40
Mar 3 04:00:00 - 04:15:02 8900 1.3% 9.873.9 GB 1.3%4549.56
TOTAL: 24:00:01 695539 100.0% 8.05293.0 GB 100.0%3556.33
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 648 145 0 62 6 0 0 0 435
2news.icm.edu.pl 25 0 0 6 0 0 0 0 19
TOTAL: 2 673 145 0 68 6 0 0 0 454

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 85
it.tlc.cellulari.android 38
de.comm.provider.telefonie 13
it.comp.os.win.windows10 8
nl.comp.os.linux.techniek 1
TOTAL: 5 145

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

GroupsCount
pl.praca.oferowana 4
pl.sci.matematyka 2
TOTAL: 2 6

INND Perl filter [Top 20]:

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

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 27382 533 10808 142 4 28073 1%23:59:38
2icm 15104 481 12110 23 0 0 3%23:57:29
3nask 0 0 0 0 0 8640 0%23:55:06
4poznan 89 0 60 0 0 0 0%05:42:04
5okapi 0 0 0 0 0 952 0%23:55:06
TOTAL: 5 42575 1014 22978 165 4 37665 2%101:29:23
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama1.7 MB523.8 KB2.2 MB0.0 KB/s3.3 KB23:59:38
2icm1.6 MB118.6 KB1.7 MB0.0 KB/s3.5 KB23:57:29
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:55:06
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s005:42:04
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:55:06
TOTAL: 53.3 MB642.4 KB3.9 MB0.0 KB/s3.4 KB101:29:23
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 287 7465.2 KB 25 0 000:00:36
2212.90.61.180 1 45.4 KB 1 0 000:00:02
TOTAL: 2 288 7870.7 KB 26 0 000:31:03

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 575 7465.2 KB 25 0 000:00:41
2unresolved 104 45.4 KB 1 0 000:00:21
3*.dynamic.chello.pl 1 00.0 KB 0 0 000:30:00
4*.us-west-1.compute.amazonaws.com 1 00.0 KB 0 0 000:00:00
TOTAL: 4 681 7870.7 KB 26 0 000:31:03

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
89-64-149-5.dynamic.chello.pl 0.011 0.011 0.00000:30:00
web.man.lodz.pl 2.327 5.181 0.00000:00:36
80.111.142.213 0.029 0.048 0.00000:00:16
mon.man.lodz.pl 1.601 3.429 0.00000:00:05
212.90.61.180 0.016 0.012 0.00000:00:02
94.232.40.110 0.012 0.020 0.00000:00:01
212.51.192.185 0.459 1.160 0.00000:00:01
ec2-13-56-240-107.us-west-1.compute.amazonaws.com 0.008 0.004 0.00000:00:00
185.143.221.245 0.014 0.014 0.00000:00:00
TOTAL: 9 4.477 9.879 0.00000:31:03

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
94.232.40.110 2
89-64-149-5.dynamic.chello.pl 1
ec2-13-56-240-107.us-west-1.compute.amazonaws.com 1
185.143.221.245 1
TOTAL: 7 393

NNRP unrecognized commands (by host):

SystemConn
94.232.40.110 2
185.143.221.245 1
TOTAL: 2 3

NNRP unrecognized commands (by command):

CommandCount
#003 3
TOTAL: 1 3

NNRP client timeouts [Top 20]:

SystemConnPeer
89-64-149-5.dynamic.chello.pl 1 0
185.143.221.245 1 1
94.232.40.110 1 1
TOTAL: 3 3 2

Newsgroup request counts (by category):

CategoryCountPct
1pl 74 94.9%
2lodman 4 5.1%
TOTAL: 2 78100.0%

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

NewsgroupCount
1pl.comp.pecet 64
2pl.comp.os.ms-windows.winnt 10
3lodman.info 4
TOTAL: 3 78