Daily Usenet report

May 26 04:15:02 -- May 27 04:15:02

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

May 26 09:29:14 newsfeed nnrpd[32189]: SERVER perl filter not defined
May 26 12:24:36 newsfeed nnrpd[5844]: SERVER perl filter not defined
May 26 13:30:25 newsfeed nnrpd[8042]: SERVER perl filter not defined
May 26 13:31:16 newsfeed nnrpd[8043]: SERVER perl filter not defined
May 26 13:40:10 newsfeed nnrpd[8383]: unable to get certificate from '/etc/news/cert.pem'
May 26 13:40:10 newsfeed nnrpd[8383]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
May 26 13:40:10 newsfeed nnrpd[8382]: unable to get certificate from '/etc/news/cert.pem'
May 26 13:40:10 newsfeed nnrpd[8382]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
May 26 13:40:11 newsfeed nnrpd[8384]: unable to get certificate from '/etc/news/cert.pem'
May 26 13:40:11 newsfeed nnrpd[8384]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
May 26 13:41:35 newsfeed nnrpd[8385]: unable to get certificate from '/etc/news/cert.pem'
May 26 13:41:35 newsfeed nnrpd[8385]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
May 27 04:15:02 newsfeed nnrpd[6083]: web.man.lodz.pl rejected Flushing log and syslog files

Log entries by program:

Program nameLines%LinesSize%Size
inn2508219 96.8%281.8 MB 96.3%
innfeed 45806 1.8%5.4 MB 1.9%
innd 33056 1.3%4.8 MB 1.6%
nnrpd 4854 0.2%506.6 KB 0.2%
TOTAL: 42591935 100.0%292.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2503542 95.3%
Negative hits 108052 4.1%
Positive hits 15789 0.6%
Cache misses 113 0.0%
TOTAL: 4 2627496 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:04.420 0.0%177 0.000 24.972 770.000
article cleanup00:00:33.585 0.0%2506137 0.006 0.013 0.023
article logging00:01:09.786 0.1%2506728 0.016 0.028 0.735
article parse01:22:48.144 5.8%199990180 0.015 0.025 0.071
article write00:23:36.426 1.6%2490048 0.388 0.569 3.672
artlog/artcncl00:00:00.005 0.0%177 0.000 0.028 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:02:58.314 0.2%216865847 0.001 0.001 0.017
hisgrep/artcncl00:00:00.166 0.0%162 0.000 1.025 22.000
hishave/artcncl00:00:00.051 0.0%177 0.000 0.288 12.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:25:46.092 1.8%2627722 0.066 0.588 10.916
history sync00:00:00.019 0.0%298 0.000 0.064 1.000
history write00:40:54.938 2.8%2503838 0.168 0.980 47.526
hiswrite/artcncl00:00:00.024 0.0%15 0.000 1.600 20.000
idle12:58:09.765 54.1%147446137 0.106 0.317 0.931
nntp read01:19:26.972 5.5%198097064 0.018 0.024 0.034
overview write00:00:13.654 0.0%2490048 0.000 0.005 0.012
perl filter05:40:36.597 23.7%2503838 6.352 8.162 11.727
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:22.331 0.3%5015534 0.036 0.052 0.089
TOTAL: 23:59:13.56423:00:41.289 95.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.250 0.0%99389 0.000 0.003 0.143
article prepare00:00:00.013 0.0%52678 0.000 0.000 0.083
article read00:01:06.320 0.1%13153 0.000 5.042 847.000
backlog stats00:00:00.182 0.0%276998 0.000 0.001 0.015
callbacks00:00:00.000 0.0%4 0.000 0.000 0.000
data read00:00:01.782 0.0%145729 0.000 0.012 0.138
data write00:00:08.842 0.0%126397 0.000 0.070 0.414
idle23:57:29.819 99.9%276998 14.839 311.373 1297.660
status file00:00:13.586 0.0%15967 0.167 0.851 65.444
TOTAL: 23:59:13.26123:59:00.794100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:29.701 63.2%3081 0.000 9.640 10047.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.166 0.4%6807 0.000 0.024 0.737
readart00:00:00.009 0.0%34 0.000 0.265 3.000
TOTAL: 00:00:46.97100:00:29.876 63.6%----

Control commands to INND:

CommandNumber
L 1
flush 24
flushlogs 2
go 2
logmode 2
mode 148
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 189

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 880 24908392478492 10073 2274 99%284:43:39
2news.nask.pl 2 29296 12551 3020 13725 42%24:08:06
3news.icm.edu.pl 46 301 26 251 24 8%15:42:18
4localhost 5 4 4 0 0 100%00:00:00
TOTAL: 4 933 25204402491073 13344 16023 98%324:34:03
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl852.0 GB23.4 MB24.9 MB852.1 GB 99%360.2 KB
2news.nask.pl65.5 MB575.5 KB146.8 MB212.8 MB 30%8.3 KB
3news.icm.edu.pl819.7 KB0.0 KB388.9 KB1.2 MB 67%24.2 KB
4localhost6.6 KB0.0 KB0.0 KB6.6 KB100%1.7 KB
TOTAL: 4852.1 GB24.0 MB172.0 MB852.3 GB 99%356.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 26 04:15:02 - 04:59:59 79845 3.2% 29.5929.8 GB 3.5%11583.47
May 26 05:00:00 - 05:59:59 108716 4.4% 30.2041.0 GB 4.8%11948.30
May 26 06:00:00 - 06:59:59 117401 4.7% 32.6140.0 GB 4.7%11660.24
May 26 07:00:00 - 07:59:59 90267 3.6% 25.0731.4 GB 3.7%9132.97
May 26 08:00:00 - 08:59:59 109214 4.4% 30.3439.3 GB 4.6%11438.83
May 26 09:00:00 - 09:59:59 116024 4.7% 32.2342.5 GB 5.0%12365.82
May 26 10:00:00 - 10:59:59 122310 4.9% 33.9840.6 GB 4.8%11814.11
May 26 11:00:00 - 11:59:59 126628 5.1% 35.1740.6 GB 4.8%11821.02
May 26 12:00:00 - 12:59:59 95696 3.8% 26.5834.7 GB 4.1%10117.02
May 26 13:00:00 - 13:59:59 107272 4.3% 29.8035.1 GB 4.1%10218.31
May 26 14:00:00 - 14:59:59 109658 4.4% 30.4636.9 GB 4.3%10759.36
May 26 15:00:00 - 15:59:59 95694 3.8% 26.5833.6 GB 3.9%9777.23
May 26 16:00:00 - 16:59:59 100540 4.0% 27.9333.1 GB 3.9%9630.41
May 26 17:00:00 - 17:59:59 104503 4.2% 29.0332.8 GB 3.9%9561.84
May 26 18:00:00 - 18:59:59 99066 4.0% 27.5234.2 GB 4.0%9947.65
May 26 19:00:00 - 19:59:59 95451 3.8% 26.5134.6 GB 4.1%10064.30
May 26 20:00:00 - 20:59:59 105772 4.2% 29.3838.2 GB 4.5%11138.53
May 26 21:00:00 - 21:59:59 101992 4.1% 28.3333.0 GB 3.9%9614.42
May 26 22:00:00 - 22:59:59 105725 4.2% 29.3734.3 GB 4.0%9984.58
May 26 23:00:00 - 23:59:59 104771 4.2% 29.1033.6 GB 3.9%9785.82
May 27 00:00:00 - 00:59:59 80562 3.2% 22.3825.9 GB 3.0%7531.23
May 27 01:00:00 - 01:59:59 95770 3.8% 26.6032.2 GB 3.8%9370.30
May 27 02:00:00 - 02:59:59 100734 4.0% 27.9833.5 GB 3.9%9761.78
May 27 03:00:00 - 03:59:59 95275 3.8% 26.4733.1 GB 3.9%9648.24
May 27 04:00:00 - 04:15:02 22470 0.9% 24.918.2 GB 1.0%9538.17
TOTAL: 24:00:00 2491356 100.0% 28.84852.0 GB 100.0%10340.14
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 13941 14 0 195 5 0 0 013727
2newsfeed.pionier.net.pl 2663 120 0 2107 0 0 0 0 436
3news.icm.edu.pl 82 0 0 0 0 0 0 0 82
TOTAL: 3 16686 134 0 2302 5 0 0 014245

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 70
nl.comp.sys.android 19
comp.mobile.android 14
it.comp.os.win.windows10 13
it.tlc.cellulari.android 8
comp.sys.raspberry-pi 4
nl.comp.os.linux.techniek 1
it.comp.os.win.windows8 1
it.comp.os.win.windows7 1
de.comp.lang.vbclassic 1
it.discussioni.energia 1
alt.sex.telephones 1
TOTAL: 12 134

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

GroupsCount
pl.praca.oferowana 3
bit.listserv.catholic 1
pl.sci.historia 1
TOTAL: 3 5

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 12965
PFM bot misc 214
Binary in non-binary group 133
Scoring filter (8) 127
EMP (phl) 67
Scoring filter (12) 27
Scoring filter (9) 25
Scoring filter (10) 22
Scoring filter (13) 19
Scoring filter (11) 12
HTML post 5
EMP (fsl) 5
Excessively crossposted test article 5
Scoring filter (33) 4
Scoring filter (23) 4
Scoring filter (19) 2
Scoring filter (28) 2
Scoring filter (21) 2
Scoring filter (18) 2
Scoring filter (22) 2
TOTAL: 30 13654

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 42314 7817 24043 2845 0 0 18%23:57:01
2panorama 70599 1125 42516 421 11 55324 1%23:59:37
3poznan 19742 134 12407 20 0 0 0%24:07:06
4nask 6377 16 4030 91 0 0 0%24:03:11
5okapi 0 0 0 0 0 1796 0%24:00:02
TOTAL: 5 139032 9092 82996 3377 11 57120 6%120:06:57
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm1.3 GB598.2 MB1.9 GB22.8 KB/s184.2 KB23:57:01
2panorama4.5 MB2.0 MB6.6 MB0.1 KB/s4.4 KB23:59:37
3poznan847.4 KB40.7 KB888.0 KB0.0 KB/s5.8 KB24:07:06
4nask51.9 KB34.9 MB35.0 MB0.4 KB/s334.7 KB24:03:11
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:02
TOTAL: 51.3 GB635.1 MB1.9 GB4.6 KB/s161.0 KB120:06:57
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama488.3 KB
TOTAL: 1488.3 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 3430.5 KB 17 0 000:00:23
2isvcs01.man.lodz.pl 4 00.0 KB 0 4 000:00:00
TOTAL: 2 292 3430.5 KB 17 4 000:00:46

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 676 3430.5 KB 17 4 000:00:29
2*.toya.net.pl 12 00.0 KB 0 0 000:00:00
3unresolved 7 00.0 KB 0 0 000:00:16
TOTAL: 3 695 3430.5 KB 17 4 000:00:46

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.081 4.817 0.00000:00:23
185.48.194.74 0.003 0.014 0.00000:00:10
185.72.178.148 0.034 0.098 0.00000:00:06
mon.man.lodz.pl 0.988 4.715 0.00000:00:04
david.man.lodz.pl 0.347 1.668 0.00000:00:01
isvcs01.man.lodz.pl 0.045 0.059 0.00000:00:00
staticline41435.toya.net.pl 0.043 0.215 0.00000:00:00
TOTAL: 7 2.541 11.586 0.00000:00:46

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
staticline41435.toya.net.pl 12
185.72.178.148 5
185.48.194.74 2
TOTAL: 5 403

Newsgroup request counts (by category):

CategoryCountPct
1pl 34100.0%
TOTAL: 1 34100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 20
2pl.comp.pecet 14
TOTAL: 2 34