Daily Usenet report

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

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Aug 10 08:11:21 newsfeed overchan[30305]: input line too long, skipping
Aug 10 09:58:50 newsfeed overchan[30305]: input line too long, skipping
Aug 10 14:09:36 newsfeed nnrpd[20646]: SERVER perl filter not defined
Aug 10 16:00:44 newsfeed nnrpd[24766]: SERVER perl filter not defined
Aug 10 17:26:22 newsfeed overchan[30305]: input line too long, skipping
Aug 10 17:45:14 newsfeed overchan[30305]: input line too long, skipping
Aug 10 17:55:54 newsfeed overchan[30305]: input line too long, skipping
Aug 10 18:36:17 newsfeed overchan[30305]: input line too long, skipping
Aug 10 18:38:15 newsfeed overchan[30305]: input line too long, skipping
Aug 10 20:00:18 newsfeed overchan[30305]: input line too long, skipping
Aug 10 21:59:13 newsfeed nnrpd[5546]: SERVER perl filter not defined
Aug 11 01:41:42 newsfeed nnrpd[13708]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn1997861 96.6%227.8 MB 96.2%
innfeed 47871 2.3%5.7 MB 2.4%
innd 17433 0.8%2.8 MB 1.2%
nnrpd 4771 0.2%506.5 KB 0.2%
overchan 9 0.0%1.6 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 62067946 100.0%236.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1982537 91.9%
Positive hits 92015 4.3%
Negative hits 81365 3.8%
Cache misses 839 0.0%
TOTAL: 4 2156756 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.624 0.0%127 0.000 12.787 123.000
article cleanup00:00:25.484 0.0%1998265 0.007 0.013 0.020
article logging00:01:32.591 0.1%1998876 0.028 0.046 0.171
article parse00:34:00.280 2.4%77822688 0.013 0.026 0.050
article write00:14:27.985 1.0%1992663 0.201 0.436 0.793
artlog/artcncl00:00:00.004 0.0%125 0.000 0.032 1.000
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:01:35.880 0.1%89361185 0.001 0.001 0.003
hisgrep/artcncl00:00:00.513 0.0%121 0.000 4.240 21.833
hishave/artcncl00:00:00.063 0.0%127 0.000 0.496 2.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:44:47.217 3.1%2170952 0.281 1.238 6.505
history sync00:00:00.019 0.0%290 0.000 0.066 1.000
history write02:02:53.820 8.5%1994596 1.004 3.697 15.372
hiswrite/artcncl00:00:00.016 0.0%6 0.000 2.667 10.000
idle15:35:20.089 65.0%65338493 0.546 0.859 2.718
nntp read00:47:03.268 3.3%76488096 0.025 0.037 0.070
overview write00:00:10.043 0.0%1992663 0.002 0.005 0.010
perl filter03:30:02.881 14.6%1994594 3.555 6.319 11.136
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:04.950 0.3%4218605 0.040 0.058 0.105
TOTAL: 24:00:02.54023:36:26.727 98.4%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:01.273 0.0%473030 0.000 0.003 0.024
article prepare00:00:00.120 0.0%569314 0.000 0.000 0.012
article read00:03:29.548 0.2%135971 0.292 1.541 22.734
backlog stats00:00:02.138 0.0%2402297 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:15.106 0.0%920962 0.009 0.016 0.029
data write00:07:43.384 0.5%1470185 0.074 0.315 0.697
idle23:37:45.186 99.1%2402297 19.548 35.410 292.587
status file00:00:14.114 0.0%17037 0.479 0.828 2.057
TOTAL: 23:50:34.01423:49:30.869 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:20.702 63.8%3033 0.000 6.826 763.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.265 0.8%6693 0.000 0.040 1.667
readart00:00:00.001 0.0%32 0.000 0.031 0.500
TOTAL: 00:00:32.46600:00:20.968 64.6%----

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 1302 19894801985025 2594 1861 99%394:14:15
2news.nask.pl 2 97981 4595 89696 3690 4%24:29:24
3news.icm.edu.pl 33 370 163 161 46 44%20:26:34
4localhost 5 4 4 0 0 100%00:00:00
TOTAL: 4 1342 20878351989787 92451 5597 95%439:10:13
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl558.6 GB24.5 MB28.9 MB558.7 GB 99%294.8 KB
2news.nask.pl80.2 MB248.6 MB257.9 MB586.8 MB 13%72.5 KB
3news.icm.edu.pl2.8 MB59.8 KB1.2 MB4.0 MB 68%19.8 KB
4localhost4.8 KB0.0 KB0.0 KB4.8 KB100%1.2 KB
TOTAL: 4558.7 GB273.2 MB288.0 MB559.3 GB 99%293.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 10 04:15:03 - 04:59:59 56547 2.8% 20.9717.8 GB 3.2%6933.79
Aug 10 05:00:00 - 05:59:59 81594 4.1% 22.6626.3 GB 4.7%7656.38
Aug 10 06:00:00 - 06:59:59 21274 1.1% 5.918.3 GB 1.5%2427.14
Aug 10 07:00:00 - 07:59:59 43281 2.2% 12.0214.0 GB 2.5%4086.80
Aug 10 08:00:00 - 08:59:59 65153 3.3% 18.1020.3 GB 3.6%5906.94
Aug 10 09:00:00 - 09:59:59 82066 4.1% 22.8021.1 GB 3.8%6151.67
Aug 10 10:00:00 - 10:59:59 98222 4.9% 27.2820.5 GB 3.7%5981.58
Aug 10 11:00:00 - 11:59:59 121188 6.1% 33.6625.1 GB 4.5%7307.15
Aug 10 12:00:00 - 12:59:59 123041 6.2% 34.1828.3 GB 5.1%8229.68
Aug 10 13:00:00 - 13:59:59 91259 4.6% 25.3527.5 GB 4.9%7995.41
Aug 10 14:00:00 - 14:59:59 110956 5.6% 30.8228.3 GB 5.1%8250.31
Aug 10 15:00:00 - 15:59:59 103376 5.2% 28.7217.8 GB 3.2%5196.50
Aug 10 16:00:00 - 16:59:59 68085 3.4% 18.9119.3 GB 3.4%5616.33
Aug 10 17:00:00 - 17:59:59 74116 3.7% 20.5925.1 GB 4.5%7299.72
Aug 10 18:00:00 - 18:59:59 85222 4.3% 23.6728.7 GB 5.1%8362.47
Aug 10 19:00:00 - 19:59:59 84058 4.2% 23.3528.5 GB 5.1%8299.78
Aug 10 20:00:00 - 20:59:59 86123 4.3% 23.9227.4 GB 4.9%7975.35
Aug 10 21:00:00 - 21:59:59 88360 4.4% 24.5428.6 GB 5.1%8326.83
Aug 10 22:00:00 - 22:59:59 93738 4.7% 26.0429.3 GB 5.2%8525.52
Aug 10 23:00:00 - 23:59:59 97505 4.9% 27.0828.7 GB 5.1%8364.99
Aug 11 00:00:00 - 00:59:59 73561 3.7% 20.4317.0 GB 3.0%4941.21
Aug 11 01:00:00 - 01:59:59 81753 4.1% 22.7122.1 GB 3.9%6425.49
Aug 11 02:00:00 - 02:59:59 81657 4.1% 22.6824.3 GB 4.4%7086.78
Aug 11 03:00:00 - 03:59:59 63698 3.2% 17.6920.3 GB 3.6%5924.03
Aug 11 04:00:00 - 04:15:02 15690 0.8% 17.394.5 GB 0.8%5206.37
TOTAL: 23:59:59 1991523 100.0% 23.05559.1 GB 100.0%6784.96
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 3851 8 0 2062 1 0 0 0 1780
2newsfeed.pionier.net.pl 2312 156 0 1604 11 0 0 0 541
3news.icm.edu.pl 50 0 0 4 0 0 0 0 46
TOTAL: 3 6213 164 0 3670 12 0 0 0 2367

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 53
it.comp.os.win.windows10 44
it.tlc.cellulari.android 38
de.comp.lang.vbclassic 6
comp.sys.mac.vintage 6
comp.mobile.android 5
comp.sys.raspberry-pi 5
uk.rec.cycling.moderated 3
it.comp.os.win.windows7 2
de.rec.sf.startrek 1
de.comp.lang.perl 1
TOTAL: 11 164

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

GroupsCount
pl.sci.matematyka 7
pl.praca.oferowana 4
bit.listserv.catholic 1
TOTAL: 3 12

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1599
Binary in non-binary group 85
Scoring filter (9) 17
Scoring filter (16) 17
Scoring filter (8) 11
EMP (phl) 9
HTML post 6
EMP (fsl) 3
Scoring filter (11) 2
Scoring filter (10) 2
Scoring filter (18) 2
Scoring filter (14) 1
TOTAL: 12 1754

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
newsfeed.pionier.net.pl 1
TOTAL: 1 1
Including strange strings
newsfeed.pionier.net.pl 451
news.nask.pl 156
news.icm.edu.pl 4
TOTAL: 3 611
TOTAL: 2 612

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nask 283409 132333 89979 22 0 5046 46%23:59:57
2panorama 253808 1575 223376 352 5 247631 0%23:59:57
3icm 298837 68 223956 8449 0 3 0%23:59:57
4poznan 6184 47 4492 18 0 1 0%23:59:55
5okapi 0 0 0 0 0 1027 0%23:57:50
TOTAL: 5 842238 134023 541803 8841 5 253708 15%119:57:36
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask79.4 GB10.6 MB79.4 GB963.3 KB/s628.8 KB23:59:57
2panorama357.5 MB78.7 MB436.2 MB5.2 KB/s231.8 KB23:59:57
3icm2.5 MB4.8 GB4.8 GB58.5 KB/s593.4 KB23:59:57
4poznan279.5 KB38.0 KB317.5 KB0.0 KB/s4.9 KB23:59:55
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:50
TOTAL: 579.7 GB4.9 GB84.6 GB205.5 KB/s621.1 KB119:57:36
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama2.4 MB
okapi488.4 KB
TOTAL: 22.9 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 3233.5 KB 15 0 000:00:22
2isvcs01.man.lodz.pl 4 00.0 KB 0 4 000:00:00
TOTAL: 2 292 3233.5 KB 15 4 000:00:31

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 676 3233.5 KB 15 4 000:00:27
2*.centertel.pl 2 00.0 KB 0 0 000:00:04
TOTAL: 2 678 3233.5 KB 15 4 000:00:31

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.524 4.484 0.00000:00:22
public-gprs364532.centertel.pl 0.004 0.012 0.00000:00:04
mon.man.lodz.pl 1.156 3.392 0.00000:00:03
david.man.lodz.pl 0.392 1.112 0.00000:00:01
isvcs01.man.lodz.pl 0.028 0.104 0.00000:00:00
? 0.000 0.008 0.00000:00:00
TOTAL: 6 3.104 9.112 0.00000:00:31

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
public-gprs364532.centertel.pl 2
TOTAL: 3 386

NNRP gethostbyaddr failures [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1pl 32100.0%
TOTAL: 1 32100.0%

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

NewsgroupCount
1pl.comp.pecet 32
TOTAL: 1 32