[08:32:28.457] New invocation is queued and will start shortly
[08:32:29.753] Starting the invocation (attempt 1)
[08:32:29.785] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:32:29.785] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:32:29.785] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9051839737380319856",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"52bb9bcf55601233224f95d162c028be0f5b0503\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9051839737380319856",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/52bb9bcf55601233224f95d162c028be0f5b0503",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/52bb9bcf55601233224f95d162c028be0f5b0503",
"gitiles_ref:refs/heads/master"
]
}
[08:32:31.599] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1583656349903857",
"id": "8886409675202645504",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"52bb9bcf55601233224f95d162c028be0f5b0503\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1583656351157834",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/27088",
"builder:Deterministic Linux",
"buildset:commit/git/52bb9bcf55601233224f95d162c028be0f5b0503",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/52bb9bcf55601233224f95d162c028be0f5b0503",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9051839737380319856",
"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/8886409675202645504/+/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": "1583656351176324",
"url": "https://ci.chromium.org/b/8886409675202645504",
"utcnow_ts": "1583656351582704"
}
}
[08:32:31.599] Task URL: https://ci.chromium.org/b/8886409675202645504
[08:32:31.599] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:2:0) after 1m0s
[08:32:36.558] Received PubSub notification, asking Buildbucket for the build status
[08:32:36.655] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:31.658] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:2:0)
[08:33:31.658] Timer tick, asking Buildbucket for the build status
[08:33:31.844] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:31.844] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:4:0) after 1m0s
[08:34:31.953] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:4:0)
[08:34:31.953] Timer tick, asking Buildbucket for the build status
[08:34:32.268] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:32.268] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:5:0) after 1m0s
[08:35:32.445] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:5:0)
[08:35:32.445] Timer tick, asking Buildbucket for the build status
[08:35:33.005] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:33.006] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:6:0) after 1m0s
[08:36:33.013] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:6:0)
[08:36:33.013] Timer tick, asking Buildbucket for the build status
[08:36:33.162] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:33.162] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:7:0) after 1m0s
[08:37:33.238] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:7:0)
[08:37:33.238] Timer tick, asking Buildbucket for the build status
[08:37:33.390] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:33.390] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:8:0) after 1m0s
[08:38:33.444] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:8:0)
[08:38:33.444] Timer tick, asking Buildbucket for the build status
[08:38:33.593] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:33.593] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:9:0) after 1m0s
[08:39:33.616] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:9:0)
[08:39:33.616] Timer tick, asking Buildbucket for the build status
[08:39:33.896] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:33.896] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:10:0) after 1m0s
[08:40:33.923] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:10:0)
[08:40:33.923] Timer tick, asking Buildbucket for the build status
[08:40:34.037] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:34.037] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:11:0) after 1m0s
[08:41:34.054] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:11:0)
[08:41:34.054] Timer tick, asking Buildbucket for the build status
[08:41:34.169] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:34.169] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:12:0) after 1m0s
[08:42:34.196] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:12:0)
[08:42:34.196] Timer tick, asking Buildbucket for the build status
[08:42:34.363] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:34.363] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:13:0) after 1m0s
[08:43:34.390] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:13:0)
[08:43:34.390] Timer tick, asking Buildbucket for the build status
[08:43:34.611] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:34.611] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:14:0) after 1m0s
[08:44:34.704] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:14:0)
[08:44:34.704] Timer tick, asking Buildbucket for the build status
[08:44:34.895] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:34.896] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:15:0) after 1m0s
[08:45:34.890] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:15:0)
[08:45:34.890] Timer tick, asking Buildbucket for the build status
[08:45:35.073] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:35.073] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:16:0) after 1m0s
[08:46:35.132] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:16:0)
[08:46:35.132] Timer tick, asking Buildbucket for the build status
[08:46:35.341] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:35.341] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:17:0) after 1m0s
[08:47:35.339] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:17:0)
[08:47:35.339] Timer tick, asking Buildbucket for the build status
[08:47:35.446] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:35.446] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:18:0) after 1m0s
[08:48:35.454] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:18:0)
[08:48:35.454] Timer tick, asking Buildbucket for the build status
[08:48:35.591] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:35.591] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:19:0) after 1m0s
[08:49:35.639] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:19:0)
[08:49:35.639] Timer tick, asking Buildbucket for the build status
[08:49:35.732] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:35.732] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:20:0) after 1m0s
[08:50:35.752] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:20:0)
[08:50:35.752] Timer tick, asking Buildbucket for the build status
[08:50:35.891] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:35.891] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:21:0) after 1m0s
[08:51:35.908] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:21:0)
[08:51:35.908] Timer tick, asking Buildbucket for the build status
[08:51:35.984] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:35.984] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:22:0) after 1m0s
[08:52:36.003] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:22:0)
[08:52:36.003] Timer tick, asking Buildbucket for the build status
[08:52:36.086] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:36.086] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:23:0) after 1m0s
[08:53:36.104] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:23:0)
[08:53:36.104] Timer tick, asking Buildbucket for the build status
[08:53:36.392] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:36.392] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:24:0) after 1m0s
[08:54:36.510] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:24:0)
[08:54:36.510] Timer tick, asking Buildbucket for the build status
[08:54:36.802] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:36.802] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:25:0) after 1m0s
[08:55:36.820] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:25:0)
[08:55:36.820] Timer tick, asking Buildbucket for the build status
[08:55:36.924] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:36.924] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:26:0) after 1m0s
[08:56:36.951] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:26:0)
[08:56:36.951] Timer tick, asking Buildbucket for the build status
[08:56:37.045] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:37.045] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:27:0) after 1m0s
[08:57:37.123] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:27:0)
[08:57:37.123] Timer tick, asking Buildbucket for the build status
[08:57:37.333] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:37.333] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:28:0) after 1m0s
[08:58:37.354] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:28:0)
[08:58:37.354] Timer tick, asking Buildbucket for the build status
[08:58:37.599] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:37.599] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:29:0) after 1m0s
[08:59:37.617] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:29:0)
[08:59:37.617] Timer tick, asking Buildbucket for the build status
[08:59:37.772] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:37.772] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:30:0) after 1m0s
[09:00:37.813] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:30:0)
[09:00:37.813] Timer tick, asking Buildbucket for the build status
[09:00:37.927] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:37.927] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:31:0) after 1m0s
[09:01:37.963] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:31:0)
[09:01:37.963] Timer tick, asking Buildbucket for the build status
[09:01:38.377] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:38.377] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:32:0) after 1m0s
[09:02:38.465] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:32:0)
[09:02:38.465] Timer tick, asking Buildbucket for the build status
[09:02:38.574] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:38.574] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:33:0) after 1m0s
[09:03:38.662] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:33:0)
[09:03:38.662] Timer tick, asking Buildbucket for the build status
[09:03:38.759] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:38.759] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:34:0) after 1m0s
[09:04:38.787] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:34:0)
[09:04:38.787] Timer tick, asking Buildbucket for the build status
[09:04:38.932] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:38.932] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:35:0) after 1m0s
[09:05:38.957] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:35:0)
[09:05:38.957] Timer tick, asking Buildbucket for the build status
[09:05:39.065] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:39.065] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:36:0) after 1m0s
[09:06:39.128] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:36:0)
[09:06:39.128] Timer tick, asking Buildbucket for the build status
[09:06:39.461] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:39.461] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:37:0) after 1m0s
[09:07:39.487] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:37:0)
[09:07:39.487] Timer tick, asking Buildbucket for the build status
[09:07:39.612] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:39.612] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:38:0) after 1m0s
[09:08:39.611] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:38:0)
[09:08:39.611] Timer tick, asking Buildbucket for the build status
[09:08:39.764] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:39.764] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:39:0) after 1m0s
[09:09:39.818] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:39:0)
[09:09:39.818] Timer tick, asking Buildbucket for the build status
[09:09:40.084] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:40.084] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:40:0) after 1m0s
[09:10:40.112] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:40:0)
[09:10:40.112] Timer tick, asking Buildbucket for the build status
[09:10:40.634] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:40.634] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:41:0) after 1m0s
[09:11:40.757] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:41:0)
[09:11:40.757] Timer tick, asking Buildbucket for the build status
[09:11:40.915] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:40.915] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:42:0) after 1m0s
[09:12:41.001] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:42:0)
[09:12:41.001] Timer tick, asking Buildbucket for the build status
[09:12:41.174] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:41.174] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:43:0) after 1m0s
[09:13:41.220] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:43:0)
[09:13:41.220] Timer tick, asking Buildbucket for the build status
[09:13:41.557] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:41.558] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:44:0) after 1m0s
[09:14:41.588] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:44:0)
[09:14:41.588] Timer tick, asking Buildbucket for the build status
[09:14:41.730] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:41.730] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:45:0) after 1m0s
[09:15:41.886] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:45:0)
[09:15:41.886] Timer tick, asking Buildbucket for the build status
[09:15:42.254] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:42.254] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:46:0) after 1m0s
[09:16:42.286] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:46:0)
[09:16:42.286] Timer tick, asking Buildbucket for the build status
[09:16:42.605] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:42.605] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:47:0) after 1m0s
[09:17:42.652] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:47:0)
[09:17:42.652] Timer tick, asking Buildbucket for the build status
[09:17:43.013] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:43.013] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:48:0) after 1m0s
[09:18:43.064] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:48:0)
[09:18:43.064] Timer tick, asking Buildbucket for the build status
[09:18:43.426] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:43.426] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:49:0) after 1m0s
[09:19:43.484] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:49:0)
[09:19:43.484] Timer tick, asking Buildbucket for the build status
[09:19:43.572] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:43.572] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:50:0) after 1m0s
[09:20:43.593] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:50:0)
[09:20:43.593] Timer tick, asking Buildbucket for the build status
[09:20:43.734] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:43.734] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:51:0) after 1m0s
[09:21:43.802] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:51:0)
[09:21:43.802] Timer tick, asking Buildbucket for the build status
[09:21:44.044] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:44.044] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:52:0) after 1m0s
[09:22:44.075] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:52:0)
[09:22:44.075] Timer tick, asking Buildbucket for the build status
[09:22:44.209] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:44.209] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:53:0) after 1m0s
[09:23:44.239] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:53:0)
[09:23:44.239] Timer tick, asking Buildbucket for the build status
[09:23:44.555] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:44.555] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:54:0) after 1m0s
[09:24:44.599] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:54:0)
[09:24:44.599] Timer tick, asking Buildbucket for the build status
[09:24:44.751] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:44.751] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:55:0) after 1m0s
[09:25:44.778] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:55:0)
[09:25:44.778] Timer tick, asking Buildbucket for the build status
[09:25:44.893] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:44.893] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:56:0) after 1m0s
[09:26:44.939] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:56:0)
[09:26:44.939] Timer tick, asking Buildbucket for the build status
[09:26:45.294] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:45.294] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:57:0) after 1m0s
[09:27:45.318] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:57:0)
[09:27:45.318] Timer tick, asking Buildbucket for the build status
[09:27:45.439] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:45.439] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:58:0) after 1m0s
[09:28:45.464] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:58:0)
[09:28:45.464] Timer tick, asking Buildbucket for the build status
[09:28:46.963] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:46.963] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:59:0) after 1m0s
[09:29:47.048] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:59:0)
[09:29:47.048] Timer tick, asking Buildbucket for the build status
[09:29:47.485] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:47.485] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:60:0) after 1m0s
[09:30:47.544] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:60:0)
[09:30:47.544] Timer tick, asking Buildbucket for the build status
[09:30:47.701] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:47.701] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:61:0) after 1m0s
[09:31:47.726] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:61:0)
[09:31:47.726] Timer tick, asking Buildbucket for the build status
[09:31:47.845] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:47.845] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:62:0) after 1m0s
[09:32:47.868] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:62:0)
[09:32:47.868] Timer tick, asking Buildbucket for the build status
[09:32:48.002] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:48.002] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:63:0) after 1m0s
[09:33:48.028] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:63:0)
[09:33:48.028] Timer tick, asking Buildbucket for the build status
[09:33:48.133] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:48.133] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:64:0) after 1m0s
[09:34:48.153] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:64:0)
[09:34:48.153] Timer tick, asking Buildbucket for the build status
[09:34:48.290] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:48.290] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:65:0) after 1m0s
[09:35:48.377] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:65:0)
[09:35:48.377] Timer tick, asking Buildbucket for the build status
[09:35:48.564] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:48.564] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:66:0) after 1m0s
[09:36:48.651] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:66:0)
[09:36:48.651] Timer tick, asking Buildbucket for the build status
[09:36:48.891] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:48.891] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:67:0) after 1m0s
[09:37:48.985] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:67:0)
[09:37:48.985] Timer tick, asking Buildbucket for the build status
[09:37:49.147] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:49.147] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:68:0) after 1m0s
[09:38:49.231] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:68:0)
[09:38:49.231] Timer tick, asking Buildbucket for the build status
[09:38:49.319] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:49.319] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:69:0) after 1m0s
[09:39:49.342] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:69:0)
[09:39:49.342] Timer tick, asking Buildbucket for the build status
[09:39:49.557] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:49.557] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:70:0) after 1m0s
[09:40:49.527] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:70:0)
[09:40:49.527] Timer tick, asking Buildbucket for the build status
[09:40:49.661] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:49.661] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:71:0) after 1m0s
[09:41:49.785] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:71:0)
[09:41:49.785] Timer tick, asking Buildbucket for the build status
[09:41:50.168] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:50.168] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:72:0) after 1m0s
[09:42:50.302] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:72:0)
[09:42:50.302] Timer tick, asking Buildbucket for the build status
[09:42:50.394] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:50.394] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:73:0) after 1m0s
[09:43:50.540] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:73:0)
[09:43:50.540] Timer tick, asking Buildbucket for the build status
[09:43:50.794] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:50.794] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:74:0) after 1m0s
[09:44:50.831] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:74:0)
[09:44:50.831] Timer tick, asking Buildbucket for the build status
[09:44:50.970] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:50.970] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:75:0) after 1m0s
[09:45:51.064] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:75:0)
[09:45:51.064] Timer tick, asking Buildbucket for the build status
[09:45:51.277] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:51.277] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:76:0) after 1m0s
[09:46:51.298] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:76:0)
[09:46:51.298] Timer tick, asking Buildbucket for the build status
[09:46:51.409] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:51.409] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:77:0) after 1m0s
[09:47:51.432] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:77:0)
[09:47:51.432] Timer tick, asking Buildbucket for the build status
[09:47:51.575] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:51.575] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:78:0) after 1m0s
[09:48:51.769] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:78:0)
[09:48:51.769] Timer tick, asking Buildbucket for the build status
[09:48:51.869] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:51.869] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:79:0) after 1m0s
[09:49:52.065] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:79:0)
[09:49:52.065] Timer tick, asking Buildbucket for the build status
[09:49:52.324] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:52.324] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:80:0) after 1m0s
[09:50:52.436] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:80:0)
[09:50:52.436] Timer tick, asking Buildbucket for the build status
[09:50:52.880] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:52.880] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:81:0) after 1m0s
[09:51:52.916] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:81:0)
[09:51:52.917] Timer tick, asking Buildbucket for the build status
[09:51:53.098] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:53.098] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:82:0) after 1m0s
[09:52:53.118] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:82:0)
[09:52:53.118] Timer tick, asking Buildbucket for the build status
[09:52:53.283] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:53.283] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:83:0) after 1m0s
[09:53:53.314] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:83:0)
[09:53:53.314] Timer tick, asking Buildbucket for the build status
[09:53:53.708] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:53.708] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:84:0) after 1m0s
[09:54:53.734] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:84:0)
[09:54:53.734] Timer tick, asking Buildbucket for the build status
[09:54:53.887] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:53.887] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:85:0) after 1m0s
[09:55:53.960] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:85:0)
[09:55:53.960] Timer tick, asking Buildbucket for the build status
[09:55:54.109] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:54.109] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:86:0) after 1m0s
[09:56:54.133] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:86:0)
[09:56:54.133] Timer tick, asking Buildbucket for the build status
[09:56:54.244] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:54.244] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:87:0) after 1m0s
[09:57:54.431] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:87:0)
[09:57:54.431] Timer tick, asking Buildbucket for the build status
[09:57:54.593] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:54.593] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:88:0) after 1m0s
[09:58:54.764] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:88:0)
[09:58:54.764] Timer tick, asking Buildbucket for the build status
[09:58:55.381] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:55.381] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:89:0) after 1m0s
[09:59:58.287] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:89:0)
[09:59:58.287] Timer tick, asking Buildbucket for the build status
[09:59:58.590] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:58.590] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:90:0) after 1m0s
[10:00:58.679] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:90:0)
[10:00:58.679] Timer tick, asking Buildbucket for the build status
[10:00:58.781] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:58.781] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:91:0) after 1m0s
[10:01:58.854] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:91:0)
[10:01:58.854] Timer tick, asking Buildbucket for the build status
[10:01:59.372] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:59.372] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:92:0) after 1m0s
[10:02:59.393] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:92:0)
[10:02:59.394] Timer tick, asking Buildbucket for the build status
[10:02:59.528] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:59.528] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:93:0) after 1m0s
[10:03:59.552] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:93:0)
[10:03:59.552] Timer tick, asking Buildbucket for the build status
[10:03:59.796] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:59.796] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:94:0) after 1m0s
[10:04:59.820] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:94:0)
[10:04:59.820] Timer tick, asking Buildbucket for the build status
[10:04:59.953] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:59.953] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:95:0) after 1m0s
[10:06:00.091] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:95:0)
[10:06:00.091] Timer tick, asking Buildbucket for the build status
[10:06:00.263] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:00.263] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:96:0) after 1m0s
[10:07:00.340] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:96:0)
[10:07:00.340] Timer tick, asking Buildbucket for the build status
[10:07:00.444] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:00.444] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:97:0) after 1m0s
[10:08:00.616] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:97:0)
[10:08:00.616] Timer tick, asking Buildbucket for the build status
[10:08:00.755] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:00.755] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:98:0) after 1m0s
[10:09:00.847] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:98:0)
[10:09:00.847] Timer tick, asking Buildbucket for the build status
[10:09:00.983] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:00.983] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:99:0) after 1m0s
[10:10:01.007] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:99:0)
[10:10:01.007] Timer tick, asking Buildbucket for the build status
[10:10:01.235] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:01.235] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:100:0) after 1m0s
[10:11:01.259] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:100:0)
[10:11:01.259] Timer tick, asking Buildbucket for the build status
[10:11:01.601] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:01.601] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:101:0) after 1m0s
[10:12:01.660] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:101:0)
[10:12:01.660] Timer tick, asking Buildbucket for the build status
[10:12:01.795] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:01.795] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:102:0) after 1m0s
[10:13:01.893] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:102:0)
[10:13:01.893] Timer tick, asking Buildbucket for the build status
[10:13:02.275] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:02.275] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:103:0) after 1m0s
[10:14:02.346] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:103:0)
[10:14:02.346] Timer tick, asking Buildbucket for the build status
[10:14:02.531] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:02.531] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:104:0) after 1m0s
[10:15:02.597] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:104:0)
[10:15:02.597] Timer tick, asking Buildbucket for the build status
[10:15:02.896] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:02.896] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:105:0) after 1m0s
[10:16:03.101] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:105:0)
[10:16:03.101] Timer tick, asking Buildbucket for the build status
[10:16:03.438] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:03.438] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:106:0) after 1m0s
[10:17:03.428] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:106:0)
[10:17:03.428] Timer tick, asking Buildbucket for the build status
[10:17:03.553] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:03.553] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:107:0) after 1m0s
[10:18:03.639] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:107:0)
[10:18:03.639] Timer tick, asking Buildbucket for the build status
[10:18:03.788] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:03.788] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:108:0) after 1m0s
[10:19:03.823] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:108:0)
[10:19:03.823] Timer tick, asking Buildbucket for the build status
[10:19:03.947] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:03.947] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:109:0) after 1m0s
[10:20:04.058] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:109:0)
[10:20:04.058] Timer tick, asking Buildbucket for the build status
[10:20:04.361] Build 8886409675202645504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:04.362] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051839737380319856:110:0) after 1m0s
[10:20:04.939] Received PubSub notification, asking Buildbucket for the build status
[10:20:05.212] Build 8886409675202645504: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:20:05.212] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1583662804142050",
"created_by": "project:chromium",
"created_ts": "1583656349903857",
"id": "8886409675202645504",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"52bb9bcf55601233224f95d162c028be0f5b0503\"}}",
"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-central1-b-8-110-9h2g\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 27088, \"got_angle_revision\": \"0c9b6abde90cbf6fd88fe4d86c2d66ef145607b5\", \"got_dawn_revision\": \"7d20b4450182b8e25dfd315019623d7a746cc290\", \"got_nacl_revision\": \"35bcc9f6d5e81c3c39ad57de97ef9cd22301ee9e\", \"got_revision\": \"52bb9bcf55601233224f95d162c028be0f5b0503\", \"got_revision_cp\": \"refs/heads/master@{#748041}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"b44162fdbb25996e4710026007bc98b7201f2a1d\", \"got_v8_revision\": \"d4ed59c4ed609eacc9062bd22ebca409ef7c6d1c\", \"got_v8_revision_cp\": \"refs/heads/8.2.263@{#1}\", \"got_webrtc_revision\": \"04f7bfc4192f5ce444b312afd287203ea53c99b6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30715}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"52bb9bcf55601233224f95d162c028be0f5b0503\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_20aad707bde81044119dd77cf5c9d90dd36ea4d1587e350d19bd0c1a6099dab7_v2\", \"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-110-9h2g\"], \"image\": [\"chrome-xenial-20030100-2bddf837f90\"], \"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\": [\"4851-268d16b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1583656353255681",
"status": "COMPLETED",
"status_changed_ts": "1583662804479771",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/27088",
"builder:Deterministic Linux",
"buildset:commit/git/52bb9bcf55601233224f95d162c028be0f5b0503",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/52bb9bcf55601233224f95d162c028be0f5b0503",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9051839737380319856",
"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/8886409675202645504/+/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:4ad217c228e64010",
"user_agent:luci-scheduler"
],
"updated_ts": "1583662804484514",
"url": "https://ci.chromium.org/b/8886409675202645504",
"utcnow_ts": "1583662805181198"
}
}
[10:20:05.212] Invocation finished in 1h47m36.769936909s with status SUCCEEDED