Daily Usenet report

Jan 28 04:15:06 -- Jan 29 04:15:03

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

Jan 28 05:15:03 newsfeed overchan[13838]: input line too long, skipping
Jan 28 05:24:01 newsfeed overchan[13838]: input line too long, skipping
Jan 28 07:40:05 newsfeed overchan[13838]: input line too long, skipping
Jan 28 07:46:41 newsfeed overchan[13838]: input line too long, skipping
Jan 28 08:29:43 newsfeed overchan[13838]: input line too long, skipping
Jan 28 13:45:02 newsfeed overchan[13838]: input line too long, skipping
Jan 28 15:36:28 newsfeed overchan[13838]: input line too long, skipping
Jan 28 21:35:37 newsfeed overchan[13838]: input line too long, skipping
Jan 28 22:35:58 newsfeed overchan[13838]: input line too long, skipping
Jan 28 23:54:13 newsfeed overchan[13838]: input line too long, skipping
Jan 29 01:29:46 newsfeed overchan[13838]: input line too long, skipping
Jan 29 02:09:56 newsfeed overchan[13838]: input line too long, skipping
Jan 29 03:12:40 newsfeed overchan[13838]: input line too long, skipping
Jan 29 03:36:16 newsfeed overchan[13838]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn3584811 98.0%409.5 MB 97.7%
innfeed 43286 1.2%5.1 MB 1.2%
innd 24163 0.7%4.0 MB 0.9%
nnrpd 4750 0.1%499.7 KB 0.1%
overchan 15 0.0%2.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 63657026 100.0%419.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 3557079 96.8%
Negative hits 106918 2.9%
Positive hits 11496 0.3%
Cache misses 108 0.0%
TOTAL: 4 3675601 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:06.398 0.0%178 0.000 35.944 490.000
article cleanup00:00:31.218 0.0%3585438 0.006 0.009 0.012
article logging00:01:57.200 0.1%3586212 0.020 0.033 0.085
article parse00:35:17.155 2.5%85640589 0.014 0.025 0.047
article write00:15:46.946 1.1%3578556 0.155 0.265 0.440
artlog/artcncl00:00:00.005 0.0%176 0.000 0.028 0.500
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:03:30.088 0.2%102148383 0.001 0.002 0.003
hisgrep/artcncl00:00:01.539 0.0%145 0.000 10.614 99.727
hishave/artcncl00:00:00.569 0.0%178 0.000 3.197 455.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup01:33:24.614 6.5%3702994 0.289 1.514 9.184
history sync00:00:00.009 0.0%290 0.000 0.031 0.500
history write04:21:01.773 18.1%3582237 0.860 4.372 13.732
hiswrite/artcncl00:00:00.575 0.0%33 0.000 17.424 58.714
idle11:35:27.841 48.3%61550293 0.209 0.678 1.691
nntp read00:45:23.122 3.2%82862662 0.023 0.033 0.045
overview write00:00:15.206 0.0%3578556 0.003 0.004 0.006
perl filter04:20:38.189 18.1%3582237 2.859 4.365 6.281
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:05:29.036 0.4%7176260 0.026 0.046 0.065
TOTAL: 24:00:06.43223:38:51.483 98.5%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.137 0.0%55108 0.000 0.002 0.019
article prepare00:00:00.004 0.0%8430 0.000 0.000 0.017
article read00:02:07.402 0.1%2140 2.500 59.534 378.000
backlog stats00:00:00.128 0.0%164155 0.000 0.001 0.004
callbacks00:00:00.000 0.0%41 0.000 0.000 0.000
data read00:00:01.106 0.0%86608 0.002 0.013 0.031
data write00:00:03.035 0.0%67877 0.020 0.045 0.087
idle23:51:15.370 99.8%164155 319.787 523.136 921.449
status file00:00:28.475 0.0%15579 0.570 1.828 32.065
TOTAL: 23:54:04.21923:53:55.657100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle04:37:04.034 99.9%73903 0.000 224.944450086.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:03.552 0.0%148420 0.000 0.024 1.500
readart00:00:00.064 0.0%12 0.000 5.333 31.500
TOTAL: 04:37:22.34704:37:07.650 99.9%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 515 35752183565119 7133 2966 99%509:31:01
2news.nask.pl 3 14968 10268 877 3823 68%23:45:36
3news.icm.edu.pl 38 313 16 288 9 5%16:09:39
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 557 35904993575403 8298 6798 99%549:26:16
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl693.8 GB15.5 MB35.5 MB693.8 GB 99%203.9 KB
2news.nask.pl41.0 MB1.0 MB15.8 MB57.9 MB 70%4.2 KB
3news.icm.edu.pl489.9 KB28.4 KB420.1 KB938.4 KB 52%37.5 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 4693.8 GB16.5 MB51.7 MB693.9 GB 99%203.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 28 04:15:06 - 04:59:59 102747 2.9% 38.1422.9 GB 3.3%8932.73
Jan 28 05:00:00 - 05:59:59 153809 4.3% 42.7234.3 GB 4.9%10000.57
Jan 28 06:00:00 - 06:59:59 136287 3.8% 37.8632.7 GB 4.7%9513.41
Jan 28 07:00:00 - 07:59:59 150952 4.2% 41.9333.1 GB 4.8%9640.66
Jan 28 08:00:00 - 08:59:59 140794 3.9% 39.1128.4 GB 4.1%8267.63
Jan 28 09:00:00 - 09:59:59 141896 4.0% 39.4228.7 GB 4.1%8365.96
Jan 28 10:00:00 - 10:59:59 153773 4.3% 42.7130.6 GB 4.4%8924.18
Jan 28 11:00:00 - 11:59:59 151859 4.2% 42.1831.5 GB 4.5%9185.54
Jan 28 12:00:00 - 12:59:59 165919 4.6% 46.0930.2 GB 4.3%8801.14
Jan 28 13:00:00 - 13:59:59 165639 4.6% 46.0137.3 GB 5.4%10858.52
Jan 28 14:00:00 - 14:59:59 143683 4.0% 39.9129.8 GB 4.3%8684.18
Jan 28 15:00:00 - 15:59:59 72960 2.0% 20.2713.6 GB 2.0%3972.13
Jan 28 16:00:00 - 16:59:59 73701 2.1% 20.4712.4 GB 1.8%3617.14
Jan 28 17:00:00 - 17:59:59 140015 3.9% 38.8923.3 GB 3.4%6800.12
Jan 28 18:00:00 - 18:59:59 169023 4.7% 46.9529.3 GB 4.2%8528.77
Jan 28 19:00:00 - 19:59:59 178856 5.0% 49.6835.1 GB 5.0%10209.94
Jan 28 20:00:00 - 20:59:59 186992 5.2% 51.9436.8 GB 5.3%10708.75
Jan 28 21:00:00 - 21:59:59 161270 4.5% 44.8025.6 GB 3.7%7442.93
Jan 28 22:00:00 - 22:59:59 137751 3.9% 38.2628.0 GB 4.0%8141.89
Jan 28 23:00:00 - 23:59:59 150129 4.2% 41.7029.7 GB 4.3%8658.55
Jan 29 00:00:00 - 00:59:59 154537 4.3% 42.9326.4 GB 3.8%7678.96
Jan 29 01:00:00 - 01:59:59 193103 5.4% 53.6431.1 GB 4.5%9067.35
Jan 29 02:00:00 - 02:59:59 165237 4.6% 45.9031.0 GB 4.5%9025.88
Jan 29 03:00:00 - 03:59:59 154209 4.3% 42.8426.9 GB 3.9%7837.66
Jan 29 04:00:00 - 04:15:03 31860 0.9% 35.286.3 GB 0.9%7290.64
TOTAL: 23:59:57 3577001 100.0% 41.40695.0 GB 100.0%8435.51
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 4172 22 0 403 1 0 0 0 3746
2newsfeed.pionier.net.pl 3452 64 0 2769 0 0 0 0 619
3news.icm.edu.pl 9 0 0 1 0 0 0 0 8
TOTAL: 3 7633 86 0 3173 1 0 0 0 4373

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 46
de.rec.sf.startrek 15
comp.mobile.android 10
it.tlc.cellulari.android 7
de.comp.lang.vbclassic 3
de.comm.software.mailreader 2
it.comp.os.win.windows10 2
it.comp.os.win.windows7 1
TOTAL: 8 86

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3397
Binary in non-binary group 167
Scoring filter (8) 14
Scoring filter (9) 11
Scoring filter (10) 6
Angle-bracket bot 2
Scoring filter (12) 1
TOTAL: 7 3598

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 486
news.nask.pl 289
TOTAL: 2 775
TOTAL: 1 775

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 42391 735 15637 158 102 38657 1%23:59:57
2poznan 16738 366 9963 12 0 0 2%23:59:57
3icm 24615 33 18271 51 0 0 0%23:59:46
4nask 2484 6 1865 0 0 0 0%23:34:59
5okapi 0 0 0 0 0 967 0%23:55:43
TOTAL: 5 86228 1140 45736 221 102 39624 1%119:30:22
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama6.4 MB512.5 KB6.9 MB0.1 KB/s8.0 KB23:59:57
2icm4.3 MB13.4 MB17.7 MB0.2 KB/s215.5 KB23:59:46
3poznan1.2 MB64.8 KB1.3 MB0.0 KB/s3.5 KB23:59:57
4nask204.8 KB0.0 KB204.8 KB0.0 KB/s34.1 KB23:34:59
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:55:43
TOTAL: 512.1 MB14.0 MB26.1 MB0.1 KB/s19.6 KB119:30:22
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 109.4 KB 5 0 000:00:28
292.60.129.74 3 23.5 KB 1 0 001:05:33
TOTAL: 2 291 1212.9 KB 6 0 004:37:21

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 671 109.4 KB 5 0 000:00:32
2unresolved 6 23.5 KB 1 0 004:36:49
TOTAL: 2 677 1212.9 KB 6 0 004:37:21

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
185.48.195.160 3.776 5.404 0.00003:31:06
92.60.129.74 0.004 0.064 0.00001:05:33
web.man.lodz.pl 1.468 6.340 0.00000:00:28
192.241.224.105 0.008 0.024 0.00000:00:09
mon.man.lodz.pl 1.000 5.048 0.00000:00:03
david.man.lodz.pl 0.344 1.684 0.00000:00:01
TOTAL: 6 6.600 18.564 0.00004:37:21

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 95
185.48.195.160 2
192.241.224.105 1
TOTAL: 4 386

NNRP client timeouts [Top 20]:

SystemConnPeer
92.60.129.74 2 0
185.48.195.160 1 1
TOTAL: 2 3 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 10 83.3%
2lodz 2 16.7%
TOTAL: 2 12100.0%

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

NewsgroupCount
1pl.comp.pecet 8
2lodz.ogloszenia 2
3pl.comp.os.ms-windows.winnt 2
TOTAL: 3 12