Daily Usenet report for news.nobody.at

Sep 1 04:15:02 -- Sep 2 04:15:01

Unknown entries from news log file:

First 15 / 15 lines (100.0%)
Sep 1 11:55:01 news innfeed[32648]: assertion -- cxn != NULL -- failed in file connection.c line 1240
Sep 1 12:28:12 news innfeed[9609]: assertion -- cxn != NULL -- failed in file connection.c line 1240
Sep 1 14:20:01 news innfeed[13529]: assertion -- cxn != NULL -- failed in file connection.c line 1240
Sep 1 18:35:36 news innfeed[7967]: assertion -- cxn != NULL -- failed in file connection.c line 1240
Sep 1 18:55:16 news innfeed[29992]: assertion -- cxn != NULL -- failed in file connection.c line 1240
Sep 1 19:10:58 news innfeed[25839]: assertion -- cxn != NULL -- failed in file connection.c line 1240
Sep 1 19:17:17 news innfeed[16021]: assertion -- cxn != NULL -- failed in file connection.c line 1240
Sep 1 19:34:15 news innfeed[25773]: assertion -- cxn != NULL -- failed in file connection.c line 1240
Sep 1 19:51:04 news innfeed[17710]: assertion -- cxn != NULL -- failed in file connection.c line 1240
Sep 1 22:21:01 news controlchan[13903]: skipping rmgroup sfnet@hopeatilhi.cs.tut.fi(pgpverify failed) in <h7jvnd$idb$1@news.cc.tut.fi>
Sep 2 00:00:23 news innfeed[13904]: assertion -- cxn != NULL -- failed in file connection.c line 1240
Sep 2 00:27:11 news innfeed[27674]: assertion -- cxn != NULL -- failed in file connection.c line 1240
Sep 2 00:51:14 news innfeed[32178]: assertion -- cxn != NULL -- failed in file connection.c line 1240
Sep 2 01:32:24 news pgpverify[15477]: pgpverify: verification failed
Sep 2 01:32:24 news controlchan[13903]: skipping checkgroups moderator@dana.de(pgpverify failed) in <checkgroups_2009-09@dana.de>

Log entries by program:

Program nameLines%LinesSize%Size
inn 177553 86.2%54.7 MB 93.7%
innd 15541 7.5%1.9 MB 3.2%
innfeed 8405 4.1%1.4 MB 2.4%
nnrpd 4414 2.1%435.3 KB 0.7%
controlchan 9 0.0%1.1 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 6 205923 100.0%58.4 MB100.0%

History cache:

ReasonCount%Count
Cache misses 2200055 63.5%
Do not exist 1264071 36.5%
Positive hits 0 0.0%
Negative hits 0 0.0%
TOTAL: 4 3464126 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:12.694 0.0%4969 0.000 2.555 195.500
article cleanup00:00:03.184 0.0%168836 0.000 0.019 0.086
article logging00:00:02.201 0.0%172409 0.000 0.013 0.160
article parse00:00:12.369 0.0%3410438 0.000 0.004 0.038
article write00:17:28.912 1.2%150050 0.000 6.990 142.802
artlog/artcncl00:00:00.057 0.0%4930 0.000 0.012 1.000
artlog/artparse00:00:00.004 0.0%223 0.000 0.018 0.333
data move00:00:05.556 0.0%5983339 0.000 0.001 0.004
hisgrep/artcncl00:00:02.577 0.0%3097 0.000 0.832 53.333
hishave/artcncl00:00:00.623 0.0%4969 0.000 0.125 22.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:01:06.637 0.1%3461561 0.000 0.019 0.663
history sync00:00:00.062 0.0%479 0.000 0.129 1.000
history write00:01:59.415 0.1%168297 0.000 0.710 31.988
hiswrite/artcncl00:00:01.380 0.0%1872 0.000 0.737 145.000
idle23:26:29.371 97.6%5822666 1.900 14.493 106.478
nntp read00:00:42.739 0.0%5959715 0.001 0.007 0.013
overview write00:09:13.440 0.6%150050 0.000 3.688 102.889
perl filter00:00:10.053 0.0%168246 0.000 0.060 0.198
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:03.228 0.0%300281 0.000 0.011 0.142
TOTAL: 24:00:26.22723:57:54.502 99.8%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.528 0.0%226184 0.000 0.002 0.016
article prepare00:00:00.115 0.0%181606 0.000 0.001 0.011
article read00:00:06.391 0.0%24760 0.000 0.258 23.500
backlog stats00:00:03.457 0.0%3306310 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:13.309 0.0%2517562 0.003 0.005 0.008
data write00:00:32.974 0.0%2444996 0.009 0.013 0.025
idle22:41:41.433 99.9%3306310 0.000 24.711 50.858
status file00:00:01.059 0.0%1573 0.000 0.673 4.421
TOTAL: 22:43:33.44222:42:39.266 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:00.862 0.7%1426 0.000 0.604 28.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.063 0.0%4311 0.000 0.015 0.000
TOTAL: 00:02:07.32600:00:00.925 0.7%----

Control commands to INND:

CommandNumber
flush 1
flushlogs 1
paused 2
reload 2
shutdown 2
throttle 1
TOTAL: 6 9

Newsgroups created:

GroupMode
alt.online-service.verizony
TOTAL1

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
control-microsoft@trigofacile.com001001
hirtenrat@szaf.org001001
us-control@lists.killfile.org001001
usenet@verizon.net100011
TOTAL103014

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news-out.nntp.giganews.com 10 3057942 575132989811 10618 1%3621:11:59
2news-out.glorb.com 70 133293 48511 84262 520 36%29:36:09
3feeders.tudelft.nl 289 168574 15709 141040 11825 9%23:46:25
4nobody-at-out.feeder.erje.net 290 124093 13932 109804 357 11%23:45:46
5feeder.eternal-september.org 4 93414 12472 80842 100 13%30:49:11
6de-l.enfer-du-nord.net 16 139785 10657 128848 280 7%26:37:59
7newsfeed.neva.ru 150 324444 8414 315779 251 2%73:16:17
8195.114.241.69 288 129621 7234 122074 313 5%23:45:32
9newsfeed.straub-nv.de 5 82082 6941 75027 114 8%17:01:05
10feeder.news-service.com 288 135685 5601 126353 3731 4%23:46:10
11nobody-out.news.weretis.net 5 208777 4486 204005 286 2%46:39:05
12nobody-out.newsfeed.netcologne.de 290 178588 3864 174447 277 2%23:45:50
13194.45.27.103 1418 143941 3377 140216 348 2%47:52:39
14news.albasani.net 24 136794 3067 133653 74 2%28:55:03
15news.telesweet.net 8 130560 619 129885 56 0%27:25:27
16newsfeed.datemas.de 13 86852 391 86455 6 0%20:21:42
17news.swapon.de 2 10359 317 10042 0 3%38:15:26
18localhost 25 0 0 0 0 0%00:00:02
19reflex.at 523 0 0 0 0 0%00:02:14
TOTAL: 19 3718 5284804 2031055052543 29156 3%4126:54:01

Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolTotalVol%AccVol/ArtElapsed
1news-out.nntp.giganews.com820.0 MB2.1 MB822.1 MB 99%12.4 KB3621:11:59
2feeders.tudelft.nl722.4 MB932.5 KB723.3 MB 99%26.9 KB23:46:25
3news-out.glorb.com186.0 MB1.6 MB187.6 MB 99%3.9 KB29:36:09
4feeder.news-service.com65.1 MB421.0 KB65.5 MB 99%7.2 KB23:46:10
5195.114.241.6941.7 MB140.1 KB41.8 MB 99%5.7 KB23:45:32
6nobody-at-out.feeder.erje.net31.5 MB195.5 KB31.6 MB 99%2.3 KB23:45:46
7de-l.enfer-du-nord.net29.7 MB32.3 KB29.7 MB 99%2.8 KB26:37:59
8feeder.eternal-september.org28.8 MB3.0 KB28.8 MB 99%2.3 KB30:49:11
9194.45.27.10324.2 MB24.7 KB24.2 MB 99%6.7 KB47:52:39
10newsfeed.straub-nv.de24.1 MB3.6 KB24.1 MB 99%3.5 KB17:01:05
11newsfeed.neva.ru22.2 MB161.5 KB22.3 MB 99%2.6 KB73:16:17
12nobody-out.news.weretis.net17.8 MB2.9 KB17.8 MB 99%3.8 KB46:39:05
13nobody-out.newsfeed.netcologne.de10.7 MB234.5 KB10.9 MB 97%2.7 KB23:45:50
14news.albasani.net9.4 MB13.4 KB9.4 MB 99%3.1 KB28:55:03
15news.telesweet.net1.9 MB20.3 KB2.0 MB 98%3.0 KB27:25:27
16newsfeed.datemas.de1.3 MB0.0 KB1.3 MB100%3.3 KB20:21:42
17news.swapon.de764.6 KB0.0 KB764.6 KB100%2.4 KB38:15:26
18localhost0.0 KB0.0 KB0.0 KB 0%000:00:02
19reflex.at0.0 KB0.0 KB0.0 KB 0%000:02:14
TOTAL: 192.0 GB5.8 MB2.0 GB 99%9.0 KB4126:54:01

Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 1 04:15:02 - 04:59:59 3304 2.2% 1.2215.6 MB 1.2% 5.91
Sep 1 05:00:00 - 05:59:59 4271 2.8% 1.1992.4 MB 7.3% 26.27
Sep 1 06:00:00 - 06:59:59 3728 2.5% 1.0438.8 MB 3.0% 11.04
Sep 1 07:00:00 - 07:59:59 3470 2.3% 0.9674.0 MB 5.8% 21.05
Sep 1 08:00:00 - 08:59:59 3993 2.7% 1.1114.8 MB 1.2% 4.20
Sep 1 09:00:00 - 09:59:59 5027 3.4% 1.4016.1 MB 1.3% 4.57
Sep 1 10:00:00 - 10:59:59 5319 3.5% 1.4842.6 MB 3.3% 12.12
Sep 1 11:00:00 - 11:59:59 5463 3.6% 1.5228.5 MB 2.2% 8.11
Sep 1 12:00:00 - 12:59:59 5984 4.0% 1.6627.1 MB 2.1% 7.72
Sep 1 13:00:00 - 13:59:59 6355 4.2% 1.7767.7 MB 5.3% 19.25
Sep 1 14:00:00 - 14:59:59 6864 4.6% 1.9133.1 MB 2.6% 9.41
Sep 1 15:00:00 - 15:59:59 7752 5.2% 2.1548.2 MB 3.8% 13.72
Sep 1 16:00:00 - 16:59:59 9144 6.1% 2.5495.8 MB 7.5% 27.25
Sep 1 17:00:00 - 17:59:59 8373 5.6% 2.3350.8 MB 4.0% 14.45
Sep 1 18:00:00 - 18:59:59 8968 6.0% 2.4972.5 MB 5.7% 20.61
Sep 1 19:00:00 - 19:59:59 9643 6.4% 2.68145.0 MB 11.4% 41.24
Sep 1 20:00:00 - 20:59:59 9186 6.1% 2.5588.0 MB 6.9% 25.03
Sep 1 21:00:00 - 21:59:59 7906 5.3% 2.2066.0 MB 5.2% 18.76
Sep 1 22:00:00 - 22:59:59 6888 4.6% 1.9141.5 MB 3.3% 11.82
Sep 1 23:00:00 - 23:59:59 7394 4.9% 2.0554.6 MB 4.3% 15.54
Sep 2 00:00:00 - 00:59:59 5420 3.6% 1.5118.8 MB 1.5% 5.36
Sep 2 01:00:00 - 01:59:59 5946 4.0% 1.6530.1 MB 2.4% 8.57
Sep 2 02:00:00 - 02:59:59 4470 3.0% 1.2455.0 MB 4.3% 15.64
Sep 2 03:00:00 - 03:59:59 4166 2.8% 1.1651.3 MB 4.0% 14.58
Sep 2 04:00:00 - 04:15:01 993 0.7% 1.104.8 MB 0.4% 5.41
TOTAL: 23:59:59 150027 100.0% 1.741.2 GB 100.0% 15.09

Incoming articles

Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1feeders.tudelft.nl 11832 11636 22 80 2 0 0 0 92
2feeder.news-service.com 3730 3597 51 46 0 0 0 0 36
3news-out.glorb.com 3019 296 0 211 0 0 0 0 2512
4nobody-at-out.feeder.erje.net 633 293 2 37 3 0 0 0 298
5newsfeed.neva.ru 564 209 0 32 0 0 0 0 323
6news-out.nntp.giganews.com 515 375 59 12 2 0 0 0 67
7de-l.enfer-du-nord.net 428 300 0 16 0 0 0 0 112
8newsfeed.straub-nv.de 360 199 0 7 0 0 0 0 154
9194.45.27.103 359 268 25 5 1 0 0 0 60
10nobody-out.news.weretis.net 332 298 0 2 0 0 0 0 32
11195.114.241.69 319 199 25 43 0 0 0 0 52
12nobody-out.newsfeed.netcologne.de 281 188 0 45 1 0 0 0 47
13feeder.eternal-september.org 99 51 0 1 0 0 0 0 47
14news.albasani.net 54 48 0 0 0 0 0 0 6
15news.telesweet.net 40 37 0 2 0 0 0 0 1
16newsfeed.datemas.de 18 13 0 0 0 0 0 0 5
17news.swapon.de 13 0 0 0 0 0 0 0 13
TOTAL: 17 22596 18007 184 539 9 0 0 0 3857

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.pictures.erotic 5994
a.b.boneless 4268
news.giganews.com 2600
alt.sex.stories.sex 418
alt.siol 272
alt.sex.alt.sex.erotica 245
alt.sex.erotica.marketp 245
alt.sex.voyerism 73
alt.bianaries.pictures.erotica.sensualamateurs 72
alt.sex.masturbate 69
alt.fan.fightclub 67
alt.sex.first.time 67
hr.ponuda.hardver.komponente 67
alt.sex.orgies 66
alt.sex.ehibitionism 66
alt.sex.stories.erotic 64
alt.sex.exhibitonism 63
alt.sex.pictures.oral 57
alt.sex.first-timer 57
alt.alt.sex 47
TOTAL: 708 18007

Unwanted distributions [Top 20]:

DistributionCount
local 184
TOTAL: 1 184

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

GroupsCount
alt.sex.spanking.adult 6
uk.legal.moderated 1
alt.shoe.lesbians.moderated 1
linux.kernel 1
TOTAL: 4 9

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
195.114.241.69 17
feeders.tudelft.nl 11
feeder.news-service.com 11
news-out.nntp.giganews.com 8
nobody-at-out.feeder.erje.net 3
194.45.27.103 1
TOTAL: 6 51
Bad Message-ID's offered
nobody-out.newsfeed.netcologne.de 2
194.45.27.103 2
feeders.tudelft.nl 2
feeder.news-service.com 2
nobody-at-out.feeder.erje.net 2
195.114.241.69 2
news-out.nntp.giganews.com 1
TOTAL: 7 13
Including strange strings
news-out.glorb.com 2503
newsfeed.neva.ru 316
nobody-at-out.feeder.erje.net 286
newsfeed.straub-nv.de 154
de-l.enfer-du-nord.net 112
news-out.nntp.giganews.com 49
feeder.eternal-september.org 37
nobody-out.news.weretis.net 32
195.114.241.69 18
194.45.27.103 17
TOTAL: 17 3583
No colon-space in header
feeders.tudelft.nl 61
194.45.27.103 37
nobody-out.newsfeed.netcologne.de 32
feeder.news-service.com 9
195.114.241.69 9
news-out.nntp.giganews.com 7
nobody-at-out.feeder.erje.net 3
TOTAL: 7 158
TOTAL: 4 3805

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.osn.de 117877 6868 107270 2 2 3934 5%19:54:01
2news.netcologne.de 55173 2891 50369 85 0 60 5%10:20:15
3goblin.stu.neva.ru 64479 1223 46771 1727 0 23 1%10:16:57
4newsfeed.datemas.de 56495 915 48245 1830 0 0 1%10:16:57
5reflex.at 671 658 7 6 0 4 98%14:11:30
6nntp.giganews.com 42642 458 42184 0 0 0 1%10:16:57
7texta.sil.at 71941 188 54282 222 0 7 0%10:16:57
8tudelft.nl 52793 143 48100 0 0 0 0%10:16:57
9news-in.glorb.com 56614 100 36017 175 0 33 0%10:16:56
10news.albasani.net 59791 97 51460 1243 0 171 0%10:16:57
11enfer-du-nord.net 113342 86 101802 73 0 2 0%18:56:09
12weretis.net 56926 68 51722 172 0 69 0%10:16:57
13eternal-september.org 73030 48 62707 1395 0 169 0%13:07:24
14feeder.news-service.com 127106 34 122253 2 0 4742 0%10:17:01
15news.telesweet.net 74866 30 51280 183 2 5 0%10:16:56
16newsfeed.straub-nv.de 53980 18 49174 25 0 2 0%10:16:57
17feeder.erje.net 48854 17 46506 3 0 1 0%10:16:57
18news.swapon.de 2790 0 2634 0 0 0 0%10:16:57
TOTAL: 181129370 13842 972783 7143 4 9222 1%210:09:42

Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.osn.de484.1 MB3.6 KB484.1 MB6.9 KB/s72.2 KB19:54:01
2news.netcologne.de231.8 MB579.6 KB232.3 MB6.4 KB/s79.9 KB10:20:15
3goblin.stu.neva.ru16.2 MB22.2 MB38.4 MB1.1 KB/s13.3 KB10:16:57
4nntp.giganews.com10.3 MB0.0 KB10.3 MB0.3 KB/s23.1 KB10:16:57
5news-in.glorb.com7.0 MB26.2 MB33.2 MB0.9 KB/s123.7 KB10:16:56
6weretis.net5.4 MB24.0 MB29.4 MB0.8 KB/s125.5 KB10:16:57
7texta.sil.at4.1 MB8.9 MB12.9 MB0.4 KB/s32.3 KB10:16:57
8newsfeed.datemas.de3.3 MB5.5 MB8.7 MB0.2 KB/s3.3 KB10:16:57
9reflex.at1.5 MB443.5 KB1.9 MB0.0 KB/s3.0 KB14:11:30
10news.albasani.net906.6 KB116.2 MB117.1 MB3.2 KB/s89.5 KB10:16:57
11tudelft.nl713.7 KB0.0 KB713.7 KB0.0 KB/s5.0 KB10:16:57
12enfer-du-nord.net388.5 KB1.4 MB1.8 MB0.0 KB/s11.3 KB18:56:09
13eternal-september.org182.0 KB157.0 MB157.2 MB3.4 KB/s111.5 KB13:07:24
14feeder.news-service.com149.8 KB3.4 KB153.2 KB0.0 KB/s4.3 KB10:17:01
15news.telesweet.net73.3 KB861.3 KB934.6 KB0.0 KB/s4.4 KB10:16:56
16feeder.erje.net66.7 KB19.2 KB86.0 KB0.0 KB/s4.3 KB10:16:57
17newsfeed.straub-nv.de55.1 KB840.9 KB895.9 KB0.0 KB/s20.8 KB10:16:57
18news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s010:16:57
TOTAL: 18766.1 MB364.1 MB1.1 GB1.5 KB/s55.2 KB210:09:42

Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1monitor.mediainvent.at1426 00.0 KB 0 0 000:01:56
TOTAL: 11426 00.0 KB 0 0 000:02:00

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.mediainvent.at1426 00.0 KB 0 0 000:01:56
TOTAL: 11426 00.0 KB 0 0 000:01:56

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
monitor.mediainvent.at 90.173 16.849 0.00000:01:56
palmers.nobody.at 1.517 0.285 0.00000:00:02
168.126.248.58 0.063 0.010 0.00000:00:00
85.107.250.134 0.191 0.036 0.00000:00:00
user-514d755f.l2.c2.dsl.pol.co.uk 0.128 0.026 0.00000:00:00
166.16.219.87.dynamic.jazztel.es 0.062 0.011 0.00000:00:00
232.17.219.87.dynamic.jazztel.es 0.061 0.014 0.00000:00:00
dhcp-06.nobody.at 0.058 0.019 0.00000:00:00
TOTAL: 8 92.253 17.250 0.00000:02:00

NNRP no permission clients:

SystemConn
palmers.nobody.at 24
85.107.250.134 3
user-514d755f.l2.c2.dsl.pol.co.uk 2
166.16.219.87.dynamic.jazztel.es 1
168.126.248.58 1
232.17.219.87.dynamic.jazztel.es 1
dhcp-06.nobody.at 1
TOTAL: 7 33

innreport 3.0.2 (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>.
Local contact: news@mediainvent.com