[ 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
