[00:38:37.300] New invocation is queued and will start shortly
[00:38:38.489] Starting the invocation (attempt 1)
[00:38:38.530] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:38:38.530] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:38:38.530] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030307471607348144",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e8fb05882b51d829fdb61ba8c3f607ef144c4346\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9030307471607348144",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/e8fb05882b51d829fdb61ba8c3f607ef144c4346",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e8fb05882b51d829fdb61ba8c3f607ef144c4346",
"gitiles_ref:refs/heads/master"
]
}
[00:38:39.887] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604191118644174",
"id": "8864877409534820992",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e8fb05882b51d829fdb61ba8c3f607ef144c4346\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604191119600090",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177212",
"builder:Linux Builder (dbg)",
"buildset:commit/git/e8fb05882b51d829fdb61ba8c3f607ef144c4346",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e8fb05882b51d829fdb61ba8c3f607ef144c4346",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030307471607348144",
"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/8864877409534820992/+/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": "1604191119600210",
"url": "https://ci.chromium.org/b/8864877409534820992",
"utcnow_ts": "1604191119818117"
}
}
[00:38:39.887] Task URL: https://ci.chromium.org/b/8864877409534820992
[00:38:39.887] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:2:0) after 1m0s
[00:39:39.908] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:2:0)
[00:39:39.908] Timer tick, asking Buildbucket for the build status
[00:39:40.000] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:39:40.000] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:3:0) after 1m0s
[00:40:40.033] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:3:0)
[00:40:40.033] Timer tick, asking Buildbucket for the build status
[00:40:40.161] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:40:40.161] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:4:0) after 1m0s
[00:41:40.233] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:4:0)
[00:41:40.233] Timer tick, asking Buildbucket for the build status
[00:41:40.314] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:41:40.314] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:5:0) after 1m0s
[00:42:40.388] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:5:0)
[00:42:40.388] Timer tick, asking Buildbucket for the build status
[00:42:40.462] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:42:40.462] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:6:0) after 1m0s
[00:43:40.529] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:6:0)
[00:43:40.529] Timer tick, asking Buildbucket for the build status
[00:43:40.620] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:43:40.620] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:7:0) after 1m0s
[00:44:40.638] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:7:0)
[00:44:40.638] Timer tick, asking Buildbucket for the build status
[00:44:40.767] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:44:40.767] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:8:0) after 1m0s
[00:45:40.786] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:8:0)
[00:45:40.786] Timer tick, asking Buildbucket for the build status
[00:45:40.869] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:45:40.869] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:9:0) after 1m0s
[00:46:40.943] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:9:0)
[00:46:40.943] Timer tick, asking Buildbucket for the build status
[00:46:41.014] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:46:41.014] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:10:0) after 1m0s
[00:47:41.045] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:10:0)
[00:47:41.045] Timer tick, asking Buildbucket for the build status
[00:47:43.283] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:47:43.284] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:11:0) after 1m0s
[00:48:43.449] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:11:0)
[00:48:43.449] Timer tick, asking Buildbucket for the build status
[00:48:43.605] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:48:43.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:12:0) after 1m0s
[00:49:43.642] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:12:0)
[00:49:43.642] Timer tick, asking Buildbucket for the build status
[00:49:43.800] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:49:43.800] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:13:0) after 1m0s
[00:50:43.851] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:13:0)
[00:50:43.851] Timer tick, asking Buildbucket for the build status
[00:50:43.926] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:50:43.926] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:14:0) after 1m0s
[00:51:43.946] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:14:0)
[00:51:43.946] Timer tick, asking Buildbucket for the build status
[00:51:44.143] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:51:44.143] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:15:0) after 1m0s
[00:52:44.242] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:15:0)
[00:52:44.242] Timer tick, asking Buildbucket for the build status
[00:52:46.073] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:52:46.073] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:16:0) after 1m0s
[00:53:46.156] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:16:0)
[00:53:46.156] Timer tick, asking Buildbucket for the build status
[00:53:46.249] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:53:46.249] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:17:0) after 1m0s
[00:54:46.361] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:17:0)
[00:54:46.361] Timer tick, asking Buildbucket for the build status
[00:54:46.428] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:54:46.428] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:18:0) after 1m0s
[00:55:46.455] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:18:0)
[00:55:46.455] Timer tick, asking Buildbucket for the build status
[00:55:46.644] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:55:46.644] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:19:0) after 1m0s
[00:56:46.697] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:19:0)
[00:56:46.697] Timer tick, asking Buildbucket for the build status
[00:56:46.793] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:56:46.793] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:20:0) after 1m0s
[00:57:47.029] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:20:0)
[00:57:47.029] Timer tick, asking Buildbucket for the build status
[00:57:47.166] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:57:47.166] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:21:0) after 1m0s
[00:58:47.356] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:21:0)
[00:58:47.356] Timer tick, asking Buildbucket for the build status
[00:58:47.567] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:58:47.567] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:22:0) after 1m0s
[00:59:47.694] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:22:0)
[00:59:47.694] Timer tick, asking Buildbucket for the build status
[00:59:47.792] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:59:47.792] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:23:0) after 1m0s
[01:00:47.810] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:23:0)
[01:00:47.810] Timer tick, asking Buildbucket for the build status
[01:00:47.892] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:00:47.892] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:24:0) after 1m0s
[01:01:48.012] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:24:0)
[01:01:48.012] Timer tick, asking Buildbucket for the build status
[01:01:48.113] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:01:48.113] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:25:0) after 1m0s
[01:02:48.222] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:25:0)
[01:02:48.222] Timer tick, asking Buildbucket for the build status
[01:02:49.007] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:02:49.007] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:26:0) after 1m0s
[01:03:49.317] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:26:0)
[01:03:49.317] Timer tick, asking Buildbucket for the build status
[01:03:49.509] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:03:49.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:27:0) after 1m0s
[01:04:49.524] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:27:0)
[01:04:49.524] Timer tick, asking Buildbucket for the build status
[01:04:49.607] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:04:49.607] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:28:0) after 1m0s
[01:05:49.611] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:28:0)
[01:05:49.611] Timer tick, asking Buildbucket for the build status
[01:05:49.690] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:05:49.690] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:29:0) after 1m0s
[01:06:49.721] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:29:0)
[01:06:49.721] Timer tick, asking Buildbucket for the build status
[01:06:49.857] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:06:49.857] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:30:0) after 1m0s
[01:07:49.915] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:30:0)
[01:07:49.915] Timer tick, asking Buildbucket for the build status
[01:07:50.042] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:07:50.042] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:31:0) after 1m0s
[01:08:50.066] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:31:0)
[01:08:50.066] Timer tick, asking Buildbucket for the build status
[01:08:50.262] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:08:50.262] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:32:0) after 1m0s
[01:09:50.498] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:32:0)
[01:09:50.498] Timer tick, asking Buildbucket for the build status
[01:09:50.577] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:09:50.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:33:0) after 1m0s
[01:10:50.637] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:33:0)
[01:10:50.637] Timer tick, asking Buildbucket for the build status
[01:10:50.757] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:10:50.757] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:34:0) after 1m0s
[01:11:50.836] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:34:0)
[01:11:50.836] Timer tick, asking Buildbucket for the build status
[01:11:50.994] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:11:50.994] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:35:0) after 1m0s
[01:12:51.077] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:35:0)
[01:12:51.077] Timer tick, asking Buildbucket for the build status
[01:12:51.380] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:12:51.380] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:36:0) after 1m0s
[01:13:51.400] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:36:0)
[01:13:51.400] Timer tick, asking Buildbucket for the build status
[01:13:51.505] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:13:51.505] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:37:0) after 1m0s
[01:14:51.576] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:37:0)
[01:14:51.576] Timer tick, asking Buildbucket for the build status
[01:14:51.767] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:14:51.767] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:38:0) after 1m0s
[01:15:51.919] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:38:0)
[01:15:51.919] Timer tick, asking Buildbucket for the build status
[01:15:52.009] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:15:52.009] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:39:0) after 1m0s
[01:16:52.072] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:39:0)
[01:16:52.072] Timer tick, asking Buildbucket for the build status
[01:16:52.307] Build 8864877409534820992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:16:52.307] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:40:0) after 1m0s
[01:16:52.524] Received PubSub notification, asking Buildbucket for the build status
[01:16:52.607] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:52.446] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:40:0)
[01:17:52.446] Timer tick, asking Buildbucket for the build status
[01:17:52.547] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:52.547] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:42:0) after 1m0s
[01:18:52.635] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:42:0)
[01:18:52.635] Timer tick, asking Buildbucket for the build status
[01:18:52.803] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:52.803] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:43:0) after 1m0s
[01:19:52.877] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:43:0)
[01:19:52.877] Timer tick, asking Buildbucket for the build status
[01:19:52.977] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:52.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:44:0) after 1m0s
[01:20:53.077] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:44:0)
[01:20:53.077] Timer tick, asking Buildbucket for the build status
[01:20:53.504] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:53.504] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:45:0) after 1m0s
[01:21:53.510] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:45:0)
[01:21:53.510] Timer tick, asking Buildbucket for the build status
[01:21:53.699] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:53.699] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:46:0) after 1m0s
[01:22:53.722] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:46:0)
[01:22:53.722] Timer tick, asking Buildbucket for the build status
[01:22:53.840] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:53.840] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:47:0) after 1m0s
[01:23:53.888] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:47:0)
[01:23:53.888] Timer tick, asking Buildbucket for the build status
[01:23:53.984] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:53.984] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:48:0) after 1m0s
[01:24:54.001] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:48:0)
[01:24:54.002] Timer tick, asking Buildbucket for the build status
[01:24:54.212] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:54.212] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:49:0) after 1m0s
[01:25:54.265] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:49:0)
[01:25:54.265] Timer tick, asking Buildbucket for the build status
[01:25:54.491] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:54.491] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:50:0) after 1m0s
[01:26:54.524] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:50:0)
[01:26:54.524] Timer tick, asking Buildbucket for the build status
[01:26:54.662] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:54.662] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:51:0) after 1m0s
[01:27:54.687] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:51:0)
[01:27:54.687] Timer tick, asking Buildbucket for the build status
[01:27:54.785] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:54.785] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:52:0) after 1m0s
[01:28:54.889] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:52:0)
[01:28:54.889] Timer tick, asking Buildbucket for the build status
[01:28:54.999] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:54.999] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:53:0) after 1m0s
[01:29:55.017] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:53:0)
[01:29:55.017] Timer tick, asking Buildbucket for the build status
[01:29:55.078] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:55.078] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:54:0) after 1m0s
[01:30:55.139] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:54:0)
[01:30:55.139] Timer tick, asking Buildbucket for the build status
[01:30:55.227] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:55.227] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:55:0) after 1m0s
[01:31:55.299] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:55:0)
[01:31:55.299] Timer tick, asking Buildbucket for the build status
[01:31:55.530] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:55.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:56:0) after 1m0s
[01:32:55.615] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:56:0)
[01:32:55.615] Timer tick, asking Buildbucket for the build status
[01:32:55.744] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:55.744] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:57:0) after 1m0s
[01:33:56.035] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:57:0)
[01:33:56.035] Timer tick, asking Buildbucket for the build status
[01:33:57.401] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:57.401] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:58:0) after 1m0s
[01:34:57.458] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:58:0)
[01:34:57.458] Timer tick, asking Buildbucket for the build status
[01:34:57.560] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:57.560] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:59:0) after 1m0s
[01:35:57.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:59:0)
[01:35:57.624] Timer tick, asking Buildbucket for the build status
[01:35:58.078] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:58.078] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:60:0) after 1m0s
[01:36:58.062] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:60:0)
[01:36:58.062] Timer tick, asking Buildbucket for the build status
[01:36:58.361] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:58.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:61:0) after 1m0s
[01:37:58.514] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:61:0)
[01:37:58.514] Timer tick, asking Buildbucket for the build status
[01:37:58.580] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:58.581] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:62:0) after 1m0s
[01:38:58.654] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:62:0)
[01:38:58.654] Timer tick, asking Buildbucket for the build status
[01:38:59.146] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:59.146] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:63:0) after 1m0s
[01:39:59.251] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:63:0)
[01:39:59.251] Timer tick, asking Buildbucket for the build status
[01:39:59.479] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:59.479] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:64:0) after 1m0s
[01:40:59.522] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:64:0)
[01:40:59.522] Timer tick, asking Buildbucket for the build status
[01:40:59.585] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:59.585] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:65:0) after 1m0s
[01:41:59.612] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:65:0)
[01:41:59.612] Timer tick, asking Buildbucket for the build status
[01:41:59.677] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:59.677] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:66:0) after 1m0s
[01:42:59.795] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:66:0)
[01:42:59.795] Timer tick, asking Buildbucket for the build status
[01:42:59.869] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:59.869] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:67:0) after 1m0s
[01:43:59.937] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:67:0)
[01:43:59.937] Timer tick, asking Buildbucket for the build status
[01:44:00.148] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:00.148] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:68:0) after 1m0s
[01:45:00.157] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:68:0)
[01:45:00.157] Timer tick, asking Buildbucket for the build status
[01:45:00.521] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:00.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:69:0) after 1m0s
[01:46:00.579] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:69:0)
[01:46:00.579] Timer tick, asking Buildbucket for the build status
[01:46:01.049] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:01.049] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:70:0) after 1m0s
[01:47:01.818] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:70:0)
[01:47:01.818] Timer tick, asking Buildbucket for the build status
[01:47:02.013] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:02.013] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:71:0) after 1m0s
[01:48:02.079] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:71:0)
[01:48:02.079] Timer tick, asking Buildbucket for the build status
[01:48:02.147] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:02.147] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:72:0) after 1m0s
[01:49:02.185] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:72:0)
[01:49:02.185] Timer tick, asking Buildbucket for the build status
[01:49:02.317] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:02.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:73:0) after 1m0s
[01:50:02.462] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:73:0)
[01:50:02.462] Timer tick, asking Buildbucket for the build status
[01:50:02.557] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:02.557] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:74:0) after 1m0s
[01:51:02.710] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:74:0)
[01:51:02.710] Timer tick, asking Buildbucket for the build status
[01:51:02.774] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:02.774] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:75:0) after 1m0s
[01:52:02.944] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:75:0)
[01:52:02.944] Timer tick, asking Buildbucket for the build status
[01:52:03.022] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:03.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:76:0) after 1m0s
[01:53:03.100] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:76:0)
[01:53:03.100] Timer tick, asking Buildbucket for the build status
[01:53:03.170] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:03.170] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:77:0) after 1m0s
[01:54:03.162] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:77:0)
[01:54:03.162] Timer tick, asking Buildbucket for the build status
[01:54:03.267] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:03.267] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:78:0) after 1m0s
[01:55:03.338] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:78:0)
[01:55:03.338] Timer tick, asking Buildbucket for the build status
[01:55:03.588] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:03.588] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:79:0) after 1m0s
[01:56:03.753] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:79:0)
[01:56:03.753] Timer tick, asking Buildbucket for the build status
[01:56:03.823] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:03.823] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:80:0) after 1m0s
[01:57:03.845] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:80:0)
[01:57:03.845] Timer tick, asking Buildbucket for the build status
[01:57:03.912] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:03.912] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:81:0) after 1m0s
[01:58:04.054] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:81:0)
[01:58:04.054] Timer tick, asking Buildbucket for the build status
[01:58:04.122] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:04.122] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:82:0) after 1m0s
[01:59:04.632] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:82:0)
[01:59:04.632] Timer tick, asking Buildbucket for the build status
[01:59:04.968] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:04.968] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:83:0) after 1m0s
[02:00:05.753] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:83:0)
[02:00:05.753] Timer tick, asking Buildbucket for the build status
[02:00:06.009] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:06.009] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:84:0) after 1m0s
[02:01:07.480] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:84:0)
[02:01:07.480] Timer tick, asking Buildbucket for the build status
[02:01:07.555] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:07.555] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:85:0) after 1m0s
[02:02:07.984] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:85:0)
[02:02:07.984] Timer tick, asking Buildbucket for the build status
[02:02:08.093] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:08.093] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:86:0) after 1m0s
[02:03:08.208] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:86:0)
[02:03:08.208] Timer tick, asking Buildbucket for the build status
[02:03:08.267] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:08.267] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:87:0) after 1m0s
[02:04:08.468] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:87:0)
[02:04:08.468] Timer tick, asking Buildbucket for the build status
[02:04:08.960] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:08.960] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:88:0) after 1m0s
[02:05:08.968] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:88:0)
[02:05:08.968] Timer tick, asking Buildbucket for the build status
[02:05:09.092] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:09.092] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:89:0) after 1m0s
[02:06:09.123] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:89:0)
[02:06:09.123] Timer tick, asking Buildbucket for the build status
[02:06:09.326] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:09.326] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:90:0) after 1m0s
[02:07:09.461] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:90:0)
[02:07:09.461] Timer tick, asking Buildbucket for the build status
[02:07:09.797] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:09.797] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:91:0) after 1m0s
[02:08:09.875] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:91:0)
[02:08:09.875] Timer tick, asking Buildbucket for the build status
[02:08:10.281] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:10.281] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:92:0) after 1m0s
[02:09:10.423] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:92:0)
[02:09:10.423] Timer tick, asking Buildbucket for the build status
[02:09:10.600] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:10.600] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:93:0) after 1m0s
[02:10:10.663] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:93:0)
[02:10:10.663] Timer tick, asking Buildbucket for the build status
[02:10:11.181] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:11.181] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:94:0) after 1m0s
[02:11:11.334] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:94:0)
[02:11:11.334] Timer tick, asking Buildbucket for the build status
[02:11:11.431] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:11.431] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:95:0) after 1m0s
[02:12:11.455] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:95:0)
[02:12:11.455] Timer tick, asking Buildbucket for the build status
[02:12:11.687] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:11.687] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:96:0) after 1m0s
[02:13:11.720] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:96:0)
[02:13:11.720] Timer tick, asking Buildbucket for the build status
[02:13:11.829] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:11.829] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:97:0) after 1m0s
[02:14:11.852] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:97:0)
[02:14:11.852] Timer tick, asking Buildbucket for the build status
[02:14:12.371] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:12.371] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:98:0) after 1m0s
[02:15:12.404] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:98:0)
[02:15:12.404] Timer tick, asking Buildbucket for the build status
[02:15:12.592] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:12.593] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:99:0) after 1m0s
[02:16:12.698] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:99:0)
[02:16:12.698] Timer tick, asking Buildbucket for the build status
[02:16:12.754] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:12.754] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:100:0) after 1m0s
[02:17:12.879] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:100:0)
[02:17:12.879] Timer tick, asking Buildbucket for the build status
[02:17:13.022] Build 8864877409534820992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:13.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030307471607348144:101:0) after 1m0s
[02:18:03.326] Received PubSub notification, asking Buildbucket for the build status
[02:18:03.666] Build 8864877409534820992: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:18:03.666] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604197082676246",
"created_by": "project:chromium",
"created_ts": "1604191118644174",
"id": "8864877409534820992",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e8fb05882b51d829fdb61ba8c3f607ef144c4346\"}}",
"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\": \"e8fb05882b51d829fdb61ba8c3f607ef144c4346\", \"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-29-y86z\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 177212, \"got_angle_revision\": \"42ad027982404039e6c9a921b2f6354f55b65a2e\", \"got_dawn_revision\": \"0a374dce665328391ab3b68fd9e667b018dd9dcd\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"e8fb05882b51d829fdb61ba8c3f607ef144c4346\", \"got_revision_cp\": \"refs/heads/master@{#822989}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e0de282e678b72dac25b81f8d25305231aec01f8\", \"got_v8_revision\": \"69c856dc816ff1dd65fcc536095b44399a7434b9\", \"got_v8_revision_cp\": \"refs/heads/8.8.214@{#1}\", \"got_webrtc_revision\": \"ee24eb66d23ffea5ef729dc340e1fc4381c72a4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32507}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e8fb05882b51d829fdb61ba8c3f607ef144c4346\", \"swarm_hashes_refs/heads/master(at){#822989}_without_patch\": {\"absl_hardening_tests\": \"62d17c5b6a92efec885e754f0e41906edfd63d15\", \"accessibility_unittests\": \"531f9849fbc239fc4add7e54f92e71afa4b4b17c\", \"angle_unittests\": \"2991425248eb29562290817277e39950148c7089\", \"app_shell_unittests\": \"f24d64d809a78fc16a09d7ffd09ff8b5647cdc04\", \"aura_unittests\": \"3938d9de70756e276624f3871b36590b853c8daa\", \"base_unittests\": \"3d6c41d65c7e1e8a91b1fa67a64ee22ab8041725\", \"base_util_unittests\": \"c6d1b92de57d1e50750da7a3e4e938991aa41efc\", \"blink_common_unittests\": \"4caa28db6e7fd8e7233bb89b29d9626a21490349\", \"blink_fuzzer_unittests\": \"64118307b1785f665731dd8cea0ddd716a0e2bb4\", \"blink_heap_unittests\": \"97a2984d46b4c3a3f2bfab27f6834eb9ec649b9e\", \"blink_platform_unittests\": \"486b9d417ea7a23dc7a70fa9fc954b7f5bcde6f6\", \"blink_python_tests\": \"883466661e0f3504c4be9119dae32cdf61ca6c72\", \"blink_unittests\": \"0f73b3a15ce3732b62aafed26739ca7a28491045\", \"blink_web_tests\": \"a7e0736b643ceb358da584f74c454a66abdd5561\", \"boringssl_crypto_tests\": \"da47be240987f0045d14ae59f5a03106bfc3ea96\", \"boringssl_ssl_tests\": \"beb37e3e92f79d3a1f80525229719de8e4210eda\", \"browser_tests\": \"7e139837e8258655c147efed751b5a048227905f\", \"capture_unittests\": \"8ab27becb76c0a7d5dc07296090ba794d212029b\", \"cast_unittests\": \"69467a3ea0f5e4f9dd402730b4c5e04de1fe466c\", \"cc_unittests\": \"8da2c2235fa56a73cc55e361d30f99237c9d85f1\", \"chrome_app_unittests\": \"a1206e7b11fb262e823fcfe958c922ef1cfb8791\", \"chromedriver_unittests\": \"8667f79ef4161aeba22f9ee54117d267161f994a\", \"components_browsertests\": \"7cd44b5a015830a02b1dd0b91c9300ac3d1cb198\", \"components_unittests\": \"c392ac4783d269e86dcc4164576a8cec8b7af33e\", \"compositor_unittests\": \"a8382efd63d91f4d8c5f700ec97fe252f178ac7c\", \"content_browsertests\": \"cede2cd3e7572aa2cf20bf421f9c4a273424569e\", \"content_shell_crash_test\": \"40963a0680a480a23f9a7dcd5dd37a310a5857a4\", \"content_unittests\": \"e0bd44dea1c37eaae7a40bf266c358f84285a25e\", \"crashpad_tests\": \"e49cdef6fb51d19ffab4fe53e6e07f3b21b69c02\", \"cronet_tests\": \"965f044bb429c333abb84eaae18e3da264362bbb\", \"cronet_unittests\": \"f32ec96978eeb367192c9632ed63ff17fc4db339\", \"crypto_unittests\": \"34c687c651f16f53d68354ffc9529ca267ef1d8b\", \"dbus_unittests\": \"32c00a140fd4e13b40767cb74cef8d7814576404\", \"device_unittests\": \"848874513b4e041c6f1a57ed0c498439e8788245\", \"display_unittests\": \"813d6cc01d6f0c13f18aa2c84d44f18a3db994c8\", \"events_unittests\": \"482cb1a28f84b4165264efb3184ad605161a7e42\", \"extension_docserver_python_unittests\": \"25a9abcc31bf8269434d524a1af451a24e098f46\", \"extensions_browsertests\": \"298a1714c90c3e7f7e1b6837e0edff40eaa5e1e7\", \"extensions_unittests\": \"65e6beadc070ac3579697d0f1434a9b9106b61f4\", \"filesystem_service_unittests\": \"80f6984b927ce57347b8317ad7436e5e7d72bfc8\", \"flatbuffers_unittests\": \"ca986cd6c8ae1796858da669da1b4475f0113d71\", \"gcm_unit_tests\": \"1494b27c6e69730605d47b685b7c1efdab37eb64\", \"gfx_unittests\": \"2fa6bd3623dc3592101b7758ddbe47bc6dcbd16f\", \"gin_unittests\": \"497129f9c5290aaccb5b415c8696d4b65d5cddb3\", \"google_apis_unittests\": \"115c01e08fe276ced6cda9bd82406df8c808565d\", \"gpu_unittests\": \"e42053b4003342ab70767d2f1fe0bd23035791f8\", \"grit_python_unittests\": \"c57107c549d400957552f9572189db48595072fe\", \"gwp_asan_unittests\": \"68c2c2ebf08c088e8ba6d268504d341b45968096\", \"headless_browsertests\": \"bfe1751ddf87ab0609574aabc79339775da8280f\", \"headless_unittests\": \"a2bb62bbe54f271fc06fa93fec3b6a7524139f67\", \"interactive_ui_tests\": \"6243acad2285e1bdc5ad070e524e2bdf0eb3ca3b\", \"ipc_tests\": \"69a87a2c28a07b53ab1746a095eaf547d372c204\", \"jingle_unittests\": \"6dac147a370434c6ec7ab422816fd8b7f6f8ceb7\", \"latency_unittests\": \"17f2857b4ca06141ef8c167702251d0f2c5e4e20\", \"libjingle_xmpp_unittests\": \"58d6cba1f5283cc82e91a15bb600cca87481cfc7\", \"liburlpattern_unittests\": \"b0d9c0442ad9fed353ed39b47b4fb7be4796cde6\", \"media_blink_unittests\": \"c73aeac96f0475616e7121a8b6881d5aa9550402\", \"media_unittests\": \"7ac0f00b73a5841ca1c9041fab8f810eebb623aa\", \"message_center_unittests\": \"866a0de23f00ee606e894b487493ba9cfd452367\", \"metrics_python_tests\": \"06c0c187697ffe6ce6e655078b17b8bf75206ccf\", \"midi_unittests\": \"0dd1efcc97c692dc604e8a95a5f073d7d3e6a8a2\", \"mojo_core_unittests\": \"a0309d84d14f1e41d5d9202cca9960b814834604\", \"mojo_unittests\": \"e11f3068ef497bcde811f71af26ffa9e561e860b\", \"nacl_helper_nonsfi_unittests\": \"120eeab89e95734f1178701e7fe0850d7acf9672\", \"nacl_loader_unittests\": \"c77175db70c6d66651396c97b3c1c0327f98c8f6\", \"native_theme_unittests\": \"b7fb0bcd3dfa36ee8c887aee1a76a4c9d5b045e8\", \"net_unittests\": \"9ace935a7c8ba86c91ddcffd34b89c2c1186fd9b\", \"openscreen_unittests\": \"7703cf0e5e2186e7fc854f78d132653d2cfb0cd5\", \"pdf_unittests\": \"5d4e03d86116fd23ed859a82c6691aef6439fd60\", \"perfetto_unittests\": \"3744a0158d35babcc5666b814953231297b263d1\", \"ppapi_unittests\": \"bf5b71bcc8a9b3f4d1604613f6fb2f22167026e9\", \"printing_unittests\": \"3c141d939a7a97b3b6f37c522d92b0e9614c8b43\", \"remoting_unittests\": \"c86fd21aeb28119a57343762f58ce2c1b70aef65\", \"sandbox_linux_unittests\": \"8205575cdea4651505bf12b61baceef2c3011878\", \"service_manager_unittests\": \"ee580862a575a468b4b2f48632f974544bf749fa\", \"services_unittests\": \"e759d5dedaab596a7ca2a68c755428fa8ad3c119\", \"shell_dialogs_unittests\": \"4050efbd3b64eacc384dc8dcc647f56faba20eb3\", \"skia_unittests\": \"62205cfa59d8a45d71a0e19bef498ecc95a154fe\", \"snapshot_unittests\": \"9e7fe83337a5e2904e8839a00bf462b81a209073\", \"sql_unittests\": \"dd055533a52695dcf10955aafbefbe8f7529bd3f\", \"storage_unittests\": \"fa57c1af21a419af0b7fd6e32eceb2e7cb5aa0a6\", \"sync_integration_tests\": \"47d070e0bdb22e816a85562cffa7ae61386b5441\", \"telemetry_gpu_unittests\": \"8d68cd44b09dfc7ba8247d3f4c52993d408becce\", \"telemetry_perf_unittests\": \"216690a6b1bb24d258f546629754de94a6c12c0e\", \"telemetry_unittests\": \"1fe77ce046212477f11ea8d972a9c0e7f673ae08\", \"traffic_annotation_auditor_unittests\": \"0abe4942e1ca2d6086c3495b7b8b755a3024f248\", \"ui_base_unittests\": \"b55cab0667e29cdcf49716aa9b466f6764608a44\", \"ui_touch_selection_unittests\": \"a76264ba51ba6034968d273e7f14494d99f1e829\", \"unit_tests\": \"d3d581d366147565cc1eed8f2cc2a40635f75248\", \"url_unittests\": \"d95bfebaa55d9ac827436cda4e7c0043d66df60e\", \"views_perftests\": \"99e73cfa0a5ec80676b119d49bc05b82629af074\", \"views_unittests\": \"9236bc9090ee8b6f8fdb091047ac57e6e4679cc9\", \"viz_unittests\": \"920da66ff3b52b2502bceb973cd8497ef6af491a\", \"vr_common_unittests\": \"39eff7ffd47b672f978770014d74059940f3fb13\", \"vr_pixeltests\": \"50426c1df15e8e4623ec2504f854a065a8bb70c6\", \"webdriver_wpt_tests\": \"c186744600e77a7cae73463c01b54ae4ec5773b5\", \"weblayer_browsertests\": \"65803a4a591b8a883bf161ef0823eddcd2972f3f\", \"weblayer_unittests\": \"85a939111699fbb887e4e9b14ea25b1bea28a1b3\", \"wm_unittests\": \"b43036c2d296880740599ab25b6292d00d2143d5\", \"wtf_unittests\": \"e4f0662c35eb8f4a7739cc46168d6ce29ad412c0\", \"x11_unittests\": \"e3ce204b300da25dc7aa17c99b587dab8331ab86\", \"xr_browser_tests\": \"66fb600786ef54e1c91c9281b5d066582a76a36b\", \"zlib_unittests\": \"32c2bc1f9419bb2d9a6f15a15c4c7ad70562da54\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_578c225c2c50d5653cce8ddfaab266952737b31d66b6113fbb64cc6f5229aebd_v2\", \"builder_8851890e994e29b56fba2042f90feba99073c8e56d0ea67af5ee13ebe9f87cf6_v2\", \"builder_a9924cd14a58b117dad8e399e061ac2c13857b9010bc500885f2e2912d9b3070_v2\", \"builder_ffe623326ac74578ce917ff55ef6cefa75094e5ad3ad5fe3409a729d79be647a_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-29-y86z\"], \"image\": [\"chrome-xenial-20102500-5da31bca5f9\"], \"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\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604193410969106",
"status": "COMPLETED",
"status_changed_ts": "1604197083018592",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177212",
"builder:Linux Builder (dbg)",
"buildset:commit/git/e8fb05882b51d829fdb61ba8c3f607ef144c4346",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e8fb05882b51d829fdb61ba8c3f607ef144c4346",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030307471607348144",
"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/8864877409534820992/+/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:4f9a0f7643953710",
"user_agent:luci-scheduler"
],
"updated_ts": "1604197083033051",
"url": "https://ci.chromium.org/b/8864877409534820992",
"utcnow_ts": "1604197083643156"
}
}
[02:18:03.666] Invocation finished in 1h39m26.382405069s with status SUCCEEDED