[00:29:08.287] New invocation is queued and will start shortly
[00:29:09.377] Starting the invocation (attempt 1)
[00:29:09.422] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:29:09.422] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:29:09.422] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9064281930661633104",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b886fbb7855346782ead41c676f109338a9a6054\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9064281930661633104",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/b886fbb7855346782ead41c676f109338a9a6054",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b886fbb7855346782ead41c676f109338a9a6054",
"gitiles_ref:refs/heads/master"
]
}
[00:29:10.397] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1571790549620979",
"id": "8898851868599710416",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b886fbb7855346782ead41c676f109338a9a6054\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1571790550020770",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/25392",
"builder:Deterministic Linux",
"buildset:commit/git/b886fbb7855346782ead41c676f109338a9a6054",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b886fbb7855346782ead41c676f109338a9a6054",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9064281930661633104",
"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/8898851868599710416/+/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": "1571790550020925",
"url": "https://ci.chromium.org/b/8898851868599710416",
"utcnow_ts": "1571790550348688"
}
}
[00:29:10.397] Task URL: https://ci.chromium.org/b/8898851868599710416
[00:29:10.397] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:2:0) after 1m0s
[00:29:24.577] Received PubSub notification, asking Buildbucket for the build status
[00:29:25.986] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:10.450] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:2:0)
[00:30:10.450] Timer tick, asking Buildbucket for the build status
[00:30:10.685] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:10.685] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:4:0) after 1m0s
[00:31:10.967] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:4:0)
[00:31:10.967] Timer tick, asking Buildbucket for the build status
[00:31:11.731] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:11.732] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:5:0) after 1m0s
[00:32:11.806] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:5:0)
[00:32:11.806] Timer tick, asking Buildbucket for the build status
[00:32:12.574] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:12.574] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:6:0) after 1m0s
[00:33:12.645] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:6:0)
[00:33:12.645] Timer tick, asking Buildbucket for the build status
[00:33:12.871] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:12.871] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:7:0) after 1m0s
[00:34:12.974] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:7:0)
[00:34:12.974] Timer tick, asking Buildbucket for the build status
[00:34:13.818] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:13.818] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:8:0) after 1m0s
[00:35:13.903] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:8:0)
[00:35:13.903] Timer tick, asking Buildbucket for the build status
[00:35:14.719] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:14.719] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:9:0) after 1m0s
[00:36:14.781] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:9:0)
[00:36:14.781] Timer tick, asking Buildbucket for the build status
[00:36:14.939] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:14.939] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:10:0) after 1m0s
[00:37:15.001] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:10:0)
[00:37:15.001] Timer tick, asking Buildbucket for the build status
[00:37:16.908] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:16.908] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:11:0) after 1m0s
[00:38:16.929] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:11:0)
[00:38:16.929] Timer tick, asking Buildbucket for the build status
[00:38:17.210] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:17.210] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:12:0) after 1m0s
[00:39:17.232] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:12:0)
[00:39:17.232] Timer tick, asking Buildbucket for the build status
[00:39:18.376] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:18.376] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:13:0) after 1m0s
[00:40:18.442] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:13:0)
[00:40:18.442] Timer tick, asking Buildbucket for the build status
[00:40:21.124] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:21.124] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:14:0) after 1m0s
[00:41:21.172] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:14:0)
[00:41:21.172] Timer tick, asking Buildbucket for the build status
[00:41:21.554] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:21.554] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:15:0) after 1m0s
[00:42:21.667] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:15:0)
[00:42:21.667] Timer tick, asking Buildbucket for the build status
[00:42:22.376] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:22.376] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:16:0) after 1m0s
[00:43:22.465] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:16:0)
[00:43:22.465] Timer tick, asking Buildbucket for the build status
[00:43:22.816] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:22.816] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:17:0) after 1m0s
[00:44:22.854] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:17:0)
[00:44:22.854] Timer tick, asking Buildbucket for the build status
[00:44:23.418] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:23.418] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:18:0) after 1m0s
[00:45:23.520] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:18:0)
[00:45:23.520] Timer tick, asking Buildbucket for the build status
[00:45:23.771] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:23.771] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:19:0) after 1m0s
[00:46:23.793] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:19:0)
[00:46:23.793] Timer tick, asking Buildbucket for the build status
[00:46:23.941] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:23.941] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:20:0) after 1m0s
[00:47:23.979] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:20:0)
[00:47:23.979] Timer tick, asking Buildbucket for the build status
[00:47:24.237] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:24.237] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:21:0) after 1m0s
[00:48:24.321] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:21:0)
[00:48:24.321] Timer tick, asking Buildbucket for the build status
[00:48:24.740] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:24.741] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:22:0) after 1m0s
[00:49:24.768] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:22:0)
[00:49:24.768] Timer tick, asking Buildbucket for the build status
[00:49:25.172] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:25.172] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:23:0) after 1m0s
[00:50:25.193] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:23:0)
[00:50:25.193] Timer tick, asking Buildbucket for the build status
[00:50:25.423] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:25.423] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:24:0) after 1m0s
[00:51:25.449] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:24:0)
[00:51:25.449] Timer tick, asking Buildbucket for the build status
[00:51:26.421] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:26.421] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:25:0) after 1m0s
[00:52:26.493] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:25:0)
[00:52:26.493] Timer tick, asking Buildbucket for the build status
[00:52:26.699] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:26.699] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:26:0) after 1m0s
[00:53:26.740] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:26:0)
[00:53:26.740] Timer tick, asking Buildbucket for the build status
[00:53:27.303] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:27.303] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:27:0) after 1m0s
[00:54:27.400] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:27:0)
[00:54:27.400] Timer tick, asking Buildbucket for the build status
[00:54:27.668] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:27.668] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:28:0) after 1m0s
[00:55:27.760] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:28:0)
[00:55:27.760] Timer tick, asking Buildbucket for the build status
[00:55:28.815] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:28.815] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:29:0) after 1m0s
[00:56:28.898] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:29:0)
[00:56:28.898] Timer tick, asking Buildbucket for the build status
[00:56:29.376] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:29.376] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:30:0) after 1m0s
[00:57:29.588] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:30:0)
[00:57:29.588] Timer tick, asking Buildbucket for the build status
[00:57:29.922] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:29.922] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:31:0) after 1m0s
[00:58:29.959] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:31:0)
[00:58:29.959] Timer tick, asking Buildbucket for the build status
[00:58:30.494] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:30.494] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:32:0) after 1m0s
[00:59:30.579] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:32:0)
[00:59:30.579] Timer tick, asking Buildbucket for the build status
[00:59:31.069] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:31.069] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:33:0) after 1m0s
[01:00:31.256] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:33:0)
[01:00:31.256] Timer tick, asking Buildbucket for the build status
[01:00:31.448] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:31.448] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:34:0) after 1m0s
[01:01:31.581] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:34:0)
[01:01:31.581] Timer tick, asking Buildbucket for the build status
[01:01:32.201] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:32.202] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:35:0) after 1m0s
[01:02:32.243] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:35:0)
[01:02:32.243] Timer tick, asking Buildbucket for the build status
[01:02:35.503] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:35.503] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:36:0) after 1m0s
[01:03:35.524] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:36:0)
[01:03:35.524] Timer tick, asking Buildbucket for the build status
[01:03:36.444] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:36.444] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:37:0) after 1m0s
[01:04:36.623] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:37:0)
[01:04:36.623] Timer tick, asking Buildbucket for the build status
[01:04:36.852] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:36.852] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:38:0) after 1m0s
[01:05:36.908] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:38:0)
[01:05:36.908] Timer tick, asking Buildbucket for the build status
[01:05:37.562] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:37.562] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:39:0) after 1m0s
[01:06:37.677] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:39:0)
[01:06:37.677] Timer tick, asking Buildbucket for the build status
[01:06:38.126] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:38.126] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:40:0) after 1m0s
[01:07:38.207] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:40:0)
[01:07:38.207] Timer tick, asking Buildbucket for the build status
[01:07:40.541] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:40.541] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:41:0) after 1m0s
[01:08:40.696] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:41:0)
[01:08:40.696] Timer tick, asking Buildbucket for the build status
[01:08:40.869] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:40.869] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:42:0) after 1m0s
[01:09:40.893] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:42:0)
[01:09:40.893] Timer tick, asking Buildbucket for the build status
[01:09:41.108] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:41.108] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:43:0) after 1m0s
[01:10:41.134] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:43:0)
[01:10:41.134] Timer tick, asking Buildbucket for the build status
[01:10:41.311] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:41.312] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:44:0) after 1m0s
[01:11:41.409] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:44:0)
[01:11:41.409] Timer tick, asking Buildbucket for the build status
[01:11:41.912] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:41.912] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:45:0) after 1m0s
[01:12:41.963] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:45:0)
[01:12:41.963] Timer tick, asking Buildbucket for the build status
[01:12:42.840] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:42.840] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:46:0) after 1m0s
[01:13:42.895] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:46:0)
[01:13:42.895] Timer tick, asking Buildbucket for the build status
[01:13:43.078] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:43.078] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:47:0) after 1m0s
[01:14:43.141] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:47:0)
[01:14:43.141] Timer tick, asking Buildbucket for the build status
[01:14:43.487] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:43.487] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:48:0) after 1m0s
[01:15:43.534] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:48:0)
[01:15:43.534] Timer tick, asking Buildbucket for the build status
[01:15:44.269] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:44.269] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:49:0) after 1m0s
[01:16:44.312] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:49:0)
[01:16:44.312] Timer tick, asking Buildbucket for the build status
[01:16:45.660] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:45.660] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:50:0) after 1m0s
[01:17:45.712] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:50:0)
[01:17:45.712] Timer tick, asking Buildbucket for the build status
[01:17:46.646] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:46.646] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:51:0) after 1m0s
[01:18:46.653] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:51:0)
[01:18:46.653] Timer tick, asking Buildbucket for the build status
[01:18:46.944] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:46.944] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:52:0) after 1m0s
[01:19:47.073] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:52:0)
[01:19:47.073] Timer tick, asking Buildbucket for the build status
[01:19:48.078] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:48.078] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:53:0) after 1m0s
[01:20:48.101] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:53:0)
[01:20:48.101] Timer tick, asking Buildbucket for the build status
[01:20:49.572] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:49.572] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:54:0) after 1m0s
[01:21:49.683] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:54:0)
[01:21:49.683] Timer tick, asking Buildbucket for the build status
[01:21:49.979] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:49.979] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:55:0) after 1m0s
[01:22:50.039] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:55:0)
[01:22:50.039] Timer tick, asking Buildbucket for the build status
[01:22:50.564] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:50.564] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:56:0) after 1m0s
[01:23:50.821] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:56:0)
[01:23:50.821] Timer tick, asking Buildbucket for the build status
[01:23:51.066] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:51.066] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:57:0) after 1m0s
[01:24:51.110] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:57:0)
[01:24:51.110] Timer tick, asking Buildbucket for the build status
[01:24:51.333] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:51.333] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:58:0) after 1m0s
[01:25:51.313] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:58:0)
[01:25:51.313] Timer tick, asking Buildbucket for the build status
[01:25:51.636] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:51.636] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:59:0) after 1m0s
[01:26:51.714] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:59:0)
[01:26:51.714] Timer tick, asking Buildbucket for the build status
[01:26:52.710] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:52.710] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:60:0) after 1m0s
[01:27:52.747] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:60:0)
[01:27:52.747] Timer tick, asking Buildbucket for the build status
[01:27:52.991] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:52.991] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:61:0) after 1m0s
[01:28:53.012] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:61:0)
[01:28:53.012] Timer tick, asking Buildbucket for the build status
[01:28:53.312] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:53.312] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:62:0) after 1m0s
[01:29:53.371] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:62:0)
[01:29:53.371] Timer tick, asking Buildbucket for the build status
[01:29:53.759] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:53.759] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:63:0) after 1m0s
[01:30:53.787] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:63:0)
[01:30:53.787] Timer tick, asking Buildbucket for the build status
[01:30:53.989] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:53.989] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:64:0) after 1m0s
[01:31:54.069] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:64:0)
[01:31:54.069] Timer tick, asking Buildbucket for the build status
[01:31:56.723] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:56.723] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:65:0) after 1m0s
[01:32:56.756] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:65:0)
[01:32:56.756] Timer tick, asking Buildbucket for the build status
[01:32:57.795] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:57.795] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:66:0) after 1m0s
[01:33:57.852] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:66:0)
[01:33:57.852] Timer tick, asking Buildbucket for the build status
[01:33:59.132] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:59.132] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:67:0) after 1m0s
[01:34:59.272] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:67:0)
[01:34:59.272] Timer tick, asking Buildbucket for the build status
[01:34:59.458] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:59.458] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:68:0) after 1m0s
[01:35:59.482] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:68:0)
[01:35:59.482] Timer tick, asking Buildbucket for the build status
[01:35:59.876] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:59.876] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:69:0) after 1m0s
[01:37:00.065] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:69:0)
[01:37:00.065] Timer tick, asking Buildbucket for the build status
[01:37:00.322] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:00.322] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:70:0) after 1m0s
[01:38:00.391] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:70:0)
[01:38:00.391] Timer tick, asking Buildbucket for the build status
[01:38:01.053] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:01.053] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:71:0) after 1m0s
[01:39:01.102] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:71:0)
[01:39:01.102] Timer tick, asking Buildbucket for the build status
[01:39:01.335] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:01.335] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:72:0) after 1m0s
[01:40:01.457] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:72:0)
[01:40:01.457] Timer tick, asking Buildbucket for the build status
[01:40:01.801] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:01.801] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:73:0) after 1m0s
[01:41:01.857] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:73:0)
[01:41:01.857] Timer tick, asking Buildbucket for the build status
[01:41:02.077] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:02.077] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:74:0) after 1m0s
[01:42:02.091] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:74:0)
[01:42:02.091] Timer tick, asking Buildbucket for the build status
[01:42:02.337] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:02.337] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:75:0) after 1m0s
[01:43:02.416] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:75:0)
[01:43:02.416] Timer tick, asking Buildbucket for the build status
[01:43:02.589] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:02.589] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:76:0) after 1m0s
[01:44:02.614] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:76:0)
[01:44:02.614] Timer tick, asking Buildbucket for the build status
[01:44:03.109] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:03.109] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:77:0) after 1m0s
[01:45:03.216] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:77:0)
[01:45:03.216] Timer tick, asking Buildbucket for the build status
[01:45:04.216] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:04.216] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:78:0) after 1m0s
[01:46:04.285] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:78:0)
[01:46:04.285] Timer tick, asking Buildbucket for the build status
[01:46:04.654] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:04.654] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:79:0) after 1m0s
[01:47:04.691] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:79:0)
[01:47:04.691] Timer tick, asking Buildbucket for the build status
[01:47:04.874] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:04.874] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:80:0) after 1m0s
[01:48:04.901] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:80:0)
[01:48:04.901] Timer tick, asking Buildbucket for the build status
[01:48:05.203] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:05.203] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:81:0) after 1m0s
[01:49:05.189] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:81:0)
[01:49:05.189] Timer tick, asking Buildbucket for the build status
[01:49:06.051] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:06.051] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:82:0) after 1m0s
[01:50:06.078] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:82:0)
[01:50:06.078] Timer tick, asking Buildbucket for the build status
[01:50:06.854] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:06.854] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:83:0) after 1m0s
[01:51:06.907] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:83:0)
[01:51:06.907] Timer tick, asking Buildbucket for the build status
[01:51:07.593] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:07.593] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:84:0) after 1m0s
[01:52:07.747] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:84:0)
[01:52:07.747] Timer tick, asking Buildbucket for the build status
[01:52:08.035] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:08.035] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:85:0) after 1m0s
[01:53:08.069] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:85:0)
[01:53:08.069] Timer tick, asking Buildbucket for the build status
[01:53:08.309] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:08.309] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:86:0) after 1m0s
[01:54:08.429] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:86:0)
[01:54:08.429] Timer tick, asking Buildbucket for the build status
[01:54:08.618] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:08.618] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:87:0) after 1m0s
[01:55:08.817] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:87:0)
[01:55:08.817] Timer tick, asking Buildbucket for the build status
[01:55:11.519] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:11.519] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:88:0) after 1m0s
[01:56:11.601] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:88:0)
[01:56:11.601] Timer tick, asking Buildbucket for the build status
[01:56:12.310] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:12.311] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:89:0) after 1m0s
[01:57:12.347] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:89:0)
[01:57:12.347] Timer tick, asking Buildbucket for the build status
[01:57:12.690] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:12.690] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:90:0) after 1m0s
[01:58:12.725] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:90:0)
[01:58:12.725] Timer tick, asking Buildbucket for the build status
[01:58:12.978] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:12.978] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:91:0) after 1m0s
[01:59:13.003] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:91:0)
[01:59:13.003] Timer tick, asking Buildbucket for the build status
[01:59:13.753] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:13.753] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:92:0) after 1m0s
[02:00:13.777] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:92:0)
[02:00:13.777] Timer tick, asking Buildbucket for the build status
[02:00:14.097] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:14.097] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:93:0) after 1m0s
[02:01:14.189] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:93:0)
[02:01:14.189] Timer tick, asking Buildbucket for the build status
[02:01:14.453] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:14.453] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:94:0) after 1m0s
[02:02:14.507] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:94:0)
[02:02:14.507] Timer tick, asking Buildbucket for the build status
[02:02:14.955] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:14.955] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:95:0) after 1m0s
[02:03:14.988] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:95:0)
[02:03:14.988] Timer tick, asking Buildbucket for the build status
[02:03:15.335] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:15.335] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:96:0) after 1m0s
[02:04:15.453] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:96:0)
[02:04:15.453] Timer tick, asking Buildbucket for the build status
[02:04:16.315] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:16.315] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:97:0) after 1m0s
[02:05:16.338] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:97:0)
[02:05:16.338] Timer tick, asking Buildbucket for the build status
[02:05:16.573] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:16.573] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:98:0) after 1m0s
[02:06:16.711] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:98:0)
[02:06:16.711] Timer tick, asking Buildbucket for the build status
[02:06:16.915] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:16.915] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:99:0) after 1m0s
[02:07:17.084] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:99:0)
[02:07:17.084] Timer tick, asking Buildbucket for the build status
[02:07:19.012] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:19.012] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:100:0) after 1m0s
[02:08:19.012] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:100:0)
[02:08:19.012] Timer tick, asking Buildbucket for the build status
[02:08:19.302] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:19.302] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:101:0) after 1m0s
[02:09:19.370] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:101:0)
[02:09:19.370] Timer tick, asking Buildbucket for the build status
[02:09:19.589] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:19.589] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:102:0) after 1m0s
[02:10:19.639] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:102:0)
[02:10:19.639] Timer tick, asking Buildbucket for the build status
[02:10:19.886] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:19.886] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:103:0) after 1m0s
[02:11:19.919] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:103:0)
[02:11:19.919] Timer tick, asking Buildbucket for the build status
[02:11:20.314] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:20.314] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:104:0) after 1m0s
[02:12:20.427] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:104:0)
[02:12:20.427] Timer tick, asking Buildbucket for the build status
[02:12:20.724] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:20.724] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:105:0) after 1m0s
[02:13:20.859] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:105:0)
[02:13:20.860] Timer tick, asking Buildbucket for the build status
[02:13:21.827] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:21.827] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:106:0) after 1m0s
[02:14:21.938] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:106:0)
[02:14:21.938] Timer tick, asking Buildbucket for the build status
[02:14:22.498] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:22.498] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:107:0) after 1m0s
[02:15:22.563] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:107:0)
[02:15:22.563] Timer tick, asking Buildbucket for the build status
[02:15:23.014] Build 8898851868599710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:23.014] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064281930661633104:108:0) after 1m0s
[02:15:40.305] Received PubSub notification, asking Buildbucket for the build status
[02:15:40.844] Build 8898851868599710416: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:15:40.844] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1571796937968243",
"created_by": "project:chromium",
"created_ts": "1571790549620979",
"id": "8898851868599710416",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b886fbb7855346782ead41c676f109338a9a6054\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-14-frl2\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 25392, \"got_angle_revision\": \"be1fa7d8cddfe0ccc05d1458678b93eaab1afa43\", \"got_dawn_revision\": \"7b3cc35cb6e52fbc9d9c0f1b89035e0a4c50df5d\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"b886fbb7855346782ead41c676f109338a9a6054\", \"got_revision_cp\": \"refs/heads/master@{#708433}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_v8_revision\": \"e9c6aa2428d01a7adcfbccc3132443ee309e9568\", \"got_v8_revision_cp\": \"refs/heads/8.0.28@{#1}\", \"got_webrtc_revision\": \"05691ddbd2bcf0fc31a64d7714b5ea05d2492820\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29576}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b886fbb7855346782ead41c676f109338a9a6054\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1267e646917891f5f926cdb94ab3368f0c9399d68d76518d691afb23f68811c9_v2\", \"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"builder_980e79f61a9eb10b3ecd5f710f08f0308a5299da9889db3d2b6a7010c019cc1f_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-xenial-us-east1-d-8-14-frl2\"], \"image\": [\"chrome-xenial-19100400-6cc5b08ab04\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4549-8dc3ae7\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1571790563663474",
"status": "COMPLETED",
"status_changed_ts": "1571796939024462",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/25392",
"builder:Deterministic Linux",
"buildset:commit/git/b886fbb7855346782ead41c676f109338a9a6054",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b886fbb7855346782ead41c676f109338a9a6054",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9064281930661633104",
"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/8898851868599710416/+/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:480ed61b0be3e310",
"user_agent:luci-scheduler"
],
"updated_ts": "1571796939116453",
"url": "https://ci.chromium.org/b/8898851868599710416",
"utcnow_ts": "1571796940835473"
}
}
[02:15:40.844] Invocation finished in 1h46m32.574735331s with status SUCCEEDED