[00:59:30.574] New invocation is queued and will start shortly
[00:59:32.186] Starting the invocation (attempt 1)
[00:59:32.268] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:59:32.271] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:59:32.271] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9044982866014366736",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"59a666e889169c43c8ec623c5cce8d01d0ed1380\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9044982866014366736",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/59a666e889169c43c8ec623c5cce8d01d0ed1380",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/59a666e889169c43c8ec623c5cce8d01d0ed1380",
"gitiles_ref:refs/heads/master"
]
}
[00:59:33.202] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1590195572399803",
"id": "8879552803434448720",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"59a666e889169c43c8ec623c5cce8d01d0ed1380\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1590195572973537",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/27981",
"builder:Deterministic Linux",
"buildset:commit/git/59a666e889169c43c8ec623c5cce8d01d0ed1380",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/59a666e889169c43c8ec623c5cce8d01d0ed1380",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9044982866014366736",
"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/8879552803434448720/+/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": "1590195572973659",
"url": "https://ci.chromium.org/b/8879552803434448720",
"utcnow_ts": "1590195573192625"
}
}
[00:59:33.202] Task URL: https://ci.chromium.org/b/8879552803434448720
[00:59:33.202] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:2:0) after 1m0s
[00:59:45.264] Received PubSub notification, asking Buildbucket for the build status
[00:59:45.344] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:33.421] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:2:0)
[01:00:33.421] Timer tick, asking Buildbucket for the build status
[01:00:33.574] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:33.575] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:4:0) after 1m0s
[01:01:33.855] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:4:0)
[01:01:33.857] Timer tick, asking Buildbucket for the build status
[01:01:34.003] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:34.003] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:5:0) after 1m0s
[01:02:34.232] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:5:0)
[01:02:34.233] Timer tick, asking Buildbucket for the build status
[01:02:34.529] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:34.529] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:6:0) after 1m0s
[01:03:34.703] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:6:0)
[01:03:34.703] Timer tick, asking Buildbucket for the build status
[01:03:34.995] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:34.995] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:7:0) after 1m0s
[01:04:35.303] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:7:0)
[01:04:35.303] Timer tick, asking Buildbucket for the build status
[01:04:35.683] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:35.683] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:8:0) after 1m0s
[01:05:35.809] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:8:0)
[01:05:35.809] Timer tick, asking Buildbucket for the build status
[01:05:35.983] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:35.983] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:9:0) after 1m0s
[01:06:36.237] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:9:0)
[01:06:36.237] Timer tick, asking Buildbucket for the build status
[01:06:36.426] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:36.426] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:10:0) after 1m0s
[01:07:36.451] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:10:0)
[01:07:36.451] Timer tick, asking Buildbucket for the build status
[01:07:36.609] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:36.609] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:11:0) after 1m0s
[01:08:36.656] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:11:0)
[01:08:36.656] Timer tick, asking Buildbucket for the build status
[01:08:36.818] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:36.818] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:12:0) after 1m0s
[01:09:36.895] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:12:0)
[01:09:36.895] Timer tick, asking Buildbucket for the build status
[01:09:37.446] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:37.446] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:13:0) after 1m0s
[01:10:37.476] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:13:0)
[01:10:37.476] Timer tick, asking Buildbucket for the build status
[01:10:37.627] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:37.627] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:14:0) after 1m0s
[01:11:37.795] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:14:0)
[01:11:37.795] Timer tick, asking Buildbucket for the build status
[01:11:38.002] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:38.002] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:15:0) after 1m0s
[01:12:38.246] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:15:0)
[01:12:38.246] Timer tick, asking Buildbucket for the build status
[01:12:38.385] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:38.385] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:16:0) after 1m0s
[01:13:38.389] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:16:0)
[01:13:38.389] Timer tick, asking Buildbucket for the build status
[01:13:38.673] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:38.673] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:17:0) after 1m0s
[01:14:38.802] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:17:0)
[01:14:38.802] Timer tick, asking Buildbucket for the build status
[01:14:39.758] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:39.758] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:18:0) after 1m0s
[01:15:39.853] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:18:0)
[01:15:39.853] Timer tick, asking Buildbucket for the build status
[01:15:40.133] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:40.133] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:19:0) after 1m0s
[01:16:40.684] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:19:0)
[01:16:40.684] Timer tick, asking Buildbucket for the build status
[01:16:40.987] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:40.987] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:20:0) after 1m0s
[01:17:41.276] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:20:0)
[01:17:41.276] Timer tick, asking Buildbucket for the build status
[01:17:41.699] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:41.699] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:21:0) after 1m0s
[01:18:42.062] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:21:0)
[01:18:42.062] Timer tick, asking Buildbucket for the build status
[01:18:42.327] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:42.327] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:22:0) after 1m0s
[01:19:42.528] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:22:0)
[01:19:42.528] Timer tick, asking Buildbucket for the build status
[01:19:43.476] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:43.476] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:23:0) after 1m0s
[01:20:43.526] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:23:0)
[01:20:43.526] Timer tick, asking Buildbucket for the build status
[01:20:44.053] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:44.053] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:24:0) after 1m0s
[01:21:44.135] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:24:0)
[01:21:44.135] Timer tick, asking Buildbucket for the build status
[01:21:44.319] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:44.319] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:25:0) after 1m0s
[01:22:44.466] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:25:0)
[01:22:44.466] Timer tick, asking Buildbucket for the build status
[01:22:44.711] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:44.711] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:26:0) after 1m0s
[01:23:44.792] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:26:0)
[01:23:44.792] Timer tick, asking Buildbucket for the build status
[01:23:45.298] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:45.298] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:27:0) after 1m0s
[01:24:45.415] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:27:0)
[01:24:45.415] Timer tick, asking Buildbucket for the build status
[01:24:46.019] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:46.019] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:28:0) after 1m0s
[01:25:46.104] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:28:0)
[01:25:46.104] Timer tick, asking Buildbucket for the build status
[01:25:46.338] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:46.338] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:29:0) after 1m0s
[01:26:46.375] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:29:0)
[01:26:46.375] Timer tick, asking Buildbucket for the build status
[01:26:46.615] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:46.615] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:30:0) after 1m0s
[01:27:46.659] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:30:0)
[01:27:46.659] Timer tick, asking Buildbucket for the build status
[01:27:47.112] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:47.112] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:31:0) after 1m0s
[01:28:47.264] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:31:0)
[01:28:47.264] Timer tick, asking Buildbucket for the build status
[01:28:47.385] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:47.385] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:32:0) after 1m0s
[01:29:47.598] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:32:0)
[01:29:47.598] Timer tick, asking Buildbucket for the build status
[01:29:47.865] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:47.865] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:33:0) after 1m0s
[01:30:47.845] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:33:0)
[01:30:47.845] Timer tick, asking Buildbucket for the build status
[01:30:48.004] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:48.004] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:34:0) after 1m0s
[01:31:48.086] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:34:0)
[01:31:48.086] Timer tick, asking Buildbucket for the build status
[01:31:48.216] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:48.216] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:35:0) after 1m0s
[01:32:48.420] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:35:0)
[01:32:48.420] Timer tick, asking Buildbucket for the build status
[01:32:48.708] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:48.708] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:36:0) after 1m0s
[01:33:48.734] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:36:0)
[01:33:48.734] Timer tick, asking Buildbucket for the build status
[01:33:48.901] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:48.901] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:37:0) after 1m0s
[01:34:49.100] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:37:0)
[01:34:49.100] Timer tick, asking Buildbucket for the build status
[01:34:49.408] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:49.408] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:38:0) after 1m0s
[01:35:49.532] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:38:0)
[01:35:49.532] Timer tick, asking Buildbucket for the build status
[01:35:49.957] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:49.957] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:39:0) after 1m0s
[01:36:49.984] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:39:0)
[01:36:49.984] Timer tick, asking Buildbucket for the build status
[01:36:51.105] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:51.105] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:40:0) after 1m0s
[01:37:51.149] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:40:0)
[01:37:51.149] Timer tick, asking Buildbucket for the build status
[01:37:51.673] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:51.673] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:41:0) after 1m0s
[01:38:51.734] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:41:0)
[01:38:51.734] Timer tick, asking Buildbucket for the build status
[01:38:51.979] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:51.979] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:42:0) after 1m0s
[01:39:52.044] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:42:0)
[01:39:52.044] Timer tick, asking Buildbucket for the build status
[01:39:52.424] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:52.424] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:43:0) after 1m0s
[01:40:52.563] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:43:0)
[01:40:52.563] Timer tick, asking Buildbucket for the build status
[01:40:52.722] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:52.722] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:44:0) after 1m0s
[01:41:52.891] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:44:0)
[01:41:52.891] Timer tick, asking Buildbucket for the build status
[01:41:53.890] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:53.890] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:45:0) after 1m0s
[01:42:54.286] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:45:0)
[01:42:54.286] Timer tick, asking Buildbucket for the build status
[01:42:54.446] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:54.446] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:46:0) after 1m0s
[01:43:54.627] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:46:0)
[01:43:54.627] Timer tick, asking Buildbucket for the build status
[01:43:55.092] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:55.092] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:47:0) after 1m0s
[01:44:55.231] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:47:0)
[01:44:55.231] Timer tick, asking Buildbucket for the build status
[01:44:55.421] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:55.421] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:48:0) after 1m0s
[01:45:55.443] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:48:0)
[01:45:55.443] Timer tick, asking Buildbucket for the build status
[01:45:56.099] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:56.099] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:49:0) after 1m0s
[01:46:56.123] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:49:0)
[01:46:56.123] Timer tick, asking Buildbucket for the build status
[01:46:56.583] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:56.583] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:50:0) after 1m0s
[01:47:56.733] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:50:0)
[01:47:56.733] Timer tick, asking Buildbucket for the build status
[01:47:56.875] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:56.875] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:51:0) after 1m0s
[01:48:57.019] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:51:0)
[01:48:57.019] Timer tick, asking Buildbucket for the build status
[01:48:57.166] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:57.166] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:52:0) after 1m0s
[01:49:57.192] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:52:0)
[01:49:57.192] Timer tick, asking Buildbucket for the build status
[01:49:57.402] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:57.402] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:53:0) after 1m0s
[01:50:57.594] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:53:0)
[01:50:57.594] Timer tick, asking Buildbucket for the build status
[01:50:57.774] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:57.774] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:54:0) after 1m0s
[01:51:57.829] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:54:0)
[01:51:57.829] Timer tick, asking Buildbucket for the build status
[01:51:57.936] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:57.936] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:55:0) after 1m0s
[01:52:58.024] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:55:0)
[01:52:58.024] Timer tick, asking Buildbucket for the build status
[01:52:58.181] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:58.181] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:56:0) after 1m0s
[01:53:58.205] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:56:0)
[01:53:58.205] Timer tick, asking Buildbucket for the build status
[01:53:58.356] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:58.356] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:57:0) after 1m0s
[01:54:58.432] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:57:0)
[01:54:58.432] Timer tick, asking Buildbucket for the build status
[01:54:58.600] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:58.600] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:58:0) after 1m0s
[01:55:58.617] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:58:0)
[01:55:58.617] Timer tick, asking Buildbucket for the build status
[01:55:58.729] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:58.729] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:59:0) after 1m0s
[01:56:58.802] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:59:0)
[01:56:58.802] Timer tick, asking Buildbucket for the build status
[01:56:59.151] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:59.152] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:60:0) after 1m0s
[01:57:59.189] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:60:0)
[01:57:59.189] Timer tick, asking Buildbucket for the build status
[01:57:59.344] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:59.344] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:61:0) after 1m0s
[01:58:59.365] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:61:0)
[01:58:59.365] Timer tick, asking Buildbucket for the build status
[01:58:59.625] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:59.625] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:62:0) after 1m0s
[01:59:59.647] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:62:0)
[01:59:59.647] Timer tick, asking Buildbucket for the build status
[01:59:59.936] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:59.936] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:63:0) after 1m0s
[02:00:59.962] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:63:0)
[02:00:59.962] Timer tick, asking Buildbucket for the build status
[02:01:00.384] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:00.384] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:64:0) after 1m0s
[02:02:00.375] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:64:0)
[02:02:00.375] Timer tick, asking Buildbucket for the build status
[02:02:00.539] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:00.539] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:65:0) after 1m0s
[02:03:01.191] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:65:0)
[02:03:01.191] Timer tick, asking Buildbucket for the build status
[02:03:01.434] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:01.434] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:66:0) after 1m0s
[02:04:01.748] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:66:0)
[02:04:01.748] Timer tick, asking Buildbucket for the build status
[02:04:01.972] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:01.973] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:67:0) after 1m0s
[02:05:02.002] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:67:0)
[02:05:02.002] Timer tick, asking Buildbucket for the build status
[02:05:02.241] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:02.241] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:68:0) after 1m0s
[02:06:02.327] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:68:0)
[02:06:02.327] Timer tick, asking Buildbucket for the build status
[02:06:02.559] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:02.559] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:69:0) after 1m0s
[02:07:02.724] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:69:0)
[02:07:02.724] Timer tick, asking Buildbucket for the build status
[02:07:02.855] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:02.855] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:70:0) after 1m0s
[02:08:02.901] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:70:0)
[02:08:02.901] Timer tick, asking Buildbucket for the build status
[02:08:03.359] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:03.359] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:71:0) after 1m0s
[02:09:03.406] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:71:0)
[02:09:03.406] Timer tick, asking Buildbucket for the build status
[02:09:03.889] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:03.890] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:72:0) after 1m0s
[02:10:04.045] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:72:0)
[02:10:04.045] Timer tick, asking Buildbucket for the build status
[02:10:04.362] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:04.362] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:73:0) after 1m0s
[02:11:04.619] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:73:0)
[02:11:04.619] Timer tick, asking Buildbucket for the build status
[02:11:04.932] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:04.932] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:74:0) after 1m0s
[02:12:04.995] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:74:0)
[02:12:04.995] Timer tick, asking Buildbucket for the build status
[02:12:05.278] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:05.278] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:75:0) after 1m0s
[02:13:05.356] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:75:0)
[02:13:05.356] Timer tick, asking Buildbucket for the build status
[02:13:05.490] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:05.490] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:76:0) after 1m0s
[02:14:05.522] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:76:0)
[02:14:05.522] Timer tick, asking Buildbucket for the build status
[02:14:05.869] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:05.869] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:77:0) after 1m0s
[02:15:05.864] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:77:0)
[02:15:05.864] Timer tick, asking Buildbucket for the build status
[02:15:06.003] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:06.003] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:78:0) after 1m0s
[02:16:06.084] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:78:0)
[02:16:06.084] Timer tick, asking Buildbucket for the build status
[02:16:06.221] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:06.221] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:79:0) after 1m0s
[02:17:06.370] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:79:0)
[02:17:06.370] Timer tick, asking Buildbucket for the build status
[02:17:06.751] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:06.751] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:80:0) after 1m0s
[02:18:06.857] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:80:0)
[02:18:06.857] Timer tick, asking Buildbucket for the build status
[02:18:07.382] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:07.383] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:81:0) after 1m0s
[02:19:07.436] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:81:0)
[02:19:07.436] Timer tick, asking Buildbucket for the build status
[02:19:07.567] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:07.567] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:82:0) after 1m0s
[02:20:07.647] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:82:0)
[02:20:07.648] Timer tick, asking Buildbucket for the build status
[02:20:07.777] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:07.777] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:83:0) after 1m0s
[02:21:07.853] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:83:0)
[02:21:07.853] Timer tick, asking Buildbucket for the build status
[02:21:08.185] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:08.185] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:84:0) after 1m0s
[02:22:08.220] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:84:0)
[02:22:08.220] Timer tick, asking Buildbucket for the build status
[02:22:09.259] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:09.259] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:85:0) after 1m0s
[02:23:09.294] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:85:0)
[02:23:09.294] Timer tick, asking Buildbucket for the build status
[02:23:09.619] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:09.619] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:86:0) after 1m0s
[02:24:09.774] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:86:0)
[02:24:09.774] Timer tick, asking Buildbucket for the build status
[02:24:10.136] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:10.136] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:87:0) after 1m0s
[02:25:10.170] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:87:0)
[02:25:10.170] Timer tick, asking Buildbucket for the build status
[02:25:10.449] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:10.449] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:88:0) after 1m0s
[02:26:10.561] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:88:0)
[02:26:10.561] Timer tick, asking Buildbucket for the build status
[02:26:10.839] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:10.839] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:89:0) after 1m0s
[02:27:10.903] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:89:0)
[02:27:10.903] Timer tick, asking Buildbucket for the build status
[02:27:11.293] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:11.293] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:90:0) after 1m0s
[02:28:11.314] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:90:0)
[02:28:11.314] Timer tick, asking Buildbucket for the build status
[02:28:11.820] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:11.820] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:91:0) after 1m0s
[02:29:11.852] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:91:0)
[02:29:11.852] Timer tick, asking Buildbucket for the build status
[02:29:12.595] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:12.595] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:92:0) after 1m0s
[02:30:12.616] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:92:0)
[02:30:12.616] Timer tick, asking Buildbucket for the build status
[02:30:15.180] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:15.180] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:93:0) after 1m0s
[02:31:15.210] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:93:0)
[02:31:15.210] Timer tick, asking Buildbucket for the build status
[02:31:15.310] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:15.310] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:94:0) after 1m0s
[02:32:15.335] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:94:0)
[02:32:15.335] Timer tick, asking Buildbucket for the build status
[02:32:15.482] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:15.482] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:95:0) after 1m0s
[02:33:15.559] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:95:0)
[02:33:15.559] Timer tick, asking Buildbucket for the build status
[02:33:15.860] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:15.860] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:96:0) after 1m0s
[02:34:15.950] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:96:0)
[02:34:15.950] Timer tick, asking Buildbucket for the build status
[02:34:16.188] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:16.188] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:97:0) after 1m0s
[02:35:16.216] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:97:0)
[02:35:16.216] Timer tick, asking Buildbucket for the build status
[02:35:16.367] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:16.367] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:98:0) after 1m0s
[02:36:16.393] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:98:0)
[02:36:16.393] Timer tick, asking Buildbucket for the build status
[02:36:16.832] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:16.832] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:99:0) after 1m0s
[02:37:16.911] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:99:0)
[02:37:16.911] Timer tick, asking Buildbucket for the build status
[02:37:17.121] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:17.121] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:100:0) after 1m0s
[02:38:17.196] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:100:0)
[02:38:17.196] Timer tick, asking Buildbucket for the build status
[02:38:17.483] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:17.483] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:101:0) after 1m0s
[02:39:17.678] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:101:0)
[02:39:17.678] Timer tick, asking Buildbucket for the build status
[02:39:18.049] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:18.049] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:102:0) after 1m0s
[02:40:18.231] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:102:0)
[02:40:18.231] Timer tick, asking Buildbucket for the build status
[02:40:18.547] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:18.547] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:103:0) after 1m0s
[02:41:18.666] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:103:0)
[02:41:18.666] Timer tick, asking Buildbucket for the build status
[02:41:19.188] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:19.188] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:104:0) after 1m0s
[02:42:19.265] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:104:0)
[02:42:19.265] Timer tick, asking Buildbucket for the build status
[02:42:19.371] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:19.371] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:105:0) after 1m0s
[02:43:19.412] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:105:0)
[02:43:19.412] Timer tick, asking Buildbucket for the build status
[02:43:19.794] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:19.794] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:106:0) after 1m0s
[02:44:19.831] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:106:0)
[02:44:19.831] Timer tick, asking Buildbucket for the build status
[02:44:19.948] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:19.948] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:107:0) after 1m0s
[02:45:19.972] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:107:0)
[02:45:19.972] Timer tick, asking Buildbucket for the build status
[02:45:20.307] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:20.307] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:108:0) after 1m0s
[02:46:20.356] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:108:0)
[02:46:20.356] Timer tick, asking Buildbucket for the build status
[02:46:20.534] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:20.534] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:109:0) after 1m0s
[02:47:20.543] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:109:0)
[02:47:20.543] Timer tick, asking Buildbucket for the build status
[02:47:20.965] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:20.965] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:110:0) after 1m0s
[02:48:20.987] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:110:0)
[02:48:20.987] Timer tick, asking Buildbucket for the build status
[02:48:21.651] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:21.651] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:111:0) after 1m0s
[02:49:21.744] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:111:0)
[02:49:21.744] Timer tick, asking Buildbucket for the build status
[02:49:22.259] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:22.259] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:112:0) after 1m0s
[02:50:22.353] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:112:0)
[02:50:22.353] Timer tick, asking Buildbucket for the build status
[02:50:22.612] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:22.612] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:113:0) after 1m0s
[02:51:22.646] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:113:0)
[02:51:22.646] Timer tick, asking Buildbucket for the build status
[02:51:23.290] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:23.290] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:114:0) after 1m0s
[02:52:23.313] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:114:0)
[02:52:23.313] Timer tick, asking Buildbucket for the build status
[02:52:23.443] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:23.443] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:115:0) after 1m0s
[02:53:23.477] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:115:0)
[02:53:23.477] Timer tick, asking Buildbucket for the build status
[02:53:23.669] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:23.669] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:116:0) after 1m0s
[02:54:23.696] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:116:0)
[02:54:23.696] Timer tick, asking Buildbucket for the build status
[02:54:23.937] Build 8879552803434448720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:23.937] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9044982866014366736:117:0) after 1m0s
[02:54:45.486] Received PubSub notification, asking Buildbucket for the build status
[02:54:45.712] Build 8879552803434448720: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:54:45.712] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1590202484766846",
"created_by": "project:chromium",
"created_ts": "1590195572399803",
"id": "8879552803434448720",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"59a666e889169c43c8ec623c5cce8d01d0ed1380\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-103-juxr\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 27981, \"got_angle_revision\": \"d3d7b95bac1957900d346637600adc9eacf1fd64\", \"got_dawn_revision\": \"65ee6497d620110546181c1dfbd0cc3064f9f7f9\", \"got_nacl_revision\": \"87616f7ce2ea8383efd3731960c15f4ba5852d93\", \"got_revision\": \"59a666e889169c43c8ec623c5cce8d01d0ed1380\", \"got_revision_cp\": \"refs/heads/master@{#771369}\", \"got_swarming_client_revision\": \"7e8636295f4763a5f5aace1e700b17a4af3c81b7\", \"got_swiftshader_revision\": \"cc5cda0f997d8280712920f2749bbdfe7a0f4dc3\", \"got_v8_revision\": \"414d114aaaad4f0cac357eb2705a71e3ca7bf898\", \"got_v8_revision_cp\": \"refs/heads/8.5.34@{#1}\", \"got_webrtc_revision\": \"3cc1a6509bf6143f9d52d76a7648a9c8d3bdccea\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31336}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"59a666e889169c43c8ec623c5cce8d01d0ed1380\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_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-103-juxr\"], \"image\": [\"chrome-xenial-20041200-f56df5dd7ad\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5100-d2625c1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1590195574537138",
"status": "COMPLETED",
"status_changed_ts": "1590202485080826",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/27981",
"builder:Deterministic Linux",
"buildset:commit/git/59a666e889169c43c8ec623c5cce8d01d0ed1380",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/59a666e889169c43c8ec623c5cce8d01d0ed1380",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9044982866014366736",
"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/8879552803434448720/+/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:4c57dc5a4e895a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1590202485091241",
"url": "https://ci.chromium.org/b/8879552803434448720",
"utcnow_ts": "1590202485700887"
}
}
[02:54:45.712] Invocation finished in 1h55m15.157140054s with status SUCCEEDED