[13:00:58.124] New invocation is queued and will start shortly
[13:00:59.236] Starting the invocation (attempt 1)
[13:00:59.275] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:00:59.276] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:00:59.276] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9050010905845771360",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"dc8a3d504f827a7f68afed0feb867f984f942233\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9050010905845771360",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/dc8a3d504f827a7f68afed0feb867f984f942233",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dc8a3d504f827a7f68afed0feb867f984f942233",
"gitiles_ref:refs/heads/master"
]
}
[13:01:00.315] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1585400459381786",
"id": "8884580843862261008",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dc8a3d504f827a7f68afed0feb867f984f942233\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1585400460090272",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/170307",
"builder:Linux Builder (dbg)",
"buildset:commit/git/dc8a3d504f827a7f68afed0feb867f984f942233",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dc8a3d504f827a7f68afed0feb867f984f942233",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050010905845771360",
"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/8884580843862261008/+/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": "1585400460090428",
"url": "https://ci.chromium.org/b/8884580843862261008",
"utcnow_ts": "1585400460300835"
}
}
[13:01:00.315] Task URL: https://ci.chromium.org/b/8884580843862261008
[13:01:00.315] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:2:0) after 1m0s
[13:02:00.730] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:2:0)
[13:02:00.730] Timer tick, asking Buildbucket for the build status
[13:02:01.391] Build 8884580843862261008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:02:01.391] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:3:0) after 1m0s
[13:03:01.495] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:3:0)
[13:03:01.495] Timer tick, asking Buildbucket for the build status
[13:03:01.664] Build 8884580843862261008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:03:01.664] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:4:0) after 1m0s
[13:04:01.942] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:4:0)
[13:04:01.942] Timer tick, asking Buildbucket for the build status
[13:04:02.272] Build 8884580843862261008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:04:02.272] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:5:0) after 1m0s
[13:05:02.405] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:5:0)
[13:05:02.405] Timer tick, asking Buildbucket for the build status
[13:05:02.543] Build 8884580843862261008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:05:02.543] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:6:0) after 1m0s
[13:05:07.543] Received PubSub notification, asking Buildbucket for the build status
[13:05:07.663] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:02.626] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:6:0)
[13:06:02.626] Timer tick, asking Buildbucket for the build status
[13:06:03.203] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:03.203] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:8:0) after 1m0s
[13:07:03.212] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:8:0)
[13:07:03.212] Timer tick, asking Buildbucket for the build status
[13:07:03.370] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:03.370] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:9:0) after 1m0s
[13:08:03.446] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:9:0)
[13:08:03.446] Timer tick, asking Buildbucket for the build status
[13:08:03.633] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:03.633] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:10:0) after 1m0s
[13:09:03.755] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:10:0)
[13:09:03.755] Timer tick, asking Buildbucket for the build status
[13:09:03.961] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:03.961] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:11:0) after 1m0s
[13:10:03.965] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:11:0)
[13:10:03.965] Timer tick, asking Buildbucket for the build status
[13:10:04.171] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:04.171] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:12:0) after 1m0s
[13:11:04.289] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:12:0)
[13:11:04.290] Timer tick, asking Buildbucket for the build status
[13:11:04.416] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:04.416] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:13:0) after 1m0s
[13:12:04.674] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:13:0)
[13:12:04.674] Timer tick, asking Buildbucket for the build status
[13:12:04.785] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:04.785] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:14:0) after 1m0s
[13:13:04.873] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:14:0)
[13:13:04.873] Timer tick, asking Buildbucket for the build status
[13:13:05.022] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:05.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:15:0) after 1m0s
[13:14:05.014] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:15:0)
[13:14:05.014] Timer tick, asking Buildbucket for the build status
[13:14:05.203] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:05.203] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:16:0) after 1m0s
[13:15:05.276] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:16:0)
[13:15:05.276] Timer tick, asking Buildbucket for the build status
[13:15:05.453] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:05.453] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:17:0) after 1m0s
[13:16:05.527] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:17:0)
[13:16:05.527] Timer tick, asking Buildbucket for the build status
[13:16:05.679] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:05.679] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:18:0) after 1m0s
[13:17:05.699] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:18:0)
[13:17:05.699] Timer tick, asking Buildbucket for the build status
[13:17:05.794] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:05.794] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:19:0) after 1m0s
[13:18:05.856] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:19:0)
[13:18:05.856] Timer tick, asking Buildbucket for the build status
[13:18:07.544] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:07.544] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:20:0) after 1m0s
[13:19:07.572] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:20:0)
[13:19:07.572] Timer tick, asking Buildbucket for the build status
[13:19:07.754] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:07.754] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:21:0) after 1m0s
[13:20:07.773] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:21:0)
[13:20:07.773] Timer tick, asking Buildbucket for the build status
[13:20:08.169] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:08.169] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:22:0) after 1m0s
[13:21:08.238] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:22:0)
[13:21:08.238] Timer tick, asking Buildbucket for the build status
[13:21:10.883] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:10.883] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:23:0) after 1m0s
[13:22:10.916] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:23:0)
[13:22:10.916] Timer tick, asking Buildbucket for the build status
[13:22:11.101] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:11.101] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:24:0) after 1m0s
[13:23:11.129] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:24:0)
[13:23:11.129] Timer tick, asking Buildbucket for the build status
[13:23:11.423] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:11.423] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:25:0) after 1m0s
[13:24:11.505] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:25:0)
[13:24:11.505] Timer tick, asking Buildbucket for the build status
[13:24:11.636] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:11.636] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:26:0) after 1m0s
[13:25:11.676] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:26:0)
[13:25:11.676] Timer tick, asking Buildbucket for the build status
[13:25:11.780] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:11.780] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:27:0) after 1m0s
[13:26:11.844] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:27:0)
[13:26:11.844] Timer tick, asking Buildbucket for the build status
[13:26:12.152] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:12.152] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:28:0) after 1m0s
[13:27:12.175] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:28:0)
[13:27:12.175] Timer tick, asking Buildbucket for the build status
[13:27:12.659] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:12.659] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:29:0) after 1m0s
[13:28:12.709] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:29:0)
[13:28:12.709] Timer tick, asking Buildbucket for the build status
[13:28:12.981] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:12.981] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:30:0) after 1m0s
[13:29:13.005] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:30:0)
[13:29:13.005] Timer tick, asking Buildbucket for the build status
[13:29:13.162] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:13.162] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:31:0) after 1m0s
[13:30:13.190] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:31:0)
[13:30:13.190] Timer tick, asking Buildbucket for the build status
[13:30:13.482] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:13.482] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:32:0) after 1m0s
[13:31:13.506] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:32:0)
[13:31:13.506] Timer tick, asking Buildbucket for the build status
[13:31:13.621] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:13.621] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:33:0) after 1m0s
[13:32:13.611] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:33:0)
[13:32:13.611] Timer tick, asking Buildbucket for the build status
[13:32:13.777] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:13.777] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:34:0) after 1m0s
[13:33:13.826] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:34:0)
[13:33:13.826] Timer tick, asking Buildbucket for the build status
[13:33:14.772] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:14.772] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:35:0) after 1m0s
[13:34:14.806] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:35:0)
[13:34:14.806] Timer tick, asking Buildbucket for the build status
[13:34:14.966] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:14.966] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:36:0) after 1m0s
[13:35:15.012] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:36:0)
[13:35:15.012] Timer tick, asking Buildbucket for the build status
[13:35:15.240] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:15.240] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:37:0) after 1m0s
[13:36:15.270] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:37:0)
[13:36:15.270] Timer tick, asking Buildbucket for the build status
[13:36:15.385] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:15.385] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:38:0) after 1m0s
[13:37:15.429] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:38:0)
[13:37:15.429] Timer tick, asking Buildbucket for the build status
[13:37:15.556] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:15.556] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:39:0) after 1m0s
[13:38:15.648] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:39:0)
[13:38:15.648] Timer tick, asking Buildbucket for the build status
[13:38:16.147] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:16.147] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:40:0) after 1m0s
[13:39:16.199] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:40:0)
[13:39:16.199] Timer tick, asking Buildbucket for the build status
[13:39:16.387] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:16.387] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:41:0) after 1m0s
[13:40:16.510] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:41:0)
[13:40:16.510] Timer tick, asking Buildbucket for the build status
[13:40:16.655] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:16.655] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:42:0) after 1m0s
[13:41:16.662] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:42:0)
[13:41:16.662] Timer tick, asking Buildbucket for the build status
[13:41:16.776] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:16.776] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:43:0) after 1m0s
[13:42:16.831] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:43:0)
[13:42:16.831] Timer tick, asking Buildbucket for the build status
[13:42:17.063] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:17.063] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:44:0) after 1m0s
[13:43:17.203] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:44:0)
[13:43:17.203] Timer tick, asking Buildbucket for the build status
[13:43:18.129] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:18.130] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:45:0) after 1m0s
[13:44:18.161] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:45:0)
[13:44:18.161] Timer tick, asking Buildbucket for the build status
[13:44:18.309] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:18.309] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:46:0) after 1m0s
[13:45:18.337] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:46:0)
[13:45:18.337] Timer tick, asking Buildbucket for the build status
[13:45:18.478] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:18.478] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:47:0) after 1m0s
[13:46:18.482] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:47:0)
[13:46:18.482] Timer tick, asking Buildbucket for the build status
[13:46:18.773] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:18.773] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:48:0) after 1m0s
[13:47:18.804] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:48:0)
[13:47:18.804] Timer tick, asking Buildbucket for the build status
[13:47:19.165] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:19.165] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:49:0) after 1m0s
[13:48:19.305] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:49:0)
[13:48:19.305] Timer tick, asking Buildbucket for the build status
[13:48:20.166] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:20.166] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:50:0) after 1m0s
[13:49:21.055] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:50:0)
[13:49:21.055] Timer tick, asking Buildbucket for the build status
[13:49:21.353] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:21.353] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:51:0) after 1m0s
[13:50:21.501] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:51:0)
[13:50:21.501] Timer tick, asking Buildbucket for the build status
[13:50:21.766] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:21.766] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:52:0) after 1m0s
[13:51:21.992] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:52:0)
[13:51:21.992] Timer tick, asking Buildbucket for the build status
[13:51:22.109] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:22.109] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:53:0) after 1m0s
[13:52:22.304] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:53:0)
[13:52:22.304] Timer tick, asking Buildbucket for the build status
[13:52:22.414] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:22.414] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:54:0) after 1m0s
[13:53:22.739] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:54:0)
[13:53:22.739] Timer tick, asking Buildbucket for the build status
[13:53:25.562] Build 8884580843862261008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:25.562] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050010905845771360:55:0) after 1m0s
[13:53:27.596] Received PubSub notification, asking Buildbucket for the build status
[13:53:27.749] Build 8884580843862261008: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:53:27.749] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1585403606919415",
"created_by": "project:chromium",
"created_ts": "1585400459381786",
"id": "8884580843862261008",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dc8a3d504f827a7f68afed0feb867f984f942233\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/chromium_tests\": {\"bucketed_triggers\": true}, \"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-54-n713\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 170307, \"got_angle_revision\": \"b387ce9389ede6a4ed3b831ab1b8187927fa295f\", \"got_dawn_revision\": \"81431f5034b4ce3a0cdc339709bd8ca8856fe427\", \"got_nacl_revision\": \"ebf11aaad97fde7f91b1c72e0dddaf1653d41f77\", \"got_revision\": \"dc8a3d504f827a7f68afed0feb867f984f942233\", \"got_revision_cp\": \"refs/heads/master@{#754306}\", \"got_swarming_client_revision\": \"cc958279ffd6853e0a1b227a7e957ca334fe56af\", \"got_swiftshader_revision\": \"de3f38a72c486c14a5cfe0810af9871acb7dec9a\", \"got_v8_revision\": \"85b5c24b8be514a1d0e802ae100c3ce793420743\", \"got_v8_revision_cp\": \"refs/heads/8.3.101@{#1}\", \"got_webrtc_revision\": \"d19513f3ffbb939fd56b5377b678bb31d3154e14\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30881}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dc8a3d504f827a7f68afed0feb867f984f942233\", \"swarm_hashes_refs/heads/master(at){#754306}_without_patch\": {\"accessibility_unittests\": \"51a3a50c11850230539e271f2cc95a69577091a4\", \"angle_unittests\": \"00c760068926b183d6aafb08b7d489c9698791dc\", \"app_shell_unittests\": \"b82bc767455f16126264328f3e91cca654190fc5\", \"aura_unittests\": \"c9fd6e4ee90e759fb9937abdb6127b4a63d02f7b\", \"base_unittests\": \"d5e5bfc5aaaf43131d7e5bfb221ee5117d1e2189\", \"base_util_unittests\": \"11ca7e3d49437cdfdcb955c29868611e68341c1d\", \"blink_common_unittests\": \"5c0f1027943e40ab23c968fb9410e1912af28c27\", \"blink_fuzzer_unittests\": \"9ffeadc011a8242dbccd5959770771a4b4b3a126\", \"blink_heap_unittests\": \"6a30d44b08a22e1da61f43a2a075ac25b12ef70c\", \"blink_platform_unittests\": \"4cb101f45baff6bc177fd10bb4459e361c1e92f1\", \"blink_python_tests\": \"39b84fb649adbe15b7fda9c857014d405b47b1fd\", \"blink_unittests\": \"d2f8de59fa356ed99c8c50e5f51e0f1824131627\", \"blink_web_tests\": \"b4aa0a2ff6e286f0e40664453300541af905ebd7\", \"boringssl_crypto_tests\": \"e8e09b9f00ab8cc00963fc373de2eafeb34ccb9d\", \"boringssl_ssl_tests\": \"d89c67ef59569381a3e683818fdaea25b5cd3db3\", \"browser_tests\": \"a0d555481e179411bb7907d0633a2abc896dfaf8\", \"cacheinvalidation_unittests\": \"f44ea7dbec6b36533fa1eccf8f19e75e875de074\", \"capture_unittests\": \"cfde30c0966c6943639728a0b4c5433a1fdd307d\", \"cast_unittests\": \"38f07ce831c399881a80fb161f141cce582a831a\", \"cc_unittests\": \"a53a9203696d3523aa941bfe7eedb6028cd98925\", \"chrome_app_unittests\": \"fb65ee7fdce331b7db5a54d6d094973207e0f3cb\", \"chromedriver_unittests\": \"87df3b6265fb1719fb6f98c94e60fc32f7128c82\", \"components_browsertests\": \"1cb9d002f5eb6967abe60a04fad44ce250945611\", \"components_unittests\": \"c877ff4dea4a031c79ffd3cab4790ba164a5effe\", \"compositor_unittests\": \"4a24c598d373167ce6c5b39272824835f2743fd7\", \"content_browsertests\": \"5b9452f16ee1bf54dc223bb5a986254007c47566\", \"content_shell_crash_test\": \"6050149ae867ed3a44456cd695cc6d4a293f727b\", \"content_unittests\": \"82a3790bcb1cb9c69f87a1733a28ad3b05feeb13\", \"crashpad_tests\": \"a5cdcd6c71f83ed091fe450085f91aed7546b757\", \"cronet_tests\": \"7955219f1620911cbdf49028b793b21ba0b65347\", \"cronet_unittests\": \"89689a5e9ebfabd51a8457581da4f20709a6e2ff\", \"crypto_unittests\": \"2df85ac50516cef6c6f828157e9bc9972be9c5fd\", \"dbus_unittests\": \"7d34f96d0f6b889d3de407710090aa5f61b05f09\", \"device_unittests\": \"9430de0e355dab36826bbfb79dcaa8793adccaad\", \"display_unittests\": \"66b789d7fb9177a85c49377b219e447196bac908\", \"events_unittests\": \"e9ed3bf140c1debb769086890860da232f30bf45\", \"extensions_browsertests\": \"c4c2b0349a050a26f5949bb225cc705449f2f738\", \"extensions_unittests\": \"37186299c980938ba7fc594ba0720042b8438015\", \"filesystem_service_unittests\": \"e21199e0e5ab35e71ab7666f2e2c7baf0c3622a5\", \"flatbuffers_unittests\": \"d5a97f0e268c1e3e0a07477fbb5635ba77b25a21\", \"gcm_unit_tests\": \"0b2e46c923d0da7afd6052de0ed115c682dc3652\", \"gfx_unittests\": \"6e638165746c9d9813c598ee253eec675b643992\", \"gin_unittests\": \"ca4cace7eaf901159cf99371d4f22a84101fa599\", \"google_apis_unittests\": \"06e3f073ba7139a6b13987350c316acbb46da929\", \"gpu_unittests\": \"469df8f774237f564be5076e6c2000e3e81db612\", \"grit_python_unittests\": \"4b6762478187600b0d776425ac36aaa43e7b6bc1\", \"gwp_asan_unittests\": \"e2cb286d8fdc32101d0fac7df00663dea6cc38fe\", \"headless_browsertests\": \"bafd4e7f0e36bb5c5e1c321d9e8c7ad70d9f7eb8\", \"headless_unittests\": \"b9de95ca5eef2c786cd4412f4d155e62debb2e45\", \"interactive_ui_tests\": \"4db7448817d1d7efe4dd0c4ce6a6fbf340307be5\", \"ipc_tests\": \"afd8f266d5960e9ff9d53344647a8ac8a3702b10\", \"jingle_unittests\": \"02659bbd3b5b5cef652e8087d71be64cf5f92a25\", \"latency_unittests\": \"6ab9bada187957eb106adebebf5fc76920a0a215\", \"libjingle_xmpp_unittests\": \"ed7181b0edccf77ed545ea2f5905bfc61c67bac6\", \"media_blink_unittests\": \"37fb80b7cc48f7d90c10ce5d8d695599746511ed\", \"media_unittests\": \"fd0e9aa25ff8cfd4da53a6599f9dcf16b5445ca4\", \"message_center_unittests\": \"3473b18923ccf29c1d1420ce25d39a8b6520140a\", \"metrics_python_tests\": \"c75734497ce169a9fa43cf7d5320a6c5f239e11a\", \"midi_unittests\": \"6aad2b90d48007c4e2372007705840ca8bca6d58\", \"mojo_core_unittests\": \"7530e9c6f29b6f87851079ec6c05d7a29c40aaf7\", \"mojo_unittests\": \"10eea5c5f8e844a0a0129ea8c9c712e5d8bd1639\", \"nacl_helper_nonsfi_unittests\": \"dea35ff9e2723e143e9130360833f64ab82a7061\", \"nacl_loader_unittests\": \"7b51a746f68e9bf48dde60861e11336a7c966aca\", \"native_theme_unittests\": \"df841d9529712a959d1366c303f91f02e8b41d2e\", \"net_unittests\": \"6d7ca87bca69940f2e258bfce82eba8dacf3806b\", \"pdf_unittests\": \"f23e6de20179b5ebcff4c127cba0938dc326e93d\", \"perfetto_unittests\": \"322a911fde851662b885ef140c566ce41c76b8c9\", \"ppapi_unittests\": \"3bf77f1aab7d9e6272f9302fbceba4de2d83a827\", \"printing_unittests\": \"d632166221c65c76b3c7187b7c7fd41e05a97943\", \"remoting_unittests\": \"235af4487cbdd8acbe1e347760f63587056a3380\", \"sandbox_linux_unittests\": \"2a46841807b673394d78fb9a8c32ca6c73fb7af5\", \"service_manager_unittests\": \"655fac2ed6a5364d3e89ad4495829f97fbd1780a\", \"services_unittests\": \"01e572e39f0c0270bc209d769f9ca738a06c7dbb\", \"shell_dialogs_unittests\": \"c4c0fa5ca819b75ea02dc7cf23a9f019e4e9f18d\", \"skia_unittests\": \"b6d67316990786eb3064fa67577a174e45895f4d\", \"snapshot_unittests\": \"552260592b234dbe77f459c48d3dd79cf0fef60b\", \"sql_unittests\": \"0773b1c479d7982c5519f1127ec5ea70b4cf03fe\", \"storage_unittests\": \"386d359ce6b37d20d07be8ad256e7c9d5b2368df\", \"sync_integration_tests\": \"24572980b8799ea7f93b9857181b4563d1722af1\", \"telemetry_gpu_unittests\": \"55cfd0b9cbd8fbc6edd9740273ec28c3c3f848c3\", \"telemetry_perf_unittests\": \"8b4fe731d1aeaa65f55179f382f7de83ec2138a0\", \"telemetry_unittests\": \"0f9f8b4f85a05804d20eb6428af38e553800c1ad\", \"traffic_annotation_auditor_unittests\": \"5184d7de74075a9e234feb009ce7ed88d37435ad\", \"ui_base_unittests\": \"e5aa23624102de643d5e0cb240d7610f797be09c\", \"ui_touch_selection_unittests\": \"651ffb2e5b7f9390b5aac4f77d114ab83ab0d9f2\", \"unit_tests\": \"34a04896f30ac3b429df1cc3d410a5f591746f78\", \"url_unittests\": \"38f4c474a34069f928bc9792302e6a4b03b9eb54\", \"views_perftests\": \"baa0e136a5137e5dc28db69206e92bfbd50ef843\", \"views_unittests\": \"555e626a2c1cc04b703efbd0598e9f960b963e47\", \"viz_unittests\": \"d6b8f737af4a2d647793bc8872810d03b3c8550e\", \"vr_common_unittests\": \"78faf29b2a3fe0971a59842dd5d6f7a4c7d89c46\", \"vr_pixeltests\": \"8e08c1a619c98c33da1a7ef4ff186e1d7f3014e4\", \"webdriver_wpt_tests\": \"4b2f3dcfee6a419ebf559938d5fe75f1254d44d4\", \"weblayer_browsertests\": \"c524a5172cb867cabe52ec64212c9a9b1b67e188\", \"wm_unittests\": \"5eaac4b3cd82f91ba6a77c473dd64f9bfd066b5a\", \"wtf_unittests\": \"e7b3c058e225a3b200c7a188ea33031331bfccdb\", \"xr_browser_tests\": \"fab30c7635ec1caf8f573d508e397feff4267e2c\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_40238b720ec4feb1f57c327a3b72021d0e440ababc8fca32fd370c36be82ffcf_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-54-n713\"], \"image\": [\"chrome-xenial-20032200-f0f7a76907a\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4901-91f024a\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1585400706521204",
"status": "COMPLETED",
"status_changed_ts": "1585403607245081",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/170307",
"builder:Linux Builder (dbg)",
"buildset:commit/git/dc8a3d504f827a7f68afed0feb867f984f942233",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dc8a3d504f827a7f68afed0feb867f984f942233",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050010905845771360",
"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/8884580843862261008/+/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:4b3a0cbcc5e7b710",
"user_agent:luci-scheduler"
],
"updated_ts": "1585403607249631",
"url": "https://ci.chromium.org/b/8884580843862261008",
"utcnow_ts": "1585403607738915"
}
}
[13:53:27.749] Invocation finished in 52m29.642606775s with status SUCCEEDED