Daily Usenet report

Jun 15 04:15:03 -- Jun 16 04:15:03

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

Jun 15 08:25:45 newsfeed nnrpd[16644]: SERVER perl filter not defined
Jun 15 13:07:17 newsfeed overchan[6365]: input line too long, skipping
Jun 15 13:13:24 newsfeed nnrpd[27278]: SERVER perl filter not defined
Jun 15 13:32:11 newsfeed overchan[6365]: input line too long, skipping
Jun 15 13:32:28 newsfeed overchan[6365]: input line too long, skipping
Jun 15 15:28:01 newsfeed nnrpd[32421]: SERVER perl filter not defined
Jun 15 16:34:47 newsfeed overchan[6365]: input line too long, skipping
Jun 15 17:00:05 newsfeed pgpverify[3432]: pgpverify: verification failed
Jun 15 17:22:18 newsfeed overchan[6365]: input line too long, skipping
Jun 15 17:34:13 newsfeed overchan[6365]: input line too long, skipping
Jun 15 17:35:29 newsfeed overchan[6365]: input line too long, skipping
Jun 15 17:40:21 newsfeed overchan[6365]: input line too long, skipping
Jun 15 20:14:40 newsfeed overchan[6365]: input line too long, skipping
Jun 15 20:17:59 newsfeed nnrpd[10814]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn2504462 97.4%289.3 MB 97.1%
innfeed 42172 1.6%5.0 MB 1.7%
innd 19653 0.8%3.2 MB 1.1%
nnrpd 4850 0.2%514.5 KB 0.2%
overchan 10 0.0%1.8 KB 0.0%
controlchan 4 0.0%0.5 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 72571152 100.0%298.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2417790 66.1%
Negative hits 1066003 29.2%
Positive hits 171837 4.7%
Cache misses 390 0.0%
TOTAL: 4 3656020 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:05.370 0.0%164 0.000 32.744 1269.000
article cleanup00:00:28.563 0.0%2502196 0.008 0.011 0.016
article logging00:01:42.187 0.1%2502658 0.028 0.041 0.151
article parse00:38:55.562 2.7%91189067 0.015 0.026 0.041
article write00:15:50.916 1.1%2425912 0.195 0.392 0.703
artlog/artcncl00:00:00.007 0.0%164 0.000 0.043 1.000
artlog/artparse00:00:00.001 0.0%1 1.000 1.000 1.000
data move00:01:47.453 0.1%106116756 0.001 0.001 0.002
hisgrep/artcncl00:00:00.873 0.0%161 0.000 5.422 38.300
hishave/artcncl00:00:00.088 0.0%164 0.000 0.537 5.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:48:55.581 3.4%3669628 0.066 0.800 3.810
history sync00:00:00.015 0.0%293 0.000 0.051 1.000
history write01:39:18.953 6.9%2427919 0.331 2.454 8.824
hiswrite/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
idle15:22:33.309 64.1%75937611 0.464 0.729 2.005
nntp read00:49:09.741 3.4%89919390 0.020 0.033 0.049
overview write00:00:11.557 0.0%2425912 0.003 0.005 0.008
perl filter03:50:16.841 16.0%2427904 3.676 5.691 8.350
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:58.100 0.3%5156401 0.039 0.058 0.080
TOTAL: 24:00:06.09323:34:15.117 98.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:01.153 0.0%536219 0.000 0.002 0.005
article prepare00:00:00.013 0.0%68544 0.000 0.000 0.009
article read00:00:37.342 0.0%14918 0.000 2.503 237.103
backlog stats00:00:00.869 0.0%1647503 0.000 0.001 0.002
callbacks00:00:00.000 0.0%5 0.000 0.000 0.000
data read00:00:13.742 0.0%1034696 0.007 0.013 0.023
data write00:00:51.785 0.1%748150 0.039 0.069 0.119
idle23:48:31.924 99.8%1647503 23.421 52.025 543.392
status file00:00:14.282 0.0%16735 0.496 0.853 2.369
TOTAL: 23:51:06.62423:50:31.110100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:46.436 88.6%3157 0.000 33.714 859.400
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.245 0.2%6943 0.000 0.035 0.842
readart00:00:00.120 0.1%62 0.000 1.935 2.069
TOTAL: 00:02:00.13200:01:46.801 88.9%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 1177 24271982322131 33622 71445 95%416:56:18
2news.nask.pl 3 174949 105102 64727 5120 60%23:58:36
3news.icm.edu.pl 42 239 40 190 9 16%17:03:52
4localhost 5 4 4 0 0 100%00:00:00
TOTAL: 4 1227 26023902427277 98539 76574 93%457:58:46
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl610.5 GB24.7 GB24.7 GB659.8 GB 92%289.1 KB
2news.nask.pl34.4 GB1.1 GB1.1 GB36.6 GB 94%348.0 KB
3news.icm.edu.pl831.5 KB0.0 KB546.2 KB1.3 MB 60%28.1 KB
4localhost5.5 KB0.0 KB0.0 KB5.5 KB100%1.4 KB
TOTAL: 4644.9 GB25.8 GB25.8 GB696.4 GB 92%291.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 15 04:15:03 - 04:59:59 85330 3.5% 31.6422.9 GB 3.5%8892.43
Jun 15 05:00:00 - 05:59:59 117388 4.8% 32.6130.8 GB 4.8%8980.38
Jun 15 06:00:00 - 06:59:59 94992 3.9% 26.3928.1 GB 4.4%8179.52
Jun 15 07:00:00 - 07:59:59 46929 1.9% 13.0415.6 GB 2.4%4556.43
Jun 15 08:00:00 - 08:59:59 56134 2.3% 15.5917.1 GB 2.7%4987.65
Jun 15 09:00:00 - 09:59:59 114777 4.7% 31.8827.5 GB 4.3%8006.79
Jun 15 10:00:00 - 10:59:59 103526 4.3% 28.7628.6 GB 4.4%8341.41
Jun 15 11:00:00 - 11:59:59 110130 4.5% 30.5934.6 GB 5.4%10082.76
Jun 15 12:00:00 - 12:59:59 106986 4.4% 29.7234.1 GB 5.3%9931.03
Jun 15 13:00:00 - 13:59:59 111057 4.6% 30.8530.6 GB 4.7%8905.13
Jun 15 14:00:00 - 14:59:59 157947 6.5% 43.8728.9 GB 4.5%8417.79
Jun 15 15:00:00 - 15:59:59 112908 4.7% 31.3626.9 GB 4.2%7839.27
Jun 15 16:00:00 - 16:59:59 53681 2.2% 14.9114.6 GB 2.3%4253.96
Jun 15 17:00:00 - 17:59:59 79296 3.3% 22.0321.2 GB 3.3%6187.84
Jun 15 18:00:00 - 18:59:59 49977 2.1% 13.8813.4 GB 2.1%3916.62
Jun 15 19:00:00 - 19:59:59 81106 3.3% 22.5320.8 GB 3.2%6058.59
Jun 15 20:00:00 - 20:59:59 162104 6.7% 45.0328.5 GB 4.4%8288.13
Jun 15 21:00:00 - 21:59:59 135970 5.6% 37.7734.3 GB 5.3%9982.14
Jun 15 22:00:00 - 22:59:59 110722 4.6% 30.7632.6 GB 5.1%9499.77
Jun 15 23:00:00 - 23:59:59 109596 4.5% 30.4436.9 GB 5.7%10747.58
Jun 16 00:00:00 - 00:59:59 82122 3.4% 22.8122.9 GB 3.5%6660.51
Jun 16 01:00:00 - 01:59:59 107221 4.4% 29.7830.1 GB 4.7%8769.63
Jun 16 02:00:00 - 02:59:59 115292 4.7% 32.0331.5 GB 4.9%9162.81
Jun 16 03:00:00 - 03:59:59 100517 4.1% 27.9226.8 GB 4.2%7800.82
Jun 16 04:00:00 - 04:15:03 21558 0.9% 23.875.7 GB 0.9%6568.51
TOTAL: 24:00:00 2427266 100.0% 28.09645.0 GB 100.0%7827.75
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 71691 170 0 71198 0 0 0 0 323
2news.nask.pl 5330 21 0 3368 1 0 0 0 1940
3news.icm.edu.pl 9 0 0 0 0 0 0 0 9
TOTAL: 3 77030 191 0 74566 1 0 0 0 2272

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 72
it.comp.os.win.windows10 41
it.tlc.cellulari.android 30
comp.sys.raspberry-pi 27
xs4all.general 10
nl.comp.os.linux.techniek 6
comp.mobile.android 4
de.comp.lang.vbclassic 1
TOTAL: 8 191

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1610
Binary in non-binary group 115
Scoring filter (8) 31
HTML post 10
Scoring filter (16) 9
Scoring filter (9) 6
Too many newsgroups 5
Scoring filter (10) 4
Scoring filter (18) 1
Scoring filter (11) 1
Scoring filter (17) 1
Scoring filter (12) 1
TOTAL: 12 1794

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
newsfeed.pionier.net.pl 14
TOTAL: 1 14
Including strange strings
newsfeed.pionier.net.pl 253
news.nask.pl 210
TOTAL: 2 463
TOTAL: 2 477

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nask 246854 10037 183469 11 0 9 4%23:59:58
2panorama 255260 1692 225052 391 12 311886 0%23:59:58
3poznan 11775 164 7488 11 0 0 1%23:59:58
4icm 370491 44 299963 4745 0 5 0%23:59:58
5okapi 0 0 0 0 0 941 0%23:57:51
TOTAL: 5 884380 11937 715972 5158 12 312841 1%119:57:43
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask3.7 GB3.5 MB3.7 GB44.4 KB/s382.0 KB23:59:58
2panorama201.6 MB44.5 MB246.1 MB2.9 KB/s121.0 KB23:59:58
3icm7.5 MB1.7 GB1.7 GB21.0 KB/s378.5 KB23:59:58
4poznan1002.5 KB156.2 KB1.1 MB0.0 KB/s6.6 KB23:59:58
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
TOTAL: 53.9 GB1.8 GB5.6 GB13.7 KB/s345.4 KB119:57:43
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama3.3 MB
TOTAL: 13.3 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
10890788407.static.corbina.ru 9 3144.2 KB 3 0 000:01:30
2isvcs01.man.lodz.pl 4 00.0 KB 0 4 000:00:00
TOTAL: 2 13 3144.2 KB 3 4 000:01:59

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.static.corbina.ru 9 3144.2 KB 3 0 000:01:30
2*.man.lodz.pl 676 00.0 KB 0 4 000:00:28
TOTAL: 2 685 3144.2 KB 3 4 000:01:59

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
0890788407.static.corbina.ru 0.044 0.116 0.00000:01:30
web.man.lodz.pl 1.592 5.272 0.00000:00:23
mon.man.lodz.pl 1.088 4.072 0.00000:00:03
david.man.lodz.pl 0.380 1.224 0.00000:00:01
isvcs01.man.lodz.pl 0.052 0.076 0.00000:00:00
TOTAL: 5 3.156 10.760 0.00000:01:59

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
web.man.lodz.pl 288
david.man.lodz.pl 96
TOTAL: 3 672

Newsgroup request counts (by category):

CategoryCountPct
1lodman 31100.0%
TOTAL: 1 31100.0%

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

NewsgroupCount
1lodman.info 31
TOTAL: 1 31