db-derby-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From "Mike Matrigali (JIRA)" <derby-...@db.apache.org>
Subject [jira] Updated: (DERBY-1248) Assert failure in BasePage.shiftUp() when running store/onlineBackupTest4.sql
Date Fri, 07 Jul 2006 16:40:31 GMT
     [ http://issues.apache.org/jira/browse/DERBY-1248?page=all ]

Mike Matrigali updated DERBY-1248:
----------------------------------


The following is from looking at the test335 failure.

My interpretation so far is that the online backup has data page changes without the corresponding
log records
for those changes.  The test takes a backup concurrently with a compress, and then tries to
apply the backup
and check it.  Unfortunately I this means it deletes the original db, which would be interesting
to have to compare
to the backup.  Connecting the the backup by hand I get the same error as is reported by the
test (which is what
I would expect from a boot recovery error).  

It looks like an undo of  Page(3,Container(0, 913)) , PageVersion: 579 is being attempted,
but the last  redo record of
that page attempted was page version 477.  Has the feel of a missing log file from the backup
copy.

Another issue is that I am surprised that we got the BasePage error, I thought that we would
get an error higher up from
undo saying that we could not apply undo page version 477 to page version 579.

Here are just the log records for this page applied during recovery, gotten by connecting
with a sane server and 
derby.debug.true=LogTrace property:

DEBUG LogTrace OUTPUT: scanned 253 : Page Operation: Page(3,Container(0, 913)) pageVersion
386 :  Delete : Slot=110 recordId=116 delete=true instant = (1,270917) logEnd = (1,270977)
logIn at 25 available 19
DEBUG LogTrace OUTPUT: scanned 253 : Page Operation: Page(3,Container(0, 913)) pageVersion
387 :  Delete : Slot=110 recordId=116 delete=false instant = (1,270977) logEnd = (1,271037)
logIn at 25 available 19
DEBUG LogTrace OUTPUT: scanned 253 : Page Operation: Page(3,Container(0, 913)) pageVersion
388 : UpdateField :  Slot=110 recordId=116 fieldId=1 instant = (1,271037) logEnd = (1,271108)
logIn at 25 available 30
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
389 : Purge : 1 slots starting at 190 (recordId=196) instant = (1,274147) logEnd = (1,274205)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
390 : Purge : 1 slots starting at 189 (recordId=195) instant = (1,274205) logEnd = (1,274263)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
391 : Purge : 1 slots starting at 188 (recordId=194) instant = (1,274263) logEnd = (1,274321)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
392 : Purge : 1 slots starting at 187 (recordId=193) instant = (1,274321) logEnd = (1,274379)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
393 : Purge : 1 slots starting at 186 (recordId=192) instant = (1,274379) logEnd = (1,274437)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
394 : Purge : 1 slots starting at 185 (recordId=191) instant = (1,274437) logEnd = (1,274495)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
395 : Purge : 1 slots starting at 184 (recordId=190) instant = (1,274495) logEnd = (1,274553)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
396 : Purge : 1 slots starting at 183 (recordId=189) instant = (1,274553) logEnd = (1,274611)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
397 : Purge : 1 slots starting at 182 (recordId=188) instant = (1,274611) logEnd = (1,274669)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
398 : Purge : 1 slots starting at 181 (recordId=187) instant = (1,274669) logEnd = (1,274727)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
399 : Purge : 1 slots starting at 180 (recordId=186) instant = (1,274727) logEnd = (1,274785)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
400 : Purge : 1 slots starting at 179 (recordId=185) instant = (1,274785) logEnd = (1,274843)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
401 : Purge : 1 slots starting at 178 (recordId=184) instant = (1,274843) logEnd = (1,274901)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
402 : Purge : 1 slots starting at 177 (recordId=183) instant = (1,274901) logEnd = (1,274959)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
403 : Purge : 1 slots starting at 176 (recordId=182) instant = (1,274959) logEnd = (1,275017)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
404 : Purge : 1 slots starting at 175 (recordId=181) instant = (1,275017) logEnd = (1,275075)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
405 : Purge : 1 slots starting at 174 (recordId=180) instant = (1,275075) logEnd = (1,275133)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
406 : Purge : 1 slots starting at 173 (recordId=179) instant = (1,275133) logEnd = (1,275191)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
407 : Purge : 1 slots starting at 172 (recordId=178) instant = (1,275191) logEnd = (1,275249)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
408 : Purge : 1 slots starting at 171 (recordId=177) instant = (1,275249) logEnd = (1,275307)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
409 : Purge : 1 slots starting at 170 (recordId=176) instant = (1,275307) logEnd = (1,275365)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
410 : Purge : 1 slots starting at 169 (recordId=175) instant = (1,275365) logEnd = (1,275423)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
411 : Purge : 1 slots starting at 168 (recordId=174) instant = (1,275423) logEnd = (1,275481)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
412 : Purge : 1 slots starting at 167 (recordId=173) instant = (1,275481) logEnd = (1,275539)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
413 : Purge : 1 slots starting at 166 (recordId=172) instant = (1,275539) logEnd = (1,275597)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
414 : Purge : 1 slots starting at 165 (recordId=171) instant = (1,275597) logEnd = (1,275655)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
415 : Purge : 1 slots starting at 164 (recordId=170) instant = (1,275655) logEnd = (1,275713)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
416 : Purge : 1 slots starting at 163 (recordId=169) instant = (1,275713) logEnd = (1,275771)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
417 : Purge : 1 slots starting at 162 (recordId=168) instant = (1,275771) logEnd = (1,275829)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
418 : Purge : 1 slots starting at 161 (recordId=167) instant = (1,275829) logEnd = (1,275887)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
419 : Purge : 1 slots starting at 160 (recordId=166) instant = (1,275887) logEnd = (1,275945)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
420 : Purge : 1 slots starting at 159 (recordId=165) instant = (1,275945) logEnd = (1,276003)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
421 : Purge : 1 slots starting at 158 (recordId=164) instant = (1,276003) logEnd = (1,276061)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
422 : Purge : 1 slots starting at 157 (recordId=163) instant = (1,276061) logEnd = (1,276119)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
423 : Purge : 1 slots starting at 156 (recordId=162) instant = (1,276119) logEnd = (1,276177)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
424 : Purge : 1 slots starting at 155 (recordId=161) instant = (1,276177) logEnd = (1,276235)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
425 : Purge : 1 slots starting at 154 (recordId=160) instant = (1,276235) logEnd = (1,276293)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
426 : Purge : 1 slots starting at 153 (recordId=159) instant = (1,276293) logEnd = (1,276351)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
427 : Purge : 1 slots starting at 152 (recordId=158) instant = (1,276351) logEnd = (1,276409)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
428 : Purge : 1 slots starting at 151 (recordId=157) instant = (1,276409) logEnd = (1,276467)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
429 : Purge : 1 slots starting at 150 (recordId=156) instant = (1,276467) logEnd = (1,276525)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
430 : Purge : 1 slots starting at 149 (recordId=155) instant = (1,276525) logEnd = (1,276583)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
431 : Purge : 1 slots starting at 148 (recordId=154) instant = (1,276583) logEnd = (1,276641)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
432 : Purge : 1 slots starting at 147 (recordId=153) instant = (1,276641) logEnd = (1,276699)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
433 : Purge : 1 slots starting at 146 (recordId=152) instant = (1,276699) logEnd = (1,276757)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
434 : Purge : 1 slots starting at 145 (recordId=151) instant = (1,276757) logEnd = (1,276815)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
435 : Purge : 1 slots starting at 144 (recordId=150) instant = (1,276815) logEnd = (1,276873)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
436 : Purge : 1 slots starting at 143 (recordId=149) instant = (1,276873) logEnd = (1,276931)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
437 : Purge : 1 slots starting at 142 (recordId=148) instant = (1,276931) logEnd = (1,276989)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
438 : Purge : 1 slots starting at 141 (recordId=147) instant = (1,276989) logEnd = (1,277047)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
439 : Purge : 1 slots starting at 140 (recordId=146) instant = (1,277047) logEnd = (1,277105)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
440 : Purge : 1 slots starting at 139 (recordId=145) instant = (1,277105) logEnd = (1,277163)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
441 : Purge : 1 slots starting at 138 (recordId=144) instant = (1,277163) logEnd = (1,277221)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
442 : Purge : 1 slots starting at 137 (recordId=143) instant = (1,277221) logEnd = (1,277279)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
443 : Purge : 1 slots starting at 136 (recordId=142) instant = (1,277279) logEnd = (1,277337)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
444 : Purge : 1 slots starting at 135 (recordId=141) instant = (1,277337) logEnd = (1,277395)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
445 : Purge : 1 slots starting at 134 (recordId=140) instant = (1,277395) logEnd = (1,277453)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
446 : Purge : 1 slots starting at 133 (recordId=139) instant = (1,277453) logEnd = (1,277511)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
447 : Purge : 1 slots starting at 132 (recordId=138) instant = (1,277511) logEnd = (1,277569)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
448 : Purge : 1 slots starting at 131 (recordId=137) instant = (1,277569) logEnd = (1,277627)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
449 : Purge : 1 slots starting at 130 (recordId=136) instant = (1,277627) logEnd = (1,277685)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
450 : Purge : 1 slots starting at 129 (recordId=135) instant = (1,277685) logEnd = (1,277743)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
451 : Purge : 1 slots starting at 128 (recordId=134) instant = (1,277743) logEnd = (1,277801)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
452 : Purge : 1 slots starting at 127 (recordId=133) instant = (1,277801) logEnd = (1,277859)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
453 : Purge : 1 slots starting at 126 (recordId=132) instant = (1,277859) logEnd = (1,277917)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
454 : Purge : 1 slots starting at 125 (recordId=131) instant = (1,277917) logEnd = (1,277975)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
455 : Purge : 1 slots starting at 124 (recordId=130) instant = (1,277975) logEnd = (1,278033)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
456 : Purge : 1 slots starting at 123 (recordId=129) instant = (1,278033) logEnd = (1,278091)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
457 : Purge : 1 slots starting at 122 (recordId=128) instant = (1,278091) logEnd = (1,278149)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
458 : Purge : 1 slots starting at 121 (recordId=127) instant = (1,278149) logEnd = (1,278207)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
459 : Purge : 1 slots starting at 120 (recordId=126) instant = (1,278243) logEnd = (1,278301)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
460 : Purge : 1 slots starting at 119 (recordId=125) instant = (1,278301) logEnd = (1,278359)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
461 : Purge : 1 slots starting at 118 (recordId=124) instant = (1,278359) logEnd = (1,278417)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
462 : Purge : 1 slots starting at 117 (recordId=123) instant = (1,278417) logEnd = (1,278475)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
463 : Purge : 1 slots starting at 116 (recordId=122) instant = (1,278475) logEnd = (1,278533)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
464 : Purge : 1 slots starting at 115 (recordId=121) instant = (1,278533) logEnd = (1,278591)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
465 : Purge : 1 slots starting at 114 (recordId=120) instant = (1,278591) logEnd = (1,278649)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
466 : Purge : 1 slots starting at 113 (recordId=119) instant = (1,278649) logEnd = (1,278707)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
467 : Purge : 1 slots starting at 112 (recordId=118) instant = (1,278707) logEnd = (1,278765)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
468 : Purge : 1 slots starting at 111 (recordId=117) instant = (1,278765) logEnd = (1,278823)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
469 : Purge : 1 slots starting at 109 (recordId=115) instant = (1,278823) logEnd = (1,278881)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
470 : Purge : 1 slots starting at 108 (recordId=114) instant = (1,278881) logEnd = (1,278939)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
471 : Purge : 1 slots starting at 107 (recordId=113) instant = (1,278939) logEnd = (1,278997)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
472 : Purge : 1 slots starting at 106 (recordId=112) instant = (1,278997) logEnd = (1,279055)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
473 : Purge : 1 slots starting at 105 (recordId=111) instant = (1,279055) logEnd = (1,279113)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
474 : Purge : 1 slots starting at 104 (recordId=110) instant = (1,279113) logEnd = (1,279171)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
475 : Purge : 1 slots starting at 103 (recordId=109) instant = (1,279171) logEnd = (1,279229)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
476 : Purge : 1 slots starting at 102 (recordId=108) instant = (1,279229) logEnd = (1,279287)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: scanned 255 : Page Operation: Page(3,Container(0, 913)) pageVersion
477 : Purge : 1 slots starting at 101 (recordId=107) instant = (1,279388) logEnd = (1,279446)
logIn at 23 available 19
DEBUG LogTrace OUTPUT: Rollback log record at instant (1,279388) : Page Operation: Page(3,Container(0,
913)) pageVersion 477 : Purge : 1 slots starting at 101 (recordId=107)
page id Page(3,Container(0, 913)) Overflow: false PageVersion: 579 SlotsInUse: 2 DeletedRowCount:
0 PageStatus: 1 NextId: 199 firstFreeByte: 133 freeSpace: 3943 totalSpace: 4028 spareSpace:
0 PageSize: 4096
page id Page(3,Container(0, 913)) Overflow: false PageVersion: 579 SlotsInUse: 2 DeletedRowCount:
0 PageStatus: 1 NextId: 199 firstFreeByte: 133 freeSpace: 3943 totalSpace: 4028 spareSpace:
0 PageSize: 4096


> Assert failure in BasePage.shiftUp() when running store/onlineBackupTest4.sql
> -----------------------------------------------------------------------------
>
>          Key: DERBY-1248
>          URL: http://issues.apache.org/jira/browse/DERBY-1248
>      Project: Derby
>         Type: Bug

>   Components: Store, Regression Test Failure
>     Versions: 10.2.0.0
>  Environment: Sun JVM 1.5.0_04 on Solaris 10 x86. Derby from trunk (revision 396285).
Sane build.
>     Reporter: Knut Anders Hatlen
>  Attachments: linuxfailure.zip, solaris-singlecpu.zip, solarisfailure.zip, storemore.zip,
test2_379.jar, test335.jar
>
> I saw this error when I ran derbyall.
> ********* Diff file derbyall/storeall/storemore/onlineBackupTest4.diff
> *** Start: onlineBackupTest4 jdk1.5.0_04 storeall:storemore 2006-04-24 11:51:50 ***
> 68 del
> < ij(CONNECTION1)> select * from ctest;
> 69 del
> < ID         |NAME                                                               
                                                            
> 70 del
> < --------------------------------------------------------------------------------------------------------------------------------------------
> 71 del
> < 1          |derby backup/compress test                                         
                                                           &
> 72 del
> < 2          |derby backup/compress test                                         
                                                           &
> 73 del
> < 300        |derby backup/compress test                                         
                                                           &
> 74 del
> < 509        |derby backup/compress test                                         
                                                           &
> 75 del
> < 510        |derby backup/compress test                                         
                                                           &
> 76 del
> < 511        |derby backup/compress test                                         
                                                           &
> 77 del
> < 512        |derby backup/compress test                                         
                                                           &
> 78 del
> < ij(CONNECTION1)> insert into ctest values(2000, 'restore was successfil') ;
> 79 del
> < 1 row inserted/updated/deleted
> 80 del
> < ij(CONNECTION1)> 
> 80 add
> > org.apache.derby.shared.common.sanity.AssertFailure: ASSERT FAILED shiftUp failed,
low must be between 0 and recordCount.  low = 140, recordCount = 2
> > ERROR XJ040: Failed to start database 'wombat', see the next exception for details.
> > ERROR XJ001: Java exception: 'ASSERT FAILED shiftUp failed, low must be between
0 and recordCount.  low = 140, recordCount = 2: org.apache.derby.shared.common.sanity.AssertFailure'.
> > ij> select * from ctest;
> > IJ ERROR: Unable to establish connection
> > ij> insert into ctest values(2000, 'restore was successfil') ;
> > IJ ERROR: Unable to establish connection
> > ij> 
> Test Failed.
> *** End:   onlineBackupTest4 jdk1.5.0_04 storeall:storemore 2006-04-24 11:51:56 ***
> The test usually succeeds, but I managed to reproduce the failure by running this loop
in the shell:
> touch onlineBackupTest4.pass
> while [ -f onlineBackupTest4.pass ]; do
>     rm onlineBackupTest4.pass
>     java org.apache.derbyTesting.functionTests.harness.RunTest store/onlineBackupTest4.sql
> done

-- 
This message is automatically generated by JIRA.
-
If you think it was sent incorrectly contact one of the administrators:
   http://issues.apache.org/jira/secure/Administrators.jspa
-
For more information on JIRA, see:
   http://www.atlassian.com/software/jira


Mime
View raw message