Details
-
Bug
-
Status: Closed (View Workflow)
-
Critical
-
Resolution: Cannot Reproduce
-
10.3.21
-
None
-
TestTarball_2 debian-8
Description
galera.galera_bf_lock_wait failed on CI.
stdio.log:
|
10.3.21-5 699d312a959bab33c59cb78afd6dd55eb0c63d54, MDEV-21594 |
2020-01-26T05:43:42.2290168Z galera.galera_bf_lock_wait 'innodb' w1 [ fail ]
|
2020-01-26T05:43:42.2291032Z Test ended at 2020-01-26 05:43:42
|
2020-01-26T05:43:42.2291236Z
|
|
|
[...]
|
|
|
2020-01-26T05:43:42.2300931Z CURRENT_TEST: galera.galera_bf_lock_wait
|
2020-01-26T05:43:42.2301427Z mysqltest: At line 50: query 'drop table t1' failed: 2013: Lost connection to MySQL server during query
|
2020-01-26T05:43:42.2301630Z
|
2020-01-26T05:43:42.2301827Z The result from queries just before the failure was:
|
2020-01-26T05:43:42.2302035Z < snip >
|
2020-01-26T05:43:42.2302223Z WHILE 1 DO
|
2020-01-26T05:43:42.2302393Z start transaction;
|
2020-01-26T05:43:42.2302893Z update t1 set b=connection_id() where a=1;
|
2020-01-26T05:43:42.2303095Z commit;
|
2020-01-26T05:43:42.2303281Z END WHILE;
|
2020-01-26T05:43:42.2303450Z END|
|
2020-01-26T05:43:42.2303648Z connect node_1_p1, 127.0.0.1, root, , test, $NODE_MYPORT_1;
|
2020-01-26T05:43:42.2303854Z call p1;
|
2020-01-26T05:43:42.2304051Z connect node_1_p2, 127.0.0.1, root, , test, $NODE_MYPORT_1;
|
2020-01-26T05:43:42.2304242Z call p1;
|
2020-01-26T05:43:42.2304442Z connect node_2_p1, 127.0.0.1, root, , test, $NODE_MYPORT_2;
|
2020-01-26T05:43:42.2304646Z call p1;
|
2020-01-26T05:43:42.2304848Z connect node_2_p2, 127.0.0.1, root, , test, $NODE_MYPORT_2;
|
2020-01-26T05:43:42.2305037Z call p1;
|
2020-01-26T05:43:42.2305221Z connection default;
|
2020-01-26T05:43:42.2305701Z checking error log for 'BF lock wait long' message for 10 times every 10 seconds ...
|
2020-01-26T05:43:42.2305943Z drop table t1;
|
2020-01-26T05:43:42.2306731Z
|
2020-01-26T05:43:42.2306920Z More results from queries before failure can be found in /var/tmp/mtr/1/log/galera_bf_lock_wait.log
|
2020-01-26T05:43:42.2307461Z
|
2020-01-26T05:43:42.2325011Z
|
2020-01-26T05:43:42.2326028Z Server [mysqld.1 - pid: 21147, winpid: 21147, exit: 256] failed during test run
|
2020-01-26T05:43:42.2326780Z Server log from this test:
|
2020-01-26T05:43:42.2327222Z ----------SERVER LOG START-----------
|
2020-01-26T05:43:42.2327690Z 2020-01-26 5:27:40 0 [Warning] WSREP: option --wsrep-causal-reads is deprecated
|
2020-01-26T05:43:42.2328246Z 2020-01-26 5:27:40 0 [Note] /__w/1/s/bin/mysqld (mysqld 10.3.21-5-MariaDB-enterprise-log) starting as process 21148 ...
|
2020-01-26T05:43:42.2329277Z 2020-01-26 5:27:40 0 [Warning] Could not increase number of max_open_files to more than 1024 (request: 4184)
|
2020-01-26T05:43:42.2331285Z 2020-01-26 5:27:40 0 [Warning] Changed limits: max_open_files: 1024 max_connections: 151 (was 151) table_cache: 421 (was 2000)
|
2020-01-26T05:43:42.2332782Z 2020-01-26 5:27:40 0 [Warning] WSREP: wsrep_sst_receive_address is set to '127.0.0.1:16024' which makes it impossible for another host to reach this one. Please set it to the address which this node can be connected at by other cluster members.
|
2020-01-26T05:43:42.2333662Z 2020-01-26 5:27:40 0 [Note] WSREP: Read nil XID from storage engines, skipping position init
|
2020-01-26T05:43:42.2334232Z 2020-01-26 5:27:40 0 [Note] WSREP: wsrep_load(): loading provider library '/usr/lib/galera/libgalera_smm.so'
|
2020-01-26T05:43:42.2334803Z 2020-01-26 5:27:40 0 [Note] WSREP: wsrep_load(): Galera 25.3.28(r3894) by Codership Oy <info@codership.com> loaded successfully.
|
2020-01-26T05:43:42.2335309Z 2020-01-26 5:27:40 0 [Note] WSREP: CRC-32C: using hardware acceleration.
|
2020-01-26T05:43:42.2335841Z 2020-01-26 5:27:40 0 [Warning] WSREP: Could not open state file for reading: '/var/tmp/mtr/1/mysqld.1/data//grastate.dat'
|
2020-01-26T05:43:42.2337039Z 2020-01-26 5:27:40 0 [Note] WSREP: Found saved state: 00000000-0000-0000-0000-000000000000:-1, safe_to_bootstrap: 1
|
2020-01-26T05:43:42.2339968Z 2020-01-26 5:27:40 0 [Note] WSREP: Passing config to GCS: base_dir = /var/tmp/mtr/1/mysqld.1/data/; base_host = 127.0.0.1; base_port = 16022; cert.log_conflicts = no; cert.optimistic_pa = yes; debug = no; evs.auto_evict = 0; evs.delay_margin = PT1S; evs.delayed_keep_period = PT30S; evs.inactive_check_period = PT0.5S; evs.inactive_timeout = PT30S; evs.install_timeout = PT15S; evs.join_retrans_period = PT1S; evs.max_install_timeouts = 3; evs.send_window = 4; evs.stats_report_period = PT1M; evs.suspect_timeout = PT10S; evs.user_send_window = 2; evs.view_forget_timeout = PT24H; gcache.dir = /var/tmp/mtr/1/mysqld.1/data/; gcache.keep_pages_size = 0; gcache.mem_size = 0; gcache.name = /var/tmp/mtr/1/mysqld.1/data//galera.cache; gcache.page_size = 128M; gcache.recover = no; gcache.size = 10M; gcomm.thread_prio = ; gcs.fc_debug = 0; gcs.fc_factor = 1.0; gcs.fc_limit = 16; gcs.fc_master_slave = no; gcs.max_packet_size = 64500; gcs.max_throttle = 0.25; gcs.recv_q_hard_limit = 9223372036854775807; gcs.recv_q_soft_limit = 0.25; gcs.sync_donor = no
|
2020-01-26T05:43:42.2341393Z 2020-01-26 5:27:40 0 [Note] WSREP: GCache history reset: 00000000-0000-0000-0000-000000000000:0 -> 00000000-0000-0000-0000-000000000000:-1
|
2020-01-26T05:43:42.2341979Z 2020-01-26 5:27:40 0 [Note] WSREP: Assign initial position for certification: -1, protocol version: -1
|
2020-01-26T05:43:42.2342447Z 2020-01-26 5:27:40 0 [Note] WSREP: wsrep_sst_grab()
|
2020-01-26T05:43:42.2342895Z 2020-01-26 5:27:40 0 [Note] WSREP: Start replication
|
2020-01-26T05:43:42.2343411Z 2020-01-26 5:27:40 0 [Note] WSREP: Setting initial position to 00000000-0000-0000-0000-000000000000:-1
|
2020-01-26T05:43:42.2343891Z 2020-01-26 5:27:40 0 [Note] WSREP: protonet asio version 0
|
2020-01-26T05:43:42.2344345Z 2020-01-26 5:27:40 0 [Note] WSREP: Using CRC-32C for message checksums.
|
2020-01-26T05:43:42.2344793Z 2020-01-26 5:27:40 0 [Note] WSREP: backend: asio
|
2020-01-26T05:43:42.2345273Z 2020-01-26 5:27:40 0 [Note] WSREP: gcomm thread scheduling priority set to other:0
|
2020-01-26T05:43:42.2345826Z 2020-01-26 5:27:40 0 [Warning] WSREP: access file(/var/tmp/mtr/1/mysqld.1/data//gvwstate.dat) failed(No such file or directory)
|
2020-01-26T05:43:42.2347684Z 2020-01-26 5:27:40 0 [Note] WSREP: restore pc from disk failed
|
2020-01-26T05:43:42.2348115Z 2020-01-26 5:27:40 0 [Note] WSREP: GMCast version 0
|
2020-01-26T05:43:42.2348635Z 2020-01-26 5:27:40 0 [Note] WSREP: (9230dc59, 'tcp://0.0.0.0:16022') listening at tcp://0.0.0.0:16022
|
2020-01-26T05:43:42.2349145Z 2020-01-26 5:27:40 0 [Note] WSREP: (9230dc59, 'tcp://0.0.0.0:16022') multicast: , ttl: 1
|
2020-01-26T05:43:42.2349596Z 2020-01-26 5:27:40 0 [Note] WSREP: EVS version 0
|
2020-01-26T05:43:42.2350227Z 2020-01-26 5:27:40 0 [Note] WSREP: gcomm: connecting to group 'my_wsrep_cluster', peer ''
|
2020-01-26T05:43:42.2350720Z 2020-01-26 5:27:40 0 [Note] WSREP: start_prim is enabled, turn off pc_recovery
|
2020-01-26T05:43:42.2351167Z 2020-01-26 5:27:40 0 [Note] WSREP: Node 9230dc59 state prim
|
2020-01-26T05:43:42.2351639Z 2020-01-26 5:27:40 0 [Note] WSREP: view(view_id(PRIM,9230dc59,1) memb {
|
2020-01-26T05:43:42.2351880Z 9230dc59,0
|
2020-01-26T05:43:42.2352070Z } joined {
|
2020-01-26T05:43:42.2352239Z } left {
|
2020-01-26T05:43:42.2352425Z } partitioned {
|
2020-01-26T05:43:42.2352613Z })
|
2020-01-26T05:43:42.2353015Z 2020-01-26 5:27:40 0 [Note] WSREP: save pc into disk
|
2020-01-26T05:43:42.2353434Z 2020-01-26 5:27:40 0 [Note] WSREP: gcomm: connected
|
2020-01-26T05:43:42.2353932Z 2020-01-26 5:27:40 0 [Note] WSREP: Changing maximum packet size to 64500, resulting msg size: 32636
|
2020-01-26T05:43:42.2354414Z 2020-01-26 5:27:40 0 [Note] WSREP: Shifting CLOSED -> OPEN (TO: 0)
|
2020-01-26T05:43:42.2354888Z 2020-01-26 5:27:40 0 [Note] WSREP: Opened channel 'my_wsrep_cluster'
|
2020-01-26T05:43:42.2355344Z 2020-01-26 5:27:40 0 [Note] WSREP: Waiting for SST to complete.
|
2020-01-26T05:43:42.2356166Z 2020-01-26 5:27:40 0 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 1
|
2020-01-26T05:43:42.2357846Z 2020-01-26 5:27:40 0 [Note] WSREP: Starting new group from scratch: 9231bd4d-3ffc-11ea-8c1b-0636e4634d5d
|
2020-01-26T05:43:42.2358460Z 2020-01-26 5:27:40 0 [Note] WSREP: STATE_EXCHANGE: sent state UUID: 9231c792-3ffc-11ea-b136-b76f22d5fefc
|
2020-01-26T05:43:42.2358993Z 2020-01-26 5:27:40 0 [Note] WSREP: STATE EXCHANGE: sent state msg: 9231c792-3ffc-11ea-b136-b76f22d5fefc
|
2020-01-26T05:43:42.2359561Z 2020-01-26 5:27:40 0 [Note] WSREP: STATE EXCHANGE: got state msg: 9231c792-3ffc-11ea-b136-b76f22d5fefc from 0 (4aabfa970209)
|
2020-01-26T05:43:42.2360030Z 2020-01-26 5:27:40 0 [Note] WSREP: Quorum results:
|
2020-01-26T05:43:42.2360260Z version = 6,
|
2020-01-26T05:43:42.2360443Z component = PRIMARY,
|
2020-01-26T05:43:42.2360640Z conf_id = 0,
|
2020-01-26T05:43:42.2360831Z members = 1/1 (joined/total),
|
2020-01-26T05:43:42.2361030Z act_id = 0,
|
2020-01-26T05:43:42.2361371Z last_appl. = -1,
|
2020-01-26T05:43:42.2361585Z protocols = 0/9/3 (gcs/repl/appl),
|
2020-01-26T05:43:42.2362000Z group UUID = 9231bd4d-3ffc-11ea-8c1b-0636e4634d5d
|
2020-01-26T05:43:42.2362454Z 2020-01-26 5:27:40 0 [Note] WSREP: Flow-control interval: [16, 16]
|
2020-01-26T05:43:42.2363019Z 2020-01-26 5:27:40 0 [Note] WSREP: Trying to continue unpaused monitor
|
2020-01-26T05:43:42.2363486Z 2020-01-26 5:27:40 0 [Note] WSREP: Restored state OPEN -> JOINED (0)
|
2020-01-26T05:43:42.2363968Z 2020-01-26 5:27:40 0 [Note] WSREP: Member 0.0 (4aabfa970209) synced with group.
|
2020-01-26T05:43:42.2364435Z 2020-01-26 5:27:40 0 [Note] WSREP: Shifting JOINED -> SYNCED (TO: 0)
|
2020-01-26T05:43:42.2365051Z 2020-01-26 5:27:40 2 [Note] WSREP: New cluster view: global state: 9231bd4d-3ffc-11ea-8c1b-0636e4634d5d:0, view# 1: Primary, number of nodes: 1, my index: 0, protocol version 3
|
2020-01-26T05:43:42.2365572Z 2020-01-26 5:27:40 0 [Note] WSREP: SST complete, seqno: 0
|
2020-01-26T05:43:42.2366022Z 2020-01-26 5:27:40 0 [Note] Plugin 'partition' is disabled.
|
2020-01-26T05:43:42.2367082Z 2020-01-26 5:27:40 0 [Note] Plugin 'SEQUENCE' is disabled.
|
2020-01-26T05:43:42.2367548Z 2020-01-26 5:27:40 0 [Note] InnoDB: Using Linux native AIO
|
2020-01-26T05:43:42.2368033Z 2020-01-26 5:27:40 0 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
|
2020-01-26T05:43:42.2368486Z 2020-01-26 5:27:40 0 [Note] InnoDB: Uses event mutexes
|
2020-01-26T05:43:42.2368948Z 2020-01-26 5:27:40 0 [Note] InnoDB: Compressed tables use zlib 1.2.11
|
2020-01-26T05:43:42.2369376Z 2020-01-26 5:27:40 0 [Note] InnoDB: Number of pools: 1
|
2020-01-26T05:43:42.2369967Z 2020-01-26 5:27:40 0 [Note] InnoDB: Using SSE2 crc32 instructions
|
2020-01-26T05:43:42.2370496Z 2020-01-26 5:27:40 0 [Note] InnoDB: Initializing buffer pool, total size = 8M, instances = 1, chunk size = 8M
|
2020-01-26T05:43:42.2371096Z 2020-01-26 5:27:40 0 [Note] InnoDB: Completed initialization of buffer pool
|
2020-01-26T05:43:42.2371682Z 2020-01-26 5:27:40 0 [Note] InnoDB: If the mysqld execution user is authorized, page cleaner thread priority can be changed. See the man page of setpriority().
|
2020-01-26T05:43:42.2372203Z 2020-01-26 5:27:40 0 [Note] InnoDB: 128 out of 128 rollback segments are active.
|
2020-01-26T05:43:42.2372704Z 2020-01-26 5:27:40 0 [Note] InnoDB: Creating shared tablespace for temporary tables
|
2020-01-26T05:43:42.2373220Z 2020-01-26 5:27:40 0 [Note] InnoDB: Setting file './ibtmp1' size to 12 MB. Physically writing the file full; Please wait ...
|
2020-01-26T05:43:42.2373714Z 2020-01-26 5:27:40 0 [Note] InnoDB: File './ibtmp1' size is now 12 MB.
|
2020-01-26T05:43:42.2374172Z 2020-01-26 5:27:40 0 [Note] InnoDB: Waiting for purge to start
|
2020-01-26T05:43:42.2374683Z 2020-01-26 5:27:40 0 [Note] InnoDB: 10.3.21 started; log sequence number 1629889; transaction id 28
|
2020-01-26T05:43:42.2375202Z 2020-01-26 5:27:40 0 [Note] InnoDB: Loading buffer pool(s) from /var/tmp/mtr/1/mysqld.1/data/ib_buffer_pool
|
2020-01-26T05:43:42.2375661Z 2020-01-26 5:27:40 0 [Note] Plugin 'S3' is disabled.
|
2020-01-26T05:43:42.2376121Z 2020-01-26 5:27:40 0 [Note] Plugin 'INNODB_SYS_DATAFILES' is disabled.
|
2020-01-26T05:43:42.2377335Z 2020-01-26 5:27:40 0 [Note] Plugin 'INNODB_SYS_TABLESTATS' is disabled.
|
2020-01-26T05:43:42.2378150Z 2020-01-26 5:27:40 0 [Note] Plugin 'INNODB_MUTEXES' is disabled.
|
2020-01-26T05:43:42.2378616Z 2020-01-26 5:27:40 0 [Note] Plugin 'INNODB_CMP' is disabled.
|
2020-01-26T05:43:42.2379079Z 2020-01-26 5:27:40 0 [Note] Plugin 'INNODB_FT_DELETED' is disabled.
|
2020-01-26T05:43:42.2379540Z 2020-01-26 5:27:40 0 [Note] Plugin 'INNODB_CMP_RESET' is disabled.
|
2020-01-26T05:43:42.2380014Z 2020-01-26 5:27:40 0 [Note] Plugin 'INNODB_TABLESPACES_ENCRYPTION' is disabled.
|
2020-01-26T05:43:42.2380503Z 2020-01-26 5:27:40 0 [Note] InnoDB: Buffer pool(s) load completed at 200126 5:27:40
|
2020-01-26T05:43:42.2380982Z 2020-01-26 5:27:40 0 [Note] Plugin 'INNODB_CMPMEM_RESET' is disabled.
|
2020-01-26T05:43:42.2381413Z 2020-01-26 5:27:40 0 [Note] Plugin 'FEEDBACK' is disabled.
|
2020-01-26T05:43:42.2410893Z 2020-01-26 5:27:40 0 [Note] Plugin 'INNODB_FT_INDEX_TABLE' is disabled.
|
2020-01-26T05:43:42.2412094Z 2020-01-26 5:27:40 0 [Note] Plugin 'INNODB_CMP_PER_INDEX_RESET' is disabled.
|
2020-01-26T05:43:42.2413147Z 2020-01-26 5:27:40 0 [Note] Plugin 'user_variables' is disabled.
|
2020-01-26T05:43:42.2418158Z 2020-01-26 5:27:40 0 [Note] Plugin 'INNODB_FT_INDEX_CACHE' is disabled.
|
2020-01-26T05:43:42.2420950Z 2020-01-26 5:27:40 0 [Note] Plugin 'INNODB_FT_BEING_DELETED' is disabled.
|
2020-01-26T05:43:42.2423699Z 2020-01-26 5:27:40 0 [Note] Plugin 'INNODB_FT_DEFAULT_STOPWORD' is disabled.
|
2020-01-26T05:43:42.2426904Z 2020-01-26 5:27:40 0 [Note] Plugin 'INNODB_FT_CONFIG' is disabled.
|
2020-01-26T05:43:42.2427874Z 2020-01-26 5:27:40 0 [Note] Plugin 'INNODB_SYS_TABLESPACES' is disabled.
|
2020-01-26T05:43:42.2429694Z 2020-01-26 5:27:40 0 [Note] Plugin 'INNODB_TABLESPACES_SCRUBBING' is disabled.
|
2020-01-26T05:43:42.2430651Z 2020-01-26 5:27:40 0 [Note] Plugin 'INNODB_SYS_SEMAPHORE_WAITS' is disabled.
|
2020-01-26T05:43:42.2439027Z 2020-01-26 5:27:40 0 [Warning] /__w/1/s/bin/mysqld: unknown variable 'loose-feedback-debug-startup-interval=20'
|
2020-01-26T05:43:42.2440305Z 2020-01-26 5:27:40 0 [Warning] /__w/1/s/bin/mysqld: unknown variable 'loose-feedback-debug-first-interval=60'
|
2020-01-26T05:43:42.2441307Z 2020-01-26 5:27:40 0 [Warning] /__w/1/s/bin/mysqld: unknown variable 'loose-feedback-debug-interval=60'
|
2020-01-26T05:43:42.2442247Z 2020-01-26 5:27:40 0 [Warning] /__w/1/s/bin/mysqld: unknown option '--loose-pam-debug'
|
2020-01-26T05:43:42.2443169Z 2020-01-26 5:27:40 0 [Warning] /__w/1/s/bin/mysqld: unknown option '--loose-aria'
|
2020-01-26T05:43:42.2444251Z 2020-01-26 5:27:40 0 [Warning] /__w/1/s/bin/mysqld: unknown variable 'loose-debug-sync-timeout=300'
|
2020-01-26T05:43:42.2448950Z 2020-01-26 5:27:40 0 [Note] Server socket created on IP: '127.0.0.1'.
|
2020-01-26T05:43:42.2483710Z 2020-01-26 5:27:40 0 [Note] Reading of all Master_info entries succeeded
|
2020-01-26T05:43:42.2486017Z 2020-01-26 5:27:40 0 [Note] Added new Master_info '' to hash table
|
2020-01-26T05:43:42.2487339Z 2020-01-26 5:27:40 0 [Note] /__w/1/s/bin/mysqld: ready for connections.
|
2020-01-26T05:43:42.2487935Z Version: '10.3.21-5-MariaDB-enterprise-log' socket: '/var/tmp/mtr/tmp/1/mysqld.1.sock' port: 16020 MariaDB Enterprise Server
|
2020-01-26T05:43:42.2488477Z 2020-01-26 5:27:40 2 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
|
2020-01-26T05:43:42.2488943Z 2020-01-26 5:27:40 2 [Note] WSREP: REPL Protocols: 9 (4, 2)
|
2020-01-26T05:43:42.2489660Z 2020-01-26 5:27:40 2 [Note] WSREP: Assign initial position for certification: 0, protocol version: 4
|
2020-01-26T05:43:42.2490335Z 2020-01-26 5:27:40 0 [Note] WSREP: Service thread queue flushed.
|
2020-01-26T05:43:42.2491052Z 2020-01-26 5:27:40 2 [Note] WSREP: GCache history reset: 00000000-0000-0000-0000-000000000000:0 -> 9231bd4d-3ffc-11ea-8c1b-0636e4634d5d:0
|
2020-01-26T05:43:42.2491581Z 2020-01-26 5:27:40 2 [Note] WSREP: Synchronized with group, ready for connections
|
2020-01-26T05:43:42.2492084Z 2020-01-26 5:27:40 2 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
|
2020-01-26T05:43:42.2492647Z 2020-01-26 5:27:41 0 [Note] WSREP: (9230dc59, 'tcp://0.0.0.0:16022') connection established to 9288238b tcp://127.0.0.1:16025
|
2020-01-26T05:43:42.2493221Z 2020-01-26 5:27:41 0 [Note] WSREP: (9230dc59, 'tcp://0.0.0.0:16022') turning message relay requesting on, nonlive peers:
|
2020-01-26T05:43:42.2493747Z 2020-01-26 5:27:41 0 [Note] WSREP: declaring 9288238b at tcp://127.0.0.1:16025 stable
|
2020-01-26T05:43:42.2494204Z 2020-01-26 5:27:41 0 [Note] WSREP: Node 9230dc59 state prim
|
2020-01-26T05:43:42.2494675Z 2020-01-26 5:27:41 0 [Note] WSREP: view(view_id(PRIM,9230dc59,2) memb {
|
2020-01-26T05:43:42.2494908Z 9230dc59,0
|
2020-01-26T05:43:42.2495106Z 9288238b,0
|
2020-01-26T05:43:42.2495288Z } joined {
|
2020-01-26T05:43:42.2495455Z } left {
|
2020-01-26T05:43:42.2495650Z } partitioned {
|
2020-01-26T05:43:42.2495835Z })
|
2020-01-26T05:43:42.2496231Z 2020-01-26 5:27:41 0 [Note] WSREP: save pc into disk
|
2020-01-26T05:43:42.2497555Z 2020-01-26 5:27:41 0 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 2
|
2020-01-26T05:43:42.2498216Z 2020-01-26 5:27:41 0 [Note] WSREP: STATE_EXCHANGE: sent state UUID: 92d4f69f-3ffc-11ea-a500-0e7c1d95bf29
|
2020-01-26T05:43:42.2529475Z 2020-01-26 5:27:41 0 [Note] WSREP: STATE EXCHANGE: sent state msg: 92d4f69f-3ffc-11ea-a500-0e7c1d95bf29
|
2020-01-26T05:43:42.2544374Z 2020-01-26 5:27:41 0 [Note] WSREP: STATE EXCHANGE: got state msg: 92d4f69f-3ffc-11ea-a500-0e7c1d95bf29 from 0 (4aabfa970209)
|
2020-01-26T05:43:42.2545435Z 2020-01-26 5:27:42 0 [Note] WSREP: STATE EXCHANGE: got state msg: 92d4f69f-3ffc-11ea-a500-0e7c1d95bf29 from 1 (4aabfa970209)
|
2020-01-26T05:43:42.2545985Z 2020-01-26 5:27:42 0 [Note] WSREP: Quorum results:
|
2020-01-26T05:43:42.2546820Z version = 6,
|
2020-01-26T05:43:42.2547032Z component = PRIMARY,
|
2020-01-26T05:43:42.2547228Z conf_id = 1,
|
2020-01-26T05:43:42.2547584Z members = 1/2 (joined/total),
|
2020-01-26T05:43:42.2547795Z act_id = 0,
|
2020-01-26T05:43:42.2547985Z last_appl. = 0,
|
2020-01-26T05:43:42.2548176Z protocols = 0/9/3 (gcs/repl/appl),
|
2020-01-26T05:43:42.2548608Z group UUID = 9231bd4d-3ffc-11ea-8c1b-0636e4634d5d
|
2020-01-26T05:43:42.2549257Z 2020-01-26 5:27:42 0 [Note] WSREP: Flow-control interval: [23, 23]
|
2020-01-26T05:43:42.2549750Z 2020-01-26 5:27:42 0 [Note] WSREP: Trying to continue unpaused monitor
|
2020-01-26T05:43:42.2550383Z 2020-01-26 5:27:42 2 [Note] WSREP: New cluster view: global state: 9231bd4d-3ffc-11ea-8c1b-0636e4634d5d:0, view# 2: Primary, number of nodes: 2, my index: 0, protocol version 3
|
2020-01-26T05:43:42.2550944Z 2020-01-26 5:27:42 2 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
|
2020-01-26T05:43:42.2551551Z 2020-01-26 5:27:42 2 [Note] WSREP: REPL Protocols: 9 (4, 2)
|
2020-01-26T05:43:42.2552041Z 2020-01-26 5:27:42 2 [Note] WSREP: Assign initial position for certification: 0, protocol version: 4
|
2020-01-26T05:43:42.2552518Z 2020-01-26 5:27:42 0 [Note] WSREP: Service thread queue flushed.
|
2020-01-26T05:43:42.2553094Z 2020-01-26 5:27:42 0 [Note] WSREP: Member 1.0 (4aabfa970209) requested state transfer from '*any*'. Selected 0.0 (4aabfa970209)(SYNCED) as donor.
|
|
|
[...]
|
|
|
2020-01-26T05:43:42.3736925Z ============================
|
2020-01-26T05:43:42.3737155Z InnoDB: ###### Diagnostic info printed to the standard error stream
|
2020-01-26T05:43:42.3737749Z 2020-01-26 5:40:35 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.3738243Z --Thread 140059959392000 has waited at lock0lock.cc line 6267 for 768.00 seconds the semaphore:
|
2020-01-26T05:43:42.3738459Z Mutex at 0x56540909d940, Mutex LOCK_SYS created lock0lock.cc:460, lock var 2
|
2020-01-26T05:43:42.3738599Z
|
2020-01-26T05:43:42.3738938Z 2020-01-26 5:40:35 0 [Note] InnoDB: A semaphore wait:
|
2020-01-26T05:43:42.3739381Z --Thread 140059959392000 has waited at lock0lock.cc line 6267 for 768.00 seconds the semaphore:
|
2020-01-26T05:43:42.3739654Z Mutex at 0x56540909d940, Mutex LOCK_SYS created lock0lock.cc:460, lock var 2
|
2020-01-26T05:43:42.3739791Z
|
2020-01-26T05:43:42.3739962Z InnoDB: ###### Starts InnoDB Monitor for 30 secs to print diagnostic info:
|
2020-01-26T05:43:42.3740128Z InnoDB: Pending reads 0, writes 0
|
2020-01-26T05:43:42.3740279Z
|
2020-01-26T05:43:42.3740426Z =====================================
|
2020-01-26T05:43:42.3740855Z 2020-01-26 05:40:40 0x7f621b7fe700 INNODB MONITOR OUTPUT
|
2020-01-26T05:43:42.3741086Z =====================================
|
2020-01-26T05:43:42.3741265Z Per second averages calculated from the last 20 seconds
|
2020-01-26T05:43:42.3741578Z -----------------
|
2020-01-26T05:43:42.3741784Z BACKGROUND THREAD
|
2020-01-26T05:43:42.3742145Z -----------------
|
2020-01-26T05:43:42.3742370Z srv_master_thread loops: 2 srv_active, 0 srv_shutdown, 777 srv_idle
|
2020-01-26T05:43:42.3742576Z srv_master_thread log flush and writes: 779
|
2020-01-26T05:43:42.3742957Z ----------
|
2020-01-26T05:43:42.3743166Z SEMAPHORES
|
2020-01-26T05:43:42.3743512Z ----------
|
2020-01-26T05:43:42.3743701Z OS WAIT ARRAY INFO: reservation count 363
|
2020-01-26T05:43:42.3744180Z --Thread 140059959392000 has waited at lock0lock.cc line 6267 for 773.00 seconds the semaphore:
|
2020-01-26T05:43:42.3744441Z Mutex at 0x56540909d940, Mutex LOCK_SYS created lock0lock.cc:460, lock var 2
|
2020-01-26T05:43:42.3744734Z
|
2020-01-26T05:43:42.3744906Z OS WAIT ARRAY INFO: signal count 198
|
2020-01-26T05:43:42.3745439Z RW-shared spins 0, rounds 38, OS waits 14
|
2020-01-26T05:43:42.3745865Z RW-excl spins 0, rounds 11, OS waits 0
|
2020-01-26T05:43:42.3746673Z RW-sx spins 0, rounds 0, OS waits 0
|
2020-01-26T05:43:42.3747135Z Spin rounds per wait: 38.00 RW-shared, 11.00 RW-excl, 0.00 RW-sx
|
2020-01-26T05:43:42.3747494Z FAIL TO OBTAIN LOCK MUTEX, SKIP LOCK INFO PRINTING
|
2020-01-26T05:43:42.3748520Z --------
|
2020-01-26T05:43:42.3748748Z FILE I/O
|
2020-01-26T05:43:42.3749062Z --------
|
2020-01-26T05:43:42.3749263Z I/O thread 0 state: waiting for completed aio requests (insert buffer thread)
|
2020-01-26T05:43:42.3749449Z I/O thread 1 state: waiting for completed aio requests (log thread)
|
2020-01-26T05:43:42.3749629Z I/O thread 2 state: waiting for completed aio requests (read thread)
|
2020-01-26T05:43:42.3749806Z I/O thread 3 state: waiting for completed aio requests (read thread)
|
2020-01-26T05:43:42.3749967Z I/O thread 4 state: waiting for completed aio requests (write thread)
|
2020-01-26T05:43:42.3750150Z I/O thread 5 state: waiting for completed aio requests (write thread)
|
2020-01-26T05:43:42.3750321Z Pending normal aio reads: [0, 0] , aio writes: [0, 0] ,
|
2020-01-26T05:43:42.3750675Z ibuf aio reads:, log i/o's:, sync i/o's:
|
2020-01-26T05:43:42.3750898Z Pending flushes (fsync) log: 0; buffer pool: 0
|
2020-01-26T05:43:42.3751097Z 190 OS file reads, 863 OS file writes, 336 OS fsyncs
|
2020-01-26T05:43:42.3751267Z 0.00 reads/s, 0 avg bytes/read, 0.00 writes/s, 0.00 fsyncs/s
|
2020-01-26T05:43:42.3752642Z -------------------------------------
|
2020-01-26T05:43:42.3752877Z INSERT BUFFER AND ADAPTIVE HASH INDEX
|
2020-01-26T05:43:42.3753284Z -------------------------------------
|
2020-01-26T05:43:42.3753491Z Ibuf: size 1, free list len 0, seg size 2, 0 merges
|
2020-01-26T05:43:42.3753650Z merged operations:
|
2020-01-26T05:43:42.3753792Z insert 0, delete mark 0, delete 0
|
2020-01-26T05:43:42.3753993Z discarded operations:
|
2020-01-26T05:43:42.3754179Z insert 0, delete mark 0, delete 0
|
2020-01-26T05:43:42.3754387Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3754599Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3754810Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3755017Z Hash table size 2267, node heap has 1 buffer(s)
|
2020-01-26T05:43:42.3755209Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3755414Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3755629Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3755813Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3756218Z 0.00 hash searches/s, 0.00 non-hash searches/s
|
2020-01-26T05:43:42.3757664Z ---
|
2020-01-26T05:43:42.3758283Z LOG
|
2020-01-26T05:43:42.3758662Z ---
|
2020-01-26T05:43:42.3758851Z Log sequence number 1900754
|
2020-01-26T05:43:42.3759535Z Log flushed up to 1900754
|
2020-01-26T05:43:42.3759779Z Pages flushed up to 1900754
|
2020-01-26T05:43:42.3759985Z Last checkpoint at 1900745
|
2020-01-26T05:43:42.3760183Z 0 pending log flushes, 0 pending chkp writes
|
2020-01-26T05:43:42.3761003Z 325 log i/o's done, 0.00 log i/o's/second
|
2020-01-26T05:43:42.3761642Z ----------------------
|
2020-01-26T05:43:42.3761874Z BUFFER POOL AND MEMORY
|
2020-01-26T05:43:42.3762253Z ----------------------
|
2020-01-26T05:43:42.3762450Z Total large memory allocated 10682368
|
2020-01-26T05:43:42.3762661Z Dictionary memory allocated 29376
|
2020-01-26T05:43:42.3762862Z Buffer pool size 512
|
2020-01-26T05:43:42.3763052Z Free buffers 179
|
2020-01-26T05:43:42.3763232Z Database pages 332
|
2020-01-26T05:43:42.3763417Z Old database pages 0
|
2020-01-26T05:43:42.3763606Z Modified db pages 0
|
2020-01-26T05:43:42.3764050Z Percent of dirty pages(LRU & free pages): 0.000
|
2020-01-26T05:43:42.3764250Z Max dirty pages percent: 75.000
|
2020-01-26T05:43:42.3764927Z Pending reads 0
|
2020-01-26T05:43:42.3765176Z Pending writes: LRU 0, flush list 0, single page 0
|
2020-01-26T05:43:42.3765673Z Pages made young 0, not young 0
|
2020-01-26T05:43:42.3767243Z 0.00 youngs/s, 0.00 non-youngs/s
|
2020-01-26T05:43:42.3767624Z Pages read 175, created 257, written 533
|
2020-01-26T05:43:42.3767842Z 0.00 reads/s, 0.00 creates/s, 0.00 writes/s
|
2020-01-26T05:43:42.3768056Z No buffer pool page gets since the last printout
|
2020-01-26T05:43:42.3768287Z Pages read ahead 0.00/s, evicted without access 0.00/s, Random read ahead 0.00/s
|
2020-01-26T05:43:42.3768492Z LRU len: 332, unzip_LRU len: 0
|
2020-01-26T05:43:42.3768694Z I/O sum[0]:cur[0], unzip sum[0]:cur[0]
|
2020-01-26T05:43:42.3769120Z --------------
|
2020-01-26T05:43:42.3769338Z ROW OPERATIONS
|
2020-01-26T05:43:42.3769692Z --------------
|
2020-01-26T05:43:42.3808433Z 0 queries inside InnoDB, 0 queries in queue
|
2020-01-26T05:43:42.3808864Z 0 read views open inside InnoDB
|
2020-01-26T05:43:42.3809111Z Process ID=21148, Main thread ID=140059445536512, state: sleeping
|
2020-01-26T05:43:42.3809345Z Number of rows inserted 2, updated 307, deleted 0, read 478
|
2020-01-26T05:43:42.3809564Z 0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 0.00 reads/s
|
2020-01-26T05:43:42.3809924Z Number of system rows inserted 0, updated 0, deleted 0, read 0
|
2020-01-26T05:43:42.3810155Z 0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 0.00 reads/s
|
2020-01-26T05:43:42.3810767Z ----------------------------
|
2020-01-26T05:43:42.3810992Z END OF INNODB MONITOR OUTPUT
|
2020-01-26T05:43:42.3811174Z ============================
|
2020-01-26T05:43:42.3811343Z
|
2020-01-26T05:43:42.3811488Z =====================================
|
2020-01-26T05:43:42.3811936Z 2020-01-26 05:41:00 0x7f621b7fe700 INNODB MONITOR OUTPUT
|
2020-01-26T05:43:42.3812313Z =====================================
|
2020-01-26T05:43:42.3812531Z Per second averages calculated from the last 20 seconds
|
2020-01-26T05:43:42.3812937Z -----------------
|
2020-01-26T05:43:42.3813132Z BACKGROUND THREAD
|
2020-01-26T05:43:42.3813497Z -----------------
|
2020-01-26T05:43:42.3813724Z srv_master_thread loops: 2 srv_active, 0 srv_shutdown, 797 srv_idle
|
2020-01-26T05:43:42.3813955Z srv_master_thread log flush and writes: 799
|
2020-01-26T05:43:42.3814321Z ----------
|
2020-01-26T05:43:42.3814509Z SEMAPHORES
|
2020-01-26T05:43:42.3814852Z ----------
|
2020-01-26T05:43:42.3815058Z OS WAIT ARRAY INFO: reservation count 363
|
2020-01-26T05:43:42.3815541Z --Thread 140059959392000 has waited at lock0lock.cc line 6267 for 793.00 seconds the semaphore:
|
2020-01-26T05:43:42.3815791Z Mutex at 0x56540909d940, Mutex LOCK_SYS created lock0lock.cc:460, lock var 2
|
2020-01-26T05:43:42.3815978Z
|
2020-01-26T05:43:42.3816167Z OS WAIT ARRAY INFO: signal count 198
|
2020-01-26T05:43:42.3816997Z RW-shared spins 0, rounds 38, OS waits 14
|
2020-01-26T05:43:42.3817424Z RW-excl spins 0, rounds 11, OS waits 0
|
2020-01-26T05:43:42.3817829Z RW-sx spins 0, rounds 0, OS waits 0
|
2020-01-26T05:43:42.3818277Z Spin rounds per wait: 38.00 RW-shared, 11.00 RW-excl, 0.00 RW-sx
|
2020-01-26T05:43:42.3818523Z FAIL TO OBTAIN LOCK MUTEX, SKIP LOCK INFO PRINTING
|
2020-01-26T05:43:42.3818874Z --------
|
2020-01-26T05:43:42.3819089Z FILE I/O
|
2020-01-26T05:43:42.3819396Z --------
|
2020-01-26T05:43:42.3819568Z I/O thread 0 state: waiting for completed aio requests (insert buffer thread)
|
2020-01-26T05:43:42.3819736Z I/O thread 1 state: waiting for completed aio requests (log thread)
|
2020-01-26T05:43:42.3819917Z I/O thread 2 state: waiting for completed aio requests (read thread)
|
2020-01-26T05:43:42.3820094Z I/O thread 3 state: waiting for completed aio requests (read thread)
|
2020-01-26T05:43:42.3820271Z I/O thread 4 state: waiting for completed aio requests (write thread)
|
2020-01-26T05:43:42.3820448Z I/O thread 5 state: waiting for completed aio requests (write thread)
|
2020-01-26T05:43:42.3820611Z Pending normal aio reads: [0, 0] , aio writes: [0, 0] ,
|
2020-01-26T05:43:42.3821243Z ibuf aio reads:, log i/o's:, sync i/o's:
|
2020-01-26T05:43:42.3821484Z Pending flushes (fsync) log: 0; buffer pool: 0
|
2020-01-26T05:43:42.3821702Z 190 OS file reads, 863 OS file writes, 336 OS fsyncs
|
2020-01-26T05:43:42.3821875Z 0.00 reads/s, 0 avg bytes/read, 0.00 writes/s, 0.00 fsyncs/s
|
2020-01-26T05:43:42.3822354Z -------------------------------------
|
2020-01-26T05:43:42.3822582Z INSERT BUFFER AND ADAPTIVE HASH INDEX
|
2020-01-26T05:43:42.3822925Z -------------------------------------
|
2020-01-26T05:43:42.3823219Z Ibuf: size 1, free list len 0, seg size 2, 0 merges
|
2020-01-26T05:43:42.3823443Z merged operations:
|
2020-01-26T05:43:42.3823576Z insert 0, delete mark 0, delete 0
|
2020-01-26T05:43:42.3823779Z discarded operations:
|
2020-01-26T05:43:42.3824034Z insert 0, delete mark 0, delete 0
|
2020-01-26T05:43:42.3824201Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3824407Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3824624Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3824835Z Hash table size 2267, node heap has 1 buffer(s)
|
2020-01-26T05:43:42.3825041Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3825231Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3825445Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3825658Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3826086Z 0.00 hash searches/s, 0.00 non-hash searches/s
|
2020-01-26T05:43:42.3827205Z ---
|
2020-01-26T05:43:42.3827407Z LOG
|
2020-01-26T05:43:42.3827743Z ---
|
2020-01-26T05:43:42.3827944Z Log sequence number 1900754
|
2020-01-26T05:43:42.3828149Z Log flushed up to 1900754
|
2020-01-26T05:43:42.3828328Z Pages flushed up to 1900754
|
2020-01-26T05:43:42.3828518Z Last checkpoint at 1900745
|
2020-01-26T05:43:42.3828719Z 0 pending log flushes, 0 pending chkp writes
|
2020-01-26T05:43:42.3829239Z 325 log i/o's done, 0.00 log i/o's/second
|
2020-01-26T05:43:42.3829617Z ----------------------
|
2020-01-26T05:43:42.3829837Z BUFFER POOL AND MEMORY
|
2020-01-26T05:43:42.3830202Z ----------------------
|
2020-01-26T05:43:42.3830415Z Total large memory allocated 10682368
|
2020-01-26T05:43:42.3830616Z Dictionary memory allocated 29376
|
2020-01-26T05:43:42.3830809Z Buffer pool size 512
|
2020-01-26T05:43:42.3831015Z Free buffers 179
|
2020-01-26T05:43:42.3831205Z Database pages 332
|
2020-01-26T05:43:42.3831397Z Old database pages 0
|
2020-01-26T05:43:42.3831570Z Modified db pages 0
|
2020-01-26T05:43:42.3831766Z Percent of dirty pages(LRU & free pages): 0.000
|
2020-01-26T05:43:42.3831971Z Max dirty pages percent: 75.000
|
2020-01-26T05:43:42.3832166Z Pending reads 0
|
2020-01-26T05:43:42.3832347Z Pending writes: LRU 0, flush list 0, single page 0
|
2020-01-26T05:43:42.3832551Z Pages made young 0, not young 0
|
2020-01-26T05:43:42.3832936Z 0.00 youngs/s, 0.00 non-youngs/s
|
2020-01-26T05:43:42.3833159Z Pages read 175, created 257, written 533
|
2020-01-26T05:43:42.3833347Z 0.00 reads/s, 0.00 creates/s, 0.00 writes/s
|
2020-01-26T05:43:42.3833555Z No buffer pool page gets since the last printout
|
2020-01-26T05:43:42.3833781Z Pages read ahead 0.00/s, evicted without access 0.00/s, Random read ahead 0.00/s
|
2020-01-26T05:43:42.3834001Z LRU len: 332, unzip_LRU len: 0
|
2020-01-26T05:43:42.3834199Z I/O sum[0]:cur[0], unzip sum[0]:cur[0]
|
2020-01-26T05:43:42.3834554Z --------------
|
2020-01-26T05:43:42.3834765Z ROW OPERATIONS
|
2020-01-26T05:43:42.3835122Z --------------
|
2020-01-26T05:43:42.3835329Z 0 queries inside InnoDB, 0 queries in queue
|
2020-01-26T05:43:42.3835518Z 0 read views open inside InnoDB
|
2020-01-26T05:43:42.3835731Z Process ID=21148, Main thread ID=140059445536512, state: sleeping
|
2020-01-26T05:43:42.3835958Z Number of rows inserted 2, updated 307, deleted 0, read 478
|
2020-01-26T05:43:42.3836180Z 0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 0.00 reads/s
|
2020-01-26T05:43:42.3836820Z Number of system rows inserted 0, updated 0, deleted 0, read 0
|
2020-01-26T05:43:42.3837040Z 0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 0.00 reads/s
|
2020-01-26T05:43:42.3837448Z ----------------------------
|
2020-01-26T05:43:42.3837660Z END OF INNODB MONITOR OUTPUT
|
2020-01-26T05:43:42.3837855Z ============================
|
2020-01-26T05:43:42.3838071Z InnoDB: ###### Diagnostic info printed to the standard error stream
|
2020-01-26T05:43:42.3838588Z 2020-01-26 5:41:06 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.3839099Z --Thread 140059959392000 has waited at lock0lock.cc line 6267 for 799.00 seconds the semaphore:
|
2020-01-26T05:43:42.3839367Z Mutex at 0x56540909d940, Mutex LOCK_SYS created lock0lock.cc:460, lock var 2
|
2020-01-26T05:43:42.3839537Z
|
2020-01-26T05:43:42.3839956Z 2020-01-26 5:41:06 0 [Note] InnoDB: A semaphore wait:
|
2020-01-26T05:43:42.3840454Z --Thread 140059959392000 has waited at lock0lock.cc line 6267 for 799.00 seconds the semaphore:
|
2020-01-26T05:43:42.3840724Z Mutex at 0x56540909d940, Mutex LOCK_SYS created lock0lock.cc:460, lock var 2
|
2020-01-26T05:43:42.3840901Z
|
2020-01-26T05:43:42.3841091Z InnoDB: ###### Starts InnoDB Monitor for 30 secs to print diagnostic info:
|
2020-01-26T05:43:42.3841470Z InnoDB: Pending reads 0, writes 0
|
2020-01-26T05:43:42.3841636Z
|
2020-01-26T05:43:42.3841775Z =====================================
|
2020-01-26T05:43:42.3842227Z 2020-01-26 05:41:20 0x7f621b7fe700 INNODB MONITOR OUTPUT
|
2020-01-26T05:43:42.3842469Z =====================================
|
2020-01-26T05:43:42.3842669Z Per second averages calculated from the last 20 seconds
|
2020-01-26T05:43:42.3843057Z -----------------
|
2020-01-26T05:43:42.3843402Z BACKGROUND THREAD
|
2020-01-26T05:43:42.3843770Z -----------------
|
2020-01-26T05:43:42.3843994Z srv_master_thread loops: 2 srv_active, 0 srv_shutdown, 817 srv_idle
|
2020-01-26T05:43:42.3844200Z srv_master_thread log flush and writes: 819
|
2020-01-26T05:43:42.3844571Z ----------
|
2020-01-26T05:43:42.3844771Z SEMAPHORES
|
2020-01-26T05:43:42.3845120Z ----------
|
2020-01-26T05:43:42.3845399Z OS WAIT ARRAY INFO: reservation count 363
|
2020-01-26T05:43:42.3845890Z --Thread 140059959392000 has waited at lock0lock.cc line 6267 for 813.00 seconds the semaphore:
|
2020-01-26T05:43:42.3846153Z Mutex at 0x56540909d940, Mutex LOCK_SYS created lock0lock.cc:460, lock var 2
|
2020-01-26T05:43:42.3847118Z
|
2020-01-26T05:43:42.3847310Z OS WAIT ARRAY INFO: signal count 198
|
2020-01-26T05:43:42.3847736Z RW-shared spins 0, rounds 38, OS waits 14
|
2020-01-26T05:43:42.3848159Z RW-excl spins 0, rounds 11, OS waits 0
|
2020-01-26T05:43:42.3848577Z RW-sx spins 0, rounds 0, OS waits 0
|
2020-01-26T05:43:42.3849009Z Spin rounds per wait: 38.00 RW-shared, 11.00 RW-excl, 0.00 RW-sx
|
2020-01-26T05:43:42.3849248Z FAIL TO OBTAIN LOCK MUTEX, SKIP LOCK INFO PRINTING
|
2020-01-26T05:43:42.3849618Z --------
|
2020-01-26T05:43:42.3890448Z FILE I/O
|
2020-01-26T05:43:42.3891470Z --------
|
2020-01-26T05:43:42.3891802Z I/O thread 0 state: waiting for completed aio requests (insert buffer thread)
|
2020-01-26T05:43:42.3892093Z I/O thread 1 state: waiting for completed aio requests (log thread)
|
2020-01-26T05:43:42.3892364Z I/O thread 2 state: waiting for completed aio requests (read thread)
|
2020-01-26T05:43:42.3912294Z I/O thread 3 state: waiting for completed aio requests (read thread)
|
2020-01-26T05:43:42.3913080Z I/O thread 4 state: waiting for completed aio requests (write thread)
|
2020-01-26T05:43:42.3913377Z I/O thread 5 state: waiting for completed aio requests (write thread)
|
2020-01-26T05:43:42.3913642Z Pending normal aio reads: [0, 0] , aio writes: [0, 0] ,
|
2020-01-26T05:43:42.3914283Z ibuf aio reads:, log i/o's:, sync i/o's:
|
2020-01-26T05:43:42.3914542Z Pending flushes (fsync) log: 0; buffer pool: 0
|
2020-01-26T05:43:42.3914787Z 190 OS file reads, 863 OS file writes, 336 OS fsyncs
|
2020-01-26T05:43:42.3915020Z 0.00 reads/s, 0 avg bytes/read, 0.00 writes/s, 0.00 fsyncs/s
|
2020-01-26T05:43:42.3915479Z -------------------------------------
|
2020-01-26T05:43:42.3915735Z INSERT BUFFER AND ADAPTIVE HASH INDEX
|
2020-01-26T05:43:42.3916184Z -------------------------------------
|
2020-01-26T05:43:42.3917043Z Ibuf: size 1, free list len 0, seg size 2, 0 merges
|
2020-01-26T05:43:42.3917485Z merged operations:
|
2020-01-26T05:43:42.3917708Z insert 0, delete mark 0, delete 0
|
2020-01-26T05:43:42.3917931Z discarded operations:
|
2020-01-26T05:43:42.3918149Z insert 0, delete mark 0, delete 0
|
2020-01-26T05:43:42.3918364Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3918761Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3918997Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3919232Z Hash table size 2267, node heap has 1 buffer(s)
|
2020-01-26T05:43:42.3919452Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3919682Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3919912Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3920142Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3920631Z 0.00 hash searches/s, 0.00 non-hash searches/s
|
2020-01-26T05:43:42.3921045Z ---
|
2020-01-26T05:43:42.3921272Z LOG
|
2020-01-26T05:43:42.3921640Z ---
|
2020-01-26T05:43:42.3921865Z Log sequence number 1900754
|
2020-01-26T05:43:42.3922076Z Log flushed up to 1900754
|
2020-01-26T05:43:42.3922294Z Pages flushed up to 1900754
|
2020-01-26T05:43:42.3922514Z Last checkpoint at 1900745
|
2020-01-26T05:43:42.3922737Z 0 pending log flushes, 0 pending chkp writes
|
2020-01-26T05:43:42.3923166Z 325 log i/o's done, 0.00 log i/o's/second
|
2020-01-26T05:43:42.3923593Z ----------------------
|
2020-01-26T05:43:42.3923838Z BUFFER POOL AND MEMORY
|
2020-01-26T05:43:42.3924253Z ----------------------
|
2020-01-26T05:43:42.3924481Z Total large memory allocated 10682368
|
2020-01-26T05:43:42.3924714Z Dictionary memory allocated 29376
|
2020-01-26T05:43:42.3924937Z Buffer pool size 512
|
2020-01-26T05:43:42.3925155Z Free buffers 179
|
2020-01-26T05:43:42.3925371Z Database pages 332
|
2020-01-26T05:43:42.3925577Z Old database pages 0
|
2020-01-26T05:43:42.3925792Z Modified db pages 0
|
2020-01-26T05:43:42.3926127Z Percent of dirty pages(LRU & free pages): 0.000
|
2020-01-26T05:43:42.3926970Z Max dirty pages percent: 75.000
|
2020-01-26T05:43:42.3927258Z Pending reads 0
|
2020-01-26T05:43:42.3927489Z Pending writes: LRU 0, flush list 0, single page 0
|
2020-01-26T05:43:42.3927713Z Pages made young 0, not young 0
|
2020-01-26T05:43:42.3928173Z 0.00 youngs/s, 0.00 non-youngs/s
|
2020-01-26T05:43:42.3928427Z Pages read 175, created 257, written 533
|
2020-01-26T05:43:42.3928671Z 0.00 reads/s, 0.00 creates/s, 0.00 writes/s
|
2020-01-26T05:43:42.3928895Z No buffer pool page gets since the last printout
|
2020-01-26T05:43:42.3929153Z Pages read ahead 0.00/s, evicted without access 0.00/s, Random read ahead 0.00/s
|
2020-01-26T05:43:42.3929405Z LRU len: 332, unzip_LRU len: 0
|
2020-01-26T05:43:42.3929635Z I/O sum[0]:cur[0], unzip sum[0]:cur[0]
|
2020-01-26T05:43:42.3930259Z --------------
|
2020-01-26T05:43:42.3930520Z ROW OPERATIONS
|
2020-01-26T05:43:42.3930913Z --------------
|
2020-01-26T05:43:42.3931160Z 0 queries inside InnoDB, 0 queries in queue
|
2020-01-26T05:43:42.3931405Z 0 read views open inside InnoDB
|
2020-01-26T05:43:42.3931622Z Process ID=21148, Main thread ID=140059445536512, state: sleeping
|
2020-01-26T05:43:42.3931898Z Number of rows inserted 2, updated 307, deleted 0, read 478
|
2020-01-26T05:43:42.3932152Z 0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 0.00 reads/s
|
2020-01-26T05:43:42.3932405Z Number of system rows inserted 0, updated 0, deleted 0, read 0
|
2020-01-26T05:43:42.3932663Z 0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 0.00 reads/s
|
2020-01-26T05:43:42.3933078Z ----------------------------
|
2020-01-26T05:43:42.3933334Z END OF INNODB MONITOR OUTPUT
|
2020-01-26T05:43:42.3933559Z ============================
|
2020-01-26T05:43:42.3933804Z InnoDB: ###### Diagnostic info printed to the standard error stream
|
2020-01-26T05:43:42.3934279Z 2020-01-26 5:41:37 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.3934831Z --Thread 140059959392000 has waited at lock0lock.cc line 6267 for 830.00 seconds the semaphore:
|
2020-01-26T05:43:42.3935139Z Mutex at 0x56540909d940, Mutex LOCK_SYS created lock0lock.cc:460, lock var 2
|
2020-01-26T05:43:42.3935362Z
|
2020-01-26T05:43:42.3935789Z 2020-01-26 5:41:37 0 [Note] InnoDB: A semaphore wait:
|
2020-01-26T05:43:42.3936327Z --Thread 140059959392000 has waited at lock0lock.cc line 6267 for 830.00 seconds the semaphore:
|
2020-01-26T05:43:42.3937321Z Mutex at 0x56540909d940, Mutex LOCK_SYS created lock0lock.cc:460, lock var 2
|
2020-01-26T05:43:42.3937677Z
|
2020-01-26T05:43:42.3937911Z InnoDB: ###### Starts InnoDB Monitor for 30 secs to print diagnostic info:
|
2020-01-26T05:43:42.3938150Z InnoDB: Pending reads 0, writes 0
|
2020-01-26T05:43:42.3938346Z
|
2020-01-26T05:43:42.3938544Z =====================================
|
2020-01-26T05:43:42.3939040Z 2020-01-26 05:41:40 0x7f621b7fe700 INNODB MONITOR OUTPUT
|
2020-01-26T05:43:42.3939306Z =====================================
|
2020-01-26T05:43:42.3939548Z Per second averages calculated from the last 20 seconds
|
2020-01-26T05:43:42.3939938Z -----------------
|
2020-01-26T05:43:42.3940212Z BACKGROUND THREAD
|
2020-01-26T05:43:42.3940608Z -----------------
|
2020-01-26T05:43:42.3940864Z srv_master_thread loops: 2 srv_active, 0 srv_shutdown, 837 srv_idle
|
2020-01-26T05:43:42.3941100Z srv_master_thread log flush and writes: 839
|
2020-01-26T05:43:42.3941497Z ----------
|
2020-01-26T05:43:42.3941735Z SEMAPHORES
|
2020-01-26T05:43:42.3942115Z ----------
|
2020-01-26T05:43:42.3942337Z OS WAIT ARRAY INFO: reservation count 363
|
2020-01-26T05:43:42.3942857Z --Thread 140059959392000 has waited at lock0lock.cc line 6267 for 833.00 seconds the semaphore:
|
2020-01-26T05:43:42.3943155Z Mutex at 0x56540909d940, Mutex LOCK_SYS created lock0lock.cc:460, lock var 2
|
2020-01-26T05:43:42.3943371Z
|
2020-01-26T05:43:42.3943573Z OS WAIT ARRAY INFO: signal count 198
|
2020-01-26T05:43:42.3944011Z RW-shared spins 0, rounds 38, OS waits 14
|
2020-01-26T05:43:42.3944462Z RW-excl spins 0, rounds 11, OS waits 0
|
2020-01-26T05:43:42.3944911Z RW-sx spins 0, rounds 0, OS waits 0
|
2020-01-26T05:43:42.3945476Z Spin rounds per wait: 38.00 RW-shared, 11.00 RW-excl, 0.00 RW-sx
|
2020-01-26T05:43:42.3945749Z FAIL TO OBTAIN LOCK MUTEX, SKIP LOCK INFO PRINTING
|
2020-01-26T05:43:42.3946143Z --------
|
2020-01-26T05:43:42.3946928Z FILE I/O
|
2020-01-26T05:43:42.3947383Z --------
|
2020-01-26T05:43:42.3947623Z I/O thread 0 state: waiting for completed aio requests (insert buffer thread)
|
2020-01-26T05:43:42.3947879Z I/O thread 1 state: waiting for completed aio requests (log thread)
|
2020-01-26T05:43:42.3948148Z I/O thread 2 state: waiting for completed aio requests (read thread)
|
2020-01-26T05:43:42.3948399Z I/O thread 3 state: waiting for completed aio requests (read thread)
|
2020-01-26T05:43:42.3948649Z I/O thread 4 state: waiting for completed aio requests (write thread)
|
2020-01-26T05:43:42.3948909Z I/O thread 5 state: waiting for completed aio requests (write thread)
|
2020-01-26T05:43:42.3949349Z Pending normal aio reads: [0, 0] , aio writes: [0, 0] ,
|
2020-01-26T05:43:42.3949848Z ibuf aio reads:, log i/o's:, sync i/o's:
|
2020-01-26T05:43:42.3950117Z Pending flushes (fsync) log: 0; buffer pool: 0
|
2020-01-26T05:43:42.3950343Z 190 OS file reads, 863 OS file writes, 336 OS fsyncs
|
2020-01-26T05:43:42.3950591Z 0.00 reads/s, 0 avg bytes/read, 0.00 writes/s, 0.00 fsyncs/s
|
2020-01-26T05:43:42.3951025Z -------------------------------------
|
2020-01-26T05:43:42.3951279Z INSERT BUFFER AND ADAPTIVE HASH INDEX
|
2020-01-26T05:43:42.3951701Z -------------------------------------
|
2020-01-26T05:43:42.3951952Z Ibuf: size 1, free list len 0, seg size 2, 0 merges
|
2020-01-26T05:43:42.3952193Z merged operations:
|
2020-01-26T05:43:42.3952418Z insert 0, delete mark 0, delete 0
|
2020-01-26T05:43:42.3952649Z discarded operations:
|
2020-01-26T05:43:42.3952857Z insert 0, delete mark 0, delete 0
|
2020-01-26T05:43:42.3953093Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3953334Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3953575Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3953814Z Hash table size 2267, node heap has 1 buffer(s)
|
2020-01-26T05:43:42.3954041Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3954274Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3954511Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3954749Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3955201Z 0.00 hash searches/s, 0.00 non-hash searches/s
|
2020-01-26T05:43:42.3955703Z ---
|
2020-01-26T05:43:42.3955961Z LOG
|
2020-01-26T05:43:42.3956792Z ---
|
2020-01-26T05:43:42.3957081Z Log sequence number 1900754
|
2020-01-26T05:43:42.3957295Z Log flushed up to 1900754
|
2020-01-26T05:43:42.3957517Z Pages flushed up to 1900754
|
2020-01-26T05:43:42.3957743Z Last checkpoint at 1900745
|
2020-01-26T05:43:42.3957971Z 0 pending log flushes, 0 pending chkp writes
|
2020-01-26T05:43:42.3958393Z 325 log i/o's done, 0.00 log i/o's/second
|
2020-01-26T05:43:42.3958824Z ----------------------
|
2020-01-26T05:43:42.3959077Z BUFFER POOL AND MEMORY
|
2020-01-26T05:43:42.3959479Z ----------------------
|
2020-01-26T05:43:42.3959718Z Total large memory allocated 10682368
|
2020-01-26T05:43:42.3959952Z Dictionary memory allocated 29376
|
2020-01-26T05:43:42.3960183Z Buffer pool size 512
|
2020-01-26T05:43:42.3960406Z Free buffers 179
|
2020-01-26T05:43:42.3960629Z Database pages 332
|
2020-01-26T05:43:42.3960834Z Old database pages 0
|
2020-01-26T05:43:42.3961055Z Modified db pages 0
|
2020-01-26T05:43:42.3961290Z Percent of dirty pages(LRU & free pages): 0.000
|
2020-01-26T05:43:42.3961525Z Max dirty pages percent: 75.000
|
2020-01-26T05:43:42.3961725Z Pending reads 0
|
2020-01-26T05:43:42.3961949Z Pending writes: LRU 0, flush list 0, single page 0
|
2020-01-26T05:43:42.3962186Z Pages made young 0, not young 0
|
2020-01-26T05:43:42.3962600Z 0.00 youngs/s, 0.00 non-youngs/s
|
2020-01-26T05:43:42.3962835Z Pages read 175, created 257, written 533
|
2020-01-26T05:43:42.3963075Z 0.00 reads/s, 0.00 creates/s, 0.00 writes/s
|
2020-01-26T05:43:42.3963316Z No buffer pool page gets since the last printout
|
2020-01-26T05:43:42.3963680Z Pages read ahead 0.00/s, evicted without access 0.00/s, Random read ahead 0.00/s
|
2020-01-26T05:43:42.3963946Z LRU len: 332, unzip_LRU len: 0
|
2020-01-26T05:43:42.3964916Z I/O sum[0]:cur[0], unzip sum[0]:cur[0]
|
2020-01-26T05:43:42.3965475Z --------------
|
2020-01-26T05:43:42.3965727Z ROW OPERATIONS
|
2020-01-26T05:43:42.3966119Z --------------
|
2020-01-26T05:43:42.3966938Z 0 queries inside InnoDB, 0 queries in queue
|
2020-01-26T05:43:42.3967208Z 0 read views open inside InnoDB
|
2020-01-26T05:43:42.3967442Z Process ID=21148, Main thread ID=140059445536512, state: sleeping
|
2020-01-26T05:43:42.3967699Z Number of rows inserted 2, updated 307, deleted 0, read 478
|
2020-01-26T05:43:42.3967951Z 0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 0.00 reads/s
|
2020-01-26T05:43:42.3968187Z Number of system rows inserted 0, updated 0, deleted 0, read 0
|
2020-01-26T05:43:42.3968441Z 0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 0.00 reads/s
|
2020-01-26T05:43:42.3968913Z ----------------------------
|
2020-01-26T05:43:42.3969170Z END OF INNODB MONITOR OUTPUT
|
2020-01-26T05:43:42.3970839Z ============================
|
2020-01-26T05:43:42.3971083Z
|
2020-01-26T05:43:42.3971306Z =====================================
|
2020-01-26T05:43:42.3971848Z 2020-01-26 05:42:00 0x7f621b7fe700 INNODB MONITOR OUTPUT
|
2020-01-26T05:43:42.3972119Z =====================================
|
2020-01-26T05:43:42.3972363Z Per second averages calculated from the last 20 seconds
|
2020-01-26T05:43:42.3972788Z -----------------
|
2020-01-26T05:43:42.3973361Z BACKGROUND THREAD
|
2020-01-26T05:43:42.3974665Z -----------------
|
2020-01-26T05:43:42.3974949Z srv_master_thread loops: 2 srv_active, 0 srv_shutdown, 857 srv_idle
|
2020-01-26T05:43:42.3975206Z srv_master_thread log flush and writes: 859
|
2020-01-26T05:43:42.3975759Z ----------
|
2020-01-26T05:43:42.3977244Z SEMAPHORES
|
2020-01-26T05:43:42.3983456Z ----------
|
2020-01-26T05:43:42.3983776Z OS WAIT ARRAY INFO: reservation count 363
|
2020-01-26T05:43:42.3984679Z --Thread 140059959392000 has waited at lock0lock.cc line 6267 for 853.00 seconds the semaphore:
|
2020-01-26T05:43:42.3985053Z Mutex at 0x56540909d940, Mutex LOCK_SYS created lock0lock.cc:460, lock var 2
|
2020-01-26T05:43:42.3985261Z
|
2020-01-26T05:43:42.3985482Z OS WAIT ARRAY INFO: signal count 198
|
2020-01-26T05:43:42.3985931Z RW-shared spins 0, rounds 38, OS waits 14
|
2020-01-26T05:43:42.3986757Z RW-excl spins 0, rounds 11, OS waits 0
|
2020-01-26T05:43:42.3987269Z RW-sx spins 0, rounds 0, OS waits 0
|
2020-01-26T05:43:42.3987898Z Spin rounds per wait: 38.00 RW-shared, 11.00 RW-excl, 0.00 RW-sx
|
2020-01-26T05:43:42.3988176Z FAIL TO OBTAIN LOCK MUTEX, SKIP LOCK INFO PRINTING
|
2020-01-26T05:43:42.3988566Z --------
|
2020-01-26T05:43:42.3988803Z FILE I/O
|
2020-01-26T05:43:42.3989187Z --------
|
2020-01-26T05:43:42.3989441Z I/O thread 0 state: waiting for completed aio requests (insert buffer thread)
|
2020-01-26T05:43:42.3989709Z I/O thread 1 state: waiting for completed aio requests (log thread)
|
2020-01-26T05:43:42.3989950Z I/O thread 2 state: waiting for completed aio requests (read thread)
|
2020-01-26T05:43:42.3990218Z I/O thread 3 state: waiting for completed aio requests (read thread)
|
2020-01-26T05:43:42.3990475Z I/O thread 4 state: waiting for completed aio requests (write thread)
|
2020-01-26T05:43:42.3990732Z I/O thread 5 state: waiting for completed aio requests (write thread)
|
2020-01-26T05:43:42.3990983Z Pending normal aio reads: [0, 0] , aio writes: [0, 0] ,
|
2020-01-26T05:43:42.3991407Z ibuf aio reads:, log i/o's:, sync i/o's:
|
2020-01-26T05:43:42.3991692Z Pending flushes (fsync) log: 0; buffer pool: 0
|
2020-01-26T05:43:42.3993060Z 190 OS file reads, 863 OS file writes, 336 OS fsyncs
|
2020-01-26T05:43:42.3993337Z 0.00 reads/s, 0 avg bytes/read, 0.00 writes/s, 0.00 fsyncs/s
|
2020-01-26T05:43:42.3993817Z -------------------------------------
|
2020-01-26T05:43:42.3994069Z INSERT BUFFER AND ADAPTIVE HASH INDEX
|
2020-01-26T05:43:42.3994497Z -------------------------------------
|
2020-01-26T05:43:42.3995020Z Ibuf: size 1, free list len 0, seg size 2, 0 merges
|
2020-01-26T05:43:42.3995267Z merged operations:
|
2020-01-26T05:43:42.3995589Z insert 0, delete mark 0, delete 0
|
2020-01-26T05:43:42.3995823Z discarded operations:
|
2020-01-26T05:43:42.3996047Z insert 0, delete mark 0, delete 0
|
2020-01-26T05:43:42.3996754Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3997327Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3997607Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3997855Z Hash table size 2267, node heap has 1 buffer(s)
|
2020-01-26T05:43:42.3998092Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3999029Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3999284Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.3999522Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4000082Z 0.00 hash searches/s, 0.00 non-hash searches/s
|
2020-01-26T05:43:42.4000497Z ---
|
2020-01-26T05:43:42.4000715Z LOG
|
2020-01-26T05:43:42.4001086Z ---
|
2020-01-26T05:43:42.4001317Z Log sequence number 1900754
|
2020-01-26T05:43:42.4001556Z Log flushed up to 1900754
|
2020-01-26T05:43:42.4008994Z Pages flushed up to 1900754
|
2020-01-26T05:43:42.4009303Z Last checkpoint at 1900745
|
2020-01-26T05:43:42.4009536Z 0 pending log flushes, 0 pending chkp writes
|
2020-01-26T05:43:42.4011019Z 325 log i/o's done, 0.00 log i/o's/second
|
2020-01-26T05:43:42.4011563Z ----------------------
|
2020-01-26T05:43:42.4011794Z BUFFER POOL AND MEMORY
|
2020-01-26T05:43:42.4012206Z ----------------------
|
2020-01-26T05:43:42.4012455Z Total large memory allocated 10682368
|
2020-01-26T05:43:42.4012722Z Dictionary memory allocated 29376
|
2020-01-26T05:43:42.4012939Z Buffer pool size 512
|
2020-01-26T05:43:42.4013160Z Free buffers 179
|
2020-01-26T05:43:42.4013380Z Database pages 332
|
2020-01-26T05:43:42.4013602Z Old database pages 0
|
2020-01-26T05:43:42.4014352Z Modified db pages 0
|
2020-01-26T05:43:42.4014643Z Percent of dirty pages(LRU & free pages): 0.000
|
2020-01-26T05:43:42.4014882Z Max dirty pages percent: 75.000
|
2020-01-26T05:43:42.4015119Z Pending reads 0
|
2020-01-26T05:43:42.4015328Z Pending writes: LRU 0, flush list 0, single page 0
|
2020-01-26T05:43:42.4015572Z Pages made young 0, not young 0
|
2020-01-26T05:43:42.4016052Z 0.00 youngs/s, 0.00 non-youngs/s
|
2020-01-26T05:43:42.4017105Z Pages read 175, created 257, written 533
|
2020-01-26T05:43:42.4017383Z 0.00 reads/s, 0.00 creates/s, 0.00 writes/s
|
2020-01-26T05:43:42.4017612Z No buffer pool page gets since the last printout
|
2020-01-26T05:43:42.4018005Z Pages read ahead 0.00/s, evicted without access 0.00/s, Random read ahead 0.00/s
|
2020-01-26T05:43:42.4018260Z LRU len: 332, unzip_LRU len: 0
|
2020-01-26T05:43:42.4020528Z I/O sum[0]:cur[0], unzip sum[0]:cur[0]
|
2020-01-26T05:43:42.4021406Z --------------
|
2020-01-26T05:43:42.4026111Z ROW OPERATIONS
|
2020-01-26T05:43:42.4027641Z --------------
|
2020-01-26T05:43:42.4027919Z 0 queries inside InnoDB, 0 queries in queue
|
2020-01-26T05:43:42.4028166Z 0 read views open inside InnoDB
|
2020-01-26T05:43:42.4028400Z Process ID=21148, Main thread ID=140059445536512, state: sleeping
|
2020-01-26T05:43:42.4028672Z Number of rows inserted 2, updated 307, deleted 0, read 478
|
2020-01-26T05:43:42.4028929Z 0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 0.00 reads/s
|
2020-01-26T05:43:42.4029181Z Number of system rows inserted 0, updated 0, deleted 0, read 0
|
2020-01-26T05:43:42.4029431Z 0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 0.00 reads/s
|
2020-01-26T05:43:42.4029851Z ----------------------------
|
2020-01-26T05:43:42.4030106Z END OF INNODB MONITOR OUTPUT
|
2020-01-26T05:43:42.4030333Z ============================
|
2020-01-26T05:43:42.4030576Z InnoDB: ###### Diagnostic info printed to the standard error stream
|
2020-01-26T05:43:42.4031054Z 2020-01-26 5:42:08 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4031601Z --Thread 140059959392000 has waited at lock0lock.cc line 6267 for 861.00 seconds the semaphore:
|
2020-01-26T05:43:42.4031896Z Mutex at 0x56540909d940, Mutex LOCK_SYS created lock0lock.cc:460, lock var 2
|
2020-01-26T05:43:42.4032113Z
|
2020-01-26T05:43:42.4033255Z 2020-01-26 5:42:08 0 [Note] InnoDB: A semaphore wait:
|
2020-01-26T05:43:42.4033822Z --Thread 140059959392000 has waited at lock0lock.cc line 6267 for 861.00 seconds the semaphore:
|
2020-01-26T05:43:42.4034246Z Mutex at 0x56540909d940, Mutex LOCK_SYS created lock0lock.cc:460, lock var 2
|
2020-01-26T05:43:42.4034401Z
|
2020-01-26T05:43:42.4034559Z InnoDB: ###### Starts InnoDB Monitor for 30 secs to print diagnostic info:
|
2020-01-26T05:43:42.4034735Z InnoDB: Pending reads 0, writes 0
|
2020-01-26T05:43:42.4034856Z
|
2020-01-26T05:43:42.4035540Z =====================================
|
2020-01-26T05:43:42.4036034Z 2020-01-26 05:42:20 0x7f621b7fe700 INNODB MONITOR OUTPUT
|
2020-01-26T05:43:42.4036214Z =====================================
|
2020-01-26T05:43:42.4036818Z Per second averages calculated from the last 20 seconds
|
2020-01-26T05:43:42.4037150Z -----------------
|
2020-01-26T05:43:42.4037307Z BACKGROUND THREAD
|
2020-01-26T05:43:42.4039676Z -----------------
|
2020-01-26T05:43:42.4039881Z srv_master_thread loops: 2 srv_active, 0 srv_shutdown, 877 srv_idle
|
2020-01-26T05:43:42.4040052Z srv_master_thread log flush and writes: 879
|
2020-01-26T05:43:42.4040372Z ----------
|
2020-01-26T05:43:42.4040527Z SEMAPHORES
|
2020-01-26T05:43:42.4040822Z ----------
|
2020-01-26T05:43:42.4040961Z OS WAIT ARRAY INFO: reservation count 363
|
2020-01-26T05:43:42.4041395Z --Thread 140059959392000 has waited at lock0lock.cc line 6267 for 873.00 seconds the semaphore:
|
2020-01-26T05:43:42.4041617Z Mutex at 0x56540909d940, Mutex LOCK_SYS created lock0lock.cc:460, lock var 2
|
2020-01-26T05:43:42.4041756Z
|
2020-01-26T05:43:42.4041880Z OS WAIT ARRAY INFO: signal count 198
|
2020-01-26T05:43:42.4042238Z RW-shared spins 0, rounds 38, OS waits 14
|
2020-01-26T05:43:42.4042597Z RW-excl spins 0, rounds 11, OS waits 0
|
2020-01-26T05:43:42.4042945Z RW-sx spins 0, rounds 0, OS waits 0
|
2020-01-26T05:43:42.4043321Z Spin rounds per wait: 38.00 RW-shared, 11.00 RW-excl, 0.00 RW-sx
|
2020-01-26T05:43:42.4043506Z FAIL TO OBTAIN LOCK MUTEX, SKIP LOCK INFO PRINTING
|
2020-01-26T05:43:42.4043827Z --------
|
2020-01-26T05:43:42.4043977Z FILE I/O
|
2020-01-26T05:43:42.4044265Z --------
|
2020-01-26T05:43:42.4044420Z I/O thread 0 state: waiting for completed aio requests (insert buffer thread)
|
2020-01-26T05:43:42.4044601Z I/O thread 1 state: waiting for completed aio requests (log thread)
|
2020-01-26T05:43:42.4044783Z I/O thread 2 state: waiting for completed aio requests (read thread)
|
2020-01-26T05:43:42.4045090Z I/O thread 3 state: waiting for completed aio requests (read thread)
|
2020-01-26T05:43:42.4045271Z I/O thread 4 state: waiting for completed aio requests (write thread)
|
2020-01-26T05:43:42.4045436Z I/O thread 5 state: waiting for completed aio requests (write thread)
|
2020-01-26T05:43:42.4045612Z Pending normal aio reads: [0, 0] , aio writes: [0, 0] ,
|
2020-01-26T05:43:42.4045973Z ibuf aio reads:, log i/o's:, sync i/o's:
|
2020-01-26T05:43:42.4046147Z Pending flushes (fsync) log: 0; buffer pool: 0
|
2020-01-26T05:43:42.4046840Z 190 OS file reads, 863 OS file writes, 336 OS fsyncs
|
2020-01-26T05:43:42.4047030Z 0.00 reads/s, 0 avg bytes/read, 0.00 writes/s, 0.00 fsyncs/s
|
2020-01-26T05:43:42.4047396Z -------------------------------------
|
2020-01-26T05:43:42.4047564Z INSERT BUFFER AND ADAPTIVE HASH INDEX
|
2020-01-26T05:43:42.4047896Z -------------------------------------
|
2020-01-26T05:43:42.4048049Z Ibuf: size 1, free list len 0, seg size 2, 0 merges
|
2020-01-26T05:43:42.4048205Z merged operations:
|
2020-01-26T05:43:42.4048356Z insert 0, delete mark 0, delete 0
|
2020-01-26T05:43:42.4048506Z discarded operations:
|
2020-01-26T05:43:42.4048635Z insert 0, delete mark 0, delete 0
|
2020-01-26T05:43:42.4048789Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4048950Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4049106Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4049263Z Hash table size 2267, node heap has 1 buffer(s)
|
2020-01-26T05:43:42.4049402Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4049558Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4049939Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4050109Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4050489Z 0.00 hash searches/s, 0.00 non-hash searches/s
|
2020-01-26T05:43:42.4050787Z ---
|
2020-01-26T05:43:42.4050936Z LOG
|
2020-01-26T05:43:42.4051218Z ---
|
2020-01-26T05:43:42.4051367Z Log sequence number 1900754
|
2020-01-26T05:43:42.4051510Z Log flushed up to 1900754
|
2020-01-26T05:43:42.4051657Z Pages flushed up to 1900754
|
2020-01-26T05:43:42.4051816Z Last checkpoint at 1900745
|
2020-01-26T05:43:42.4051967Z 0 pending log flushes, 0 pending chkp writes
|
2020-01-26T05:43:42.4052302Z 325 log i/o's done, 0.00 log i/o's/second
|
2020-01-26T05:43:42.4052636Z ----------------------
|
2020-01-26T05:43:42.4052795Z BUFFER POOL AND MEMORY
|
2020-01-26T05:43:42.4053104Z ----------------------
|
2020-01-26T05:43:42.4053248Z Total large memory allocated 10682368
|
2020-01-26T05:43:42.4053403Z Dictionary memory allocated 29376
|
2020-01-26T05:43:42.4053563Z Buffer pool size 512
|
2020-01-26T05:43:42.4053706Z Free buffers 179
|
2020-01-26T05:43:42.4053832Z Database pages 332
|
2020-01-26T05:43:42.4053972Z Old database pages 0
|
2020-01-26T05:43:42.4054115Z Modified db pages 0
|
2020-01-26T05:43:42.4054263Z Percent of dirty pages(LRU & free pages): 0.000
|
2020-01-26T05:43:42.4054419Z Max dirty pages percent: 75.000
|
2020-01-26T05:43:42.4054551Z Pending reads 0
|
2020-01-26T05:43:42.4054705Z Pending writes: LRU 0, flush list 0, single page 0
|
2020-01-26T05:43:42.4054866Z Pages made young 0, not young 0
|
2020-01-26T05:43:42.4055200Z 0.00 youngs/s, 0.00 non-youngs/s
|
2020-01-26T05:43:42.4055352Z Pages read 175, created 257, written 533
|
2020-01-26T05:43:42.4055510Z 0.00 reads/s, 0.00 creates/s, 0.00 writes/s
|
2020-01-26T05:43:42.4055671Z No buffer pool page gets since the last printout
|
2020-01-26T05:43:42.4055850Z Pages read ahead 0.00/s, evicted without access 0.00/s, Random read ahead 0.00/s
|
2020-01-26T05:43:42.4056028Z LRU len: 332, unzip_LRU len: 0
|
2020-01-26T05:43:42.4056170Z I/O sum[0]:cur[0], unzip sum[0]:cur[0]
|
2020-01-26T05:43:42.4056882Z --------------
|
2020-01-26T05:43:42.4057053Z ROW OPERATIONS
|
2020-01-26T05:43:42.4057349Z --------------
|
2020-01-26T05:43:42.4057490Z 0 queries inside InnoDB, 0 queries in queue
|
2020-01-26T05:43:42.4057646Z 0 read views open inside InnoDB
|
2020-01-26T05:43:42.4057811Z Process ID=21148, Main thread ID=140059445536512, state: sleeping
|
2020-01-26T05:43:42.4058075Z Number of rows inserted 2, updated 307, deleted 0, read 478
|
2020-01-26T05:43:42.4058233Z 0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 0.00 reads/s
|
2020-01-26T05:43:42.4058408Z Number of system rows inserted 0, updated 0, deleted 0, read 0
|
2020-01-26T05:43:42.4058581Z 0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 0.00 reads/s
|
2020-01-26T05:43:42.4058934Z ----------------------------
|
2020-01-26T05:43:42.4059094Z END OF INNODB MONITOR OUTPUT
|
2020-01-26T05:43:42.4059225Z ============================
|
2020-01-26T05:43:42.4059390Z InnoDB: ###### Diagnostic info printed to the standard error stream
|
2020-01-26T05:43:42.4059789Z 2020-01-26 5:42:39 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4060237Z --Thread 140059959392000 has waited at lock0lock.cc line 6267 for 892.00 seconds the semaphore:
|
2020-01-26T05:43:42.4060447Z Mutex at 0x56540909d940, Mutex LOCK_SYS created lock0lock.cc:460, lock var 2
|
2020-01-26T05:43:42.4060567Z
|
2020-01-26T05:43:42.4060932Z 2020-01-26 5:42:39 0 [Note] InnoDB: A semaphore wait:
|
2020-01-26T05:43:42.4061372Z --Thread 140059959392000 has waited at lock0lock.cc line 6267 for 892.00 seconds the semaphore:
|
2020-01-26T05:43:42.4061580Z Mutex at 0x56540909d940, Mutex LOCK_SYS created lock0lock.cc:460, lock var 2
|
2020-01-26T05:43:42.4061699Z
|
2020-01-26T05:43:42.4061850Z InnoDB: ###### Starts InnoDB Monitor for 30 secs to print diagnostic info:
|
2020-01-26T05:43:42.4062016Z InnoDB: Pending reads 0, writes 0
|
2020-01-26T05:43:42.4062114Z
|
2020-01-26T05:43:42.4062247Z =====================================
|
2020-01-26T05:43:42.4062701Z 2020-01-26 05:42:40 0x7f621b7fe700 INNODB MONITOR OUTPUT
|
2020-01-26T05:43:42.4062867Z =====================================
|
2020-01-26T05:43:42.4063030Z Per second averages calculated from the last 20 seconds
|
2020-01-26T05:43:42.4063352Z -----------------
|
2020-01-26T05:43:42.4063506Z BACKGROUND THREAD
|
2020-01-26T05:43:42.4063792Z -----------------
|
2020-01-26T05:43:42.4063960Z srv_master_thread loops: 2 srv_active, 0 srv_shutdown, 897 srv_idle
|
2020-01-26T05:43:42.4064138Z srv_master_thread log flush and writes: 899
|
2020-01-26T05:43:42.4064444Z ----------
|
2020-01-26T05:43:42.4064594Z SEMAPHORES
|
2020-01-26T05:43:42.4064869Z ----------
|
2020-01-26T05:43:42.4065020Z OS WAIT ARRAY INFO: reservation count 363
|
2020-01-26T05:43:42.4065475Z --Thread 140059959392000 has waited at lock0lock.cc line 6267 for 893.00 seconds the semaphore:
|
2020-01-26T05:43:42.4065689Z Mutex at 0x56540909d940, Mutex LOCK_SYS created lock0lock.cc:460, lock var 2
|
2020-01-26T05:43:42.4065806Z
|
2020-01-26T05:43:42.4065941Z OS WAIT ARRAY INFO: signal count 198
|
2020-01-26T05:43:42.4066878Z RW-shared spins 0, rounds 38, OS waits 14
|
2020-01-26T05:43:42.4067240Z RW-excl spins 0, rounds 11, OS waits 0
|
2020-01-26T05:43:42.4067588Z RW-sx spins 0, rounds 0, OS waits 0
|
2020-01-26T05:43:42.4067974Z Spin rounds per wait: 38.00 RW-shared, 11.00 RW-excl, 0.00 RW-sx
|
2020-01-26T05:43:42.4068160Z FAIL TO OBTAIN LOCK MUTEX, SKIP LOCK INFO PRINTING
|
2020-01-26T05:43:42.4068478Z --------
|
2020-01-26T05:43:42.4068611Z FILE I/O
|
2020-01-26T05:43:42.4068903Z --------
|
2020-01-26T05:43:42.4069072Z I/O thread 0 state: waiting for completed aio requests (insert buffer thread)
|
2020-01-26T05:43:42.4069259Z I/O thread 1 state: waiting for completed aio requests (log thread)
|
2020-01-26T05:43:42.4069420Z I/O thread 2 state: waiting for completed aio requests (read thread)
|
2020-01-26T05:43:42.4069597Z I/O thread 3 state: waiting for completed aio requests (read thread)
|
2020-01-26T05:43:42.4069774Z I/O thread 4 state: waiting for completed aio requests (write thread)
|
2020-01-26T05:43:42.4069959Z I/O thread 5 state: waiting for completed aio requests (write thread)
|
2020-01-26T05:43:42.4070131Z Pending normal aio reads: [0, 0] , aio writes: [0, 0] ,
|
2020-01-26T05:43:42.4070465Z ibuf aio reads:, log i/o's:, sync i/o's:
|
2020-01-26T05:43:42.4070633Z Pending flushes (fsync) log: 0; buffer pool: 0
|
2020-01-26T05:43:42.4070796Z 190 OS file reads, 863 OS file writes, 336 OS fsyncs
|
2020-01-26T05:43:42.4071035Z 0.00 reads/s, 0 avg bytes/read, 0.00 writes/s, 0.00 fsyncs/s
|
2020-01-26T05:43:42.4071388Z -------------------------------------
|
2020-01-26T05:43:42.4071538Z INSERT BUFFER AND ADAPTIVE HASH INDEX
|
2020-01-26T05:43:42.4071866Z -------------------------------------
|
2020-01-26T05:43:42.4072032Z Ibuf: size 1, free list len 0, seg size 2, 0 merges
|
2020-01-26T05:43:42.4072187Z merged operations:
|
2020-01-26T05:43:42.4072313Z insert 0, delete mark 0, delete 0
|
2020-01-26T05:43:42.4072461Z discarded operations:
|
2020-01-26T05:43:42.4072604Z insert 0, delete mark 0, delete 0
|
2020-01-26T05:43:42.4072762Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4072921Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4073064Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4073219Z Hash table size 2267, node heap has 1 buffer(s)
|
2020-01-26T05:43:42.4073376Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4073533Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4073695Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4073834Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4074187Z 0.00 hash searches/s, 0.00 non-hash searches/s
|
2020-01-26T05:43:42.4074510Z ---
|
2020-01-26T05:43:42.4074657Z LOG
|
2020-01-26T05:43:42.4074922Z ---
|
2020-01-26T05:43:42.4075067Z Log sequence number 1900754
|
2020-01-26T05:43:42.4075215Z Log flushed up to 1900754
|
2020-01-26T05:43:42.4075359Z Pages flushed up to 1900754
|
2020-01-26T05:43:42.4075484Z Last checkpoint at 1900745
|
2020-01-26T05:43:42.4075692Z 0 pending log flushes, 0 pending chkp writes
|
2020-01-26T05:43:42.4076047Z 325 log i/o's done, 0.00 log i/o's/second
|
2020-01-26T05:43:42.4076697Z ----------------------
|
2020-01-26T05:43:42.4076849Z BUFFER POOL AND MEMORY
|
2020-01-26T05:43:42.4077159Z ----------------------
|
2020-01-26T05:43:42.4077319Z Total large memory allocated 10682368
|
2020-01-26T05:43:42.4077472Z Dictionary memory allocated 29376
|
2020-01-26T05:43:42.4077629Z Buffer pool size 512
|
2020-01-26T05:43:42.4077752Z Free buffers 179
|
2020-01-26T05:43:42.4077892Z Database pages 332
|
2020-01-26T05:43:42.4078033Z Old database pages 0
|
2020-01-26T05:43:42.4078173Z Modified db pages 0
|
2020-01-26T05:43:42.4078303Z Percent of dirty pages(LRU & free pages): 0.000
|
2020-01-26T05:43:42.4078462Z Max dirty pages percent: 75.000
|
2020-01-26T05:43:42.4078609Z Pending reads 0
|
2020-01-26T05:43:42.4078760Z Pending writes: LRU 0, flush list 0, single page 0
|
2020-01-26T05:43:42.4078903Z Pages made young 0, not young 0
|
2020-01-26T05:43:42.4079234Z 0.00 youngs/s, 0.00 non-youngs/s
|
2020-01-26T05:43:42.4079408Z Pages read 175, created 257, written 533
|
2020-01-26T05:43:42.4079562Z 0.00 reads/s, 0.00 creates/s, 0.00 writes/s
|
2020-01-26T05:43:42.4079720Z No buffer pool page gets since the last printout
|
2020-01-26T05:43:42.4079879Z Pages read ahead 0.00/s, evicted without access 0.00/s, Random read ahead 0.00/s
|
2020-01-26T05:43:42.4080049Z LRU len: 332, unzip_LRU len: 0
|
2020-01-26T05:43:42.4080204Z I/O sum[0]:cur[0], unzip sum[0]:cur[0]
|
2020-01-26T05:43:42.4080512Z --------------
|
2020-01-26T05:43:42.4080651Z ROW OPERATIONS
|
2020-01-26T05:43:42.4080947Z --------------
|
2020-01-26T05:43:42.4081103Z 0 queries inside InnoDB, 0 queries in queue
|
2020-01-26T05:43:42.4081257Z 0 read views open inside InnoDB
|
2020-01-26T05:43:42.4081403Z Process ID=21148, Main thread ID=140059445536512, state: sleeping
|
2020-01-26T05:43:42.4081578Z Number of rows inserted 2, updated 307, deleted 0, read 478
|
2020-01-26T05:43:42.4081747Z 0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 0.00 reads/s
|
2020-01-26T05:43:42.4081926Z Number of system rows inserted 0, updated 0, deleted 0, read 0
|
2020-01-26T05:43:42.4082097Z 0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 0.00 reads/s
|
2020-01-26T05:43:42.4082418Z ----------------------------
|
2020-01-26T05:43:42.4082576Z END OF INNODB MONITOR OUTPUT
|
2020-01-26T05:43:42.4082721Z ============================
|
2020-01-26T05:43:42.4082817Z
|
2020-01-26T05:43:42.4082951Z =====================================
|
2020-01-26T05:43:42.4083406Z 2020-01-26 05:43:00 0x7f621b7fe700 INNODB MONITOR OUTPUT
|
2020-01-26T05:43:42.4083579Z =====================================
|
2020-01-26T05:43:42.4083745Z Per second averages calculated from the last 20 seconds
|
2020-01-26T05:43:42.4084053Z -----------------
|
2020-01-26T05:43:42.4084207Z BACKGROUND THREAD
|
2020-01-26T05:43:42.4084508Z -----------------
|
2020-01-26T05:43:42.4084678Z srv_master_thread loops: 2 srv_active, 0 srv_shutdown, 917 srv_idle
|
2020-01-26T05:43:42.4084833Z srv_master_thread log flush and writes: 919
|
2020-01-26T05:43:42.4085148Z ----------
|
2020-01-26T05:43:42.4085299Z SEMAPHORES
|
2020-01-26T05:43:42.4085591Z ----------
|
2020-01-26T05:43:42.4085726Z OS WAIT ARRAY INFO: reservation count 363
|
2020-01-26T05:43:42.4086162Z --Thread 140059959392000 has waited at lock0lock.cc line 6267 for 913.00 seconds the semaphore:
|
2020-01-26T05:43:42.4087203Z Mutex at 0x56540909d940, Mutex LOCK_SYS created lock0lock.cc:460, lock var 2
|
2020-01-26T05:43:42.4087356Z
|
2020-01-26T05:43:42.4087478Z OS WAIT ARRAY INFO: signal count 198
|
2020-01-26T05:43:42.4087834Z RW-shared spins 0, rounds 38, OS waits 14
|
2020-01-26T05:43:42.4088184Z RW-excl spins 0, rounds 11, OS waits 0
|
2020-01-26T05:43:42.4088528Z RW-sx spins 0, rounds 0, OS waits 0
|
2020-01-26T05:43:42.4088901Z Spin rounds per wait: 38.00 RW-shared, 11.00 RW-excl, 0.00 RW-sx
|
2020-01-26T05:43:42.4089083Z FAIL TO OBTAIN LOCK MUTEX, SKIP LOCK INFO PRINTING
|
2020-01-26T05:43:42.4089396Z --------
|
2020-01-26T05:43:42.4089547Z FILE I/O
|
2020-01-26T05:43:42.4098139Z --------
|
2020-01-26T05:43:42.4098698Z I/O thread 0 state: waiting for completed aio requests (insert buffer thread)
|
2020-01-26T05:43:42.4098955Z I/O thread 1 state: waiting for completed aio requests (log thread)
|
2020-01-26T05:43:42.4099649Z I/O thread 2 state: waiting for completed aio requests (read thread)
|
2020-01-26T05:43:42.4100004Z I/O thread 3 state: waiting for completed aio requests (read thread)
|
2020-01-26T05:43:42.4100169Z I/O thread 4 state: waiting for completed aio requests (write thread)
|
2020-01-26T05:43:42.4100359Z I/O thread 5 state: waiting for completed aio requests (write thread)
|
2020-01-26T05:43:42.4100532Z Pending normal aio reads: [0, 0] , aio writes: [0, 0] ,
|
2020-01-26T05:43:42.4101070Z ibuf aio reads:, log i/o's:, sync i/o's:
|
2020-01-26T05:43:42.4101250Z Pending flushes (fsync) log: 0; buffer pool: 0
|
2020-01-26T05:43:42.4101458Z 190 OS file reads, 863 OS file writes, 336 OS fsyncs
|
2020-01-26T05:43:42.4101794Z 0.00 reads/s, 0 avg bytes/read, 0.00 writes/s, 0.00 fsyncs/s
|
2020-01-26T05:43:42.4102240Z -------------------------------------
|
2020-01-26T05:43:42.4102474Z INSERT BUFFER AND ADAPTIVE HASH INDEX
|
2020-01-26T05:43:42.4102871Z -------------------------------------
|
2020-01-26T05:43:42.4103078Z Ibuf: size 1, free list len 0, seg size 2, 0 merges
|
2020-01-26T05:43:42.4110320Z merged operations:
|
2020-01-26T05:43:42.4110711Z insert 0, delete mark 0, delete 0
|
2020-01-26T05:43:42.4110927Z discarded operations:
|
2020-01-26T05:43:42.4111107Z insert 0, delete mark 0, delete 0
|
2020-01-26T05:43:42.4111325Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4111540Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4111751Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4111962Z Hash table size 2267, node heap has 1 buffer(s)
|
2020-01-26T05:43:42.4112160Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4112368Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4112576Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4112794Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4113976Z 0.00 hash searches/s, 0.00 non-hash searches/s
|
2020-01-26T05:43:42.4120875Z ---
|
2020-01-26T05:43:42.4121288Z LOG
|
2020-01-26T05:43:42.4121666Z ---
|
2020-01-26T05:43:42.4121853Z Log sequence number 1900754
|
2020-01-26T05:43:42.4122060Z Log flushed up to 1900754
|
2020-01-26T05:43:42.4122257Z Pages flushed up to 1900754
|
2020-01-26T05:43:42.4122450Z Last checkpoint at 1900745
|
2020-01-26T05:43:42.4122771Z 0 pending log flushes, 0 pending chkp writes
|
2020-01-26T05:43:42.4123189Z 325 log i/o's done, 0.00 log i/o's/second
|
2020-01-26T05:43:42.4123590Z ----------------------
|
2020-01-26T05:43:42.4123807Z BUFFER POOL AND MEMORY
|
2020-01-26T05:43:42.4124175Z ----------------------
|
2020-01-26T05:43:42.4124372Z Total large memory allocated 10682368
|
2020-01-26T05:43:42.4124575Z Dictionary memory allocated 29376
|
2020-01-26T05:43:42.4124776Z Buffer pool size 512
|
2020-01-26T05:43:42.4124969Z Free buffers 179
|
2020-01-26T05:43:42.4125143Z Database pages 332
|
2020-01-26T05:43:42.4125341Z Old database pages 0
|
2020-01-26T05:43:42.4125533Z Modified db pages 0
|
2020-01-26T05:43:42.4125729Z Percent of dirty pages(LRU & free pages): 0.000
|
2020-01-26T05:43:42.4125937Z Max dirty pages percent: 75.000
|
2020-01-26T05:43:42.4126755Z Pending reads 0
|
2020-01-26T05:43:42.4127005Z Pending writes: LRU 0, flush list 0, single page 0
|
2020-01-26T05:43:42.4127217Z Pages made young 0, not young 0
|
2020-01-26T05:43:42.4130917Z 0.00 youngs/s, 0.00 non-youngs/s
|
2020-01-26T05:43:42.4131186Z Pages read 175, created 257, written 533
|
2020-01-26T05:43:42.4131355Z 0.00 reads/s, 0.00 creates/s, 0.00 writes/s
|
2020-01-26T05:43:42.4131519Z No buffer pool page gets since the last printout
|
2020-01-26T05:43:42.4131757Z Pages read ahead 0.00/s, evicted without access 0.00/s, Random read ahead 0.00/s
|
2020-01-26T05:43:42.4131986Z LRU len: 332, unzip_LRU len: 0
|
2020-01-26T05:43:42.4132173Z I/O sum[0]:cur[0], unzip sum[0]:cur[0]
|
2020-01-26T05:43:42.4132560Z --------------
|
2020-01-26T05:43:42.4132898Z ROW OPERATIONS
|
2020-01-26T05:43:42.4133269Z --------------
|
2020-01-26T05:43:42.4133465Z 0 queries inside InnoDB, 0 queries in queue
|
2020-01-26T05:43:42.4133670Z 0 read views open inside InnoDB
|
2020-01-26T05:43:42.4133883Z Process ID=21148, Main thread ID=140059445536512, state: sleeping
|
2020-01-26T05:43:42.4134112Z Number of rows inserted 2, updated 307, deleted 0, read 478
|
2020-01-26T05:43:42.4134320Z 0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 0.00 reads/s
|
2020-01-26T05:43:42.4134550Z Number of system rows inserted 0, updated 0, deleted 0, read 0
|
2020-01-26T05:43:42.4134775Z 0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 0.00 reads/s
|
2020-01-26T05:43:42.4135175Z ----------------------------
|
2020-01-26T05:43:42.4135390Z END OF INNODB MONITOR OUTPUT
|
2020-01-26T05:43:42.4135570Z ============================
|
2020-01-26T05:43:42.4135785Z InnoDB: ###### Diagnostic info printed to the standard error stream
|
2020-01-26T05:43:42.4136235Z 2020-01-26 5:43:10 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4136821Z --Thread 140059959392000 has waited at lock0lock.cc line 6267 for 923.00 seconds the semaphore:
|
2020-01-26T05:43:42.4137090Z Mutex at 0x56540909d940, Mutex LOCK_SYS created lock0lock.cc:460, lock var 2
|
2020-01-26T05:43:42.4137216Z
|
2020-01-26T05:43:42.4137576Z 2020-01-26 5:43:10 0 [Note] InnoDB: A semaphore wait:
|
2020-01-26T05:43:42.4138075Z --Thread 140059959392000 has waited at lock0lock.cc line 6267 for 923.00 seconds the semaphore:
|
2020-01-26T05:43:42.4138329Z Mutex at 0x56540909d940, Mutex LOCK_SYS created lock0lock.cc:460, lock var 2
|
2020-01-26T05:43:42.4138516Z
|
2020-01-26T05:43:42.4138718Z InnoDB: ###### Starts InnoDB Monitor for 30 secs to print diagnostic info:
|
2020-01-26T05:43:42.4138934Z InnoDB: Pending reads 0, writes 0
|
2020-01-26T05:43:42.4139084Z
|
2020-01-26T05:43:42.4139267Z =====================================
|
2020-01-26T05:43:42.4139700Z 2020-01-26 05:43:20 0x7f621b7fe700 INNODB MONITOR OUTPUT
|
2020-01-26T05:43:42.4139913Z =====================================
|
2020-01-26T05:43:42.4140140Z Per second averages calculated from the last 20 seconds
|
2020-01-26T05:43:42.4140518Z -----------------
|
2020-01-26T05:43:42.4140730Z BACKGROUND THREAD
|
2020-01-26T05:43:42.4141041Z -----------------
|
2020-01-26T05:43:42.4141212Z srv_master_thread loops: 2 srv_active, 0 srv_shutdown, 937 srv_idle
|
2020-01-26T05:43:42.4141384Z srv_master_thread log flush and writes: 939
|
2020-01-26T05:43:42.4141698Z ----------
|
2020-01-26T05:43:42.4141928Z SEMAPHORES
|
2020-01-26T05:43:42.4142213Z ----------
|
2020-01-26T05:43:42.4142362Z OS WAIT ARRAY INFO: reservation count 363
|
2020-01-26T05:43:42.4142785Z --Thread 140059959392000 has waited at lock0lock.cc line 6267 for 933.00 seconds the semaphore:
|
2020-01-26T05:43:42.4142994Z Mutex at 0x56540909d940, Mutex LOCK_SYS created lock0lock.cc:460, lock var 2
|
2020-01-26T05:43:42.4143115Z
|
2020-01-26T05:43:42.4143252Z OS WAIT ARRAY INFO: signal count 198
|
2020-01-26T05:43:42.4143600Z RW-shared spins 0, rounds 38, OS waits 14
|
2020-01-26T05:43:42.4143936Z RW-excl spins 0, rounds 11, OS waits 0
|
2020-01-26T05:43:42.4144289Z RW-sx spins 0, rounds 0, OS waits 0
|
2020-01-26T05:43:42.4144675Z Spin rounds per wait: 38.00 RW-shared, 11.00 RW-excl, 0.00 RW-sx
|
2020-01-26T05:43:42.4144859Z FAIL TO OBTAIN LOCK MUTEX, SKIP LOCK INFO PRINTING
|
2020-01-26T05:43:42.4145168Z --------
|
2020-01-26T05:43:42.4145301Z FILE I/O
|
2020-01-26T05:43:42.4145589Z --------
|
2020-01-26T05:43:42.4145758Z I/O thread 0 state: waiting for completed aio requests (insert buffer thread)
|
2020-01-26T05:43:42.4145947Z I/O thread 1 state: waiting for completed aio requests (log thread)
|
2020-01-26T05:43:42.4146109Z I/O thread 2 state: waiting for completed aio requests (read thread)
|
2020-01-26T05:43:42.4146378Z I/O thread 3 state: waiting for completed aio requests (read thread)
|
2020-01-26T05:43:42.4146561Z I/O thread 4 state: waiting for completed aio requests (write thread)
|
2020-01-26T05:43:42.4146739Z I/O thread 5 state: waiting for completed aio requests (write thread)
|
2020-01-26T05:43:42.4146910Z Pending normal aio reads: [0, 0] , aio writes: [0, 0] ,
|
2020-01-26T05:43:42.4147315Z ibuf aio reads:, log i/o's:, sync i/o's:
|
2020-01-26T05:43:42.4147486Z Pending flushes (fsync) log: 0; buffer pool: 0
|
2020-01-26T05:43:42.4147645Z 190 OS file reads, 863 OS file writes, 336 OS fsyncs
|
2020-01-26T05:43:42.4147816Z 0.00 reads/s, 0 avg bytes/read, 0.00 writes/s, 0.00 fsyncs/s
|
2020-01-26T05:43:42.4148163Z -------------------------------------
|
2020-01-26T05:43:42.4148319Z INSERT BUFFER AND ADAPTIVE HASH INDEX
|
2020-01-26T05:43:42.4148652Z -------------------------------------
|
2020-01-26T05:43:42.4148821Z Ibuf: size 1, free list len 0, seg size 2, 0 merges
|
2020-01-26T05:43:42.4148974Z merged operations:
|
2020-01-26T05:43:42.4149102Z insert 0, delete mark 0, delete 0
|
2020-01-26T05:43:42.4149249Z discarded operations:
|
2020-01-26T05:43:42.4149394Z insert 0, delete mark 0, delete 0
|
2020-01-26T05:43:42.4149550Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4149711Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4149862Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4150023Z Hash table size 2267, node heap has 1 buffer(s)
|
2020-01-26T05:43:42.4150181Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4150337Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4150478Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4150634Z Hash table size 2267, node heap has 0 buffer(s)
|
2020-01-26T05:43:42.4151000Z 0.00 hash searches/s, 0.00 non-hash searches/s
|
2020-01-26T05:43:42.4151314Z ---
|
2020-01-26T05:43:42.4151460Z LOG
|
2020-01-26T05:43:42.4151725Z ---
|
2020-01-26T05:43:42.4151870Z Log sequence number 1900754
|
2020-01-26T05:43:42.4152017Z Log flushed up to 1900754
|
2020-01-26T05:43:42.4152174Z Pages flushed up to 1900754
|
2020-01-26T05:43:42.4152301Z Last checkpoint at 1900745
|
2020-01-26T05:43:42.4152454Z 0 pending log flushes, 0 pending chkp writes
|
2020-01-26T05:43:42.4152799Z 325 log i/o's done, 0.00 log i/o's/second
|
2020-01-26T05:43:42.4153135Z ----------------------
|
2020-01-26T05:43:42.4153276Z BUFFER POOL AND MEMORY
|
2020-01-26T05:43:42.4153582Z ----------------------
|
2020-01-26T05:43:42.4153737Z Total large memory allocated 10682368
|
2020-01-26T05:43:42.4153890Z Dictionary memory allocated 29376
|
2020-01-26T05:43:42.4154022Z Buffer pool size 512
|
2020-01-26T05:43:42.4154163Z Free buffers 179
|
2020-01-26T05:43:42.4154302Z Database pages 332
|
2020-01-26T05:43:42.4154550Z Old database pages 0
|
2020-01-26T05:43:42.4154693Z Modified db pages 0
|
2020-01-26T05:43:42.4154823Z Percent of dirty pages(LRU & free pages): 0.000
|
2020-01-26T05:43:42.4154978Z Max dirty pages percent: 75.000
|
2020-01-26T05:43:42.4155125Z Pending reads 0
|
2020-01-26T05:43:42.4155274Z Pending writes: LRU 0, flush list 0, single page 0
|
2020-01-26T05:43:42.4155415Z Pages made young 0, not young 0
|
2020-01-26T05:43:42.4155760Z 0.00 youngs/s, 0.00 non-youngs/s
|
2020-01-26T05:43:42.4155923Z Pages read 175, created 257, written 533
|
2020-01-26T05:43:42.4156080Z 0.00 reads/s, 0.00 creates/s, 0.00 writes/s
|
2020-01-26T05:43:42.4156232Z No buffer pool page gets since the last printout
|
2020-01-26T05:43:42.4157110Z Pages read ahead 0.00/s, evicted without access 0.00/s, Random read ahead 0.00/s
|
2020-01-26T05:43:42.4157692Z LRU len: 332, unzip_LRU len: 0
|
2020-01-26T05:43:42.4157905Z I/O sum[0]:cur[0], unzip sum[0]:cur[0]
|
2020-01-26T05:43:42.4158569Z --------------
|
2020-01-26T05:43:42.4158736Z ROW OPERATIONS
|
2020-01-26T05:43:42.4159107Z --------------
|
2020-01-26T05:43:42.4159289Z 0 queries inside InnoDB, 0 queries in queue
|
2020-01-26T05:43:42.4159466Z 0 read views open inside InnoDB
|
2020-01-26T05:43:42.4159637Z Process ID=21148, Main thread ID=140059445536512, state: sleeping
|
2020-01-26T05:43:42.4159842Z Number of rows inserted 2, updated 307, deleted 0, read 478
|
2020-01-26T05:43:42.4160037Z 0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 0.00 reads/s
|
2020-01-26T05:43:42.4160232Z Number of system rows inserted 0, updated 0, deleted 0, read 0
|
2020-01-26T05:43:42.4160426Z 0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 0.00 reads/s
|
2020-01-26T05:43:42.4160994Z ----------------------------
|
2020-01-26T05:43:42.4161178Z END OF INNODB MONITOR OUTPUT
|
2020-01-26T05:43:42.4161342Z ============================
|
2020-01-26T05:43:42.4161529Z InnoDB: ###### Diagnostic info printed to the standard error stream
|
2020-01-26T05:43:42.4162178Z 2020-01-26 5:43:40 0 [ERROR] [FATAL] InnoDB: Semaphore wait has lasted > 600 seconds. We intentionally crash the server because it appears to be hung.
|
2020-01-26T05:43:42.4162457Z 200126 5:43:40 [ERROR] mysqld got signal 6 ;
|
2020-01-26T05:43:42.4162636Z This could be because you hit a bug. It is also possible that this binary
|
2020-01-26T05:43:42.4162850Z or one of the libraries it was linked against is corrupt, improperly built,
|
2020-01-26T05:43:42.4163064Z or misconfigured. This error can also be caused by malfunctioning hardware.
|
2020-01-26T05:43:42.4163204Z
|
2020-01-26T05:43:42.4163628Z To report this bug, see https://mariadb.com/kb/en/reporting-bugs
|
2020-01-26T05:43:42.4163800Z
|
2020-01-26T05:43:42.4163953Z We will try our best to scrape up some info that will hopefully help
|
2020-01-26T05:43:42.4164150Z diagnose the problem, but since we have already crashed,
|
2020-01-26T05:43:42.4164337Z something is definitely wrong and this may fail.
|
2020-01-26T05:43:42.4164492Z
|
2020-01-26T05:43:42.4164866Z Server version: 10.3.21-5-MariaDB-enterprise-log
|
2020-01-26T05:43:42.4165058Z key_buffer_size=1048576
|
2020-01-26T05:43:42.4165228Z read_buffer_size=131072
|
2020-01-26T05:43:42.4165389Z max_used_connections=4
|
2020-01-26T05:43:42.4165533Z max_threads=153
|
2020-01-26T05:43:42.4165691Z thread_count=12
|
2020-01-26T05:43:42.4165851Z It is possible that mysqld could use up to
|
2020-01-26T05:43:42.4166054Z key_buffer_size + (read_buffer_size + sort_buffer_size)*max_threads = 63225 K bytes of memory
|
2020-01-26T05:43:42.4167022Z Hope that's ok; if not, decrease some variables in the equation.
|
2020-01-26T05:43:42.4167199Z
|
2020-01-26T05:43:42.4167353Z Thread pointer: 0x0
|
2020-01-26T05:43:42.4167526Z Attempting backtrace. You can use the following information to find out
|
2020-01-26T05:43:42.4167733Z where mysqld died. If you see no messages after this, something went
|
2020-01-26T05:43:42.4167920Z terribly wrong...
|
2020-01-26T05:43:42.4168085Z stack_bottom = 0x0 thread_stack 0x49000
|
2020-01-26T05:43:42.4168275Z /__w/1/s/bin/mysqld(my_print_stacktrace+0x2e)[0x565407eb4dfe]
|
2020-01-26T05:43:42.4168453Z mysys/stacktrace.c:270(my_print_stacktrace)[0x565407935f87]
|
2020-01-26T05:43:42.4169025Z /lib/x86_64-linux-gnu/libpthread.so.0(+0xf890)[0x7f624eedf890]
|
2020-01-26T05:43:42.4169483Z /lib/x86_64-linux-gnu/libc.so.6(gsignal+0x37)[0x7f624d0b5067]
|
2020-01-26T05:43:42.4169689Z linux/raise.c:56(__GI_raise)[0x7f624d0b6448]
|
2020-01-26T05:43:42.4169876Z /__w/1/s/bin/mysqld(+0xbbf990)[0x565407d44990]
|
2020-01-26T05:43:42.4170044Z /__w/1/s/bin/mysqld(+0xb73987)[0x565407cf8987]
|
2020-01-26T05:43:42.4170228Z nptl/pthread_create.c:309(start_thread)[0x7f624eed8064]
|
2020-01-26T05:43:42.4170410Z x86_64/clone.S:113(clone)[0x7f624d16862d]
|
2020-01-26T05:43:42.4170615Z The manual page at http://dev.mysql.com/doc/mysql/en/crashing.html contains
|
2020-01-26T05:43:42.4170828Z information that should help you find out what is causing the crash.
|
2020-01-26T05:43:42.4170998Z Writing a core file...
|
2020-01-26T05:43:42.4171171Z Working directory at /var/tmp/mtr/1/mysqld.1/data
|
2020-01-26T05:43:42.4171349Z Resource Limits:
|
2020-01-26T05:43:42.4171509Z Fatal signal 11 while backtracing
|
2020-01-26T05:43:42.4171896Z ----------SERVER LOG END-------------
|
2020-01-26T05:43:42.4178065Z
|
2020-01-26T05:43:42.4178771Z
|
2020-01-26T05:43:42.4179813Z - saving '/var/tmp/mtr/1/log/galera.galera_bf_lock_wait-innodb/' to '/var/tmp/mtr/log/galera.galera_bf_lock_wait-innodb/'
|
2020-01-26T05:43:42.4180169Z ***Warnings generated in error logs during shutdown after running tests: galera.galera_bf_lock_wait
|
2020-01-26T05:43:42.4180541Z
|
2020-01-26T05:43:42.4181052Z 2020-01-26 5:31:48 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4181579Z 2020-01-26 5:32:19 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4182238Z 2020-01-26 5:32:50 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4182754Z 2020-01-26 5:33:21 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4183259Z 2020-01-26 5:33:52 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4183750Z 2020-01-26 5:34:23 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4184962Z 2020-01-26 5:34:54 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4192866Z 2020-01-26 5:35:25 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4193661Z 2020-01-26 5:35:56 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4194200Z 2020-01-26 5:36:27 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4195317Z 2020-01-26 5:36:58 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4195915Z 2020-01-26 5:37:29 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4204121Z 2020-01-26 5:38:00 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4204870Z 2020-01-26 5:38:31 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4205408Z 2020-01-26 5:39:02 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4205917Z 2020-01-26 5:39:33 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4207664Z 2020-01-26 5:40:04 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4208287Z 2020-01-26 5:40:35 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4208797Z 2020-01-26 5:41:06 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4209312Z 2020-01-26 5:41:37 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4210452Z 2020-01-26 5:42:08 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4211099Z 2020-01-26 5:42:39 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4218621Z 2020-01-26 5:43:10 0 [Warning] InnoDB: A long semaphore wait:
|
2020-01-26T05:43:42.4219323Z 2020-01-26 5:43:40 0 [ERROR] [FATAL] InnoDB: Semaphore wait has lasted > 600 seconds. We intentionally crash the server because it appears to be hung.
|
2020-01-26T05:43:42.4219676Z Attempting backtrace. You can use the following information to find out
|
2020-01-26T05:43:42.4219873Z
|
Attachments
Issue Links
- relates to
-
-
- Closed
-