11204 RAC日志记录的时间与操作系统时间不一致

RAC搭建完成以后，在系统层面做了时区改动之后，发现RAC日志记录的时候与操作系统时间不一致。

其中包括

AWR生成的时间点

数据库alert日志

CRS各种日志

等等

举个例子:
kaycsqdb001r:/u01/app/11.2.0/grid/log/kaycsqdb001r$date

Fri Oct 17 11:06:37 CST 2014
<<<这个时间点,开另外一个窗口执行集群启动命令

kaycsqdb001r:/u01/app/11.2.0/grid/log/kaycsqdb001r$tail -f al*1r.log <<<监测日志输出

2014-10-16 22:06:24.941:

[/u01/app/11.2.0/grid/bin/orarootagent.bin(3146170)]CRS-2302:Cannot get GPnP profile. Error CLSGPNP_NO_DAEMON (GPNPD daemon is not running).

2014-10-16 22:06:30.145:

[ohasd(5242990)]CRS-2302:Cannot get GPnP profile. Error CLSGPNP_NO_DAEMON (GPNPD daemon is not running).

2014-10-16 22:06:30.162:

[gpnpd(5767206)]CRS-2328:GPNPD started on node kaycsqdb001r.

2014-10-16 22:06:33.415:

[cssd(3277140)]CRS-1713:CSSD daemon is started in clustered mode

2014-10-16 22:06:34.856:

[ohasd(5242990)]CRS-2767:Resource state recovery not attempted for 'ora.diskmon' as its target state is OFFLINE

2014-10-16 22:06:44.482:

[cssd(3277140)]CRS-1707:Lease acquisition for node kaycsqdb001r number 1 completed

2014-10-16 22:06:45.853:

[cssd(3277140)]CRS-1605:CSSD voting file is online: /dev/rhdisk2; details in /u01/app/11.2.0/grid/log/kaycsqdb001r/cssd/ocssd.log.

2014-10-16 22:06:50.018:

[cssd(3277140)]CRS-1601:CSSD Reconfiguration complete. Active nodes are kaycsqdb001r kaycsqdb002r .

2014-10-16 22:06:52.856:

[ctssd(3998150)]CRS-2407:The new Cluster Time Synchronization Service reference node is host kaycsqdb002r.

2014-10-16 22:06:52.858:

[ctssd(3998150)]CRS-2401:The Cluster Time Synchronization Service started on host kaycsqdb001r.

2014-10-16 22:06:54.468:

[ohasd(5242990)]CRS-2767:Resource state recovery not attempted for 'ora.diskmon' as its target state is OFFLINE

2014-10-16 22:06:58.959:

[ctssd(3998150)]CRS-2408:The clock on host kaycsqdb001r has been updated by the Cluster Time Synchronization Service to be synchronous with the mean cluster time.

2014-10-16 22:07:04.036:

[/u01/app/11.2.0/grid/bin/orarootagent.bin(6684836)]CRS-5018:(:CLSN00037:) Removed unused HAIP route: 169.254.255.255 / 255.255.0.0 / 169.254.152.93 / en1

[client(3604840)]CRS-10001:16-Oct-14 22:07 ACFS-9391: Checking for existing ADVM/ACFS installation.

[client(3604842)]CRS-10001:16-Oct-14 22:07 ACFS-9392: Validating ADVM/ACFS installation files for operating system.

[client(3604844)]CRS-10001:16-Oct-14 22:07 ACFS-9393: Verifying ASM Administrator setup.

[client(3604846)]CRS-10001:16-Oct-14 22:07 ACFS-9308: Loading installed ADVM/ACFS drivers.

[client(3604852)]CRS-10001:16-Oct-14 22:07 ACFS-9154: Loading 'oracleadvm.ext' driver.

[client(3670458)]CRS-10001:16-Oct-14 22:07 ACFS-9154: Loading 'oracleacfs.ext' driver.

[client(7208994)]CRS-10001:16-Oct-14 22:07 ACFS-9327: Verifying ADVM/ACFS devices.

[client(3670464)]CRS-10001:16-Oct-14 22:07 ACFS-9156: Detecting control device '/dev/asm/.asm_ctl_spec'.

[client(3670468)]CRS-10001:16-Oct-14 22:07 ACFS-9156: Detecting control device '/dev/ofsctl'.

[client(3670472)]CRS-10001:16-Oct-14 22:07 ACFS-9322: completed

2014-10-16 22:07:19.261:

[crsd(5111996)]CRS-1012:The OCR service started on node kaycsqdb001r.

2014-10-16 22:07:19.303:

[evmd(4456814)]CRS-1401:EVMD started on node kaycsqdb001r.

2014-10-16 22:07:21.026:

[crsd(5111996)]CRS-1201:CRSD started on node kaycsqdb001r.

可以看到,日志写入时间比操作系统时间往近13小时.
这是由于新版本中的一个变化 ，GRID也有属于自己的时区设置。在安装过程中，默认值与操作系统的TZ环境变量相同。

microdb01:/u01/app/11.2.0/grid/crs/install$cat s_crsconfig_microdb01_env.txt

TZ=BEIST-8 <<<<<<<<<<<<<<<GRID的时区设置

NLS_LANG=AMERICAN_AMERICA.WE8ISO8859P1

RT_GRQ=ON

EXTSHM=OFF

TNS_ADMIN=

ORACLE_BASE=

microdb01:/u01/app/11.2.0/grid/crs/install$grep TZ /etc/environment

TZ=Asia/Shanghai <<<<<<<<<<<<<<<<<<系统的时区设置

microdb01:/u01/app/11.2.0/grid/crs/install$

会发现GRID的时区设置与系统环境变量TZ不同了。

解决方法：
编辑s_crsconfig_microdb01_env.txt设置TZ=Asia/Shanghai，重启集群服务即可恢复。
-------------------------------------------------------------------------------------------------

本文来自于我的技术博客 http://blog.csdn.net/robo23

转载请标注源文链接,否则追究法律责任!