Daily Usenet report

Jan 9 04:15:03 -- Jan 10 04:15:03

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

Jan 9 09:09:51 newsfeed overchan[18666]: input line too long, skipping
Jan 9 09:19:20 newsfeed nnrpd[30410]: SERVER perl filter not defined
Jan 9 09:21:45 newsfeed nnrpd[30501]: SERVER perl filter not defined
Jan 9 09:22:59 newsfeed nnrpd[30516]: SERVER perl filter not defined
Jan 9 15:17:59 newsfeed nnrpd[11188]: SERVER perl filter not defined
Jan 9 15:18:40 newsfeed overchan[18666]: input line too long, skipping
Jan 9 15:19:17 newsfeed nnrpd[11191]: SERVER perl filter not defined
Jan 9 15:22:02 newsfeed nnrpd[11280]: SERVER perl filter not defined
Jan 9 15:24:32 newsfeed overchan[18666]: input line too long, skipping
Jan 9 15:39:51 newsfeed overchan[18666]: input line too long, skipping
Jan 9 15:46:22 newsfeed overchan[18666]: input line too long, skipping
Jan 9 22:43:57 newsfeed nnrpd[27569]: SERVER perl filter not defined
Jan 9 23:21:26 newsfeed nnrpd[29009]: SERVER perl filter not defined
Jan 9 23:22:03 newsfeed nnrpd[29017]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn3862464 98.2%432.2 MB 97.8%
innd 35558 0.9%5.4 MB 1.2%
innfeed 31970 0.8%3.8 MB 0.9%
nnrpd 4830 0.1%507.6 KB 0.1%
overchan 6 0.0%0.9 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 63934829 100.0%441.9 MB100.0%

History cache:

ReasonCount%Count
Do not exist 3829648 96.6%
Negative hits 114849 2.9%
Positive hits 19163 0.5%
Cache misses 71 0.0%
TOTAL: 4 3963731 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:03.412 0.0%99 0.000 34.465 390.000
article cleanup00:00:38.055 0.0%3871064 0.007 0.010 0.014
article logging00:02:00.851 0.1%3871995 0.020 0.031 0.092
article parse00:36:20.171 2.5%118984963 0.011 0.018 0.038
article write00:15:34.188 1.1%3848530 0.140 0.243 0.454
artlog/artcncl00:00:00.001 0.0%93 0.000 0.011 0.500
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:01:43.530 0.1%136304217 0.001 0.001 0.002
hisgrep/artcncl00:00:00.482 0.0%96 0.000 5.021 58.667
hishave/artcncl00:00:00.021 0.0%99 0.000 0.212 12.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup01:43:16.381 7.2%3998647 0.278 1.550 9.211
history sync00:00:00.013 0.0%290 0.000 0.045 0.500
history write05:22:13.037 22.4%3863261 0.870 5.004 14.645
hiswrite/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
idle10:09:43.884 42.3%88166766 0.156 0.415 1.525
nntp read00:44:19.397 3.1%115975280 0.018 0.023 0.035
overview write00:00:15.781 0.0%3848530 0.003 0.004 0.006
perl filter04:34:39.710 19.1%3863261 2.916 4.266 5.792
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:50.485 0.3%7718190 0.028 0.038 0.051
TOTAL: 24:00:06.52323:35:39.399 98.3%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.107 0.0%45940 0.000 0.002 0.015
article prepare00:00:00.000 0.0%7568 0.000 0.000 0.000
article read00:00:40.454 0.0%1887 0.000 21.438 351.333
backlog stats00:00:00.101 0.0%151415 0.000 0.001 0.005
callbacks00:00:00.000 0.0%3 0.000 0.000 0.000
data read00:00:00.982 0.0%83060 0.000 0.012 0.027
data write00:00:02.664 0.0%62373 0.015 0.043 0.087
idle23:54:09.654 99.9%151415 315.071 568.303 1324.945
status file00:00:20.972 0.0%10715 0.467 1.957 27.617
TOTAL: 23:55:22.00823:55:14.934100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle37:10:07.842 99.9%843102 0.000 158.709452341.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:41.436 0.0%1686773 0.000 0.025 0.500
readart00:00:00.002 0.0%32 0.000 0.062 0.500
TOTAL: 37:11:50.31637:10:49.280100.0%----

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 162 38478003826126 8526 13148 99%247:54:02
2news.nask.pl 2 24065 11896 2697 9472 49%23:44:47
3news.icm.edu.pl 45 243 12 225 6 4%17:55:22
4localhost 10 9 9 0 0 100%00:00:00
TOTAL: 4 219 38721173838043 11448 22626 99%289:34:11
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl677.7 GB1.1 GB2.1 GB680.9 GB 99%186.0 KB
2news.nask.pl78.3 MB5.7 MB1.1 GB1.2 GB 6%58.6 KB
3news.icm.edu.pl1.6 MB25.6 KB106.4 KB1.8 MB 92%100.1 KB
4localhost24.7 KB0.0 KB0.0 KB24.7 KB100%2.7 KB
TOTAL: 4677.7 GB1.1 GB3.3 GB682.1 GB 99%185.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 9 04:15:03 - 04:59:59 101668 2.6% 37.7015.7 GB 2.3%6088.11
Jan 9 05:00:00 - 05:59:59 163056 4.2% 45.2925.2 GB 3.7%7344.35
Jan 9 06:00:00 - 06:59:59 135383 3.5% 37.6133.1 GB 4.9%9646.07
Jan 9 07:00:00 - 07:59:59 143676 3.7% 39.9134.5 GB 5.1%10049.85
Jan 9 08:00:00 - 08:59:59 143268 3.7% 39.8033.3 GB 4.9%9685.39
Jan 9 09:00:00 - 09:59:59 142963 3.7% 39.7132.8 GB 4.8%9546.90
Jan 9 10:00:00 - 10:59:59 153787 4.0% 42.7235.2 GB 5.2%10263.99
Jan 9 11:00:00 - 11:59:59 166330 4.3% 46.2038.7 GB 5.7%11273.96
Jan 9 12:00:00 - 12:59:59 139657 3.6% 38.7930.0 GB 4.4%8741.39
Jan 9 13:00:00 - 13:59:59 140914 3.7% 39.1432.4 GB 4.8%9439.14
Jan 9 14:00:00 - 14:59:59 158016 4.1% 43.8933.3 GB 4.9%9687.24
Jan 9 15:00:00 - 15:59:59 131306 3.4% 36.4731.1 GB 4.6%9054.92
Jan 9 16:00:00 - 16:59:59 105883 2.8% 29.4123.5 GB 3.5%6841.40
Jan 9 17:00:00 - 17:59:59 125445 3.3% 34.8523.1 GB 3.4%6738.08
Jan 9 18:00:00 - 18:59:59 228187 5.9% 63.3926.6 GB 3.9%7751.08
Jan 9 19:00:00 - 19:59:59 215579 5.6% 59.8823.2 GB 3.4%6771.48
Jan 9 20:00:00 - 20:59:59 185654 4.8% 51.5720.5 GB 3.0%5960.67
Jan 9 21:00:00 - 21:59:59 202883 5.3% 56.3628.2 GB 4.2%8218.76
Jan 9 22:00:00 - 22:59:59 97303 2.5% 27.0320.2 GB 3.0%5887.84
Jan 9 23:00:00 - 23:59:59 184020 4.8% 51.1226.8 GB 3.9%7805.50
Jan 10 00:00:00 - 00:59:59 206271 5.4% 57.3024.4 GB 3.6%7114.84
Jan 10 01:00:00 - 01:59:59 224767 5.9% 62.4429.0 GB 4.3%8442.75
Jan 10 02:00:00 - 02:59:59 200651 5.2% 55.7430.6 GB 4.5%8918.62
Jan 10 03:00:00 - 03:59:59 116555 3.0% 32.3822.0 GB 3.2%6397.23
Jan 10 04:00:00 - 04:15:03 25540 0.7% 28.285.9 GB 0.9%6809.15
TOTAL: 24:00:00 3838762 100.0% 44.43679.3 GB 100.0%8243.77
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 13548 97 0 7494 4 0 0 0 5953
2news.nask.pl 10055 21 0 309 9 0 0 0 9716
3news.icm.edu.pl 6 0 0 1 0 0 0 0 5
TOTAL: 3 23609 118 0 7804 13 0 0 015674

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 55
it.comp.os.win.windows10 19
it.tlc.cellulari.android 19
comp.mobile.android 13
comp.sys.raspberry-pi 8
it.comp.os.win.windows7 3
alt.sex.fetish.wrestling.male 1
TOTAL: 7 118

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

GroupsCount
pl.sci.matematyka 7
pl.praca.oferowana 4
pl.sci.historia 1
bit.listserv.catholic 1
TOTAL: 4 13

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 11123
EMP (md5) 3457
Scoring filter (8) 48
Scoring filter (9) 27
EMP (phl) 23
Scoring filter (10) 20
HTML post 10
Scoring filter (11) 9
Too many newsgroups 8
Poison newsgroup 5
Scoring filter (16) 5
Scoring filter (12) 4
Excessively crossposted test article 3
Scoring filter (13) 2
TOTAL: 14 14744

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.nask.pl 549
newsfeed.pionier.net.pl 381
TOTAL: 2 930
TOTAL: 1 930

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1poznan 19110 708 11060 100 0 2 3%23:59:37
2panorama 26265 426 7964 104 6 37574 1%23:59:30
3icm 25183 44 20558 3 0 2 0%23:59:48
4nask 2528 2 1968 219 0 0 0%23:47:48
5okapi 0 0 0 0 0 1377 0%23:57:51
TOTAL: 5 73086 1180 41550 426 6 38955 1%119:44:34
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm4.1 MB37.4 KB4.1 MB0.0 KB/s89.1 KB23:59:48
2poznan3.2 MB3.5 MB6.7 MB0.1 KB/s8.5 KB23:59:37
3panorama2.9 MB873.2 KB3.7 MB0.0 KB/s7.2 KB23:59:30
4nask2.2 KB23.1 MB23.1 MB0.3 KB/s106.9 KB23:47:48
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
TOTAL: 510.1 MB27.4 MB37.6 MB0.1 KB/s24.0 KB119:44:34
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 3225.6 KB 13 0 000:00:26
2isvcs01.man.lodz.pl 9 00.0 KB 0 9 000:00:03
TOTAL: 2 297 3225.6 KB 13 9 037:11:49

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 681 3225.6 KB 13 9 000:00:33
2unresolved 4 00.0 KB 0 0 036:41:06
3*.neoplus.adsl.tpnet.pl 1 00.0 KB 0 0 000:30:09
TOTAL: 3 686 3225.6 KB 13 9 037:11:49

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
185.48.195.97 42.244 67.760 0.00036:41:01
abje177.neoplus.adsl.tpnet.pl 0.052 0.032 0.00000:30:09
web.man.lodz.pl 1.164 7.148 0.00000:00:26
27.156.90.19 0.000 0.020 0.00000:00:04
isvcs01.man.lodz.pl 0.052 0.192 0.00000:00:03
mon.man.lodz.pl 0.836 6.432 0.00000:00:03
david.man.lodz.pl 0.268 2.012 0.00000:00:00
TOTAL: 7 44.616 83.596 0.00037:11:49

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
185.48.195.97 3
abje177.neoplus.adsl.tpnet.pl 1
27.156.90.19 1
TOTAL: 5 389

NNRP unrecognized commands (by host):

SystemConn
27.156.90.19 2
TOTAL: 1 2

NNRP unrecognized commands (by command):

CommandCount
Host: 212.191.2.21:119 1
GET / HTTP/1.0 1
TOTAL: 2 2

NNRP client timeouts [Top 20]:

SystemConnPeer
abje177.neoplus.adsl.tpnet.pl 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.os.ms-windows.winnt 16
2pl.comp.pecet 16
TOTAL: 2 32