Daily Usenet report

Feb 17 04:15:02 -- Feb 18 04:15:02

Unknown entries from news log file:

First 18 / 18 lines (100.0%)

Feb 17 04:21:27 newsfeed overchan[26514]: input line too long, skipping
Feb 17 05:05:22 newsfeed overchan[26514]: input line too long, skipping
Feb 17 06:54:32 newsfeed overchan[26514]: input line too long, skipping
Feb 17 07:27:37 newsfeed overchan[26514]: input line too long, skipping
Feb 17 07:27:53 newsfeed overchan[26514]: input line too long, skipping
Feb 17 07:28:07 newsfeed overchan[26514]: input line too long, skipping
Feb 17 10:28:34 newsfeed overchan[26514]: input line too long, skipping
Feb 17 13:10:02 newsfeed pgpverify[14894]: pgpverify: verification failed
Feb 17 14:04:53 newsfeed overchan[26514]: input line too long, skipping
Feb 17 15:05:05 newsfeed overchan[26514]: input line too long, skipping
Feb 17 15:42:32 newsfeed overchan[26514]: input line too long, skipping
Feb 17 15:56:45 newsfeed overchan[26514]: input line too long, skipping
Feb 17 15:57:18 newsfeed overchan[26514]: input line too long, skipping
Feb 17 15:59:29 newsfeed overchan[26514]: input line too long, skipping
Feb 17 16:00:47 newsfeed overchan[26514]: input line too long, skipping
Feb 17 17:57:49 newsfeed overchan[26514]: input line too long, skipping
Feb 18 00:55:00 newsfeed overchan[26514]: input line too long, skipping
Feb 18 02:24:47 newsfeed overchan[26514]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2642573 97.7%300.2 MB 97.3%
innfeed 41125 1.5%4.9 MB 1.6%
innd 17522 0.6%2.9 MB 0.9%
nnrpd 4758 0.2%501.0 KB 0.2%
overchan 18 0.0%2.8 KB 0.0%
controlchan 4 0.0%0.5 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 72706001 100.0%308.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2615044 96.8%
Negative hits 73756 2.7%
Positive hits 11496 0.4%
Cache misses 102 0.0%
TOTAL: 4 2700398 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.778 0.0%156 0.000 11.397 976.000
article cleanup00:00:37.595 0.0%2642429 0.009 0.014 0.020
article logging00:02:02.493 0.1%2643003 0.033 0.046 0.147
article parse00:42:13.907 2.9%85713696 0.018 0.030 0.043
article write00:15:12.719 1.1%2635273 0.155 0.346 0.589
artlog/artcncl00:00:00.004 0.0%149 0.000 0.027 1.000
artlog/artparse00:00:00.000 0.0%3 0.000 0.000 0.000
data move00:01:42.910 0.1%98763788 0.001 0.001 0.002
hisgrep/artcncl00:00:00.218 0.0%153 0.000 1.425 13.000
hishave/artcncl00:00:00.068 0.0%156 0.000 0.436 4.071
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:28:46.536 2.0%2724599 0.038 0.634 5.539
history sync00:00:00.021 0.0%290 0.000 0.072 1.000
history write01:31:32.800 6.4%2637686 0.197 2.082 8.164
hiswrite/artcncl00:00:00.021 0.0%3 0.000 7.000 10.500
idle14:46:55.531 61.6%71085103 0.342 0.749 2.669
nntp read00:58:58.435 4.1%83657607 0.028 0.042 0.053
overview write00:00:15.076 0.0%2635273 0.004 0.006 0.010
perl filter04:32:45.308 18.9%2637683 2.442 6.204 8.035
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:06:09.802 0.4%5288645 0.043 0.070 0.101
TOTAL: 24:00:02.92223:27:15.222 97.7%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.221 0.0%82520 0.000 0.003 0.029
article prepare00:00:00.008 0.0%46626 0.000 0.000 0.025
article read00:01:52.920 0.1%11646 0.036 9.696 236.250
backlog stats00:00:00.166 0.0%205753 0.000 0.001 0.006
callbacks00:00:00.000 0.0%29 0.000 0.000 0.000
data read00:00:01.793 0.0%107904 0.005 0.017 0.039
data write00:00:04.806 0.0%90071 0.028 0.053 0.091
idle23:52:00.773 99.8%205753 13.847 417.592 996.449
status file00:00:14.562 0.0%15348 0.000 0.949 4.000
TOTAL: 23:54:26.34223:54:15.249100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:28.210 73.0%3024 0.000 9.329 9663.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.252 0.7%6716 0.000 0.038 0.667
readart00:00:00.005 0.0%46 0.000 0.109 1.500
TOTAL: 00:00:38.66400:00:28.467 73.6%----

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
newsmaster@carnet.hr000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 305 26337802623655 5614 4511 99%146:19:21
2news.nask.pl 2 14627 11094 913 2620 75%23:57:18
3news.icm.edu.pl 43 262 18 221 23 6%17:28:07
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 351 26486692634767 6748 7154 99%187:44:46
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl541.1 GB25.6 MB26.7 MB541.1 GB 99%215.9 KB
2news.nask.pl54.3 MB2.7 MB19.3 MB76.3 MB 71%5.7 KB
3news.icm.edu.pl427.5 KB94.3 KB1.5 MB2.0 MB 21%49.5 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 4541.1 GB28.4 MB47.5 MB541.2 GB 99%214.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 17 04:15:02 - 04:59:59 86478 3.3% 32.0515.3 GB 2.8%5929.15
Feb 17 05:00:00 - 05:59:59 100341 3.8% 27.8715.2 GB 2.8%4431.53
Feb 17 06:00:00 - 06:59:59 190290 7.2% 52.8621.8 GB 4.0%6338.48
Feb 17 07:00:00 - 07:59:59 59590 2.3% 16.5512.2 GB 2.2%3547.17
Feb 17 08:00:00 - 08:59:59 109149 4.1% 30.3232.6 GB 6.0%9493.09
Feb 17 09:00:00 - 09:59:59 97032 3.7% 26.9529.6 GB 5.5%8612.79
Feb 17 10:00:00 - 10:59:59 119650 4.5% 33.2427.4 GB 5.1%7980.22
Feb 17 11:00:00 - 11:59:59 82223 3.1% 22.8414.7 GB 2.7%4273.06
Feb 17 12:00:00 - 12:59:59 76858 2.9% 21.3514.5 GB 2.7%4221.56
Feb 17 13:00:00 - 13:59:59 73927 2.8% 20.5415.0 GB 2.8%4356.74
Feb 17 14:00:00 - 14:59:59 66158 2.5% 18.3815.5 GB 2.9%4519.67
Feb 17 15:00:00 - 15:59:59 62243 2.4% 17.2915.0 GB 2.8%4376.82
Feb 17 16:00:00 - 16:59:59 69800 2.6% 19.3915.8 GB 2.9%4607.70
Feb 17 17:00:00 - 17:59:59 106472 4.0% 29.5827.0 GB 5.0%7863.78
Feb 17 18:00:00 - 18:59:59 152735 5.8% 42.4330.8 GB 5.7%8964.47
Feb 17 19:00:00 - 19:59:59 157132 6.0% 43.6532.4 GB 6.0%9423.02
Feb 17 20:00:00 - 20:59:59 145441 5.5% 40.4029.7 GB 5.5%8658.99
Feb 17 21:00:00 - 21:59:59 110791 4.2% 30.7825.6 GB 4.7%7451.79
Feb 17 22:00:00 - 22:59:59 147071 5.6% 40.8527.5 GB 5.1%8016.24
Feb 17 23:00:00 - 23:59:59 84789 3.2% 23.5518.3 GB 3.4%5336.96
Feb 18 00:00:00 - 00:59:59 119719 4.5% 33.2617.8 GB 3.3%5188.32
Feb 18 01:00:00 - 01:59:59 129869 4.9% 36.0726.1 GB 4.8%7592.94
Feb 18 02:00:00 - 02:59:59 157195 6.0% 43.6731.2 GB 5.8%9101.53
Feb 18 03:00:00 - 03:59:59 101859 3.9% 28.2924.3 GB 4.5%7076.25
Feb 18 04:00:00 - 04:15:02 27874 1.1% 30.906.6 GB 1.2%7656.25
TOTAL: 24:00:00 2634686 100.0% 30.49541.7 GB 100.0%6574.79
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 4830 85 0 4368 2 0 0 0 375
2news.nask.pl 2883 31 0 376 2 0 0 0 2474
3news.icm.edu.pl 25 0 0 2 0 0 0 0 23
TOTAL: 3 7738 116 0 4746 4 0 0 0 2872

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 59
comp.mobile.android 20
it.tlc.cellulari.android 15
comp.sys.raspberry-pi 5
de.comp.office-pakete.ms-office.word 4
de.rec.sf.startrek 3
it.comp.os.win.windows10 3
it.comp.os.win.windows7 2
de.comp.lang.vbclassic 2
alt.sex.telephones 2
it.discussioni.energia 1
TOTAL: 11 116

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

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

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2148
Binary in non-binary group 99
Scoring filter (8) 25
Scoring filter (9) 9
Scoring filter (16) 6
HTML post 5
Scoring filter (18) 1
Scoring filter (10) 1
Excessively crossposted test article 1
TOTAL: 9 2295

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 331
news.nask.pl 241
news.icm.edu.pl 2
TOTAL: 3 574
TOTAL: 1 574

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 70558 5703 34901 4441 83 37426 8%23:59:58
2poznan 18579 551 10536 27 0 1 2%23:59:58
3icm 23597 30 17859 2 0 1 0%23:59:56
4nask 2406 4 1624 1 0 0 0%23:52:25
5okapi 0 0 0 0 0 1102 0%23:57:51
TOTAL: 5 115140 6288 64920 4471 83 38530 5%119:50:08
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama42.0 MB22.1 MB64.1 MB0.8 KB/s6.5 KB23:59:58
2icm2.7 MB76.9 KB2.8 MB0.0 KB/s89.4 KB23:59:56
3poznan2.6 MB329.2 KB2.9 MB0.0 KB/s5.1 KB23:59:58
4nask5.4 KB1.9 KB7.4 KB0.0 KB/s1.5 KB23:52:25
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
TOTAL: 547.3 MB22.5 MB69.8 MB0.2 KB/s6.6 KB119:50:08
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 4649.8 KB 22 0 000:00:21
TOTAL: 1 288 4649.8 KB 22 0 000:00:37

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 672 4649.8 KB 22 0 000:00:25
2unresolved 2 00.0 KB 0 0 000:00:12
TOTAL: 2 674 4649.8 KB 22 0 000:00:37

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.400 6.100 0.00000:00:21
107.170.234.222 0.008 0.032 0.00000:00:09
mon.man.lodz.pl 1.388 6.404 0.00000:00:03
71.6.146.130 0.004 0.028 0.00000:00:02
david.man.lodz.pl 0.428 2.232 0.00000:00:01
TOTAL: 5 3.228 14.796 0.00000:00:37

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
107.170.234.222 1
71.6.146.130 1
TOTAL: 4 386

Newsgroup request counts (by category):

CategoryCountPct
1pl 46100.0%
TOTAL: 1 46100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 46
TOTAL: 1 46