Daily Usenet report

Feb 13 04:15:02 -- Feb 14 04:15:11

Unknown entries from news log file:

First 20 / 20 lines (100.0%)

Feb 13 05:14:40 newsfeed overchan[11315]: input line too long, skipping
Feb 13 06:22:06 newsfeed overchan[11315]: input line too long, skipping
Feb 13 07:05:48 newsfeed overchan[11315]: input line too long, skipping
Feb 13 07:06:03 newsfeed overchan[11315]: input line too long, skipping
Feb 13 07:06:21 newsfeed overchan[11315]: input line too long, skipping
Feb 13 08:50:43 newsfeed overchan[11315]: input line too long, skipping
Feb 13 10:30:00 newsfeed nnrpd[27635]: SERVER perl filter not defined
Feb 13 13:35:23 newsfeed nnrpd[2306]: SERVER perl filter not defined
Feb 13 13:36:16 newsfeed nnrpd[2318]: SERVER perl filter not defined
Feb 13 13:37:13 newsfeed nnrpd[2332]: SERVER perl filter not defined
Feb 13 13:37:52 newsfeed nnrpd[2344]: SERVER perl filter not defined
Feb 13 14:08:53 newsfeed nnrpd[3475]: SERVER perl filter not defined
Feb 13 16:02:41 newsfeed overchan[11315]: input line too long, skipping
Feb 13 17:25:30 newsfeed overchan[11315]: input line too long, skipping
Feb 13 17:25:40 newsfeed overchan[11315]: input line too long, skipping
Feb 13 17:25:51 newsfeed overchan[11315]: input line too long, skipping
Feb 13 22:09:09 newsfeed overchan[11315]: input line too long, skipping
Feb 14 02:04:16 newsfeed overchan[11315]: input line too long, skipping
Feb 14 02:05:16 newsfeed overchan[11315]: input line too long, skipping
Feb 14 02:05:27 newsfeed overchan[11315]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2787526 97.6%324.2 MB 97.3%
innfeed 45595 1.6%5.4 MB 1.6%
innd 19225 0.7%3.2 MB 1.0%
nnrpd 4829 0.2%510.4 KB 0.1%
overchan 16 0.0%2.6 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 62857192 100.0%333.4 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2771639 96.5%
Negative hits 89358 3.1%
Positive hits 10936 0.4%
Cache misses 105 0.0%
TOTAL: 4 2872038 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:13.913 0.0%182 0.000 76.445 930.714
article cleanup00:00:32.490 0.0%2790436 0.008 0.012 0.015
article logging00:03:05.082 0.2%2791183 0.030 0.066 1.103
article parse00:44:30.014 3.1%83256542 0.022 0.032 0.041
article write00:22:28.383 1.6%2785833 0.178 0.484 4.662
artlog/artcncl00:00:00.002 0.0%177 0.000 0.011 0.333
data move00:02:37.729 0.2%98279208 0.001 0.002 0.005
hisgrep/artcncl00:00:04.079 0.0%162 0.000 25.179 470.571
hishave/artcncl00:00:05.599 0.0%182 0.000 30.764 400.286
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup01:33:18.506 6.5%2890574 0.162 1.937 7.584
history sync00:00:00.015 0.0%290 0.000 0.052 0.500
history write03:27:03.418 14.4%2788971 0.615 4.454 10.546
hiswrite/artcncl00:00:00.023 0.0%20 0.000 1.150 20.000
idle12:01:09.556 50.1%60853548 0.343 0.711 2.202
nntp read00:47:57.971 3.3%81147019 0.026 0.035 0.052
overview write00:00:13.992 0.0%2785833 0.004 0.005 0.007
perl filter04:27:06.510 18.5%2788971 4.161 5.746 7.250
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:05:15.253 0.4%5591455 0.039 0.056 0.143
TOTAL: 24:00:12.35023:35:42.535 98.3%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.142 0.0%56859 0.000 0.002 0.015
article prepare00:00:00.004 0.0%11278 0.000 0.000 0.016
article read00:06:04.864 0.4%2797 2.522 130.448 584.125
backlog stats00:00:00.139 0.0%163443 0.000 0.001 0.005
callbacks00:00:00.000 0.0%9 0.000 0.000 0.000
data read00:00:01.303 0.0%87227 0.000 0.015 0.030
data write00:00:03.258 0.0%67641 0.021 0.048 0.085
idle23:46:09.104 99.4%163443 343.698 523.541 959.168
status file00:01:48.391 0.1%15668 0.789 6.918 109.025
TOTAL: 23:54:18.68823:54:07.205100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle21:15:25.137 99.9%696953 0.000 109.800 1024.222
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:39.140 0.1%1394596 0.000 0.028 1.000
readart00:00:00.011 0.0%74 0.000 0.149 2.500
TOTAL: 21:16:55.31221:16:04.288 99.9%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 388 27834262773929 8016 1481 99%537:43:18
2news.nask.pl 3 14285 9867 1304 3114 69%24:06:51
3news.icm.edu.pl 46 226 36 188 2 15%15:37:33
4localhost 7 6 6 0 0 100%00:00:00
TOTAL: 4 444 27979432783838 9508 4597 99%577:27:42
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl704.4 GB24.0 MB25.0 MB704.4 GB 99%266.1 KB
2news.nask.pl48.5 MB364.9 KB16.1 MB64.9 MB 74%5.1 KB
3news.icm.edu.pl1.2 MB0.0 KB42.4 KB1.2 MB 96%33.0 KB
4localhost9.7 KB0.0 KB0.0 KB9.7 KB100%1.6 KB
TOTAL: 4704.4 GB24.3 MB41.1 MB704.5 GB 99%264.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 13 04:15:02 - 04:59:59 70227 2.5% 26.0321.4 GB 3.0%8312.70
Feb 13 05:00:00 - 05:59:59 100297 3.6% 27.8630.1 GB 4.3%8773.88
Feb 13 06:00:00 - 06:59:59 146825 5.3% 40.7830.9 GB 4.4%8986.99
Feb 13 07:00:00 - 07:59:59 128367 4.6% 35.6637.8 GB 5.4%11015.69
Feb 13 08:00:00 - 08:59:59 111002 4.0% 30.8332.6 GB 4.6%9508.49
Feb 13 09:00:00 - 09:59:59 99705 3.6% 27.7029.3 GB 4.2%8521.44
Feb 13 10:00:00 - 10:59:59 99471 3.6% 27.6329.3 GB 4.2%8531.16
Feb 13 11:00:00 - 11:59:59 102916 3.7% 28.5929.9 GB 4.3%8717.72
Feb 13 12:00:00 - 12:59:59 98649 3.5% 27.4027.9 GB 4.0%8120.45
Feb 13 13:00:00 - 13:59:59 97493 3.5% 27.0828.2 GB 4.0%8209.94
Feb 13 14:00:00 - 14:59:59 93269 3.4% 25.9127.9 GB 4.0%8125.67
Feb 13 15:00:00 - 15:59:59 83980 3.0% 23.3326.7 GB 3.8%7785.73
Feb 13 16:00:00 - 16:59:59 119182 4.3% 33.1130.6 GB 4.3%8899.97
Feb 13 17:00:00 - 17:59:59 102511 3.7% 28.4828.8 GB 4.1%8378.73
Feb 13 18:00:00 - 18:59:59 92217 3.3% 25.6230.4 GB 4.3%8855.95
Feb 13 19:00:00 - 19:59:59 115491 4.2% 32.0835.4 GB 5.0%10316.80
Feb 13 20:00:00 - 20:59:59 219889 7.9% 61.0835.9 GB 5.1%10459.46
Feb 13 21:00:00 - 21:59:59 131554 4.7% 36.5424.6 GB 3.5%7169.25
Feb 13 22:00:00 - 22:59:59 112826 4.1% 31.3432.2 GB 4.6%9373.21
Feb 13 23:00:00 - 23:59:59 143284 5.2% 39.8034.5 GB 4.9%10050.43
Feb 14 00:00:00 - 00:59:59 87941 3.2% 24.4319.3 GB 2.7%5625.13
Feb 14 01:00:00 - 01:59:59 117124 4.2% 32.5321.8 GB 3.1%6342.73
Feb 14 02:00:00 - 02:59:59 163952 5.9% 45.5431.4 GB 4.5%9146.09
Feb 14 03:00:00 - 03:59:59 133940 4.8% 37.2124.2 GB 3.4%7060.18
Feb 14 04:00:00 - 04:15:11 9881 0.4% 10.852.6 GB 0.4%2970.88
TOTAL: 24:00:09 2781993 100.0% 32.20703.7 GB 100.0%8538.98
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 3347 22 0 143 2 0 0 0 3180
2newsfeed.pionier.net.pl 2006 120 0 1322 1 0 0 0 563
3news.icm.edu.pl 3 0 0 0 0 0 0 0 3
TOTAL: 3 5356 142 0 1465 3 0 0 0 3746

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 74
it.tlc.cellulari.android 22
it.comp.os.win.windows10 14
de.comm.software.mailreader 8
comp.mobile.android 8
de.rec.sf.startrek 7
it.comp.os.win.windows7 2
de.comp.lang.vbclassic 2
comp.mobile.ipad 2
it.comp.virtualizzazione 1
de.comp.office-pakete.ms-office.word 1
it.discussioni.energia 1
TOTAL: 12 142

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

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

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2776
Binary in non-binary group 145
Scoring filter (9) 34
Scoring filter (8) 23
Scoring filter (18) 11
Scoring filter (10) 2
Scoring filter (13) 1
Scoring filter (12) 1
HTML post 1
Scoring filter (11) 1
Attached HTML file 1
TOTAL: 11 2996

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 525
news.nask.pl 224
news.icm.edu.pl 1
TOTAL: 3 750
TOTAL: 1 750

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 41998 1185 14458 241 17 41193 2%24:00:07
2poznan 15467 337 9388 15 0 0 2%24:00:07
3icm 24592 29 18848 2 0 0 0%24:00:06
4nask 3512 3 2754 0 0 0 0%23:57:32
5okapi 0 0 0 0 0 1240 0%23:58:00
TOTAL: 5 85569 1554 45448 258 17 42433 1%119:55:52
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm7.1 MB7.4 KB7.1 MB0.1 KB/s233.8 KB24:00:06
2panorama5.8 MB876.1 KB6.6 MB0.1 KB/s4.7 KB24:00:07
3poznan1.1 MB47.9 KB1.1 MB0.0 KB/s3.3 KB24:00:07
4nask94.0 KB0.0 KB94.0 KB0.0 KB/s31.3 KB23:57:32
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:00
TOTAL: 514.0 MB931.4 KB14.9 MB0.0 KB/s8.4 KB119:55:52
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 74103.2 KB 33 0 000:00:33
2isvcs01.man.lodz.pl 6 00.0 KB 0 6 000:00:00
TOTAL: 2 294 74103.2 KB 33 6 021:16:54

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 678 74103.2 KB 33 6 000:00:39
2unresolved 1 00.0 KB 0 0 021:16:13
3*.dhcp.chtrptr.net 2 00.0 KB 0 0 000:00:01
TOTAL: 3 681 74103.2 KB 33 6 021:16:54

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
89.38.40.96 40.244 63.628 0.00021:16:13
web.man.lodz.pl 1.532 4.460 0.00000:00:33
mon.man.lodz.pl 1.276 4.084 0.00000:00:03
172-221-045-126.dhcp.chtrptr.net 0.004 0.028 0.00000:00:01
david.man.lodz.pl 0.432 1.480 0.00000:00:01
isvcs01.man.lodz.pl 0.084 0.096 0.00000:00:00
66.240.219.146 0.012 0.008 0.00000:00:00
TOTAL: 7 43.584 73.784 0.00021:16:54

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
172-221-045-126.dhcp.chtrptr.net 2
66.240.219.146 1
TOTAL: 4 387

Newsgroup request counts (by category):

CategoryCountPct
1pl 74100.0%
TOTAL: 1 74100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 66
2pl.comp.pecet 8
TOTAL: 2 74