[02:52:04.926] New invocation is queued and will start shortly
[02:52:06.059] Starting the invocation (attempt 1)
[02:52:06.123] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:52:06.123] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:52:06.123] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018702663301226096",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"0f2726ee6a733f6ae507ca07d797c3c4dd61f606\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9018702663301226096",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/0f2726ee6a733f6ae507ca07d797c3c4dd61f606",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0f2726ee6a733f6ae507ca07d797c3c4dd61f606",
"gitiles_ref:refs/heads/master"
]
}
[02:52:06.883] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615258326251802",
"id": "8853272601251642672",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0f2726ee6a733f6ae507ca07d797c3c4dd61f606\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615258326709623",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181223",
"builder:Linux Builder (dbg)",
"buildset:commit/git/0f2726ee6a733f6ae507ca07d797c3c4dd61f606",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0f2726ee6a733f6ae507ca07d797c3c4dd61f606",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018702663301226096",
"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/8853272601251642672/+/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": "1615258326709737",
"url": "https://ci.chromium.org/b/8853272601251642672",
"utcnow_ts": "1615258326869664"
}
}
[02:52:06.883] Task URL: https://ci.chromium.org/b/8853272601251642672
[02:52:06.883] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:2:0) after 1m0s
[02:52:19.151] Received PubSub notification, asking Buildbucket for the build status
[02:52:19.223] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:06.946] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:2:0)
[02:53:06.946] Timer tick, asking Buildbucket for the build status
[02:53:07.163] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:07.163] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:4:0) after 1m0s
[02:54:07.629] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:4:0)
[02:54:07.629] Timer tick, asking Buildbucket for the build status
[02:54:08.950] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:08.950] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:5:0) after 1m0s
[02:55:09.071] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:5:0)
[02:55:09.071] Timer tick, asking Buildbucket for the build status
[02:55:09.142] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:09.142] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:6:0) after 1m0s
[02:56:09.392] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:6:0)
[02:56:09.392] Timer tick, asking Buildbucket for the build status
[02:56:09.829] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:09.829] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:7:0) after 1m0s
[02:57:09.847] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:7:0)
[02:57:09.847] Timer tick, asking Buildbucket for the build status
[02:57:09.974] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:09.974] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:8:0) after 1m0s
[02:58:09.970] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:8:0)
[02:58:09.970] Timer tick, asking Buildbucket for the build status
[02:58:10.305] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:10.305] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:9:0) after 1m0s
[02:59:10.314] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:9:0)
[02:59:10.314] Timer tick, asking Buildbucket for the build status
[02:59:10.443] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:10.443] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:10:0) after 1m0s
[03:00:10.448] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:10:0)
[03:00:10.448] Timer tick, asking Buildbucket for the build status
[03:00:10.539] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:10.539] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:11:0) after 1m0s
[03:01:10.526] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:11:0)
[03:01:10.526] Timer tick, asking Buildbucket for the build status
[03:01:10.662] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:10.662] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:12:0) after 1m0s
[03:02:10.681] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:12:0)
[03:02:10.681] Timer tick, asking Buildbucket for the build status
[03:02:11.167] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:11.167] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:13:0) after 1m0s
[03:03:11.431] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:13:0)
[03:03:11.431] Timer tick, asking Buildbucket for the build status
[03:03:11.649] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:11.649] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:14:0) after 1m0s
[03:04:11.842] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:14:0)
[03:04:11.842] Timer tick, asking Buildbucket for the build status
[03:04:12.517] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:12.517] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:15:0) after 1m0s
[03:05:12.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:15:0)
[03:05:12.517] Timer tick, asking Buildbucket for the build status
[03:05:12.612] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:12.612] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:16:0) after 1m0s
[03:06:12.599] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:16:0)
[03:06:12.600] Timer tick, asking Buildbucket for the build status
[03:06:12.664] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:12.664] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:17:0) after 1m0s
[03:07:12.685] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:17:0)
[03:07:12.685] Timer tick, asking Buildbucket for the build status
[03:07:13.279] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:13.279] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:18:0) after 1m0s
[03:08:13.247] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:18:0)
[03:08:13.247] Timer tick, asking Buildbucket for the build status
[03:08:13.316] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:13.316] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:19:0) after 1m0s
[03:09:13.296] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:19:0)
[03:09:13.296] Timer tick, asking Buildbucket for the build status
[03:09:13.695] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:13.695] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:20:0) after 1m0s
[03:10:13.738] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:20:0)
[03:10:13.738] Timer tick, asking Buildbucket for the build status
[03:10:13.838] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:13.838] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:21:0) after 1m0s
[03:11:13.853] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:21:0)
[03:11:13.853] Timer tick, asking Buildbucket for the build status
[03:11:13.918] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:13.918] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:22:0) after 1m0s
[03:12:13.966] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:22:0)
[03:12:13.966] Timer tick, asking Buildbucket for the build status
[03:12:14.371] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:14.371] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:23:0) after 1m0s
[03:13:14.393] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:23:0)
[03:13:14.393] Timer tick, asking Buildbucket for the build status
[03:13:16.869] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:16.869] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:24:0) after 1m0s
[03:14:16.856] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:24:0)
[03:14:16.856] Timer tick, asking Buildbucket for the build status
[03:14:17.054] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:17.054] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:25:0) after 1m0s
[03:15:17.072] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:25:0)
[03:15:17.072] Timer tick, asking Buildbucket for the build status
[03:15:17.167] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:17.167] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:26:0) after 1m0s
[03:16:17.194] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:26:0)
[03:16:17.194] Timer tick, asking Buildbucket for the build status
[03:16:17.272] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:17.272] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:27:0) after 1m0s
[03:17:17.347] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:27:0)
[03:17:17.347] Timer tick, asking Buildbucket for the build status
[03:17:17.432] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:17.432] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:28:0) after 1m0s
[03:18:17.447] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:28:0)
[03:18:17.447] Timer tick, asking Buildbucket for the build status
[03:18:17.518] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:17.518] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:29:0) after 1m0s
[03:19:17.497] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:29:0)
[03:19:17.497] Timer tick, asking Buildbucket for the build status
[03:19:17.604] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:17.604] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:30:0) after 1m0s
[03:20:17.696] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:30:0)
[03:20:17.696] Timer tick, asking Buildbucket for the build status
[03:20:17.999] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:17.999] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:31:0) after 1m0s
[03:21:18.124] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:31:0)
[03:21:18.124] Timer tick, asking Buildbucket for the build status
[03:21:18.218] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:18.218] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:32:0) after 1m0s
[03:22:18.289] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:32:0)
[03:22:18.289] Timer tick, asking Buildbucket for the build status
[03:22:18.421] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:18.421] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:33:0) after 1m0s
[03:23:18.463] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:33:0)
[03:23:18.463] Timer tick, asking Buildbucket for the build status
[03:23:18.561] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:18.561] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:34:0) after 1m0s
[03:24:18.699] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:34:0)
[03:24:18.699] Timer tick, asking Buildbucket for the build status
[03:24:18.777] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:18.777] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:35:0) after 1m0s
[03:25:18.832] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:35:0)
[03:25:18.832] Timer tick, asking Buildbucket for the build status
[03:25:18.896] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:18.896] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:36:0) after 1m0s
[03:26:18.993] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:36:0)
[03:26:18.993] Timer tick, asking Buildbucket for the build status
[03:26:19.060] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:19.061] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:37:0) after 1m0s
[03:27:19.144] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:37:0)
[03:27:19.144] Timer tick, asking Buildbucket for the build status
[03:27:19.401] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:19.401] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:38:0) after 1m0s
[03:28:19.418] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:38:0)
[03:28:19.418] Timer tick, asking Buildbucket for the build status
[03:28:19.555] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:19.555] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:39:0) after 1m0s
[03:29:19.618] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:39:0)
[03:29:19.618] Timer tick, asking Buildbucket for the build status
[03:29:19.712] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:19.712] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:40:0) after 1m0s
[03:30:19.728] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:40:0)
[03:30:19.728] Timer tick, asking Buildbucket for the build status
[03:30:19.801] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:19.801] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:41:0) after 1m0s
[03:31:19.822] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:41:0)
[03:31:19.822] Timer tick, asking Buildbucket for the build status
[03:31:20.173] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:20.173] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:42:0) after 1m0s
[03:32:20.193] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:42:0)
[03:32:20.193] Timer tick, asking Buildbucket for the build status
[03:32:20.287] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:20.287] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:43:0) after 1m0s
[03:33:20.321] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:43:0)
[03:33:20.321] Timer tick, asking Buildbucket for the build status
[03:33:20.386] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:20.386] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:44:0) after 1m0s
[03:34:20.411] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:44:0)
[03:34:20.411] Timer tick, asking Buildbucket for the build status
[03:34:20.489] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:20.489] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:45:0) after 1m0s
[03:35:20.510] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:45:0)
[03:35:20.510] Timer tick, asking Buildbucket for the build status
[03:35:20.653] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:20.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:46:0) after 1m0s
[03:36:20.674] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:46:0)
[03:36:20.674] Timer tick, asking Buildbucket for the build status
[03:36:20.912] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:20.912] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:47:0) after 1m0s
[03:37:20.929] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:47:0)
[03:37:20.929] Timer tick, asking Buildbucket for the build status
[03:37:21.045] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:21.045] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:48:0) after 1m0s
[03:38:21.064] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:48:0)
[03:38:21.064] Timer tick, asking Buildbucket for the build status
[03:38:21.316] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:21.316] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:49:0) after 1m0s
[03:39:21.335] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:49:0)
[03:39:21.335] Timer tick, asking Buildbucket for the build status
[03:39:21.403] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:21.403] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:50:0) after 1m0s
[03:40:21.423] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:50:0)
[03:40:21.423] Timer tick, asking Buildbucket for the build status
[03:40:21.496] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:21.496] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:51:0) after 1m0s
[03:41:21.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:51:0)
[03:41:21.517] Timer tick, asking Buildbucket for the build status
[03:41:21.835] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:21.835] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:52:0) after 1m0s
[03:42:21.854] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:52:0)
[03:42:21.854] Timer tick, asking Buildbucket for the build status
[03:42:21.943] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:21.943] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:53:0) after 1m0s
[03:43:22.027] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:53:0)
[03:43:22.027] Timer tick, asking Buildbucket for the build status
[03:43:22.136] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:22.136] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:54:0) after 1m0s
[03:44:22.176] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:54:0)
[03:44:22.176] Timer tick, asking Buildbucket for the build status
[03:44:22.295] Build 8853272601251642672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:22.295] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018702663301226096:55:0) after 1m0s
[03:44:49.194] Received PubSub notification, asking Buildbucket for the build status
[03:44:49.302] Build 8853272601251642672: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:44:49.302] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615261487876326",
"created_by": "project:chromium",
"created_ts": "1615258326251802",
"id": "8853272601251642672",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0f2726ee6a733f6ae507ca07d797c3c4dd61f606\"}}",
"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\": \"0f2726ee6a733f6ae507ca07d797c3c4dd61f606\", \"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-86-up21\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 181223, \"got_angle_revision\": \"faa3915ee3f06dade41a2bc260d850b99c5c6845\", \"got_dawn_revision\": \"7c3b5740db6be782ca4d2e78139568b67db1fc0f\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"0f2726ee6a733f6ae507ca07d797c3c4dd61f606\", \"got_revision_cp\": \"refs/heads/master@{#861002}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"bbda0c17c6ca186d829fa99e712875657d9a1155\", \"got_v8_revision\": \"5c86b9ed5fdab5a53c326ae37b77effcef0b67ff\", \"got_v8_revision_cp\": \"refs/heads/9.1.75@{#1}\", \"got_webrtc_revision\": \"3208bf102b75e8ec1eaa6640dfa3b545310b1e02\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33382}\", \"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\": \"0f2726ee6a733f6ae507ca07d797c3c4dd61f606\", \"swarm_hashes_refs/heads/master(at){#861002}_without_patch\": {\"absl_hardening_tests\": \"337ea8a181974af1f234f11bf6158c6f4730b412\", \"accessibility_unittests\": \"7f831b8fc0d0b3a58aba948e3f6e995dd54155ac\", \"angle_unittests\": \"a517c745b3997baa8c18f56cd16dc3da63c93ae0\", \"app_shell_unittests\": \"fdca016d612e750fdcddeafad360335a86750a79\", \"aura_unittests\": \"8ee16280b295c9bf35094685779f5c3ace8b2424\", \"base_unittests\": \"09bc08e8aac5ce3aac7d60ee578cc2c3f3dc612b\", \"base_util_unittests\": \"cff2beb39c4ba3b56b6aa65330350fe76c8eb943\", \"blink_common_unittests\": \"ffad71325b066a78fadd6d42224bd5272fecea08\", \"blink_fuzzer_unittests\": \"cbb804b71587103c6711d9658e8504a795056841\", \"blink_heap_unittests\": \"6f1b8c5a2a82cbd2ee93db1b58b17c9922f53099\", \"blink_platform_unittests\": \"e484cef800fb38e6e30856e31134582880ddf675\", \"blink_python_tests\": \"a7b985e2d525aeb8ab1f6e5f9f5a0ac2fdd908b5\", \"blink_unittests\": \"7d439d4714890edc3e7e40dae1f64947212a7582\", \"blink_web_tests\": \"a24a881250f6e717b3cfb349310235c69d34d3f3\", \"boringssl_crypto_tests\": \"d0d6001cc1a9da00c947e6da51b505317863fb5b\", \"boringssl_ssl_tests\": \"c0a0b1a58517aae0e7aeb10896c4316d0344607b\", \"browser_tests\": \"308e02caf14cadbb6f582a1ff7f4aa511dad650c\", \"capture_unittests\": \"a06c3acb200a98ef952a385d4e625adb117858da\", \"cast_unittests\": \"f2824f4aceccc4bab661c9c22ab1b6c9e5529b64\", \"cc_unittests\": \"c7ede791cf0d0ab9c67aaca9c3e39ab903b35344\", \"chrome_app_unittests\": \"0249d8a1d6da8232739fd510b9411cf129fc9327\", \"chromedriver_unittests\": \"efbce3be72d73f7420cd2236c3cb60c89506ac88\", \"color_unittests\": \"8cd66519f4360755257e35608c6f956d78ae4c35\", \"components_browsertests\": \"ffbb0d4ff3d1857f9324c0d8413696792b80f186\", \"components_unittests\": \"e30617bc44d0da1d45684f6a7608208265262899\", \"compositor_unittests\": \"e5cfd9b1b630bfc27a6258122a692cd688550636\", \"content_browsertests\": \"eb357417ed24a4e94a3c342a90402a7206781dba\", \"content_shell_crash_test\": \"2636074d681acff15ec4a8e661cdd5d8c17cc0b4\", \"content_unittests\": \"757c1805724b14b5e385573972a6f44aaca0cdcb\", \"crashpad_tests\": \"2f3e6e5cf8dad86f9361212a92fcd11ea6dee154\", \"cronet_tests\": \"d238158d4427096dd00e82486e4bf0714b8ac150\", \"cronet_unittests\": \"8f45055f29dadd2c1dda4779ba8e3159148aa748\", \"crypto_unittests\": \"a6dee214aa32c4528e8e346b2801220d16d6bda8\", \"dbus_unittests\": \"6fc1df5e27c113972858367cbb798f75287a2ae4\", \"device_unittests\": \"3e4fd42969a23d26e6995c44ac86338da2b6df9f\", \"display_unittests\": \"edfef78dd9e2f9bbb2587a26756192890c29c798\", \"events_unittests\": \"7bc4bbc9aab4d1e442a320b94d5bef759db0c817\", \"extensions_browsertests\": \"58a1d44e2b41a25b5c3be2e68420b817ccff91e8\", \"extensions_unittests\": \"7d9ad42bd6680e0a77dcf0504b323b37ced986d9\", \"filesystem_service_unittests\": \"7c5486f157e0a370fbe81e974892392a3bab92a3\", \"flatbuffers_unittests\": \"917c1926f9a03d6ef30fc9665ef3a1d956152ddf\", \"gcm_unit_tests\": \"c16467abc35ebaf8ddec3260f92e19c134559d5d\", \"gfx_unittests\": \"877d61bc13e7185af0d2540197caa3fed8fd20fc\", \"gin_unittests\": \"ac9b6d7a1b82c6c2da6a92264886b80ea68b78a9\", \"google_apis_unittests\": \"91bca1881209064a03763f25621384a881bc14cc\", \"gpu_unittests\": \"598ad0d5c24af35fd993621ed36872f2711f03ea\", \"grit_python_unittests\": \"2629172029a5ce27ead3b3791972502f1e7f17c8\", \"gwp_asan_unittests\": \"83efa7f03573f7748116a79f3de3100365caeb41\", \"headless_browsertests\": \"2b876a5fce4c552319824ceda112ee6dca254d82\", \"headless_unittests\": \"e6d1a57e5c3bfdab67e7a5028830aa55f8aaf90b\", \"interactive_ui_tests\": \"133eaa292ffd1d47d3b799d7833f3d15d9e3dd05\", \"ipc_tests\": \"75c57bde629b003f9f511b53050a218291073d1b\", \"jingle_unittests\": \"eccbfee78be8ac2df1ce33164497a64439b42f93\", \"latency_unittests\": \"29c5becdd2bd256e333dc2a1d6ef802734cb7081\", \"libjingle_xmpp_unittests\": \"94d3eccd0ed85f740f6c24d41a84f9200fd356b7\", \"liburlpattern_unittests\": \"9bf6cab4966e9d8ae2c4a49fecbe96504b999b02\", \"media_blink_unittests\": \"42ad6698f708fa5e0495ecd4fac31d28730d7c86\", \"media_unittests\": \"cce205714e055d5a2e226db5d433e7e545f48203\", \"message_center_unittests\": \"a9d4adf65e7e0240f0e9160b738194fba41d0393\", \"metrics_python_tests\": \"cf903ca204caf6182e68b4bc933eaf90a5ed45c8\", \"midi_unittests\": \"680bff5c346718932e7e2eea751a6631077a31bb\", \"mojo_core_unittests\": \"4381f43941188b92a314447bab87ad9d1fdc9eb9\", \"mojo_unittests\": \"984faf1be858a8c877dadabb2f571241ee734e0e\", \"nacl_helper_nonsfi_unittests\": \"c68258f304c0ffb31bc448dae60a1336550e2f0c\", \"nacl_loader_unittests\": \"32efead28a261c660b56ecf7e33805f1df13ebf8\", \"native_theme_unittests\": \"547ea037f3bdb9926855e1aabbaeeb407749001f\", \"net_unittests\": \"dd6828ae616cc1266672953de0888e82847091c0\", \"openscreen_unittests\": \"0009715a6fb7646c269343a1460691b8d10d1ce8\", \"pdf_unittests\": \"bed23e6d6b729f40614c44ca35576cbdae034602\", \"perfetto_unittests\": \"b24481863f362db0d3e8c755548452dbb07aec03\", \"ppapi_unittests\": \"01e7860e48a205854e91583248db0d808931b7c5\", \"printing_unittests\": \"0aad3263ddc33f3e7a7ba87c645fb129ad3c1522\", \"remoting_unittests\": \"87e4f7bcc1c3b723900f7c2a92af078cafc8cdc1\", \"sandbox_linux_unittests\": \"b7f0f5580d5a06ae519df1f44acccb69b1dec8eb\", \"service_manager_unittests\": \"793e2b7101c6de6b46442c401f448ddfb62b73e9\", \"services_unittests\": \"9c722ce79512680d3601f73934b5822dd9155412\", \"shell_dialogs_unittests\": \"d8eee04c6c36f255d2dafe020c104daf0877681b\", \"skia_unittests\": \"cf34a5a4cdff292a2cd5eac060ed614a5dc19503\", \"snapshot_unittests\": \"14f2301d916ebe6185157c92661e2c8cddb41187\", \"sql_unittests\": \"4ee11c2dd2b23b895b736bd6c922a16aad0c3dab\", \"storage_unittests\": \"e8ace5e56343b5be5eb6a0d6e1f02a7eed09b0f6\", \"sync_integration_tests\": \"f69506db1f60b8bba0a26a5f6c75b066ef3001a1\", \"telemetry_gpu_unittests\": \"19836800f1ba09abec6a26c6521ab1c9f5ce2ebb\", \"telemetry_perf_unittests\": \"7f8e58d791bcd685dfe3a6bf90bdbca1a1c2222d\", \"telemetry_unittests\": \"9be61f2f2a46db5f36ce4f21d2ffc74344d203e1\", \"traffic_annotation_auditor_unittests\": \"fa61901250af11d4ad7a06996f3fc5362a990552\", \"ui_base_unittests\": \"afb6748f8f4c13ee4da8902e9f362ae8ddc13ee8\", \"ui_touch_selection_unittests\": \"2098525fd063c51224d1824954117390dddf7b9b\", \"unit_tests\": \"4aa63f5207048e46c0b6513713bab178e22d1639\", \"url_unittests\": \"dcf23feedb97fde759031f73251b1ab92ae6e193\", \"views_perftests\": \"a56f042b516778d23877bf83668da2e9da412243\", \"views_unittests\": \"658a54e3cddf46d1483de034b23e70a4f236c121\", \"viz_unittests\": \"b30608cd0a68d58a0f41fd355bb644a60d0f6982\", \"vr_common_unittests\": \"8c18172f0103300dafec082f3f1012d6de875e66\", \"vr_pixeltests\": \"c19058e81bdde25b85e988348ca4e2b35fb5fe4c\", \"webdriver_wpt_tests\": \"dcace5e5882ce5cd421e0c11cf6a868cba6264db\", \"weblayer_browsertests\": \"fed77cb312d42aeba1e6eef04fc2f301dea63435\", \"weblayer_unittests\": \"a57f725242de63f75ebcbc951a4925dbc76ca52d\", \"wm_unittests\": \"a5ff6f4e26a475b9262fd266a94be8f89e2c6ab5\", \"wtf_unittests\": \"ec78ed42073dfd35c240e81e5d3b8a73f20fcdbd\", \"x11_unittests\": \"5e9e7ced8fc5c5155157f872dd274032aa8b4063\", \"xr_browser_tests\": \"f2fbb6240e3b1c557bb2da861e592bd961d21b38\", \"zlib_unittests\": \"735a41d64092949b97db6f3c7f9851a80bdf1bce\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3d74f5cea4cbf91e4b26f92a522c5c74e61b738440ef29ba16f5c9a596a5b201_v2\", \"builder_75bb63162a23d4b1c0ff37321417ec47e6c57c7535580350abbb418df2b18732_v2\", \"builder_94dc7d486ab1bafc5bfb11010ef18f0cf20e8e07ae86b58c09f57ba294c280ac_v2\", \"builder_b224075beee246a5ffe9706a23163fae567137407ac5f1b69c50b4dcd22edd9b_v2\", \"builder_d4fdaf58b7947408531076283e0e8baf90c29d26a4447be7804b77c871ea449a_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-86-up21\"], \"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\": [\"5744-5c0a4b4\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615258333451401",
"status": "COMPLETED",
"status_changed_ts": "1615261488840369",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181223",
"builder:Linux Builder (dbg)",
"buildset:commit/git/0f2726ee6a733f6ae507ca07d797c3c4dd61f606",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0f2726ee6a733f6ae507ca07d797c3c4dd61f606",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018702663301226096",
"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/8853272601251642672/+/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:522db7a09ed3b410",
"user_agent:luci-scheduler"
],
"updated_ts": "1615261488851955",
"url": "https://ci.chromium.org/b/8853272601251642672",
"utcnow_ts": "1615261489288848"
}
}
[03:44:49.302] Invocation finished in 52m44.390477591s with status SUCCEEDED