Error lines from build-log.txt
... skipping 77 lines ...
============================
==== RUNNING UNIT TESTS ====
============================
/home/prow/go/src/github.com/tektoncd/results /home/prow/go/src/github.com/tektoncd/results
Using overridden unit_tests
? github.com/tektoncd/results/cmd/cli-docs [no test files]
2025/08/12 07:25:04 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 26 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 (0.04s)
--- PASS: TestParseFilter/success (0.03s)
--- PASS: TestParseFilter/success/#00 (0.00s)
--- PASS: TestParseFilter/success/result (0.01s)
--- PASS: TestParseFilter/success/result.id (0.01s)
--- PASS: TestParseFilter/success/result.id_==_"1" (0.00s)
--- PASS: TestParseFilter/success/result.id_==_"1"_||_result.name_==_"2" (0.00s)
--- PASS: TestParseFilter/success/result.id.startsWith("tacocat") (0.01s)
--- PASS: TestParseFilter/error (0.00s)
--- PASS: TestParseFilter/error/asdf (0.00s)
--- 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 1.128s
=== RUN TestConvertRecordExpressions
=== RUN TestConvertRecordExpressions/simple_expression
convert_test.go:170: want: (name = 'foo')
convert_test.go:171: got: (name = 'foo')
... skipping 363 lines ...
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/logs.go:352
[0m[33m[0.842ms] [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":1754983577.5160322,"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 (1.79s)
--- PASS: TestListLogs/all (0.12s)
--- PASS: TestListLogs/list_all_records_without_knowing_the_result_name (0.06s)
--- PASS: TestListLogs/list_all_records_without_knowing_the_parent_and_the_result_name (0.06s)
... 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.282ms] [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[0.514ms] [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-1754983575997452879","2025-08-12 07:26:15.997","2025-08-12 07:26:15.997") RETURNING `created_time`,`updated_time`
--- PASS: TestCreateRecord (0.13s)
--- PASS: TestCreateRecord/success (0.02s)
--- 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.174ms] [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[13.395ms] [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[18.623ms] [34;1m[rows:0][0m CREATE UNIQUE INDEX `records_by_name` ON `records`(`parent`,`result_name`,`name`)
{"level":"warn","ts":1754983581.308293,"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[5.326ms] [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-1754983575997452879","2025-08-12 07:26:15.997","2025-08-12 07:26:15.997") RETURNING `created_time`,`updated_time`
--- PASS: TestCreateRecord_ConcurrentDelete (0.09s)
=== RUN TestGetRecord
records_test.go:185: test database: /tmp/testdb1810434581
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/test/db.go:59
[0m[33m[0.035ms] [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[1.853ms] [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[1.391ms] [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-1754983600997452879","2025-08-12 07:26:40.997","2025-08-12 07:26:40.997") RETURNING `created_time`,`updated_time`
=== RUN TestCreateResult/large_name
=== RUN TestCreateResult/large_result_summary_type
--- PASS: TestCreateResult (0.56s)
--- PASS: TestCreateResult/success (0.10s)
--- 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 (5.62s)
PASS
ok github.com/tektoncd/results/pkg/api/server/v1alpha2/plugin 8.073s
=== 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/08/12 07:26:14 failed to evaluate the expression: no such attribute(s): record
--- PASS: TestMatch (0.07s)
--- PASS: TestMatch/no_filter (0.00s)
--- PASS: TestMatch/matching_condition (0.05s)
--- PASS: TestMatch/non-matching_condition (0.00s)
--- PASS: TestMatch/nil_result (0.00s)
--- PASS: TestMatch/non-bool_output (0.00s)
... skipping 29 lines ...
--- PASS: TestSend/successful_request (0.01s)
PASS
ok github.com/tektoncd/results/pkg/cli/client 1.140s
=== RUN TestListRecords
=== RUN TestListRecords/successful_list
=== RUN TestListRecords/error_response
2025/08/12 07:26:14 RoundTripper returned a response & error; ignoring response
--- PASS: TestListRecords (0.01s)
--- PASS: TestListRecords/successful_list (0.00s)
--- PASS: TestListRecords/error_response (0.00s)
PASS
ok github.com/tektoncd/results/pkg/cli/client/records 1.130s
=== RUN TestPrintProto
... skipping 159 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 22 lines ...
--- PASS: TestSet (0.03s)
=== RUN TestReset
--- PASS: TestReset (0.05s)
=== RUN TestLoadClientConfig
--- PASS: TestLoadClientConfig (0.03s)
=== RUN TestSetWithPrompt
[0G[2K[0;1;92m? [0m[0;1;99mHost : [0m[?25l[?25l7[999;999f[6n8[?25h[6n[?25h config_test.go:378: Received expected error when prompting for user input in test environment
--- PASS: TestSetWithPrompt (0.02s)
=== RUN TestPersist
--- PASS: TestPersist (0.21s)
=== RUN TestSetVersion
--- PASS: TestSetVersion (0.02s)
=== RUN TestHost
... skipping 5 lines ...
--- PASS: TestHost/basic_host_detection (0.05s)
--- PASS: TestHost/invalid_config (0.11s)
=== RUN TestToken
=== RUN TestToken/config_with_bearer_token
=== RUN TestToken/config_without_bearer_token
=== RUN TestToken/config_with_nil_RESTConfig
config_test.go:649: should return error when RESTConfig is nil: Token() returned expected error: REST configuration is not initialized
--- PASS: TestToken (0.02s)
--- PASS: TestToken/config_with_bearer_token (0.01s)
--- PASS: TestToken/config_without_bearer_token (0.00s)
--- PASS: TestToken/config_with_nil_RESTConfig (0.00s)
=== RUN TestExtensionDeepCopy
--- PASS: TestExtensionDeepCopy (0.00s)
... skipping 320 lines ...
[0m[33m[0.502ms] [34;1m[rows:1][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "pr-id" AND `records`.`name` = "pr-id" ORDER BY `records`.`id` LIMIT 1
=== 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-08-12T07:26:55.052Z 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-08-12T07:26:55.052Z 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-08-12T07:26:55.053Z DEBUG TestController dynamic/dynamic.go:152 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": "82492d4f-a75f-476a-934a-5462d8f8f250", "knative.dev/key": "ns/pr", "results.tekton.dev/kind": "PipelineRun", "error": "rpc error: code = Unavailable desc = error reading from server: EOF", "results.tekton.dev/time-taken-ms": 24}
logger.go:146: 2025-08-12T07:26:55.053Z 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": "82492d4f-a75f-476a-934a-5462d8f8f250", "knative.dev/key": "ns/pr", "results.tekton.dev/kind": "PipelineRun"}
logger.go:146: 2025-08-12T07:26:55.053Z 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": "82492d4f-a75f-476a-934a-5462d8f8f250", "knative.dev/key": "ns/pr", "targetMethod": "ReconcileKind", "error": "error upserting record: rpc error: code = Unavailable desc = error reading from server: EOF"}
logger.go:146: 2025-08-12T07:26:55.053Z 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": "82492d4f-a75f-476a-934a-5462d8f8f250", "knative.dev/key": "ns/pr", "duration": "25.79221ms", "error": "error upserting record: rpc error: code = Unavailable desc = error reading from server: EOF"}
logger.go:146: 2025-08-12T07:26:55.054Z DEBUG TestController controller/controller.go:511 Processing from queue ns/pr (depth: 0) {"knative.dev/controller": "github.com.tektoncd.results.pkg.watcher.reconciler.pipelinerun.Reconciler", "knative.dev/kind": "tekton.dev.PipelineRun"}
logger.go:146: 2025-08-12T07:26:55.054Z INFO TestController pipelinerun/reconciler.go:67 Initiating reconciliation for PipelineRun 'ns/pr' {"knative.dev/controller": "github.com.tektoncd.results.pkg.watcher.reconciler.pipelinerun.Reconciler", "knative.dev/kind": "tekton.dev.PipelineRun", "knative.dev/traceid": "4f1343f6-cd7b-4f0e-a825-740a27c27b60", "knative.dev/key": "ns/pr", "results.tekton.dev/kind": "PipelineRun"}
logger.go:146: 2025-08-12T07:26:55.054Z DEBUG TestController dynamic/dynamic.go:152 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": "4f1343f6-cd7b-4f0e-a825-740a27c27b60", "knative.dev/key": "ns/pr", "results.tekton.dev/kind": "PipelineRun", "error": "rpc error: code = Canceled desc = GetResult(ns/results/pr-id): rpc error: code = Canceled desc = grpc: the client connection is closing", "results.tekton.dev/time-taken-ms": 0}
logger.go:146: 2025-08-12T07:26:55.055Z 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": "4f1343f6-cd7b-4f0e-a825-740a27c27b60", "knative.dev/key": "ns/pr", "results.tekton.dev/kind": "PipelineRun"}
logger.go:146: 2025-08-12T07:26:55.055Z 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": "4f1343f6-cd7b-4f0e-a825-740a27c27b60", "knative.dev/key": "ns/pr", "targetMethod": "ReconcileKind", "error": "error upserting record: rpc error: code = Canceled desc = GetResult(ns/results/pr-id): rpc error: code = Canceled desc = grpc: the client connection is closing"}
logger.go:146: 2025-08-12T07:26:55.055Z 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": "4f1343f6-cd7b-4f0e-a825-740a27c27b60", "knative.dev/key": "ns/pr", "duration": "965.3µs", "error": "error upserting record: rpc error: code = Canceled desc = GetResult(ns/results/pr-id): rpc error: code = Canceled desc = grpc: the client connection is closing"}
--- PASS: TestController (5.55s)
--- PASS: TestController/taskrun (2.00s)
--- PASS: TestController/pipelinerun (1.00s)
PASS
==================
WARNING: DATA RACE
... skipping 92 lines ...
google.golang.org/grpc.(*Server).handleStream(0xc000242800, {0x6f4b560, 0xc001108680}, 0xc001178480)
/home/prow/go/src/github.com/tektoncd/results/vendor/google.golang.org/grpc/server.go:1815 +0x139c
google.golang.org/grpc.(*Server).serveStreams.func2.1()
/home/prow/go/src/github.com/tektoncd/results/vendor/google.golang.org/grpc/server.go:1035 +0x159
created by google.golang.org/grpc.(*Server).serveStreams.func2 in goroutine 105
/home/prow/go/src/github.com/tektoncd/results/vendor/google.golang.org/grpc/server.go:1046 +0x225
FAIL github.com/tektoncd/results/pkg/watcher/reconciler 6.459s
=== 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.383ms] [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[344.152ms] [34;1m[rows:1][0m INSERT INTO `records` (`parent`,`result_id`,`result_name`,`id`,`name`,`type`,`data`,`etag`,`created_time`,`updated_time`) VALUES ("ns","19ea18fc-9783-4ada-8e29-e98d64352bd3","12345","42ab4a95-8652-42ff-873e-c142853e9fcc","0257723b-7c06-3d37-b09c-f8ad7b9474b8","results.tekton.dev/v1alpha3.Log","{""kind"":""Log"",""apiVersion"":""results.tekton.dev/v1alpha3"",""metadata"":{""name"":""taskrun-log"",""namespace"":""ns"",""uid"":""0257723b-7c06-3d37-b09c-f8ad7b9474b8"",""creationTimestamp"":null},""spec"":{""resource"":{""kind"":""TaskRun"",""namespace"":""ns"",""name"":""taskrun"",""uid"":""12345""},""type"":""File""},""status"":{""size"":0,""isStored"":false,""errorOnStoreMsg"":"""",""isRetryableErr"":false}}","42ab4a95-8652-42ff-873e-c142853e9fcc-1754983620408168105","2025-08-12 07:27:00.408","2025-08-12 07:27:00.408") RETURNING `created_time`,`updated_time`
logger.go:146: 2025-08-12T07:27:00.753Z DEBUG TestReconcile_TaskRun dynamic/dynamic.go:254 Skipping CRD annotation patch: annotation update is disabled
logger.go:146: 2025-08-12T07:27:00.754Z DEBUG TestReconcile_TaskRun dynamic/dynamic.go:437 Streaming log started
logger.go:146: 2025-08-12T07:27:00.754Z ERROR TestReconcile_TaskRun dynamic/dynamic.go:441 Error streaming log {"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-08-12T07:27:00.754Z INFO TestReconcile_TaskRun dynamic/dynamic.go:444 Streaming log completed
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/results.go:208
[0m[33m[0.605ms] [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-08-12T07:27:00.758Z 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.366ms] [34;1m[rows:0][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "7f806133-9617-3b7f-9139-554fab418145" 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.721ms] [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-08-12T07:27:01.496Z 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.560ms] [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.521ms] [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-08-12T07:27:01Z"",""reason"":""Failed"",""message"":""Failed""}],""podName"":"""",""startTime"":""2025-08-12T07:27:01Z"",""completionTime"":""2025-08-12T07:27:02Z""}}",`created_time`="2025-08-12 07:27:00.358",`updated_time`="2025-08-12 07:27:01.498",`etag`="24dc8c07-52b0-4624-96a2-9c3e37aa5810-1754983621498706685" WHERE `parent` = "ns" AND `result_id` = "19ea18fc-9783-4ada-8e29-e98d64352bd3" AND `id` = "24dc8c07-52b0-4624-96a2-9c3e37aa5810"
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/results.go:208
[0m[33m[0.477ms] [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-08-12T07:27:01.527Z 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.561ms] [34;1m[rows:1][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "0257723b-7c06-3d37-b09c-f8ad7b9474b8" 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.327ms] [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-08-12T07:27:01.583Z 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.920ms] [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.380ms] [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-08-12T07:27:01Z"",""reason"":""Failed"",""message"":""Failed""}],""podName"":"""",""startTime"":""2025-08-12T07:27:01Z"",""completionTime"":""2025-08-12T07:27:02Z""}}",`created_time`="2025-08-12 07:27:00.358",`updated_time`="2025-08-12 07:27:01.586",`etag`="24dc8c07-52b0-4624-96a2-9c3e37aa5810-1754983621586391644" WHERE `parent` = "ns" AND `result_id` = "19ea18fc-9783-4ada-8e29-e98d64352bd3" AND `id` = "24dc8c07-52b0-4624-96a2-9c3e37aa5810"
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/results.go:208
[0m[33m[0.442ms] [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-08-12T07:27:01.596Z 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.437ms] [34;1m[rows:1][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "0257723b-7c06-3d37-b09c-f8ad7b9474b8" 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.392ms] [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-08-12T07:27:01.680Z 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.495ms] [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.446ms] [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-08-12T07:27:01Z"",""reason"":""Failed"",""message"":""Failed""}],""podName"":"""",""startTime"":""2025-08-12T07:27:01Z"",""completionTime"":""2025-08-12T07:27:02Z""}}",`created_time`="2025-08-12 07:27:00.358",`updated_time`="2025-08-12 07:27:01.682",`etag`="24dc8c07-52b0-4624-96a2-9c3e37aa5810-1754983621682610103" WHERE `parent` = "ns" AND `result_id` = "19ea18fc-9783-4ada-8e29-e98d64352bd3" AND `id` = "24dc8c07-52b0-4624-96a2-9c3e37aa5810"
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/results.go:208
[0m[33m[0.684ms] [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-08-12T07:27:01.723Z 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.681ms] [34;1m[rows:1][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "0257723b-7c06-3d37-b09c-f8ad7b9474b8" 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.552ms] [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-08-12T07:27:01.750Z 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.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
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:217
[0m[33m[0.480ms] [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-08-12T07:27:01Z"",""reason"":""Failed"",""message"":""Failed""}],""podName"":"""",""startTime"":""2025-08-12T07:27:01Z"",""completionTime"":""2025-08-12T07:27:02Z""}}",`created_time`="2025-08-12 07:27:00.358",`updated_time`="2025-08-12 07:27:01.752",`etag`="24dc8c07-52b0-4624-96a2-9c3e37aa5810-1754983621752861242" WHERE `parent` = "ns" AND `result_id` = "19ea18fc-9783-4ada-8e29-e98d64352bd3" AND `id` = "24dc8c07-52b0-4624-96a2-9c3e37aa5810"
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/results.go:208
[0m[33m[0.527ms] [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-08-12T07:27:01.763Z 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.500ms] [34;1m[rows:1][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "0257723b-7c06-3d37-b09c-f8ad7b9474b8" 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.469ms] [34;1m[rows:0][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "fe21ed34-9482-48d8-bb75-8909b471e8b6" AND `records`.`name` = "12345" ORDER BY `records`.`id` LIMIT 1
logger.go:146: 2025-08-12T07:27:01.785Z DEBUG TestReconcile_TaskRun results/results.go:334 Record doesn't exist yet - creating {"results.tekton.dev/record": "ns/results/fe21ed34-9482-48d8-bb75-8909b471e8b6/records/12345"}
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/records.go:102
[0m[33m[0.367ms] [34;1m[rows:1][0m SELECT `results`.`name`,`results`.`id` FROM `results` WHERE `results`.`parent` = "ns" AND `results`.`name` = "fe21ed34-9482-48d8-bb75-8909b471e8b6" 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[6.633ms] [34;1m[rows:1][0m INSERT INTO `records` (`parent`,`result_id`,`result_name`,`id`,`name`,`type`,`data`,`etag`,`created_time`,`updated_time`) VALUES ("ns","62bb0aa8-d545-4dcc-ab98-928f9258dd7c","fe21ed34-9482-48d8-bb75-8909b471e8b6","de97bc00-1b13-4d2a-97e2-2bec6601b86e","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"":""fe21ed34-9482-48d8-bb75-8909b471e8b6""}]},""spec"":{""serviceAccountName"":"""",""taskSpec"":{""steps"":[{""name"":"""",""computeResources"":{},""script"":""echo hello world!""}]}},""status"":{""conditions"":[{""type"":""Succeeded"",""status"":""False"",""lastTransitionTime"":""2025-08-12T07:27:01Z"",""reason"":""Failed"",""message"":""Failed""}],""podName"":"""",""startTime"":""2025-08-12T07:27:01Z"",""completionTime"":""2025-08-12T07:27:02Z""}}","de97bc00-1b13-4d2a-97e2-2bec6601b86e-1754983621787072992","2025-08-12 07:27:01.787","2025-08-12 07:27:01.787") 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.532ms] [34;1m[rows:1][0m SELECT * FROM `results` WHERE `results`.`parent` = "ns" AND `results`.`name` = "fe21ed34-9482-48d8-bb75-8909b471e8b6" ORDER BY `results`.`id` LIMIT 1
logger.go:146: 2025-08-12T07:27:01.797Z 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/fe21ed34-9482-48d8-bb75-8909b471e8b6", "results.tekton.dev/record": "ns/results/fe21ed34-9482-48d8-bb75-8909b471e8b6/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.287ms] [34;1m[rows:0][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "fe21ed34-9482-48d8-bb75-8909b471e8b6" AND `records`.`name` = "8245ecaf-d6c7-3ce1-8792-3a7e4c5001dc" 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.389ms] [34;1m[rows:0][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "fe21ed34-9482-48d8-bb75-8909b471e8b6" AND `records`.`name` = "8245ecaf-d6c7-3ce1-8792-3a7e4c5001dc" 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.513ms] [34;1m[rows:1][0m SELECT `results`.`name`,`results`.`id` FROM `results` WHERE `results`.`parent` = "ns" AND `results`.`name` = "fe21ed34-9482-48d8-bb75-8909b471e8b6" 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[7.091ms] [34;1m[rows:1][0m INSERT INTO `records` (`parent`,`result_id`,`result_name`,`id`,`name`,`type`,`data`,`etag`,`created_time`,`updated_time`) VALUES ("ns","62bb0aa8-d545-4dcc-ab98-928f9258dd7c","fe21ed34-9482-48d8-bb75-8909b471e8b6","7f69134a-c051-49ff-a0fa-5af852246c63","8245ecaf-d6c7-3ce1-8792-3a7e4c5001dc","results.tekton.dev/v1alpha3.Log","{""kind"":""Log"",""apiVersion"":""results.tekton.dev/v1alpha3"",""metadata"":{""name"":""taskrun-log"",""namespace"":""ns"",""uid"":""8245ecaf-d6c7-3ce1-8792-3a7e4c5001dc"",""creationTimestamp"":null},""spec"":{""resource"":{""kind"":""TaskRun"",""namespace"":""ns"",""name"":""taskrun"",""uid"":""12345""},""type"":""File""},""status"":{""size"":0,""isStored"":false,""errorOnStoreMsg"":"""",""isRetryableErr"":false}}","7f69134a-c051-49ff-a0fa-5af852246c63-1754983621804276812","2025-08-12 07:27:01.804","2025-08-12 07:27:01.804") RETURNING `created_time`,`updated_time`
logger.go:146: 2025-08-12T07:27:01.815Z DEBUG TestReconcile_TaskRun dynamic/dynamic.go:437 Streaming log started
logger.go:146: 2025-08-12T07:27:01.815Z ERROR TestReconcile_TaskRun dynamic/dynamic.go:441 Error streaming log {"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-08-12T07:27:01.815Z INFO TestReconcile_TaskRun dynamic/dynamic.go:444 Streaming log completed
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/results.go:208
[0m[33m[0.543ms] [34;1m[rows:1][0m SELECT * FROM `results` WHERE `results`.`parent` = "ns" AND `results`.`name` = "fe21ed34-9482-48d8-bb75-8909b471e8b6" ORDER BY `results`.`id` LIMIT 1
logger.go:146: 2025-08-12T07:27:01.818Z 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/fe21ed34-9482-48d8-bb75-8909b471e8b6", "results.tekton.dev/record": "ns/results/fe21ed34-9482-48d8-bb75-8909b471e8b6/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.299ms] [34;1m[rows:0][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "fe21ed34-9482-48d8-bb75-8909b471e8b6" AND `records`.`name` = "5d6b62ac-7d21-38b4-832b-5228f7aac25a" 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.523ms] [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-08-12T07:27:01.848Z 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.450ms] [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.477ms] [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"":""e79c12e9-06c6-4391-8c89-e47fbf1035f2""}]},""spec"":{""serviceAccountName"":"""",""taskSpec"":{""steps"":[{""name"":"""",""computeResources"":{},""script"":""echo hello world!""}]}},""status"":{""conditions"":[{""type"":""Succeeded"",""status"":""False"",""lastTransitionTime"":""2025-08-12T07:27:01Z"",""reason"":""Failed"",""message"":""Failed""}],""podName"":"""",""startTime"":""2025-08-12T07:27:01Z"",""completionTime"":""2025-08-12T07:27:02Z""}}",`created_time`="2025-08-12 07:27:00.358",`updated_time`="2025-08-12 07:27:01.85",`etag`="24dc8c07-52b0-4624-96a2-9c3e37aa5810-1754983621850232921" WHERE `parent` = "ns" AND `result_id` = "19ea18fc-9783-4ada-8e29-e98d64352bd3" AND `id` = "24dc8c07-52b0-4624-96a2-9c3e37aa5810"
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/results.go:208
[0m[33m[0.577ms] [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-08-12T07:27:01.858Z 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.500ms] [34;1m[rows:1][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "0257723b-7c06-3d37-b09c-f8ad7b9474b8" 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.250ms] [34;1m[rows:0][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "c940d78e-f88f-34e4-bbbe-07f3fc22585a" 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.441ms] [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[10.560ms] [34;1m[rows:1][0m INSERT INTO `records` (`parent`,`result_id`,`result_name`,`id`,`name`,`type`,`data`,`etag`,`created_time`,`updated_time`) VALUES ("ns","87c72ff7-b5f6-48d2-b48c-9b2a8b2988f9","12345","ec1d4810-e816-471e-ad6f-b0a64c4d80bf","c940d78e-f88f-34e4-bbbe-07f3fc22585a","results.tekton.dev/v1alpha3.Log","{""kind"":""Log"",""apiVersion"":""results.tekton.dev/v1alpha3"",""metadata"":{""name"":""pipelinerun-log"",""namespace"":""ns"",""uid"":""c940d78e-f88f-34e4-bbbe-07f3fc22585a"",""creationTimestamp"":null},""spec"":{""resource"":{""kind"":""PipelineRun"",""namespace"":""ns"",""name"":""pipelinerun"",""uid"":""12345""},""type"":""File""},""status"":{""size"":0,""isStored"":false,""errorOnStoreMsg"":"""",""isRetryableErr"":false}}","ec1d4810-e816-471e-ad6f-b0a64c4d80bf-1754983622070767480","2025-08-12 07:27:02.07","2025-08-12 07:27:02.07") RETURNING `created_time`,`updated_time`
logger.go:146: 2025-08-12T07:27:02.085Z DEBUG TestReconcile_PipelineRun dynamic/dynamic.go:437 Streaming log started
logger.go:146: 2025-08-12T07:27:02.086Z ERROR TestReconcile_PipelineRun dynamic/dynamic.go:441 Error streaming log {"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-08-12T07:27:02.086Z INFO TestReconcile_PipelineRun dynamic/dynamic.go:444 Streaming log completed
db.go:69: [32m/home/prow/go/src/github.com/tektoncd/results/pkg/api/server/v1alpha2/results.go:208
[0m[33m[0.444ms] [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-08-12T07:27:02.089Z 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.247ms] [34;1m[rows:0][0m SELECT * FROM `records` WHERE `records`.`parent` = "ns" AND `records`.`result_name` = "12345" AND `records`.`name` = "e2672b3f-4475-3c82-9138-9fdc787376d9" ORDER BY `records`.`id` LIMIT 1
... skipping 56 lines ...
=== RUN TestFinalize
=== RUN TestFinalize/pipelinerun_still_running_-_skip_finalization
logger.go:146: 2025-08-12T07:26:58.489Z DEBUG pipelinerun test-ns/test-pr is still running
=== RUN TestFinalize/store_deadline_passed_-_proceed_with_deletion
logger.go:146: 2025-08-12T07:26:58.489Z DEBUG store deadline: 2025-08-12 06:26:58.489017253 +0000 UTC now: 2025-08-12 07:26:58.489398083 +0000 UTC, completion time: 2025-08-12 05:26:58.489017253 +0000 UTC
logger.go:146: 2025-08-12T07:26:58.489Z DEBUG store deadline has passed for pipelinerun test-ns/test-pr
logger.go:146: 2025-08-12T07:26:58.489Z ERROR pipelinerun not stored: test-ns/test-pr, uid: ,
=== RUN TestFinalize/missing_annotations_-_requeue
logger.go:146: 2025-08-12T07:26:58.489Z DEBUG pipelinerun test-ns/test-pr annotations are missing, now: 2025-08-12 07:26:58.489823373 +0000 UTC, storeDeadline: 2025-08-12 08:26:58.489018093 +0000 UTC
=== RUN TestFinalize/stored_annotation_missing_-_requeue
logger.go:146: 2025-08-12T07:26:58.490Z DEBUG stored annotation is missing on pipelinerun test-ns/test-pr, now: 2025-08-12 07:26:58.490049703 +0000 UTC, storeDeadline: 2025-08-12 08:26:58.489018493 +0000 UTC
=== RUN TestFinalize/stored_annotation_not_true_-_requeue
logger.go:146: 2025-08-12T07:26:58.490Z DEBUG stored annotation is not true on pipelinerun test-ns/test-pr, now: 2025-08-12 07:26:58.490265953 +0000 UTC, storeDeadline: 2025-08-12 08:26:58.489018703 +0000 UTC
... skipping 24 lines ...
=== RUN TestFinalize
=== RUN TestFinalize/taskrun_still_running_-_skip_finalization
logger.go:146: 2025-08-12T07:26:58.488Z DEBUG taskrun test-ns/test-pr is still running
=== RUN TestFinalize/store_deadline_passed_-_proceed_with_deletion
logger.go:146: 2025-08-12T07:26:58.488Z DEBUG store deadline: 2025-08-12 06:26:58.488059863 +0000 UTC now: 2025-08-12 07:26:58.488552453 +0000 UTC, completion time: 2025-08-12 05:26:58.488059863 +0000 UTC
logger.go:146: 2025-08-12T07:26:58.488Z DEBUG store deadline has passed for taskrun test-ns/test-pr
logger.go:146: 2025-08-12T07:26:58.488Z ERROR taskrun not stored: test-ns/test-pr, uid: ,
=== RUN TestFinalize/missing_annotations_-_requeue
logger.go:146: 2025-08-12T07:26:58.489Z DEBUG taskrun test-ns/test-pr annotations are missing, now: 2025-08-12 07:26:58.489063563 +0000 UTC, storeDeadline: 2025-08-12 08:26:58.488060383 +0000 UTC
=== RUN TestFinalize/stored_annotation_missing_-_requeue
logger.go:146: 2025-08-12T07:26:58.489Z DEBUG stored annotation is missing on taskrun test-ns/test-pr, now: 2025-08-12 07:26:58.489305523 +0000 UTC, storeDeadline: 2025-08-12 08:26:58.488067023 +0000 UTC
=== RUN TestFinalize/stored_annotation_not_true_-_requeue
logger.go:146: 2025-08-12T07:26:58.489Z DEBUG stored annotation is not true on taskrun test-ns/test-pr, now: 2025-08-12 07:26:58.489540733 +0000 UTC, storeDeadline: 2025-08-12 08:26:58.488067253 +0000 UTC
... skipping 367 lines ...
--- PASS: TestPut/pipelinerun/update (0.01s)
PASS
ok github.com/tektoncd/results/pkg/watcher/results 5.307s
testing: warning: no tests to run
PASS
ok github.com/tektoncd/results/tools/postgres-migrate 1.070s [no tests to run]
FAIL
unit_tests returning
===========================
==== UNIT TESTS FAILED ====
===========================
+ EXIT_VALUE=1
+ set +o xtrace
