Daily Usenet report

Oct 17 04:15:02 -- Oct 18 04:15:01

Unknown entries from news log file:

First 27 / 27 lines (100.0%)

Oct 17 06:27:52 newsfeed overchan[30670]: input line too long, skipping
Oct 17 06:33:24 newsfeed overchan[30670]: input line too long, skipping
Oct 17 06:44:42 newsfeed overchan[30670]: input line too long, skipping
Oct 17 07:11:31 newsfeed overchan[30670]: input line too long, skipping
Oct 17 07:22:29 newsfeed overchan[30670]: input line too long, skipping
Oct 17 07:33:18 newsfeed overchan[30670]: input line too long, skipping
Oct 17 08:57:15 newsfeed nnrpd[10220]: SERVER perl filter not defined
Oct 17 08:58:34 newsfeed nnrpd[10352]: SERVER perl filter not defined
Oct 17 09:00:26 newsfeed nnrpd[10844]: SERVER perl filter not defined
Oct 17 11:08:05 newsfeed overchan[30670]: input line too long, skipping
Oct 17 15:38:43 newsfeed overchan[30670]: input line too long, skipping
Oct 17 17:49:25 newsfeed overchan[30670]: input line too long, skipping
Oct 17 17:55:33 newsfeed overchan[30670]: input line too long, skipping
Oct 17 20:23:57 newsfeed overchan[30670]: input line too long, skipping
Oct 17 20:34:10 newsfeed overchan[30670]: input line too long, skipping
Oct 17 20:58:04 newsfeed overchan[30670]: input line too long, skipping
Oct 17 22:12:30 newsfeed overchan[30670]: input line too long, skipping
Oct 17 22:28:07 newsfeed overchan[30670]: input line too long, skipping
Oct 17 22:29:13 newsfeed nnrpd[5136]: SERVER perl filter not defined
Oct 17 22:52:15 newsfeed overchan[30670]: input line too long, skipping
Oct 17 22:55:27 newsfeed overchan[30670]: input line too long, skipping
Oct 18 01:39:29 newsfeed overchan[30670]: input line too long, skipping
Oct 18 02:06:29 newsfeed overchan[30670]: input line too long, skipping
Oct 18 02:23:40 newsfeed overchan[30670]: input line too long, skipping
Oct 18 03:19:20 newsfeed overchan[30670]: input line too long, skipping
Oct 18 03:20:42 newsfeed overchan[30670]: input line too long, skipping
Oct 18 03:44:33 newsfeed overchan[30670]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 648802 94.0%70.7 MB 93.3%
innfeed 27878 4.0%3.3 MB 4.3%
innd 9103 1.3%1.4 MB 1.8%
nnrpd 4324 0.6%433.9 KB 0.6%
overchan 24 0.0%4.3 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 690132 100.0%75.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 645257 99.7%
Negative hits 1364 0.2%
Positive hits 278 0.0%
Cache misses 49 0.0%
TOTAL: 4 646948 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.821 0.0%166 0.000 4.946 65.000
article cleanup00:00:09.633 0.0%647938 0.009 0.015 0.024
article logging00:00:30.697 0.0%648382 0.036 0.047 0.059
article parse00:20:10.909 1.4%59782200 0.014 0.020 0.029
article write00:08:07.980 0.6%647690 0.546 0.753 1.060
artlog/artcncl00:00:00.005 0.0%166 0.000 0.030 0.333
data move00:00:39.063 0.0%64910505 0.000 0.001 0.001
hisgrep/artcncl00:00:00.242 0.0%164 0.000 1.476 23.000
hishave/artcncl00:00:00.071 0.0%166 0.000 0.428 5.300
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:17:01.975 1.2%649450 0.578 1.574 7.345
history sync00:00:00.025 0.0%290 0.000 0.086 1.000
history write00:07:42.931 0.5%647921 0.514 0.714 5.109
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle21:01:08.153 87.6%59067937 0.900 1.281 2.055
nntp read00:35:48.362 2.5%59392965 0.027 0.036 0.046
overview write00:00:03.738 0.0%647690 0.003 0.006 0.010
perl filter01:13:37.608 5.1%647921 5.228 6.818 8.856
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:33.683 0.0%1309377 0.021 0.026 0.031
TOTAL: 24:00:02.90923:45:35.896 99.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.106 0.0%40915 0.000 0.003 0.011
article prepare00:00:00.000 0.0%1660 0.000 0.000 0.000
article read00:00:01.630 0.0%414 0.000 3.937 29.000
backlog stats00:00:00.103 0.0%100352 0.000 0.001 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.894 0.0%49941 0.000 0.018 0.040
data write00:00:02.114 0.0%36024 0.015 0.059 0.132
idle23:54:51.886100.0%100352 194.984 857.899 2014.346
status file00:00:22.196 0.0%9311 0.742 2.384 52.410
TOTAL: 23:55:24.38423:55:18.929100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:02:07.333 81.3%3351 0.000 37.999 9571.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.372 0.2%7318 0.000 0.051 2.667
readart00:00:00.003 0.0%101 0.000 0.030 0.500
TOTAL: 00:02:36.52700:02:07.708 81.6%----

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 159 648069 647888 1 180 99%84:58:08
2news.icm.edu.pl 47 233 20 144 69 8%14:05:35
3localhost 1445 4 4 0 0 100%00:00:00
TOTAL: 3 1651 648306 647912 145 249 99%99:03:43
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl326.6 GB1.3 MB1.6 MB326.6 GB 99%528.4 KB
2news.icm.edu.pl1.3 MB16.4 KB2.9 MB4.3 MB 31%49.4 KB
3localhost8.4 KB0.0 KB0.0 KB8.4 KB100%2.1 KB
TOTAL: 3326.6 GB1.3 MB4.6 MB326.6 GB 99%528.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 17 04:15:02 - 04:59:59 17996 2.8% 6.6710.0 GB 3.1%3883.81
Oct 17 05:00:00 - 05:59:59 25615 4.0% 7.1214.8 GB 4.5%4317.57
Oct 17 06:00:00 - 06:59:59 27444 4.2% 7.6214.4 GB 4.4%4201.38
Oct 17 07:00:00 - 07:59:59 25219 3.9% 7.0113.4 GB 4.1%3896.60
Oct 17 08:00:00 - 08:59:59 26508 4.1% 7.3614.4 GB 4.4%4203.59
Oct 17 09:00:00 - 09:59:59 25914 4.0% 7.2013.4 GB 4.1%3914.37
Oct 17 10:00:00 - 10:59:59 26746 4.1% 7.4314.1 GB 4.3%4109.82
Oct 17 11:00:00 - 11:59:59 28265 4.4% 7.8514.2 GB 4.3%4122.58
Oct 17 12:00:00 - 12:59:59 30875 4.8% 8.5815.1 GB 4.6%4397.12
Oct 17 13:00:00 - 13:59:59 28092 4.3% 7.8013.8 GB 4.2%4012.85
Oct 17 14:00:00 - 14:59:59 25312 3.9% 7.0312.9 GB 4.0%3771.16
Oct 17 15:00:00 - 15:59:59 27635 4.3% 7.6814.1 GB 4.3%4106.89
Oct 17 16:00:00 - 16:59:59 28595 4.4% 7.9413.4 GB 4.1%3913.57
Oct 17 17:00:00 - 17:59:59 28496 4.4% 7.9213.6 GB 4.2%3959.64
Oct 17 18:00:00 - 18:59:59 29752 4.6% 8.2612.9 GB 3.9%3744.87
Oct 17 19:00:00 - 19:59:59 33699 5.2% 9.3612.9 GB 3.9%3750.69
Oct 17 20:00:00 - 20:59:59 35101 5.4% 9.7514.2 GB 4.3%4129.59
Oct 17 21:00:00 - 21:59:59 27433 4.2% 7.6214.1 GB 4.3%4111.84
Oct 17 22:00:00 - 22:59:59 26349 4.1% 7.3214.2 GB 4.4%4148.29
Oct 17 23:00:00 - 23:59:59 25609 4.0% 7.1113.4 GB 4.1%3902.05
Oct 18 00:00:00 - 00:59:59 23604 3.6% 6.5612.0 GB 3.7%3493.11
Oct 18 01:00:00 - 01:59:59 25226 3.9% 7.0114.2 GB 4.3%4145.77
Oct 18 02:00:00 - 02:59:59 21158 3.3% 5.8812.3 GB 3.7%3571.45
Oct 18 03:00:00 - 03:59:59 21435 3.3% 5.9512.1 GB 3.7%3515.42
Oct 18 04:00:00 - 04:15:01 5866 0.9% 6.513.3 GB 1.0%3819.43
TOTAL: 23:59:59 647944 100.0% 7.50327.2 GB 100.0%3971.16
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 624 155 0 17 8 0 0 0 444
2news.icm.edu.pl 68 0 0 1 0 0 0 0 67
TOTAL: 2 692 155 0 18 8 0 0 0 511

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 64
it.tlc.cellulari.android 52
it.comp.os.win.windows10 20
comp.mobile.android 7
comp.sys.raspberry-pi 6
it.comp.os.win.windows7 3
de.rec.sf.startrek 2
it.comp.os.win.windows8 1
TOTAL: 8 155

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

GroupsCount
pl.praca.oferowana 7
pl.sci.matematyka 1
TOTAL: 2 8

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 62
Binary in non-binary group 4
Too many newsgroups 1
TOTAL: 3 67

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 21177 260 13430 40 0 0 1%23:52:28
2panorama 27611 21 12257 32 0 28745 0%23:59:59
3poznan 15 1 11 0 0 0 6%01:35:51
4okapi 0 0 0 0 0 764 0%23:57:51
5nask 0 0 0 0 0 9677 0%23:57:45
TOTAL: 5 48803 282 25698 72 0 39186 0%97:23:54
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm888.4 KB75.8 KB964.2 KB0.0 KB/s3.2 KB23:52:28
2panorama73.0 KB259.7 KB332.7 KB0.0 KB/s6.3 KB23:59:59
3poznan3.6 KB0.0 KB3.6 KB0.0 KB/s3.6 KB01:35:51
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:45
TOTAL: 5965.0 KB335.5 KB1.3 MB0.0 KB/s3.7 KB97:23:54
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 95115.2 KB 34 1 000:00:23
2109.63.165.59 7 34.8 KB 1 0 000:01:02
3isvcs01.man.lodz.pl 3 00.0 KB 0 3 000:00:00
TOTAL: 3 298 98120.0 KB 35 4 000:02:36

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 579 95115.2 KB 34 4 000:00:32
2unresolved 108 34.8 KB 1 0 000:01:27
3*.dsl.bell.ca 3 00.0 KB 0 0 000:00:35
TOTAL: 3 690 98120.0 KB 35 4 000:02:36

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
109.63.165.59 0.056 0.079 0.00000:01:02
bras-base-mtrlpq2320w-grc-04-174-91-198-172.dsl.bell.ca 0.053 0.052 0.00000:00:35
web.man.lodz.pl 1.658 4.130 0.00000:00:23
80.111.142.213 0.018 0.045 0.00000:00:14
192.241.233.235 0.000 0.009 0.00000:00:09
mon.man.lodz.pl 2.609 5.848 0.00000:00:09
212.51.192.185 0.542 0.864 0.00000:00:01
isvcs01.man.lodz.pl 0.030 0.039 0.00000:00:00
TOTAL: 8 4.966 11.066 0.00000:02:36

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
bras-base-mtrlpq2320w-grc-04-174-91-198-172.dsl.bell.ca 3
192.241.233.235 1
TOTAL: 5 392

Newsgroup request counts (by category):

CategoryCountPct
1pl 95 96.9%
2lodman 3 3.1%
TOTAL: 2 98100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 48
2pl.comp.pecet 46
3lodman.info 3
4pl.rec.mineraly 1
TOTAL: 4 98