Daily Usenet report

Nov 15 04:15:03 -- Nov 16 04:15:02

Unknown entries from news log file:

First 17 / 17 lines (100.0%)

Nov 15 05:52:39 newsfeed overchan[32336]: input line too long, skipping
Nov 15 06:46:43 newsfeed overchan[32336]: input line too long, skipping
Nov 15 10:54:51 newsfeed nnrpd[29431]: SERVER perl filter not defined
Nov 15 11:17:00 newsfeed nnrpd[384]: SERVER perl filter not defined
Nov 15 12:21:50 newsfeed nnrpd[10324]: SERVER perl filter not defined
Nov 15 12:22:44 newsfeed nnrpd[10589]: SERVER perl filter not defined
Nov 15 12:23:53 newsfeed nnrpd[10709]: SERVER perl filter not defined
Nov 15 14:42:44 newsfeed overchan[32336]: input line too long, skipping
Nov 15 15:40:14 newsfeed overchan[32336]: input line too long, skipping
Nov 15 17:55:29 newsfeed overchan[32336]: input line too long, skipping
Nov 15 18:55:29 newsfeed overchan[32336]: input line too long, skipping
Nov 15 19:49:06 newsfeed overchan[32336]: input line too long, skipping
Nov 15 19:54:29 newsfeed overchan[32336]: input line too long, skipping
Nov 15 20:42:15 newsfeed overchan[32336]: input line too long, skipping
Nov 15 21:32:01 newsfeed pgpverify[30295]: pgpverify: verification failed
Nov 15 23:05:29 newsfeed overchan[32336]: input line too long, skipping
Nov 15 23:50:08 newsfeed overchan[32336]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 628421 91.3%68.0 MB 90.3%
innfeed 46350 6.7%5.5 MB 7.3%
innd 8623 1.3%1.3 MB 1.8%
nnrpd 4819 0.7%486.6 KB 0.6%
controlchan 12 0.0%2.5 KB 0.0%
overchan 12 0.0%2.0 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 7 688238 100.0%75.3 MB100.0%

History cache:

ReasonCount%Count
Do not exist 624895 99.6%
Negative hits 2157 0.3%
Positive hits 205 0.0%
Cache misses 32 0.0%
TOTAL: 4 627289 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:03.939 0.0%57 0.000 69.105 402.000
article cleanup00:00:09.100 0.0%627029 0.010 0.015 0.021
article logging00:00:31.339 0.0%627529 0.035 0.050 0.073
article parse00:16:10.138 1.1%46255293 0.012 0.021 0.030
article write00:07:07.324 0.5%626794 0.183 0.682 1.007
artlog/artcncl00:00:00.001 0.0%56 0.000 0.018 1.000
data move00:00:38.701 0.0%50249480 0.001 0.001 0.001
hisgrep/artcncl00:00:00.503 0.0%57 0.000 8.825 40.000
hishave/artcncl00:00:00.472 0.0%57 0.000 8.281 76.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup01:40:09.015 7.0%629642 4.347 9.544 20.673
history sync00:00:00.032 0.0%291 0.000 0.110 1.000
history write01:52:29.889 7.8%627001 5.989 10.765 26.020
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle18:19:53.447 76.4%45685492 0.586 1.445 1.816
nntp read00:29:03.438 2.0%45925861 0.024 0.038 0.057
overview write00:00:03.313 0.0%626794 0.002 0.005 0.009
perl filter00:58:57.670 4.1%627001 3.065 5.642 7.618
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:35.766 0.0%1265904 0.022 0.028 0.037
TOTAL: 24:00:05.95123:45:54.087 99.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.119 0.0%47927 0.000 0.002 0.016
article prepare00:00:00.002 0.0%3974 0.000 0.001 0.025
article read00:00:18.863 0.0%943 0.000 20.003 356.250
backlog stats00:00:00.084 0.0%97823 0.000 0.001 0.005
callbacks00:00:00.001 0.0%1 1.000 1.000 1.000
data read00:00:00.975 0.0%49066 0.003 0.020 0.038
data write00:00:02.052 0.0%36912 0.020 0.056 0.092
idle23:51:16.243 99.7%97823 541.339 877.874 1424.124
status file00:03:38.682 0.3%16428 1.114 13.312 350.050
TOTAL: 23:55:22.78523:55:17.021100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:46:02.488 99.4%3387 0.000 815.615900007.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.625 0.0%7542 0.000 0.083 9.111
readart00:00:00.002 0.0%40 0.000 0.050 0.500
TOTAL: 00:46:18.42300:46:03.115 99.4%----

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
group-admin@isc.org001101
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 70 627667 627484 0 183 99%56:51:43
2news.icm.edu.pl 52 247 43 152 52 17%16:22:29
3localhost 1446 5 5 0 0 100%00:00:01
TOTAL: 3 1568 627919 627532 152 235 99%73:14:13
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl242.3 GB1.8 MB2.2 MB242.3 GB 99%404.8 KB
2news.icm.edu.pl2.2 MB65.0 KB1.6 MB3.8 MB 57%41.3 KB
3localhost7.3 KB0.0 KB0.0 KB7.3 KB100%1.5 KB
TOTAL: 3242.3 GB1.8 MB3.8 MB242.3 GB 99%404.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 15 04:15:03 - 04:59:59 12885 2.1% 4.786.3 GB 2.6%2452.11
Nov 15 05:00:00 - 05:59:59 20062 3.2% 5.578.9 GB 3.7%2592.87
Nov 15 06:00:00 - 06:59:59 20504 3.3% 5.708.7 GB 3.6%2536.91
Nov 15 07:00:00 - 07:59:59 23338 3.7% 6.489.3 GB 3.8%2721.45
Nov 15 08:00:00 - 08:59:59 23768 3.8% 6.609.4 GB 3.9%2727.51
Nov 15 09:00:00 - 09:59:59 23944 3.8% 6.658.8 GB 3.6%2566.46
Nov 15 10:00:00 - 10:59:59 26624 4.2% 7.409.7 GB 4.0%2833.90
Nov 15 11:00:00 - 11:59:59 20978 3.3% 5.8310.0 GB 4.1%2904.20
Nov 15 12:00:00 - 12:59:59 91728 14.6% 25.4811.6 GB 4.8%3369.01
Nov 15 13:00:00 - 13:59:59 21024 3.3% 5.8410.2 GB 4.2%2969.62
Nov 15 14:00:00 - 14:59:59 21293 3.4% 5.9110.3 GB 4.2%2986.60
Nov 15 15:00:00 - 15:59:59 22744 3.6% 6.3210.8 GB 4.4%3139.04
Nov 15 16:00:00 - 16:59:59 21801 3.5% 6.0610.1 GB 4.2%2944.26
Nov 15 17:00:00 - 17:59:59 20173 3.2% 5.609.3 GB 3.8%2701.25
Nov 15 18:00:00 - 18:59:59 23029 3.7% 6.4010.6 GB 4.4%3096.19
Nov 15 19:00:00 - 19:59:59 21656 3.5% 6.0210.2 GB 4.2%2976.64
Nov 15 20:00:00 - 20:59:59 21264 3.4% 5.9110.3 GB 4.2%2987.52
Nov 15 21:00:00 - 21:59:59 20522 3.3% 5.709.7 GB 4.0%2821.66
Nov 15 22:00:00 - 22:59:59 22774 3.6% 6.3311.0 GB 4.5%3206.72
Nov 15 23:00:00 - 23:59:59 27608 4.4% 7.6710.5 GB 4.3%3072.53
Nov 16 00:00:00 - 00:59:59 29695 4.7% 8.2512.2 GB 5.0%3541.99
Nov 16 01:00:00 - 01:59:59 30291 4.8% 8.4112.2 GB 5.0%3557.80
Nov 16 02:00:00 - 02:59:59 27659 4.4% 7.6810.4 GB 4.3%3020.48
Nov 16 03:00:00 - 03:59:59 25487 4.1% 7.089.9 GB 4.1%2872.14
Nov 16 04:00:00 - 04:15:02 6779 1.1% 7.522.6 GB 1.1%3037.11
TOTAL: 23:59:59 627630 100.0% 7.26242.9 GB 100.0%2947.73
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 683 157 0 24 0 0 0 0 502
2news.icm.edu.pl 52 0 0 4 0 0 0 0 48
TOTAL: 2 735 157 0 28 0 0 0 0 550

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 99
it.tlc.cellulari.android 33
it.comp.os.win.windows10 14
de.rec.sf.startrek 4
comp.sys.raspberry-pi 3
comp.mobile.android 2
it.comp.os.win.windows7 2
TOTAL: 7 157

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 46
Binary in non-binary group 4
TOTAL: 2 50

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 500
TOTAL: 1 500
TOTAL: 1 500

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 38756 361 11114 106 1 36525 0%23:59:54
2icm 14769 71 12147 1 0 0 0%23:50:02
3nask 0 0 0 0 0 8134 0%23:50:03
4poznan 30 0 29 0 0 0 0%02:55:50
5okapi 0 0 0 0 0 869 0%23:50:03
TOTAL: 5 53555 432 23290 107 1 45528 0%98:25:52
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama1.2 MB347.2 KB1.5 MB0.0 KB/s3.4 KB23:59:54
2icm355.4 KB1.8 KB357.3 KB0.0 KB/s5.0 KB23:50:02
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:03
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:55:50
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:03
TOTAL: 51.5 MB349.0 KB1.9 MB0.0 KB/s3.6 KB98:25:52
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 4035.7 KB 20 0 000:00:35
2isvcs01.man.lodz.pl 5 00.0 KB 0 5 000:00:00
TOTAL: 2 293 4035.7 KB 20 5 000:46:18

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 581 4035.7 KB 20 5 000:00:40
2*.versanet.de 190 00.0 KB 0 0 000:00:10
3*.toya.net.pl 3 00.0 KB 0 0 000:15:11
4unresolved 102 00.0 KB 0 0 000:30:15
TOTAL: 4 876 4035.7 KB 20 5 000:46:18

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
202.107.226.3 0.004 0.012 0.00000:30:00
staticline-31-183-156-95.toya.net.pl 0.043 0.030 0.00000:15:11
web.man.lodz.pl 1.780 3.245 0.00000:00:35
i5c74253a.versanet.de 0.847 1.758 0.00000:00:10
176.192.174.32 0.000 0.012 0.00000:00:08
80.111.142.213 0.048 0.043 0.00000:00:05
mon.man.lodz.pl 1.489 2.595 0.00000:00:03
212.51.192.185 0.467 0.893 0.00000:00:01
isvcs01.man.lodz.pl 0.030 0.062 0.00000:00:00
TOTAL: 9 4.708 8.650 0.00000:46:18

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
i5c74253a.versanet.de 190
212.51.192.185 96
80.111.142.213 4
staticline-31-183-156-95.toya.net.pl 3
176.192.174.32 1
202.107.226.3 1
TOTAL: 7 583

NNRP unrecognized commands (by host):

SystemConn
202.107.226.3 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.0 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
202.107.226.3 1 0
TOTAL: 1 1 0

Newsgroup request counts (by category):

CategoryCountPct
1pl 40100.0%
TOTAL: 1 40100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 28
2pl.comp.pecet 12
TOTAL: 2 40