[16:54:06.211] New invocation is queued and will start shortly
[16:54:07.499] Starting the invocation (attempt 1)
[16:54:07.632] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:54:07.633] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:54:07.633] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9071648913257638000",
"parameters_json": "{\"builder_name\":\"Deterministic Linux (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"cef7d788cd106b11c4dd8f32ec4924bd7d04d037\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux (dbg)",
"scheduler_invocation_id:9071648913257638000",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/cef7d788cd106b11c4dd8f32ec4924bd7d04d037",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cef7d788cd106b11c4dd8f32ec4924bd7d04d037",
"gitiles_ref:refs/heads/master"
]
}
[16:54:12.543] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1564764849223243",
"id": "8906218849419328144",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"cef7d788cd106b11c4dd8f32ec4924bd7d04d037\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1564764851810341",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/9816",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/cef7d788cd106b11c4dd8f32ec4924bd7d04d037",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cef7d788cd106b11c4dd8f32ec4924bd7d04d037",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9071648913257638000",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8906218849419328144/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1564764851810441",
"url": "https://ci.chromium.org/b/8906218849419328144",
"utcnow_ts": "1564764852379907"
}
}
[16:54:12.543] Task URL: https://ci.chromium.org/b/8906218849419328144
[16:54:12.543] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:2:0) after 1m0s
[16:54:19.662] Received PubSub notification, asking Buildbucket for the build status
[16:54:19.906] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:12.562] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:2:0)
[16:55:12.562] Timer tick, asking Buildbucket for the build status
[16:55:13.336] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:13.336] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:4:0) after 1m0s
[16:56:13.385] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:4:0)
[16:56:13.385] Timer tick, asking Buildbucket for the build status
[16:56:14.316] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:14.316] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:5:0) after 1m0s
[16:57:14.342] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:5:0)
[16:57:14.342] Timer tick, asking Buildbucket for the build status
[16:57:14.536] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:14.536] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:6:0) after 1m0s
[16:58:14.565] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:6:0)
[16:58:14.565] Timer tick, asking Buildbucket for the build status
[16:58:14.789] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:14.789] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:7:0) after 1m0s
[16:59:14.856] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:7:0)
[16:59:14.856] Timer tick, asking Buildbucket for the build status
[16:59:15.124] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:15.124] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:8:0) after 1m0s
[17:00:15.229] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:8:0)
[17:00:15.229] Timer tick, asking Buildbucket for the build status
[17:00:18.218] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:18.218] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:9:0) after 1m0s
[17:01:18.241] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:9:0)
[17:01:18.241] Timer tick, asking Buildbucket for the build status
[17:01:18.989] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:18.989] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:10:0) after 1m0s
[17:02:19.066] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:10:0)
[17:02:19.066] Timer tick, asking Buildbucket for the build status
[17:02:20.818] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:20.818] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:11:0) after 1m0s
[17:03:20.866] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:11:0)
[17:03:20.866] Timer tick, asking Buildbucket for the build status
[17:03:26.690] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:26.690] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:12:0) after 1m0s
[17:04:26.737] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:12:0)
[17:04:26.737] Timer tick, asking Buildbucket for the build status
[17:04:28.213] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:28.213] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:13:0) after 1m0s
[17:05:28.301] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:13:0)
[17:05:28.301] Timer tick, asking Buildbucket for the build status
[17:05:30.268] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:30.268] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:14:0) after 1m0s
[17:06:30.308] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:14:0)
[17:06:30.308] Timer tick, asking Buildbucket for the build status
[17:06:30.672] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:30.672] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:15:0) after 1m0s
[17:07:30.819] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:15:0)
[17:07:30.819] Timer tick, asking Buildbucket for the build status
[17:07:31.560] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:31.560] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:16:0) after 1m0s
[17:08:31.638] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:16:0)
[17:08:31.638] Timer tick, asking Buildbucket for the build status
[17:08:31.885] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:31.885] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:17:0) after 1m0s
[17:09:31.912] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:17:0)
[17:09:31.912] Timer tick, asking Buildbucket for the build status
[17:09:36.806] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:36.806] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:18:0) after 1m0s
[17:10:36.873] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:18:0)
[17:10:36.873] Timer tick, asking Buildbucket for the build status
[17:10:37.094] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:37.094] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:19:0) after 1m0s
[17:11:37.106] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:19:0)
[17:11:37.106] Timer tick, asking Buildbucket for the build status
[17:11:37.333] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:37.333] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:20:0) after 1m0s
[17:12:37.363] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:20:0)
[17:12:37.363] Timer tick, asking Buildbucket for the build status
[17:12:38.128] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:38.128] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:21:0) after 1m0s
[17:13:38.299] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:21:0)
[17:13:38.299] Timer tick, asking Buildbucket for the build status
[17:13:38.656] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:38.656] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:22:0) after 1m0s
[17:14:38.699] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:22:0)
[17:14:38.699] Timer tick, asking Buildbucket for the build status
[17:14:39.109] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:39.109] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:23:0) after 1m0s
[17:15:39.128] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:23:0)
[17:15:39.128] Timer tick, asking Buildbucket for the build status
[17:15:39.453] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:39.453] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:24:0) after 1m0s
[17:16:39.557] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:24:0)
[17:16:39.557] Timer tick, asking Buildbucket for the build status
[17:16:40.665] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:40.665] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:25:0) after 1m0s
[17:17:40.694] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:25:0)
[17:17:40.694] Timer tick, asking Buildbucket for the build status
[17:17:41.853] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:41.853] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:26:0) after 1m0s
[17:18:41.879] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:26:0)
[17:18:41.879] Timer tick, asking Buildbucket for the build status
[17:18:42.064] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:42.064] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:27:0) after 1m0s
[17:19:42.145] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:27:0)
[17:19:42.145] Timer tick, asking Buildbucket for the build status
[17:19:42.531] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:42.531] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:28:0) after 1m0s
[17:20:42.592] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:28:0)
[17:20:42.592] Timer tick, asking Buildbucket for the build status
[17:20:42.961] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:42.961] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:29:0) after 1m0s
[17:21:43.109] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:29:0)
[17:21:43.109] Timer tick, asking Buildbucket for the build status
[17:21:43.973] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:43.973] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:30:0) after 1m0s
[17:22:44.067] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:30:0)
[17:22:44.067] Timer tick, asking Buildbucket for the build status
[17:22:44.428] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:44.428] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:31:0) after 1m0s
[17:23:44.510] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:31:0)
[17:23:44.510] Timer tick, asking Buildbucket for the build status
[17:23:47.893] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:47.893] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:32:0) after 1m0s
[17:24:47.922] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:32:0)
[17:24:47.922] Timer tick, asking Buildbucket for the build status
[17:24:51.233] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:51.233] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:33:0) after 1m0s
[17:25:51.479] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:33:0)
[17:25:51.479] Timer tick, asking Buildbucket for the build status
[17:25:51.785] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:51.785] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:34:0) after 1m0s
[17:26:51.829] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:34:0)
[17:26:51.829] Timer tick, asking Buildbucket for the build status
[17:26:52.355] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:52.355] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:35:0) after 1m0s
[17:27:52.395] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:35:0)
[17:27:52.395] Timer tick, asking Buildbucket for the build status
[17:27:52.545] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:52.545] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:36:0) after 1m0s
[17:28:52.561] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:36:0)
[17:28:52.561] Timer tick, asking Buildbucket for the build status
[17:28:52.919] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:52.919] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:37:0) after 1m0s
[17:29:53.060] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:37:0)
[17:29:53.060] Timer tick, asking Buildbucket for the build status
[17:29:53.761] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:53.761] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:38:0) after 1m0s
[17:30:53.814] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:38:0)
[17:30:53.814] Timer tick, asking Buildbucket for the build status
[17:30:55.798] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:55.798] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:39:0) after 1m0s
[17:31:55.958] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:39:0)
[17:31:55.958] Timer tick, asking Buildbucket for the build status
[17:31:56.207] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:56.207] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:40:0) after 1m0s
[17:32:56.246] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:40:0)
[17:32:56.246] Timer tick, asking Buildbucket for the build status
[17:32:57.738] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:57.738] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:41:0) after 1m0s
[17:33:58.007] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:41:0)
[17:33:58.007] Timer tick, asking Buildbucket for the build status
[17:34:00.259] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:00.259] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:42:0) after 1m0s
[17:35:00.293] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:42:0)
[17:35:00.293] Timer tick, asking Buildbucket for the build status
[17:35:00.884] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:00.884] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:43:0) after 1m0s
[17:36:00.931] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:43:0)
[17:36:00.931] Timer tick, asking Buildbucket for the build status
[17:36:01.218] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:01.218] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:44:0) after 1m0s
[17:37:01.236] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:44:0)
[17:37:01.236] Timer tick, asking Buildbucket for the build status
[17:37:02.346] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:02.346] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:45:0) after 1m0s
[17:38:02.412] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:45:0)
[17:38:02.412] Timer tick, asking Buildbucket for the build status
[17:38:02.768] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:02.768] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:46:0) after 1m0s
[17:39:02.926] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:46:0)
[17:39:02.926] Timer tick, asking Buildbucket for the build status
[17:39:03.247] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:03.247] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:47:0) after 1m0s
[17:40:03.261] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:47:0)
[17:40:03.261] Timer tick, asking Buildbucket for the build status
[17:40:04.242] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:04.242] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:48:0) after 1m0s
[17:41:04.449] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:48:0)
[17:41:04.449] Timer tick, asking Buildbucket for the build status
[17:41:04.966] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:04.966] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:49:0) after 1m0s
[17:42:05.024] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:49:0)
[17:42:05.024] Timer tick, asking Buildbucket for the build status
[17:42:05.813] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:05.813] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:50:0) after 1m0s
[17:43:05.871] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:50:0)
[17:43:05.871] Timer tick, asking Buildbucket for the build status
[17:43:06.025] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:06.025] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:51:0) after 1m0s
[17:44:06.059] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:51:0)
[17:44:06.059] Timer tick, asking Buildbucket for the build status
[17:44:07.872] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:07.872] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:52:0) after 1m0s
[17:45:07.916] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:52:0)
[17:45:07.916] Timer tick, asking Buildbucket for the build status
[17:45:08.716] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:08.717] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:53:0) after 1m0s
[17:46:08.824] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:53:0)
[17:46:08.824] Timer tick, asking Buildbucket for the build status
[17:46:09.119] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:09.119] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:54:0) after 1m0s
[17:47:09.145] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:54:0)
[17:47:09.145] Timer tick, asking Buildbucket for the build status
[17:47:09.546] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:09.546] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:55:0) after 1m0s
[17:48:09.570] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:55:0)
[17:48:09.570] Timer tick, asking Buildbucket for the build status
[17:48:09.951] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:09.951] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:56:0) after 1m0s
[17:49:09.966] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:56:0)
[17:49:09.966] Timer tick, asking Buildbucket for the build status
[17:49:11.535] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:11.535] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:57:0) after 1m0s
[17:50:11.546] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:57:0)
[17:50:11.546] Timer tick, asking Buildbucket for the build status
[17:50:13.500] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:13.500] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:58:0) after 1m0s
[17:51:13.629] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:58:0)
[17:51:13.629] Timer tick, asking Buildbucket for the build status
[17:51:13.894] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:13.894] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:59:0) after 1m0s
[17:52:13.915] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:59:0)
[17:52:13.915] Timer tick, asking Buildbucket for the build status
[17:52:14.742] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:14.742] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:60:0) after 1m0s
[17:53:14.738] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:60:0)
[17:53:14.738] Timer tick, asking Buildbucket for the build status
[17:53:15.653] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:15.653] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:61:0) after 1m0s
[17:54:15.675] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:61:0)
[17:54:15.675] Timer tick, asking Buildbucket for the build status
[17:54:17.292] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:17.292] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:62:0) after 1m0s
[17:55:17.332] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:62:0)
[17:55:17.333] Timer tick, asking Buildbucket for the build status
[17:55:22.143] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:22.143] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:63:0) after 1m0s
[17:56:22.236] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:63:0)
[17:56:22.236] Timer tick, asking Buildbucket for the build status
[17:56:22.528] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:22.528] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:64:0) after 1m0s
[17:57:22.572] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:64:0)
[17:57:22.572] Timer tick, asking Buildbucket for the build status
[17:57:25.871] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:25.871] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:65:0) after 1m0s
[17:58:25.933] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:65:0)
[17:58:25.933] Timer tick, asking Buildbucket for the build status
[17:58:26.071] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:26.071] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:66:0) after 1m0s
[17:59:26.121] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:66:0)
[17:59:26.121] Timer tick, asking Buildbucket for the build status
[17:59:26.413] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:26.413] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:67:0) after 1m0s
[18:00:26.510] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:67:0)
[18:00:26.510] Timer tick, asking Buildbucket for the build status
[18:00:26.801] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:26.801] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:68:0) after 1m0s
[18:01:26.827] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:68:0)
[18:01:26.827] Timer tick, asking Buildbucket for the build status
[18:01:27.577] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:27.577] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:69:0) after 1m0s
[18:02:27.630] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:69:0)
[18:02:27.630] Timer tick, asking Buildbucket for the build status
[18:02:29.987] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:29.987] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:70:0) after 1m0s
[18:03:30.010] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:70:0)
[18:03:30.010] Timer tick, asking Buildbucket for the build status
[18:03:31.748] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:31.748] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:71:0) after 1m0s
[18:04:31.819] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:71:0)
[18:04:31.819] Timer tick, asking Buildbucket for the build status
[18:04:35.240] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:35.240] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:72:0) after 1m0s
[18:05:35.343] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:72:0)
[18:05:35.343] Timer tick, asking Buildbucket for the build status
[18:05:37.283] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:37.283] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:73:0) after 1m0s
[18:06:37.475] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:73:0)
[18:06:37.475] Timer tick, asking Buildbucket for the build status
[18:06:37.850] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:37.850] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:74:0) after 1m0s
[18:07:37.924] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:74:0)
[18:07:37.924] Timer tick, asking Buildbucket for the build status
[18:07:38.549] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:38.549] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:75:0) after 1m0s
[18:08:38.596] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:75:0)
[18:08:38.596] Timer tick, asking Buildbucket for the build status
[18:08:38.858] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:38.858] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:76:0) after 1m0s
[18:09:39.185] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:76:0)
[18:09:39.185] Timer tick, asking Buildbucket for the build status
[18:09:40.059] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:40.059] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:77:0) after 1m0s
[18:10:40.250] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:77:0)
[18:10:40.250] Timer tick, asking Buildbucket for the build status
[18:10:42.737] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:42.737] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:78:0) after 1m0s
[18:11:43.420] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:78:0)
[18:11:43.420] Timer tick, asking Buildbucket for the build status
[18:11:43.566] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:43.566] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:79:0) after 1m0s
[18:12:43.592] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:79:0)
[18:12:43.592] Timer tick, asking Buildbucket for the build status
[18:12:43.878] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:43.878] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:80:0) after 1m0s
[18:13:43.921] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:80:0)
[18:13:43.921] Timer tick, asking Buildbucket for the build status
[18:13:44.849] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:44.849] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:81:0) after 1m0s
[18:14:44.883] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:81:0)
[18:14:44.883] Timer tick, asking Buildbucket for the build status
[18:14:47.792] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:47.792] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:82:0) after 1m0s
[18:15:47.907] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:82:0)
[18:15:47.907] Timer tick, asking Buildbucket for the build status
[18:15:48.061] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:48.061] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:83:0) after 1m0s
[18:16:48.133] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:83:0)
[18:16:48.133] Timer tick, asking Buildbucket for the build status
[18:16:49.949] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:49.949] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:84:0) after 1m0s
[18:17:50.033] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:84:0)
[18:17:50.033] Timer tick, asking Buildbucket for the build status
[18:17:54.119] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:54.119] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:85:0) after 1m0s
[18:18:54.430] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:85:0)
[18:18:54.430] Timer tick, asking Buildbucket for the build status
[18:18:56.518] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:56.518] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:86:0) after 1m0s
[18:19:56.595] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:86:0)
[18:19:56.595] Timer tick, asking Buildbucket for the build status
[18:19:57.415] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:57.415] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:87:0) after 1m0s
[18:20:57.576] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:87:0)
[18:20:57.576] Timer tick, asking Buildbucket for the build status
[18:20:57.743] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:57.743] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:88:0) after 1m0s
[18:21:57.896] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:88:0)
[18:21:57.896] Timer tick, asking Buildbucket for the build status
[18:21:58.629] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:58.629] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:89:0) after 1m0s
[18:22:58.917] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:89:0)
[18:22:58.917] Timer tick, asking Buildbucket for the build status
[18:22:59.149] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:59.149] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:90:0) after 1m0s
[18:23:59.314] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:90:0)
[18:23:59.314] Timer tick, asking Buildbucket for the build status
[18:23:59.631] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:59.631] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:91:0) after 1m0s
[18:24:59.896] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:91:0)
[18:24:59.896] Timer tick, asking Buildbucket for the build status
[18:25:00.511] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:00.512] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:92:0) after 1m0s
[18:26:00.576] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:92:0)
[18:26:00.576] Timer tick, asking Buildbucket for the build status
[18:26:00.834] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:00.834] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:93:0) after 1m0s
[18:27:01.015] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:93:0)
[18:27:01.015] Timer tick, asking Buildbucket for the build status
[18:27:01.625] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:01.625] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:94:0) after 1m0s
[18:28:01.687] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:94:0)
[18:28:01.687] Timer tick, asking Buildbucket for the build status
[18:28:02.204] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:02.204] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:95:0) after 1m0s
[18:29:02.287] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:95:0)
[18:29:02.287] Timer tick, asking Buildbucket for the build status
[18:29:04.072] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:04.072] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:96:0) after 1m0s
[18:30:04.175] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:96:0)
[18:30:04.175] Timer tick, asking Buildbucket for the build status
[18:30:04.526] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:04.526] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:97:0) after 1m0s
[18:31:04.827] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:97:0)
[18:31:04.827] Timer tick, asking Buildbucket for the build status
[18:31:05.439] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:05.439] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:98:0) after 1m0s
[18:32:05.467] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:98:0)
[18:32:05.467] Timer tick, asking Buildbucket for the build status
[18:32:06.554] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:06.554] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:99:0) after 1m0s
[18:33:06.709] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:99:0)
[18:33:06.709] Timer tick, asking Buildbucket for the build status
[18:33:13.864] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:13.864] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:100:0) after 1m0s
[18:34:13.888] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:100:0)
[18:34:13.888] Timer tick, asking Buildbucket for the build status
[18:34:15.462] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:15.462] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:101:0) after 1m0s
[18:35:15.538] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:101:0)
[18:35:15.538] Timer tick, asking Buildbucket for the build status
[18:35:15.871] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:15.871] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:102:0) after 1m0s
[18:36:15.960] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:102:0)
[18:36:15.960] Timer tick, asking Buildbucket for the build status
[18:36:16.215] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:16.215] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:103:0) after 1m0s
[18:37:16.328] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:103:0)
[18:37:16.328] Timer tick, asking Buildbucket for the build status
[18:37:17.113] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:17.113] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:104:0) after 1m0s
[18:38:17.147] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:104:0)
[18:38:17.147] Timer tick, asking Buildbucket for the build status
[18:38:17.352] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:17.352] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:105:0) after 1m0s
[18:39:17.462] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:105:0)
[18:39:17.462] Timer tick, asking Buildbucket for the build status
[18:39:17.690] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:17.690] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:106:0) after 1m0s
[18:40:17.769] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:106:0)
[18:40:17.769] Timer tick, asking Buildbucket for the build status
[18:40:18.134] Build 8906218849419328144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:18.134] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9071648913257638000:107:0) after 1m0s
[18:40:28.869] Received PubSub notification, asking Buildbucket for the build status
[18:40:28.968] Build 8906218849419328144: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:40:28.968] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1564771226123570",
"created_by": "project:chromium",
"created_ts": "1564764849223243",
"id": "8906218849419328144",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"cef7d788cd106b11c4dd8f32ec4924bd7d04d037\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-32-6-ndut\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux (dbg)\", \"buildnumber\": 9816, \"got_angle_revision\": \"825233007c7d4473d33da4907614e4b90959a7c5\", \"got_dawn_revision\": \"54b4df706968359c8c5a332e06de3dc3d372e2c8\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"cef7d788cd106b11c4dd8f32ec4924bd7d04d037\", \"got_revision_cp\": \"refs/heads/master@{#683633}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"b43eb88ba8c08a54cc419d88ef6f5ba7c6478a00\", \"got_v8_revision_cp\": \"refs/heads/7.8.56@{#1}\", \"got_webrtc_revision\": \"054e3bbbe7921b8b84213ecbbb58f68cd5712f6d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28746}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"cef7d788cd106b11c4dd8f32ec4924bd7d04d037\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_940b8dd4638ac05ec7d44839e381a2baf02720b3eac518443ac04ffe6b1809c0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-32-6-ndut\"], \"image\": [\"chrome-xenial-19052201-9cb74617499\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4382-5929880\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1564764856045179",
"status": "COMPLETED",
"status_changed_ts": "1564771227022608",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/9816",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/cef7d788cd106b11c4dd8f32ec4924bd7d04d037",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cef7d788cd106b11c4dd8f32ec4924bd7d04d037",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9071648913257638000",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8906218849419328144/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:466c125bc59c7e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1564771227057859",
"url": "https://ci.chromium.org/b/8906218849419328144",
"utcnow_ts": "1564771228960346"
}
}
[18:40:28.968] Invocation finished in 1h46m22.789279581s with status SUCCEEDED