Daily Usenet report

Dec 5 04:15:02 -- Dec 6 04:15:02

Unknown entries from news log file:

First 15 / 15 lines (100.0%)

Dec 5 05:58:04 newsfeed overchan[18070]: input line too long, skipping
Dec 5 07:08:04 newsfeed overchan[18070]: input line too long, skipping
Dec 5 09:23:02 newsfeed nnrpd[1531]: SERVER perl filter not defined
Dec 5 09:45:02 newsfeed pgpverify[4884]: pgpverify: verification failed
Dec 5 14:51:11 newsfeed overchan[18070]: input line too long, skipping
Dec 5 15:11:33 newsfeed overchan[18070]: input line too long, skipping
Dec 5 17:16:55 newsfeed nnrpd[9510]: SERVER perl filter not defined
Dec 5 17:31:32 newsfeed overchan[18070]: input line too long, skipping
Dec 5 19:42:28 newsfeed overchan[18070]: input line too long, skipping
Dec 5 19:49:01 newsfeed overchan[18070]: input line too long, skipping
Dec 5 19:57:45 newsfeed overchan[18070]: input line too long, skipping
Dec 5 23:53:17 newsfeed overchan[18070]: input line too long, skipping
Dec 6 00:10:44 newsfeed overchan[18070]: input line too long, skipping
Dec 6 03:22:51 newsfeed overchan[18070]: input line too long, skipping
Dec 6 03:33:54 newsfeed overchan[18070]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 802243 95.2%87.9 MB 94.5%
innfeed 26843 3.2%3.2 MB 3.4%
innd 9763 1.2%1.5 MB 1.6%
nnrpd 4233 0.5%419.7 KB 0.4%
controlchan 12 0.0%2.2 KB 0.0%
overchan 12 0.0%2.0 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 7 843107 100.0%92.9 MB100.0%

History cache:

ReasonCount%Count
Do not exist 797736 99.7%
Negative hits 1740 0.2%
Positive hits 243 0.0%
Cache misses 45 0.0%
TOTAL: 4 799764 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.545 0.0%78 0.000 19.808 180.000
article cleanup00:00:12.348 0.0%801892 0.011 0.015 0.021
article logging00:00:39.823 0.0%802277 0.042 0.050 0.062
article parse00:24:09.804 1.7%62834383 0.016 0.023 0.028
article write00:08:51.472 0.6%801655 0.531 0.663 0.933
artlog/artcncl00:00:00.002 0.0%77 0.000 0.026 1.000
data move00:00:56.607 0.1%67846476 0.001 0.001 0.001
hisgrep/artcncl00:00:00.449 0.0%76 0.000 5.908 38.333
hishave/artcncl00:00:00.046 0.0%78 0.000 0.590 3.667
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:19:22.769 1.3%803961 0.405 1.446 6.852
history sync00:00:00.026 0.0%290 0.000 0.090 1.000
history write00:20:22.083 1.4%801853 0.441 1.524 6.435
hiswrite/artcncl00:00:00.003 0.0%2 0.000 1.500 3.000
idle20:22:26.506 84.9%62369031 0.856 1.176 1.758
nntp read00:45:28.334 3.2%62484135 0.033 0.044 0.052
overview write00:00:04.561 0.0%801655 0.003 0.006 0.009
perl filter01:17:54.337 5.4%801853 4.893 5.829 8.065
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:44.099 0.1%1616492 0.023 0.027 0.033
TOTAL: 24:00:03.99223:41:14.814 98.7%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.130 0.0%38433 0.000 0.003 0.015
article prepare00:00:00.000 0.0%1732 0.000 0.000 0.000
article read00:00:00.477 0.0%433 0.000 1.102 61.500
backlog stats00:00:00.106 0.0%97008 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.963 0.0%47710 0.000 0.020 0.043
data write00:00:02.449 0.0%34685 0.027 0.071 0.136
idle23:54:28.131100.0%97008 510.967 887.227 1826.620
status file00:00:24.474 0.0%8685 0.767 2.818 173.542
TOTAL: 23:55:03.45523:54:56.730100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle04:00:17.699 99.9%3053 0.000 4722.469900143.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.343 0.0%6722 0.000 0.051 2.421
readart00:00:00.001 0.0%20 0.000 0.050 0.500
TOTAL: 04:00:34.14404:00:18.043 99.9%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de001101
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 132 801560 801398 0 162 99%79:36:19
2news.icm.edu.pl 46 300 47 175 78 15%16:48:05
3localhost 1443 2 2 0 0 100%00:00:00
TOTAL: 3 1621 801862 801447 175 240 99%96:24:24
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl296.0 GB1.4 MB1.8 MB296.0 GB 99%387.3 KB
2news.icm.edu.pl1.6 MB111.4 KB2.8 MB4.6 MB 35%37.6 KB
3localhost2.6 KB0.0 KB0.0 KB2.6 KB100%1.3 KB
TOTAL: 3296.0 GB1.5 MB4.6 MB296.0 GB 99%387.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 5 04:15:02 - 04:59:59 20609 2.6% 7.647.8 GB 2.6%3040.08
Dec 5 05:00:00 - 05:59:59 30354 3.8% 8.4312.0 GB 4.0%3490.58
Dec 5 06:00:00 - 06:59:59 30497 3.8% 8.4711.9 GB 4.0%3476.89
Dec 5 07:00:00 - 07:59:59 26068 3.3% 7.2411.7 GB 3.9%3407.79
Dec 5 08:00:00 - 08:59:59 31461 3.9% 8.7412.0 GB 4.0%3482.31
Dec 5 09:00:00 - 09:59:59 33896 4.2% 9.4212.2 GB 4.1%3560.09
Dec 5 10:00:00 - 10:59:59 36611 4.6% 10.1713.2 GB 4.4%3832.96
Dec 5 11:00:00 - 11:59:59 39692 5.0% 11.0314.6 GB 4.9%4239.12
Dec 5 12:00:00 - 12:59:59 34102 4.3% 9.4713.3 GB 4.5%3859.83
Dec 5 13:00:00 - 13:59:59 34231 4.3% 9.5112.9 GB 4.3%3751.60
Dec 5 14:00:00 - 14:59:59 35942 4.5% 9.9813.3 GB 4.5%3864.74
Dec 5 15:00:00 - 15:59:59 34372 4.3% 9.5513.1 GB 4.4%3801.97
Dec 5 16:00:00 - 16:59:59 34520 4.3% 9.5912.9 GB 4.3%3746.20
Dec 5 17:00:00 - 17:59:59 32838 4.1% 9.1211.8 GB 4.0%3428.30
Dec 5 18:00:00 - 18:59:59 31939 4.0% 8.8711.9 GB 4.0%3461.11
Dec 5 19:00:00 - 19:59:59 34145 4.3% 9.4812.5 GB 4.2%3628.24
Dec 5 20:00:00 - 20:59:59 35361 4.4% 9.8212.6 GB 4.2%3675.53
Dec 5 21:00:00 - 21:59:59 39155 4.9% 10.8814.1 GB 4.7%4093.64
Dec 5 22:00:00 - 22:59:59 35258 4.4% 9.7911.2 GB 3.8%3262.67
Dec 5 23:00:00 - 23:59:59 35567 4.4% 9.8812.4 GB 4.2%3623.22
Dec 6 00:00:00 - 00:59:59 33679 4.2% 9.3613.6 GB 4.6%3967.95
Dec 6 01:00:00 - 01:59:59 28854 3.6% 8.0212.6 GB 4.3%3675.99
Dec 6 02:00:00 - 02:59:59 35737 4.5% 9.9310.5 GB 3.5%3058.71
Dec 6 03:00:00 - 03:59:59 28885 3.6% 8.0210.0 GB 3.4%2912.84
Dec 6 04:00:00 - 04:15:02 7770 1.0% 8.613.1 GB 1.1%3628.34
TOTAL: 24:00:00 801543 100.0% 9.28296.9 GB 100.0%3603.74
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 546 114 0 35 12 0 0 0 385
2news.icm.edu.pl 77 0 0 4 0 0 0 0 73
TOTAL: 2 623 114 0 39 12 0 0 0 458

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 45
it.tlc.cellulari.android 35
comp.mobile.android 10
comp.sys.raspberry-pi 8
comp.mobile.ipad 7
nl.comp.os.linux.techniek 2
nl.comp.sys.android 1
nl.actueel 1
de.comm.software.mailreader 1
nl.gezondheid.alternatief-genezen 1
nl.wetenschap.regulier 1
nl.comp.3d-printen 1
it.comp.os.win.windows10 1
TOTAL: 13 114

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

GroupsCount
pl.praca.oferowana 12
TOTAL: 1 12

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 66
Binary in non-binary group 5
Too many newsgroups 2
TOTAL: 3 73

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 384
news.icm.edu.pl 1
TOTAL: 2 385
TOTAL: 1 385

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 21101 300 12544 25 0 0 1%23:59:42
2panorama 25456 0 11327 16 0 27193 0%23:59:52
3okapi 0 0 0 0 0 1143 0%23:57:45
4nask 0 0 0 0 0 8592 0%23:57:43
5poznan 46 0 29 1 0 0 0%03:46:28
TOTAL: 5 46603 300 23900 42 0 36928 0%99:41:30
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm1.2 MB116.5 KB1.3 MB0.0 KB/s4.0 KB23:59:42
2panorama0.0 KB108.3 KB108.3 KB0.0 KB/s6.8 KB23:59:52
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:45
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:43
5poznan0.0 KB42.8 KB42.8 KB0.0 KB/s42.8 KB03:46:28
TOTAL: 51.2 MB267.5 KB1.4 MB0.0 KB/s4.2 KB99:41:30
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.3 KB
TOTAL: 1488.3 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 2019.0 KB 9 0 000:00:21
2isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:00
35.226.139.227 9 00.0 KB 0 0 403:00:01
4185.246.208.180 2 00.0 KB 0 0 101:00:00
TOTAL: 4 301 2019.0 KB 9 2 504:00:33

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 578 2019.0 KB 9 2 000:00:25
2unresolved 111 00.0 KB 0 0 504:00:08
TOTAL: 2 689 2019.0 KB 9 2 504:00:33

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
5.226.139.227 0.069 0.087 0.00003:00:01
185.246.208.180 0.003 0.029 0.00001:00:00
web.man.lodz.pl 1.996 4.235 0.00000:00:21
80.111.142.213 0.048 0.028 0.00000:00:05
mon.man.lodz.pl 1.505 2.858 0.00000:00:03
212.51.192.185 0.469 0.897 0.00000:00:01
isvcs01.man.lodz.pl 0.015 0.044 0.00000:00:00
TOTAL: 7 4.105 8.178 0.00004:00:33

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
TOTAL: 3 388

NNRP client timeouts [Top 20]:

SystemConnPeer
5.226.139.227 6 0
185.246.208.180 2 0
TOTAL: 2 8 0

Newsgroup request counts (by category):

CategoryCountPct
1pl 20100.0%
TOTAL: 1 20100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 16
2pl.comp.pecet 4
TOTAL: 2 20