postgresql-2011-10-27_202007.log

2011-10-27 20:20:07.248 MDT [1267]: [1-1] LOG:  database system was interrupted; last known up at 2011-10-27 20:19:51 MDT
2011-10-27 20:20:07.248 MDT [1267]: [2-1] LOG:  creating missing WAL directory "pg_xlog/archive_status"
2011-10-27 20:20:07.251 MDT [1267]: [3-1] LOG:  entering standby mode
DEBUG:  received replication command: IDENTIFY_SYSTEM
DEBUG:  received replication command: START_REPLICATION D/82000000
2011-10-27 20:20:07.255 MDT [1268]: [1-1] LOG:  streaming replication successfully connected to primary
2011-10-27 20:20:07.256 MDT [1271]: [1-1] FATAL:  the database system is starting up
2011-10-27 20:20:07.848 MDT [1267]: [4-1] DEBUG:  checkpoint record is at D/824B10D0
2011-10-27 20:20:07.848 MDT [1267]: [5-1] DEBUG:  redo record is at D/82000020; shutdown FALSE
2011-10-27 20:20:07.848 MDT [1267]: [6-1] DEBUG:  next transaction ID: 0/20005378; next OID: 5843537
2011-10-27 20:20:07.848 MDT [1267]: [7-1] DEBUG:  next MultiXactId: 3095; next MultiXactOffset: 6233
2011-10-27 20:20:07.848 MDT [1267]: [8-1] DEBUG:  oldest unfrozen transaction ID: 1669, in database 1
2011-10-27 20:20:07.848 MDT [1267]: [9-1] DEBUG:  transaction ID wrap limit is 2147485316, limited by database with OID 1
2011-10-27 20:20:07.851 MDT [1267]: [10-1] DEBUG:  resetting unlogged relations: cleanup 1 init 0
2011-10-27 20:20:07.862 MDT [1267]: [11-1] DEBUG:  initializing for hot standby
2011-10-27 20:20:07.862 MDT [1267]: [12-1] LOG:  consistent recovery state reached at D/824B1128
2011-10-27 20:20:07.870 MDT [1267]: [13-1] LOG:  redo starts at D/82000020
2011-10-27 20:20:08.009 MDT [1267]: [14-1] LOG:  recovery snapshot waiting for non-overflowed snapshot or until oldest active xid on standby is at least 20005377 (now 20005124)
2011-10-27 20:20:08.009 MDT [1267]: [15-1] CONTEXT:  xlog redo  running xacts: nextXid 20005378 latestCompletedXid 20005377 oldestRunningXid 20005124; 133 xacts: 20005124 20005125 20005126 20005127 20005128 20005129 20005130 20005131 20005132 20005135 20005136 20005137 20005138 20005139 20005140 20005141 20005142 20005143 20005144 20005145 20005146 20005147 20005148 20005149 20005150 20005151 20005152 20005153 20005154 20005155 20005156 20005157 20005158 20005159 20005160 20005161 20005299 20005300 20005301 20005302 20005303 20005304 20005305 20005306 20005307 20005308 20005309 20005310 20005311 20005312 20005313 20005314 20005315 20005316 20005317 20005318 20005319 20005320 20005321 20005322 20005323 20005324 20005325 20005326 20005327 20005260 20005261 20005262 20005263 20005264 20005265 20005266 20005267 20005268 20005269 20005270 20005271 20005272 20005273 20005274 20005275 20005276 20005277 20005278 20005279 20005280 20005281 20005282 20005283 20005284 20005285 20005286 20005287 20005288 20005289 20005290 20005291 20005292 20005293 20005205 20005206 20005207 20005208 20005209 20005210 20005211 20005212 20005213 20005214 20005215 20005216 20005217 20005218 20005219 20005220 20005221 20005222 20005223 20005224 20005225 20005226 20005227 20005228 20005229 20005230 20005231 20005232 20005233 20005234 20005235 20005236 20005237 20005238; subxid ovf
2011-10-27 20:20:08.313 MDT [1315]: [1-1] FATAL:  the database system is starting up
2011-10-27 20:20:08.576 MDT [1267]: [16-1] LOG:  68 KnownAssignedXids (num=68 tail=0 head=111) [0]=20024422 [1]=20024423 [2]=20024424 [3]=20024425 [4]=20024426 [5]=20024427 [6]=20024428 [7]=20024429 [8]=20024430 [9]=20024431 [10]=20024432 [11]=20024433 [12]=20024434 [13]=20024435 [14]=20024436 [15]=20024437 [16]=20024438 [17]=20024439 [18]=20024440 [19]=20024441 [20]=20024442 [21]=20024443 [22]=20024444 [23]=20024445 [24]=20024446 [25]=20024447 [26]=20024448 [27]=20024449 [28]=20024450 [29]=20024451 [30]=20024452 [31]=20024453 [32]=20024454 [33]=20024455 [54]=20024476 [55]=20024477 [56]=20024478 [57]=20024479 [58]=20024480 [59]=20024481 [60]=20024482 [61]=20024483 [62]=20024484 [63]=20024485 [64]=20024486 [65]=20024487 [66]=20024488 [67]=20024489 [68]=20024490 [69]=20024491 [70]=20024492 [71]=20024493 [72]=20024494 [73]=20024495 [74]=20024496 [75]=20024497 [76]=20024498 [77]=20024499 [78]=20024500 [79]=20024501 [80]=20024502 [81]=20024503 [82]=20024504 [83]=20024505 [84]=20024506 [85]=20024507 [86]=20024508 [87]=20024509 
2011-10-27 20:20:08.576 MDT [1267]: [17-1] CONTEXT:  xlog redo  running xacts: nextXid 20024533 latestCompletedXid 20024530 oldestRunningXid 20024422; 70 xacts: 20024476 20024477 20024478 20024479 20024480 20024481 20024482 20024483 20024484 20024485 20024486 20024487 20024488 20024489 20024490 20024491 20024492 20024493 20024494 20024495 20024496 20024497 20024498 20024499 20024500 20024501 20024502 20024503 20024504 20024505 20024506 20024507 20024508 20024509 20024532 20024422 20024423 20024424 20024425 20024426 20024427 20024428 20024429 20024430 20024431 20024432 20024433 20024434 20024435 20024436 20024437 20024438 20024439 20024440 20024441 20024442 20024443 20024444 20024445 20024446 20024447 20024448 20024449 20024450 20024451 20024452 20024453 20024454 20024455 20024531
2011-10-27 20:20:08.576 MDT [1267]: [18-1] FATAL:  out-of-order XID insertion in KnownAssignedXids
2011-10-27 20:20:08.576 MDT [1267]: [19-1] CONTEXT:  xlog redo  running xacts: nextXid 20024533 latestCompletedXid 20024530 oldestRunningXid 20024422; 70 xacts: 20024476 20024477 20024478 20024479 20024480 20024481 20024482 20024483 20024484 20024485 20024486 20024487 20024488 20024489 20024490 20024491 20024492 20024493 20024494 20024495 20024496 20024497 20024498 20024499 20024500 20024501 20024502 20024503 20024504 20024505 20024506 20024507 20024508 20024509 20024532 20024422 20024423 20024424 20024425 20024426 20024427 20024428 20024429 20024430 20024431 20024432 20024433 20024434 20024435 20024436 20024437 20024438 20024439 20024440 20024441 20024442 20024443 20024444 20024445 20024446 20024447 20024448 20024449 20024450 20024451 20024452 20024453 20024454 20024455 20024531
2011-10-27 20:20:08.582 MDT [1192]: [2-1] LOG:  startup process (PID 1267) exited with exit code 1
2011-10-27 20:20:08.582 MDT [1192]: [3-1] LOG:  terminating any other active server processes
2011-10-27 20:20:08.659 MDT [1264]: [1-1] DEBUG:  logger shutting down