Five fast years
Affects | Status | Importance | Assigned to | Milestone | |
---|---|---|---|---|---|
Akiban Persistit |
Fix Released
|
Low
|
Peter Beaman |
Bug Description
I don't know what was unusual here, other than that this is a volume with the akiban_txn reference (and no workaround entry yet in server.properties).
2012-07-27 09:29:44,340 [main] INFO ServiceManager - Starting services.
2012-07-27 09:29:44,490 [main] INFO TreeService - [main] INFO Akiban Persistit Copyright (c) 2012 Akiban Technologies Inc.
2012-07-27 09:29:44,685 [main] INFO TreeService - [main] INFO Recovery plan: will recover 193 pages and 1 committed transactions; will discard 0 uncommitted transactions
2012-07-27 09:29:44,698 [main] INFO TreeService - [main] INFO Allocating 25,460 buffers of size 16,384 bytes
2012-07-27 09:29:45,036 [main] INFO TreeService - [main] INFO Opening volume akiban_data (/akiban/
2012-07-27 09:29:45,507 [main] INFO TreeService - [main] INFO Opening volume akiban_system (/akiban/
2012-07-27 09:29:45,554 [JOURNAL_COPIER] WARN TreeService - [JOURNAL_COPIER] WARNING Missing volume akiban_txn referenced at journal address 54,000,088,216
2012-07-27 09:29:45,597 [main] INFO TreeService - [main] INFO Recovery done: 1 retained pages, 1 committed transactions, 0 errors
2012-07-27 09:29:50,759 [main] INFO ServiceManager - Akiban Server 1.4.0-SNAPSHOT. ready.
^C2012-07-27 09:29:53,887 [ShutdownHook] INFO ServiceManager - Stopping services normally.
2012-07-27 09:29:53,899 [ShutdownHook] INFO TreeService - [ShutdownHook] INFO Waited 30,000,000 seconds for IO operations to finish
2012-07-27 09:29:53,900 [ShutdownHook] INFO TreeService - [ShutdownHook] INFO Waited 60,000,000 seconds for IO operations to finish
2012-07-27 09:29:54,450 [ShutdownHook] INFO TreeService - [ShutdownHook] INFO Waited 90,000,000 seconds for IO operations to finish
2012-07-27 09:29:54,451 [ShutdownHook] INFO TreeService - [ShutdownHook] INFO Waited 120,000,000 seconds for IO operations to finish
2012-07-27 09:29:54,454 [ShutdownHook] INFO TreeService - [ShutdownHook] INFO Waited 150,000,000 seconds for IO operations to finish
2012-07-27 09:29:54,455 [ShutdownHook] INFO TreeService - [ShutdownHook] INFO Waited 180,000,000 seconds for IO operations to finish
2012-07-27 09:29:54,457 [ShutdownHook] WARN TreeService - [ShutdownHook] WARNING Missing volume akiban_txn referenced at journal address 54,000,088,216 (4 similar occurrences in 8 seconds)
2012-07-27 09:29:54,459 [ShutdownHook] INFO ServiceManager - Services stopped.
Related branches
- Nathan Williams: Pending requested
-
Diff: 770 lines (+287/-80)18 files modifiedsrc/main/java/com/persistit/BufferPool.java (+6/-5)
src/main/java/com/persistit/CheckpointManager.java (+2/-2)
src/main/java/com/persistit/JournalManager.java (+3/-20)
src/main/java/com/persistit/JournalManagerBench.java (+2/-1)
src/main/java/com/persistit/Persistit.java (+53/-27)
src/main/java/com/persistit/SessionId.java (+10/-0)
src/main/java/com/persistit/Transaction.java (+0/-1)
src/main/java/com/persistit/TransactionIndexBucket.java (+5/-9)
src/main/java/com/persistit/TransactionStatus.java (+20/-0)
src/main/java/com/persistit/VolumeHeader.java (+9/-1)
src/main/java/com/persistit/logging/LogBase.java (+3/-0)
src/main/java/com/persistit/util/Util.java (+4/-0)
src/test/java/com/persistit/IOFailureTest.java (+2/-0)
src/test/java/com/persistit/TransactionTest2.java (+43/-9)
src/test/java/com/persistit/stress/AbstractStressTest.java (+3/-1)
src/test/java/com/persistit/stress/AbstractSuite.java (+4/-4)
src/test/java/com/persistit/stress/StartStop.java (+2/-0)
src/test/java/com/persistit/unit/ExchangeTest.java (+116/-0)
Changed in akiban-persistit: | |
status: | Confirmed → Fix Committed |
assignee: | nobody → Peter Beaman (pbeaman) |
milestone: | none → 3.1.8 |
visibility: | private → public |
Changed in akiban-persistit: | |
status: | Fix Committed → Fix Released |
Looks to be a unit mix up in Persistit# waitForIOTaskSt op(). The begin and initial current times are collected as nanoseconds. The now time is collected as milliseconds. The log message is printed as (ms - ns) / 1000.