Daily Usenet report

Aug 31 04:15:02 -- Sep 1 04:15:02

Unknown entries from news log file:

First 11 / 11 lines (100.0%)

Aug 31 16:20:30 newsfeed nnrpd[11833]: SERVER perl filter not defined
Aug 31 16:20:44 newsfeed nnrpd[11835]: SERVER perl filter not defined
Aug 31 17:53:03 newsfeed overchan[16238]: input line too long, skipping
Aug 31 17:57:58 newsfeed overchan[16238]: input line too long, skipping
Aug 31 18:20:24 newsfeed overchan[16238]: input line too long, skipping
Aug 31 19:13:44 newsfeed overchan[16238]: input line too long, skipping
Sep 1 01:40:24 newsfeed overchan[16238]: input line too long, skipping
Sep 1 02:30:20 newsfeed overchan[16238]: input line too long, skipping
Sep 1 02:39:28 newsfeed overchan[16238]: input line too long, skipping
Sep 1 02:41:13 newsfeed overchan[16238]: input line too long, skipping
Sep 1 03:12:04 newsfeed overchan[16238]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2482783 97.2%286.4 MB 96.9%
innfeed 48127 1.9%5.7 MB 1.9%
innd 18513 0.7%3.1 MB 1.0%
nnrpd 4742 0.2%505.8 KB 0.2%
overchan 10 0.0%1.9 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 62554176 100.0%295.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2456697 94.3%
Positive hits 84907 3.3%
Negative hits 63303 2.4%
Cache misses 337 0.0%
TOTAL: 4 2605244 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.268 0.0%109 0.000 20.807 111.000
article cleanup00:00:33.714 0.0%2485883 0.008 0.014 0.019
article logging00:01:54.943 0.1%2486469 0.026 0.046 0.129
article parse00:49:11.212 3.4%99967855 0.016 0.030 0.045
article write00:18:21.695 1.3%2477299 0.249 0.445 1.076
artlog/artcncl00:00:00.008 0.0%109 0.000 0.073 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:02:11.713 0.2%115240879 0.000 0.001 0.002
hisgrep/artcncl00:00:00.865 0.0%108 0.000 8.009 38.000
hishave/artcncl00:00:00.036 0.0%109 0.000 0.330 7.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:40:05.233 2.8%2630743 0.076 0.914 4.385
history sync00:00:00.015 0.0%290 0.000 0.052 1.000
history write01:27:16.496 6.1%2479165 0.166 2.112 7.118
hiswrite/artcncl00:00:00.001 0.0%1 1.000 1.000 1.000
idle14:34:45.933 60.7%76774396 0.419 0.684 1.318
nntp read01:13:30.773 5.1%98167370 0.028 0.045 0.068
overview write00:00:12.147 0.0%2477299 0.003 0.005 0.007
perl filter04:17:47.685 17.9%2479165 3.446 6.239 9.272
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:38.000 0.3%5075249 0.035 0.055 0.074
TOTAL: 24:00:03.03923:30:32.737 98.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.686 0.0%292219 0.000 0.002 0.009
article prepare00:00:00.027 0.0%115228 0.000 0.000 0.002
article read00:00:35.652 0.0%27340 0.000 1.304 197.250
backlog stats00:00:00.771 0.0%915555 0.000 0.001 0.003
callbacks00:00:00.001 0.0%4 0.000 0.250 1.000
data read00:00:09.089 0.0%473857 0.005 0.019 0.035
data write00:01:33.747 0.1%466161 0.019 0.201 0.315
idle23:49:37.578 99.8%915555 26.980 93.689 817.285
status file00:00:16.885 0.0%16858 0.492 1.002 1.965
TOTAL: 23:52:49.19223:52:14.436100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:19.019 63.1%3015 0.000 6.308 148.111
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.254 0.8%6644 0.000 0.038 1.500
readart00:00:00.002 0.0%24 0.000 0.083 0.500
TOTAL: 00:00:30.15700:00:19.275 63.9%----

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 960 24735762468353 2518 2705 99%372:54:01
2news.nask.pl 2 87378 4930 76668 5780 5%23:11:04
3news.icm.edu.pl 40 271 76 176 19 28%16:01:57
4localhost 3 2 2 0 0 100%00:00:00
TOTAL: 4 1005 25612272473361 79362 8504 96%412:07:02
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl781.5 GB174.9 MB190.3 MB781.8 GB 99%331.8 KB
2news.nask.pl206.7 MB1.2 GB1.2 GB2.7 GB 7%261.4 KB
3news.icm.edu.pl1.7 MB8.7 KB989.5 KB2.7 MB 63%28.6 KB
4localhost3.0 KB0.0 KB0.0 KB3.0 KB100%1.5 KB
TOTAL: 4781.7 GB1.4 GB1.4 GB784.5 GB 99%331.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 31 04:15:02 - 04:59:59 81895 3.3% 30.3529.1 GB 3.7%11327.30
Aug 31 05:00:00 - 05:59:59 104778 4.2% 29.1138.3 GB 4.9%11152.80
Aug 31 06:00:00 - 06:59:59 110780 4.5% 30.7736.9 GB 4.7%10753.60
Aug 31 07:00:00 - 07:59:59 102224 4.1% 28.4033.0 GB 4.2%9617.25
Aug 31 08:00:00 - 08:59:59 57481 2.3% 15.9719.6 GB 2.5%5699.69
Aug 31 09:00:00 - 09:59:59 94314 3.8% 26.2030.7 GB 3.9%8941.96
Aug 31 10:00:00 - 10:59:59 140280 5.7% 38.9735.6 GB 4.5%10355.15
Aug 31 11:00:00 - 11:59:59 123512 5.0% 34.3124.5 GB 3.1%7143.49
Aug 31 12:00:00 - 12:59:59 74779 3.0% 20.7724.8 GB 3.2%7211.80
Aug 31 13:00:00 - 13:59:59 102637 4.1% 28.5130.3 GB 3.9%8821.93
Aug 31 14:00:00 - 14:59:59 93239 3.8% 25.9033.7 GB 4.3%9807.64
Aug 31 15:00:00 - 15:59:59 116554 4.7% 32.3834.4 GB 4.4%10021.97
Aug 31 16:00:00 - 16:59:59 92762 3.8% 25.7734.4 GB 4.4%10015.19
Aug 31 17:00:00 - 17:59:59 97956 4.0% 27.2132.9 GB 4.2%9570.40
Aug 31 18:00:00 - 18:59:59 98896 4.0% 27.4735.1 GB 4.5%10210.70
Aug 31 19:00:00 - 19:59:59 99070 4.0% 27.5237.2 GB 4.8%10838.73
Aug 31 20:00:00 - 20:59:59 105566 4.3% 29.3234.9 GB 4.5%10178.18
Aug 31 21:00:00 - 21:59:59 121725 4.9% 33.8136.2 GB 4.6%10555.92
Aug 31 22:00:00 - 22:59:59 161751 6.5% 44.9336.0 GB 4.6%10493.94
Aug 31 23:00:00 - 23:59:59 116473 4.7% 32.3536.0 GB 4.6%10480.12
Sep 1 00:00:00 - 00:59:59 70987 2.9% 19.7226.5 GB 3.4%7725.87
Sep 1 01:00:00 - 01:59:59 96253 3.9% 26.7433.7 GB 4.3%9802.58
Sep 1 02:00:00 - 02:59:59 105074 4.2% 29.1931.6 GB 4.0%9194.78
Sep 1 03:00:00 - 03:59:59 84655 3.4% 23.5229.1 GB 3.7%8474.62
Sep 1 04:00:00 - 04:15:02 19847 0.8% 22.007.4 GB 0.9%8613.09
TOTAL: 24:00:00 2473488 100.0% 28.63781.8 GB 100.0%9488.15
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 5983 6 0 4426 2 0 0 0 1549
2newsfeed.pionier.net.pl 3184 258 0 2305 0 0 0 0 621
3news.icm.edu.pl 19 0 0 1 0 0 0 0 18
TOTAL: 3 9186 264 0 6732 2 0 0 0 2188

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 197
it.tlc.cellulari.android 27
it.comp.os.win.windows10 11
comp.mobile.android 8
it.comp.os.win.windows7 7
it.discussioni.energia 7
comp.mobile.ipad 2
uk.rec.cycling.moderated 2
uk.net.providers.gradwell 1
de.comm.software.mailreader 1
de.rec.sf.startrek 1
TOTAL: 11 264

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

GroupsCount
pl.praca.oferowana 1
bit.listserv.catholic 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1308
Binary in non-binary group 242
Scoring filter (8) 15
Scoring filter (16) 9
Scoring filter (11) 8
Scoring filter (9) 8
HTML post 4
Scoring filter (10) 2
Scoring filter (18) 2
EMP (fsl) 2
Scoring filter (13) 1
TOTAL: 11 1601

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 478
news.nask.pl 109
TOTAL: 2 587
TOTAL: 1 587

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nask 161587 22374 84414 35 0 0 13%23:59:56
2panorama 179760 908 150519 242 6 140804 0%23:59:56
3icm 139040 73 113396 4647 0 1 0%23:59:56
4poznan 6341 66 4567 13 0 0 1%23:57:58
5okapi 0 0 0 0 0 834 0%23:57:49
TOTAL: 5 486728 23421 352896 4937 6 141639 4%119:55:35
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask11.3 GB9.6 MB11.3 GB137.1 KB/s528.6 KB23:59:56
2panorama29.7 MB9.8 MB39.5 MB0.5 KB/s35.2 KB23:59:56
3icm4.5 MB2.1 GB2.1 GB25.3 KB/s463.5 KB23:59:56
4poznan188.8 KB37.2 KB226.0 KB0.0 KB/s2.9 KB23:57:58
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:49
TOTAL: 511.3 GB2.1 GB13.4 GB32.6 KB/s496.3 KB119:55:35
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama1.4 MB
TOTAL: 11.4 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 2420.5 KB 11 0 000:00:24
2isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:00
TOTAL: 2 290 2420.5 KB 11 2 000:00:29

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 674 2420.5 KB 11 2 000:00:29
TOTAL: 1 674 2420.5 KB 11 2 000:00:29

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.324 4.264 0.00000:00:24
mon.man.lodz.pl 1.248 4.188 0.00000:00:03
david.man.lodz.pl 0.448 1.412 0.00000:00:01
isvcs01.man.lodz.pl 0.008 0.028 0.00000:00:00
TOTAL: 4 3.028 9.892 0.00000:00:29

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
TOTAL: 2 384

Newsgroup request counts (by category):

CategoryCountPct
1pl 24100.0%
TOTAL: 1 24100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 20
2pl.comp.pecet 4
TOTAL: 2 24