Daily Usenet report

Oct 2 04:15:03 -- Oct 3 04:15:02

Unknown entries from news log file:

First 20 / 20 lines (100.0%)

Oct 2 05:51:33 newsfeed pgpverify[8884]: pgpverify: verification failed
Oct 2 05:59:34 newsfeed overchan[5044]: input line too long, skipping
Oct 2 11:15:42 newsfeed nnrpd[21574]: SERVER perl filter not defined
Oct 2 11:17:28 newsfeed nnrpd[21741]: SERVER perl filter not defined
Oct 2 11:33:19 newsfeed nnrpd[22271]: SERVER perl filter not defined
Oct 2 12:14:46 newsfeed nnrpd[23776]: SERVER perl filter not defined
Oct 2 12:16:25 newsfeed nnrpd[23978]: SERVER perl filter not defined
Oct 2 12:41:44 newsfeed overchan[5044]: input line too long, skipping
Oct 2 12:42:55 newsfeed overchan[5044]: input line too long, skipping
Oct 2 12:43:20 newsfeed overchan[5044]: input line too long, skipping
Oct 2 13:40:46 newsfeed overchan[5044]: input line too long, skipping
Oct 2 15:37:15 newsfeed nnrpd[31993]: SERVER perl filter not defined
Oct 2 15:50:06 newsfeed nnrpd[32498]: SERVER perl filter not defined
Oct 2 18:37:14 newsfeed nnrpd[6799]: SERVER perl filter not defined
Oct 2 18:43:39 newsfeed overchan[5044]: input line too long, skipping
Oct 2 19:22:03 newsfeed nnrpd[8493]: SERVER perl filter not defined
Oct 2 20:16:15 newsfeed overchan[5044]: input line too long, skipping
Oct 2 20:57:08 newsfeed overchan[5044]: input line too long, skipping
Oct 2 21:04:59 newsfeed nnrpd[12474]: SERVER perl filter not defined
Oct 3 02:49:38 newsfeed overchan[5044]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2129417 97.0%251.5 MB 96.7%
innfeed 44654 2.0%5.3 MB 2.0%
innd 16449 0.7%2.7 MB 1.0%
nnrpd 5186 0.2%550.0 KB 0.2%
overchan 10 0.0%1.8 KB 0.0%
controlchan 4 0.0%0.5 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 72195721 100.0%260.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2105054 87.8%
Positive hits 196256 8.2%
Negative hits 91503 3.8%
Cache misses 3602 0.2%
TOTAL: 4 2396415 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:10.182 0.0%378 0.000 26.937 168.000
article cleanup00:00:35.942 0.0%2127385 0.011 0.017 0.025
article logging00:02:07.933 0.1%2128036 0.034 0.060 0.123
article parse01:06:18.206 4.6%79442045 0.023 0.050 0.076
article write00:23:12.591 1.6%2112722 0.415 0.659 36.143
artlog/artcncl00:00:00.023 0.0%370 0.000 0.062 0.333
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:03:16.577 0.2%92812623 0.001 0.002 0.005
hisgrep/artcncl00:00:02.810 0.0%378 0.000 7.434 56.000
hishave/artcncl00:00:01.379 0.0%378 0.000 3.648 5.333
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup02:22:31.663 9.9%2415604 0.503 3.540 286.618
history sync00:00:00.024 0.0%290 0.000 0.083 1.000
history write04:13:08.951 17.6%2115099 2.718 7.181 398.188
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle08:08:28.001 33.9%49716425 0.095 0.590 1.222
nntp read01:25:34.905 5.9%77948137 0.037 0.066 0.084
overview write00:00:13.676 0.0%2112722 0.003 0.006 0.008
perl filter05:36:00.705 23.3%2115092 5.237 9.532 11.555
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:05:48.852 0.4%4516410 0.048 0.077 0.097
TOTAL: 24:00:07.49123:27:32.420 97.7%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:02.355 0.0%622774 0.001 0.004 0.008
article prepare00:00:00.135 0.0%401766 0.000 0.000 0.003
article read00:05:35.886 0.4%87901 0.300 3.821 862.480
backlog stats00:00:02.379 0.0%2116473 0.000 0.001 0.003
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:32.678 0.0%1131735 0.010 0.029 0.049
data write00:06:59.552 0.5%1103895 0.041 0.380 0.883
idle23:30:21.279 98.6%2116473 6.195 39.982 372.577
status file00:05:50.113 0.4%16221 0.400 21.584 1760.647
TOTAL: 23:50:48.93623:49:24.377 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:24:32.794 99.8%3430 0.000 2528.511288377.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.633 0.0%8015 0.000 0.079 7.000
readart00:00:01.154 0.0%197 0.000 5.858 31.667
TOTAL: 02:24:52.79802:24:34.581 99.8%----

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
hun-mnt@news.sztaki.hu000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 637 21102272104151 3215 2861 99%503:46:04
2news.nask.pl 34 209017 9412 187775 11830 4%29:55:16
3news.icm.edu.pl 49 223 94 111 18 42%15:54:04
4localhost 11 10 10 0 0 100%00:00:00
TOTAL: 4 731 23194772113667 191101 14709 91%549:35:24
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl744.7 GB481.7 MB489.0 MB745.7 GB 99%371.1 KB
2news.nask.pl2.3 GB4.2 GB4.2 GB10.6 GB 21%525.0 KB
3news.icm.edu.pl1.5 MB97.1 KB246.0 KB1.8 MB 81%16.4 KB
4localhost15.0 KB0.0 KB0.0 KB15.0 KB100%1.5 KB
TOTAL: 4747.0 GB4.6 GB4.7 GB756.3 GB 98%372.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 2 04:15:03 - 04:59:59 78297 3.7% 29.0330.4 GB 4.1%11800.12
Oct 2 05:00:00 - 05:59:59 102735 4.9% 28.5439.6 GB 5.3%11522.65
Oct 2 06:00:00 - 06:59:59 103923 4.9% 28.8737.9 GB 5.1%11052.31
Oct 2 07:00:00 - 07:59:59 90579 4.3% 25.1633.8 GB 4.5%9833.67
Oct 2 08:00:00 - 08:59:59 81462 3.9% 22.6329.1 GB 3.9%8468.09
Oct 2 09:00:00 - 09:59:59 75110 3.6% 20.8629.5 GB 4.0%8596.99
Oct 2 10:00:00 - 10:59:59 89448 4.2% 24.8530.5 GB 4.1%8882.66
Oct 2 11:00:00 - 11:59:59 81646 3.9% 22.6826.5 GB 3.6%7729.25
Oct 2 12:00:00 - 12:59:59 80024 3.8% 22.2326.6 GB 3.6%7739.66
Oct 2 13:00:00 - 13:59:59 93786 4.4% 26.0532.2 GB 4.3%9390.62
Oct 2 14:00:00 - 14:59:59 111878 5.3% 31.0838.7 GB 5.2%11281.64
Oct 2 15:00:00 - 15:59:59 101230 4.8% 28.1233.8 GB 4.5%9851.84
Oct 2 16:00:00 - 16:59:59 90549 4.3% 25.1530.9 GB 4.1%8994.24
Oct 2 17:00:00 - 17:59:59 78459 3.7% 21.7927.5 GB 3.7%8006.30
Oct 2 18:00:00 - 18:59:59 66608 3.2% 18.5025.5 GB 3.4%7437.87
Oct 2 19:00:00 - 19:59:59 73372 3.5% 20.3826.9 GB 3.6%7845.69
Oct 2 20:00:00 - 20:59:59 72345 3.4% 20.1025.0 GB 3.3%7276.42
Oct 2 21:00:00 - 21:59:59 87558 4.1% 24.3230.5 GB 4.1%8896.17
Oct 2 22:00:00 - 22:59:59 97509 4.6% 27.0932.7 GB 4.4%9517.19
Oct 2 23:00:00 - 23:59:59 102671 4.9% 28.5232.8 GB 4.4%9550.01
Oct 3 00:00:00 - 00:59:59 90406 4.3% 25.1128.2 GB 3.8%8199.98
Oct 3 01:00:00 - 01:59:59 85646 4.1% 23.7933.7 GB 4.5%9817.28
Oct 3 02:00:00 - 02:59:59 68090 3.2% 18.9123.2 GB 3.1%6747.58
Oct 3 03:00:00 - 03:59:59 88899 4.2% 24.6933.9 GB 4.5%9868.40
Oct 3 04:00:00 - 04:15:02 21512 1.0% 23.857.5 GB 1.0%8767.16
TOTAL: 23:59:59 2113742 100.0% 24.46746.9 GB 100.0%9064.41
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 11932 12 0 9620 7 0 0 0 2293
2newsfeed.pionier.net.pl 3352 97 0 2642 4 0 0 0 609
3news.icm.edu.pl 21 0 0 7 1 0 0 0 13
TOTAL: 3 15305 109 0 12269 12 0 0 0 2915

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 46
comp.mobile.android 19
it.tlc.cellulari.android 18
it.comp.os.win.windows10 16
comp.sys.raspberry-pi 5
de.comp.lang.vbclassic 4
it.comp.os.win.windows7 1
TOTAL: 7 109

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

GroupsCount
pl.praca.oferowana 6
courts.usa.federal.supreme 3
pl.sci.matematyka 2
bit.listserv.catholic 1
TOTAL: 4 12

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2017
Binary in non-binary group 170
EMP (phl) 28
Scoring filter (8) 11
Scoring filter (9) 8
Scoring filter (16) 5
HTML post 5
Scoring filter (18) 4
Scoring filter (13) 2
Scoring filter (11) 2
Scoring filter (10) 2
Scoring filter (12) 1
TOTAL: 12 2255

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
newsfeed.pionier.net.pl 7
TOTAL: 1 7
Bad command received
news.nask.pl 176
TOTAL: 1 176
Including strange strings
newsfeed.pionier.net.pl 493
news.nask.pl 155
news.icm.edu.pl 3
TOTAL: 3 651
TOTAL: 3 834

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nask 398048 66103 205548 796 0 5372 16%23:59:56
2panorama 362450 6499 327571 1319 7 284091 1%23:59:56
3poznan 6762 119 4986 23 0 0 1%23:47:57
4icm 328084 30 264422 25787 0 28 0%23:59:56
5okapi 0 0 0 0 0 1023 0%23:57:49
TOTAL: 51095344 72751 802527 27925 7 290514 6%119:45:34
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask33.9 GB427.8 MB34.3 GB416.8 KB/s538.3 KB23:59:56
2panorama2.3 GB67.0 MB2.4 GB29.1 KB/s321.9 KB23:59:56
3icm5.0 MB12.2 GB12.3 GB148.7 KB/s497.7 KB23:59:56
4poznan568.8 KB84.1 KB652.9 KB0.0 KB/s4.6 KB23:47:57
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:49
TOTAL: 536.3 GB12.7 GB49.0 GB119.2 KB/s510.3 KB119:45:34
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama1.9 MB
TOTAL: 11.9 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1185.40.113.3 30 129129.2 KB 16 0 002:24:04
2web.man.lodz.pl 288 6865.1 KB 30 0 000:00:29
3isvcs01.man.lodz.pl 10 00.0 KB 0 10 000:00:01
TOTAL: 3 328 197194.3 KB 46 10 002:24:51

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 127 129129.2 KB 16 0 002:24:15
2*.man.lodz.pl 586 6865.1 KB 30 10 000:00:36
TOTAL: 2 713 197194.3 KB 46 10 002:24:51

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
185.40.113.3 0.780 0.824 0.00002:24:04
web.man.lodz.pl 1.780 6.660 0.00000:00:29
162.243.150.10 0.004 0.024 0.00000:00:09
mon.man.lodz.pl 1.572 6.596 0.00000:00:04
212.51.192.185 0.584 2.360 0.00000:00:01
isvcs01.man.lodz.pl 0.092 0.260 0.00000:00:01
TOTAL: 6 4.812 16.724 0.00002:24:51

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
162.243.150.10 1
TOTAL: 3 385

Newsgroup request counts (by category):

CategoryCountPct
1lodz 110 55.8%
2pl 68 34.5%
3lodman 15 7.6%
4lodzman 4 2.0%
TOTAL: 4 197100.0%

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

NewsgroupCount
1lodz.test 105
2pl.comp.pecet 42
3pl.comp.os.ms-windows.winnt 26
4lodman.test 15
5lodz.ogloszenia 5
6lodzman.test 4
TOTAL: 6 197