[02:18:22.098] New invocation is queued and will start shortly
[02:18:23.185] Starting the invocation (attempt 1)
[02:18:23.223] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:18:23.224] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:18:23.224] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022872244854339616",
"parameters_json": "{\"builder_name\":\"Deterministic Fuchsia (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"616fe743ff71e1883edfc3b27a5e0af865778fce\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Fuchsia (dbg)",
"scheduler_invocation_id:9022872244854339616",
"scheduler_job_id:chromium/Deterministic Fuchsia (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/616fe743ff71e1883edfc3b27a5e0af865778fce",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/616fe743ff71e1883edfc3b27a5e0af865778fce",
"gitiles_ref:refs/heads/master"
]
}
[02:18:24.772] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611281903453314",
"id": "8857442182763130688",
"parameters_json": "{\"builder_name\": \"Deterministic Fuchsia (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"616fe743ff71e1883edfc3b27a5e0af865778fce\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611281904542210",
"tags": [
"build_address:luci.chromium.ci/Deterministic Fuchsia (dbg)/6614",
"builder:Deterministic Fuchsia (dbg)",
"buildset:commit/git/616fe743ff71e1883edfc3b27a5e0af865778fce",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/616fe743ff71e1883edfc3b27a5e0af865778fce",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022872244854339616",
"scheduler_job_id:chromium/Deterministic Fuchsia (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857442182763130688/+/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": "1611281904542353",
"url": "https://ci.chromium.org/b/8857442182763130688",
"utcnow_ts": "1611281904759235"
}
}
[02:18:24.773] Task URL: https://ci.chromium.org/b/8857442182763130688
[02:18:24.773] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:2:0) after 1m0s
[02:18:27.501] Received PubSub notification, asking Buildbucket for the build status
[02:18:27.582] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:24.788] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:2:0)
[02:19:24.788] Timer tick, asking Buildbucket for the build status
[02:19:24.883] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:24.883] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:4:0) after 1m0s
[02:20:24.979] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:4:0)
[02:20:24.979] Timer tick, asking Buildbucket for the build status
[02:20:25.063] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:25.063] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:5:0) after 1m0s
[02:21:25.084] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:5:0)
[02:21:25.084] Timer tick, asking Buildbucket for the build status
[02:21:25.186] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:25.186] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:6:0) after 1m0s
[02:22:25.301] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:6:0)
[02:22:25.301] Timer tick, asking Buildbucket for the build status
[02:22:25.785] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:25.785] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:7:0) after 1m0s
[02:23:25.781] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:7:0)
[02:23:25.781] Timer tick, asking Buildbucket for the build status
[02:23:25.936] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:25.936] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:8:0) after 1m0s
[02:24:25.965] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:8:0)
[02:24:25.965] Timer tick, asking Buildbucket for the build status
[02:24:26.071] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:26.071] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:9:0) after 1m0s
[02:25:26.099] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:9:0)
[02:25:26.099] Timer tick, asking Buildbucket for the build status
[02:25:26.175] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:26.175] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:10:0) after 1m0s
[02:26:26.295] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:10:0)
[02:26:26.295] Timer tick, asking Buildbucket for the build status
[02:26:26.449] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:26.449] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:11:0) after 1m0s
[02:27:26.586] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:11:0)
[02:27:26.586] Timer tick, asking Buildbucket for the build status
[02:27:26.747] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:26.747] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:12:0) after 1m0s
[02:28:26.763] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:12:0)
[02:28:26.763] Timer tick, asking Buildbucket for the build status
[02:28:27.506] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:27.506] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:13:0) after 1m0s
[02:29:27.626] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:13:0)
[02:29:27.626] Timer tick, asking Buildbucket for the build status
[02:29:27.723] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:27.723] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:14:0) after 1m0s
[02:30:27.794] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:14:0)
[02:30:27.794] Timer tick, asking Buildbucket for the build status
[02:30:28.029] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:28.029] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:15:0) after 1m0s
[02:31:28.105] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:15:0)
[02:31:28.105] Timer tick, asking Buildbucket for the build status
[02:31:28.176] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:28.176] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:16:0) after 1m0s
[02:32:28.228] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:16:0)
[02:32:28.228] Timer tick, asking Buildbucket for the build status
[02:32:28.575] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:28.575] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:17:0) after 1m0s
[02:33:28.603] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:17:0)
[02:33:28.603] Timer tick, asking Buildbucket for the build status
[02:33:28.709] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:28.709] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:18:0) after 1m0s
[02:34:28.758] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:18:0)
[02:34:28.758] Timer tick, asking Buildbucket for the build status
[02:34:29.037] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:29.037] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:19:0) after 1m0s
[02:35:29.043] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:19:0)
[02:35:29.043] Timer tick, asking Buildbucket for the build status
[02:35:29.299] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:29.299] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:20:0) after 1m0s
[02:36:29.324] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:20:0)
[02:36:29.324] Timer tick, asking Buildbucket for the build status
[02:36:29.463] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:29.463] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:21:0) after 1m0s
[02:37:29.497] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:21:0)
[02:37:29.497] Timer tick, asking Buildbucket for the build status
[02:37:29.578] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:29.578] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:22:0) after 1m0s
[02:38:29.562] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:22:0)
[02:38:29.562] Timer tick, asking Buildbucket for the build status
[02:38:29.727] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:29.727] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:23:0) after 1m0s
[02:39:29.756] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:23:0)
[02:39:29.756] Timer tick, asking Buildbucket for the build status
[02:39:29.847] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:29.847] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:24:0) after 1m0s
[02:40:29.861] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:24:0)
[02:40:29.861] Timer tick, asking Buildbucket for the build status
[02:40:29.931] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:29.931] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:25:0) after 1m0s
[02:41:29.956] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:25:0)
[02:41:29.956] Timer tick, asking Buildbucket for the build status
[02:41:30.032] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:30.032] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:26:0) after 1m0s
[02:42:30.111] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:26:0)
[02:42:30.111] Timer tick, asking Buildbucket for the build status
[02:42:30.180] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:30.180] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:27:0) after 1m0s
[02:43:30.240] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:27:0)
[02:43:30.240] Timer tick, asking Buildbucket for the build status
[02:43:30.390] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:30.390] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:28:0) after 1m0s
[02:44:30.475] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:28:0)
[02:44:30.475] Timer tick, asking Buildbucket for the build status
[02:44:30.555] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:30.555] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:29:0) after 1m0s
[02:45:30.606] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:29:0)
[02:45:30.606] Timer tick, asking Buildbucket for the build status
[02:45:30.803] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:30.803] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:30:0) after 1m0s
[02:46:30.830] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:30:0)
[02:46:30.830] Timer tick, asking Buildbucket for the build status
[02:46:31.105] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:31.105] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:31:0) after 1m0s
[02:47:31.208] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:31:0)
[02:47:31.208] Timer tick, asking Buildbucket for the build status
[02:47:31.318] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:31.318] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:32:0) after 1m0s
[02:48:31.351] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:32:0)
[02:48:31.351] Timer tick, asking Buildbucket for the build status
[02:48:31.467] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:31.467] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:33:0) after 1m0s
[02:49:31.534] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:33:0)
[02:49:31.534] Timer tick, asking Buildbucket for the build status
[02:49:31.598] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:31.598] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:34:0) after 1m0s
[02:50:31.632] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:34:0)
[02:50:31.632] Timer tick, asking Buildbucket for the build status
[02:50:31.725] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:31.725] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:35:0) after 1m0s
[02:51:31.748] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:35:0)
[02:51:31.748] Timer tick, asking Buildbucket for the build status
[02:51:32.036] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:32.036] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:36:0) after 1m0s
[02:52:32.125] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:36:0)
[02:52:32.125] Timer tick, asking Buildbucket for the build status
[02:52:32.411] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:32.411] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:37:0) after 1m0s
[02:53:32.434] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:37:0)
[02:53:32.435] Timer tick, asking Buildbucket for the build status
[02:53:32.856] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:32.856] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:38:0) after 1m0s
[02:54:32.929] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:38:0)
[02:54:32.929] Timer tick, asking Buildbucket for the build status
[02:54:33.058] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:33.058] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:39:0) after 1m0s
[02:55:33.078] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:39:0)
[02:55:33.078] Timer tick, asking Buildbucket for the build status
[02:55:33.153] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:33.153] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:40:0) after 1m0s
[02:56:33.201] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:40:0)
[02:56:33.201] Timer tick, asking Buildbucket for the build status
[02:56:33.302] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:33.302] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:41:0) after 1m0s
[02:57:33.430] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:41:0)
[02:57:33.430] Timer tick, asking Buildbucket for the build status
[02:57:33.496] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:33.496] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:42:0) after 1m0s
[02:58:33.515] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:42:0)
[02:58:33.515] Timer tick, asking Buildbucket for the build status
[02:58:33.615] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:33.615] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:43:0) after 1m0s
[02:59:33.715] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:43:0)
[02:59:33.716] Timer tick, asking Buildbucket for the build status
[02:59:33.786] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:33.786] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:44:0) after 1m0s
[03:00:33.880] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:44:0)
[03:00:33.880] Timer tick, asking Buildbucket for the build status
[03:00:34.190] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:34.191] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:45:0) after 1m0s
[03:01:34.418] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:45:0)
[03:01:34.418] Timer tick, asking Buildbucket for the build status
[03:01:34.790] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:34.790] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:46:0) after 1m0s
[03:02:34.994] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:46:0)
[03:02:34.994] Timer tick, asking Buildbucket for the build status
[03:02:35.057] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:35.057] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:47:0) after 1m0s
[03:03:35.179] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:47:0)
[03:03:35.179] Timer tick, asking Buildbucket for the build status
[03:03:35.293] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:35.293] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:48:0) after 1m0s
[03:04:35.404] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:48:0)
[03:04:35.404] Timer tick, asking Buildbucket for the build status
[03:04:35.482] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:35.482] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:49:0) after 1m0s
[03:05:35.573] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:49:0)
[03:05:35.573] Timer tick, asking Buildbucket for the build status
[03:05:35.645] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:35.645] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:50:0) after 1m0s
[03:06:35.667] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:50:0)
[03:06:35.667] Timer tick, asking Buildbucket for the build status
[03:06:35.727] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:35.727] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:51:0) after 1m0s
[03:07:35.837] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:51:0)
[03:07:35.837] Timer tick, asking Buildbucket for the build status
[03:07:36.951] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:36.951] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:52:0) after 1m0s
[03:08:36.957] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:52:0)
[03:08:36.957] Timer tick, asking Buildbucket for the build status
[03:08:37.145] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:37.145] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:53:0) after 1m0s
[03:09:37.186] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:53:0)
[03:09:37.186] Timer tick, asking Buildbucket for the build status
[03:09:37.245] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:37.245] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:54:0) after 1m0s
[03:10:37.352] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:54:0)
[03:10:37.352] Timer tick, asking Buildbucket for the build status
[03:10:37.605] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:37.605] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:55:0) after 1m0s
[03:11:37.668] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:55:0)
[03:11:37.668] Timer tick, asking Buildbucket for the build status
[03:11:37.896] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:37.896] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:56:0) after 1m0s
[03:12:39.453] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:56:0)
[03:12:39.453] Timer tick, asking Buildbucket for the build status
[03:12:39.510] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:39.510] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:57:0) after 1m0s
[03:13:39.535] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:57:0)
[03:13:39.535] Timer tick, asking Buildbucket for the build status
[03:13:39.824] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:39.824] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:58:0) after 1m0s
[03:14:39.798] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:58:0)
[03:14:39.798] Timer tick, asking Buildbucket for the build status
[03:14:39.845] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:39.845] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:59:0) after 1m0s
[03:15:39.907] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:59:0)
[03:15:39.907] Timer tick, asking Buildbucket for the build status
[03:15:40.269] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:40.269] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:60:0) after 1m0s
[03:16:40.351] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:60:0)
[03:16:40.351] Timer tick, asking Buildbucket for the build status
[03:16:40.514] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:40.514] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:61:0) after 1m0s
[03:17:40.562] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:61:0)
[03:17:40.562] Timer tick, asking Buildbucket for the build status
[03:17:40.734] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:40.734] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:62:0) after 1m0s
[03:18:40.826] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:62:0)
[03:18:40.826] Timer tick, asking Buildbucket for the build status
[03:18:40.992] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:40.992] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:63:0) after 1m0s
[03:19:40.975] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:63:0)
[03:19:40.975] Timer tick, asking Buildbucket for the build status
[03:19:41.230] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:41.230] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:64:0) after 1m0s
[03:20:41.257] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:64:0)
[03:20:41.257] Timer tick, asking Buildbucket for the build status
[03:20:41.975] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:41.975] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:65:0) after 1m0s
[03:21:42.036] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:65:0)
[03:21:42.036] Timer tick, asking Buildbucket for the build status
[03:21:42.121] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:42.121] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:66:0) after 1m0s
[03:22:42.144] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:66:0)
[03:22:42.144] Timer tick, asking Buildbucket for the build status
[03:22:42.259] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:42.259] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:67:0) after 1m0s
[03:23:42.309] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:67:0)
[03:23:42.309] Timer tick, asking Buildbucket for the build status
[03:23:42.467] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:42.467] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:68:0) after 1m0s
[03:24:42.522] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:68:0)
[03:24:42.522] Timer tick, asking Buildbucket for the build status
[03:24:43.699] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:43.699] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:69:0) after 1m0s
[03:25:43.719] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:69:0)
[03:25:43.719] Timer tick, asking Buildbucket for the build status
[03:25:43.776] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:43.776] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:70:0) after 1m0s
[03:26:43.855] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:70:0)
[03:26:43.855] Timer tick, asking Buildbucket for the build status
[03:26:43.988] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:43.988] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:71:0) after 1m0s
[03:27:44.124] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:71:0)
[03:27:44.124] Timer tick, asking Buildbucket for the build status
[03:27:44.197] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:44.197] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:72:0) after 1m0s
[03:28:44.210] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:72:0)
[03:28:44.210] Timer tick, asking Buildbucket for the build status
[03:28:44.626] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:44.626] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:73:0) after 1m0s
[03:29:44.722] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:73:0)
[03:29:44.722] Timer tick, asking Buildbucket for the build status
[03:29:44.792] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:44.792] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:74:0) after 1m0s
[03:30:44.816] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:74:0)
[03:30:44.817] Timer tick, asking Buildbucket for the build status
[03:30:44.907] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:44.907] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:75:0) after 1m0s
[03:31:44.890] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:75:0)
[03:31:44.890] Timer tick, asking Buildbucket for the build status
[03:31:45.299] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:45.299] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:76:0) after 1m0s
[03:32:45.400] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:76:0)
[03:32:45.400] Timer tick, asking Buildbucket for the build status
[03:32:45.502] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:45.502] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:77:0) after 1m0s
[03:33:45.530] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:77:0)
[03:33:45.530] Timer tick, asking Buildbucket for the build status
[03:33:45.861] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:45.861] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:78:0) after 1m0s
[03:34:45.930] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:78:0)
[03:34:45.930] Timer tick, asking Buildbucket for the build status
[03:34:46.123] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:46.123] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:79:0) after 1m0s
[03:35:46.595] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:79:0)
[03:35:46.595] Timer tick, asking Buildbucket for the build status
[03:35:47.118] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:47.118] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:80:0) after 1m0s
[03:36:47.149] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:80:0)
[03:36:47.149] Timer tick, asking Buildbucket for the build status
[03:36:47.335] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:47.335] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:81:0) after 1m0s
[03:37:47.395] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:81:0)
[03:37:47.395] Timer tick, asking Buildbucket for the build status
[03:37:47.504] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:47.504] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:82:0) after 1m0s
[03:38:47.604] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:82:0)
[03:38:47.604] Timer tick, asking Buildbucket for the build status
[03:38:48.217] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:48.217] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:83:0) after 1m0s
[03:39:48.378] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:83:0)
[03:39:48.378] Timer tick, asking Buildbucket for the build status
[03:39:48.445] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:48.445] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:84:0) after 1m0s
[03:40:48.460] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:84:0)
[03:40:48.460] Timer tick, asking Buildbucket for the build status
[03:40:48.628] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:48.628] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:85:0) after 1m0s
[03:41:48.698] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:85:0)
[03:41:48.698] Timer tick, asking Buildbucket for the build status
[03:41:49.007] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:49.007] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:86:0) after 1m0s
[03:42:49.047] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:86:0)
[03:42:49.047] Timer tick, asking Buildbucket for the build status
[03:42:49.122] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:49.122] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:87:0) after 1m0s
[03:43:49.192] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:87:0)
[03:43:49.192] Timer tick, asking Buildbucket for the build status
[03:43:49.327] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:49.327] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:88:0) after 1m0s
[03:44:49.409] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:88:0)
[03:44:49.409] Timer tick, asking Buildbucket for the build status
[03:44:49.556] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:49.556] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:89:0) after 1m0s
[03:45:49.705] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:89:0)
[03:45:49.705] Timer tick, asking Buildbucket for the build status
[03:45:49.857] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:49.857] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:90:0) after 1m0s
[03:46:49.975] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:90:0)
[03:46:49.975] Timer tick, asking Buildbucket for the build status
[03:46:50.425] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:50.425] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:91:0) after 1m0s
[03:47:50.587] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:91:0)
[03:47:50.587] Timer tick, asking Buildbucket for the build status
[03:47:50.714] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:50.714] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:92:0) after 1m0s
[03:48:50.754] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:92:0)
[03:48:50.754] Timer tick, asking Buildbucket for the build status
[03:48:51.160] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:51.160] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:93:0) after 1m0s
[03:49:51.269] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:93:0)
[03:49:51.269] Timer tick, asking Buildbucket for the build status
[03:49:51.473] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:51.473] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:94:0) after 1m0s
[03:50:51.503] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:94:0)
[03:50:51.503] Timer tick, asking Buildbucket for the build status
[03:50:51.612] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:51.612] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:95:0) after 1m0s
[03:51:51.820] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:95:0)
[03:51:51.820] Timer tick, asking Buildbucket for the build status
[03:51:52.150] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:52.150] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:96:0) after 1m0s
[03:52:52.215] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:96:0)
[03:52:52.215] Timer tick, asking Buildbucket for the build status
[03:52:52.272] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:52.272] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:97:0) after 1m0s
[03:53:52.320] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:97:0)
[03:53:52.320] Timer tick, asking Buildbucket for the build status
[03:53:52.694] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:52.694] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:98:0) after 1m0s
[03:54:53.217] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:98:0)
[03:54:53.217] Timer tick, asking Buildbucket for the build status
[03:54:53.431] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:53.431] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:99:0) after 1m0s
[03:55:53.856] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:99:0)
[03:55:53.856] Timer tick, asking Buildbucket for the build status
[03:55:53.915] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:53.915] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:100:0) after 1m0s
[03:56:53.914] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:100:0)
[03:56:53.914] Timer tick, asking Buildbucket for the build status
[03:56:54.125] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:54.125] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:101:0) after 1m0s
[03:57:54.253] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:101:0)
[03:57:54.253] Timer tick, asking Buildbucket for the build status
[03:57:54.471] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:54.471] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:102:0) after 1m0s
[03:58:54.691] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:102:0)
[03:58:54.691] Timer tick, asking Buildbucket for the build status
[03:58:54.970] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:54.970] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:103:0) after 1m0s
[03:59:55.029] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:103:0)
[03:59:55.029] Timer tick, asking Buildbucket for the build status
[03:59:55.125] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:55.125] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:104:0) after 1m0s
[04:00:55.302] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:104:0)
[04:00:55.302] Timer tick, asking Buildbucket for the build status
[04:00:55.375] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:55.375] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:105:0) after 1m0s
[04:01:55.547] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:105:0)
[04:01:55.547] Timer tick, asking Buildbucket for the build status
[04:01:55.646] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:55.646] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:106:0) after 1m0s
[04:02:55.809] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:106:0)
[04:02:55.809] Timer tick, asking Buildbucket for the build status
[04:02:55.991] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:55.991] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:107:0) after 1m0s
[04:03:56.013] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:107:0)
[04:03:56.013] Timer tick, asking Buildbucket for the build status
[04:03:56.174] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:56.174] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:108:0) after 1m0s
[04:04:56.307] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:108:0)
[04:04:56.307] Timer tick, asking Buildbucket for the build status
[04:04:56.414] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:56.414] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:109:0) after 1m0s
[04:05:56.696] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:109:0)
[04:05:56.696] Timer tick, asking Buildbucket for the build status
[04:05:56.752] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:56.752] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:110:0) after 1m0s
[04:06:56.843] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:110:0)
[04:06:56.843] Timer tick, asking Buildbucket for the build status
[04:06:57.022] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:57.022] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:111:0) after 1m0s
[04:07:57.078] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:111:0)
[04:07:57.078] Timer tick, asking Buildbucket for the build status
[04:07:57.144] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:57.144] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:112:0) after 1m0s
[04:08:57.200] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:112:0)
[04:08:57.200] Timer tick, asking Buildbucket for the build status
[04:08:57.376] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:57.376] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:113:0) after 1m0s
[04:09:57.653] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:113:0)
[04:09:57.653] Timer tick, asking Buildbucket for the build status
[04:09:57.749] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:57.749] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:114:0) after 1m0s
[04:10:57.821] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:114:0)
[04:10:57.821] Timer tick, asking Buildbucket for the build status
[04:10:57.901] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:57.901] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:115:0) after 1m0s
[04:11:58.042] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:115:0)
[04:11:58.042] Timer tick, asking Buildbucket for the build status
[04:11:58.140] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:58.140] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:116:0) after 1m0s
[04:12:58.254] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:116:0)
[04:12:58.254] Timer tick, asking Buildbucket for the build status
[04:12:59.152] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:59.152] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:117:0) after 1m0s
[04:13:59.259] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:117:0)
[04:13:59.259] Timer tick, asking Buildbucket for the build status
[04:13:59.377] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:59.377] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:118:0) after 1m0s
[04:14:59.558] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:118:0)
[04:14:59.558] Timer tick, asking Buildbucket for the build status
[04:14:59.625] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:59.625] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:119:0) after 1m0s
[04:15:59.704] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:119:0)
[04:15:59.704] Timer tick, asking Buildbucket for the build status
[04:16:00.070] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:00.070] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:120:0) after 1m0s
[04:17:00.121] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:120:0)
[04:17:00.121] Timer tick, asking Buildbucket for the build status
[04:17:00.379] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:00.379] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:121:0) after 1m0s
[04:18:00.398] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:121:0)
[04:18:00.398] Timer tick, asking Buildbucket for the build status
[04:18:00.524] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:00.524] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:122:0) after 1m0s
[04:19:00.656] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:122:0)
[04:19:00.656] Timer tick, asking Buildbucket for the build status
[04:19:00.771] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:00.771] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:123:0) after 1m0s
[04:20:00.853] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:123:0)
[04:20:00.853] Timer tick, asking Buildbucket for the build status
[04:20:00.921] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:00.921] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:124:0) after 1m0s
[04:21:01.126] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:124:0)
[04:21:01.126] Timer tick, asking Buildbucket for the build status
[04:21:01.317] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:01.317] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:125:0) after 1m0s
[04:22:01.398] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:125:0)
[04:22:01.398] Timer tick, asking Buildbucket for the build status
[04:22:01.469] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:01.469] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:126:0) after 1m0s
[04:23:01.602] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:126:0)
[04:23:01.602] Timer tick, asking Buildbucket for the build status
[04:23:01.923] Build 8857442182763130688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:01.923] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Fuchsia (dbg):9022872244854339616:127:0) after 1m0s
[04:23:24.713] Received PubSub notification, asking Buildbucket for the build status
[04:23:25.004] Build 8857442182763130688: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:23:25.004] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611289403354688",
"created_by": "project:chromium",
"created_ts": "1611281903453314",
"id": "8857442182763130688",
"parameters_json": "{\"builder_name\": \"Deterministic Fuchsia (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"616fe743ff71e1883edfc3b27a5e0af865778fce\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$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-108-0yz5\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Deterministic Fuchsia (dbg)\", \"buildnumber\": 6614, \"got_angle_revision\": \"70f493d6e6ab13cb372345af9aac58df0d5add69\", \"got_dawn_revision\": \"b5cfe3a7746c59903d3fe216e3876cb80c1d71c7\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"616fe743ff71e1883edfc3b27a5e0af865778fce\", \"got_revision_cp\": \"refs/heads/master@{#845880}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"5b36fbc5ed2b330b2bc02c93ff2bdb58d03ae051\", \"got_v8_revision\": \"bba017b40897bdf1fed939a76260569fe84bdc71\", \"got_v8_revision_cp\": \"refs/heads/9.0.42@{#1}\", \"got_webrtc_revision\": \"6031b74664d0be40d7f913600d17f6d8d1323729\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33052}\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"616fe743ff71e1883edfc3b27a5e0af865778fce\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_043ff3f52d8d01364b204065bddda74d1a1fba0b8da9301cf8e96315f69303d6_v2\", \"builder_cfdb55a1f65ed072d1fe07f7fc1107a97a5e848a8d1b6b0015401ab521f6b501_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-108-0yz5\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5671-1d9dea8\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611281906607316",
"status": "COMPLETED",
"status_changed_ts": "1611289404240543",
"tags": [
"build_address:luci.chromium.ci/Deterministic Fuchsia (dbg)/6614",
"builder:Deterministic Fuchsia (dbg)",
"buildset:commit/git/616fe743ff71e1883edfc3b27a5e0af865778fce",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/616fe743ff71e1883edfc3b27a5e0af865778fce",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022872244854339616",
"scheduler_job_id:chromium/Deterministic Fuchsia (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857442182763130688/+/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:5140b43c69585e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611289404293676",
"url": "https://ci.chromium.org/b/8857442182763130688",
"utcnow_ts": "1611289404990525"
}
}
[04:23:25.004] Invocation finished in 2h5m2.92885048s with status SUCCEEDED