2pc_patch_logs.log
application/octet-stream
Filename: 2pc_patch_logs.log
Type: application/octet-stream
Part: 1
Message:
Re: Speedup twophase transactions
2016-04-12 17:05:31 JST [87829]: [1-1] db=,user=,app=,client= LOG: database system was interrupted while in recovery at log time 2016-04-12 17:04:48 JST 2016-04-12 17:05:31 JST [87829]: [2-1] db=,user=,app=,client= HINT: If this has occurred more than once some data might be corrupted and you might need to choose an earlier recovery target. cp: /Users/ioltas/archive/5432/00000002.history: No such file or directory 2016-04-12 17:05:31 JST [87829]: [3-1] db=,user=,app=,client= LOG: entering standby mode 2016-04-12 17:05:31 JST [87829]: [4-1] db=,user=,app=,client= LOG: restored log file "000000010000000000000002" from archive 2016-04-12 17:05:31 JST [87829]: [5-1] db=,user=,app=,client= DEBUG: got WAL segment from archive 2016-04-12 17:05:31 JST [87829]: [6-1] db=,user=,app=,client= DEBUG: checkpoint record is at 0/2000060 2016-04-12 17:05:31 JST [87829]: [7-1] db=,user=,app=,client= DEBUG: redo record is at 0/2000028; shutdown FALSE 2016-04-12 17:05:31 JST [87829]: [8-1] db=,user=,app=,client= DEBUG: next transaction ID: 0:866; next OID: 12670 2016-04-12 17:05:31 JST [87829]: [9-1] db=,user=,app=,client= DEBUG: next MultiXactId: 1; next MultiXactOffset: 0 2016-04-12 17:05:31 JST [87829]: [10-1] db=,user=,app=,client= DEBUG: oldest unfrozen transaction ID: 858, in database 1 2016-04-12 17:05:31 JST [87829]: [11-1] db=,user=,app=,client= DEBUG: oldest MultiXactId: 1, in database 1 2016-04-12 17:05:31 JST [87829]: [12-1] db=,user=,app=,client= DEBUG: commit timestamp Xid oldest/newest: 0/0 2016-04-12 17:05:31 JST [87829]: [13-1] db=,user=,app=,client= DEBUG: transaction ID wrap limit is 2147484505, limited by database with OID 1 2016-04-12 17:05:31 JST [87829]: [14-1] db=,user=,app=,client= DEBUG: MultiXactId wrap limit is 2147483648, limited by database with OID 1 2016-04-12 17:05:31 JST [87829]: [15-1] db=,user=,app=,client= DEBUG: starting up replication slots 2016-04-12 17:05:31 JST [87829]: [16-1] db=,user=,app=,client= DEBUG: resetting unlogged relations: cleanup 1 init 0 2016-04-12 17:05:31 JST [87829]: [17-1] db=,user=,app=,client= DEBUG: initializing for hot standby 2016-04-12 17:05:31 JST [87829]: [18-1] db=,user=,app=,client= LOG: redo starts at 0/2000028 2016-04-12 17:05:31 JST [87829]: [19-1] db=,user=,app=,client= DEBUG: recovery snapshots are now enabled 2016-04-12 17:05:31 JST [87829]: [20-1] db=,user=,app=,client= CONTEXT: xlog redo at 0/2000028 for Standby/RUNNING_XACTS: nextXid 866 latestCompletedXid 865 oldestRunningXid 866 cp: /Users/ioltas/archive/5432/000000010000000000000003: No such file or directory 2016-04-12 17:05:31 JST [87829]: [21-1] db=,user=,app=,client= LOG: consistent recovery state reached at 0/3000850 2016-04-12 17:05:31 JST [87822]: [3-1] db=,user=,app=,client= LOG: database system is ready to accept read only connections 2016-04-12 17:05:31 JST [87829]: [22-1] db=,user=,app=,client= LOG: LockAcquire: lock [16384,16385] AccessExclusiveLock 2016-04-12 17:05:31 JST [87829]: [23-1] db=,user=,app=,client= CONTEXT: xlog redo at 0/3016578 for Standby/LOCK: xid 867 db 16384 rel 16385 2016-04-12 17:05:31 JST [87829]: [24-1] db=,user=,app=,client= LOG: LockAcquire: new: lock(0x114dd5e48) id(16384,16385,0,0,0,1) grantMask(0) req(0,0,0,0,0,0,0)=0 grant(0,0,0,0,0,0,0)=0 wait(0) type(AccessExclusiveLock) 2016-04-12 17:05:31 JST [87829]: [25-1] db=,user=,app=,client= CONTEXT: xlog redo at 0/3016578 for Standby/LOCK: xid 867 db 16384 rel 16385 2016-04-12 17:05:31 JST [87829]: [26-1] db=,user=,app=,client= LOG: LockAcquire: new: proclock(0x114e9c380) lock(0x114dd5e48) method(1) proc(0x11515aa40) hold(0) 2016-04-12 17:05:31 JST [87829]: [27-1] db=,user=,app=,client= CONTEXT: xlog redo at 0/3016578 for Standby/LOCK: xid 867 db 16384 rel 16385 2016-04-12 17:05:31 JST [87829]: [28-1] db=,user=,app=,client= LOG: LockCheckConflicts: no conflict: proclock(0x114e9c380) lock(0x114dd5e48) method(1) proc(0x11515aa40) hold(0) 2016-04-12 17:05:31 JST [87829]: [29-1] db=,user=,app=,client= CONTEXT: xlog redo at 0/3016578 for Standby/LOCK: xid 867 db 16384 rel 16385 2016-04-12 17:05:31 JST [87829]: [30-1] db=,user=,app=,client= LOG: GrantLock: lock(0x114dd5e48) id(16384,16385,0,0,0,1) grantMask(100) req(0,0,0,0,0,0,0)=1 grant(0,0,0,0,0,0,0)=1 wait(0) type(AccessExclusiveLock) 2016-04-12 17:05:31 JST [87829]: [31-1] db=,user=,app=,client= CONTEXT: xlog redo at 0/3016578 for Standby/LOCK: xid 867 db 16384 rel 16385 2016-04-12 17:05:31 JST [87829]: [32-1] db=,user=,app=,client= LOG: LockAcquire: lock [16384,16385] AccessExclusiveLock 2016-04-12 17:05:31 JST [87829]: [33-1] db=,user=,app=,client= CONTEXT: xlog redo at 0/30165A8 for Standby/LOCK: xid 867 db 16384 rel 16385 2016-04-12 17:05:31 JST [87829]: [34-1] db=,user=,app=,client= LOG: lock_twophase_recover: found: lock(0x114dd5e48) id(16384,16385,0,0,0,1) grantMask(100) req(0,0,0,0,0,0,0)=1 grant(0,0,0,0,0,0,0)=1 wait(0) type(AccessExclusiveLock) 2016-04-12 17:05:31 JST [87829]: [35-1] db=,user=,app=,client= CONTEXT: xlog redo at 0/3016610 for Transaction/PREPARE: 2016-04-12 17:05:31 JST [87829]: [36-1] db=,user=,app=,client= LOG: lock_twophase_recover: new: proclock(0x114e9c330) lock(0x114dd5e48) method(1) proc(0x11515f5b8) hold(0) 2016-04-12 17:05:31 JST [87829]: [37-1] db=,user=,app=,client= CONTEXT: xlog redo at 0/3016610 for Transaction/PREPARE: 2016-04-12 17:05:31 JST [87829]: [38-1] db=,user=,app=,client= LOG: GrantLock: lock(0x114dd5e48) id(16384,16385,0,0,0,1) grantMask(100) req(0,0,0,0,0,0,0)=2 grant(0,0,0,0,0,0,0)=2 wait(0) type(AccessExclusiveLock) 2016-04-12 17:05:31 JST [87829]: [39-1] db=,user=,app=,client= CONTEXT: xlog redo at 0/3016610 for Transaction/PREPARE: 2016-04-12 17:05:31 JST [87829]: [40-1] db=,user=,app=,client= LOG: LockRelease: lock [16384,16385] AccessExclusiveLock 2016-04-12 17:05:31 JST [87829]: [41-1] db=,user=,app=,client= CONTEXT: xlog redo at 0/3016610 for Transaction/PREPARE: 2016-04-12 17:05:31 JST [87829]: [42-1] db=,user=,app=,client= LOG: LockRelease: lock [16384,16385] AccessExclusiveLock 2016-04-12 17:05:31 JST [87829]: [43-1] db=,user=,app=,client= CONTEXT: xlog redo at 0/3016610 for Transaction/PREPARE: 2016-04-12 17:05:31 JST [87829]: [44-1] db=,user=,app=,client= LOG: LockRelease: found: lock(0x114dd5e48) id(16384,16385,0,0,0,1) grantMask(100) req(0,0,0,0,0,0,0)=2 grant(0,0,0,0,0,0,0)=2 wait(0) type(AccessExclusiveLock) 2016-04-12 17:05:31 JST [87829]: [45-1] db=,user=,app=,client= CONTEXT: xlog redo at 0/3016610 for Transaction/PREPARE: 2016-04-12 17:05:31 JST [87829]: [46-1] db=,user=,app=,client= LOG: LockRelease: found: proclock(0x114e9c380) lock(0x114dd5e48) method(1) proc(0x11515aa40) hold(100) 2016-04-12 17:05:31 JST [87829]: [47-1] db=,user=,app=,client= CONTEXT: xlog redo at 0/3016610 for Transaction/PREPARE: 2016-04-12 17:05:31 JST [87829]: [48-1] db=,user=,app=,client= LOG: UnGrantLock: updated: lock(0x114dd5e48) id(16384,16385,0,0,0,1) grantMask(100) req(0,0,0,0,0,0,0)=1 grant(0,0,0,0,0,0,0)=1 wait(0) type(AccessExclusiveLock) 2016-04-12 17:05:31 JST [87829]: [49-1] db=,user=,app=,client= CONTEXT: xlog redo at 0/3016610 for Transaction/PREPARE: 2016-04-12 17:05:31 JST [87829]: [50-1] db=,user=,app=,client= LOG: UnGrantLock: updated: proclock(0x114e9c380) lock(0x114dd5e48) method(1) proc(0x11515aa40) hold(0) 2016-04-12 17:05:31 JST [87829]: [51-1] db=,user=,app=,client= CONTEXT: xlog redo at 0/3016610 for Transaction/PREPARE: 2016-04-12 17:05:31 JST [87829]: [52-1] db=,user=,app=,client= LOG: CleanUpLock: deleting: proclock(0x114e9c380) lock(0x114dd5e48) method(1) proc(0x11515aa40) hold(0) 2016-04-12 17:05:31 JST [87829]: [53-1] db=,user=,app=,client= CONTEXT: xlog redo at 0/3016610 for Transaction/PREPARE: 2016-04-12 17:05:31 JST [87829]: [54-1] db=,user=,app=,client= LOG: LockAcquire: lock [16384,16385] AccessExclusiveLock 2016-04-12 17:05:31 JST [87829]: [55-1] db=,user=,app=,client= CONTEXT: xlog redo at 0/3016940 for Standby/LOCK: xid 867 db 16384 rel 16385 2016-04-12 17:05:31 JST [87829]: [56-1] db=,user=,app=,client= LOG: LockAcquire: found: lock(0x114dd5e48) id(16384,16385,0,0,0,1) grantMask(100) req(0,0,0,0,0,0,0)=1 grant(0,0,0,0,0,0,0)=1 wait(0) type(AccessExclusiveLock) 2016-04-12 17:05:31 JST [87829]: [57-1] db=,user=,app=,client= CONTEXT: xlog redo at 0/3016940 for Standby/LOCK: xid 867 db 16384 rel 16385 2016-04-12 17:05:31 JST [87829]: [58-1] db=,user=,app=,client= LOG: LockAcquire: new: proclock(0x114e9c380) lock(0x114dd5e48) method(1) proc(0x11515aa40) hold(0) 2016-04-12 17:05:31 JST [87829]: [59-1] db=,user=,app=,client= CONTEXT: xlog redo at 0/3016940 for Standby/LOCK: xid 867 db 16384 rel 16385 2016-04-12 17:05:31 JST [87829]: [60-1] db=,user=,app=,client= LOG: LockCheckConflicts: conflicting (simple): proclock(0x114e9c380) lock(0x114dd5e48) method(1) proc(0x11515aa40) hold(0) 2016-04-12 17:05:31 JST [87829]: [61-1] db=,user=,app=,client= CONTEXT: xlog redo at 0/3016940 for Standby/LOCK: xid 867 db 16384 rel 16385 2016-04-12 17:05:31 JST [87829]: [62-1] db=,user=,app=,client= LOG: WaitOnLock: sleeping on lock: lock(0x114dd5e48) id(16384,16385,0,0,0,1) grantMask(100) req(0,0,0,0,0,0,0)=2 grant(0,0,0,0,0,0,0)=1 wait(0) type(AccessExclusiveLock) 2016-04-12 17:05:31 JST [87829]: [63-1] db=,user=,app=,client= CONTEXT: xlog redo at 0/3016940 for Standby/LOCK: xid 867 db 16384 rel 16385