```bash
2023-05-04T03:59:21,018 DEBUG [pool-6-thread-198] metrics.PerfLogger: </PERFLOG method=create_database start=1683172451202 end=1683172761018 duration=309816 from=org.apache.hadoop.hive.metastore.RetryingHMSHandler threadId=196 retryCount=-1 error=true>
2023-05-04T03:59:21,018 INFO [pool-6-thread-198] metastore.HiveMetaStore: 196: Cleaning up thread local RawStore...
2023-05-04T03:59:21,018 INFO [pool-6-thread-198] HiveMetaStore.audit: ugi=root ip=10.0.200.131 cmd=Cleaning up thread local RawStore...
2023-05-04T03:59:21,018 DEBUG [pool-6-thread-198] metastore.ObjectStore: RawStore: org.apache.hadoop.hive.metastore.ObjectStore@612e4728, with PersistenceManager: org.datanucleus.api.jdo.JDOPersistenceManager@7c7fcf53 will be shutdown
2023-05-04T03:59:21,018 INFO [pool-6-thread-198] metastore.HiveMetaStore: 196: Done cleaning up thread local RawStore
2023-05-04T03:59:21,018 INFO [pool-6-thread-198] HiveMetaStore.audit: ugi=root ip=10.0.200.131 cmd=Done cleaning up thread local RawStore
2023-05-04T03:59:22,939 INFO [pool-6-thread-198] metastore.HiveMetaStore: 196: Done cleaning up thread local RawStore
2023-05-04T03:59:22,939 INFO [pool-6-thread-198] HiveMetaStore.audit: ugi=root ip=10.0.200.168 cmd=Done cleaning up thread local RawStore
2023-05-04T03:59:22,939 INFO [pool-6-thread-199] metastore.HiveMetaStore: 195: Done cleaning up thread local RawStore
2023-05-04T03:59:22,939 INFO [pool-6-thread-199] HiveMetaStore.audit: ugi=root ip=10.0.200.168 cmd=Done cleaning up thread local RawStore
2023-05-04T03:59:32,938 INFO [pool-6-thread-199] metastore.HiveMetaStore: 195: Done cleaning up thread local RawStore
2023-05-04T03:59:32,939 INFO [pool-6-thread-199] HiveMetaStore.audit: ugi=root ip=10.0.200.168 cmd=Done cleaning up thread local RawStore
2023-05-04T03:59:32,939 INFO [pool-6-thread-198] metastore.HiveMetaStore: 196: Done cleaning up thread local RawStore
2023-05-04T03:59:32,939 INFO [pool-6-thread-198] HiveMetaStore.audit: ugi=root ip=10.0.200.168 cmd=Done cleaning up thread local RawStore
2023-05-04T03:59:35,138 DEBUG [HikariPool-1 housekeeper] pool.HikariPool: HikariPool-1 - Pool stats (total=10, active=0, idle=10, waiting=0)
2023-05-04T03:59:35,762 DEBUG [HikariPool-2 housekeeper] pool.HikariPool: HikariPool-2 - Pool stats (total=10, active=0, idle=10, waiting=0)
2023-05-04T03:59:35,880 DEBUG [pool-6-thread-198] metrics.PerfLogger: <PERFLOG method=get_all_databases from=org.apache.hadoop.hive.metastore.RetryingHMSHandler>
2023-05-04T03:59:35,880 INFO [pool-6-thread-198] metastore.HiveMetaStore: 196: source:10.0.200.131 get_databases: @hive#
2023-05-04T03:59:35,880 INFO [pool-6-thread-198] HiveMetaStore.audit: ugi=root ip=10.0.200.131 cmd=source:10.0.200.131 get_databases: @hive#
2023-05-04T03:59:35,881 INFO [pool-6-thread-198] metastore.HiveMetaStore: 196: Opening raw store with implementation class:org.apache.hadoop.hive.metastore.ObjectStore
2023-05-04T03:59:35,881 WARN [pool-6-thread-198] metastore.ObjectStore: datanucleus.autoStartMechanismMode is set to unsupported value null . Setting it to value: ignored
2023-05-04T03:59:35,881 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.schema.autoCreateAll value null from jpox.properties with false
2023-05-04T03:59:35,881 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding javax.jdo.option.ConnectionDriverName value null from jpox.properties with org.postgresql.Driver
2023-05-04T03:59:35,881 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.connectionPool.maxPoolSize value null from jpox.properties with 10
2023-05-04T03:59:35,881 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.connectionPoolingType value null from jpox.properties with HikariCP
2023-05-04T03:59:35,881 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding javax.jdo.option.ConnectionURL value null from jpox.properties with jdbc:postgresql://lighthouse-outpost-dev-hivemetastoredb.cm25znb924dp.ap-northeast-1.rds.amazonaws.com:5432/hivemetastoredb?allowPublicKeyRetrieval=true&useSSL=false&serverTimezone=UTC
2023-05-04T03:59:35,881 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding javax.jdo.option.ConnectionUserName value null from jpox.properties with postgres
2023-05-04T03:59:35,881 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.autoStartMechanismMode value null from jpox.properties with ignored
2023-05-04T03:59:35,881 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.cache.level2 value null from jpox.properties with false
2023-05-04T03:59:35,881 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.cache.level2.type value null from jpox.properties with none
2023-05-04T03:59:35,881 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.rdbms.initializeColumnInfo value null from jpox.properties with NONE
2023-05-04T03:59:35,881 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.plugin.pluginRegistryBundleCheck value null from jpox.properties with LOG
2023-05-04T03:59:35,881 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.transactionIsolation value null from jpox.properties with read-committed
2023-05-04T03:59:35,881 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.rdbms.useLegacyNativeValueStrategy value null from jpox.properties with true
2023-05-04T03:59:35,881 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding javax.jdo.option.DetachAllOnCommit value null from jpox.properties with true
2023-05-04T03:59:35,881 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.identifierFactory value null from jpox.properties with datanucleus1
2023-05-04T03:59:35,881 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding javax.jdo.PersistenceManagerFactoryClass value null from jpox.properties with org.datanucleus.api.jdo.JDOPersistenceManagerFactory
2023-05-04T03:59:35,881 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding javax.jdo.option.Multithreaded value null from jpox.properties with true
2023-05-04T03:59:35,881 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding javax.jdo.option.NonTransactionalRead value null from jpox.properties with true
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.storeManagerType value null from jpox.properties with rdbms
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.schema.validateColumns value null from jpox.properties with false
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.schema.validateConstraints value null from jpox.properties with false
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.schema.validateTables value null from jpox.properties with false
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.rdbms.useLegacyNativeValueStrategy = true
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.schema.validateConstraints = false
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: javax.jdo.option.ConnectionUserName = postgres
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.storeManagerType = rdbms
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: javax.jdo.option.ConnectionDriverName = org.postgresql.Driver
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.cache.level2.type = none
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: javax.jdo.option.NonTransactionalRead = true
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: javax.jdo.option.ConnectionURL = jdbc:postgresql://lighthouse-outpost-dev-hivemetastoredb.cm25znb924dp.ap-northeast-1.rds.amazonaws.com:5432/hivemetastoredb?allowPublicKeyRetrieval=true&useSSL=false&serverTimezone=UTC
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.connectionPool.maxPoolSize = 10
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.rdbms.initializeColumnInfo = NONE
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.connectionPoolingType = HikariCP
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.schema.validateColumns = false
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.transactionIsolation = read-committed
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.cache.level2 = false
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.schema.autoCreateAll = false
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.identifierFactory = datanucleus1
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: javax.jdo.option.Multithreaded = true
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.plugin.pluginRegistryBundleCheck = LOG
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: javax.jdo.PersistenceManagerFactoryClass = org.datanucleus.api.jdo.JDOPersistenceManagerFactory
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: javax.jdo.option.DetachAllOnCommit = true
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.schema.validateTables = false
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.autoStartMechanismMode = ignored
2023-05-04T03:59:35,882 DEBUG [pool-6-thread-198] metastore.ObjectStore: RawStore: org.apache.hadoop.hive.metastore.ObjectStore@4a29ba61, with PersistenceManager: null will be shutdown
2023-05-04T03:59:35,882 INFO [pool-6-thread-198] metastore.ObjectStore: ObjectStore, initialize called
2023-05-04T03:59:35,883 DEBUG [pool-6-thread-198] pool.PoolBase: HikariPool-2 - Reset (autoCommit) on connection org.postgresql.jdbc.PgConnection@5780a7c4
2023-05-04T03:59:35,883 DEBUG [pool-6-thread-198] pool.PoolBase: HikariPool-2 - Reset (autoCommit) on connection org.postgresql.jdbc.PgConnection@5780a7c4
2023-05-04T03:59:35,884 DEBUG [pool-6-thread-198] pool.PoolBase: HikariPool-2 - Reset (autoCommit) on connection org.postgresql.jdbc.PgConnection@5780a7c4
2023-05-04T03:59:35,886 DEBUG [pool-6-thread-198] pool.PoolBase: HikariPool-1 - Reset (autoCommit) on connection org.postgresql.jdbc.PgConnection@36f94433
2023-05-04T03:59:35,886 INFO [pool-6-thread-198] metastore.MetaStoreDirectSql: Using direct SQL, underlying DB is POSTGRES
2023-05-04T03:59:35,886 DEBUG [pool-6-thread-198] metastore.ObjectStore: RawStore: org.apache.hadoop.hive.metastore.ObjectStore@4a29ba61, with PersistenceManager: org.datanucleus.api.jdo.JDOPersistenceManager@25602c68 created in the thread with id: 219
2023-05-04T03:59:35,886 INFO [pool-6-thread-198] metastore.ObjectStore: Initialized ObjectStore
2023-05-04T03:59:35,886 DEBUG [pool-6-thread-198] metastore.ObjectStore: Open transaction: count = 1, isActive = true at:
org.apache.hadoop.hive.metastore.ObjectStore.getAllDatabases(ObjectStore.java:1151)
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
2023-05-04T03:59:35,888 DEBUG [pool-6-thread-198] metastore.ObjectStore: Commit transaction: count = 0, isactive true at:
org.apache.hadoop.hive.metastore.ObjectStore.getAllDatabases(ObjectStore.java:1158)
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
2023-05-04T03:59:35,888 DEBUG [pool-6-thread-198] pool.PoolBase: HikariPool-1 - Reset (autoCommit) on connection org.postgresql.jdbc.PgConnection@36f94433
2023-05-04T03:59:35,888 DEBUG [pool-6-thread-198] metrics.PerfLogger: </PERFLOG method=get_all_databases start=1683172775880 end=1683172775888 duration=8 from=org.apache.hadoop.hive.metastore.RetryingHMSHandler threadId=196 retryCount=0 error=false>
2023-05-04T03:59:35,889 INFO [pool-6-thread-198] metastore.HiveMetaStore: 196: Cleaning up thread local RawStore...
2023-05-04T03:59:35,889 INFO [pool-6-thread-198] HiveMetaStore.audit: ugi=root ip=10.0.200.131 cmd=Cleaning up thread local RawStore...
2023-05-04T03:59:35,889 DEBUG [pool-6-thread-198] metastore.ObjectStore: RawStore: org.apache.hadoop.hive.metastore.ObjectStore@4a29ba61, with PersistenceManager: org.datanucleus.api.jdo.JDOPersistenceManager@25602c68 will be shutdown
2023-05-04T03:59:35,889 INFO [pool-6-thread-198] metastore.HiveMetaStore: 196: Done cleaning up thread local RawStore
2023-05-04T03:59:35,889 INFO [pool-6-thread-198] HiveMetaStore.audit: ugi=root ip=10.0.200.131 cmd=Done cleaning up thread local RawStore
2023-05-04T03:59:35,899 DEBUG [pool-6-thread-198] metrics.PerfLogger: <PERFLOG method=create_database from=org.apache.hadoop.hive.metastore.RetryingHMSHandler>
2023-05-04T03:59:35,900 INFO [pool-6-thread-198] metastore.HiveMetaStore: 196: source:10.0.200.131 create_database: Database(name:test, description:null, locationUri:s3a://ipass-datala-o01427051a3dc18b69nmaa8betpfvhubhf2siqapn10--op-s3/test/, parameters:{presto_query_id=20230504_035935_00009_dhuk6}, ownerName:trino, ownerType:USER)
2023-05-04T03:59:35,900 INFO [pool-6-thread-198] HiveMetaStore.audit: ugi=root ip=10.0.200.131 cmd=source:10.0.200.131 create_database: Database(name:test, description:null, locationUri:s3a://ipass-datala-o01427051a3dc18b69nmaa8betpfvhubhf2siqapn10--op-s3/test/, parameters:{presto_query_id=20230504_035935_00009_dhuk6}, ownerName:trino, ownerType:USER)
2023-05-04T03:59:35,901 INFO [pool-6-thread-198] metastore.HiveMetaStore: 196: Opening raw store with implementation class:org.apache.hadoop.hive.metastore.ObjectStore
2023-05-04T03:59:35,901 WARN [pool-6-thread-198] metastore.ObjectStore: datanucleus.autoStartMechanismMode is set to unsupported value null . Setting it to value: ignored
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.schema.autoCreateAll value null from jpox.properties with false
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding javax.jdo.option.ConnectionDriverName value null from jpox.properties with org.postgresql.Driver
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.connectionPool.maxPoolSize value null from jpox.properties with 10
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.connectionPoolingType value null from jpox.properties with HikariCP
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding javax.jdo.option.ConnectionURL value null from jpox.properties with jdbc:postgresql://lighthouse-outpost-dev-hivemetastoredb.cm25znb924dp.ap-northeast-1.rds.amazonaws.com:5432/hivemetastoredb?allowPublicKeyRetrieval=true&useSSL=false&serverTimezone=UTC
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding javax.jdo.option.ConnectionUserName value null from jpox.properties with postgres
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.autoStartMechanismMode value null from jpox.properties with ignored
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.cache.level2 value null from jpox.properties with false
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.cache.level2.type value null from jpox.properties with none
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.rdbms.initializeColumnInfo value null from jpox.properties with NONE
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.plugin.pluginRegistryBundleCheck value null from jpox.properties with LOG
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.transactionIsolation value null from jpox.properties with read-committed
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.rdbms.useLegacyNativeValueStrategy value null from jpox.properties with true
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding javax.jdo.option.DetachAllOnCommit value null from jpox.properties with true
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.identifierFactory value null from jpox.properties with datanucleus1
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding javax.jdo.PersistenceManagerFactoryClass value null from jpox.properties with org.datanucleus.api.jdo.JDOPersistenceManagerFactory
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding javax.jdo.option.Multithreaded value null from jpox.properties with true
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding javax.jdo.option.NonTransactionalRead value null from jpox.properties with true
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.storeManagerType value null from jpox.properties with rdbms
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.schema.validateColumns value null from jpox.properties with false
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.schema.validateConstraints value null from jpox.properties with false
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: Overriding datanucleus.schema.validateTables value null from jpox.properties with false
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.rdbms.useLegacyNativeValueStrategy = true
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.schema.validateConstraints = false
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: javax.jdo.option.ConnectionUserName = postgres
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.storeManagerType = rdbms
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: javax.jdo.option.ConnectionDriverName = org.postgresql.Driver
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.cache.level2.type = none
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: javax.jdo.option.NonTransactionalRead = true
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: javax.jdo.option.ConnectionURL = jdbc:postgresql://lighthouse-outpost-dev-hivemetastoredb.cm25znb924dp.ap-northeast-1.rds.amazonaws.com:5432/hivemetastoredb?allowPublicKeyRetrieval=true&useSSL=false&serverTimezone=UTC
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.connectionPool.maxPoolSize = 10
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.rdbms.initializeColumnInfo = NONE
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.connectionPoolingType = HikariCP
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.schema.validateColumns = false
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.transactionIsolation = read-committed
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.cache.level2 = false
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.schema.autoCreateAll = false
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.identifierFactory = datanucleus1
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: javax.jdo.option.Multithreaded = true
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.plugin.pluginRegistryBundleCheck = LOG
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: javax.jdo.PersistenceManagerFactoryClass = org.datanucleus.api.jdo.JDOPersistenceManagerFactory
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: javax.jdo.option.DetachAllOnCommit = true
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.schema.validateTables = false
2023-05-04T03:59:35,901 DEBUG [pool-6-thread-198] metastore.ObjectStore: datanucleus.autoStartMechanismMode = ignored
2023-05-04T03:59:35,902 DEBUG [pool-6-thread-198] metastore.ObjectStore: RawStore: org.apache.hadoop.hive.metastore.ObjectStore@7e6d1b93, with PersistenceManager: null will be shutdown
2023-05-04T03:59:35,902 INFO [pool-6-thread-198] metastore.ObjectStore: ObjectStore, initialize called
2023-05-04T03:59:35,903 DEBUG [pool-6-thread-198] pool.PoolBase: HikariPool-2 - Reset (autoCommit) on connection org.postgresql.jdbc.PgConnection@5780a7c4
2023-05-04T03:59:35,904 DEBUG [pool-6-thread-198] pool.PoolBase: HikariPool-2 - Reset (autoCommit) on connection org.postgresql.jdbc.PgConnection@5780a7c4
2023-05-04T03:59:35,904 DEBUG [pool-6-thread-198] pool.PoolBase: HikariPool-2 - Reset (autoCommit) on connection org.postgresql.jdbc.PgConnection@5780a7c4
2023-05-04T03:59:35,907 DEBUG [pool-6-thread-198] pool.PoolBase: HikariPool-1 - Reset (autoCommit) on connection org.postgresql.jdbc.PgConnection@36f94433
2023-05-04T03:59:35,907 INFO [pool-6-thread-198] metastore.MetaStoreDirectSql: Using direct SQL, underlying DB is POSTGRES
2023-05-04T03:59:35,907 DEBUG [pool-6-thread-198] metastore.ObjectStore: RawStore: org.apache.hadoop.hive.metastore.ObjectStore@7e6d1b93, with PersistenceManager: org.datanucleus.api.jdo.JDOPersistenceManager@66238e04 created in the thread with id: 219
2023-05-04T03:59:35,907 INFO [pool-6-thread-198] metastore.ObjectStore: Initialized ObjectStore
2023-05-04T03:59:35,907 DEBUG [pool-6-thread-198] metastore.ObjectStore: Open transaction: count = 1, isActive = true at:
org.apache.hadoop.hive.metastore.ObjectStore$GetHelper.start(ObjectStore.java:3639)
org.apache.hadoop.hive.metastore.ObjectStore$GetHelper.run(ObjectStore.java:3609)
org.apache.hadoop.hive.metastore.ObjectStore.getDatabaseInternal(ObjectStore.java:1019)
2023-05-04T03:59:35,909 DEBUG [pool-6-thread-198] metastore.ObjectStore: Commit transaction: count = 0, isactive true at:
org.apache.hadoop.hive.metastore.ObjectStore$GetHelper.commit(ObjectStore.java:3727)
org.apache.hadoop.hive.metastore.ObjectStore$GetHelper.run(ObjectStore.java:3624)
org.apache.hadoop.hive.metastore.ObjectStore.getDatabaseInternal(ObjectStore.java:1019)
2023-05-04T03:59:35,909 DEBUG [pool-6-thread-198] pool.PoolBase: HikariPool-1 - Reset (autoCommit) on connection org.postgresql.jdbc.PgConnection@36f94433
2023-05-04T03:59:35,909 DEBUG [pool-6-thread-198] metastore.ObjectStore: db details for db test retrieved using SQL in 2.134251ms
2023-05-04T03:59:35,909 WARN [pool-6-thread-198] metastore.ObjectStore: Failed to get database hive.test, returning NoSuchObjectException
2023-05-04T03:59:35,910 DEBUG [pool-6-thread-198] metastore.ObjectStore: Fetching catalog hive
2023-05-04T03:59:35,910 DEBUG [pool-6-thread-198] metastore.ObjectStore: Open transaction: count = 1, isActive = true at:
org.apache.hadoop.hive.metastore.ObjectStore.getMCatalog(ObjectStore.java:905)
org.apache.hadoop.hive.metastore.ObjectStore.getCatalog(ObjectStore.java:852)
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
2023-05-04T03:59:35,912 DEBUG [pool-6-thread-198] metastore.ObjectStore: Commit transaction: count = 0, isactive true at:
org.apache.hadoop.hive.metastore.ObjectStore.getMCatalog(ObjectStore.java:912)
org.apache.hadoop.hive.metastore.ObjectStore.getCatalog(ObjectStore.java:852)
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
2023-05-04T03:59:35,912 DEBUG [pool-6-thread-198] pool.PoolBase: HikariPool-1 - Reset (autoCommit) on connection org.postgresql.jdbc.PgConnection@36f94433
2023-05-04T03:59:35,915 DEBUG [pool-6-thread-198] s3a.S3AFileSystem: Getting path status for s3a://ipass-datala-o01427051a3dc18b69nmaa8betpfvhubhf2siqapn10--op-s3/test (test); needEmptyDirectory=false
2023-05-04T03:59:35,915 DEBUG [pool-6-thread-198] s3a.S3AFileSystem: S3GetFileStatus s3a://ipass-datala-o01427051a3dc18b69nmaa8betpfvhubhf2siqapn10--op-s3/test
2023-05-04T03:59:35,915 DEBUG [pool-6-thread-198] s3a.S3AFileSystem: HEAD test with change tracker null
2023-05-04T03:59:35,916 DEBUG [pool-6-thread-198] impl.LoggingAuditor: [219] 64458dbd-e002-4fc9-9a9b-07861c9fa1dd-00000007 Executing op_get_file_status with {action_http_head_request 'test' size=0, mutating=false}; https://audit.example.org/hadoop/1/op_get_file_status/64458dbd-e002-4fc9-9a9b-07861c9fa1dd-00000007/?op=op_get_file_status&p1=test&pr=root&ps=b06e8a6e-d9a5-4c12-97c9-76301e77c311&id=64458dbd-e002-4fc9-9a9b-07861c9fa1dd-00000007&t0=219&fs=64458dbd-e002-4fc9-9a9b-07861c9fa1dd&t1=219&ts=1683172775914
2023-05-04T03:59:35,916 DEBUG [pool-6-thread-198] amazonaws.request: Sending Request: HEAD https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com /ipass-datala-o01427051a3dc18b69nmaa8betpfvhubhf2siqapn10--op-s3/test
2023-05-04T03:59:35,917 DEBUG [pool-6-thread-198] internal.S3Signer: Calculated string to sign:
"HEAD
application/octet-stream
Thu, 04 May 2023 03:59:35 GMT
/ipass-datala-o01427051a3dc18b69nmaa8betpfvhubhf2siqapn10--op-s3/test"
2023-05-04T03:59:35,917 DEBUG [pool-6-thread-198] protocol.RequestAddCookies: CookieSpec selected: default
2023-05-04T03:59:35,917 DEBUG [pool-6-thread-198] protocol.RequestAuthCache: Auth cache not set in the context
2023-05-04T03:59:35,917 DEBUG [pool-6-thread-198] conn.PoolingHttpClientConnectionManager: Connection request: [route: {s}->https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com:443][total available: 0; route allocated: 0 of 96; total allocated: 0 of 96]
2023-05-04T03:59:35,917 DEBUG [pool-6-thread-198] conn.PoolingHttpClientConnectionManager: Connection leased: [id: 116][route: {s}->https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com:443][total available: 0; route allocated: 1 of 96; total allocated: 1 of 96]
2023-05-04T03:59:35,918 DEBUG [pool-6-thread-198] execchain.MainClientExec: Opening connection {s}->https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com:443
2023-05-04T03:59:35,925 DEBUG [pool-6-thread-198] conn.ClientConnectionManagerFactory:
java.lang.reflect.InvocationTargetException: null
at jdk.internal.reflect.GeneratedMethodAccessor16.invoke(Unknown Source) ~[?:?]
at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) ~[?:?]
at java.lang.reflect.Method.invoke(Unknown Source) ~[?:?]
at com.amazonaws.http.conn.ClientConnectionManagerFactory$Handler.invoke(ClientConnectionManagerFactory.java:76) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.conn.$Proxy34.connect(Unknown Source) ~[?:?]
at com.amazonaws.thirdparty.apache.http.impl.execchain.MainClientExec.establishRoute(MainClientExec.java:393) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:236) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.apache.client.impl.SdkHttpClient.execute(SdkHttpClient.java:72) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.executeOneRequest(AmazonHttpClient.java:1346) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.executeHelper(AmazonHttpClient.java:1157) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.doExecute(AmazonHttpClient.java:814) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.executeWithTimer(AmazonHttpClient.java:781) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.execute(AmazonHttpClient.java:755) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.access$500(AmazonHttpClient.java:715) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutionBuilderImpl.execute(AmazonHttpClient.java:697) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient.execute(AmazonHttpClient.java:561) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient.execute(AmazonHttpClient.java:541) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.services.s3.AmazonS3Client.invoke(AmazonS3Client.java:5470) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.services.s3.AmazonS3Client.invoke(AmazonS3Client.java:5417) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.services.s3.AmazonS3Client.getObjectMetadata(AmazonS3Client.java:1373) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.lambda$getObjectMetadata$11(S3AFileSystem.java:2571) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.Invoker.retryUntranslated(Invoker.java:468) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.Invoker.retryUntranslated(Invoker.java:431) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.getObjectMetadata(S3AFileSystem.java:2559) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.getObjectMetadata(S3AFileSystem.java:2539) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.s3GetFileStatus(S3AFileSystem.java:3623) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.innerGetFileStatus(S3AFileSystem.java:3551) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.lambda$getFileStatus$24(S3AFileSystem.java:3528) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.statistics.impl.IOStatisticsBinding.invokeTrackingDuration(IOStatisticsBinding.java:547) ~[hadoop-common-3.3.5.jar:?]
at org.apache.hadoop.fs.statistics.impl.IOStatisticsBinding.lambda$trackDurationOfOperation$5(IOStatisticsBinding.java:528) ~[hadoop-common-3.3.5.jar:?]
at org.apache.hadoop.fs.statistics.impl.IOStatisticsBinding.trackDuration(IOStatisticsBinding.java:449) [hadoop-common-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.trackDurationAndSpan(S3AFileSystem.java:2401) [hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.trackDurationAndSpan(S3AFileSystem.java:2420) [hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.getFileStatus(S3AFileSystem.java:3526) [hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.hive.metastore.Warehouse.isDir(Warehouse.java:661) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.hadoop.hive.metastore.HiveMetaStore$HMSHandler.create_database_core(HiveMetaStore.java:1263) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.hadoop.hive.metastore.HiveMetaStore$HMSHandler.create_database(HiveMetaStore.java:1327) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:?]
at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) ~[?:?]
at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) ~[?:?]
at java.lang.reflect.Method.invoke(Unknown Source) ~[?:?]
at org.apache.hadoop.hive.metastore.RetryingHMSHandler.invokeInternal(RetryingHMSHandler.java:147) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.hadoop.hive.metastore.RetryingHMSHandler.invoke(RetryingHMSHandler.java:108) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at com.sun.proxy.$Proxy33.create_database(Unknown Source) [?:?]
at org.apache.hadoop.hive.metastore.api.ThriftHiveMetastore$Processor$create_database.getResult(ThriftHiveMetastore.java:14396) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.hadoop.hive.metastore.api.ThriftHiveMetastore$Processor$create_database.getResult(ThriftHiveMetastore.java:14380) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.thrift.ProcessFunction.process(ProcessFunction.java:39) [libthrift-0.9.3.jar:0.9.3]
at org.apache.hadoop.hive.metastore.TUGIBasedProcessor.process(TUGIBasedProcessor.java:104) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.thrift.server.TThreadPoolServer$WorkerProcess.run(TThreadPoolServer.java:286) [libthrift-0.9.3.jar:0.9.3]
at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) [?:?]
at java.lang.Thread.run(Unknown Source) [?:?]
Caused by: java.net.UnknownHostException: op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com: System error
at java.net.Inet6AddressImpl.lookupAllHostAddr(Native Method) ~[?:?]
at java.net.InetAddress$PlatformNameService.lookupAllHostAddr(Unknown Source) ~[?:?]
at java.net.InetAddress.getAddressesFromNameService(Unknown Source) ~[?:?]
at java.net.InetAddress$NameServiceAddresses.get(Unknown Source) ~[?:?]
at java.net.InetAddress.getAllByName0(Unknown Source) ~[?:?]
at java.net.InetAddress.getAllByName(Unknown Source) ~[?:?]
at java.net.InetAddress.getAllByName(Unknown Source) ~[?:?]
at com.amazonaws.SystemDefaultDnsResolver.resolve(SystemDefaultDnsResolver.java:27) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.DelegatingDnsResolver.resolve(DelegatingDnsResolver.java:38) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:112) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.conn.PoolingHttpClientConnectionManager.connect(PoolingHttpClientConnectionManager.java:376) ~[aws-java-sdk-bundle-1.12.454.jar:?]
... 56 more
2023-05-04T03:59:35,926 DEBUG [pool-6-thread-198] conn.DefaultManagedHttpClientConnection: http-outgoing-116: Shutdown connection
2023-05-04T03:59:35,926 DEBUG [pool-6-thread-198] execchain.MainClientExec: Connection discarded
2023-05-04T03:59:35,926 DEBUG [pool-6-thread-198] conn.PoolingHttpClientConnectionManager: Connection released: [id: 116][route: {s}->https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com:443][total available: 0; route allocated: 0 of 96; total allocated: 0 of 96]
2023-05-04T03:59:35,926 DEBUG [pool-6-thread-198] http.AmazonHttpClient: Unable to execute HTTP request: op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com: System error
2023-05-04T03:59:35,926 DEBUG [pool-6-thread-198] amazonaws.latency: MaxRetriesExceeded=[true], ServiceName=[Amazon S3], ServiceEndpoint=[https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com], Exception=[java.net.UnknownHostException: op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com: System error], RequestType=[GetObjectMetadataRequest], AWSRequestID=[null], ThrottledRetryCount=1, HttpClientPoolPendingCount=0, RetryCapacityConsumed=500, HttpClientPoolAvailableCount=0, RequestCount=1, Exception=1, HttpClientPoolLeasedCount=0, ClientExecuteTime=[9.909], HttpRequestTime=[8.688], ApiCallLatency=[9.313], RequestSigningTime=[0.33], CredentialsRequestTime=[0.007, 0.005],
2023-05-04T03:59:37,384 DEBUG [pool-6-thread-198] s3a.Invoker: retry #1
2023-05-04T03:59:37,385 DEBUG [pool-6-thread-198] s3a.S3AFileSystem: HEAD test with change tracker null
2023-05-04T03:59:37,385 DEBUG [pool-6-thread-198] impl.LoggingAuditor: [219] 64458dbd-e002-4fc9-9a9b-07861c9fa1dd-00000007 Executing op_get_file_status with {action_http_head_request 'test' size=0, mutating=false}; https://audit.example.org/hadoop/1/op_get_file_status/64458dbd-e002-4fc9-9a9b-07861c9fa1dd-00000007/?op=op_get_file_status&p1=test&pr=root&ps=b06e8a6e-d9a5-4c12-97c9-76301e77c311&id=64458dbd-e002-4fc9-9a9b-07861c9fa1dd-00000007&t0=219&fs=64458dbd-e002-4fc9-9a9b-07861c9fa1dd&t1=219&ts=1683172775914
2023-05-04T03:59:37,386 DEBUG [pool-6-thread-198] amazonaws.request: Sending Request: HEAD https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com /ipass-datala-o01427051a3dc18b69nmaa8betpfvhubhf2siqapn10--op-s3/test
2023-05-04T03:59:37,386 DEBUG [pool-6-thread-198] internal.S3Signer: Calculated string to sign:
"HEAD
application/octet-stream
Thu, 04 May 2023 03:59:37 GMT
/ipass-datala-o01427051a3dc18b69nmaa8betpfvhubhf2siqapn10--op-s3/test"
2023-05-04T03:59:37,386 DEBUG [pool-6-thread-198] protocol.RequestAddCookies: CookieSpec selected: default
2023-05-04T03:59:37,386 DEBUG [pool-6-thread-198] protocol.RequestAuthCache: Auth cache not set in the context
2023-05-04T03:59:37,386 DEBUG [pool-6-thread-198] conn.PoolingHttpClientConnectionManager: Connection request: [route: {s}->https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com:443][total available: 0; route allocated: 0 of 96; total allocated: 0 of 96]
2023-05-04T03:59:37,386 DEBUG [pool-6-thread-198] conn.PoolingHttpClientConnectionManager: Connection leased: [id: 117][route: {s}->https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com:443][total available: 0; route allocated: 1 of 96; total allocated: 1 of 96]
2023-05-04T03:59:37,386 DEBUG [pool-6-thread-198] execchain.MainClientExec: Opening connection {s}->https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com:443
2023-05-04T03:59:37,387 DEBUG [pool-6-thread-198] conn.ClientConnectionManagerFactory:
java.lang.reflect.InvocationTargetException: null
at jdk.internal.reflect.GeneratedMethodAccessor16.invoke(Unknown Source) ~[?:?]
at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) ~[?:?]
at java.lang.reflect.Method.invoke(Unknown Source) ~[?:?]
at com.amazonaws.http.conn.ClientConnectionManagerFactory$Handler.invoke(ClientConnectionManagerFactory.java:76) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.conn.$Proxy34.connect(Unknown Source) ~[?:?]
at com.amazonaws.thirdparty.apache.http.impl.execchain.MainClientExec.establishRoute(MainClientExec.java:393) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:236) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.apache.client.impl.SdkHttpClient.execute(SdkHttpClient.java:72) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.executeOneRequest(AmazonHttpClient.java:1346) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.executeHelper(AmazonHttpClient.java:1157) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.doExecute(AmazonHttpClient.java:814) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.executeWithTimer(AmazonHttpClient.java:781) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.execute(AmazonHttpClient.java:755) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.access$500(AmazonHttpClient.java:715) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutionBuilderImpl.execute(AmazonHttpClient.java:697) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient.execute(AmazonHttpClient.java:561) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient.execute(AmazonHttpClient.java:541) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.services.s3.AmazonS3Client.invoke(AmazonS3Client.java:5470) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.services.s3.AmazonS3Client.invoke(AmazonS3Client.java:5417) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.services.s3.AmazonS3Client.getObjectMetadata(AmazonS3Client.java:1373) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.lambda$getObjectMetadata$11(S3AFileSystem.java:2571) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.Invoker.retryUntranslated(Invoker.java:468) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.Invoker.retryUntranslated(Invoker.java:431) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.getObjectMetadata(S3AFileSystem.java:2559) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.getObjectMetadata(S3AFileSystem.java:2539) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.s3GetFileStatus(S3AFileSystem.java:3623) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.innerGetFileStatus(S3AFileSystem.java:3551) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.lambda$getFileStatus$24(S3AFileSystem.java:3528) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.statistics.impl.IOStatisticsBinding.invokeTrackingDuration(IOStatisticsBinding.java:547) ~[hadoop-common-3.3.5.jar:?]
at org.apache.hadoop.fs.statistics.impl.IOStatisticsBinding.lambda$trackDurationOfOperation$5(IOStatisticsBinding.java:528) ~[hadoop-common-3.3.5.jar:?]
at org.apache.hadoop.fs.statistics.impl.IOStatisticsBinding.trackDuration(IOStatisticsBinding.java:449) [hadoop-common-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.trackDurationAndSpan(S3AFileSystem.java:2401) [hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.trackDurationAndSpan(S3AFileSystem.java:2420) [hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.getFileStatus(S3AFileSystem.java:3526) [hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.hive.metastore.Warehouse.isDir(Warehouse.java:661) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.hadoop.hive.metastore.HiveMetaStore$HMSHandler.create_database_core(HiveMetaStore.java:1263) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.hadoop.hive.metastore.HiveMetaStore$HMSHandler.create_database(HiveMetaStore.java:1327) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:?]
at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) ~[?:?]
at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) ~[?:?]
at java.lang.reflect.Method.invoke(Unknown Source) ~[?:?]
at org.apache.hadoop.hive.metastore.RetryingHMSHandler.invokeInternal(RetryingHMSHandler.java:147) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.hadoop.hive.metastore.RetryingHMSHandler.invoke(RetryingHMSHandler.java:108) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at com.sun.proxy.$Proxy33.create_database(Unknown Source) [?:?]
at org.apache.hadoop.hive.metastore.api.ThriftHiveMetastore$Processor$create_database.getResult(ThriftHiveMetastore.java:14396) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.hadoop.hive.metastore.api.ThriftHiveMetastore$Processor$create_database.getResult(ThriftHiveMetastore.java:14380) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.thrift.ProcessFunction.process(ProcessFunction.java:39) [libthrift-0.9.3.jar:0.9.3]
at org.apache.hadoop.hive.metastore.TUGIBasedProcessor.process(TUGIBasedProcessor.java:104) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.thrift.server.TThreadPoolServer$WorkerProcess.run(TThreadPoolServer.java:286) [libthrift-0.9.3.jar:0.9.3]
at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) [?:?]
at java.lang.Thread.run(Unknown Source) [?:?]
Caused by: java.net.UnknownHostException: op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com
at java.net.InetAddress$CachedAddresses.get(Unknown Source) ~[?:?]
at java.net.InetAddress.getAllByName0(Unknown Source) ~[?:?]
at java.net.InetAddress.getAllByName(Unknown Source) ~[?:?]
at java.net.InetAddress.getAllByName(Unknown Source) ~[?:?]
at com.amazonaws.SystemDefaultDnsResolver.resolve(SystemDefaultDnsResolver.java:27) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.DelegatingDnsResolver.resolve(DelegatingDnsResolver.java:38) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:112) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.conn.PoolingHttpClientConnectionManager.connect(PoolingHttpClientConnectionManager.java:376) ~[aws-java-sdk-bundle-1.12.454.jar:?]
... 56 more
2023-05-04T03:59:37,387 DEBUG [pool-6-thread-198] conn.DefaultManagedHttpClientConnection: http-outgoing-117: Shutdown connection
2023-05-04T03:59:37,387 DEBUG [pool-6-thread-198] execchain.MainClientExec: Connection discarded
2023-05-04T03:59:37,387 DEBUG [pool-6-thread-198] conn.PoolingHttpClientConnectionManager: Connection released: [id: 117][route: {s}->https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com:443][total available: 0; route allocated: 0 of 96; total allocated: 0 of 96]
2023-05-04T03:59:37,387 DEBUG [pool-6-thread-198] http.AmazonHttpClient: Unable to execute HTTP request: op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com
2023-05-04T03:59:37,387 DEBUG [pool-6-thread-198] amazonaws.latency: MaxRetriesExceeded=[true], ServiceName=[Amazon S3], ServiceEndpoint=[https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com], Exception=[java.net.UnknownHostException: op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com], RequestType=[GetObjectMetadataRequest], AWSRequestID=[null], ThrottledRetryCount=1, HttpClientPoolPendingCount=0, RetryCapacityConsumed=500, HttpClientPoolAvailableCount=0, RequestCount=1, Exception=1, HttpClientPoolLeasedCount=0, ClientExecuteTime=[1.949], HttpRequestTime=[1.19], ApiCallLatency=[1.736], RequestSigningTime=[0.302], CredentialsRequestTime=[0.006, 0.002],
2023-05-04T03:59:40,194 DEBUG [pool-6-thread-198] s3a.Invoker: retry #2
2023-05-04T03:59:40,194 DEBUG [pool-6-thread-198] s3a.S3AFileSystem: HEAD test with change tracker null
2023-05-04T03:59:40,195 DEBUG [pool-6-thread-198] impl.LoggingAuditor: [219] 64458dbd-e002-4fc9-9a9b-07861c9fa1dd-00000007 Executing op_get_file_status with {action_http_head_request 'test' size=0, mutating=false}; https://audit.example.org/hadoop/1/op_get_file_status/64458dbd-e002-4fc9-9a9b-07861c9fa1dd-00000007/?op=op_get_file_status&p1=test&pr=root&ps=b06e8a6e-d9a5-4c12-97c9-76301e77c311&id=64458dbd-e002-4fc9-9a9b-07861c9fa1dd-00000007&t0=219&fs=64458dbd-e002-4fc9-9a9b-07861c9fa1dd&t1=219&ts=1683172775914
2023-05-04T03:59:40,195 DEBUG [pool-6-thread-198] amazonaws.request: Sending Request: HEAD https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com /ipass-datala-o01427051a3dc18b69nmaa8betpfvhubhf2siqapn10--op-s3/test
2023-05-04T03:59:40,195 DEBUG [pool-6-thread-198] internal.S3Signer: Calculated string to sign:
"HEAD
application/octet-stream
Thu, 04 May 2023 03:59:40 GMT
/ipass-datala-o01427051a3dc18b69nmaa8betpfvhubhf2siqapn10--op-s3/test"
2023-05-04T03:59:40,196 DEBUG [pool-6-thread-198] protocol.RequestAddCookies: CookieSpec selected: default
2023-05-04T03:59:40,196 DEBUG [pool-6-thread-198] protocol.RequestAuthCache: Auth cache not set in the context
2023-05-04T03:59:40,196 DEBUG [pool-6-thread-198] conn.PoolingHttpClientConnectionManager: Connection request: [route: {s}->https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com:443][total available: 0; route allocated: 0 of 96; total allocated: 0 of 96]
2023-05-04T03:59:40,196 DEBUG [pool-6-thread-198] conn.PoolingHttpClientConnectionManager: Connection leased: [id: 118][route: {s}->https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com:443][total available: 0; route allocated: 1 of 96; total allocated: 1 of 96]
2023-05-04T03:59:40,196 DEBUG [pool-6-thread-198] execchain.MainClientExec: Opening connection {s}->https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com:443
2023-05-04T03:59:40,196 DEBUG [pool-6-thread-198] conn.ClientConnectionManagerFactory:
java.lang.reflect.InvocationTargetException: null
at jdk.internal.reflect.GeneratedMethodAccessor16.invoke(Unknown Source) ~[?:?]
at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) ~[?:?]
at java.lang.reflect.Method.invoke(Unknown Source) ~[?:?]
at com.amazonaws.http.conn.ClientConnectionManagerFactory$Handler.invoke(ClientConnectionManagerFactory.java:76) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.conn.$Proxy34.connect(Unknown Source) ~[?:?]
at com.amazonaws.thirdparty.apache.http.impl.execchain.MainClientExec.establishRoute(MainClientExec.java:393) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:236) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.apache.client.impl.SdkHttpClient.execute(SdkHttpClient.java:72) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.executeOneRequest(AmazonHttpClient.java:1346) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.executeHelper(AmazonHttpClient.java:1157) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.doExecute(AmazonHttpClient.java:814) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.executeWithTimer(AmazonHttpClient.java:781) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.execute(AmazonHttpClient.java:755) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.access$500(AmazonHttpClient.java:715) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutionBuilderImpl.execute(AmazonHttpClient.java:697) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient.execute(AmazonHttpClient.java:561) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient.execute(AmazonHttpClient.java:541) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.services.s3.AmazonS3Client.invoke(AmazonS3Client.java:5470) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.services.s3.AmazonS3Client.invoke(AmazonS3Client.java:5417) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.services.s3.AmazonS3Client.getObjectMetadata(AmazonS3Client.java:1373) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.lambda$getObjectMetadata$11(S3AFileSystem.java:2571) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.Invoker.retryUntranslated(Invoker.java:468) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.Invoker.retryUntranslated(Invoker.java:431) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.getObjectMetadata(S3AFileSystem.java:2559) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.getObjectMetadata(S3AFileSystem.java:2539) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.s3GetFileStatus(S3AFileSystem.java:3623) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.innerGetFileStatus(S3AFileSystem.java:3551) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.lambda$getFileStatus$24(S3AFileSystem.java:3528) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.statistics.impl.IOStatisticsBinding.invokeTrackingDuration(IOStatisticsBinding.java:547) ~[hadoop-common-3.3.5.jar:?]
at org.apache.hadoop.fs.statistics.impl.IOStatisticsBinding.lambda$trackDurationOfOperation$5(IOStatisticsBinding.java:528) ~[hadoop-common-3.3.5.jar:?]
at org.apache.hadoop.fs.statistics.impl.IOStatisticsBinding.trackDuration(IOStatisticsBinding.java:449) [hadoop-common-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.trackDurationAndSpan(S3AFileSystem.java:2401) [hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.trackDurationAndSpan(S3AFileSystem.java:2420) [hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.getFileStatus(S3AFileSystem.java:3526) [hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.hive.metastore.Warehouse.isDir(Warehouse.java:661) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.hadoop.hive.metastore.HiveMetaStore$HMSHandler.create_database_core(HiveMetaStore.java:1263) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.hadoop.hive.metastore.HiveMetaStore$HMSHandler.create_database(HiveMetaStore.java:1327) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:?]
at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) ~[?:?]
at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) ~[?:?]
at java.lang.reflect.Method.invoke(Unknown Source) ~[?:?]
at org.apache.hadoop.hive.metastore.RetryingHMSHandler.invokeInternal(RetryingHMSHandler.java:147) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.hadoop.hive.metastore.RetryingHMSHandler.invoke(RetryingHMSHandler.java:108) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at com.sun.proxy.$Proxy33.create_database(Unknown Source) [?:?]
at org.apache.hadoop.hive.metastore.api.ThriftHiveMetastore$Processor$create_database.getResult(ThriftHiveMetastore.java:14396) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.hadoop.hive.metastore.api.ThriftHiveMetastore$Processor$create_database.getResult(ThriftHiveMetastore.java:14380) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.thrift.ProcessFunction.process(ProcessFunction.java:39) [libthrift-0.9.3.jar:0.9.3]
at org.apache.hadoop.hive.metastore.TUGIBasedProcessor.process(TUGIBasedProcessor.java:104) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.thrift.server.TThreadPoolServer$WorkerProcess.run(TThreadPoolServer.java:286) [libthrift-0.9.3.jar:0.9.3]
at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) [?:?]
at java.lang.Thread.run(Unknown Source) [?:?]
Caused by: java.net.UnknownHostException: op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com
at java.net.InetAddress$CachedAddresses.get(Unknown Source) ~[?:?]
at java.net.InetAddress.getAllByName0(Unknown Source) ~[?:?]
at java.net.InetAddress.getAllByName(Unknown Source) ~[?:?]
at java.net.InetAddress.getAllByName(Unknown Source) ~[?:?]
at com.amazonaws.SystemDefaultDnsResolver.resolve(SystemDefaultDnsResolver.java:27) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.DelegatingDnsResolver.resolve(DelegatingDnsResolver.java:38) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:112) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.conn.PoolingHttpClientConnectionManager.connect(PoolingHttpClientConnectionManager.java:376) ~[aws-java-sdk-bundle-1.12.454.jar:?]
... 56 more
2023-05-04T03:59:40,197 DEBUG [pool-6-thread-198] conn.DefaultManagedHttpClientConnection: http-outgoing-118: Shutdown connection
2023-05-04T03:59:40,197 DEBUG [pool-6-thread-198] execchain.MainClientExec: Connection discarded
2023-05-04T03:59:40,197 DEBUG [pool-6-thread-198] conn.PoolingHttpClientConnectionManager: Connection released: [id: 118][route: {s}->https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com:443][total available: 0; route allocated: 0 of 96; total allocated: 0 of 96]
2023-05-04T03:59:40,197 DEBUG [pool-6-thread-198] http.AmazonHttpClient: Unable to execute HTTP request: op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com
2023-05-04T03:59:40,197 DEBUG [pool-6-thread-198] amazonaws.latency: MaxRetriesExceeded=[true], ServiceName=[Amazon S3], ServiceEndpoint=[https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com], Exception=[java.net.UnknownHostException: op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com], RequestType=[GetObjectMetadataRequest], AWSRequestID=[null], ThrottledRetryCount=1, HttpClientPoolPendingCount=0, RetryCapacityConsumed=500, HttpClientPoolAvailableCount=0, RequestCount=1, Exception=1, HttpClientPoolLeasedCount=0, ClientExecuteTime=[2.241], HttpRequestTime=[1.427], ApiCallLatency=[1.949], RequestSigningTime=[0.194], CredentialsRequestTime=[0.009, 0.017],
2023-05-04T03:59:42,939 INFO [pool-6-thread-199] metastore.HiveMetaStore: 195: Done cleaning up thread local RawStore
2023-05-04T03:59:42,939 INFO [pool-6-thread-200] metastore.HiveMetaStore: 197: Done cleaning up thread local RawStore
2023-05-04T03:59:42,939 INFO [pool-6-thread-200] HiveMetaStore.audit: ugi=root ip=10.0.200.168 cmd=Done cleaning up thread local RawStore
2023-05-04T03:59:42,939 INFO [pool-6-thread-199] HiveMetaStore.audit: ugi=root ip=10.0.200.168 cmd=Done cleaning up thread local RawStore
2023-05-04T03:59:43,062 DEBUG [pool-6-thread-198] s3a.Invoker: retry #3
2023-05-04T03:59:43,062 DEBUG [pool-6-thread-198] s3a.S3AFileSystem: HEAD test with change tracker null
2023-05-04T03:59:43,063 DEBUG [pool-6-thread-198] impl.LoggingAuditor: [219] 64458dbd-e002-4fc9-9a9b-07861c9fa1dd-00000007 Executing op_get_file_status with {action_http_head_request 'test' size=0, mutating=false}; https://audit.example.org/hadoop/1/op_get_file_status/64458dbd-e002-4fc9-9a9b-07861c9fa1dd-00000007/?op=op_get_file_status&p1=test&pr=root&ps=b06e8a6e-d9a5-4c12-97c9-76301e77c311&id=64458dbd-e002-4fc9-9a9b-07861c9fa1dd-00000007&t0=219&fs=64458dbd-e002-4fc9-9a9b-07861c9fa1dd&t1=219&ts=1683172775914
2023-05-04T03:59:43,063 DEBUG [pool-6-thread-198] amazonaws.request: Sending Request: HEAD https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com /ipass-datala-o01427051a3dc18b69nmaa8betpfvhubhf2siqapn10--op-s3/test
2023-05-04T03:59:43,063 DEBUG [pool-6-thread-198] internal.S3Signer: Calculated string to sign:
"HEAD
application/octet-stream
Thu, 04 May 2023 03:59:43 GMT
/ipass-datala-o01427051a3dc18b69nmaa8betpfvhubhf2siqapn10--op-s3/test"
2023-05-04T03:59:43,064 DEBUG [pool-6-thread-198] protocol.RequestAddCookies: CookieSpec selected: default
2023-05-04T03:59:43,064 DEBUG [pool-6-thread-198] protocol.RequestAuthCache: Auth cache not set in the context
2023-05-04T03:59:43,064 DEBUG [pool-6-thread-198] conn.PoolingHttpClientConnectionManager: Connection request: [route: {s}->https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com:443][total available: 0; route allocated: 0 of 96; total allocated: 0 of 96]
2023-05-04T03:59:43,064 DEBUG [pool-6-thread-198] conn.PoolingHttpClientConnectionManager: Connection leased: [id: 119][route: {s}->https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com:443][total available: 0; route allocated: 1 of 96; total allocated: 1 of 96]
2023-05-04T03:59:43,064 DEBUG [pool-6-thread-198] execchain.MainClientExec: Opening connection {s}->https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com:443
2023-05-04T03:59:43,064 DEBUG [pool-6-thread-198] conn.ClientConnectionManagerFactory:
java.lang.reflect.InvocationTargetException: null
at jdk.internal.reflect.GeneratedMethodAccessor16.invoke(Unknown Source) ~[?:?]
at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) ~[?:?]
at java.lang.reflect.Method.invoke(Unknown Source) ~[?:?]
at com.amazonaws.http.conn.ClientConnectionManagerFactory$Handler.invoke(ClientConnectionManagerFactory.java:76) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.conn.$Proxy34.connect(Unknown Source) ~[?:?]
at com.amazonaws.thirdparty.apache.http.impl.execchain.MainClientExec.establishRoute(MainClientExec.java:393) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:236) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.apache.client.impl.SdkHttpClient.execute(SdkHttpClient.java:72) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.executeOneRequest(AmazonHttpClient.java:1346) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.executeHelper(AmazonHttpClient.java:1157) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.doExecute(AmazonHttpClient.java:814) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.executeWithTimer(AmazonHttpClient.java:781) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.execute(AmazonHttpClient.java:755) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.access$500(AmazonHttpClient.java:715) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutionBuilderImpl.execute(AmazonHttpClient.java:697) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient.execute(AmazonHttpClient.java:561) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient.execute(AmazonHttpClient.java:541) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.services.s3.AmazonS3Client.invoke(AmazonS3Client.java:5470) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.services.s3.AmazonS3Client.invoke(AmazonS3Client.java:5417) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.services.s3.AmazonS3Client.getObjectMetadata(AmazonS3Client.java:1373) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.lambda$getObjectMetadata$11(S3AFileSystem.java:2571) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.Invoker.retryUntranslated(Invoker.java:468) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.Invoker.retryUntranslated(Invoker.java:431) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.getObjectMetadata(S3AFileSystem.java:2559) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.getObjectMetadata(S3AFileSystem.java:2539) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.s3GetFileStatus(S3AFileSystem.java:3623) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.innerGetFileStatus(S3AFileSystem.java:3551) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.lambda$getFileStatus$24(S3AFileSystem.java:3528) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.statistics.impl.IOStatisticsBinding.invokeTrackingDuration(IOStatisticsBinding.java:547) ~[hadoop-common-3.3.5.jar:?]
at org.apache.hadoop.fs.statistics.impl.IOStatisticsBinding.lambda$trackDurationOfOperation$5(IOStatisticsBinding.java:528) ~[hadoop-common-3.3.5.jar:?]
at org.apache.hadoop.fs.statistics.impl.IOStatisticsBinding.trackDuration(IOStatisticsBinding.java:449) [hadoop-common-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.trackDurationAndSpan(S3AFileSystem.java:2401) [hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.trackDurationAndSpan(S3AFileSystem.java:2420) [hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.getFileStatus(S3AFileSystem.java:3526) [hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.hive.metastore.Warehouse.isDir(Warehouse.java:661) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.hadoop.hive.metastore.HiveMetaStore$HMSHandler.create_database_core(HiveMetaStore.java:1263) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.hadoop.hive.metastore.HiveMetaStore$HMSHandler.create_database(HiveMetaStore.java:1327) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:?]
at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) ~[?:?]
at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) ~[?:?]
at java.lang.reflect.Method.invoke(Unknown Source) ~[?:?]
at org.apache.hadoop.hive.metastore.RetryingHMSHandler.invokeInternal(RetryingHMSHandler.java:147) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.hadoop.hive.metastore.RetryingHMSHandler.invoke(RetryingHMSHandler.java:108) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at com.sun.proxy.$Proxy33.create_database(Unknown Source) [?:?]
at org.apache.hadoop.hive.metastore.api.ThriftHiveMetastore$Processor$create_database.getResult(ThriftHiveMetastore.java:14396) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.hadoop.hive.metastore.api.ThriftHiveMetastore$Processor$create_database.getResult(ThriftHiveMetastore.java:14380) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.thrift.ProcessFunction.process(ProcessFunction.java:39) [libthrift-0.9.3.jar:0.9.3]
at org.apache.hadoop.hive.metastore.TUGIBasedProcessor.process(TUGIBasedProcessor.java:104) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.thrift.server.TThreadPoolServer$WorkerProcess.run(TThreadPoolServer.java:286) [libthrift-0.9.3.jar:0.9.3]
at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) [?:?]
at java.lang.Thread.run(Unknown Source) [?:?]
Caused by: java.net.UnknownHostException: op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com
at java.net.InetAddress$CachedAddresses.get(Unknown Source) ~[?:?]
at java.net.InetAddress.getAllByName0(Unknown Source) ~[?:?]
at java.net.InetAddress.getAllByName(Unknown Source) ~[?:?]
at java.net.InetAddress.getAllByName(Unknown Source) ~[?:?]
at com.amazonaws.SystemDefaultDnsResolver.resolve(SystemDefaultDnsResolver.java:27) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.DelegatingDnsResolver.resolve(DelegatingDnsResolver.java:38) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:112) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.conn.PoolingHttpClientConnectionManager.connect(PoolingHttpClientConnectionManager.java:376) ~[aws-java-sdk-bundle-1.12.454.jar:?]
... 56 more
2023-05-04T03:59:43,067 DEBUG [pool-6-thread-198] conn.DefaultManagedHttpClientConnection: http-outgoing-119: Shutdown connection
2023-05-04T03:59:43,067 DEBUG [pool-6-thread-198] execchain.MainClientExec: Connection discarded
2023-05-04T03:59:43,067 DEBUG [pool-6-thread-198] conn.PoolingHttpClientConnectionManager: Connection released: [id: 119][route: {s}->https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com:443][total available: 0; route allocated: 0 of 96; total allocated: 0 of 96]
2023-05-04T03:59:43,067 DEBUG [pool-6-thread-198] http.AmazonHttpClient: Unable to execute HTTP request: op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com
2023-05-04T03:59:43,067 DEBUG [pool-6-thread-198] amazonaws.latency: MaxRetriesExceeded=[true], ServiceName=[Amazon S3], ServiceEndpoint=[https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com], Exception=[java.net.UnknownHostException: op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com], RequestType=[GetObjectMetadataRequest], AWSRequestID=[null], ThrottledRetryCount=1, HttpClientPoolPendingCount=0, RetryCapacityConsumed=500, HttpClientPoolAvailableCount=0, RequestCount=1, Exception=1, HttpClientPoolLeasedCount=0, ClientExecuteTime=[4.124], HttpRequestTime=[3.295], ApiCallLatency=[3.822], RequestSigningTime=[0.192], CredentialsRequestTime=[0.024, 0.003],
2023-05-04T03:59:51,430 DEBUG [pool-6-thread-198] s3a.Invoker: retry #4
2023-05-04T03:59:51,430 DEBUG [pool-6-thread-198] s3a.S3AFileSystem: HEAD test with change tracker null
2023-05-04T03:59:51,431 DEBUG [pool-6-thread-198] impl.LoggingAuditor: [219] 64458dbd-e002-4fc9-9a9b-07861c9fa1dd-00000007 Executing op_get_file_status with {action_http_head_request 'test' size=0, mutating=false}; https://audit.example.org/hadoop/1/op_get_file_status/64458dbd-e002-4fc9-9a9b-07861c9fa1dd-00000007/?op=op_get_file_status&p1=test&pr=root&ps=b06e8a6e-d9a5-4c12-97c9-76301e77c311&id=64458dbd-e002-4fc9-9a9b-07861c9fa1dd-00000007&t0=219&fs=64458dbd-e002-4fc9-9a9b-07861c9fa1dd&t1=219&ts=1683172775914
2023-05-04T03:59:51,432 DEBUG [pool-6-thread-198] amazonaws.request: Sending Request: HEAD https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com /ipass-datala-o01427051a3dc18b69nmaa8betpfvhubhf2siqapn10--op-s3/test
2023-05-04T03:59:51,432 DEBUG [pool-6-thread-198] internal.S3Signer: Calculated string to sign:
"HEAD
application/octet-stream
Thu, 04 May 2023 03:59:51 GMT
/ipass-datala-o01427051a3dc18b69nmaa8betpfvhubhf2siqapn10--op-s3/test"
2023-05-04T03:59:51,432 DEBUG [pool-6-thread-198] protocol.RequestAddCookies: CookieSpec selected: default
2023-05-04T03:59:51,432 DEBUG [pool-6-thread-198] protocol.RequestAuthCache: Auth cache not set in the context
2023-05-04T03:59:51,432 DEBUG [pool-6-thread-198] conn.PoolingHttpClientConnectionManager: Connection request: [route: {s}->https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com:443][total available: 0; route allocated: 0 of 96; total allocated: 0 of 96]
2023-05-04T03:59:51,433 DEBUG [pool-6-thread-198] conn.PoolingHttpClientConnectionManager: Connection leased: [id: 120][route: {s}->https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com:443][total available: 0; route allocated: 1 of 96; total allocated: 1 of 96]
2023-05-04T03:59:51,433 DEBUG [pool-6-thread-198] execchain.MainClientExec: Opening connection {s}->https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com:443
2023-05-04T03:59:51,435 DEBUG [pool-6-thread-198] conn.ClientConnectionManagerFactory:
java.lang.reflect.InvocationTargetException: null
at jdk.internal.reflect.GeneratedMethodAccessor16.invoke(Unknown Source) ~[?:?]
at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) ~[?:?]
at java.lang.reflect.Method.invoke(Unknown Source) ~[?:?]
at com.amazonaws.http.conn.ClientConnectionManagerFactory$Handler.invoke(ClientConnectionManagerFactory.java:76) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.conn.$Proxy34.connect(Unknown Source) ~[?:?]
at com.amazonaws.thirdparty.apache.http.impl.execchain.MainClientExec.establishRoute(MainClientExec.java:393) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:236) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.apache.client.impl.SdkHttpClient.execute(SdkHttpClient.java:72) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.executeOneRequest(AmazonHttpClient.java:1346) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.executeHelper(AmazonHttpClient.java:1157) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.doExecute(AmazonHttpClient.java:814) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.executeWithTimer(AmazonHttpClient.java:781) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.execute(AmazonHttpClient.java:755) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.access$500(AmazonHttpClient.java:715) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutionBuilderImpl.execute(AmazonHttpClient.java:697) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient.execute(AmazonHttpClient.java:561) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient.execute(AmazonHttpClient.java:541) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.services.s3.AmazonS3Client.invoke(AmazonS3Client.java:5470) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.services.s3.AmazonS3Client.invoke(AmazonS3Client.java:5417) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.services.s3.AmazonS3Client.getObjectMetadata(AmazonS3Client.java:1373) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.lambda$getObjectMetadata$11(S3AFileSystem.java:2571) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.Invoker.retryUntranslated(Invoker.java:468) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.Invoker.retryUntranslated(Invoker.java:431) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.getObjectMetadata(S3AFileSystem.java:2559) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.getObjectMetadata(S3AFileSystem.java:2539) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.s3GetFileStatus(S3AFileSystem.java:3623) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.innerGetFileStatus(S3AFileSystem.java:3551) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.lambda$getFileStatus$24(S3AFileSystem.java:3528) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.statistics.impl.IOStatisticsBinding.invokeTrackingDuration(IOStatisticsBinding.java:547) ~[hadoop-common-3.3.5.jar:?]
at org.apache.hadoop.fs.statistics.impl.IOStatisticsBinding.lambda$trackDurationOfOperation$5(IOStatisticsBinding.java:528) ~[hadoop-common-3.3.5.jar:?]
at org.apache.hadoop.fs.statistics.impl.IOStatisticsBinding.trackDuration(IOStatisticsBinding.java:449) [hadoop-common-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.trackDurationAndSpan(S3AFileSystem.java:2401) [hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.trackDurationAndSpan(S3AFileSystem.java:2420) [hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.getFileStatus(S3AFileSystem.java:3526) [hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.hive.metastore.Warehouse.isDir(Warehouse.java:661) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.hadoop.hive.metastore.HiveMetaStore$HMSHandler.create_database_core(HiveMetaStore.java:1263) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.hadoop.hive.metastore.HiveMetaStore$HMSHandler.create_database(HiveMetaStore.java:1327) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:?]
at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) ~[?:?]
at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) ~[?:?]
at java.lang.reflect.Method.invoke(Unknown Source) ~[?:?]
at org.apache.hadoop.hive.metastore.RetryingHMSHandler.invokeInternal(RetryingHMSHandler.java:147) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.hadoop.hive.metastore.RetryingHMSHandler.invoke(RetryingHMSHandler.java:108) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at com.sun.proxy.$Proxy33.create_database(Unknown Source) [?:?]
at org.apache.hadoop.hive.metastore.api.ThriftHiveMetastore$Processor$create_database.getResult(ThriftHiveMetastore.java:14396) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.hadoop.hive.metastore.api.ThriftHiveMetastore$Processor$create_database.getResult(ThriftHiveMetastore.java:14380) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.thrift.ProcessFunction.process(ProcessFunction.java:39) [libthrift-0.9.3.jar:0.9.3]
at org.apache.hadoop.hive.metastore.TUGIBasedProcessor.process(TUGIBasedProcessor.java:104) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.thrift.server.TThreadPoolServer$WorkerProcess.run(TThreadPoolServer.java:286) [libthrift-0.9.3.jar:0.9.3]
at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) [?:?]
at java.lang.Thread.run(Unknown Source) [?:?]
Caused by: java.net.UnknownHostException: op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com: System error
at java.net.Inet6AddressImpl.lookupAllHostAddr(Native Method) ~[?:?]
at java.net.InetAddress$PlatformNameService.lookupAllHostAddr(Unknown Source) ~[?:?]
at java.net.InetAddress.getAddressesFromNameService(Unknown Source) ~[?:?]
at java.net.InetAddress$NameServiceAddresses.get(Unknown Source) ~[?:?]
at java.net.InetAddress.getAllByName0(Unknown Source) ~[?:?]
at java.net.InetAddress.getAllByName(Unknown Source) ~[?:?]
at java.net.InetAddress.getAllByName(Unknown Source) ~[?:?]
at com.amazonaws.SystemDefaultDnsResolver.resolve(SystemDefaultDnsResolver.java:27) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.DelegatingDnsResolver.resolve(DelegatingDnsResolver.java:38) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:112) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.conn.PoolingHttpClientConnectionManager.connect(PoolingHttpClientConnectionManager.java:376) ~[aws-java-sdk-bundle-1.12.454.jar:?]
... 56 more
2023-05-04T03:59:51,436 DEBUG [pool-6-thread-198] conn.DefaultManagedHttpClientConnection: http-outgoing-120: Shutdown connection
2023-05-04T03:59:51,436 DEBUG [pool-6-thread-198] execchain.MainClientExec: Connection discarded
2023-05-04T03:59:51,436 DEBUG [pool-6-thread-198] conn.PoolingHttpClientConnectionManager: Connection released: [id: 120][route: {s}->https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com:443][total available: 0; route allocated: 0 of 96; total allocated: 0 of 96]
2023-05-04T03:59:51,436 DEBUG [pool-6-thread-198] http.AmazonHttpClient: Unable to execute HTTP request: op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com: System error
2023-05-04T03:59:51,436 DEBUG [pool-6-thread-198] amazonaws.latency: MaxRetriesExceeded=[true], ServiceName=[Amazon S3], ServiceEndpoint=[https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com], Exception=[java.net.UnknownHostException: op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com: System error], RequestType=[GetObjectMetadataRequest], AWSRequestID=[null], ThrottledRetryCount=1, HttpClientPoolPendingCount=0, RetryCapacityConsumed=500, HttpClientPoolAvailableCount=0, RequestCount=1, Exception=1, HttpClientPoolLeasedCount=0, ClientExecuteTime=[4.796], HttpRequestTime=[3.9], ApiCallLatency=[4.463], RequestSigningTime=[0.245], CredentialsRequestTime=[0.008, 0.004],
2023-05-04T03:59:52,938 INFO [pool-6-thread-199] metastore.HiveMetaStore: 195: Done cleaning up thread local RawStore
2023-05-04T03:59:52,938 INFO [pool-6-thread-200] metastore.HiveMetaStore: 197: Done cleaning up thread local RawStore
2023-05-04T03:59:52,938 INFO [pool-6-thread-200] HiveMetaStore.audit: ugi=root ip=10.0.200.168 cmd=Done cleaning up thread local RawStore
2023-05-04T03:59:52,938 INFO [pool-6-thread-199] HiveMetaStore.audit: ugi=root ip=10.0.200.168 cmd=Done cleaning up thread local RawStore
2023-05-04T04:00:00,119 DEBUG [pool-6-thread-198] s3a.Invoker: retry #5
2023-05-04T04:00:00,120 DEBUG [pool-6-thread-198] s3a.S3AFileSystem: HEAD test with change tracker null
2023-05-04T04:00:00,120 DEBUG [pool-6-thread-198] impl.LoggingAuditor: [219] 64458dbd-e002-4fc9-9a9b-07861c9fa1dd-00000007 Executing op_get_file_status with {action_http_head_request 'test' size=0, mutating=false}; https://audit.example.org/hadoop/1/op_get_file_status/64458dbd-e002-4fc9-9a9b-07861c9fa1dd-00000007/?op=op_get_file_status&p1=test&pr=root&ps=b06e8a6e-d9a5-4c12-97c9-76301e77c311&id=64458dbd-e002-4fc9-9a9b-07861c9fa1dd-00000007&t0=219&fs=64458dbd-e002-4fc9-9a9b-07861c9fa1dd&t1=219&ts=1683172775914
2023-05-04T04:00:00,120 DEBUG [pool-6-thread-198] amazonaws.request: Sending Request: HEAD https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com /ipass-datala-o01427051a3dc18b69nmaa8betpfvhubhf2siqapn10--op-s3/test
2023-05-04T04:00:00,120 DEBUG [pool-6-thread-198] internal.S3Signer: Calculated string to sign:
"HEAD
application/octet-stream
Thu, 04 May 2023 04:00:00 GMT
/ipass-datala-o01427051a3dc18b69nmaa8betpfvhubhf2siqapn10--op-s3/test"
2023-05-04T04:00:00,121 DEBUG [pool-6-thread-198] protocol.RequestAddCookies: CookieSpec selected: default
2023-05-04T04:00:00,121 DEBUG [pool-6-thread-198] protocol.RequestAuthCache: Auth cache not set in the context
2023-05-04T04:00:00,121 DEBUG [pool-6-thread-198] conn.PoolingHttpClientConnectionManager: Connection request: [route: {s}->https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com:443][total available: 0; route allocated: 0 of 96; total allocated: 0 of 96]
2023-05-04T04:00:00,121 DEBUG [pool-6-thread-198] conn.PoolingHttpClientConnectionManager: Connection leased: [id: 121][route: {s}->https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com:443][total available: 0; route allocated: 1 of 96; total allocated: 1 of 96]
2023-05-04T04:00:00,121 DEBUG [pool-6-thread-198] execchain.MainClientExec: Opening connection {s}->https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com:443
2023-05-04T04:00:00,121 DEBUG [pool-6-thread-198] conn.ClientConnectionManagerFactory:
java.lang.reflect.InvocationTargetException: null
at jdk.internal.reflect.GeneratedMethodAccessor16.invoke(Unknown Source) ~[?:?]
at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) ~[?:?]
at java.lang.reflect.Method.invoke(Unknown Source) ~[?:?]
at com.amazonaws.http.conn.ClientConnectionManagerFactory$Handler.invoke(ClientConnectionManagerFactory.java:76) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.conn.$Proxy34.connect(Unknown Source) ~[?:?]
at com.amazonaws.thirdparty.apache.http.impl.execchain.MainClientExec.establishRoute(MainClientExec.java:393) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:236) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.apache.client.impl.SdkHttpClient.execute(SdkHttpClient.java:72) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.executeOneRequest(AmazonHttpClient.java:1346) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.executeHelper(AmazonHttpClient.java:1157) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.doExecute(AmazonHttpClient.java:814) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.executeWithTimer(AmazonHttpClient.java:781) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.execute(AmazonHttpClient.java:755) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutor.access$500(AmazonHttpClient.java:715) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient$RequestExecutionBuilderImpl.execute(AmazonHttpClient.java:697) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient.execute(AmazonHttpClient.java:561) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.AmazonHttpClient.execute(AmazonHttpClient.java:541) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.services.s3.AmazonS3Client.invoke(AmazonS3Client.java:5470) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.services.s3.AmazonS3Client.invoke(AmazonS3Client.java:5417) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.services.s3.AmazonS3Client.getObjectMetadata(AmazonS3Client.java:1373) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.lambda$getObjectMetadata$11(S3AFileSystem.java:2571) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.Invoker.retryUntranslated(Invoker.java:468) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.Invoker.retryUntranslated(Invoker.java:431) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.getObjectMetadata(S3AFileSystem.java:2559) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.getObjectMetadata(S3AFileSystem.java:2539) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.s3GetFileStatus(S3AFileSystem.java:3623) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.innerGetFileStatus(S3AFileSystem.java:3551) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.lambda$getFileStatus$24(S3AFileSystem.java:3528) ~[hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.statistics.impl.IOStatisticsBinding.invokeTrackingDuration(IOStatisticsBinding.java:547) ~[hadoop-common-3.3.5.jar:?]
at org.apache.hadoop.fs.statistics.impl.IOStatisticsBinding.lambda$trackDurationOfOperation$5(IOStatisticsBinding.java:528) ~[hadoop-common-3.3.5.jar:?]
at org.apache.hadoop.fs.statistics.impl.IOStatisticsBinding.trackDuration(IOStatisticsBinding.java:449) [hadoop-common-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.trackDurationAndSpan(S3AFileSystem.java:2401) [hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.trackDurationAndSpan(S3AFileSystem.java:2420) [hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.fs.s3a.S3AFileSystem.getFileStatus(S3AFileSystem.java:3526) [hadoop-aws-3.3.5.jar:?]
at org.apache.hadoop.hive.metastore.Warehouse.isDir(Warehouse.java:661) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.hadoop.hive.metastore.HiveMetaStore$HMSHandler.create_database_core(HiveMetaStore.java:1263) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.hadoop.hive.metastore.HiveMetaStore$HMSHandler.create_database(HiveMetaStore.java:1327) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:?]
at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) ~[?:?]
at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) ~[?:?]
at java.lang.reflect.Method.invoke(Unknown Source) ~[?:?]
at org.apache.hadoop.hive.metastore.RetryingHMSHandler.invokeInternal(RetryingHMSHandler.java:147) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.hadoop.hive.metastore.RetryingHMSHandler.invoke(RetryingHMSHandler.java:108) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at com.sun.proxy.$Proxy33.create_database(Unknown Source) [?:?]
at org.apache.hadoop.hive.metastore.api.ThriftHiveMetastore$Processor$create_database.getResult(ThriftHiveMetastore.java:14396) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.hadoop.hive.metastore.api.ThriftHiveMetastore$Processor$create_database.getResult(ThriftHiveMetastore.java:14380) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.thrift.ProcessFunction.process(ProcessFunction.java:39) [libthrift-0.9.3.jar:0.9.3]
at org.apache.hadoop.hive.metastore.TUGIBasedProcessor.process(TUGIBasedProcessor.java:104) [hive-standalone-metastore-3.1.3.jar:3.1.3]
at org.apache.thrift.server.TThreadPoolServer$WorkerProcess.run(TThreadPoolServer.java:286) [libthrift-0.9.3.jar:0.9.3]
at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) [?:?]
at java.lang.Thread.run(Unknown Source) [?:?]
Caused by: java.net.UnknownHostException: op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com
at java.net.InetAddress$CachedAddresses.get(Unknown Source) ~[?:?]
at java.net.InetAddress.getAllByName0(Unknown Source) ~[?:?]
at java.net.InetAddress.getAllByName(Unknown Source) ~[?:?]
at java.net.InetAddress.getAllByName(Unknown Source) ~[?:?]
at com.amazonaws.SystemDefaultDnsResolver.resolve(SystemDefaultDnsResolver.java:27) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.http.DelegatingDnsResolver.resolve(DelegatingDnsResolver.java:38) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:112) ~[aws-java-sdk-bundle-1.12.454.jar:?]
at com.amazonaws.thirdparty.apache.http.impl.conn.PoolingHttpClientConnectionManager.connect(PoolingHttpClientConnectionManager.java:376) ~[aws-java-sdk-bundle-1.12.454.jar:?]
... 56 more
2023-05-04T04:00:00,122 DEBUG [pool-6-thread-198] conn.DefaultManagedHttpClientConnection: http-outgoing-121: Shutdown connection
2023-05-04T04:00:00,122 DEBUG [pool-6-thread-198] execchain.MainClientExec: Connection discarded
2023-05-04T04:00:00,122 DEBUG [pool-6-thread-198] conn.PoolingHttpClientConnectionManager: Connection released: [id: 121][route: {s}->https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com:443][total available: 0; route allocated: 0 of 96; total allocated: 0 of 96]
2023-05-04T04:00:00,122 DEBUG [pool-6-thread-198] http.AmazonHttpClient: Unable to execute HTTP request: op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com
2023-05-04T04:00:00,122 DEBUG [pool-6-thread-198] amazonaws.latency: MaxRetriesExceeded=[true], ServiceName=[Amazon S3], ServiceEndpoint=[https://op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com], Exception=[java.net.UnknownHostException: op-01427051a3dc18b69.s3-outposts.ap-northeast-1.amazonaws.com], RequestType=[GetObjectMetadataRequest], AWSRequestID=[null], ThrottledRetryCount=1, HttpClientPoolPendingCount=0, RetryCapacityConsumed=500, HttpClientPoolAvailableCount=0, RequestCount=1, Exception=1, HttpClientPoolLeasedCount=0, ClientExecuteTime=[2.37], HttpRequestTime=[1.579], ApiCallLatency=[2.099], RequestSigningTime=[0.167], CredentialsRequestTime=[0.007, 0.004],
2023-05-04T04:00:02,938 INFO [pool-6-thread-200] metastore.HiveMetaStore: 197: Done cleaning up thread local RawStore
2023-05-04T04:00:02,938 INFO [pool-6-thread-199] metastore.HiveMetaStore: 195: Done cleaning up thread local RawStore
2023-05-04T04:00:02,938 INFO [pool-6-thread-200] HiveMetaStore.audit: ugi=root ip=10.0.200.168 cmd=Done cleaning up thread local RawStore
2023-05-04T04:00:02,939 INFO [pool-6-thread-199] HiveMetaStore.audit: ugi=root ip=10.0.200.168 cmd=Done cleaning up thread local RawStore
2023-05-04T04:00:05,138 DEBUG [HikariPool-1 housekeeper] pool.HikariPool: HikariPool-1 - Pool stats (total=10, active=0, idle=10, waiting=0)
2023-05-04T04:00:05,766 DEBUG [HikariPool-2 housekeeper] pool.HikariPool: HikariPool-2 - Pool stats (total=10, active=0, idle=10, waiting=0)
2023-05-04T04:00:08,270 DEBUG [java-sdk-http-connection-reaper] conn.PoolingHttpClientConnectionManager: Closing connections idle longer than 60000 MILLISECONDS
```