Daily Usenet report

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

Unknown entries from news log file:

First 16 / 16 lines (100.0%)

Oct 7 07:50:24 newsfeed nnrpd[18628]: SERVER perl filter not defined
Oct 7 09:44:38 newsfeed nnrpd[3135]: SERVER perl filter not defined
Oct 7 10:48:11 newsfeed nnrpd[12896]: SERVER perl filter not defined
Oct 7 13:03:46 newsfeed nnrpd[2767]: SERVER perl filter not defined
Oct 7 13:03:56 newsfeed nnrpd[2770]: SERVER perl filter not defined
Oct 7 13:04:17 newsfeed nnrpd[2771]: SERVER perl filter not defined
Oct 7 13:35:47 newsfeed nnrpd[7524]: SERVER perl filter not defined
Oct 7 14:41:03 newsfeed overchan[18090]: input line too long, skipping
Oct 7 15:08:45 newsfeed nnrpd[21489]: SERVER perl filter not defined
Oct 7 15:30:12 newsfeed overchan[18090]: input line too long, skipping
Oct 7 16:04:49 newsfeed nnrpd[29841]: unable to get certificate from '/etc/news/cert.pem'
Oct 7 16:04:49 newsfeed nnrpd[29841]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Oct 7 16:22:42 newsfeed overchan[18090]: input line too long, skipping
Oct 7 17:24:18 newsfeed overchan[18090]: input line too long, skipping
Oct 7 18:09:44 newsfeed nnrpd[16152]: SERVER perl filter not defined
Oct 7 19:45:29 newsfeed overchan[18090]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 535680 91.1%59.1 MB 90.1%
innfeed 40154 6.8%4.8 MB 7.3%
innd 8901 1.5%1.4 MB 2.1%
nnrpd 3462 0.6%327.8 KB 0.5%
overchan 6 0.0%1.2 KB 0.0%
TOTAL: 5 588203 100.0%65.6 MB100.0%

History cache:

ReasonCount%Count
Do not exist 532422 98.7%
Negative hits 6664 1.2%
Positive hits 397 0.1%
Cache misses 37 0.0%
TOTAL: 4 539520 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.468 0.0%119 0.000 12.336 97.000
article cleanup00:00:02.835 0.0%536434 0.003 0.005 0.009
article logging00:00:09.282 0.0%536840 0.010 0.017 0.030
article parse00:05:33.064 0.4%101005217 0.003 0.003 0.005
article write00:02:47.617 0.2%535510 0.175 0.313 0.630
artlog/artcncl00:00:00.003 0.0%119 0.000 0.025 1.000
data move00:00:19.503 0.0%104897281 0.000 0.000 0.000
hisgrep/artcncl00:00:00.209 0.0%115 0.000 1.817 31.000
hishave/artcncl00:00:00.027 0.0%119 0.000 0.227 2.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:27:03.931 1.9%543494 0.394 2.988 8.559
history sync00:00:00.008 0.0%290 0.000 0.028 0.500
history write00:45:38.316 3.2%536376 1.378 5.105 16.952
hiswrite/artcncl00:00:00.018 0.0%4 0.000 4.500 18.000
idle22:00:18.830 91.7%98551138 0.562 0.804 1.743
nntp read00:10:45.528 0.7%100649121 0.005 0.006 0.009
overview write00:00:01.302 0.0%535510 0.000 0.002 0.005
perl filter00:20:20.826 1.4%536376 1.615 2.276 3.624
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:08.520 0.0%1083252 0.005 0.008 0.012
TOTAL: 24:00:01.00423:53:11.287 99.5%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.048 0.0%47340 0.000 0.001 0.008
article prepare00:00:00.002 0.0%5100 0.000 0.000 0.042
article read00:00:00.996 0.0%1275 0.000 0.781 21.000
backlog stats00:00:00.044 0.0%105473 0.000 0.000 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.288 0.0%51256 0.000 0.006 0.037
data write00:00:00.762 0.0%39504 0.000 0.019 0.060
idle23:54:46.407 99.9%105473 197.412 816.194 2612.317
status file00:01:01.300 0.1%13178 0.000 4.652 244.820
TOTAL: 23:55:52.15223:55:49.847100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:15.773 73.0%2860 0.000 5.515 1230.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.033 0.2%6216 0.000 0.005 0.500
readart00:00:00.043 0.2%56 0.000 0.768 4.200
TOTAL: 00:00:21.61000:00:15.849 73.3%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 260 534978 534076 0 902 99%112:54:25
2news.icm.edu.pl 48 336 58 258 20 17%18:07:04
3localhost 1450 9 9 0 0 100%00:00:00
TOTAL: 3 1758 535323 534143 258 922 99%131:01:29
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl224.7 GB4.3 MB22.8 MB224.7 GB 99%440.5 KB
2news.icm.edu.pl4.5 MB0.0 KB482.7 KB5.0 MB 90%65.5 KB
3localhost13.5 KB0.0 KB0.0 KB13.5 KB100%1.5 KB
TOTAL: 3224.7 GB4.3 MB23.2 MB224.7 GB 99%440.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 7 04:15:02 - 04:59:59 15492 2.9% 5.747.2 GB 3.2%2781.01
Oct 7 05:00:00 - 05:59:59 26125 4.9% 7.269.6 GB 4.3%2809.07
Oct 7 06:00:00 - 06:59:59 24583 4.6% 6.836.9 GB 3.1%2011.68
Oct 7 07:00:00 - 07:59:59 15567 2.9% 4.326.1 GB 2.7%1764.75
Oct 7 08:00:00 - 08:59:59 14353 2.7% 3.996.0 GB 2.7%1753.38
Oct 7 09:00:00 - 09:59:59 15351 2.9% 4.266.1 GB 2.7%1774.32
Oct 7 10:00:00 - 10:59:59 15605 2.9% 4.335.9 GB 2.6%1732.13
Oct 7 11:00:00 - 11:59:59 15802 3.0% 4.396.0 GB 2.7%1758.40
Oct 7 12:00:00 - 12:59:59 25099 4.7% 6.979.9 GB 4.4%2897.11
Oct 7 13:00:00 - 13:59:59 27851 5.2% 7.7411.8 GB 5.2%3432.91
Oct 7 14:00:00 - 14:59:59 25617 4.8% 7.1211.0 GB 4.9%3212.40
Oct 7 15:00:00 - 15:59:59 24509 4.6% 6.8110.7 GB 4.8%3116.38
Oct 7 16:00:00 - 16:59:59 24035 4.5% 6.6811.6 GB 5.2%3383.70
Oct 7 17:00:00 - 17:59:59 24689 4.6% 6.8610.9 GB 4.8%3167.29
Oct 7 18:00:00 - 18:59:59 23434 4.4% 6.5111.1 GB 4.9%3234.92
Oct 7 19:00:00 - 19:59:59 22984 4.3% 6.3810.2 GB 4.5%2974.88
Oct 7 20:00:00 - 20:59:59 25218 4.7% 7.0010.6 GB 4.7%3096.05
Oct 7 21:00:00 - 21:59:59 22012 4.1% 6.1110.6 GB 4.7%3099.42
Oct 7 22:00:00 - 22:59:59 22640 4.2% 6.299.9 GB 4.4%2870.73
Oct 7 23:00:00 - 23:59:59 19671 3.7% 5.469.9 GB 4.4%2878.66
Oct 8 00:00:00 - 00:59:59 21976 4.1% 6.1010.2 GB 4.5%2957.73
Oct 8 01:00:00 - 01:59:59 21910 4.1% 6.0910.1 GB 4.5%2945.47
Oct 8 02:00:00 - 02:59:59 27938 5.2% 7.7610.2 GB 4.5%2962.28
Oct 8 03:00:00 - 03:59:59 27240 5.1% 7.579.9 GB 4.4%2891.45
Oct 8 04:00:00 - 04:15:01 4531 0.8% 5.032.3 GB 1.0%2717.03
TOTAL: 23:59:59 534232 100.0% 6.18224.8 GB 100.0%2728.75
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 1309 845 0 56 1 0 0 0 407
2news.icm.edu.pl 20 0 0 0 0 0 0 0 20
TOTAL: 2 1329 845 0 56 1 0 0 0 427

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.binaries.666 607
uk.railway 127
it.comp.os.win.windows10 45
comp.mobile.android 32
it.tlc.cellulari.android 16
alt.comp.software.seamonkey 8
alt.comp.software.firefox 8
de.comp.lang.vbclassic 1
comp.sys.raspberry-pi 1
TOTAL: 9 845

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

GroupsCount
pl.praca.oferowana 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 19
Binary in non-binary group 1
TOTAL: 2 20

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 18354 1047 10676 157 0 0 5%23:59:57
2panorama 35461 3 13784 35 0 33528 0%23:59:34
3poznan 54 0 38 0 0 0 0%03:30:15
4okapi 0 0 0 0 0 785 0%23:57:48
5nask 0 0 0 0 0 7903 0%23:57:48
TOTAL: 5 53869 1050 24498 192 0 42216 1%99:25:22
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm3.5 MB32.5 MB36.0 MB0.4 KB/s30.6 KB23:59:57
2panorama193.0 KB147.1 KB340.1 KB0.0 KB/s8.9 KB23:59:34
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s003:30:15
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
TOTAL: 53.6 MB32.7 MB36.3 MB0.1 KB/s29.9 KB99:25:22
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 287 4452.0 KB 19 0 000:00:09
2212.90.61.180 2 1013.8 KB 2 0 000:00:04
3isvcs01.man.lodz.pl 9 00.0 KB 0 9 000:00:00
TOTAL: 3 298 5465.8 KB 21 9 000:00:21

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 296 4452.0 KB 19 9 000:00:10
2unresolved 110 1013.8 KB 2 0 000:00:10
3*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 3 407 5465.8 KB 21 9 000:00:21

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 0.641 1.133 0.00000:00:09
212.90.61.180 0.023 0.008 0.00000:00:04
80.111.142.213 0.011 0.016 0.00000:00:02
43.131.68.225 0.000 0.005 0.00000:00:02
134.122.15.140 0.010 0.026 0.00000:00:00
212.51.192.185 0.213 0.351 0.00000:00:00
isvcs01.man.lodz.pl 0.028 0.041 0.00000:00:00
scanner-25.ch1.censys-scanner.com 0.003 0.003 0.00000:00:00
TOTAL: 8 0.929 1.583 0.00000:00:21

Curious NNRP server explorers [Top 20]:

SystemConn
212.51.192.185 96
134.122.15.140 7
80.111.142.213 4
43.131.68.225 1
scanner-25.ch1.censys-scanner.com 1
TOTAL: 5 109

NNRP unrecognized commands (by host):

SystemConn
134.122.15.140 36
43.131.68.225 1
scanner-25.ch1.censys-scanner.com 1
TOTAL: 3 38

NNRP unrecognized commands (by command):

CommandCount
Connection: keep-alive 6
Accept-Encoding: gzip, deflate 6
Accept: */* 6
Host: 212.191.2.21:119 6
User-Agent: Mozilla/5.0 (Windows NT 10.0... 5
#026#003#001 1
GET /streaming/clients_live.php HTTP/1.1 1
User-Agent: AlexaMediaPlayer/2.1.4676.0 ... 1
GET /stalker_portal/c/version.js HTTP/1.... 1
GET /flu/403.html HTTP/1.1 1
GET /stream/live.php HTTP/1.1 1
GET /system_api.php HTTP/1.1 1
GET /c/version.js HTTP/1.1 1
EHLO www.censys.io 1
TOTAL: 14 38

NNRP client timeouts [Top 20]:

SystemConnPeer
43.131.68.225 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 44 81.5%
2lodman 10 18.5%
TOTAL: 2 54100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 42
2lodman.info 10
3pl.comp.pecet 2
TOTAL: 3 54