Daily Usenet report

Jul 7 04:15:01 -- Jul 8 04:15:02

Unknown entries from news log file:

First 21 / 21 lines (100.0%)

Jul 7 08:19:01 newsfeed nnrpd[451699]: SERVER perl filter not defined
Jul 7 08:19:32 newsfeed nnrpd[451702]: SERVER perl filter not defined
Jul 7 09:45:32 newsfeed overchan[439866]: input line too long, skipping
Jul 7 10:37:50 newsfeed nnrpd[457838]: SERVER perl filter not defined
Jul 7 10:38:01 newsfeed nnrpd[457840]: SERVER perl filter not defined
Jul 7 10:38:37 newsfeed nnrpd[457843]: SERVER perl filter not defined
Jul 7 12:03:31 newsfeed overchan[439866]: input line too long, skipping
Jul 7 13:09:24 newsfeed overchan[439866]: input line too long, skipping
Jul 7 14:45:57 newsfeed overchan[439866]: input line too long, skipping
Jul 7 14:50:34 newsfeed overchan[439866]: input line too long, skipping
Jul 7 15:12:20 newsfeed overchan[439866]: input line too long, skipping
Jul 7 15:14:13 newsfeed overchan[439866]: input line too long, skipping
Jul 7 15:38:36 newsfeed nnrpd[471079]: SERVER perl filter not defined
Jul 7 15:38:53 newsfeed nnrpd[471086]: SERVER perl filter not defined
Jul 7 15:39:08 newsfeed nnrpd[471088]: SERVER perl filter not defined
Jul 7 15:39:26 newsfeed nnrpd[471091]: SERVER perl filter not defined
Jul 7 16:42:00 newsfeed overchan[439866]: input line too long, skipping
Jul 7 17:09:16 newsfeed overchan[439866]: input line too long, skipping
Jul 7 19:53:53 newsfeed overchan[439866]: input line too long, skipping
Jul 7 19:57:55 newsfeed nnrpd[482545]: SERVER perl filter not defined
Jul 7 20:19:12 newsfeed overchan[439866]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 83253 88.6%9.5 MB 89.9%
nnrpd 7796 8.3%758.1 KB 7.0%
innd 1568 1.7%183.8 KB 1.7%
innfeed 1341 1.4%150.7 KB 1.4%
overchan 12 0.0%1.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 93971 100.0%10.6 MB100.0%

History cache:

ReasonCount%Count
Do not exist 82394 98.1%
Negative hits 1327 1.6%
Positive hits 286 0.3%
Cache misses 21 0.0%
TOTAL: 4 84028 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.723 0.0%37 0.000 19.541 119.000
article cleanup00:00:00.407 0.0%82562 0.000 0.005 0.016
article logging00:00:01.870 0.0%82904 0.003 0.023 0.048
article parse00:00:02.544 0.0%535361 0.001 0.005 0.013
article write00:00:16.430 0.0%82451 0.052 0.199 3.807
artlog/artcncl00:00:00.001 0.0%36 0.000 0.028 1.000
data move00:00:00.622 0.0%713186 0.000 0.001 0.005
hisgrep/artcncl00:00:00.162 0.0%35 0.000 4.629 17.000
hishave/artcncl00:00:00.101 0.0%37 0.000 2.730 9.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:06:42.267 0.5%84141 2.026 4.781 49.345
history sync00:00:00.015 0.0%306 0.000 0.049 1.000
history write00:07:37.292 0.5%82540 2.962 5.540 45.841
hiswrite/artcncl00:00:00.040 0.0%2 14.000 20.000 26.000
idle23:33:19.454 98.8%601202 15.777 141.050 539.956
nntp read00:00:05.765 0.0%528837 0.007 0.011 0.027
overview write00:00:00.248 0.0%82451 0.000 0.003 0.015
perl filter00:01:33.170 0.1%82540 0.624 1.129 2.069
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:02.246 0.0%175124 0.005 0.013 0.022
TOTAL: 23:50:15.73323:49:43.357100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.027 0.0%10259 0.000 0.003 0.026
article prepare00:00:00.000 0.0%84 0.000 0.000 0.000
article read00:00:00.000 0.0%21 0.000 0.000 0.000
backlog stats00:00:00.033 0.0%47004 0.000 0.001 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.215 0.0%24324 0.000 0.009 0.144
data write00:00:00.541 0.0%14223 0.000 0.038 0.152
idle23:58:54.437100.0%47004 943.648 1836.747 4663.225
status file00:00:00.325 0.0%351 0.000 0.926 119.000
TOTAL: 23:58:56.35423:58:55.578100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:15:08.699 87.4%4306 0.000 211.031102734.750
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.111 0.0%10403 0.000 0.011 0.500
readart00:00:00.175 0.0%29 0.000 6.034 9.211
TOTAL: 00:17:19.92700:15:08.985 87.4%----

Control commands to INND:

CommandNumber
flush 27
flushlogs 2
go 2
logmode 2
lowmark 1
mode 148
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 192

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 69 82953 82845 2 106 99%39:08:38
2news.icm.edu.pl 43 277 22 250 5 7%17:30:44
3localhost 11 10 10 0 0 100%00:00:01
TOTAL: 3 123 83240 82877 252 111 99%56:39:23
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl1.3 GB400.7 KB643.1 KB1.3 GB 99%16.3 KB
2news.icm.edu.pl585.5 KB36.4 KB74.3 KB696.1 KB 84%25.8 KB
3localhost15.5 KB0.0 KB0.0 KB15.5 KB100%1.6 KB
TOTAL: 31.3 GB437.0 KB717.4 KB1.3 GB 99%16.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 7 04:15:01 - 04:59:59 2218 2.7% 0.8221.2 MB 1.6% 8.03
Jul 7 05:00:00 - 05:59:59 2133 2.6% 0.5936.6 MB 2.8% 10.40
Jul 7 06:00:00 - 06:59:59 2701 3.3% 0.7552.6 MB 4.0% 14.96
Jul 7 07:00:00 - 07:59:59 2070 2.5% 0.5733.4 MB 2.5% 9.49
Jul 7 08:00:00 - 08:59:59 4585 5.5% 1.27120.9 MB 9.2% 34.39
Jul 7 09:00:00 - 09:59:59 5813 7.0% 1.6175.2 MB 5.7% 21.39
Jul 7 10:00:00 - 10:59:59 3367 4.1% 0.9441.0 MB 3.1% 11.67
Jul 7 11:00:00 - 11:59:59 3555 4.3% 0.9948.3 MB 3.7% 13.74
Jul 7 12:00:00 - 12:59:59 4241 5.1% 1.18155.8 MB 11.8% 44.31
Jul 7 13:00:00 - 13:59:59 3456 4.2% 0.9635.0 MB 2.7% 9.96
Jul 7 14:00:00 - 14:59:59 2203 2.7% 0.6128.5 MB 2.2% 8.11
Jul 7 15:00:00 - 15:59:59 2696 3.3% 0.7536.7 MB 2.8% 10.44
Jul 7 16:00:00 - 16:59:59 3650 4.4% 1.0159.4 MB 4.5% 16.88
Jul 7 17:00:00 - 17:59:59 3255 3.9% 0.9038.2 MB 2.9% 10.86
Jul 7 18:00:00 - 18:59:59 3035 3.7% 0.8447.4 MB 3.6% 13.48
Jul 7 19:00:00 - 19:59:59 3928 4.7% 1.0960.1 MB 4.6% 17.10
Jul 7 20:00:00 - 20:59:59 4232 5.1% 1.1851.5 MB 3.9% 14.65
Jul 7 21:00:00 - 21:59:59 6915 8.4% 1.92109.7 MB 8.3% 31.20
Jul 7 22:00:00 - 22:59:59 3071 3.7% 0.8545.5 MB 3.5% 12.94
Jul 7 23:00:00 - 23:59:59 3333 4.0% 0.9357.6 MB 4.4% 16.38
Jul 8 00:00:00 - 00:59:59 2856 3.5% 0.7943.5 MB 3.3% 12.38
Jul 8 01:00:00 - 01:59:59 1973 2.4% 0.5531.3 MB 2.4% 8.90
Jul 8 02:00:00 - 02:59:59 2251 2.7% 0.6330.3 MB 2.3% 8.63
Jul 8 03:00:00 - 03:59:59 4772 5.8% 1.3351.4 MB 3.9% 14.63
Jul 8 04:00:00 - 04:15:02 453 0.5% 0.505.8 MB 0.4% 6.56
TOTAL: 24:00:01 82762 100.0% 0.961.3 GB 100.0% 15.61
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 450 86 0 20 0 0 0 0 344
2news.icm.edu.pl 5 0 0 2 0 0 0 0 3
TOTAL: 2 455 86 0 22 0 0 0 0 347

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 41
comp.mobile.android 22
comp.sys.raspberry-pi 12
it.comp.os.win.windows10 6
it.discussioni.energia 2
alt.comp.software.firefox 2
alt.comp.software.seamonkey 1
TOTAL: 7 86

INND Perl filter [Top 20]:

ReasonCount
Scoring filter (8) 2
Binary in non-binary group 1
TOTAL: 2 3

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 344
TOTAL: 1 344
TOTAL: 1 344

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 14010 19 10079 2 0 0 0%24:00:00
2panorama 0 0 0 0 0 10281 0%24:05:35
3okapi 0 0 0 0 0 677 0%24:05:35
4poznan 32 0 22 0 0 0 0%02:56:53
5nask 0 0 0 0 0 6696 0%24:05:35
TOTAL: 5 14042 19 10101 2 0 17654 0%99:13:38
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm66.1 KB3.7 KB69.8 KB0.0 KB/s3.3 KB24:00:00
2panorama0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:35
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:35
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:56:53
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:35
TOTAL: 566.1 KB3.7 KB69.8 KB0.0 KB/s3.3 KB99:13:38
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
146.219.209.156 1 1723.9 KB 1 0 000:00:03
2web.man.lodz.pl 288 1018.3 KB 5 0 000:00:08
3isvcs01.man.lodz.pl 10 00.0 KB 0 10 000:00:00
TOTAL: 3 299 2742.1 KB 6 10 000:17:20

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 106 1723.9 KB 1 0 000:13:59
2*.man.lodz.pl1735 1018.3 KB 5 10 000:00:22
3*.ip.linodeusercontent.com 27 00.0 KB 0 0 000:02:58
4*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 41869 2742.1 KB 6 10 000:17:20

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
212.69.68.98 0.008 0.024 0.00000:13:42
172-104-137-47.ip.linodeusercontent.com 0.071 0.412 0.00000:02:58
nms2.man.lodz.pl 2.627 21.007 0.00000:00:13
162.243.141.19 0.004 0.014 0.00000:00:09
web.man.lodz.pl 0.649 4.293 0.00000:00:08
46.219.209.156 0.015 0.016 0.00000:00:03
80.111.142.213 0.004 0.069 0.00000:00:02
212.51.192.185 0.149 1.388 0.00000:00:00
scanner-05.ch1.censys-scanner.com 0.005 0.011 0.00000:00:00
107.170.231.20 0.000 0.021 0.00000:00:00
isvcs01.man.lodz.pl 0.053 0.141 0.00000:00:00
80.66.88.215 0.004 0.016 0.00000:00:00
TOTAL: 12 3.589 27.412 0.00000:17:20

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1437
212.51.192.185 96
172-104-137-47.ip.linodeusercontent.com 27
80.111.142.213 4
212.69.68.98 2
scanner-05.ch1.censys-scanner.com 1
80.66.88.215 1
162.243.141.19 1
107.170.231.20 1
TOTAL: 9 1570

NNRP unrecognized commands (by host):

SystemConn
172-104-137-47.ip.linodeusercontent.com 3
scanner-05.ch1.censys-scanner.com 1
107.170.231.20 1
80.66.88.215 1
TOTAL: 4 6

NNRP unrecognized commands (by command):

CommandCount
EHLO www.censys.io 1
À#024 1
S½YŽ:#025ts ˆ"¸î#0118#032ÁúX½ƒÌŠhy\ëè=»ì#005¬©DXJ#... 1
#026#003#001#002 1
#003 1
MGLNDD_212.191.2.21_119 1
TOTAL: 6 6

NNRP client timeouts [Top 20]:

SystemConnPeer
80.66.88.215 1 1
172-104-137-47.ip.linodeusercontent.com 1 1
TOTAL: 2 2 2

Newsgroup request counts (by category):

CategoryCountPct
1lodman 17 63.0%
2pl 10 37.0%
TOTAL: 2 27100.0%

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

NewsgroupCount
1lodman.info 17
2pl.comp.pecet 10
TOTAL: 2 27