Error lines from build-log.txt
... skipping 70 lines ...
git version 2.43.0
============================
==== RUNNING UNIT TESTS ====
============================
/home/prow/go/src/github.com/tektoncd/results /home/prow/go/src/github.com/tektoncd/results
Using overridden unit_tests
2025/06/24 07:34:28 maxprocs: Leaving GOMAXPROCS=16: CPU quota undefined
=== RUN Test_determineAuth
=== RUN Test_determineAuth/missing_token
=== RUN Test_determineAuth/invalid_token
=== RUN Test_determineAuth/valid_token
--- PASS: Test_determineAuth (0.00s)
--- PASS: Test_determineAuth/missing_token (0.00s)
... skipping 27 lines ...
=== RUN TestParseFilter/success/#00
=== RUN TestParseFilter/success/result
=== RUN TestParseFilter/success/result.id
=== RUN TestParseFilter/success/result.id_==_"1"
=== RUN TestParseFilter/success/result.id_==_"1"_||_result.name_==_"2"
=== RUN TestParseFilter/success/result.id.startsWith("tacocat")
=== RUN TestParseFilter/error
=== RUN TestParseFilter/error/asdf
=== RUN TestParseFilter/error/result.id_==_1
=== RUN TestParseFilter/error/result.ID
--- PASS: TestParseFilter (1.29s)
--- PASS: TestParseFilter/success (0.84s)
--- PASS: TestParseFilter/success/#00 (0.00s)
--- PASS: TestParseFilter/success/result (0.28s)
--- PASS: TestParseFilter/success/result.id (0.09s)
--- PASS: TestParseFilter/success/result.id_==_"1" (0.08s)
--- PASS: TestParseFilter/success/result.id_==_"1"_||_result.name_==_"2" (0.24s)
--- PASS: TestParseFilter/success/result.id.startsWith("tacocat") (0.04s)
--- PASS: TestParseFilter/error (0.05s)
--- PASS: TestParseFilter/error/asdf (0.05s)
--- PASS: TestParseFilter/error/result.id_==_1 (0.00s)
--- PASS: TestParseFilter/error/result.ID (0.00s)
PASS
ok github.com/tektoncd/results/pkg/api/server/cel 3.218s
=== RUN TestConvertRecordExpressions
=== RUN TestConvertRecordExpressions/simple_expression
convert_test.go:170: want: (name = 'foo')
convert_test.go:171: got: (name = 'foo')
... skipping 347 lines ...
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/logs.go:352
[0m[33m[1.167ms] [34;1m[rows:3][0m SELECT * FROM `records` WHERE type = "results.tekton.dev/v1alpha3.Log" AND id > "" AND parent = "foo" AND result_name = "bar" ORDER BY created_time LIMIT 51
=== RUN TestListLogs/unknown_type
=== RUN TestListLogs/unknown_any_field
=== RUN TestListLogs/invalid_page_size
=== RUN TestListLogs/malformed_parent
{"level":"error","ts":1750751095.1915953,"caller":"v1alpha2/logs.go:268","msg":"rpc error: code = InvalidArgument desc = name must match (^[a-z0-9_-]{1,63})/results/([a-z0-9_-]{1,63}$)","stacktrace":"github.com/tektoncd/results/pkg/api/server/v1alpha2.(*Server).ListLogs\n\t/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/logs.go:268\ngithub.com/tektoncd/results/pkg/api/server/v1alpha2.TestListLogs.func1\n\t/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/logs_test.go:569\ntesting.tRunner\n\t/usr/local/go/src/testing/testing.go:1690"}
=== RUN TestListLogs/invalid_order_by_clause
=== RUN TestListLogs/invalid_sort_direction
--- PASS: TestListLogs (4.03s)
--- PASS: TestListLogs/all (0.10s)
--- PASS: TestListLogs/list_all_records_without_knowing_the_result_name (0.25s)
--- PASS: TestListLogs/list_all_records_without_knowing_the_parent_and_the_result_name (0.34s)
... skipping 171 lines ...
=== RUN TestCreateRecord/missing_name
=== RUN TestCreateRecord/result_used_as_name
=== RUN TestCreateRecord/already_exists
=== NAME TestCreateRecord
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:102
[0m[33m[0.509ms] [34;1m[rows:1][0m SELECT `results`.`name`,`results`.`id` FROM `results` WHERE `results`.`parent` = "foo" AND `results`.`name` = "bar" ORDER BY `results`.`id` LIMIT 1
db.go:69: [31;1m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:82 [35;1mUNIQUE constraint failed: records.parent, records.result_name, records.name
[0m[33m[1.236ms] [34;1m[rows:0][0m INSERT INTO `records` (`parent`,`result_id`,`result_name`,`id`,`name`,`type`,`data`,`etag`,`created_time`,`updated_time`) VALUES ("foo","25","bar","27","baz","TaskRun","{""metadata"":{""name"":""tacocat"",""creationTimestamp"":null},""spec"":{""serviceAccountName"":""""},""status"":{""podName"":""""}}","27-1750751092541361841","2025-06-24 07:44:52.541","2025-06-24 07:44:52.541") RETURNING `created_time`,`updated_time`
--- PASS: TestCreateRecord (1.04s)
--- PASS: TestCreateRecord/success (0.17s)
--- PASS: TestCreateRecord/mismatched_parent (0.00s)
--- PASS: TestCreateRecord/parent_does_not_exist (0.00s)
--- PASS: TestCreateRecord/missing_name (0.00s)
... skipping 13 lines ...
[0m[33m[0.118ms] [34;1m[rows:-][0m SELECT count(*) FROM sqlite_master WHERE type='table' AND name="records"
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/server.go:96
[0m[33m[53.150ms] [34;1m[rows:0][0m CREATE TABLE `records` (`parent` text,`result_id` text,`result_name` text,`id` text,`name` text,`type` text,`data` jsonb,`created_time` datetime DEFAULT current_timestamp,`updated_time` datetime DEFAULT current_timestamp,`etag` text,PRIMARY KEY (`parent`,`result_id`,`id`),CONSTRAINT `fk_records_result` FOREIGN KEY (`parent`,`result_id`) REFERENCES `results`(`parent`,`id`) ON DELETE CASCADE ON UPDATE CASCADE)
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/server.go:96
[0m[33m[46.579ms] [34;1m[rows:0][0m CREATE UNIQUE INDEX `records_by_name` ON `records`(`parent`,`result_name`,`name`)
{"level":"warn","ts":1750751099.4469476,"caller":"plugin/plugin_logs.go:720","msg":"Plugin Logs API Disable: unsupported type of logs given for plugin, legacy logging system might work"}
db.go:69: [31;1m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:82 [35;1mFOREIGN KEY constraint failed
[0m[33m[1.090ms] [34;1m[rows:0][0m INSERT INTO `records` (`parent`,`result_id`,`result_name`,`id`,`name`,`type`,`data`,`etag`,`created_time`,`updated_time`) VALUES ("foo","deleted","deleted","28","baz","","","28-1750751092541361841","2025-06-24 07:44:52.541","2025-06-24 07:44:52.541") RETURNING `created_time`,`updated_time`
--- PASS: TestCreateRecord_ConcurrentDelete (0.28s)
=== RUN TestGetRecord
records_test.go:185: test database: /tmp/testdb893758512
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/test/db.go:59
[0m[33m[0.054ms] [34;1m[rows:0][0m PRAGMA foreign_keys = ON;
... skipping 439 lines ...
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/results.go:208
[0m[33m[0.737ms] [34;1m[rows:1][0m SELECT * FROM `results` WHERE `results`.`parent` = "foo" AND `results`.`name` = "bar" ORDER BY `results`.`id` LIMIT 1
=== RUN TestCreateResult/mismatched_parent
=== RUN TestCreateResult/missing_name
=== RUN TestCreateResult/already_exists
=== NAME TestCreateResult
db.go:69: [31;1m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/results.go:72 [35;1mUNIQUE constraint failed: results.parent, results.name
[0m[33m[0.977ms] [34;1m[rows:0][0m INSERT INTO `results` (`parent`,`id`,`name`,`annotations`,`recordsummary_record`,`recordsummary_type`,`recordsummary_start_time`,`recordsummary_end_time`,`recordsummary_status`,`recordsummary_annotations`,`etag`,`created_time`,`updated_time`) VALUES ("foo","40","bar","{""foo"":""bar""}","","",NULL,NULL,0,"null","40-1750751117541361841","2025-06-24 07:45:17.541","2025-06-24 07:45:17.541") RETURNING `created_time`,`updated_time`
=== RUN TestCreateResult/large_name
=== RUN TestCreateResult/large_result_summary_type
--- PASS: TestCreateResult (0.52s)
--- PASS: TestCreateResult/success (0.02s)
--- PASS: TestCreateResult/mismatched_parent (0.00s)
... skipping 849 lines ...
plugin_logs_test.go:259: Received request: POST /services/search/v2/jobs?output_mode=json
plugin_logs_test.go:260: Received headers: map[Accept-Encoding:[gzip] Authorization:[Bearer eyJraWQiOiJzcGx1bmsuc2VjcmV0IiwiYWxnIjoiSFM1MTIiLCJ2ZXIiOiJ2MiIsInR0eXAiOiJzdGF0aWMifQ.eyJpc3MiOiJzY19hZG1pbiBmcm9tIGZlZG9yYSIsInN1YiI6InNjX2FkbWluIiwiYXVkIjoia3ViZXJuZXRlcyIsImlkcCI6IlNwbHVuayIsImp0aSI6IjI0MGM1MDY3NGJkNDgxYjU5ZWE5MTY5ZDJjN2MyZjM5NDVmZDFhOTM3MWU0Yzg0MTQ0N2NkYTYzYmQ4NmZjMGQiLCJpYXQiOjE3NDYzODA1NDgsImV4cCI6MTc3MjM4OTc1NSwibmJyIjoxNzQ2MzgwNTQ4fQ.WnMJE6Dd0Fmn5AipZtl_bpfwIpfGR6feW63Xs1890XPh1o1CrBTNbslTeIH1b9ewluOfrY7rxToAQMoCO3ZJQA] Content-Length:[221] Content-Type:[application/x-www-form-urlencoded] User-Agent:[Go-http-client/1.1]]
plugin_logs_test.go:259: Received request: GET /services/search/v2/jobs/1234567?output_mode=json
plugin_logs_test.go:260: Received headers: map[Accept-Encoding:[gzip] Authorization:[Bearer eyJraWQiOiJzcGx1bmsuc2VjcmV0IiwiYWxnIjoiSFM1MTIiLCJ2ZXIiOiJ2MiIsInR0eXAiOiJzdGF0aWMifQ.eyJpc3MiOiJzY19hZG1pbiBmcm9tIGZlZG9yYSIsInN1YiI6InNjX2FkbWluIiwiYXVkIjoia3ViZXJuZXRlcyIsImlkcCI6IlNwbHVuayIsImp0aSI6IjI0MGM1MDY3NGJkNDgxYjU5ZWE5MTY5ZDJjN2MyZjM5NDVmZDFhOTM3MWU0Yzg0MTQ0N2NkYTYzYmQ4NmZjMGQiLCJpYXQiOjE3NDYzODA1NDgsImV4cCI6MTc3MjM4OTc1NSwibmJyIjoxNzQ2MzgwNTQ4fQ.WnMJE6Dd0Fmn5AipZtl_bpfwIpfGR6feW63Xs1890XPh1o1CrBTNbslTeIH1b9ewluOfrY7rxToAQMoCO3ZJQA] User-Agent:[Go-http-client/1.1]]
plugin_logs_test.go:259: Received request: GET /services/search/v2/jobs/1234567/results?output_mode=json_rows&count=0
plugin_logs_test.go:260: Received headers: map[Accept-Encoding:[gzip] Authorization:[Bearer eyJraWQiOiJzcGx1bmsuc2VjcmV0IiwiYWxnIjoiSFM1MTIiLCJ2ZXIiOiJ2MiIsInR0eXAiOiJzdGF0aWMifQ.eyJpc3MiOiJzY19hZG1pbiBmcm9tIGZlZG9yYSIsInN1YiI6InNjX2FkbWluIiwiYXVkIjoia3ViZXJuZXRlcyIsImlkcCI6IlNwbHVuayIsImp0aSI6IjI0MGM1MDY3NGJkNDgxYjU5ZWE5MTY5ZDJjN2MyZjM5NDVmZDFhOTM3MWU0Yzg0MTQ0N2NkYTYzYmQ4NmZjMGQiLCJpYXQiOjE3NDYzODA1NDgsImV4cCI6MTc3MjM4OTc1NSwibmJyIjoxNzQ2MzgwNTQ4fQ.WnMJE6Dd0Fmn5AipZtl_bpfwIpfGR6feW63Xs1890XPh1o1CrBTNbslTeIH1b9ewluOfrY7rxToAQMoCO3ZJQA] User-Agent:[Go-http-client/1.1]]
plugin_logs_test.go:375: recv error: <nil>
--- PASS: TestSplunkLogs (6.23s)
PASS
ok github.com/tektoncd/results/pkg/api/server/v1alpha2/plugin 14.339s
=== RUN TestParseName
=== RUN TestParseName/simple
=== RUN TestParseName/resource_name_reuse
... skipping 80 lines ...
=== RUN TestMatch/no_filter
=== RUN TestMatch/matching_condition
=== RUN TestMatch/non-matching_condition
=== RUN TestMatch/nil_result
=== RUN TestMatch/non-bool_output
=== RUN TestMatch/wrong_resource_type
2025/06/24 07:45:01 failed to evaluate the expression: no such attribute(s): record
--- PASS: TestMatch (0.89s)
--- PASS: TestMatch/no_filter (0.00s)
--- PASS: TestMatch/matching_condition (0.66s)
--- PASS: TestMatch/non-matching_condition (0.00s)
--- PASS: TestMatch/nil_result (0.04s)
--- PASS: TestMatch/non-bool_output (0.00s)
... skipping 29 lines ...
--- PASS: TestSend/successful_request (0.16s)
PASS
ok github.com/tektoncd/results/pkg/cli/client 2.052s
=== RUN TestListRecords
=== RUN TestListRecords/successful_list
=== RUN TestListRecords/error_response
2025/06/24 07:45:01 RoundTripper returned a response & error; ignoring response
--- PASS: TestListRecords (0.27s)
--- PASS: TestListRecords/successful_list (0.00s)
--- PASS: TestListRecords/error_response (0.27s)
PASS
ok github.com/tektoncd/results/pkg/cli/client/records 2.652s
=== RUN TestPrintProto
... skipping 158 lines ...
--- PASS: TestValidateLabels/malformed_pair (0.00s)
--- PASS: TestValidateLabels/whitespace_in_key (0.00s)
=== RUN TestLogsCommand
=== RUN TestLogsCommand/successful_log_retrieval_by_name
=== RUN TestLogsCommand/successful_log_retrieval_by_UID
=== RUN TestLogsCommand/no_PipelineRun_found
Error: no PipelineRun found with name non-existent
=== RUN TestLogsCommand/multiple_PipelineRuns_found
Error: multiple PipelineRuns found
=== RUN TestLogsCommand/error_getting_logs
Error: rpc error: code = Internal desc = failed to get logs
=== RUN TestLogsCommand/invalid_arguments
Error: requires exactly one argument when --uid is not provided
--- PASS: TestLogsCommand (0.00s)
--- PASS: TestLogsCommand/successful_log_retrieval_by_name (0.00s)
--- PASS: TestLogsCommand/successful_log_retrieval_by_UID (0.00s)
--- PASS: TestLogsCommand/no_PipelineRun_found (0.00s)
--- PASS: TestLogsCommand/multiple_PipelineRuns_found (0.00s)
--- PASS: TestLogsCommand/error_getting_logs (0.00s)
... skipping 65 lines ...
--- PASS: TestBuildFilterString/pipelinerun_and_label_filters (0.00s)
--- PASS: TestBuildFilterString/pipelinerun_and_name_filters (0.00s)
=== RUN TestLogsCommand
=== RUN TestLogsCommand/successful_log_retrieval_by_name
=== RUN TestLogsCommand/successful_log_retrieval_by_UID
=== RUN TestLogsCommand/no_TaskRun_found
Error: no TaskRun found with name non-existent
=== RUN TestLogsCommand/multiple_TaskRuns_found
Error: multiple TaskRuns found
=== RUN TestLogsCommand/error_getting_logs
Error: rpc error: code = Internal desc = failed to get logs
=== RUN TestLogsCommand/invalid_arguments
Error: requires exactly one argument when --uid is not provided
--- PASS: TestLogsCommand (0.00s)
--- PASS: TestLogsCommand/successful_log_retrieval_by_name (0.00s)
--- PASS: TestLogsCommand/successful_log_retrieval_by_UID (0.00s)
--- PASS: TestLogsCommand/no_TaskRun_found (0.00s)
--- PASS: TestLogsCommand/multiple_TaskRuns_found (0.00s)
--- PASS: TestLogsCommand/error_getting_logs (0.00s)
... skipping 16 lines ...
--- PASS: TestReset (0.28s)
=== RUN TestLoadClientConfig
--- PASS: TestLoadClientConfig (0.02s)
=== RUN TestNewConfigError
--- PASS: TestNewConfigError (0.00s)
=== RUN TestSetWithPrompt
config_test.go:270: Received expected error when prompting for user input in test environment
--- PASS: TestSetWithPrompt (0.06s)
=== RUN TestPersist
--- PASS: TestPersist (0.07s)
=== RUN TestSetVersion
--- PASS: TestSetVersion (0.25s)
=== RUN TestHost
... skipping 305 lines ...
[0m[33m[0.692ms] [34;1m[rows:1][0m UPDATE `records` SET `result_name`="pr-id",`name`="pr-id",`type`="tekton.dev/v1.PipelineRun",`data`="{""kind"":""PipelineRun"",""apiVersion"":""tekton.dev/v1"",""metadata"":{""name"":""pr"",""namespace"":""ns"",""uid"":""pr-id"",""creationTimestamp"":null,""annotations"":{""demo"":""demo"",""results.tekton.dev/record"":""ns/results/pr-id/records/pr-id"",""results.tekton.dev/result"":""ns/results/pr-id"",""results.tekton.dev/stored"":""false""},""finalizers"":[""results.tekton.dev/pipelinerun""]},""spec"":{""taskRunTemplate"":{}},""status"":{}}",`created_time`="2025-06-24 07:46:54.305",`updated_time`="2025-06-24 07:46:55.116",`etag`="a45cc631-bf0f-4921-bc67-400dbfc95221-1750751215116607505" WHERE `parent` = "ns" AND `result_id` = "5e848c4c-e3f4-40c2-b450-2c8b79d62934" AND `id` = "a45cc631-bf0f-4921-bc67-400dbfc95221"
=== NAME TestController/pipelinerun
reconciler_test.go:135: Get (&{{PipelineRun tekton.dev/v1} {pr ns pr-id 0 0001-01-01 00:00:00 +0000 UTC <nil> <nil> map[] map[demo:demo results.tekton.dev/record:ns/results/pr-id/records/pr-id results.tekton.dev/result:ns/results/pr-id results.tekton.dev/stored:false] [] [results.tekton.dev/pipelinerun] []} {<nil> <nil> [] <nil> {<nil> } [] []} {{0 [] map[]} {<nil> <nil> [] <nil> [] [] <nil> <nil> map[]}}}, <nil>)
=== NAME TestController
logger.go:146: 2025-06-24T07:46:55.702Z INFO TestController controller/controller.go:496 Shutting down workers {"knative.dev/controller": "github.com.tektoncd.results.pkg.watcher.reconciler.taskrun.Reconciler", "knative.dev/kind": "tekton.dev.TaskRun"}
logger.go:146: 2025-06-24T07:46:55.703Z INFO TestController controller/controller.go:496 Shutting down workers {"knative.dev/controller": "github.com.tektoncd.results.pkg.watcher.reconciler.pipelinerun.Reconciler", "knative.dev/kind": "tekton.dev.PipelineRun"}
logger.go:146: 2025-06-24T07:46:55.704Z DEBUG TestController dynamic/dynamic.go:165 Error upserting record to API server {"knative.dev/controller": "github.com.tektoncd.results.pkg.watcher.reconciler.pipelinerun.Reconciler", "knative.dev/kind": "tekton.dev.PipelineRun", "knative.dev/traceid": "497166be-3ebf-4d22-aca4-fb17813f4d93", "knative.dev/key": "ns/pr", "results.tekton.dev/kind": "PipelineRun", "error": "rpc error: code = Canceled desc = grpc: the client connection is closing", "results.tekton.dev/time-taken-ms": 615}
logger.go:146: 2025-06-24T07:46:55.707Z WARN TestController dynamic/dynamic.go:120 Leaving dynamic Reconciler somehow but the context channel is not closed {"knative.dev/controller": "github.com.tektoncd.results.pkg.watcher.reconciler.pipelinerun.Reconciler", "knative.dev/kind": "tekton.dev.PipelineRun", "knative.dev/traceid": "497166be-3ebf-4d22-aca4-fb17813f4d93", "knative.dev/key": "ns/pr", "results.tekton.dev/kind": "PipelineRun", "namespace": "ns", "kind": "PipelineRun", "name": "pr"}
logger.go:146: 2025-06-24T07:46:55.708Z ERROR TestController pipelinerun/reconciler.go:295 Returned an error {"knative.dev/controller": "github.com.tektoncd.results.pkg.watcher.reconciler.pipelinerun.Reconciler", "knative.dev/kind": "tekton.dev.PipelineRun", "knative.dev/traceid": "497166be-3ebf-4d22-aca4-fb17813f4d93", "knative.dev/key": "ns/pr", "targetMethod": "ReconcileKind", "error": "error upserting record: rpc error: code = Canceled desc = grpc: the client connection is closing"}
logger.go:146: 2025-06-24T07:46:55.708Z ERROR TestController controller/controller.go:564 Reconcile error {"knative.dev/controller": "github.com.tektoncd.results.pkg.watcher.reconciler.pipelinerun.Reconciler", "knative.dev/kind": "tekton.dev.PipelineRun", "knative.dev/traceid": "497166be-3ebf-4d22-aca4-fb17813f4d93", "knative.dev/key": "ns/pr", "duration": "619.810718ms", "error": "error upserting record: rpc error: code = Canceled desc = grpc: the client connection is closing"}
--- PASS: TestController (5.12s)
--- PASS: TestController/taskrun (2.07s)
--- PASS: TestController/pipelinerun (2.00s)
PASS
==================
WARNING: DATA RACE
... skipping 77 lines ...
knative.dev/pkg/controller.(*Impl).processNextWorkItem(0xc000191b00)
/home/prow/go/src/github.com/tektoncd/results/vendor/knative.dev/pkg/controller/controller.go:511 +0x2f8
knative.dev/pkg/controller.(*Impl).RunContext.func3()
/home/prow/go/src/github.com/tektoncd/results/vendor/knative.dev/pkg/controller/controller.go:489 +0x95
created by knative.dev/pkg/controller.(*Impl).RunContext in goroutine 69
/home/prow/go/src/github.com/tektoncd/results/vendor/knative.dev/pkg/controller/controller.go:487 +0x552
FAIL github.com/tektoncd/results/pkg/watcher/reconciler 7.439s
=== RUN TestPatch
=== RUN TestPatch/create_a_patch_containing_only_the_result_and_record_identifiers_since_the_object_is_a_PipelineRun
=== RUN TestPatch/create_a_patch_containing_only_the_result_and_record_identifiers_since_the_TaskRun_isn't_owned_by_a_PipelineRun
=== RUN TestPatch/create_a_patch_containing_only_the_result_and_record_identifiers_since_the_TaskRun_isn't_done_yet
=== RUN TestPatch/mark_the_TaskRun_as_ready_for_deletion_since_it's_owned_by_a_PipelineRun_and_is_done
--- PASS: TestPatch (0.00s)
... skipping 67 lines ...
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:102
[0m[33m[0.565ms] [34;1m[rows:1][0m SELECT `results`.`name`,`results`.`id` FROM `results` WHERE `results`.`parent` = "ns" AND `results`.`name` = "12345" ORDER BY `results`.`id` LIMIT 1
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:82
[0m[33m[135.797ms] [34;1m[rows:1][0m INSERT INTO `records` (`parent`,`result_id`,`result_name`,`id`,`name`,`type`,`data`,`etag`,`created_time`,`updated_time`) VALUES ("ns","b13765e3-7f0e-429c-a8be-22f7d75239e4","12345","c6d03955-3073-4505-8f18-e9eb20003581","539b2a79-5170-335f-a97c-1a2f595ceefc","results.tekton.dev/v1alpha3.Log","{""kind"":""Log"",""apiVersion"":""results.tekton.dev/v1alpha3"",""metadata"":{""name"":""taskrun-log"",""namespace"":""ns"",""uid"":""539b2a79-5170-335f-a97c-1a2f595ceefc"",""creationTimestamp"":null},""spec"":{""resource"":{""kind"":""TaskRun"",""namespace"":""ns"",""name"":""taskrun"",""uid"":""12345""},""type"":""File""},""status"":{""size"":0,""isStored"":false,""errorOnStoreMsg"":"""",""isRetryableErr"":false}}","c6d03955-3073-4505-8f18-e9eb20003581-1750751221638791583","2025-06-24 07:47:01.638","2025-06-24 07:47:01.638") RETURNING `created_time`,`updated_time`
logger.go:146: 2025-06-24T07:47:01.776Z DEBUG TestReconcile_TaskRun dynamic/dynamic.go:289 Skipping CRD annotation patch: annotation update is disabled
logger.go:146: 2025-06-24T07:47:01.776Z DEBUG TestReconcile_TaskRun dynamic/dynamic.go:472 Streaming log started {"namespace": "ns", "kind": "TaskRun", "name": "taskrun"}
logger.go:146: 2025-06-24T07:47:01.777Z ERROR TestReconcile_TaskRun dynamic/dynamic.go:480 Error streaming log {"namespace": "ns", "kind": "TaskRun", "name": "taskrun", "error": "failed to create tkn reader: Parsing kubeconfig failed: invalid configuration: no configuration has been provided, try setting KUBERNETES_MASTER environment variable"}
logger.go:146: 2025-06-24T07:47:01.777Z INFO TestReconcile_TaskRun dynamic/dynamic.go:488 Streaming log completed {"namespace": "ns", "kind": "TaskRun", "name": "taskrun"}
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/results.go:208
[0m[33m[36.029ms] [34;1m[rows:1][0m SELECT * FROM `results` WHERE `results`.`parent` = "ns" AND `results`.`name` = "12345" ORDER BY `results`.`id` LIMIT 1
logger.go:146: 2025-06-24T07:47:01.820Z DEBUG TestReconcile_TaskRun results/results.go:210 No further actions to be done on the Result: no differences found {"results.tekton.dev/result": "ns/results/12345", "results.tekton.dev/record": "ns/results/12345/records/12345", "results.tekton.dev/top-level-record": true}
db.go:69: [31;1m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:135 [35;1mrecord not found
[0m[33m[0.507ms] [34;1m[rows:0][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "6a11be1a-3f37-3ddd-a5dd-efa3e0111fcf" ORDER BY `records`.`id` LIMIT 1
... skipping 110 lines ...
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:135
[0m[33m[0.965ms] [34;1m[rows:1][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "12345" ORDER BY `records`.`id` LIMIT 1
logger.go:146: 2025-06-24T07:47:02.822Z DEBUG TestReconcile_TaskRun results/results.go:326 Updating Record {"results.tekton.dev/record": "ns/results/12345/records/12345"}
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:135
[0m[33m[0.626ms] [34;1m[rows:1][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "12345" ORDER BY `records`.`id` LIMIT 1
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:217
[0m[33m[0.738ms] [34;1m[rows:1][0m UPDATE `records` SET `result_name`="12345",`name`="12345",`type`="tekton.dev/v1.TaskRun",`data`="{""kind"":""TaskRun"",""apiVersion"":""tekton.dev/v1"",""metadata"":{""name"":""taskrun"",""namespace"":""ns"",""uid"":""12345"",""creationTimestamp"":null,""annotations"":{""demo"":""demo""}},""spec"":{""serviceAccountName"":"""",""taskSpec"":{""steps"":[{""name"":"""",""computeResources"":{},""script"":""echo hello world!""}]}},""status"":{""conditions"":[{""type"":""Succeeded"",""status"":""False"",""lastTransitionTime"":""2025-06-24T07:47:02Z"",""reason"":""Failed"",""message"":""Failed""}],""podName"":"""",""startTime"":""2025-06-24T07:47:02Z"",""completionTime"":""2025-06-24T07:47:03Z""}}",`created_time`="2025-06-24 07:47:01.339",`updated_time`="2025-06-24 07:47:02.825",`etag`="03d25a33-e6b0-4cbc-a213-99ba5849324b-1750751222825947543" WHERE `parent` = "ns" AND `result_id` = "b13765e3-7f0e-429c-a8be-22f7d75239e4" AND `id` = "03d25a33-e6b0-4cbc-a213-99ba5849324b"
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/results.go:208
[0m[33m[0.758ms] [34;1m[rows:1][0m SELECT * FROM `results` WHERE `results`.`parent` = "ns" AND `results`.`name` = "12345" ORDER BY `results`.`id` LIMIT 1
logger.go:146: 2025-06-24T07:47:03.119Z DEBUG TestReconcile_TaskRun results/results.go:210 No further actions to be done on the Result: no differences found {"results.tekton.dev/result": "ns/results/12345", "results.tekton.dev/record": "ns/results/12345/records/12345", "results.tekton.dev/top-level-record": true}
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:135
[0m[33m[0.565ms] [34;1m[rows:1][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "539b2a79-5170-335f-a97c-1a2f595ceefc" ORDER BY `records`.`id` LIMIT 1
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/results.go:208
... skipping 34 lines ...
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:135
[0m[33m[0.510ms] [34;1m[rows:1][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "12345" ORDER BY `records`.`id` LIMIT 1
logger.go:146: 2025-06-24T07:47:03.200Z DEBUG TestReconcile_TaskRun results/results.go:326 Updating Record {"results.tekton.dev/record": "ns/results/12345/records/12345"}
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:135
[0m[33m[0.649ms] [34;1m[rows:1][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "12345" ORDER BY `records`.`id` LIMIT 1
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:217
[0m[33m[0.693ms] [34;1m[rows:1][0m UPDATE `records` SET `result_name`="12345",`name`="12345",`type`="tekton.dev/v1.TaskRun",`data`="{""kind"":""TaskRun"",""apiVersion"":""tekton.dev/v1"",""metadata"":{""name"":""taskrun"",""namespace"":""ns"",""uid"":""12345"",""creationTimestamp"":null,""labels"":{""x"":""foo""},""annotations"":{""demo"":""demo""}},""spec"":{""serviceAccountName"":"""",""taskSpec"":{""steps"":[{""name"":"""",""computeResources"":{},""script"":""echo hello world!""}]}},""status"":{""conditions"":[{""type"":""Succeeded"",""status"":""False"",""lastTransitionTime"":""2025-06-24T07:47:02Z"",""reason"":""Failed"",""message"":""Failed""}],""podName"":"""",""startTime"":""2025-06-24T07:47:02Z"",""completionTime"":""2025-06-24T07:47:03Z""}}",`created_time`="2025-06-24 07:47:01.339",`updated_time`="2025-06-24 07:47:03.202",`etag`="03d25a33-e6b0-4cbc-a213-99ba5849324b-1750751223202916628" WHERE `parent` = "ns" AND `result_id` = "b13765e3-7f0e-429c-a8be-22f7d75239e4" AND `id` = "03d25a33-e6b0-4cbc-a213-99ba5849324b"
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/results.go:208
[0m[33m[0.588ms] [34;1m[rows:1][0m SELECT * FROM `results` WHERE `results`.`parent` = "ns" AND `results`.`name` = "12345" ORDER BY `results`.`id` LIMIT 1
logger.go:146: 2025-06-24T07:47:03.212Z DEBUG TestReconcile_TaskRun results/results.go:210 No further actions to be done on the Result: no differences found {"results.tekton.dev/result": "ns/results/12345", "results.tekton.dev/record": "ns/results/12345/records/12345", "results.tekton.dev/top-level-record": true}
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:135
[0m[33m[0.508ms] [34;1m[rows:1][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "539b2a79-5170-335f-a97c-1a2f595ceefc" ORDER BY `records`.`id` LIMIT 1
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/results.go:208
... skipping 52 lines ...
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:135
[0m[33m[0.463ms] [34;1m[rows:1][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "12345" ORDER BY `records`.`id` LIMIT 1
logger.go:146: 2025-06-24T07:47:03.342Z DEBUG TestReconcile_TaskRun results/results.go:326 Updating Record {"results.tekton.dev/record": "ns/results/12345/records/12345"}
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:135
[0m[33m[0.680ms] [34;1m[rows:1][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "12345" ORDER BY `records`.`id` LIMIT 1
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:217
[0m[33m[0.692ms] [34;1m[rows:1][0m UPDATE `records` SET `result_name`="12345",`name`="12345",`type`="tekton.dev/v1.TaskRun",`data`="{""kind"":""TaskRun"",""apiVersion"":""tekton.dev/v1"",""metadata"":{""name"":""taskrun"",""namespace"":""ns"",""uid"":""12345"",""creationTimestamp"":null,""labels"":{""x"":""foo""},""annotations"":{""x"":""foo""}},""spec"":{""serviceAccountName"":"""",""taskSpec"":{""steps"":[{""name"":"""",""computeResources"":{},""script"":""echo hello world!""}]}},""status"":{""conditions"":[{""type"":""Succeeded"",""status"":""False"",""lastTransitionTime"":""2025-06-24T07:47:02Z"",""reason"":""Failed"",""message"":""Failed""}],""podName"":"""",""startTime"":""2025-06-24T07:47:02Z"",""completionTime"":""2025-06-24T07:47:03Z""}}",`created_time`="2025-06-24 07:47:01.339",`updated_time`="2025-06-24 07:47:03.345",`etag`="03d25a33-e6b0-4cbc-a213-99ba5849324b-1750751223345021337" WHERE `parent` = "ns" AND `result_id` = "b13765e3-7f0e-429c-a8be-22f7d75239e4" AND `id` = "03d25a33-e6b0-4cbc-a213-99ba5849324b"
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/results.go:208
[0m[33m[0.509ms] [34;1m[rows:1][0m SELECT * FROM `results` WHERE `results`.`parent` = "ns" AND `results`.`name` = "12345" ORDER BY `results`.`id` LIMIT 1
logger.go:146: 2025-06-24T07:47:03.379Z DEBUG TestReconcile_TaskRun results/results.go:210 No further actions to be done on the Result: no differences found {"results.tekton.dev/result": "ns/results/12345", "results.tekton.dev/record": "ns/results/12345/records/12345", "results.tekton.dev/top-level-record": true}
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:135
[0m[33m[0.674ms] [34;1m[rows:1][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "539b2a79-5170-335f-a97c-1a2f595ceefc" ORDER BY `records`.`id` LIMIT 1
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/results.go:208
... skipping 14 lines ...
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:135
[0m[33m[0.725ms] [34;1m[rows:1][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "12345" ORDER BY `records`.`id` LIMIT 1
logger.go:146: 2025-06-24T07:47:03.425Z DEBUG TestReconcile_TaskRun results/results.go:326 Updating Record {"results.tekton.dev/record": "ns/results/12345/records/12345"}
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:135
[0m[33m[0.693ms] [34;1m[rows:1][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "12345" ORDER BY `records`.`id` LIMIT 1
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:217
[0m[33m[0.606ms] [34;1m[rows:1][0m UPDATE `records` SET `result_name`="12345",`name`="12345",`type`="tekton.dev/v1.TaskRun",`data`="{""kind"":""TaskRun"",""apiVersion"":""tekton.dev/v1"",""metadata"":{""name"":""taskrun"",""namespace"":""ns"",""uid"":""12345"",""creationTimestamp"":null,""labels"":{""x"":""foo""},""annotations"":{""x"":""foo""},""ownerReferences"":[{""apiVersion"":""v1"",""kind"":""test"",""name"":""test-owner"",""uid"":""""}]},""spec"":{""serviceAccountName"":"""",""taskSpec"":{""steps"":[{""name"":"""",""computeResources"":{},""script"":""echo hello world!""}]}},""status"":{""conditions"":[{""type"":""Succeeded"",""status"":""False"",""lastTransitionTime"":""2025-06-24T07:47:02Z"",""reason"":""Failed"",""message"":""Failed""}],""podName"":"""",""startTime"":""2025-06-24T07:47:02Z"",""completionTime"":""2025-06-24T07:47:03Z""}}",`created_time`="2025-06-24 07:47:01.339",`updated_time`="2025-06-24 07:47:03.428",`etag`="03d25a33-e6b0-4cbc-a213-99ba5849324b-1750751223428832796" WHERE `parent` = "ns" AND `result_id` = "b13765e3-7f0e-429c-a8be-22f7d75239e4" AND `id` = "03d25a33-e6b0-4cbc-a213-99ba5849324b"
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/results.go:208
[0m[33m[0.625ms] [34;1m[rows:1][0m SELECT * FROM `results` WHERE `results`.`parent` = "ns" AND `results`.`name` = "12345" ORDER BY `results`.`id` LIMIT 1
logger.go:146: 2025-06-24T07:47:03.438Z DEBUG TestReconcile_TaskRun results/results.go:202 No further actions to be done on the Result: the object is not a top level record {"results.tekton.dev/result": "ns/results/12345", "results.tekton.dev/record": "ns/results/12345/records/12345", "results.tekton.dev/top-level-record": false}
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:135
[0m[33m[0.479ms] [34;1m[rows:1][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "539b2a79-5170-335f-a97c-1a2f595ceefc" ORDER BY `records`.`id` LIMIT 1
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/results.go:208
... skipping 16 lines ...
db.go:69: [31;1m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:135 [35;1mrecord not found
[0m[33m[0.632ms] [34;1m[rows:0][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "0e4fdca1-4fe3-4fa6-8b62-a8ee885cfed2" AND `records`.`name` = "12345" ORDER BY `records`.`id` LIMIT 1
logger.go:146: 2025-06-24T07:47:03.467Z DEBUG TestReconcile_TaskRun results/results.go:334 Record doesn't exist yet - creating {"results.tekton.dev/record": "ns/results/0e4fdca1-4fe3-4fa6-8b62-a8ee885cfed2/records/12345"}
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:102
[0m[33m[0.450ms] [34;1m[rows:1][0m SELECT `results`.`name`,`results`.`id` FROM `results` WHERE `results`.`parent` = "ns" AND `results`.`name` = "0e4fdca1-4fe3-4fa6-8b62-a8ee885cfed2" ORDER BY `results`.`id` LIMIT 1
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:82
[0m[33m[4.620ms] [34;1m[rows:1][0m INSERT INTO `records` (`parent`,`result_id`,`result_name`,`id`,`name`,`type`,`data`,`etag`,`created_time`,`updated_time`) VALUES ("ns","394f4c03-f04e-4bad-af7a-d5e891608dae","0e4fdca1-4fe3-4fa6-8b62-a8ee885cfed2","e0efe7f5-337c-49a8-a7b5-0b3fdb7bf264","12345","tekton.dev/v1.TaskRun","{""kind"":""TaskRun"",""apiVersion"":""tekton.dev/v1"",""metadata"":{""name"":""taskrun"",""namespace"":""ns"",""uid"":""12345"",""creationTimestamp"":null,""labels"":{""x"":""foo""},""annotations"":{""x"":""foo""},""ownerReferences"":[{""apiVersion"":""tekton.dev/v1"",""kind"":""PipelineRun"",""name"":""test-pipelinerun"",""uid"":""0e4fdca1-4fe3-4fa6-8b62-a8ee885cfed2""}]},""spec"":{""serviceAccountName"":"""",""taskSpec"":{""steps"":[{""name"":"""",""computeResources"":{},""script"":""echo hello world!""}]}},""status"":{""conditions"":[{""type"":""Succeeded"",""status"":""False"",""lastTransitionTime"":""2025-06-24T07:47:02Z"",""reason"":""Failed"",""message"":""Failed""}],""podName"":"""",""startTime"":""2025-06-24T07:47:02Z"",""completionTime"":""2025-06-24T07:47:03Z""}}","e0efe7f5-337c-49a8-a7b5-0b3fdb7bf264-1750751223469565175","2025-06-24 07:47:03.469","2025-06-24 07:47:03.469") RETURNING `created_time`,`updated_time`
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/results.go:208
[0m[33m[0.528ms] [34;1m[rows:1][0m SELECT * FROM `results` WHERE `results`.`parent` = "ns" AND `results`.`name` = "0e4fdca1-4fe3-4fa6-8b62-a8ee885cfed2" ORDER BY `results`.`id` LIMIT 1
logger.go:146: 2025-06-24T07:47:03.477Z DEBUG TestReconcile_TaskRun results/results.go:202 No further actions to be done on the Result: the object is not a top level record {"results.tekton.dev/result": "ns/results/0e4fdca1-4fe3-4fa6-8b62-a8ee885cfed2", "results.tekton.dev/record": "ns/results/0e4fdca1-4fe3-4fa6-8b62-a8ee885cfed2/records/12345", "results.tekton.dev/top-level-record": false}
db.go:69: [31;1m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:135 [35;1mrecord not found
[0m[33m[0.421ms] [34;1m[rows:0][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "0e4fdca1-4fe3-4fa6-8b62-a8ee885cfed2" AND `records`.`name` = "a2709b88-772b-355b-bc72-c27f378cd665" ORDER BY `records`.`id` LIMIT 1
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/results.go:208
... skipping 3 lines ...
[0m[33m[0.448ms] [34;1m[rows:0][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "0e4fdca1-4fe3-4fa6-8b62-a8ee885cfed2" AND `records`.`name` = "a2709b88-772b-355b-bc72-c27f378cd665" ORDER BY `records`.`id` LIMIT 1
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:102
[0m[33m[0.300ms] [34;1m[rows:1][0m SELECT `results`.`name`,`results`.`id` FROM `results` WHERE `results`.`parent` = "ns" AND `results`.`name` = "0e4fdca1-4fe3-4fa6-8b62-a8ee885cfed2" ORDER BY `results`.`id` LIMIT 1
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:82
[0m[33m[11.790ms] [34;1m[rows:1][0m INSERT INTO `records` (`parent`,`result_id`,`result_name`,`id`,`name`,`type`,`data`,`etag`,`created_time`,`updated_time`) VALUES ("ns","394f4c03-f04e-4bad-af7a-d5e891608dae","0e4fdca1-4fe3-4fa6-8b62-a8ee885cfed2","990a971f-0a7c-4f40-bce0-af7668fc4e12","a2709b88-772b-355b-bc72-c27f378cd665","results.tekton.dev/v1alpha3.Log","{""kind"":""Log"",""apiVersion"":""results.tekton.dev/v1alpha3"",""metadata"":{""name"":""taskrun-log"",""namespace"":""ns"",""uid"":""a2709b88-772b-355b-bc72-c27f378cd665"",""creationTimestamp"":null},""spec"":{""resource"":{""kind"":""TaskRun"",""namespace"":""ns"",""name"":""taskrun"",""uid"":""12345""},""type"":""File""},""status"":{""size"":0,""isStored"":false,""errorOnStoreMsg"":"""",""isRetryableErr"":false}}","990a971f-0a7c-4f40-bce0-af7668fc4e12-1750751223485129642","2025-06-24 07:47:03.485","2025-06-24 07:47:03.485") RETURNING `created_time`,`updated_time`
logger.go:146: 2025-06-24T07:47:03.500Z DEBUG TestReconcile_TaskRun dynamic/dynamic.go:472 Streaming log started {"namespace": "ns", "kind": "TaskRun", "name": "taskrun"}
logger.go:146: 2025-06-24T07:47:03.501Z ERROR TestReconcile_TaskRun dynamic/dynamic.go:480 Error streaming log {"namespace": "ns", "kind": "TaskRun", "name": "taskrun", "error": "failed to create tkn reader: Parsing kubeconfig failed: invalid configuration: no configuration has been provided, try setting KUBERNETES_MASTER environment variable"}
logger.go:146: 2025-06-24T07:47:03.501Z INFO TestReconcile_TaskRun dynamic/dynamic.go:488 Streaming log completed {"namespace": "ns", "kind": "TaskRun", "name": "taskrun"}
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/results.go:208
[0m[33m[0.711ms] [34;1m[rows:1][0m SELECT * FROM `results` WHERE `results`.`parent` = "ns" AND `results`.`name` = "0e4fdca1-4fe3-4fa6-8b62-a8ee885cfed2" ORDER BY `results`.`id` LIMIT 1
logger.go:146: 2025-06-24T07:47:03.503Z DEBUG TestReconcile_TaskRun results/results.go:202 No further actions to be done on the Result: the object is not a top level record {"results.tekton.dev/result": "ns/results/0e4fdca1-4fe3-4fa6-8b62-a8ee885cfed2", "results.tekton.dev/record": "ns/results/0e4fdca1-4fe3-4fa6-8b62-a8ee885cfed2/records/12345", "results.tekton.dev/top-level-record": false}
db.go:69: [31;1m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:135 [35;1mrecord not found
[0m[33m[0.435ms] [34;1m[rows:0][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "0e4fdca1-4fe3-4fa6-8b62-a8ee885cfed2" AND `records`.`name` = "b41b6711-8b16-3d41-9a39-0892112cddc7" ORDER BY `records`.`id` LIMIT 1
... skipping 18 lines ...
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:135
[0m[33m[0.674ms] [34;1m[rows:1][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "12345" ORDER BY `records`.`id` LIMIT 1
logger.go:146: 2025-06-24T07:47:03.545Z DEBUG TestReconcile_TaskRun results/results.go:326 Updating Record {"results.tekton.dev/record": "ns/results/12345/records/12345"}
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:135
[0m[33m[0.481ms] [34;1m[rows:1][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "12345" ORDER BY `records`.`id` LIMIT 1
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:217
[0m[33m[0.529ms] [34;1m[rows:1][0m UPDATE `records` SET `result_name`="12345",`name`="12345",`type`="tekton.dev/v1.TaskRun",`data`="{""kind"":""TaskRun"",""apiVersion"":""tekton.dev/v1"",""metadata"":{""name"":""taskrun"",""namespace"":""ns"",""uid"":""12345"",""creationTimestamp"":null,""labels"":{""x"":""foo""},""annotations"":{""x"":""foo""},""ownerReferences"":[{""apiVersion"":""v1"",""kind"":""test"",""name"":""test-owner"",""uid"":""42d0ed43-043a-455f-a53c-4be2b6aa6503""}]},""spec"":{""serviceAccountName"":"""",""taskSpec"":{""steps"":[{""name"":"""",""computeResources"":{},""script"":""echo hello world!""}]}},""status"":{""conditions"":[{""type"":""Succeeded"",""status"":""False"",""lastTransitionTime"":""2025-06-24T07:47:02Z"",""reason"":""Failed"",""message"":""Failed""}],""podName"":"""",""startTime"":""2025-06-24T07:47:02Z"",""completionTime"":""2025-06-24T07:47:03Z""}}",`created_time`="2025-06-24 07:47:01.339",`updated_time`="2025-06-24 07:47:03.548",`etag`="03d25a33-e6b0-4cbc-a213-99ba5849324b-1750751223548034115" WHERE `parent` = "ns" AND `result_id` = "b13765e3-7f0e-429c-a8be-22f7d75239e4" AND `id` = "03d25a33-e6b0-4cbc-a213-99ba5849324b"
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/results.go:208
[0m[33m[0.732ms] [34;1m[rows:1][0m SELECT * FROM `results` WHERE `results`.`parent` = "ns" AND `results`.`name` = "12345" ORDER BY `results`.`id` LIMIT 1
logger.go:146: 2025-06-24T07:47:03.599Z DEBUG TestReconcile_TaskRun results/results.go:202 No further actions to be done on the Result: the object is not a top level record {"results.tekton.dev/result": "ns/results/12345", "results.tekton.dev/record": "ns/results/12345/records/12345", "results.tekton.dev/top-level-record": false}
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:135
[0m[33m[0.521ms] [34;1m[rows:1][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "539b2a79-5170-335f-a97c-1a2f595ceefc" ORDER BY `records`.`id` LIMIT 1
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/results.go:208
... skipping 57 lines ...
[0m[33m[0.500ms] [34;1m[rows:0][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "7970066c-497d-345c-ae57-4d801a38639b" ORDER BY `records`.`id` LIMIT 1
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:102
[0m[33m[0.354ms] [34;1m[rows:1][0m SELECT `results`.`name`,`results`.`id` FROM `results` WHERE `results`.`parent` = "ns" AND `results`.`name` = "12345" ORDER BY `results`.`id` LIMIT 1
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:82
[0m[33m[27.172ms] [34;1m[rows:1][0m INSERT INTO `records` (`parent`,`result_id`,`result_name`,`id`,`name`,`type`,`data`,`etag`,`created_time`,`updated_time`) VALUES ("ns","f5abd2a3-27b0-4e3e-bd8f-4898628f3d07","12345","020263ab-fb02-4114-9609-992df0840d42","7970066c-497d-345c-ae57-4d801a38639b","results.tekton.dev/v1alpha3.Log","{""kind"":""Log"",""apiVersion"":""results.tekton.dev/v1alpha3"",""metadata"":{""name"":""pipelinerun-log"",""namespace"":""ns"",""uid"":""7970066c-497d-345c-ae57-4d801a38639b"",""creationTimestamp"":null},""spec"":{""resource"":{""kind"":""PipelineRun"",""namespace"":""ns"",""name"":""pipelinerun"",""uid"":""12345""},""type"":""File""},""status"":{""size"":0,""isStored"":false,""errorOnStoreMsg"":"""",""isRetryableErr"":false}}","020263ab-fb02-4114-9609-992df0840d42-1750751223731878418","2025-06-24 07:47:03.731","2025-06-24 07:47:03.731") RETURNING `created_time`,`updated_time`
logger.go:146: 2025-06-24T07:47:03.764Z DEBUG TestReconcile_PipelineRun dynamic/dynamic.go:472 Streaming log started {"namespace": "ns", "kind": "PipelineRun", "name": "pipelinerun"}
logger.go:146: 2025-06-24T07:47:03.765Z ERROR TestReconcile_PipelineRun dynamic/dynamic.go:480 Error streaming log {"namespace": "ns", "kind": "PipelineRun", "name": "pipelinerun", "error": "failed to create tkn reader: Parsing kubeconfig failed: invalid configuration: no configuration has been provided, try setting KUBERNETES_MASTER environment variable"}
logger.go:146: 2025-06-24T07:47:03.765Z INFO TestReconcile_PipelineRun dynamic/dynamic.go:488 Streaming log completed {"namespace": "ns", "kind": "PipelineRun", "name": "pipelinerun"}
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/results.go:208
[0m[33m[0.660ms] [34;1m[rows:1][0m SELECT * FROM `results` WHERE `results`.`parent` = "ns" AND `results`.`name` = "12345" ORDER BY `results`.`id` LIMIT 1
logger.go:146: 2025-06-24T07:47:03.768Z DEBUG TestReconcile_PipelineRun results/results.go:210 No further actions to be done on the Result: no differences found {"results.tekton.dev/result": "ns/results/12345", "results.tekton.dev/record": "ns/results/12345/records/12345", "results.tekton.dev/top-level-record": true}
db.go:69: [31;1m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:135 [35;1mrecord not found
[0m[33m[0.474ms] [34;1m[rows:0][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "556cca56-457b-33f5-bcb2-812bafaee2ba" ORDER BY `records`.`id` LIMIT 1
... skipping 46 lines ...
=== RUN TestFinalize
=== RUN TestFinalize/pipelinerun_still_running_-_skip_finalization
logger.go:146: 2025-06-24T07:47:00.333Z DEBUG pipelinerun test-ns/test-pr is still running
=== RUN TestFinalize/store_deadline_passed_-_proceed_with_deletion
logger.go:146: 2025-06-24T07:47:00.333Z DEBUG store deadline: 2025-06-24 06:47:00.332992453 +0000 UTC now: 2025-06-24 07:47:00.333529859 +0000 UTC, completion time: 2025-06-24 05:47:00.332992453 +0000 UTC
logger.go:146: 2025-06-24T07:47:00.333Z DEBUG store deadline has passed for pipelinerun test-ns/test-pr
logger.go:146: 2025-06-24T07:47:00.333Z ERROR pipelinerun not stored: test-ns/test-pr, uid: ,
=== RUN TestFinalize/missing_annotations_-_requeue
logger.go:146: 2025-06-24T07:47:00.334Z DEBUG pipelinerun test-ns/test-pr annotations are missing, now: 2025-06-24 07:47:00.334012052 +0000 UTC, storeDeadline: 2025-06-24 08:47:00.332993517 +0000 UTC
=== RUN TestFinalize/stored_annotation_missing_-_requeue
logger.go:146: 2025-06-24T07:47:00.334Z DEBUG stored annotation is missing on pipelinerun test-ns/test-pr, now: 2025-06-24 07:47:00.334601411 +0000 UTC, storeDeadline: 2025-06-24 08:47:00.332993985 +0000 UTC
=== RUN TestFinalize/stored_annotation_not_true_-_requeue
logger.go:146: 2025-06-24T07:47:00.335Z DEBUG stored annotation is not true on pipelinerun test-ns/test-pr, now: 2025-06-24 07:47:00.335092754 +0000 UTC, storeDeadline: 2025-06-24 08:47:00.332994311 +0000 UTC
... skipping 16 lines ...
=== RUN TestFinalize
=== RUN TestFinalize/taskrun_still_running_-_skip_finalization
logger.go:146: 2025-06-24T07:47:00.328Z DEBUG taskrun test-ns/test-pr is still running
=== RUN TestFinalize/store_deadline_passed_-_proceed_with_deletion
logger.go:146: 2025-06-24T07:47:00.328Z DEBUG store deadline: 2025-06-24 06:47:00.327945053 +0000 UTC now: 2025-06-24 07:47:00.328875165 +0000 UTC, completion time: 2025-06-24 05:47:00.327945053 +0000 UTC
logger.go:146: 2025-06-24T07:47:00.329Z DEBUG store deadline has passed for taskrun test-ns/test-pr
logger.go:146: 2025-06-24T07:47:00.329Z ERROR taskrun not stored: test-ns/test-pr, uid: ,
=== RUN TestFinalize/missing_annotations_-_requeue
logger.go:146: 2025-06-24T07:47:00.329Z DEBUG taskrun test-ns/test-pr annotations are missing, now: 2025-06-24 07:47:00.329470978 +0000 UTC, storeDeadline: 2025-06-24 08:47:00.327945812 +0000 UTC
=== RUN TestFinalize/stored_annotation_missing_-_requeue
logger.go:146: 2025-06-24T07:47:00.329Z DEBUG stored annotation is missing on taskrun test-ns/test-pr, now: 2025-06-24 07:47:00.329869929 +0000 UTC, storeDeadline: 2025-06-24 08:47:00.327946261 +0000 UTC
=== RUN TestFinalize/stored_annotation_not_true_-_requeue
logger.go:146: 2025-06-24T07:47:00.330Z DEBUG stored annotation is not true on taskrun test-ns/test-pr, now: 2025-06-24 07:47:00.330202559 +0000 UTC, storeDeadline: 2025-06-24 08:47:00.327946864 +0000 UTC
... skipping 367 lines ...
--- PASS: TestPut/pipelinerun/update (0.01s)
PASS
ok github.com/tektoncd/results/pkg/watcher/results 5.507s
testing: warning: no tests to run
PASS
ok github.com/tektoncd/results/tools/postgres-migrate 1.137s [no tests to run]
FAIL
unit_tests returning
===========================
==== UNIT TESTS FAILED ====
===========================
+ EXIT_VALUE=1
+ set +o xtrace
