[19:03:16.775] New invocation is queued and will start shortly
[19:03:18.039] Starting the invocation (attempt 1)
[19:03:18.148] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:03:18.148] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:03:18.148] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021903051637316000",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"aa0c216c0236a118e51e0e4f07c8ee48667c7004\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9021903051637316000",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/aa0c216c0236a118e51e0e4f07c8ee48667c7004",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aa0c216c0236a118e51e0e4f07c8ee48667c7004",
"gitiles_ref:refs/heads/master"
]
}
[19:03:18.923] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612206198365636",
"id": "8856472989301289792",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"aa0c216c0236a118e51e0e4f07c8ee48667c7004\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612206198789765",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180173",
"builder:Linux Builder (dbg)",
"buildset:commit/git/aa0c216c0236a118e51e0e4f07c8ee48667c7004",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aa0c216c0236a118e51e0e4f07c8ee48667c7004",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021903051637316000",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8856472989301289792/+/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": "1612206198789939",
"url": "https://ci.chromium.org/b/8856472989301289792",
"utcnow_ts": "1612206198910057"
}
}
[19:03:18.923] Task URL: https://ci.chromium.org/b/8856472989301289792
[19:03:18.923] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:2:0) after 1m0s
[19:03:23.781] Received PubSub notification, asking Buildbucket for the build status
[19:03:24.067] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:19.142] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:2:0)
[19:04:19.142] Timer tick, asking Buildbucket for the build status
[19:04:19.324] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:19.324] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:4:0) after 1m0s
[19:05:19.452] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:4:0)
[19:05:19.452] Timer tick, asking Buildbucket for the build status
[19:05:19.539] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:19.539] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:5:0) after 1m0s
[19:06:19.700] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:5:0)
[19:06:19.700] Timer tick, asking Buildbucket for the build status
[19:06:19.870] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:19.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:6:0) after 1m0s
[19:07:19.967] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:6:0)
[19:07:19.967] Timer tick, asking Buildbucket for the build status
[19:07:20.139] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:20.139] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:7:0) after 1m0s
[19:08:20.224] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:7:0)
[19:08:20.224] Timer tick, asking Buildbucket for the build status
[19:08:20.467] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:20.467] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:8:0) after 1m0s
[19:09:20.609] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:8:0)
[19:09:20.609] Timer tick, asking Buildbucket for the build status
[19:09:20.862] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:20.862] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:9:0) after 1m0s
[19:10:20.908] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:9:0)
[19:10:20.908] Timer tick, asking Buildbucket for the build status
[19:10:20.988] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:20.988] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:10:0) after 1m0s
[19:11:21.043] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:10:0)
[19:11:21.044] Timer tick, asking Buildbucket for the build status
[19:11:21.128] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:21.129] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:11:0) after 1m0s
[19:12:21.189] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:11:0)
[19:12:21.189] Timer tick, asking Buildbucket for the build status
[19:12:21.281] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:21.281] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:12:0) after 1m0s
[19:13:21.382] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:12:0)
[19:13:21.382] Timer tick, asking Buildbucket for the build status
[19:13:21.535] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:21.535] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:13:0) after 1m0s
[19:14:22.108] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:13:0)
[19:14:22.108] Timer tick, asking Buildbucket for the build status
[19:14:22.205] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:22.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:14:0) after 1m0s
[19:15:22.353] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:14:0)
[19:15:22.353] Timer tick, asking Buildbucket for the build status
[19:15:22.446] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:22.446] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:15:0) after 1m0s
[19:16:22.774] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:15:0)
[19:16:22.774] Timer tick, asking Buildbucket for the build status
[19:16:22.850] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:22.850] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:16:0) after 1m0s
[19:17:23.160] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:16:0)
[19:17:23.160] Timer tick, asking Buildbucket for the build status
[19:17:23.269] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:23.269] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:17:0) after 1m0s
[19:18:23.419] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:17:0)
[19:18:23.419] Timer tick, asking Buildbucket for the build status
[19:18:23.633] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:23.633] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:18:0) after 1m0s
[19:19:23.857] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:18:0)
[19:19:23.857] Timer tick, asking Buildbucket for the build status
[19:19:24.054] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:24.054] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:19:0) after 1m0s
[19:20:24.272] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:19:0)
[19:20:24.272] Timer tick, asking Buildbucket for the build status
[19:20:24.553] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:24.553] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:20:0) after 1m0s
[19:21:24.823] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:20:0)
[19:21:24.823] Timer tick, asking Buildbucket for the build status
[19:21:24.911] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:24.911] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:21:0) after 1m0s
[19:22:24.934] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:21:0)
[19:22:24.935] Timer tick, asking Buildbucket for the build status
[19:22:25.034] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:25.034] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:22:0) after 1m0s
[19:23:25.169] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:22:0)
[19:23:25.169] Timer tick, asking Buildbucket for the build status
[19:23:25.306] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:25.306] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:23:0) after 1m0s
[19:24:25.431] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:23:0)
[19:24:25.431] Timer tick, asking Buildbucket for the build status
[19:24:25.527] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:25.527] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:24:0) after 1m0s
[19:25:25.614] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:24:0)
[19:25:25.614] Timer tick, asking Buildbucket for the build status
[19:25:25.813] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:25.813] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:25:0) after 1m0s
[19:26:25.972] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:25:0)
[19:26:25.972] Timer tick, asking Buildbucket for the build status
[19:26:26.312] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:26.312] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:26:0) after 1m0s
[19:27:26.449] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:26:0)
[19:27:26.449] Timer tick, asking Buildbucket for the build status
[19:27:26.939] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:26.940] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:27:0) after 1m0s
[19:28:27.058] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:27:0)
[19:28:27.058] Timer tick, asking Buildbucket for the build status
[19:28:27.521] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:27.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:28:0) after 1m0s
[19:29:28.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:28:0)
[19:29:28.409] Timer tick, asking Buildbucket for the build status
[19:29:28.492] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:28.492] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:29:0) after 1m0s
[19:30:28.883] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:29:0)
[19:30:28.883] Timer tick, asking Buildbucket for the build status
[19:30:29.024] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:29.024] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:30:0) after 1m0s
[19:31:29.326] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:30:0)
[19:31:29.326] Timer tick, asking Buildbucket for the build status
[19:31:29.402] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:29.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:31:0) after 1m0s
[19:32:29.596] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:31:0)
[19:32:29.596] Timer tick, asking Buildbucket for the build status
[19:32:29.837] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:29.837] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:32:0) after 1m0s
[19:33:29.878] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:32:0)
[19:33:29.878] Timer tick, asking Buildbucket for the build status
[19:33:30.056] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:30.056] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:33:0) after 1m0s
[19:34:30.059] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:33:0)
[19:34:30.059] Timer tick, asking Buildbucket for the build status
[19:34:30.133] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:30.133] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:34:0) after 1m0s
[19:35:30.213] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:34:0)
[19:35:30.213] Timer tick, asking Buildbucket for the build status
[19:35:30.351] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:30.351] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:35:0) after 1m0s
[19:36:30.516] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:35:0)
[19:36:30.516] Timer tick, asking Buildbucket for the build status
[19:36:30.606] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:30.606] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:36:0) after 1m0s
[19:37:30.772] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:36:0)
[19:37:30.772] Timer tick, asking Buildbucket for the build status
[19:37:30.939] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:30.939] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:37:0) after 1m0s
[19:38:31.452] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:37:0)
[19:38:31.452] Timer tick, asking Buildbucket for the build status
[19:38:31.755] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:31.755] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:38:0) after 1m0s
[19:39:32.085] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:38:0)
[19:39:32.085] Timer tick, asking Buildbucket for the build status
[19:39:32.200] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:32.200] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:39:0) after 1m0s
[19:40:32.375] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:39:0)
[19:40:32.375] Timer tick, asking Buildbucket for the build status
[19:40:32.530] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:32.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:40:0) after 1m0s
[19:41:33.026] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:40:0)
[19:41:33.026] Timer tick, asking Buildbucket for the build status
[19:41:33.239] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:33.239] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:41:0) after 1m0s
[19:42:33.354] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:41:0)
[19:42:33.354] Timer tick, asking Buildbucket for the build status
[19:42:33.410] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:33.410] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:42:0) after 1m0s
[19:43:33.488] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:42:0)
[19:43:33.488] Timer tick, asking Buildbucket for the build status
[19:43:33.642] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:33.642] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:43:0) after 1m0s
[19:44:33.694] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:43:0)
[19:44:33.694] Timer tick, asking Buildbucket for the build status
[19:44:33.800] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:33.800] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:44:0) after 1m0s
[19:45:33.888] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:44:0)
[19:45:33.888] Timer tick, asking Buildbucket for the build status
[19:45:33.946] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:33.946] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:45:0) after 1m0s
[19:46:34.105] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:45:0)
[19:46:34.105] Timer tick, asking Buildbucket for the build status
[19:46:34.484] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:34.484] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:46:0) after 1m0s
[19:47:34.627] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:46:0)
[19:47:34.627] Timer tick, asking Buildbucket for the build status
[19:47:34.855] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:34.855] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:47:0) after 1m0s
[19:48:34.942] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:47:0)
[19:48:34.942] Timer tick, asking Buildbucket for the build status
[19:48:35.064] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:35.064] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:48:0) after 1m0s
[19:49:35.304] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:48:0)
[19:49:35.304] Timer tick, asking Buildbucket for the build status
[19:49:35.382] Build 8856472989301289792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:35.382] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021903051637316000:49:0) after 1m0s
[19:49:36.959] Received PubSub notification, asking Buildbucket for the build status
[19:49:37.069] Build 8856472989301289792: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:49:37.069] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612208975360408",
"created_by": "project:chromium",
"created_ts": "1612206198365636",
"id": "8856472989301289792",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"aa0c216c0236a118e51e0e4f07c8ee48667c7004\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"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\": \"aa0c216c0236a118e51e0e4f07c8ee48667c7004\", \"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-72-rtao\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180173, \"got_angle_revision\": \"e3096d0729df059f1d251405d16eef9e71ba2516\", \"got_dawn_revision\": \"d7aacdda1119d419ce886f9ba4b9401de2834bed\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"aa0c216c0236a118e51e0e4f07c8ee48667c7004\", \"got_revision_cp\": \"refs/heads/master@{#849191}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a483f3814f0dd7d5e1a4ec18cc555b6a37d2f9dd\", \"got_v8_revision\": \"ef5b914f3d672592d9c56eb974df3ec2875f9239\", \"got_v8_revision_cp\": \"refs/heads/9.0.105@{#1}\", \"got_webrtc_revision\": \"989e6e7d22e281dde977c349355a8f1d76a8dff3\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33120}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"aa0c216c0236a118e51e0e4f07c8ee48667c7004\", \"swarm_hashes_refs/heads/master(at){#849191}_without_patch\": {\"absl_hardening_tests\": \"dd82d4a7ab2791042b95b9678b2407cbc59be00a\", \"accessibility_unittests\": \"c761078a6660b9275c6462fe53f36c05063b4504\", \"angle_unittests\": \"7b0db7f8f95eb14b5b16435535ecb9a51588761e\", \"app_shell_unittests\": \"5e550e4220533b471fb79790857eeb255104fcac\", \"aura_unittests\": \"f9495fba5baa533c9d2388524fdddffc22f9b764\", \"base_unittests\": \"d80e84264815006be52a08f9fe9e66c1fc5c51d5\", \"base_util_unittests\": \"8368b179b0d2336c0c9acf2f067b5d63309fdefb\", \"blink_common_unittests\": \"95d96ef8497bf8bc3382721b201d7f3f17f4f274\", \"blink_fuzzer_unittests\": \"823dda982f52aab3350cb1be95177f380426063a\", \"blink_heap_unittests\": \"d60f8e669b05921b675337d4ebfdc0fde99cf221\", \"blink_platform_unittests\": \"2cdb44370fb738d6103b97d96f822e07d29f793d\", \"blink_python_tests\": \"e26e657be4c6031635363bae65dbb614eff8dc6a\", \"blink_unittests\": \"61b1c291d0e957eae90c8cc79f774347e9d35fc1\", \"blink_web_tests\": \"751a8a306d50ea6d08ce9ba2388ab05a26b6cf87\", \"boringssl_crypto_tests\": \"dc3468d84ceb832dc929046b90f849ac2bf493c9\", \"boringssl_ssl_tests\": \"e86377b53c9fef5a540fcc0131e2e28e79facf73\", \"browser_tests\": \"c20d570837ed30854bcc2c0a05a42198c7e0de59\", \"capture_unittests\": \"3162bbc0ef798408f4add32a6f141180187c4d24\", \"cast_unittests\": \"d8fbd844fcba802c864e6da3de2ffd5908a7f9d7\", \"cc_unittests\": \"22dec1df4ef079504555018289f876360a3ed5a4\", \"chrome_app_unittests\": \"2f2ab91ee4a426e8d7f382aefd804d8559586b02\", \"chromedriver_unittests\": \"83c9cd1fb628d87db8baa54c51b71c312c61dbaa\", \"components_browsertests\": \"deb981ad32ee0902f0cc39ef3a896e96bdfa22f2\", \"components_unittests\": \"6627954da8715ab4a83d226e32988cfc2d7ba492\", \"compositor_unittests\": \"0f911fc6767a8e45cf1c42ac1d1b9d7af2d8d836\", \"content_browsertests\": \"d46a0ba981fbf557634b94994d06fcf2ee8896a6\", \"content_shell_crash_test\": \"f6eedc4d09ffad982509ef304107d6c8a72dd0f1\", \"content_unittests\": \"0bebf986de4b54b42a66b6f5a404f99005244c28\", \"crashpad_tests\": \"44cc8ddecabcb5b10d16a8be469446ffa168bdd2\", \"cronet_tests\": \"45902ddb3ea06239593fc2514f62fd07c3cfba49\", \"cronet_unittests\": \"89f00cf511dcd2cc34db93066d0225a0e4c82ba8\", \"crypto_unittests\": \"b689d6be9f61e0b925b8890894326d38c4327852\", \"dbus_unittests\": \"e26bfa27744fac0bc3d53224790c3e68f35620e0\", \"device_unittests\": \"206e9981f79db5f59e1232b3357b30674c950bd3\", \"display_unittests\": \"5b4e0625155e889a19465444dcb5b8ccfc6e2671\", \"events_unittests\": \"f133fd73d198e08ab94af4a08f3876651edda039\", \"extensions_browsertests\": \"c3630b10f392c218b49fc18f0cbf04976c344f73\", \"extensions_unittests\": \"49f486a4bbc053894865cbcb2c5a91182e0d350f\", \"filesystem_service_unittests\": \"a1a83740021253a87145e0daa4fbef2a423b6666\", \"flatbuffers_unittests\": \"abe7737f42a55ed672142d98ab3b938d8384c781\", \"gcm_unit_tests\": \"1363d9b81b47f626fb30c6d83d588f58ee165d05\", \"gfx_unittests\": \"42f4ddcab7046e379088536a97acbda9aeb45905\", \"gin_unittests\": \"fee384e7f9510b17e68bc83321be62541508cb96\", \"google_apis_unittests\": \"42c2d1a5a9e9b85cb3d12fb254dff27abb81a6d2\", \"gpu_unittests\": \"d6295c57948d6e659c8165ef97646517ff32aa5e\", \"grit_python_unittests\": \"13f3716d46ac6e381748ef5bf28b994edd24545a\", \"gwp_asan_unittests\": \"618199dfe239978a968ad52a0d03a382724b8eb7\", \"headless_browsertests\": \"ad44ca6639fe0bb99b8ba88092e94c7169b2556b\", \"headless_unittests\": \"8a4d578fb0eadcb61ec8739a387bc33aa4b19450\", \"interactive_ui_tests\": \"eac0bae2a1ce33b4018d875008bcd19762ff783c\", \"ipc_tests\": \"edaa680850d29e5e2e8fc5b49dd12f2cb5f84c2e\", \"jingle_unittests\": \"dade173757af0629523033facc2fd8c625b54a50\", \"latency_unittests\": \"9133281ab414b03ed5598d748c89c84c7244508c\", \"libjingle_xmpp_unittests\": \"b826291f8fd4bc1a0611ad33e3a20f1be73f469d\", \"liburlpattern_unittests\": \"cbc56444ef173e314c88daa2e0a7e06f092f077f\", \"media_blink_unittests\": \"950fbbdf69a2d6a1bc44df275e03ea5e37ecc4b7\", \"media_unittests\": \"45f5f66ba82c7303faa6742afdf148705834ca11\", \"message_center_unittests\": \"57aa77b0e9fb0a2aabeeb31b14e317ae89b7db7f\", \"metrics_python_tests\": \"9606cacc6c122baf87cfb604c0fdece65d673338\", \"midi_unittests\": \"755ce5b4f18dc7cf50fb15c1b355f52d8def6e37\", \"mojo_core_unittests\": \"ca1ba46ea5dd37d74ed0f370d081e53d9c8b731b\", \"mojo_unittests\": \"58d8237b27dcc62a1f1f36bf6b70f8c41f24109f\", \"nacl_helper_nonsfi_unittests\": \"b7ee4af6a1364cba2bbed819225e35d5315dacf6\", \"nacl_loader_unittests\": \"541aa7272650022915ae5e799327babd2ded6ecd\", \"native_theme_unittests\": \"87099d0ef2597c1ddc52b5fa18a80254a7605f23\", \"net_unittests\": \"c177169d2d0c55695b735b219d5170557f10e207\", \"openscreen_unittests\": \"7afd1215c48b00456a515de1b4e2f2da7b1e99eb\", \"pdf_unittests\": \"7e583c1ca82cb523678146153ea54400fefdfbe5\", \"perfetto_unittests\": \"acc0854ba6ff98b2fc6845e4e1d70a537a48d130\", \"ppapi_unittests\": \"1360c090fc8b14e06e3da9339afac03d861ab19c\", \"printing_unittests\": \"159daea3666d0457bd98e23cf39d0c2fd07cf784\", \"remoting_unittests\": \"e2491d3b787139fb16ae610f14f44723f9c361f8\", \"sandbox_linux_unittests\": \"e356bbb5d7b91bdc7dba9c94d81591daf9970e45\", \"service_manager_unittests\": \"bbbec0648699d860ac6721ddba3bee3e4645cd8a\", \"services_unittests\": \"808b2279795f81f882137bb4e597c0ddc47fd433\", \"shell_dialogs_unittests\": \"33bdd4293c2bc41f57cfc9440170c895f352f961\", \"skia_unittests\": \"ca2c90e533435f89da7582b468641d71ef440bf3\", \"snapshot_unittests\": \"c16cfcc86c46056d5dbde140a1d25a271887ecb7\", \"sql_unittests\": \"28bd4a901ba40b6109e28a3b2fb9d293757b41aa\", \"storage_unittests\": \"c1acc32be3231186ad7a02ac8fd932ba823b8f86\", \"sync_integration_tests\": \"28d46ba84db42595ab5971fe7fd56ab804d9804c\", \"telemetry_gpu_unittests\": \"ea26ae6ce096c2679e504915791bbb509d89d009\", \"telemetry_perf_unittests\": \"0c61b37ea309a7d4d90a4c4cea609bddcbb9f7a7\", \"telemetry_unittests\": \"12f088a468f6f8f91a7dcd3d98df1d839014826d\", \"traffic_annotation_auditor_unittests\": \"7a2172763b22749b58e6ddaf5dd3053720013dc3\", \"ui_base_unittests\": \"4d3ea37ac8b8f65c76634516ce1ab1dca86f41ff\", \"ui_touch_selection_unittests\": \"cfcebb39eb8e4f138e16896ca788032b142e4eb0\", \"unit_tests\": \"d21475cecb9297a6cfb4cb723b677c911f0a79f7\", \"url_unittests\": \"44c3607907cd0b28f37ea7811b718ee4f7255bf7\", \"views_perftests\": \"5e4a92bc4d9c0a390d1931b3f3fbc3092bc482b5\", \"views_unittests\": \"03a04a92e1e81212652e0d256b7e8cfe7154de00\", \"viz_unittests\": \"2ed1ff9d8753a4d2bf890239ded74b448a67c7fc\", \"vr_common_unittests\": \"19657de539d6a37b08e10138d49a2a3fff8dd9b9\", \"vr_pixeltests\": \"456f5f131e5901c45346236ff15881656b849bcc\", \"webdriver_wpt_tests\": \"0c657191efb6b7a8d5944ae5db139313390cbb4b\", \"weblayer_browsertests\": \"668cc68300591b81f93fa382a81d867a329226a2\", \"weblayer_unittests\": \"ff64efb98f297bfedb776e4288a5e4e1f3b08006\", \"wm_unittests\": \"712a361026a1cbf79b600f2e9ad75f1bb476aeb2\", \"wtf_unittests\": \"38d31864a07b5a27060bcf767f6f7419d9a03baa\", \"x11_unittests\": \"42c89d91e944867592d3bbb6e34a68b79dbed250\", \"xr_browser_tests\": \"7663965b1fbca567aca445c74a85864e1d7cd780\", \"zlib_unittests\": \"93d7328f70f237dc4219bbed98287e8e9674aa8c\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_9ab1612fdb00db29a8d60b17a842600a8e29ecb37944be685dafbc3ddd01329a_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_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-72-rtao\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"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\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612206202886933",
"status": "COMPLETED",
"status_changed_ts": "1612208976074770",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180173",
"builder:Linux Builder (dbg)",
"buildset:commit/git/aa0c216c0236a118e51e0e4f07c8ee48667c7004",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aa0c216c0236a118e51e0e4f07c8ee48667c7004",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021903051637316000",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8856472989301289792/+/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:5177cbd92dbb9b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1612208976166800",
"url": "https://ci.chromium.org/b/8856472989301289792",
"utcnow_ts": "1612208977058192"
}
}
[19:49:37.069] Invocation finished in 46m20.315024572s with status SUCCEEDED