[14:29:38.779] New invocation is queued and will start shortly
[14:29:39.956] Starting the invocation (attempt 1)
[14:29:40.000] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:29:40.000] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:29:40.000] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018386985458378640",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"566c9e52f2ef5fea0a1f1622652b83b854713b70\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9018386985458378640",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/566c9e52f2ef5fea0a1f1622652b83b854713b70",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/566c9e52f2ef5fea0a1f1622652b83b854713b70",
"gitiles_ref:refs/heads/master"
]
}
[14:29:40.798] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615559380102160",
"id": "8852956923408399584",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"566c9e52f2ef5fea0a1f1622652b83b854713b70\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615559380460139",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181336",
"builder:Linux Builder (dbg)",
"buildset:commit/git/566c9e52f2ef5fea0a1f1622652b83b854713b70",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/566c9e52f2ef5fea0a1f1622652b83b854713b70",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018386985458378640",
"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/8852956923408399584/+/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": "1615559380460247",
"url": "https://ci.chromium.org/b/8852956923408399584",
"utcnow_ts": "1615559380752436"
}
}
[14:29:40.798] Task URL: https://ci.chromium.org/b/8852956923408399584
[14:29:40.798] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:2:0) after 1m0s
[14:30:40.853] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:2:0)
[14:30:40.853] Timer tick, asking Buildbucket for the build status
[14:30:41.147] Build 8852956923408399584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:30:41.147] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:3:0) after 1m0s
[14:31:41.178] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:3:0)
[14:31:41.178] Timer tick, asking Buildbucket for the build status
[14:31:41.359] Build 8852956923408399584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:31:41.359] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:4:0) after 1m0s
[14:32:41.431] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:4:0)
[14:32:41.431] Timer tick, asking Buildbucket for the build status
[14:32:41.494] Build 8852956923408399584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:32:41.494] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:5:0) after 1m0s
[14:33:41.513] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:5:0)
[14:33:41.513] Timer tick, asking Buildbucket for the build status
[14:33:41.615] Build 8852956923408399584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:33:41.615] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:6:0) after 1m0s
[14:33:48.090] Received PubSub notification, asking Buildbucket for the build status
[14:33:48.231] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:41.682] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:6:0)
[14:34:41.682] Timer tick, asking Buildbucket for the build status
[14:34:41.944] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:41.944] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:8:0) after 1m0s
[14:35:41.991] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:8:0)
[14:35:41.991] Timer tick, asking Buildbucket for the build status
[14:35:42.144] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:42.144] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:9:0) after 1m0s
[14:36:42.185] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:9:0)
[14:36:42.185] Timer tick, asking Buildbucket for the build status
[14:36:42.342] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:42.342] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:10:0) after 1m0s
[14:37:42.379] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:10:0)
[14:37:42.379] Timer tick, asking Buildbucket for the build status
[14:37:42.462] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:42.462] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:11:0) after 1m0s
[14:38:42.506] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:11:0)
[14:38:42.506] Timer tick, asking Buildbucket for the build status
[14:38:42.593] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:42.593] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:12:0) after 1m0s
[14:39:42.618] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:12:0)
[14:39:42.618] Timer tick, asking Buildbucket for the build status
[14:39:42.806] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:42.806] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:13:0) after 1m0s
[14:40:42.825] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:13:0)
[14:40:42.825] Timer tick, asking Buildbucket for the build status
[14:40:42.913] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:42.913] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:14:0) after 1m0s
[14:41:42.978] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:14:0)
[14:41:42.978] Timer tick, asking Buildbucket for the build status
[14:41:43.210] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:43.210] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:15:0) after 1m0s
[14:42:43.258] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:15:0)
[14:42:43.258] Timer tick, asking Buildbucket for the build status
[14:42:43.334] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:43.334] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:16:0) after 1m0s
[14:43:43.408] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:16:0)
[14:43:43.408] Timer tick, asking Buildbucket for the build status
[14:43:43.608] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:43.608] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:17:0) after 1m0s
[14:44:43.654] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:17:0)
[14:44:43.654] Timer tick, asking Buildbucket for the build status
[14:44:43.785] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:43.785] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:18:0) after 1m0s
[14:45:43.884] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:18:0)
[14:45:43.884] Timer tick, asking Buildbucket for the build status
[14:45:44.021] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:44.021] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:19:0) after 1m0s
[14:46:44.083] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:19:0)
[14:46:44.083] Timer tick, asking Buildbucket for the build status
[14:46:44.156] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:44.156] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:20:0) after 1m0s
[14:47:44.162] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:20:0)
[14:47:44.162] Timer tick, asking Buildbucket for the build status
[14:47:44.289] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:44.289] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:21:0) after 1m0s
[14:48:44.331] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:21:0)
[14:48:44.331] Timer tick, asking Buildbucket for the build status
[14:48:44.412] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:44.412] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:22:0) after 1m0s
[14:49:44.459] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:22:0)
[14:49:44.459] Timer tick, asking Buildbucket for the build status
[14:49:44.794] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:44.794] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:23:0) after 1m0s
[14:50:44.829] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:23:0)
[14:50:44.829] Timer tick, asking Buildbucket for the build status
[14:50:44.912] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:44.912] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:24:0) after 1m0s
[14:51:44.937] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:24:0)
[14:51:44.937] Timer tick, asking Buildbucket for the build status
[14:51:45.137] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:45.137] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:25:0) after 1m0s
[14:52:45.196] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:25:0)
[14:52:45.196] Timer tick, asking Buildbucket for the build status
[14:52:45.281] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:45.281] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:26:0) after 1m0s
[14:53:45.311] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:26:0)
[14:53:45.311] Timer tick, asking Buildbucket for the build status
[14:53:45.424] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:45.424] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:27:0) after 1m0s
[14:54:45.463] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:27:0)
[14:54:45.463] Timer tick, asking Buildbucket for the build status
[14:54:45.651] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:45.651] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:28:0) after 1m0s
[14:55:45.718] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:28:0)
[14:55:45.718] Timer tick, asking Buildbucket for the build status
[14:55:45.803] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:45.803] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:29:0) after 1m0s
[14:56:45.786] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:29:0)
[14:56:45.786] Timer tick, asking Buildbucket for the build status
[14:56:46.029] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:46.029] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:30:0) after 1m0s
[14:57:46.038] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:30:0)
[14:57:46.038] Timer tick, asking Buildbucket for the build status
[14:57:46.226] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:46.226] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:31:0) after 1m0s
[14:58:46.256] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:31:0)
[14:58:46.256] Timer tick, asking Buildbucket for the build status
[14:58:46.342] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:46.342] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:32:0) after 1m0s
[14:59:46.374] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:32:0)
[14:59:46.374] Timer tick, asking Buildbucket for the build status
[14:59:46.694] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:46.694] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:33:0) after 1m0s
[15:00:46.770] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:33:0)
[15:00:46.770] Timer tick, asking Buildbucket for the build status
[15:00:46.861] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:46.861] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:34:0) after 1m0s
[15:01:46.982] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:34:0)
[15:01:46.983] Timer tick, asking Buildbucket for the build status
[15:01:47.246] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:47.246] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:35:0) after 1m0s
[15:02:47.358] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:35:0)
[15:02:47.358] Timer tick, asking Buildbucket for the build status
[15:02:47.434] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:47.434] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:36:0) after 1m0s
[15:03:47.546] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:36:0)
[15:03:47.546] Timer tick, asking Buildbucket for the build status
[15:03:47.636] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:47.636] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:37:0) after 1m0s
[15:04:47.686] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:37:0)
[15:04:47.686] Timer tick, asking Buildbucket for the build status
[15:04:47.783] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:47.783] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:38:0) after 1m0s
[15:05:47.805] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:38:0)
[15:05:47.805] Timer tick, asking Buildbucket for the build status
[15:05:47.870] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:47.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:39:0) after 1m0s
[15:06:47.899] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:39:0)
[15:06:47.899] Timer tick, asking Buildbucket for the build status
[15:06:47.981] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:47.981] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:40:0) after 1m0s
[15:07:48.059] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:40:0)
[15:07:48.059] Timer tick, asking Buildbucket for the build status
[15:07:48.145] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:48.145] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:41:0) after 1m0s
[15:08:48.242] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:41:0)
[15:08:48.242] Timer tick, asking Buildbucket for the build status
[15:08:48.426] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:48.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:42:0) after 1m0s
[15:09:48.534] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:42:0)
[15:09:48.534] Timer tick, asking Buildbucket for the build status
[15:09:48.612] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:48.612] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:43:0) after 1m0s
[15:10:48.642] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:43:0)
[15:10:48.642] Timer tick, asking Buildbucket for the build status
[15:10:48.728] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:48.728] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:44:0) after 1m0s
[15:11:48.797] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:44:0)
[15:11:48.797] Timer tick, asking Buildbucket for the build status
[15:11:48.866] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:48.866] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:45:0) after 1m0s
[15:12:49.695] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:45:0)
[15:12:49.695] Timer tick, asking Buildbucket for the build status
[15:12:49.761] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:49.761] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:46:0) after 1m0s
[15:13:49.796] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:46:0)
[15:13:49.796] Timer tick, asking Buildbucket for the build status
[15:13:50.011] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:50.011] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:47:0) after 1m0s
[15:14:50.028] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:47:0)
[15:14:50.028] Timer tick, asking Buildbucket for the build status
[15:14:51.328] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:51.328] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:48:0) after 1m0s
[15:15:51.380] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:48:0)
[15:15:51.380] Timer tick, asking Buildbucket for the build status
[15:15:51.734] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:51.734] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:49:0) after 1m0s
[15:16:51.731] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:49:0)
[15:16:51.731] Timer tick, asking Buildbucket for the build status
[15:16:51.917] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:51.917] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:50:0) after 1m0s
[15:17:52.008] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:50:0)
[15:17:52.008] Timer tick, asking Buildbucket for the build status
[15:17:52.098] Build 8852956923408399584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:52.098] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018386985458378640:51:0) after 1m0s
[15:18:34.607] Received PubSub notification, asking Buildbucket for the build status
[15:18:34.683] Build 8852956923408399584: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:18:34.683] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615562314110789",
"created_by": "project:chromium",
"created_ts": "1615559380102160",
"id": "8852956923408399584",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"566c9e52f2ef5fea0a1f1622652b83b854713b70\"}}",
"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\": \"566c9e52f2ef5fea0a1f1622652b83b854713b70\", \"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-east1-d-8-94-6juj\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 181336, \"got_angle_revision\": \"b775012c55a3894b35bbcc4f21838752ac6c7764\", \"got_dawn_revision\": \"a57308e60b7879ab89bb59abe90b01b5f21e92b5\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"566c9e52f2ef5fea0a1f1622652b83b854713b70\", \"got_revision_cp\": \"refs/heads/master@{#862400}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3c4fd15fb075ab3a8eb5809f9a42b5faa9ac63ae\", \"got_v8_revision\": \"9d12b666c3e113f5cd61e2b2eb384aae242ac840\", \"got_v8_revision_cp\": \"refs/heads/9.1.105@{#1}\", \"got_webrtc_revision\": \"14a626af56675c9d95f9fb207d53366a53a95fbd\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33409}\", \"is_cached\": true, \"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\": \"566c9e52f2ef5fea0a1f1622652b83b854713b70\", \"swarm_hashes_refs/heads/master(at){#862400}_without_patch\": {\"absl_hardening_tests\": \"e38da0205bae41b7469c1137a846fea6d1143c62\", \"accessibility_unittests\": \"7feef5b072bdd1ede71b6fde282e2e26989a1a33\", \"angle_unittests\": \"6bebf16b10fd333d5d28577751693d9883654a38\", \"app_shell_unittests\": \"b640442162adfae8f171850cddd72edf3a8d6303\", \"aura_unittests\": \"730e09014e66f49f0c3b652c2023c98bee2f0047\", \"base_unittests\": \"87ffba2152c56b0a24f06e92f6fb91174ffa7f89\", \"base_util_unittests\": \"c42be76c6b98fdf02a30cfeb0718129bc3847fed\", \"blink_common_unittests\": \"69074dff7f549e5fc921046b360b0d487a180b2d\", \"blink_fuzzer_unittests\": \"687175a70b99341dbf4cafc48f0e3b133bbcce2c\", \"blink_heap_unittests\": \"26344c2cd108d497a1dce1da4f425765df9d3cfe\", \"blink_platform_unittests\": \"af27c33e0642056b69515de8243077cc7c33341b\", \"blink_python_tests\": \"93464f06068a03bb3d3d6e37ce65f4b9fa8badef\", \"blink_unittests\": \"15c8cfd6062647d2060bce92a0160860dbf8cef9\", \"blink_web_tests\": \"e6a3ce3e727622e429421ccfb551c94e3e62e39d\", \"boringssl_crypto_tests\": \"9fbb70b5114474b7e2af2ba87e665f551f4dc80e\", \"boringssl_ssl_tests\": \"ecb5f9b95be13427aaa7129c30b9ba242e4d090d\", \"browser_tests\": \"6b202664ea48c583334bc63fac562ecaf2a657a4\", \"capture_unittests\": \"a900aa59808a4774a3e34bb56c75cb92b39ae494\", \"cast_unittests\": \"ed5a6aef901d49c4b941887ac0ab8a7d17a905e4\", \"cc_unittests\": \"c7e87591ae8b1908a29222aca6c8ece9c197dc90\", \"chrome_app_unittests\": \"b88b00c12421f0f02f010bd8bb0aa63dc64310f4\", \"chromedriver_unittests\": \"815ebc7015aeed2a63d321f492594af2f2204bb5\", \"color_unittests\": \"9831617c131808d93b05e7de90d88558f1d7f304\", \"components_browsertests\": \"4e193b86c43f94767d8976607ba045a0b0fb98b5\", \"components_unittests\": \"d08fb26469d97394fed80bbbde984ff7e98bcbc5\", \"compositor_unittests\": \"6600d06d256be33de6494c18c2f22ef1078a7858\", \"content_browsertests\": \"86ced3ad3f896278c5a692f9de7f92951f1163bf\", \"content_shell_crash_test\": \"f7ed9ceafba57712eda7034f4b9b2896c4062070\", \"content_unittests\": \"17ec6d7e5c0f77ef38f02740c32289e420af3927\", \"crashpad_tests\": \"0f02457d443e1e3fb614b1ca8d1b72f37724f7f6\", \"cronet_tests\": \"30aa422867de3467e9bce320f15a0bd58d301699\", \"cronet_unittests\": \"cef5261828a5a8bfea901588a85aacf807a34950\", \"crypto_unittests\": \"20b57e93987782e30549b6e926012d97d757a65e\", \"dbus_unittests\": \"2531a3b1ada35239b8a9c017694ce9c712854ccc\", \"device_unittests\": \"d892aa53678532c948eab51d8081473c65f4d044\", \"display_unittests\": \"6e241ae4902b7163e18b2f562ab1321e65bc0d24\", \"events_unittests\": \"49bbeb61d560d5af9a6d7fd0750fa31ee7115adc\", \"extensions_browsertests\": \"0b4903679f094427705c9f1b989f3c8d7325b275\", \"extensions_unittests\": \"a880bb64f521be7000afcc94b11edf99be13d409\", \"filesystem_service_unittests\": \"c0341e0112424bb322123fae1481f88edbf04372\", \"flatbuffers_unittests\": \"917c1926f9a03d6ef30fc9665ef3a1d956152ddf\", \"gcm_unit_tests\": \"ff05c44306f3e620bd501ec93fd7633f1d51f135\", \"gfx_unittests\": \"49ac9079c23bd964420ddbbfbc7a8f4a1eb18471\", \"gin_unittests\": \"5c07c81932b0e7a3fbc7042f1cb42155f0a8f23f\", \"google_apis_unittests\": \"21d6393d0f2b492e5d2e45c1690e25cc8b36919c\", \"gpu_unittests\": \"b641584f93dec534938ba8cf952d7d8ec71b5ccf\", \"grit_python_unittests\": \"34dc6f3cc2d88a5fac848f4742c34f024387cdb5\", \"gwp_asan_unittests\": \"5da8f585f97685b92b8e7af72b05e4ceebd573ce\", \"headless_browsertests\": \"ed666e4f29eaec5ae4ca49b2c3ed79f55008eddf\", \"headless_unittests\": \"b9356c38e881cc0f3e975835ea86aae21c5fdad1\", \"interactive_ui_tests\": \"875223ff71386b10ce9504546b2ba0848a85c03b\", \"ipc_tests\": \"d3590f05a041a7c2c760160c24a98eb9a9f387fc\", \"jingle_unittests\": \"971b00807ead2b3460e54a41c9aed2d9dded1125\", \"latency_unittests\": \"54213b4b6b1f7437458b768fd166a2018266622d\", \"libjingle_xmpp_unittests\": \"4ac0cbd70ec9e0a2bd5e6ed89d12aa938bcdb42b\", \"liburlpattern_unittests\": \"27005479ceab748f19068dd0e5948b08e5077c9c\", \"media_blink_unittests\": \"586bfe89aaf63e85c100d96b60f80e4d9e1fb075\", \"media_unittests\": \"231f5ae76e5143378a3f34de24329658d5cb1cb0\", \"message_center_unittests\": \"66ce85999d2166efe90c6a3a0cad3a2923e91091\", \"metrics_python_tests\": \"5451d891eabed5f67c841ff008fdafea5b5066ad\", \"midi_unittests\": \"ced63c4ed7aa9ea38d959810cfb00adafdf4d6c7\", \"mojo_core_unittests\": \"e85645d2ea88a11f7ca7f51cf434bf824a0789bc\", \"mojo_unittests\": \"6fabf97297ba65e24e71af10e07e6bd6e01f9cc1\", \"nacl_helper_nonsfi_unittests\": \"789ac1870ae0da80f5d9b66adcc110945f994fc1\", \"nacl_loader_unittests\": \"3c36e8bd1d207ee7c839c23c414e1301731e8a7f\", \"native_theme_unittests\": \"0852ed72c3836a3dc090d50fc8b04446c0783e1a\", \"net_unittests\": \"91a5a15385426913cf104c0647a70c6f1c455999\", \"openscreen_unittests\": \"53a8a96ea5db5d4bf1d21eac5929d7e7114227b3\", \"pdf_unittests\": \"d7accb50f7f189d9c960101d456194b9e70d11d3\", \"perfetto_unittests\": \"342d5ad19fc051134e8e16428d07d1629fcc8d47\", \"ppapi_unittests\": \"279375f85d393955c529182c1180154a964ba7b7\", \"printing_unittests\": \"689c27646e44a81ff36ebde100108393ca16241b\", \"remoting_unittests\": \"66177421ba8df6e0ae3ec0c2bc3b8e0753674496\", \"sandbox_linux_unittests\": \"18b9d7c60b1c5e6dda3625392d6de28a6f72492a\", \"service_manager_unittests\": \"c1f96e44bbe4dc183acb53692b28f052a7069ceb\", \"services_unittests\": \"8a21b976a3468b3b65684ee039e1a5eae6b93605\", \"shell_dialogs_unittests\": \"589cdd71c0ed392012e35a01ae9a34c1b93bb0d8\", \"skia_unittests\": \"c3b9f0da396775aeb4df809a6bc413bbe191c84b\", \"snapshot_unittests\": \"f7e15c17bf629c5b29b0fa4530cc96aeb6bc0392\", \"sql_unittests\": \"22336d3c853ca6fea5c535456a8193ea3987e361\", \"storage_unittests\": \"16e0d3472efb2dca5907ac4e461636a433307a3e\", \"sync_integration_tests\": \"006af7daf39848382032c1274703ff2fc28a1efd\", \"telemetry_gpu_unittests\": \"45509679d55ea1f36d83a0cb22ef61b7e69736a4\", \"telemetry_perf_unittests\": \"f601f65732c2b115a1d94661e6af269b4f3f4170\", \"telemetry_unittests\": \"d4b4a251b87af11369a5128471c4327333f6e8c6\", \"traffic_annotation_auditor_unittests\": \"7a3f0a1de107b8e277dfc8f04fbcd888e59c411b\", \"ui_base_unittests\": \"81e254516a1284e881739e508cfde517e3c57ef0\", \"ui_touch_selection_unittests\": \"42a774ec633d89e4b41ed2954f8a17560ec03b3e\", \"unit_tests\": \"fb3f269a4443fc0b9b70948b4b735166b0de5649\", \"url_unittests\": \"c73b0137c2ee949816407f96864edab68fde9b5a\", \"views_perftests\": \"a855454eeb18b3e8c39f09ff7c8b9e5b575acd47\", \"views_unittests\": \"73aa0c67d8530dc01f986720d0d8a60f89b3207b\", \"viz_unittests\": \"b074ccc8f64c8f8e5767139fc55e3c954587adfc\", \"vr_common_unittests\": \"97bb7cffccc4bfe815d270b5a19f8a7b77ea5830\", \"vr_pixeltests\": \"d3b3206f2d466552a7ffd863be474b31d71827a8\", \"webdriver_wpt_tests\": \"6a7ca5192039f2df5f2aba2698c276db73b76bb5\", \"weblayer_browsertests\": \"ee9db76424a53f4134e46b4f94d420612eb36bcf\", \"weblayer_unittests\": \"e6618f388f77dc51b5fdc8eca139e4c48e01888b\", \"wm_unittests\": \"42a5e20a1b4f1f5e8ba6114372fc6b558989c681\", \"wtf_unittests\": \"0fad4219a1a43240d97af39e4c285bc523c04d0d\", \"x11_unittests\": \"04832d7f3619b33073bf24a141b4652ad308f6e7\", \"xr_browser_tests\": \"32058a08b456f87ff82d2cd8667a4d6c19add130\", \"zlib_unittests\": \"b090341fe0d32d806eb60597269da30a0375af02\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"builder_b14893b55edaf5e4dad6913e524bd3694194da568bc8f7a76820eff0afe1bec5_v2\", \"builder_bcc6b3e5c0858529730294da730af8ea17f2c5c79b8b0dc7af4e722a8412ac73_v2\", \"builder_c4692ee50382bcd35d592bcc0950e009bfc7efa8bba012f560f58cf3ab714e75_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-east1-d-8-94-6juj\"], \"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\": [\"5754-8c4f760\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615559627597655",
"status": "COMPLETED",
"status_changed_ts": "1615562314367373",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181336",
"builder:Linux Builder (dbg)",
"buildset:commit/git/566c9e52f2ef5fea0a1f1622652b83b854713b70",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/566c9e52f2ef5fea0a1f1622652b83b854713b70",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018386985458378640",
"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/8852956923408399584/+/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:523fa95706673610",
"user_agent:luci-scheduler"
],
"updated_ts": "1615562314372816",
"url": "https://ci.chromium.org/b/8852956923408399584",
"utcnow_ts": "1615562314673998"
}
}
[15:18:34.683] Invocation finished in 48m55.920771865s with status SUCCEEDED