[05:54:28.349] New invocation is queued and will start shortly
[05:54:29.759] Starting the invocation (attempt 1)
[05:54:29.805] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:54:29.805] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:54:29.805] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9074408322637456704",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"111c885a9b6f7861e6e69d234eb47afab26188dc\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9074408322637456704",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/111c885a9b6f7861e6e69d234eb47afab26188dc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/111c885a9b6f7861e6e69d234eb47afab26188dc",
"gitiles_ref:refs/heads/master"
]
}
[05:54:31.305] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1562133270281909",
"id": "8908978259940063344",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"111c885a9b6f7861e6e69d234eb47afab26188dc\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1562133271105967",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/23959",
"builder:Deterministic Linux",
"buildset:commit/git/111c885a9b6f7861e6e69d234eb47afab26188dc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/111c885a9b6f7861e6e69d234eb47afab26188dc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9074408322637456704",
"scheduler_job_id:chromium/Deterministic Linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8908978259940063344/+/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": "1562133271106059",
"url": "https://ci.chromium.org/b/8908978259940063344",
"utcnow_ts": "1562133271284929"
}
}
[05:54:31.305] Task URL: https://ci.chromium.org/b/8908978259940063344
[05:54:31.305] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:2:0) after 1m0s
[05:55:31.318] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:2:0)
[05:55:31.318] Timer tick, asking Buildbucket for the build status
[05:55:31.662] Build 8908978259940063344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:55:31.662] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:3:0) after 1m0s
[05:55:47.083] Received PubSub notification, asking Buildbucket for the build status
[05:55:47.351] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:31.750] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:3:0)
[05:56:31.750] Timer tick, asking Buildbucket for the build status
[05:56:31.894] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:31.894] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:5:0) after 1m0s
[05:57:31.906] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:5:0)
[05:57:31.906] Timer tick, asking Buildbucket for the build status
[05:57:32.236] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:32.236] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:6:0) after 1m0s
[05:58:32.293] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:6:0)
[05:58:32.293] Timer tick, asking Buildbucket for the build status
[05:58:32.611] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:32.611] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:7:0) after 1m0s
[05:59:32.582] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:7:0)
[05:59:32.582] Timer tick, asking Buildbucket for the build status
[05:59:32.859] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:32.859] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:8:0) after 1m0s
[06:00:32.915] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:8:0)
[06:00:32.915] Timer tick, asking Buildbucket for the build status
[06:00:33.238] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:33.238] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:9:0) after 1m0s
[06:01:33.236] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:9:0)
[06:01:33.236] Timer tick, asking Buildbucket for the build status
[06:01:35.019] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:35.019] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:10:0) after 1m0s
[06:02:35.014] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:10:0)
[06:02:35.014] Timer tick, asking Buildbucket for the build status
[06:02:36.551] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:36.551] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:11:0) after 1m0s
[06:03:36.592] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:11:0)
[06:03:36.592] Timer tick, asking Buildbucket for the build status
[06:03:38.400] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:38.400] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:12:0) after 1m0s
[06:04:38.430] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:12:0)
[06:04:38.430] Timer tick, asking Buildbucket for the build status
[06:04:38.765] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:38.765] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:13:0) after 1m0s
[06:05:38.855] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:13:0)
[06:05:38.855] Timer tick, asking Buildbucket for the build status
[06:05:41.506] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:41.506] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:14:0) after 1m0s
[06:06:41.581] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:14:0)
[06:06:41.581] Timer tick, asking Buildbucket for the build status
[06:06:41.698] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:41.698] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:15:0) after 1m0s
[06:07:41.724] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:15:0)
[06:07:41.724] Timer tick, asking Buildbucket for the build status
[06:07:42.369] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:42.369] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:16:0) after 1m0s
[06:08:42.404] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:16:0)
[06:08:42.405] Timer tick, asking Buildbucket for the build status
[06:08:42.574] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:42.574] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:17:0) after 1m0s
[06:09:42.735] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:17:0)
[06:09:42.735] Timer tick, asking Buildbucket for the build status
[06:09:44.341] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:44.341] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:18:0) after 1m0s
[06:10:44.352] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:18:0)
[06:10:44.352] Timer tick, asking Buildbucket for the build status
[06:10:44.488] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:44.489] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:19:0) after 1m0s
[06:11:44.531] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:19:0)
[06:11:44.531] Timer tick, asking Buildbucket for the build status
[06:11:45.342] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:45.342] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:20:0) after 1m0s
[06:12:45.394] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:20:0)
[06:12:45.394] Timer tick, asking Buildbucket for the build status
[06:12:45.545] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:45.545] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:21:0) after 1m0s
[06:13:45.597] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:21:0)
[06:13:45.598] Timer tick, asking Buildbucket for the build status
[06:13:46.234] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:46.234] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:22:0) after 1m0s
[06:14:46.327] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:22:0)
[06:14:46.327] Timer tick, asking Buildbucket for the build status
[06:14:46.456] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:46.456] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:23:0) after 1m0s
[06:15:46.491] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:23:0)
[06:15:46.491] Timer tick, asking Buildbucket for the build status
[06:15:47.288] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:47.288] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:24:0) after 1m0s
[06:16:47.415] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:24:0)
[06:16:47.415] Timer tick, asking Buildbucket for the build status
[06:16:47.634] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:47.634] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:25:0) after 1m0s
[06:17:47.626] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:25:0)
[06:17:47.626] Timer tick, asking Buildbucket for the build status
[06:17:47.774] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:47.774] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:26:0) after 1m0s
[06:18:47.767] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:26:0)
[06:18:47.767] Timer tick, asking Buildbucket for the build status
[06:18:47.955] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:47.955] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:27:0) after 1m0s
[06:19:48.065] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:27:0)
[06:19:48.066] Timer tick, asking Buildbucket for the build status
[06:19:49.132] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:49.132] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:28:0) after 1m0s
[06:20:49.229] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:28:0)
[06:20:49.229] Timer tick, asking Buildbucket for the build status
[06:20:50.022] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:50.022] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:29:0) after 1m0s
[06:21:50.234] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:29:0)
[06:21:50.234] Timer tick, asking Buildbucket for the build status
[06:21:50.403] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:50.403] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:30:0) after 1m0s
[06:22:50.466] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:30:0)
[06:22:50.466] Timer tick, asking Buildbucket for the build status
[06:22:51.433] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:51.433] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:31:0) after 1m0s
[06:23:51.488] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:31:0)
[06:23:51.488] Timer tick, asking Buildbucket for the build status
[06:23:51.628] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:51.628] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:32:0) after 1m0s
[06:24:51.719] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:32:0)
[06:24:51.719] Timer tick, asking Buildbucket for the build status
[06:24:53.119] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:53.119] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:33:0) after 1m0s
[06:25:53.198] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:33:0)
[06:25:53.198] Timer tick, asking Buildbucket for the build status
[06:25:53.414] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:53.414] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:34:0) after 1m0s
[06:26:53.472] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:34:0)
[06:26:53.472] Timer tick, asking Buildbucket for the build status
[06:26:53.714] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:53.714] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:35:0) after 1m0s
[06:27:53.811] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:35:0)
[06:27:53.811] Timer tick, asking Buildbucket for the build status
[06:27:54.044] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:54.044] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:36:0) after 1m0s
[06:28:54.069] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:36:0)
[06:28:54.069] Timer tick, asking Buildbucket for the build status
[06:28:54.669] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:54.669] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:37:0) after 1m0s
[06:29:54.708] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:37:0)
[06:29:54.708] Timer tick, asking Buildbucket for the build status
[06:29:55.286] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:55.286] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:38:0) after 1m0s
[06:30:55.306] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:38:0)
[06:30:55.306] Timer tick, asking Buildbucket for the build status
[06:30:55.509] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:55.509] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:39:0) after 1m0s
[06:31:55.538] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:39:0)
[06:31:55.538] Timer tick, asking Buildbucket for the build status
[06:31:55.706] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:55.706] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:40:0) after 1m0s
[06:32:55.755] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:40:0)
[06:32:55.755] Timer tick, asking Buildbucket for the build status
[06:32:56.156] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:56.156] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:41:0) after 1m0s
[06:33:56.214] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:41:0)
[06:33:56.214] Timer tick, asking Buildbucket for the build status
[06:33:56.351] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:56.351] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:42:0) after 1m0s
[06:34:56.441] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:42:0)
[06:34:56.441] Timer tick, asking Buildbucket for the build status
[06:34:57.327] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:57.327] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:43:0) after 1m0s
[06:35:57.424] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:43:0)
[06:35:57.424] Timer tick, asking Buildbucket for the build status
[06:35:58.112] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:58.112] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:44:0) after 1m0s
[06:36:58.134] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:44:0)
[06:36:58.134] Timer tick, asking Buildbucket for the build status
[06:36:58.821] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:58.821] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:45:0) after 1m0s
[06:37:58.868] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:45:0)
[06:37:58.868] Timer tick, asking Buildbucket for the build status
[06:38:00.816] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:00.816] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:46:0) after 1m0s
[06:39:00.912] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:46:0)
[06:39:00.912] Timer tick, asking Buildbucket for the build status
[06:39:01.047] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:01.047] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:47:0) after 1m0s
[06:40:01.171] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:47:0)
[06:40:01.171] Timer tick, asking Buildbucket for the build status
[06:40:02.073] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:02.073] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:48:0) after 1m0s
[06:41:02.337] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:48:0)
[06:41:02.337] Timer tick, asking Buildbucket for the build status
[06:41:03.057] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:03.057] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:49:0) after 1m0s
[06:42:03.126] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:49:0)
[06:42:03.126] Timer tick, asking Buildbucket for the build status
[06:42:03.332] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:03.332] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:50:0) after 1m0s
[06:43:03.397] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:50:0)
[06:43:03.397] Timer tick, asking Buildbucket for the build status
[06:43:04.818] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:04.818] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:51:0) after 1m0s
[06:44:04.792] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:51:0)
[06:44:04.792] Timer tick, asking Buildbucket for the build status
[06:44:04.930] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:04.930] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:52:0) after 1m0s
[06:45:04.953] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:52:0)
[06:45:04.953] Timer tick, asking Buildbucket for the build status
[06:45:05.142] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:05.142] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:53:0) after 1m0s
[06:46:05.198] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:53:0)
[06:46:05.198] Timer tick, asking Buildbucket for the build status
[06:46:05.339] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:05.339] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:54:0) after 1m0s
[06:47:05.374] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:54:0)
[06:47:05.374] Timer tick, asking Buildbucket for the build status
[06:47:05.634] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:05.634] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:55:0) after 1m0s
[06:48:05.672] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:55:0)
[06:48:05.672] Timer tick, asking Buildbucket for the build status
[06:48:05.824] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:05.824] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:56:0) after 1m0s
[06:49:05.863] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:56:0)
[06:49:05.863] Timer tick, asking Buildbucket for the build status
[06:49:06.453] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:06.453] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:57:0) after 1m0s
[06:50:06.478] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:57:0)
[06:50:06.478] Timer tick, asking Buildbucket for the build status
[06:50:07.065] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:07.065] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:58:0) after 1m0s
[06:51:07.123] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:58:0)
[06:51:07.123] Timer tick, asking Buildbucket for the build status
[06:51:07.237] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:07.237] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:59:0) after 1m0s
[06:52:07.273] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:59:0)
[06:52:07.273] Timer tick, asking Buildbucket for the build status
[06:52:07.432] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:07.432] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:60:0) after 1m0s
[06:53:07.534] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:60:0)
[06:53:07.534] Timer tick, asking Buildbucket for the build status
[06:53:07.928] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:07.928] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:61:0) after 1m0s
[06:54:08.518] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:61:0)
[06:54:08.518] Timer tick, asking Buildbucket for the build status
[06:54:08.921] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:08.921] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:62:0) after 1m0s
[06:55:09.374] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:62:0)
[06:55:09.374] Timer tick, asking Buildbucket for the build status
[06:55:10.086] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:10.086] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:63:0) after 1m0s
[06:56:10.188] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:63:0)
[06:56:10.188] Timer tick, asking Buildbucket for the build status
[06:56:10.314] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:10.314] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:64:0) after 1m0s
[06:57:10.494] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:64:0)
[06:57:10.494] Timer tick, asking Buildbucket for the build status
[06:57:10.730] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:10.730] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:65:0) after 1m0s
[06:58:10.787] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:65:0)
[06:58:10.787] Timer tick, asking Buildbucket for the build status
[06:58:11.693] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:11.693] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:66:0) after 1m0s
[06:59:11.928] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:66:0)
[06:59:11.928] Timer tick, asking Buildbucket for the build status
[06:59:12.195] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:12.195] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:67:0) after 1m0s
[07:00:12.435] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:67:0)
[07:00:12.435] Timer tick, asking Buildbucket for the build status
[07:00:14.474] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:14.474] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:68:0) after 1m0s
[07:01:14.552] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:68:0)
[07:01:14.552] Timer tick, asking Buildbucket for the build status
[07:01:15.242] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:15.242] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:69:0) after 1m0s
[07:02:15.342] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:69:0)
[07:02:15.342] Timer tick, asking Buildbucket for the build status
[07:02:15.481] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:15.481] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:70:0) after 1m0s
[07:03:15.669] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:70:0)
[07:03:15.669] Timer tick, asking Buildbucket for the build status
[07:03:15.848] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:15.848] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:71:0) after 1m0s
[07:04:16.168] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:71:0)
[07:04:16.168] Timer tick, asking Buildbucket for the build status
[07:04:16.505] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:16.505] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:72:0) after 1m0s
[07:05:16.726] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:72:0)
[07:05:16.726] Timer tick, asking Buildbucket for the build status
[07:05:20.514] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:20.514] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:73:0) after 1m0s
[07:06:20.838] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:73:0)
[07:06:20.838] Timer tick, asking Buildbucket for the build status
[07:06:21.468] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:21.468] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:74:0) after 1m0s
[07:07:21.496] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:74:0)
[07:07:21.496] Timer tick, asking Buildbucket for the build status
[07:07:22.423] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:22.423] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:75:0) after 1m0s
[07:08:22.492] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:75:0)
[07:08:22.492] Timer tick, asking Buildbucket for the build status
[07:08:23.030] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:23.030] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:76:0) after 1m0s
[07:09:23.057] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:76:0)
[07:09:23.057] Timer tick, asking Buildbucket for the build status
[07:09:24.491] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:24.491] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:77:0) after 1m0s
[07:10:24.622] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:77:0)
[07:10:24.622] Timer tick, asking Buildbucket for the build status
[07:10:25.450] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:25.450] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:78:0) after 1m0s
[07:11:25.588] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:78:0)
[07:11:25.588] Timer tick, asking Buildbucket for the build status
[07:11:27.470] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:27.470] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:79:0) after 1m0s
[07:12:27.479] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:79:0)
[07:12:27.479] Timer tick, asking Buildbucket for the build status
[07:12:28.290] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:28.290] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:80:0) after 1m0s
[07:13:28.395] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:80:0)
[07:13:28.395] Timer tick, asking Buildbucket for the build status
[07:13:29.326] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:29.326] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:81:0) after 1m0s
[07:14:29.398] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:81:0)
[07:14:29.398] Timer tick, asking Buildbucket for the build status
[07:14:30.169] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:30.169] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:82:0) after 1m0s
[07:15:30.207] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:82:0)
[07:15:30.207] Timer tick, asking Buildbucket for the build status
[07:15:31.721] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:31.721] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:83:0) after 1m0s
[07:16:31.744] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:83:0)
[07:16:31.744] Timer tick, asking Buildbucket for the build status
[07:16:34.439] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:34.439] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:84:0) after 1m0s
[07:17:34.503] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:84:0)
[07:17:34.503] Timer tick, asking Buildbucket for the build status
[07:17:34.748] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:34.748] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:85:0) after 1m0s
[07:18:34.765] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:85:0)
[07:18:34.765] Timer tick, asking Buildbucket for the build status
[07:18:36.226] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:36.226] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:86:0) after 1m0s
[07:19:36.280] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:86:0)
[07:19:36.280] Timer tick, asking Buildbucket for the build status
[07:19:36.426] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:36.426] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:87:0) after 1m0s
[07:20:36.471] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:87:0)
[07:20:36.471] Timer tick, asking Buildbucket for the build status
[07:20:36.632] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:36.632] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:88:0) after 1m0s
[07:21:36.659] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:88:0)
[07:21:36.659] Timer tick, asking Buildbucket for the build status
[07:21:36.810] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:36.810] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:89:0) after 1m0s
[07:22:36.841] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:89:0)
[07:22:36.841] Timer tick, asking Buildbucket for the build status
[07:22:38.223] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:38.223] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:90:0) after 1m0s
[07:23:38.494] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:90:0)
[07:23:38.494] Timer tick, asking Buildbucket for the build status
[07:23:39.503] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:39.503] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:91:0) after 1m0s
[07:24:39.750] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:91:0)
[07:24:39.750] Timer tick, asking Buildbucket for the build status
[07:24:39.845] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:39.845] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:92:0) after 1m0s
[07:25:39.919] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:92:0)
[07:25:39.919] Timer tick, asking Buildbucket for the build status
[07:25:40.131] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:40.131] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:93:0) after 1m0s
[07:26:40.131] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:93:0)
[07:26:40.131] Timer tick, asking Buildbucket for the build status
[07:26:41.763] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:41.763] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:94:0) after 1m0s
[07:27:41.786] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:94:0)
[07:27:41.786] Timer tick, asking Buildbucket for the build status
[07:27:42.062] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:42.062] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:95:0) after 1m0s
[07:28:42.160] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:95:0)
[07:28:42.160] Timer tick, asking Buildbucket for the build status
[07:28:42.383] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:42.383] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:96:0) after 1m0s
[07:29:42.438] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:96:0)
[07:29:42.438] Timer tick, asking Buildbucket for the build status
[07:29:42.885] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:42.885] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:97:0) after 1m0s
[07:30:42.934] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:97:0)
[07:30:42.934] Timer tick, asking Buildbucket for the build status
[07:30:43.502] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:43.502] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:98:0) after 1m0s
[07:31:43.498] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:98:0)
[07:31:43.498] Timer tick, asking Buildbucket for the build status
[07:31:43.626] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:43.626] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:99:0) after 1m0s
[07:32:43.936] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:99:0)
[07:32:43.936] Timer tick, asking Buildbucket for the build status
[07:32:47.146] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:47.146] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:100:0) after 1m0s
[07:33:47.266] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:100:0)
[07:33:47.266] Timer tick, asking Buildbucket for the build status
[07:33:47.434] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:47.434] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:101:0) after 1m0s
[07:34:47.507] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:101:0)
[07:34:47.507] Timer tick, asking Buildbucket for the build status
[07:34:48.231] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:48.231] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:102:0) after 1m0s
[07:35:48.227] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:102:0)
[07:35:48.227] Timer tick, asking Buildbucket for the build status
[07:35:48.751] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:48.751] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:103:0) after 1m0s
[07:36:48.780] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:103:0)
[07:36:48.780] Timer tick, asking Buildbucket for the build status
[07:36:49.263] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:49.263] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:104:0) after 1m0s
[07:37:49.318] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:104:0)
[07:37:49.318] Timer tick, asking Buildbucket for the build status
[07:37:50.616] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:50.616] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:105:0) after 1m0s
[07:38:50.646] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:105:0)
[07:38:50.646] Timer tick, asking Buildbucket for the build status
[07:38:51.671] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:51.671] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:106:0) after 1m0s
[07:39:51.744] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:106:0)
[07:39:51.744] Timer tick, asking Buildbucket for the build status
[07:39:51.915] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:51.915] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:107:0) after 1m0s
[07:40:51.945] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:107:0)
[07:40:51.945] Timer tick, asking Buildbucket for the build status
[07:40:52.704] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:52.704] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:108:0) after 1m0s
[07:41:52.821] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:108:0)
[07:41:52.821] Timer tick, asking Buildbucket for the build status
[07:41:55.297] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:55.297] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:109:0) after 1m0s
[07:42:55.344] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:109:0)
[07:42:55.344] Timer tick, asking Buildbucket for the build status
[07:42:55.450] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:55.450] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:110:0) after 1m0s
[07:43:55.573] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:110:0)
[07:43:55.573] Timer tick, asking Buildbucket for the build status
[07:43:58.280] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:58.280] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:111:0) after 1m0s
[07:44:58.351] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:111:0)
[07:44:58.351] Timer tick, asking Buildbucket for the build status
[07:44:58.661] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:58.661] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:112:0) after 1m0s
[07:45:58.665] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:112:0)
[07:45:58.665] Timer tick, asking Buildbucket for the build status
[07:45:58.936] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:58.936] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:113:0) after 1m0s
[07:46:59.147] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:113:0)
[07:46:59.147] Timer tick, asking Buildbucket for the build status
[07:47:00.595] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:00.595] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:114:0) after 1m0s
[07:48:00.705] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:114:0)
[07:48:00.705] Timer tick, asking Buildbucket for the build status
[07:48:00.966] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:00.966] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:115:0) after 1m0s
[07:49:01.213] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:115:0)
[07:49:01.213] Timer tick, asking Buildbucket for the build status
[07:49:01.487] Build 8908978259940063344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:01.487] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074408322637456704:116:0) after 1m0s
[07:49:23.983] Received PubSub notification, asking Buildbucket for the build status
[07:49:27.935] Build 8908978259940063344: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:49:27.935] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1562140162028429",
"created_by": "project:chromium",
"created_ts": "1562133270281909",
"id": "8908978259940063344",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"111c885a9b6f7861e6e69d234eb47afab26188dc\"}}",
"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-trusty-8-26-hjnn\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 23959, \"got_angle_revision\": \"da904484bfc696193c15d89c9c6e847afeb978cc\", \"got_dawn_revision\": \"72508d6d0634bdb28353c2ec26bbe79307ab916a\", \"got_nacl_revision\": \"c4cf6f0621b94cca4053b19fa01ef329f5663880\", \"got_revision\": \"111c885a9b6f7861e6e69d234eb47afab26188dc\", \"got_revision_cp\": \"refs/heads/master@{#674356}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"a4cb97163e7ad16785b95bb2ac21e0a9770a176e\", \"got_v8_revision_cp\": \"refs/heads/7.7.178@{#1}\", \"got_webrtc_revision\": \"02d7d353a90bccc6fdd0e517af31fab50944d31c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28453}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"111c885a9b6f7861e6e69d234eb47afab26188dc\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_662609c3a18ad850d61ba5f58749e60478bc4d9d576475e0c738a1c9e2d8d890_v2\", \"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-trusty-8-26-hjnn\"], \"image\": [\"chrome-trusty-19041600-95c8804d634\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4359-fba09b1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1562133346106530",
"status": "COMPLETED",
"status_changed_ts": "1562140163252275",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/23959",
"builder:Deterministic Linux",
"buildset:commit/git/111c885a9b6f7861e6e69d234eb47afab26188dc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/111c885a9b6f7861e6e69d234eb47afab26188dc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9074408322637456704",
"scheduler_job_id:chromium/Deterministic Linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8908978259940063344/+/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:45cf387b22b2e910",
"user_agent:luci-scheduler"
],
"updated_ts": "1562140163280407",
"url": "https://ci.chromium.org/b/8908978259940063344",
"utcnow_ts": "1562140167763760"
}
}
[07:49:27.935] Invocation finished in 1h54m59.609582169s with status SUCCEEDED