cockroachdb / cockroach

CockroachDB — the cloud native, distributed SQL database designed for high availability, effortless scale, and control over data placement.
https://www.cockroachlabs.com
Other
30.1k stars 3.81k forks source link

acceptance: TestDockerCLI_test_demo_workload failed #134449

Open cockroach-teamcity opened 1 day ago

cockroach-teamcity commented 1 day ago

acceptance.TestDockerCLI_test_demo_workload failed with artifacts on release-24.3 @ 69d293afc2bdecd8ec4ed6577a0036e7dca0b9c6:

=== RUN   TestDockerCLI_test_demo_workload
    test_log_scope.go:165: test logs captured to: /home/agent/work/.go/src/github.com/cockroachdb/cockroach/artifacts/acceptance/_tmp/cae8acf78e91f72c41610d0ec1f275da/logTestDockerCLI_test_demo_workload285070280
    test_log_scope.go:76: use -show-logs to present logs inline
    generated_cli_test.go:161: -- test log scope end --
test logs left over in: /home/agent/work/.go/src/github.com/cockroachdb/cockroach/artifacts/acceptance/_tmp/cae8acf78e91f72c41610d0ec1f275da/logTestDockerCLI_test_demo_workload285070280
--- FAIL: TestDockerCLI_test_demo_workload (16.63s)
=== RUN   TestDockerCLI_test_demo_workload/test_demo_workload.tcl
    util_docker.go:255: non-zero exit code: 1
    --- FAIL: TestDockerCLI_test_demo_workload/test_demo_workload.tcl (10.93s)
Help

See also: [How To Investigate a Go Test Failure \(internal\)](https://cockroachlabs.atlassian.net/l/c/HgfXfJgM)

/cc @cockroachdb/sql-foundations

This test on roachdash | Improve this report!

Jira issue: CRDB-44082

rafiss commented 17 hours ago
expect: does " select key from crdb_internal.node_statement_statistics order by count desc limit 1;\r\n                                     key\r\n-----------------------------------------------------------------------------\r\n  DELETE FROM system.job_info WHERE (job_id = _) AND (info_key::STRING = _)\r\n(1 row)\r\n\r\nTime: 2ms total (execution 2ms / network 0ms)\r\n\r\nroot@127.0.0.1:26257/movr> select key from crdb_internal.node_statement_statistics order by count desc limit 1;\r\n                                     key\r\n-----------------------------------------------------------------------------\r\n  DELETE FROM system.job_info WHERE (job_id = _) AND (info_key::STRING = _)\r\n(1 row)\r\n\r\nTime: 3ms total (execution 3ms / network 0ms)\r\n\r\nroot@127.0.0.1:26257/movr> select key from crdb_internal.node_statement_statistics order by count desc limit 1;\r\n                                     key\r\n-----------------------------------------------------------------------------\r\n  DELETE FROM system.job_info WHERE (job_id = _) AND (info_key::STRING = _)\r\n(1 row)\r\n\r\nTime: 3ms total (execution 3ms / network 0ms)\r\n\r\nroot@127.0.0.1:26257/movr> select key from crdb_internal.node_statement_statistics order by count desc limit 1;\r\n                      key\r\n------------------------------------------------\r\n  SELECT city, id FROM vehicles WHERE city = _\r\n(1 row)\r\n\r\n" (spawn_id exp3) match glob pattern "SELECT city, id FROM vehicles WHERE city = _"? yes
expect: set expect_out(0,string) "SELECT city, id FROM vehicles WHERE city = _"
expect: set expect_out(spawn_id) "exp3"
expect: set expect_out(buffer) " select key from crdb_internal.node_statement_statistics order by count desc limit 1;\r\n                                     key\r\n-----------------------------------------------------------------------------\r\n  DELETE FROM system.job_info WHERE (job_id = _) AND (info_key::STRING = _)\r\n(1 row)\r\n\r\nTime: 2ms total (execution 2ms / network 0ms)\r\n\r\nroot@127.0.0.1:26257/movr> select key from crdb_internal.node_statement_statistics order by count desc limit 1;\r\n                                     key\r\n-----------------------------------------------------------------------------\r\n  DELETE FROM system.job_info WHERE (job_id = _) AND (info_key::STRING = _)\r\n(1 row)\r\n\r\nTime: 3ms total (execution 3ms / network 0ms)\r\n\r\nroot@127.0.0.1:26257/movr> select key from crdb_internal.node_statement_statistics order by count desc limit 1;\r\n                                     key\r\n-----------------------------------------------------------------------------\r\n  DELETE FROM system.job_info WHERE (job_id = _) AND (info_key::STRING = _)\r\n(1 row)\r\n\r\nTime: 3ms total (execution 3ms / network 0ms)\r\n\r\nroot@127.0.0.1:26257/movr> select key from crdb_internal.node_statement_statistics order by count desc limit 1;\r\n                      key\r\n------------------------------------------------\r\n  SELECT city, id FROM vehicles WHERE city = _"

.241106 19:46:41.998388734 START EXPECT TEST
system(echo; echo $(date '+.%y%m%d %H:%M:%S.%N') START EXPECT TEST | tee -a logs/expect-cmd.log) = 2

expect: does "\r\n(1 row)\r\n\r\n" (spawn_id exp3) match glob pattern "movr>"? no
Time: 4ms total (execution 4ms / network 0ms)

expect: does "\r\n(1 row)\r\n\r\nTime: 4ms total (execution 4ms / network 0ms)\r\n\r\n" (spawn_id exp3) match glob pattern "movr>"? no
expect: timed out
.241106 19:46:42.002328750 EXPECT TEST: TIMEOUT WAITING FOR "movr>"
system(echo; echo $(date '+.%y%m%d %H:%M:%S.%N') EXPECT TEST: 'TIMEOUT WAITING FOR "movr>"' | tee -a logs/expect-cmd.log) = 2

We've seen similar things before, like in https://github.com/cockroachdb/cockroach/issues/115626, where this test framework seems to not get back output even though everything else looks normal.