Daily Usenet report

Jul 15 04:15:04 -- Jul 16 04:15:03

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

Jul 15 08:46:55 newsfeed nnrpd[12598]: SERVER perl filter not defined
Jul 15 15:55:49 newsfeed overchan[8021]: input line too long, skipping
Jul 15 16:11:48 newsfeed overchan[8021]: input line too long, skipping
Jul 15 16:58:09 newsfeed overchan[8021]: input line too long, skipping
Jul 15 17:00:07 newsfeed pgpverify[14266]: pgpverify: verification failed
Jul 15 17:20:51 newsfeed overchan[8021]: input line too long, skipping
Jul 15 17:30:06 newsfeed overchan[8021]: input line too long, skipping
Jul 15 20:58:03 newsfeed overchan[8021]: input line too long, skipping
Jul 15 21:35:07 newsfeed overchan[8021]: input line too long, skipping
Jul 16 00:50:15 newsfeed overchan[8021]: input line too long, skipping
Jul 16 01:15:53 newsfeed overchan[8021]: input line too long, skipping
Jul 16 01:44:52 newsfeed overchan[8021]: input line too long, skipping
Jul 16 02:42:36 newsfeed overchan[8021]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 529471 89.7%57.9 MB 88.7%
innfeed 46680 7.9%5.5 MB 8.4%
innd 9229 1.6%1.4 MB 2.1%
nnrpd 4886 0.8%519.8 KB 0.8%
overchan 12 0.0%1.8 KB 0.0%
controlchan 4 0.0%0.5 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 7 590283 100.0%65.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 526684 98.9%
Negative hits 5429 1.0%
Positive hits 365 0.1%
Cache misses 56 0.0%
TOTAL: 4 532534 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:10.481 0.0%152 0.000 68.954 820.000
article cleanup00:00:07.763 0.0%529066 0.010 0.015 0.020
article logging00:00:28.032 0.0%529501 0.044 0.053 0.066
article parse00:17:17.641 1.2%33599476 0.023 0.031 0.036
article write00:07:37.285 0.5%528756 0.611 0.865 3.396
artlog/artcncl00:00:00.008 0.0%152 0.000 0.053 1.000
data move00:00:38.273 0.0%37578088 0.001 0.001 0.002
hisgrep/artcncl00:00:01.422 0.0%141 0.000 10.085 61.091
hishave/artcncl00:00:01.172 0.0%152 0.000 7.711 80.900
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup02:19:00.418 9.7%535092 7.902 15.587 37.947
history sync00:00:00.022 0.0%291 0.000 0.076 0.500
history write02:20:15.617 9.7%529011 10.533 15.908 55.879
hiswrite/artcncl00:00:00.035 0.0%11 0.000 3.182 15.000
idle16:53:23.612 70.4%30472449 1.526 1.995 3.376
nntp read00:29:07.316 2.0%33230070 0.042 0.053 0.059
overview write00:00:02.980 0.0%528756 0.003 0.006 0.009
perl filter01:19:44.419 5.5%529011 6.986 9.044 10.326
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:32.853 0.0%1072756 0.024 0.031 0.037
TOTAL: 24:00:03.71623:48:29.349 99.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.160 0.0%52870 0.000 0.003 0.012
article prepare00:00:00.003 0.0%5398 0.000 0.001 0.031
article read00:00:48.973 0.1%1347 0.200 36.357 750.500
backlog stats00:00:00.097 0.0%111744 0.000 0.001 0.009
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:01.217 0.0%56967 0.006 0.021 0.050
data write00:00:02.833 0.0%41893 0.028 0.068 0.112
idle23:52:00.602 99.9%111744 500.812 768.906 1259.813
status file00:00:50.912 0.1%16480 0.798 3.089 79.608
TOTAL: 23:53:53.29323:53:44.797100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:40.595 75.6%3039 0.000 13.358 9749.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.308 0.6%6739 0.000 0.046 0.895
readart00:00:00.000 0.0%22 0.000 0.000 0.000
TOTAL: 00:00:53.68300:00:40.903 76.2%----

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
group-admin@isc.org000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 368 528737 528456 0 281 99%178:52:05
2news.icm.edu.pl 36 291 33 228 30 11%15:47:21
3localhost 1441 1 1 0 0 100%00:00:16
TOTAL: 3 1845 529029 528490 228 311 99%194:39:42
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl271.3 GB2.6 MB3.2 MB271.3 GB 99%538.1 KB
2news.icm.edu.pl2.2 MB353.4 KB556.4 KB3.1 MB 71%50.8 KB
3localhost1.4 KB0.0 KB0.0 KB1.4 KB100%1.4 KB
TOTAL: 3271.3 GB2.9 MB3.7 MB271.3 GB 99%538.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 15 04:15:04 - 04:59:59 14873 2.8% 5.528.1 GB 3.0%3156.03
Jul 15 05:00:00 - 05:59:59 22475 4.3% 6.2412.8 GB 4.7%3741.53
Jul 15 06:00:00 - 06:59:59 21489 4.1% 5.9711.1 GB 4.1%3226.51
Jul 15 07:00:00 - 07:59:59 22899 4.3% 6.3613.0 GB 4.8%3772.03
Jul 15 08:00:00 - 08:59:59 20091 3.8% 5.5810.9 GB 4.0%3181.98
Jul 15 09:00:00 - 09:59:59 20869 3.9% 5.8011.1 GB 4.1%3246.16
Jul 15 10:00:00 - 10:59:59 20992 4.0% 5.8311.0 GB 4.1%3215.55
Jul 15 11:00:00 - 11:59:59 21979 4.2% 6.1111.4 GB 4.2%3315.06
Jul 15 12:00:00 - 12:59:59 24121 4.6% 6.7012.5 GB 4.6%3629.95
Jul 15 13:00:00 - 13:59:59 22356 4.2% 6.2111.4 GB 4.2%3327.30
Jul 15 14:00:00 - 14:59:59 23127 4.4% 6.4211.1 GB 4.1%3246.61
Jul 15 15:00:00 - 15:59:59 23156 4.4% 6.4311.5 GB 4.2%3341.51
Jul 15 16:00:00 - 16:59:59 24919 4.7% 6.9212.0 GB 4.4%3500.29
Jul 15 17:00:00 - 17:59:59 23913 4.5% 6.6411.7 GB 4.3%3398.18
Jul 15 18:00:00 - 18:59:59 22979 4.3% 6.3811.2 GB 4.1%3271.05
Jul 15 19:00:00 - 19:59:59 20638 3.9% 5.7310.0 GB 3.7%2920.05
Jul 15 20:00:00 - 20:59:59 21467 4.1% 5.9610.4 GB 3.8%3041.66
Jul 15 21:00:00 - 21:59:59 26200 5.0% 7.2812.7 GB 4.7%3687.37
Jul 15 22:00:00 - 22:59:59 21645 4.1% 6.0111.2 GB 4.1%3265.89
Jul 15 23:00:00 - 23:59:59 21838 4.1% 6.0711.7 GB 4.3%3417.74
Jul 16 00:00:00 - 00:59:59 23009 4.4% 6.3912.0 GB 4.4%3484.12
Jul 16 01:00:00 - 01:59:59 19429 3.7% 5.4010.1 GB 3.7%2944.48
Jul 16 02:00:00 - 02:59:59 19622 3.7% 5.459.4 GB 3.5%2751.57
Jul 16 03:00:00 - 03:59:59 20335 3.8% 5.6511.0 GB 4.0%3202.05
Jul 16 04:00:00 - 04:15:03 4150 0.8% 4.602.2 GB 0.8%2575.32
TOTAL: 23:59:59 528571 100.0% 6.12271.7 GB 100.0%3297.46
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 717 242 0 36 4 0 0 0 435
2news.icm.edu.pl 30 0 0 19 0 0 0 0 11
TOTAL: 2 747 242 0 55 4 0 0 0 446

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 169
it.comp.os.win.windows10 22
comp.mobile.android 20
it.comp.os.win.windows7 9
comp.sys.raspberry-pi 7
nl.comp.os.linux.techniek 5
it.tlc.cellulari.android 4
de.comp.office-pakete.ms-office.excel 3
comp.mobile.ipad 2
uk.rec.cycling.moderated 1
TOTAL: 10 242

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

GroupsCount
pl.praca.oferowana 4
TOTAL: 1 4

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 4
Scoring filter (9) 2
Scoring filter (10) 1
Scoring filter (14) 1
Scoring filter (8) 1
Too many newsgroups 1
TOTAL: 6 10

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 41453 543 13408 174 3 38962 1%23:59:56
2icm 18535 22 15011 3 0 0 0%23:50:17
3okapi 0 0 0 0 0 907 0%23:57:49
4nask 0 0 0 0 0 10592 0%23:57:49
5poznan 15 0 13 0 0 0 0%01:45:16
TOTAL: 5 60003 565 28432 177 3 50461 0%97:31:07
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama1.6 MB673.5 KB2.3 MB0.0 KB/s3.2 KB23:59:56
2icm71.8 KB6.8 KB78.6 KB0.0 KB/s3.1 KB23:50:17
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:49
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:49
5poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:45:16
TOTAL: 51.7 MB680.3 KB2.3 MB0.0 KB/s3.2 KB97:31:07
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 2223.1 KB 9 0 000:00:22
2isvcs01.man.lodz.pl 1 00.0 KB 0 1 000:00:00
TOTAL: 2 289 2223.1 KB 9 1 000:00:53

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 577 2223.1 KB 9 1 000:00:25
2*.security.ipip.net 1 00.0 KB 0 0 000:00:00
3*.74.198.200.li.binaryedge.ninja 1 00.0 KB 0 0 000:00:01
4*.20.97.83.ro.ovo.sc 1 00.0 KB 0 0 000:00:10
5unresolved 103 00.0 KB 0 0 000:00:15
TOTAL: 5 683 2223.1 KB 9 1 000:00:53

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.576 2.772 0.00000:00:22
35.20.97.83.ro.ovo.sc 0.008 0.008 0.00000:00:10
162.243.128.193 0.008 0.012 0.00000:00:09
mon.man.lodz.pl 1.356 2.308 0.00000:00:03
80.111.142.213 0.024 0.032 0.00000:00:02
92.63.196.16 0.008 0.020 0.00000:00:01
109.74.198.200.li.binaryedge.ninja 0.008 0.016 0.00000:00:01
212.51.192.185 0.456 0.816 0.00000:00:00
scan-141.security.ipip.net 0.008 0.000 0.00000:00:00
isvcs01.man.lodz.pl 0.012 0.012 0.00000:00:00
? 0.004 0.000 0.00000:00:00
TOTAL: 11 3.468 5.996 0.00000:00:53

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
92.63.196.16 2
109.74.198.200.li.binaryedge.ninja 1
35.20.97.83.ro.ovo.sc 1
scan-141.security.ipip.net 1
162.243.128.193 1
TOTAL: 8 394

NNRP gethostbyaddr failures [Top 20]:

SystemConn
? (can't getpeername) 1
TOTAL: 1 1

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 4
92.63.196.16 2
TOTAL: 2 6

NNRP unrecognized commands (by command):

CommandCount
#003 2
Host: 212.191.2.21:119 1
User-Agent: HTTP Banner Detection (https... 1
GET / HTTP/1.1 1
Connection: close 1
TOTAL: 5 6

NNRP client timeouts [Top 20]:

SystemConnPeer
92.63.196.16 2 2
TOTAL: 1 2 2

Newsgroup request counts (by category):

CategoryCountPct
1pl 22100.0%
TOTAL: 1 22100.0%

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

NewsgroupCount
1pl.comp.pecet 18
2pl.comp.os.ms-windows.winnt 4
TOTAL: 2 22