[12:54:16.922] New invocation is queued and will start shortly
[12:54:18.078] Starting the invocation (attempt 1)
[12:54:18.135] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:54:18.135] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:54:18.135] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027452681901323808",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"9d7beb96f1e8af4fd1b1155ec17a7c6740ab2859\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9027452681901323808",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/9d7beb96f1e8af4fd1b1155ec17a7c6740ab2859",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9d7beb96f1e8af4fd1b1155ec17a7c6740ab2859",
"gitiles_ref:refs/heads/master"
]
}
[12:54:19.489] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606913658302767",
"id": "8862022619790679488",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9d7beb96f1e8af4fd1b1155ec17a7c6740ab2859\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606913659127696",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43377",
"builder:linux-chromeos-rel",
"buildset:commit/git/9d7beb96f1e8af4fd1b1155ec17a7c6740ab2859",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9d7beb96f1e8af4fd1b1155ec17a7c6740ab2859",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027452681901323808",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8862022619790679488/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1606913659127911",
"url": "https://ci.chromium.org/b/8862022619790679488",
"utcnow_ts": "1606913659476471"
}
}
[12:54:19.489] Task URL: https://ci.chromium.org/b/8862022619790679488
[12:54:19.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:2:0) after 1m0s
[12:54:32.024] Received PubSub notification, asking Buildbucket for the build status
[12:54:32.119] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:19.591] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:2:0)
[12:55:19.591] Timer tick, asking Buildbucket for the build status
[12:55:19.682] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:19.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:4:0) after 1m0s
[12:56:19.754] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:4:0)
[12:56:19.754] Timer tick, asking Buildbucket for the build status
[12:56:20.461] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:20.461] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:5:0) after 1m0s
[12:57:20.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:5:0)
[12:57:20.555] Timer tick, asking Buildbucket for the build status
[12:57:20.672] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:20.672] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:6:0) after 1m0s
[12:58:21.835] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:6:0)
[12:58:21.835] Timer tick, asking Buildbucket for the build status
[12:58:21.939] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:21.939] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:7:0) after 1m0s
[12:59:23.451] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:7:0)
[12:59:23.451] Timer tick, asking Buildbucket for the build status
[12:59:23.557] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:23.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:8:0) after 1m0s
[13:00:23.647] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:8:0)
[13:00:23.647] Timer tick, asking Buildbucket for the build status
[13:00:24.609] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:24.610] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:9:0) after 1m0s
[13:01:24.731] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:9:0)
[13:01:24.731] Timer tick, asking Buildbucket for the build status
[13:01:24.876] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:24.876] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:10:0) after 1m0s
[13:02:24.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:10:0)
[13:02:24.910] Timer tick, asking Buildbucket for the build status
[13:02:25.186] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:25.186] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:11:0) after 1m0s
[13:03:25.264] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:11:0)
[13:03:25.264] Timer tick, asking Buildbucket for the build status
[13:03:25.326] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:25.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:12:0) after 1m0s
[13:04:25.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:12:0)
[13:04:25.327] Timer tick, asking Buildbucket for the build status
[13:04:25.444] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:25.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:13:0) after 1m0s
[13:05:25.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:13:0)
[13:05:25.514] Timer tick, asking Buildbucket for the build status
[13:05:25.602] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:25.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:14:0) after 1m0s
[13:06:25.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:14:0)
[13:06:25.617] Timer tick, asking Buildbucket for the build status
[13:06:26.044] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:26.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:15:0) after 1m0s
[13:07:26.080] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:15:0)
[13:07:26.080] Timer tick, asking Buildbucket for the build status
[13:07:26.161] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:26.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:16:0) after 1m0s
[13:08:26.189] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:16:0)
[13:08:26.189] Timer tick, asking Buildbucket for the build status
[13:08:26.475] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:26.475] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:17:0) after 1m0s
[13:09:26.677] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:17:0)
[13:09:26.677] Timer tick, asking Buildbucket for the build status
[13:09:26.783] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:26.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:18:0) after 1m0s
[13:10:26.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:18:0)
[13:10:26.784] Timer tick, asking Buildbucket for the build status
[13:10:26.957] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:26.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:19:0) after 1m0s
[13:11:26.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:19:0)
[13:11:26.975] Timer tick, asking Buildbucket for the build status
[13:11:27.030] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:27.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:20:0) after 1m0s
[13:12:27.101] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:20:0)
[13:12:27.101] Timer tick, asking Buildbucket for the build status
[13:12:27.177] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:27.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:21:0) after 1m0s
[13:13:27.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:21:0)
[13:13:27.237] Timer tick, asking Buildbucket for the build status
[13:13:27.306] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:27.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:22:0) after 1m0s
[13:14:27.445] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:22:0)
[13:14:27.445] Timer tick, asking Buildbucket for the build status
[13:14:27.578] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:27.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:23:0) after 1m0s
[13:15:27.652] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:23:0)
[13:15:27.652] Timer tick, asking Buildbucket for the build status
[13:15:27.907] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:27.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:24:0) after 1m0s
[13:16:28.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:24:0)
[13:16:28.015] Timer tick, asking Buildbucket for the build status
[13:16:28.129] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:28.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:25:0) after 1m0s
[13:17:28.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:25:0)
[13:17:28.236] Timer tick, asking Buildbucket for the build status
[13:17:29.313] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:29.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:26:0) after 1m0s
[13:18:29.359] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:26:0)
[13:18:29.359] Timer tick, asking Buildbucket for the build status
[13:18:29.425] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:29.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:27:0) after 1m0s
[13:19:29.463] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:27:0)
[13:19:29.463] Timer tick, asking Buildbucket for the build status
[13:19:29.659] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:29.659] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:28:0) after 1m0s
[13:20:29.755] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:28:0)
[13:20:29.755] Timer tick, asking Buildbucket for the build status
[13:20:29.952] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:29.952] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:29:0) after 1m0s
[13:21:29.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:29:0)
[13:21:29.974] Timer tick, asking Buildbucket for the build status
[13:21:30.038] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:30.038] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:30:0) after 1m0s
[13:22:30.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:30:0)
[13:22:30.037] Timer tick, asking Buildbucket for the build status
[13:22:30.141] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:30.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:31:0) after 1m0s
[13:23:30.164] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:31:0)
[13:23:30.164] Timer tick, asking Buildbucket for the build status
[13:23:30.234] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:30.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:32:0) after 1m0s
[13:24:30.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:32:0)
[13:24:30.265] Timer tick, asking Buildbucket for the build status
[13:24:30.377] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:30.377] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:33:0) after 1m0s
[13:25:30.446] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:33:0)
[13:25:30.446] Timer tick, asking Buildbucket for the build status
[13:25:30.639] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:30.639] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:34:0) after 1m0s
[13:26:30.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:34:0)
[13:26:30.712] Timer tick, asking Buildbucket for the build status
[13:26:30.785] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:30.785] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:35:0) after 1m0s
[13:27:30.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:35:0)
[13:27:30.838] Timer tick, asking Buildbucket for the build status
[13:27:34.024] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:34.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:36:0) after 1m0s
[13:28:34.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:36:0)
[13:28:34.064] Timer tick, asking Buildbucket for the build status
[13:28:34.162] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:34.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:37:0) after 1m0s
[13:29:34.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:37:0)
[13:29:34.230] Timer tick, asking Buildbucket for the build status
[13:29:34.414] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:34.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:38:0) after 1m0s
[13:30:34.415] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:38:0)
[13:30:34.416] Timer tick, asking Buildbucket for the build status
[13:30:34.582] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:34.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:39:0) after 1m0s
[13:31:34.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:39:0)
[13:31:34.567] Timer tick, asking Buildbucket for the build status
[13:31:34.916] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:34.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:40:0) after 1m0s
[13:32:35.026] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:40:0)
[13:32:35.026] Timer tick, asking Buildbucket for the build status
[13:32:35.346] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:35.346] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:41:0) after 1m0s
[13:33:35.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:41:0)
[13:33:35.369] Timer tick, asking Buildbucket for the build status
[13:33:35.844] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:35.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:42:0) after 1m0s
[13:34:35.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:42:0)
[13:34:35.882] Timer tick, asking Buildbucket for the build status
[13:34:36.376] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:36.376] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:43:0) after 1m0s
[13:35:36.463] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:43:0)
[13:35:36.463] Timer tick, asking Buildbucket for the build status
[13:35:36.629] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:36.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:44:0) after 1m0s
[13:36:36.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:44:0)
[13:36:36.698] Timer tick, asking Buildbucket for the build status
[13:36:36.859] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:36.859] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:45:0) after 1m0s
[13:37:36.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:45:0)
[13:37:36.928] Timer tick, asking Buildbucket for the build status
[13:37:37.052] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:37.052] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:46:0) after 1m0s
[13:38:37.115] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:46:0)
[13:38:37.115] Timer tick, asking Buildbucket for the build status
[13:38:37.342] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:37.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:47:0) after 1m0s
[13:39:37.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:47:0)
[13:39:37.476] Timer tick, asking Buildbucket for the build status
[13:39:37.775] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:37.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:48:0) after 1m0s
[13:40:38.002] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:48:0)
[13:40:38.002] Timer tick, asking Buildbucket for the build status
[13:40:38.652] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:38.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:49:0) after 1m0s
[13:41:38.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:49:0)
[13:41:38.698] Timer tick, asking Buildbucket for the build status
[13:41:38.850] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:38.850] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:50:0) after 1m0s
[13:42:39.101] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:50:0)
[13:42:39.101] Timer tick, asking Buildbucket for the build status
[13:42:39.266] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:39.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:51:0) after 1m0s
[13:43:39.545] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:51:0)
[13:43:39.545] Timer tick, asking Buildbucket for the build status
[13:43:39.728] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:39.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:52:0) after 1m0s
[13:44:39.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:52:0)
[13:44:39.806] Timer tick, asking Buildbucket for the build status
[13:44:40.263] Build 8862022619790679488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:40.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027452681901323808:53:0) after 1m0s
[13:45:37.578] Received PubSub notification, asking Buildbucket for the build status
[13:45:37.670] Build 8862022619790679488: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[13:45:37.670] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606916736007547",
"created_by": "project:chromium",
"created_ts": "1606913658302767",
"failure_reason": "BUILD_FAILURE",
"id": "8862022619790679488",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9d7beb96f1e8af4fd1b1155ec17a7c6740ab2859\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- TermsOfServiceDownloadTestInstance/TermsOfServiceDownloadTest.DeclineTermsOfService/1\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"9d7beb96f1e8af4fd1b1155ec17a7c6740ab2859\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-158-dnw9\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 43377, \"got_angle_revision\": \"0c47015b57a03230e0cab10532c3deed80604512\", \"got_dawn_revision\": \"bb913a94da4f22f7322a1e8a55295ac69c618ff4\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"9d7beb96f1e8af4fd1b1155ec17a7c6740ab2859\", \"got_revision_cp\": \"refs/heads/master@{#832779}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"bfb211914759cc5deffbe9419cd1c2cae0573488\", \"got_v8_revision\": \"b3456dd37acf448bb7e41b1dfc6eee5d28f38081\", \"got_v8_revision_cp\": \"refs/heads/8.9.75@{#1}\", \"got_webrtc_revision\": \"1afe2be9a9228e0b9d546a7dd9099584ed3fce4c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32737}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9d7beb96f1e8af4fd1b1155ec17a7c6740ab2859\", \"swarm_hashes_refs/heads/master(at){#832779}_without_patch\": {\"absl_hardening_tests\": \"ea7ac25d0df8a979c540cd65549426935fd9e609\", \"accessibility_unittests\": \"21bc3dd52b15bace039049959184cb0d4f90aa9a\", \"angle_unittests\": \"722219c11e90220a984cde75282c060e2233a807\", \"app_list_unittests\": \"b9a303efd500e55bdb716257c23eb8e441e8361c\", \"app_shell_unittests\": \"b753d21568f072a227c315a6e116a75675c5ff7b\", \"ash_unittests\": \"4b66ec4e6ebd572caa887b04cae5588d7f524349\", \"aura_unittests\": \"a27643714291526367b4ff6c1b1f9ef759100ca7\", \"base_unittests\": \"e8438045540e4841cd55870f208d3489342f572c\", \"base_util_unittests\": \"6cdb9baa4f9e58a844bfb5e5f026354623b11703\", \"blink_common_unittests\": \"75dd1aa7777b888804a7b200a908bcfab6b77dd2\", \"blink_fuzzer_unittests\": \"a717ccea4ef2ac0e4ebda20f401d26d619a03962\", \"blink_heap_unittests\": \"1aa7120c0347005e47892876bc8994bd0e9ff131\", \"blink_platform_unittests\": \"2bd48bec859139f0c14e994b5e2cfdd2e695e224\", \"blink_unittests\": \"36cbd4525e7e00aec38ff35f619f5514727bac51\", \"boringssl_crypto_tests\": \"7d9333463a09cd075d7d029c5d6ed234686aac12\", \"boringssl_ssl_tests\": \"2bd562d882c5bd5b658fb90e169d4c7a9aba7f2d\", \"browser_tests\": \"d8edb849235c4b3ded1082e0bc66ef3a180b2aba\", \"capture_unittests\": \"c24307973187e3193e6c307c701cc026a8b46d96\", \"cast_unittests\": \"79817099236405e50705d338392b40580f3f2803\", \"cc_unittests\": \"c20c1813fb50b3647c41e2f104cf5c1911f2a318\", \"chrome_app_unittests\": \"6cd1a94432f5518ee5c2e9fee1ea8ed36adbcc7d\", \"chromedriver_unittests\": \"c99a8ad780b6a4eca98081476e353ab46f9525be\", \"chromeos_components_unittests\": \"22c1042bc4c03fd18a9474be712b95fed234b97e\", \"chromeos_unittests\": \"2a614b9c471bdc1641211fe054a7900d916c7fda\", \"components_browsertests\": \"359dd01e5ebe92493acf6cac853b61499946830d\", \"components_unittests\": \"261fd8edd73e939d2c0000479e16abc366e6c5d1\", \"compositor_unittests\": \"7a4ff45a7b4aedac896daeaf30d3798e998989d3\", \"content_browsertests\": \"e72945f726725ca8b0da93e4eb55c07e0e14a334\", \"content_unittests\": \"da3a8ede32be2bd31837a0cd0627df641ae38b69\", \"crashpad_tests\": \"db775c662d21ace1d1d6485a0ce2c05d2d012056\", \"crypto_unittests\": \"05f3b6f37cc5868654d6cce6bd1b1c7b7fd24d0b\", \"dbus_unittests\": \"6285694f12d14dc8e8390385f750b70782dc5352\", \"device_unittests\": \"c9e289fbb1644b8ab3b28dd0263e5864154dd33f\", \"display_unittests\": \"fc80511fdfce54fdaf44f5debe0135bdd11ff079\", \"events_unittests\": \"62f6493fe19c704a2a35fc470ceb94ba719b7d73\", \"exo_unittests\": \"74215b0902b3f03f3e8aba17d8dfc61f2a5aad0a\", \"extensions_browsertests\": \"bb50803e57fa80ba77ff0ba04851fe125b9ecc54\", \"extensions_unittests\": \"b79e6560627f60e2c0645b7274f974f2090ec21a\", \"filesystem_service_unittests\": \"7df4310ff034e8d5f9d3d17cb40dfdf97f82cd2d\", \"gcm_unit_tests\": \"d544f946f010af98ebf3a503549e1ca1256915cf\", \"gfx_unittests\": \"be41ecf10c9e362e46bb8df1f29e5d14dfbb4111\", \"gin_unittests\": \"5659fd431327aa45a1a9b9d077c636ab57419a96\", \"gl_unittests_ozone\": \"2b1c67ad32b1b4e65c1261fb4d4155a4f965461e\", \"google_apis_unittests\": \"3ded25605938b4b0f29744d95679040103ce0c5d\", \"gpu_unittests\": \"e3e613d8f3974be3fee043f49ad738af940afa84\", \"gwp_asan_unittests\": \"7b6c0e48e0940b8ea047ccfce543b0d7442e07fd\", \"interactive_ui_tests\": \"1ef29ae9b0de1ef5c15df77359670730fba8759e\", \"ipc_tests\": \"efb1b1799e16f2dad36a8fba33f58a510893d08e\", \"jingle_unittests\": \"e03dc707e7c0b4996f86ca32781c01bfbd7d07a1\", \"keyboard_unittests\": \"ab202608fe8809ae35118f586f6ef91a7f2913fa\", \"latency_unittests\": \"512acbb04d72c128fc5724e4ee189494ba6b21f9\", \"libjingle_xmpp_unittests\": \"9d0f762eaf915b3283a1a30eb261bbd491666a2e\", \"liburlpattern_unittests\": \"b3fd567e31a8ef45e1140c136bc6b627e75226fb\", \"media_blink_unittests\": \"921d803be34b6aebee87ec1d104383f3725ac4ed\", \"media_unittests\": \"2c6d22c8067d70d3057f0f17ae3716d906dc62a3\", \"message_center_unittests\": \"3222f6a1896bcba86ee540ca7d45e035bb4f896d\", \"midi_unittests\": \"4cbb41501e110d0c1c34f0cbc2db18a2b8c4bd89\", \"mojo_core_unittests\": \"8f27826951ca7b7ff9b568ebe2b22377062d0345\", \"mojo_unittests\": \"9605df287e86f6535151b7d71a84000c1689e8f9\", \"nacl_helper_nonsfi_unittests\": \"ac0c97ccaa7af59a5214da9412cd5b605e621a4a\", \"nacl_loader_unittests\": \"6d23a967f36324152b7ffa7b28080b77bb25edfe\", \"native_theme_unittests\": \"a694c9be78f08cc8228c222fce6f467b8fef5b13\", \"net_unittests\": \"d0d31d33a936f2aa04cc7db82d6f4e76551ada26\", \"ozone_gl_unittests\": \"7180261597386e7f941dd2a41b285fe046165d91\", \"ozone_unittests\": \"8c9f798fc2de5ce770298057e559d803aa62c553\", \"ozone_x11_unittests\": \"40c86ccafa0af5cabdf92dd806d0170c4b907280\", \"pdf_unittests\": \"e403454969ce7ddcf6df990d642079d70fbcac21\", \"perfetto_unittests\": \"c5aca3a75f1d33aeaf5315d77f4ddb462c114313\", \"ppapi_unittests\": \"8b2bf625cdd36bb45607a536a753fd235c7fbe90\", \"printing_unittests\": \"d44669b8e15c8966b1e4beb6cc10ca47f8f3b274\", \"remoting_unittests\": \"4615f392fe0df7edb317eba9bfcc0d07f8a9a7d4\", \"sandbox_linux_unittests\": \"228f1f32a0533b9b110bc3a32638afc067f4bb1d\", \"service_manager_unittests\": \"7333016b3c1846dcc16d23d7fc18bca2f643f14e\", \"services_unittests\": \"3da1ad53ce072d7ab2d43daf05babc6844427489\", \"shell_dialogs_unittests\": \"44326def7f1323e74cea8fa1b77954fc2dc332bd\", \"shell_encryption_unittests\": \"b7cedf1e25df7cb2c898b314e651405338999304\", \"skia_unittests\": \"2a6da2a7276a705e1f9675e180a70aa3deffa4a6\", \"snapshot_unittests\": \"60dd51de4bfa835c84f4cc260c4f2a2bd5901aa8\", \"sql_unittests\": \"8025a378090834090245b84b2b5c542ba873ea08\", \"storage_unittests\": \"fead438ed1b6d7e9163d94ed535f90ba142f4853\", \"sync_integration_tests\": \"86354c3598debb2ae81570562a097212bcbcef46\", \"traffic_annotation_auditor_unittests\": \"aa228cc4d95453ce4812786a9dc08b2723a528b0\", \"ui_base_unittests\": \"48f897445cadaca0d5ee721f83dc28f66c48693e\", \"ui_chromeos_unittests\": \"61847a93c9f3458af5a80f5fa890585647fab2e2\", \"ui_touch_selection_unittests\": \"359b79cebe193faa0f4b5580a1a0968392424f09\", \"unit_tests\": \"ffa524bbd4c004bb36575a26f0d4a6922f07d0d3\", \"url_unittests\": \"f990ea3bf44ebfbacb6ec173436fc04b0deee719\", \"usage_time_limit_unittests\": \"a119ff2c01cc2c57728b6fad23c64320227347f2\", \"views_unittests\": \"6a8475586ad4cdc2793ff1ab0e7786ca3691358e\", \"viz_unittests\": \"fb8811725044a002998d18afa173858b839a6a4b\", \"wayland_client_perftests\": \"fbcb0df704c057137fbdb1d8107355cb95bf9d4c\", \"wm_unittests\": \"95d222b05d15ff9324a3d273a104da3e27088eef\", \"wtf_unittests\": \"90c7836ba7a438681d8681e70ca3a55da62f6c00\", \"zlib_unittests\": \"82f2ae8960fd61e6b7151d4644e3805f4c06781b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_6887d226fea03ae8e203d0a1d4c9e197b929dd99abf2bafb38063e06e39bc1ba_v2\", \"builder_756d7885c4e2fdf98a0ecf3a0240e3f6188de5be53188a09baa9eae15dedd66f_v2\", \"builder_79ddf9721ca7b7ce79374811fb2c516b44ee31d85deee669f4d7a1736cefaf3b_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_98a60cf4ba341a05f49601a94ea91d205798f47ee731869ed66ec9c0f2c54ce9_v2\", \"builder_b13f895f2fa532c56bcd54736f154d6ea330771f795358111cd0095a10831ab4_v2\", \"builder_c18d585c17603559d8d68e3de2c6e12032537b56b99cb619aa84174b37006d15_v2\", \"builder_eae3a4dc277b4e2282e9fce002ae6861b5ee5509389502cf3acc9366ec79a2d3_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-158-dnw9\"], \"image\": [\"chrome-xenial-20112200-f7cdea8df03\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- TermsOfServiceDownloadTestInstance/TermsOfServiceDownloadTest.DeclineTermsOfService/1\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606913671186682",
"status": "COMPLETED",
"status_changed_ts": "1606913671735342",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43377",
"builder:linux-chromeos-rel",
"buildset:commit/git/9d7beb96f1e8af4fd1b1155ec17a7c6740ab2859",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9d7beb96f1e8af4fd1b1155ec17a7c6740ab2859",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027452681901323808",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8862022619790679488/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:503c561bfb1d7f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1606916736801354",
"url": "https://ci.chromium.org/b/8862022619790679488",
"utcnow_ts": "1606916737661122"
}
}
[13:45:37.670] Invocation finished in 51m20.765082913s with status FAILED