Daily Usenet report

Apr 30 04:15:02 -- May 1 04:15:02

Unknown entries from news log file:

First 17 / 17 lines (100.0%)

Apr 30 14:00:43 newsfeed overchan[1072]: input line too long, skipping
Apr 30 14:03:11 newsfeed overchan[1072]: input line too long, skipping
Apr 30 14:04:00 newsfeed overchan[1072]: input line too long, skipping
Apr 30 14:10:09 newsfeed overchan[1072]: input line too long, skipping
Apr 30 14:10:36 newsfeed overchan[1072]: input line too long, skipping
Apr 30 14:14:04 newsfeed overchan[1072]: input line too long, skipping
Apr 30 14:14:54 newsfeed overchan[1072]: input line too long, skipping
Apr 30 16:41:41 newsfeed overchan[1072]: input line too long, skipping
Apr 30 16:45:46 newsfeed overchan[1072]: input line too long, skipping
Apr 30 16:46:25 newsfeed overchan[1072]: input line too long, skipping
Apr 30 17:59:45 newsfeed overchan[1072]: input line too long, skipping
Apr 30 19:41:20 newsfeed overchan[1072]: input line too long, skipping
Apr 30 19:42:48 newsfeed overchan[1072]: input line too long, skipping
Apr 30 19:43:11 newsfeed overchan[1072]: input line too long, skipping
Apr 30 19:46:50 newsfeed overchan[1072]: input line too long, skipping
Apr 30 19:57:14 newsfeed overchan[1072]: input line too long, skipping
May 1 02:02:35 newsfeed pgpverify[9508]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn2819568 97.2%329.0 MB 97.0%
innfeed 45164 1.6%5.3 MB 1.6%
innd 30356 1.0%4.3 MB 1.3%
nnrpd 5463 0.2%577.8 KB 0.2%
overchan 17 0.0%2.6 KB 0.0%
controlchan 5 0.0%0.5 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 72900574 100.0%339.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2779960 97.0%
Negative hits 73457 2.6%
Positive hits 11479 0.4%
Cache misses 116 0.0%
TOTAL: 4 2865012 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.370 0.0%210 0.000 11.286 308.000
article cleanup00:00:32.916 0.0%2796095 0.009 0.012 0.016
article logging00:01:52.396 0.1%2796557 0.028 0.040 0.212
article parse00:57:34.193 4.0%228603465 0.009 0.015 0.026
article write01:09:06.977 4.8%2778970 0.391 1.492 4.342
artlog/artcncl00:00:00.007 0.0%201 0.000 0.035 1.000
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:04:17.697 0.3%246049322 0.001 0.001 0.002
hisgrep/artcncl00:00:00.909 0.0%190 0.000 4.784 156.667
hishave/artcncl00:00:00.054 0.0%210 0.000 0.257 1.389
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:11:37.877 0.8%2876479 0.077 0.243 0.676
history sync00:00:00.006 0.0%288 0.000 0.021 0.500
history write01:31:03.238 6.4%2791193 0.271 1.957 8.861
hiswrite/artcncl00:00:00.066 0.0%20 0.000 3.300 7.600
idle13:06:06.610 55.0%178380115 0.209 0.264 0.381
nntp read01:16:40.955 5.4%226378747 0.016 0.020 0.031
overview write00:00:14.402 0.0%2778970 0.004 0.005 0.007
perl filter04:52:24.971 20.4%2791167 5.611 6.286 7.374
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:36.975 0.3%5777889 0.031 0.048 0.080
TOTAL: 23:50:04.64723:16:12.619 97.6%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:01.043 0.0%411039 0.000 0.003 0.013
article prepare00:00:00.237 0.0%837650 0.000 0.000 0.013
article read00:02:40.364 0.2%209289 0.117 0.766 101.381
backlog stats00:00:00.858 0.0%1042721 0.000 0.001 0.003
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:09.200 0.0%579578 0.007 0.016 0.043
data write00:02:01.370 0.1%472898 0.028 0.257 0.485
idle23:47:29.351 99.6%1042721 19.826 82.140 670.031
status file00:00:13.790 0.0%16521 0.535 0.835 1.419
TOTAL: 23:53:10.61623:52:36.213100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:05:38.750 95.5%3265 0.000 103.752 56658.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.175 0.0%7258 0.000 0.024 0.500
readart00:00:00.002 0.0%26 0.000 0.077 0.500
TOTAL: 00:05:54.74700:05:38.927 95.5%----

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
us-control@lists.killfile.org000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 867 27982092790320 2548 5341 99%429:48:17
2news.nask.pl 3 23896 8508 3771 11617 35%23:37:11
3news.icm.edu.pl 51 234 14 196 24 5%16:39:24
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 922 28223392798842 6515 16982 99%470:04:52
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl816.7 GB202.6 MB349.9 MB817.2 GB 99%306.5 KB
2news.nask.pl54.5 MB1.8 MB295.1 MB351.4 MB 15%17.9 KB
3news.icm.edu.pl367.0 KB37.7 KB1.5 MB1.8 MB 19%49.8 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 4816.7 GB204.4 MB646.5 MB817.6 GB 99%304.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 30 04:15:02 - 04:59:59 90191 3.2% 33.4329.1 GB 3.6%11290.86
Apr 30 05:00:00 - 05:59:59 126824 4.5% 35.2338.6 GB 4.7%11231.88
Apr 30 06:00:00 - 06:59:59 86865 3.1% 24.1329.9 GB 3.7%8700.96
Apr 30 07:00:00 - 07:59:59 95825 3.4% 26.6231.9 GB 3.9%9296.01
Apr 30 08:00:00 - 08:59:59 112089 4.0% 31.1436.5 GB 4.5%10626.15
Apr 30 09:00:00 - 09:59:59 133371 4.8% 37.0540.7 GB 5.0%11859.54
Apr 30 10:00:00 - 10:59:59 119022 4.2% 33.0634.1 GB 4.2%9937.47
Apr 30 11:00:00 - 11:59:59 144589 5.2% 40.1639.1 GB 4.8%11396.34
Apr 30 12:00:00 - 12:59:59 135913 4.9% 37.7536.0 GB 4.4%10491.91
Apr 30 13:00:00 - 13:59:59 137059 4.9% 38.0737.0 GB 4.5%10790.09
Apr 30 14:00:00 - 14:59:59 126390 4.5% 35.1138.5 GB 4.7%11225.52
Apr 30 15:00:00 - 15:59:59 127608 4.6% 35.4537.5 GB 4.6%10919.41
Apr 30 16:00:00 - 16:59:59 146674 5.2% 40.7438.8 GB 4.7%11296.18
Apr 30 17:00:00 - 17:59:59 144486 5.2% 40.1339.5 GB 4.8%11507.30
Apr 30 18:00:00 - 18:59:59 134178 4.8% 37.2740.0 GB 4.9%11661.61
Apr 30 19:00:00 - 19:59:59 107685 3.8% 29.9130.8 GB 3.8%8967.22
Apr 30 20:00:00 - 20:59:59 68812 2.5% 19.1120.7 GB 2.5%6023.85
Apr 30 21:00:00 - 21:59:59 67060 2.4% 18.6319.8 GB 2.4%5759.39
Apr 30 22:00:00 - 22:59:59 68581 2.4% 19.0519.8 GB 2.4%5756.70
Apr 30 23:00:00 - 23:59:59 71651 2.6% 19.9019.9 GB 2.4%5795.06
May 1 00:00:00 - 00:59:59 120795 4.3% 33.5534.2 GB 4.2%9970.13
May 1 01:00:00 - 01:59:59 140617 5.0% 39.0638.2 GB 4.7%11126.85
May 1 02:00:00 - 02:59:59 132269 4.7% 36.7439.9 GB 4.9%11619.09
May 1 03:00:00 - 03:59:59 128305 4.6% 35.6436.3 GB 4.4%10582.10
May 1 04:00:00 - 04:15:02 34881 1.2% 38.679.7 GB 1.2%11234.60
TOTAL: 24:00:00 2801740 100.0% 32.43816.5 GB 100.0%9909.06
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 11952 18 0 423 3 0 0 011508
2newsfeed.pionier.net.pl 5643 35 0 4504 0 0 0 0 1104
3news.icm.edu.pl 32 0 0 3 0 0 0 0 29
TOTAL: 3 17627 53 0 4930 3 0 0 012641

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 16
comp.mobile.android 12
it.comp.os.win.windows10 10
comp.sys.raspberry-pi 5
comp.mobile.ipad 5
de.rec.sf.startrek 1
alt.sex.telephones 1
de.comp.lang.perl 1
it.tlc.cellulari.android 1
hr.ponuda.hardver.komponente 1
TOTAL: 10 53

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

GroupsCount
pl.sci.matematyka 2
bit.listserv.catholic 1
TOTAL: 2 3

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 10471
Binary in non-binary group 1379
Scoring filter (8) 140
Scoring filter (9) 94
Scoring filter (10) 29
Too many newsgroups 10
Scoring filter (17) 8
Scoring filter (11) 7
Scoring filter (12) 6
EMP (phl) 2
Excessively crossposted test article 1
HTML post 1
TOTAL: 12 12148

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 307
news.nask.pl 159
news.icm.edu.pl 1
TOTAL: 3 467
TOTAL: 1 467

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 224297 197252 15083 9085 2 0 87%23:54:31
2panorama 208070 1669 178940 186 5 230189 0%23:55:23
3poznan 12961 289 8208 57 0 0 2%23:54:31
4nask 7508 10 4819 1 0 0 0%23:54:31
5okapi 0 0 0 0 0 967 0%23:52:24
TOTAL: 5 452836 199220 207050 9329 7 231156 43%119:31:20
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm35.4 GB1004.6 MB36.4 GB443.1 KB/s184.8 KB23:54:31
2panorama17.6 MB1.6 MB19.2 MB0.2 KB/s10.6 KB23:55:23
3poznan1.2 MB238.1 KB1.4 MB0.0 KB/s4.2 KB23:54:31
4nask22.6 KB1.0 KB23.6 KB0.0 KB/s2.1 KB23:54:31
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:52:24
TOTAL: 535.4 GB1006.5 MB36.4 GB88.7 KB/s183.0 KB119:31:20
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama2.9 MB
TOTAL: 12.9 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 290 2625.3 KB 13 0 000:00:24
TOTAL: 1 290 2625.3 KB 13 0 000:05:54

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 674 2625.3 KB 13 0 000:00:30
2*.census.shodan.io 1 00.0 KB 0 0 000:00:00
3*.neoplus.adsl.tpnet.pl 2 00.0 KB 0 0 000:03:13
4*.versanet.de 176 00.0 KB 0 0 000:02:09
TOTAL: 4 853 2625.3 KB 13 0 000:05:54

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
cms31.neoplus.adsl.tpnet.pl 0.016 0.008 0.00000:03:13
i59f7e2f7.versanet.de 0.672 1.204 0.00000:02:09
web.man.lodz.pl 1.144 2.996 0.00000:00:24
mon.man.lodz.pl 1.024 2.580 0.00000:00:05
david.man.lodz.pl 0.308 0.876 0.00000:00:01
battery.census.shodan.io 0.000 0.016 0.00000:00:00
TOTAL: 6 3.164 7.680 0.00000:05:54

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
i59f7e2f7.versanet.de 176
david.man.lodz.pl 96
cms31.neoplus.adsl.tpnet.pl 2
battery.census.shodan.io 1
TOTAL: 5 563

Newsgroup request counts (by category):

CategoryCountPct
1pl 26100.0%
TOTAL: 1 26100.0%

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

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