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