Daily Usenet report

Oct 10 04:15:02 -- Oct 11 04:15:03

Unknown entries from news log file:

First 15 / 15 lines (100.0%)

Oct 10 05:03:24 newsfeed overchan[21072]: input line too long, skipping
Oct 10 05:10:56 newsfeed overchan[21072]: input line too long, skipping
Oct 10 06:26:09 newsfeed overchan[21072]: input line too long, skipping
Oct 10 06:39:11 newsfeed overchan[21072]: input line too long, skipping
Oct 10 08:02:04 newsfeed overchan[21072]: input line too long, skipping
Oct 10 14:16:35 newsfeed overchan[21072]: input line too long, skipping
Oct 10 15:25:23 newsfeed overchan[21072]: input line too long, skipping
Oct 10 17:05:16 newsfeed overchan[21072]: input line too long, skipping
Oct 10 17:56:40 newsfeed overchan[21072]: input line too long, skipping
Oct 10 20:31:23 newsfeed overchan[21072]: input line too long, skipping
Oct 10 20:50:09 newsfeed overchan[21072]: input line too long, skipping
Oct 10 23:03:56 newsfeed overchan[21072]: input line too long, skipping
Oct 11 01:35:14 newsfeed overchan[21072]: input line too long, skipping
Oct 11 01:47:00 newsfeed overchan[21072]: input line too long, skipping
Oct 11 02:15:14 newsfeed overchan[21072]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 725449 92.3%79.6 MB 91.5%
innfeed 47449 6.0%5.6 MB 6.4%
innd 8918 1.1%1.4 MB 1.6%
nnrpd 4204 0.5%422.9 KB 0.5%
overchan 16 0.0%2.7 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 786037 100.0%87.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 720270 99.8%
Negative hits 1463 0.2%
Positive hits 186 0.0%
Cache misses 17 0.0%
TOTAL: 4 721936 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.603 0.0%37 0.000 16.297 57.000
article cleanup00:00:10.946 0.0%723852 0.011 0.015 0.022
article logging00:00:37.807 0.0%724305 0.042 0.052 0.071
article parse00:19:46.615 1.4%38068119 0.021 0.031 0.040
article write00:08:17.939 0.6%723670 0.239 0.688 1.030
artlog/artcncl00:00:00.002 0.0%37 0.000 0.054 1.000
data move00:00:39.065 0.0%42891746 0.001 0.001 0.001
hisgrep/artcncl00:00:00.136 0.0%36 0.000 3.778 16.000
hishave/artcncl00:00:00.008 0.0%37 0.000 0.216 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:24:28.837 1.7%725576 0.134 2.024 17.670
history sync00:00:00.018 0.0%290 0.000 0.062 1.000
history write00:33:16.471 2.3%723823 0.297 2.758 19.938
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle20:30:19.066 85.4%37506579 0.762 1.968 3.389
nntp read00:30:46.258 2.1%37704326 0.035 0.049 0.058
overview write00:00:04.278 0.0%723670 0.003 0.006 0.011
perl filter01:16:19.774 5.3%723823 3.831 6.327 8.754
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:43.470 0.1%1459802 0.023 0.030 0.041
TOTAL: 24:00:05.96023:45:31.293 99.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.117 0.0%49197 0.000 0.002 0.012
article prepare00:00:00.000 0.0%2944 0.000 0.000 0.000
article read00:00:08.078 0.0%733 0.000 11.020 279.000
backlog stats00:00:00.094 0.0%110032 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.133 0.0%53365 0.004 0.021 0.081
data write00:00:02.776 0.0%41040 0.034 0.068 0.103
idle23:53:23.237 99.9%110032 468.998 781.620 1261.183
status file00:00:52.069 0.1%16998 0.783 3.063 90.212
TOTAL: 23:54:33.94623:54:27.504100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:22.800 63.7%3053 0.000 7.468 486.833
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.274 0.8%6789 0.000 0.040 0.737
readart00:00:00.001 0.0%50 0.000 0.020 0.500
TOTAL: 00:00:35.82000:00:23.075 64.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 27 725080 724952 0 128 99%52:31:04
2news.icm.edu.pl 54 220 25 141 54 11%15:16:38
3localhost 1441 0 0 0 0 0%00:00:01
TOTAL: 3 1522 725300 724977 141 182 99%67:47:43
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl273.8 GB1.5 MB1.8 MB273.9 GB 99%396.0 KB
2news.icm.edu.pl1.3 MB31.0 KB3.5 MB4.8 MB 27%62.5 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 3273.8 GB1.5 MB5.2 MB273.9 GB 99%396.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 10 04:15:02 - 04:59:59 15968 2.2% 5.929.3 GB 3.4%3596.88
Oct 10 05:00:00 - 05:59:59 22129 3.1% 6.1510.6 GB 3.9%3085.49
Oct 10 06:00:00 - 06:59:59 20763 2.9% 5.7710.7 GB 3.9%3108.91
Oct 10 07:00:00 - 07:59:59 21866 3.0% 6.0710.9 GB 4.0%3183.25
Oct 10 08:00:00 - 08:59:59 22180 3.1% 6.1610.8 GB 3.9%3141.12
Oct 10 09:00:00 - 09:59:59 20135 2.8% 5.599.8 GB 3.6%2868.50
Oct 10 10:00:00 - 10:59:59 22741 3.1% 6.3210.8 GB 4.0%3160.04
Oct 10 11:00:00 - 11:59:59 23597 3.3% 6.5511.0 GB 4.0%3201.59
Oct 10 12:00:00 - 12:59:59 25314 3.5% 7.0312.1 GB 4.4%3530.82
Oct 10 13:00:00 - 13:59:59 23828 3.3% 6.6210.8 GB 3.9%3134.12
Oct 10 14:00:00 - 14:59:59 25071 3.5% 6.9611.2 GB 4.1%3257.02
Oct 10 15:00:00 - 15:59:59 24959 3.4% 6.9311.6 GB 4.2%3379.37
Oct 10 16:00:00 - 16:59:59 23613 3.3% 6.5610.9 GB 4.0%3173.43
Oct 10 17:00:00 - 17:59:59 23267 3.2% 6.4610.8 GB 3.9%3156.77
Oct 10 18:00:00 - 18:59:59 135889 18.7% 37.7515.4 GB 5.6%4494.48
Oct 10 19:00:00 - 19:59:59 68255 9.4% 18.9612.4 GB 4.5%3611.82
Oct 10 20:00:00 - 20:59:59 21086 2.9% 5.8610.2 GB 3.7%2977.93
Oct 10 21:00:00 - 21:59:59 24332 3.4% 6.7611.7 GB 4.3%3408.48
Oct 10 22:00:00 - 22:59:59 27182 3.8% 7.5512.5 GB 4.6%3648.73
Oct 10 23:00:00 - 23:59:59 28438 3.9% 7.9012.1 GB 4.4%3535.16
Oct 11 00:00:00 - 00:59:59 26586 3.7% 7.3812.5 GB 4.6%3640.59
Oct 11 01:00:00 - 01:59:59 25057 3.5% 6.9612.3 GB 4.5%3574.23
Oct 11 02:00:00 - 02:59:59 23442 3.2% 6.5110.1 GB 3.7%2953.25
Oct 11 03:00:00 - 03:59:59 22859 3.2% 6.3510.8 GB 4.0%3159.91
Oct 11 04:00:00 - 04:15:03 6219 0.9% 6.893.1 GB 1.1%3572.68
TOTAL: 24:00:01 724776 100.0% 8.39274.6 GB 100.0%3332.33
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 582 93 0 27 7 0 0 0 455
2news.icm.edu.pl 54 0 0 2 0 0 0 0 52
TOTAL: 2 636 93 0 29 7 0 0 0 507

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 38
it.tlc.cellulari.android 34
it.comp.os.win.windows10 10
nl.comp.sys.android 4
comp.mobile.android 4
de.comp.lang.vbclassic 3
TOTAL: 6 93

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

GroupsCount
pl.praca.oferowana 7
TOTAL: 1 7

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 49
Binary in non-binary group 3
Scoring filter (8) 1
TOTAL: 3 53

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 18769 195 11986 6 0 0 1%24:09:53
2panorama 39546 158 11174 70 0 37992 0%24:00:14
3poznan 21 0 13 1 0 0 0%02:01:22
4okapi 0 0 0 0 0 685 0%24:05:34
5nask 0 0 0 0 0 8605 0%24:05:32
TOTAL: 5 58336 353 23173 77 0 47282 0%98:22:35
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm556.9 KB23.4 KB580.4 KB0.0 KB/s2.9 KB24:09:53
2panorama376.9 KB419.5 KB796.4 KB0.0 KB/s3.5 KB24:00:14
3poznan0.0 KB43.3 KB43.3 KB0.0 KB/s43.3 KB02:01:22
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:34
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:32
TOTAL: 5933.9 KB486.2 KB1.4 MB0.0 KB/s3.3 KB98:22:35
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 5048.2 KB 25 0 000:00:21
TOTAL: 1 288 5048.2 KB 25 0 000:00:35

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 576 5048.2 KB 25 0 000:00:24
2unresolved 101 00.0 KB 0 0 000:00:10
3*.ip-158-69-123.net 1 00.0 KB 0 0 000:00:00
TOTAL: 3 678 5048.2 KB 25 0 000:00:35

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.765 4.209 0.00000:00:21
80.111.142.213 0.017 0.059 0.00000:00:08
mon.man.lodz.pl 1.540 3.437 0.00000:00:03
212.51.192.185 0.454 1.163 0.00000:00:01
ns525040.ip-158-69-123.net 0.000 0.020 0.00000:00:00
165.227.6.47 0.005 0.014 0.00000:00:00
? 0.008 0.012 0.00000:00:00
TOTAL: 7 3.789 8.914 0.00000:00:35

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
165.227.6.47 1
ns525040.ip-158-69-123.net 1
TOTAL: 5 390

NNRP gethostbyaddr failures [Top 20]:

SystemConn
? (can't getpeername) 1
TOTAL: 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 50100.0%
TOTAL: 1 50100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 30
2pl.comp.pecet 20
TOTAL: 2 50