Daily Usenet report

Jun 3 04:15:02 -- Jun 4 04:15:02

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Jun 3 11:30:03 newsfeed pgpverify[25237]: pgpverify: verification failed
Jun 3 14:53:11 newsfeed overchan[8673]: input line too long, skipping
Jun 3 16:13:28 newsfeed overchan[8673]: input line too long, skipping
Jun 3 16:15:34 newsfeed overchan[8673]: input line too long, skipping
Jun 3 16:19:24 newsfeed overchan[8673]: input line too long, skipping
Jun 3 16:24:26 newsfeed overchan[8673]: input line too long, skipping
Jun 3 16:41:42 newsfeed overchan[8673]: input line too long, skipping
Jun 3 21:31:19 newsfeed overchan[8673]: input line too long, skipping
Jun 3 22:17:43 newsfeed overchan[8673]: input line too long, skipping
Jun 4 03:15:03 newsfeed nnrpd[27115]: SERVER perl filter not defined
Jun 4 03:16:15 newsfeed nnrpd[27119]: SERVER perl filter not defined
Jun 4 03:18:24 newsfeed nnrpd[27287]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn2439293 97.9%276.9 MB 97.5%
innfeed 29503 1.2%3.5 MB 1.2%
innd 18588 0.7%3.0 MB 1.1%
nnrpd 5013 0.2%538.8 KB 0.2%
overchan 9 0.0%1.5 KB 0.0%
controlchan 4 0.0%0.4 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 72492411 100.0%284.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2365636 71.5%
Negative hits 813011 24.6%
Positive hits 127856 3.9%
Cache misses 306 0.0%
TOTAL: 4 3306809 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.777 0.0%230 0.000 7.726 121.000
article cleanup00:00:27.922 0.0%2437732 0.008 0.011 0.016
article logging00:01:36.939 0.1%2438634 0.028 0.040 0.114
article parse00:36:21.254 2.5%87007645 0.014 0.025 0.038
article write00:14:13.318 1.0%2375896 0.202 0.359 0.807
artlog/artcncl00:00:00.003 0.0%229 0.000 0.013 0.125
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:02:05.255 0.1%101374336 0.001 0.001 0.003
hisgrep/artcncl00:00:00.634 0.0%202 0.000 3.139 31.000
hishave/artcncl00:00:00.015 0.0%230 0.000 0.065 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:35:07.849 2.4%3327405 0.073 0.633 2.356
history sync00:00:00.015 0.0%290 0.000 0.052 0.500
history write02:06:17.716 8.8%2377292 0.356 3.188 14.181
hiswrite/artcncl00:00:00.017 0.0%28 0.000 0.607 10.000
idle15:26:16.854 64.3%72809416 0.416 0.763 2.899
nntp read00:48:22.565 3.4%85635752 0.023 0.034 0.058
overview write00:00:11.406 0.0%2375896 0.003 0.005 0.011
perl filter03:38:32.609 15.2%2377286 3.708 5.516 8.165
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:53.991 0.3%4983975 0.040 0.059 0.080
TOTAL: 24:00:04.72523:34:30.139 98.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.962 0.0%412893 0.000 0.002 0.009
article prepare00:00:00.013 0.0%69552 0.000 0.000 0.006
article read00:00:15.189 0.0%12365 0.000 1.228 408.500
backlog stats00:00:00.705 0.0%1278332 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:11.181 0.0%809644 0.006 0.014 0.028
data write00:00:41.868 0.0%597432 0.021 0.070 0.179
idle23:50:04.896 99.9%1278332 28.267 67.123 948.194
status file00:00:09.522 0.0%10961 0.000 0.869 2.875
TOTAL: 23:51:52.15223:51:24.336100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:04:06.697 99.6%3231 0.000 1190.559334930.833
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.239 0.0%7116 0.000 0.034 0.667
readart00:00:00.506 0.0%16 0.000 31.625 222.000
TOTAL: 01:04:20.40801:04:07.442 99.7%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 1123 23757542292209 27050 56495 96%407:11:57
2news.nask.pl 3 130195 83643 41226 5326 64%23:58:23
3news.icm.edu.pl 40 312 31 271 10 9%19:12:12
4localhost 4 3 3 0 0 100%00:00:00
TOTAL: 4 1170 25062642375886 68547 61831 94%450:22:32
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl596.8 GB19.3 GB19.3 GB635.4 GB 93%283.7 KB
2news.nask.pl27.2 GB1.4 GB1.4 GB30.0 GB 90%353.6 KB
3news.icm.edu.pl644.5 KB0.0 KB366.0 KB1010.5 KB 63%24.6 KB
4localhost3.8 KB0.0 KB0.0 KB3.8 KB100%1.3 KB
TOTAL: 4624.1 GB20.7 GB20.7 GB665.4 GB 93%286.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 3 04:15:02 - 04:59:59 63723 2.7% 23.6218.3 GB 2.9%7117.19
Jun 3 05:00:00 - 05:59:59 98273 4.1% 27.3028.5 GB 4.6%8294.61
Jun 3 06:00:00 - 06:59:59 73747 3.1% 20.4920.6 GB 3.3%6003.06
Jun 3 07:00:00 - 07:59:59 43352 1.8% 12.0413.9 GB 2.2%4063.12
Jun 3 08:00:00 - 08:59:59 62149 2.6% 17.2619.3 GB 3.1%5610.74
Jun 3 09:00:00 - 09:59:59 51875 2.2% 14.4117.1 GB 2.7%4972.90
Jun 3 10:00:00 - 10:59:59 120913 5.1% 33.5935.7 GB 5.7%10396.04
Jun 3 11:00:00 - 11:59:59 132391 5.6% 36.7835.5 GB 5.7%10342.58
Jun 3 12:00:00 - 12:59:59 105915 4.5% 29.4222.7 GB 3.6%6609.15
Jun 3 13:00:00 - 13:59:59 86723 3.6% 24.0927.2 GB 4.4%7925.01
Jun 3 14:00:00 - 14:59:59 127544 5.4% 35.4329.7 GB 4.8%8660.49
Jun 3 15:00:00 - 15:59:59 103135 4.3% 28.6526.5 GB 4.2%7708.21
Jun 3 16:00:00 - 16:59:59 130240 5.5% 36.1832.2 GB 5.1%9369.48
Jun 3 17:00:00 - 17:59:59 94792 4.0% 26.3321.8 GB 3.5%6360.44
Jun 3 18:00:00 - 18:59:59 106546 4.5% 29.6022.1 GB 3.5%6430.99
Jun 3 19:00:00 - 19:59:59 86946 3.7% 24.1526.3 GB 4.2%7671.57
Jun 3 20:00:00 - 20:59:59 109930 4.6% 30.5432.6 GB 5.2%9508.56
Jun 3 21:00:00 - 21:59:59 129760 5.5% 36.0433.4 GB 5.3%9721.86
Jun 3 22:00:00 - 22:59:59 152147 6.4% 42.2634.0 GB 5.4%9897.56
Jun 3 23:00:00 - 23:59:59 134711 5.7% 37.4229.2 GB 4.7%8518.27
Jun 4 00:00:00 - 00:59:59 76095 3.2% 21.1421.1 GB 3.4%6141.07
Jun 4 01:00:00 - 01:59:59 93491 3.9% 25.9721.3 GB 3.4%6217.72
Jun 4 02:00:00 - 02:59:59 77294 3.3% 21.4721.5 GB 3.4%6259.42
Jun 4 03:00:00 - 03:59:59 92725 3.9% 25.7627.0 GB 4.3%7859.20
Jun 4 04:00:00 - 04:15:02 21907 0.9% 24.297.5 GB 1.2%8737.32
TOTAL: 24:00:00 2376324 100.0% 27.50625.1 GB 100.0%7586.05
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 57154 99 0 56371 0 0 0 0 684
2news.nask.pl 5573 18 0 4068 1 0 0 0 1486
3news.icm.edu.pl 13 0 0 0 0 0 0 0 13
TOTAL: 3 62740 117 0 60439 1 0 0 0 2183

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 68
comp.sys.raspberry-pi 15
comp.mobile.android 12
it.comp.os.win.windows10 8
it.tlc.cellulari.android 7
it.comp.os.win.windows7 4
de.rec.sf.startrek 1
de.comp.lang.vbclassic 1
it.politica.m5s 1
TOTAL: 9 117

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1145
EMP (phl) 54
Binary in non-binary group 48
Scoring filter (8) 9
Scoring filter (9) 6
Scoring filter (11) 4
Too many newsgroups 4
EMP (fsl) 1
Scoring filter (16) 1
Scoring filter (10) 1
TOTAL: 10 1273

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
newsfeed.pionier.net.pl 5
TOTAL: 1 5
Including strange strings
newsfeed.pionier.net.pl 656
news.nask.pl 246
news.icm.edu.pl 3
TOTAL: 3 905
TOTAL: 2 910

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nask 173907 9302 133873 11 0 4 5%23:59:58
2icm 284174 2682 224676 4660 0 5 0%23:59:58
3panorama 222851 470 203601 166 2 212760 0%23:59:58
4poznan 10395 129 6859 6 0 0 1%23:59:58
5okapi 0 0 0 0 0 1154 0%23:57:50
TOTAL: 5 691327 12583 569009 4843 2 213923 1%119:57:42
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask3.3 GB3.2 MB3.3 GB40.3 KB/s373.6 KB23:59:58
2icm1002.4 MB1.6 GB2.6 GB31.6 KB/s371.6 KB23:59:58
3panorama30.2 MB39.2 MB69.4 MB0.8 KB/s111.7 KB23:59:58
4poznan577.7 KB20.5 KB598.2 KB0.0 KB/s4.4 KB23:59:58
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:50
TOTAL: 54.3 GB1.7 GB6.0 GB14.5 KB/s360.3 KB119:57:42
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 43.0 KB 2 0 000:00:18
2host-94-251-246-103.dynamic.mm.pl 5 44.3 KB 2 0 000:03:21
3178.43.156.103.ipv4.supernova.orange.pl 2 32.5 KB 1 0 000:08:38
40890788407.static.corbina.ru 14 22.6 KB 1 0 000:02:02
5staticline-31-182-57-102.toya.net.pl 10 10.8 KB 1 0 800:46:29
6isvcs01.man.lodz.pl 3 00.0 KB 0 3 000:00:00
TOTAL: 6 322 1413.1 KB 7 3 801:04:19

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dynamic.mm.pl 5 44.3 KB 2 0 000:03:21
2*.man.lodz.pl 675 43.0 KB 2 3 000:00:23
3*.43.156.103.ipv4.supernova.orange.pl 2 32.5 KB 1 0 000:08:38
4*.static.corbina.ru 14 22.6 KB 1 0 000:02:02
5*.toya.net.pl 10 10.8 KB 1 0 800:46:29
6*.astral.lodz.pl 1 00.0 KB 0 0 000:03:24
TOTAL: 6 707 1413.1 KB 7 3 801:04:19

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
staticline-31-182-57-102.toya.net.pl 0.056 0.168 0.00000:46:29
178.43.156.103.ipv4.supernova.orange.pl 0.012 0.016 0.00000:08:38
cable19315177-067.astral.lodz.pl 0.020 0.008 0.00000:03:24
host-94-251-246-103.dynamic.mm.pl 0.044 0.056 0.00000:03:21
0890788407.static.corbina.ru 0.068 0.196 0.00000:02:02
web.man.lodz.pl 1.240 4.472 0.00000:00:18
mon.man.lodz.pl 1.096 3.760 0.00000:00:03
david.man.lodz.pl 0.396 1.284 0.00000:00:01
isvcs01.man.lodz.pl 0.004 0.040 0.00000:00:00
TOTAL: 9 2.936 10.000 0.00001:04:19

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
cable19315177-067.astral.lodz.pl 1
TOTAL: 3 385

NNRP client timeouts [Top 20]:

SystemConnPeer
staticline-31-182-57-102.toya.net.pl 1 0
TOTAL: 1 1 0

Newsgroup request counts (by category):

CategoryCountPct
1lodz 8 57.1%
2pl 4 28.6%
3lodman 2 14.3%
TOTAL: 3 14100.0%

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

NewsgroupCount
1lodz.test 8
2pl.comp.os.ms-windows.winnt 4
3lodman.info 2
TOTAL: 3 14