[22:10:24.565] New invocation is queued and will start shortly
[22:10:25.955] Starting the invocation (attempt 1)
[22:10:25.997] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:10:25.997] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:10:25.997] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9073169161425471264",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"fd5efb2c13d09644df7564cf5873291c6687e5f2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9073169161425471264",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/fd5efb2c13d09644df7564cf5873291c6687e5f2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fd5efb2c13d09644df7564cf5873291c6687e5f2",
"gitiles_ref:refs/heads/master"
]
}
[22:10:27.000] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1563315026183643",
"id": "8907739099063786528",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"fd5efb2c13d09644df7564cf5873291c6687e5f2\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1563315026716082",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/24126",
"builder:Deterministic Linux",
"buildset:commit/git/fd5efb2c13d09644df7564cf5873291c6687e5f2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fd5efb2c13d09644df7564cf5873291c6687e5f2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9073169161425471264",
"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/8907739099063786528/+/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": "1563315026716196",
"url": "https://ci.chromium.org/b/8907739099063786528",
"utcnow_ts": "1563315026989113"
}
}
[22:10:27.000] Task URL: https://ci.chromium.org/b/8907739099063786528
[22:10:27.000] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:2:0) after 1m0s
[22:10:30.954] Received PubSub notification, asking Buildbucket for the build status
[22:10:32.470] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:27.109] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:2:0)
[22:11:27.109] Timer tick, asking Buildbucket for the build status
[22:11:27.586] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:27.586] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:4:0) after 1m0s
[22:12:27.624] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:4:0)
[22:12:27.624] Timer tick, asking Buildbucket for the build status
[22:12:27.864] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:27.864] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:5:0) after 1m0s
[22:13:27.938] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:5:0)
[22:13:27.938] Timer tick, asking Buildbucket for the build status
[22:13:29.108] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:29.108] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:6:0) after 1m0s
[22:14:29.276] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:6:0)
[22:14:29.276] Timer tick, asking Buildbucket for the build status
[22:14:30.154] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:30.154] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:7:0) after 1m0s
[22:15:30.239] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:7:0)
[22:15:30.239] Timer tick, asking Buildbucket for the build status
[22:15:30.507] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:30.507] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:8:0) after 1m0s
[22:16:30.608] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:8:0)
[22:16:30.608] Timer tick, asking Buildbucket for the build status
[22:16:30.932] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:30.932] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:9:0) after 1m0s
[22:17:31.143] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:9:0)
[22:17:31.143] Timer tick, asking Buildbucket for the build status
[22:17:31.264] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:31.264] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:10:0) after 1m0s
[22:18:31.526] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:10:0)
[22:18:31.526] Timer tick, asking Buildbucket for the build status
[22:18:32.349] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:32.349] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:11:0) after 1m0s
[22:19:32.506] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:11:0)
[22:19:32.506] Timer tick, asking Buildbucket for the build status
[22:19:33.119] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:33.119] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:12:0) after 1m0s
[22:20:33.252] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:12:0)
[22:20:33.252] Timer tick, asking Buildbucket for the build status
[22:20:34.543] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:34.543] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:13:0) after 1m0s
[22:21:34.659] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:13:0)
[22:21:34.659] Timer tick, asking Buildbucket for the build status
[22:21:35.187] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:35.187] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:14:0) after 1m0s
[22:22:35.279] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:14:0)
[22:22:35.280] Timer tick, asking Buildbucket for the build status
[22:22:35.391] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:35.391] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:15:0) after 1m0s
[22:23:35.480] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:15:0)
[22:23:35.480] Timer tick, asking Buildbucket for the build status
[22:23:35.849] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:35.849] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:16:0) after 1m0s
[22:24:35.953] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:16:0)
[22:24:35.953] Timer tick, asking Buildbucket for the build status
[22:24:37.197] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:37.197] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:17:0) after 1m0s
[22:25:37.265] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:17:0)
[22:25:37.265] Timer tick, asking Buildbucket for the build status
[22:25:37.549] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:37.549] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:18:0) after 1m0s
[22:26:37.644] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:18:0)
[22:26:37.644] Timer tick, asking Buildbucket for the build status
[22:26:38.033] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:38.033] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:19:0) after 1m0s
[22:27:38.074] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:19:0)
[22:27:38.074] Timer tick, asking Buildbucket for the build status
[22:27:38.408] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:38.408] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:20:0) after 1m0s
[22:28:38.529] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:20:0)
[22:28:38.529] Timer tick, asking Buildbucket for the build status
[22:28:38.970] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:38.970] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:21:0) after 1m0s
[22:29:39.008] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:21:0)
[22:29:39.008] Timer tick, asking Buildbucket for the build status
[22:29:39.156] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:39.156] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:22:0) after 1m0s
[22:30:39.192] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:22:0)
[22:30:39.192] Timer tick, asking Buildbucket for the build status
[22:30:39.632] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:39.632] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:23:0) after 1m0s
[22:31:39.737] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:23:0)
[22:31:39.737] Timer tick, asking Buildbucket for the build status
[22:31:39.975] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:39.975] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:24:0) after 1m0s
[22:32:40.046] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:24:0)
[22:32:40.046] Timer tick, asking Buildbucket for the build status
[22:32:40.588] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:40.588] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:25:0) after 1m0s
[22:33:40.629] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:25:0)
[22:33:40.629] Timer tick, asking Buildbucket for the build status
[22:33:40.809] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:40.809] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:26:0) after 1m0s
[22:34:40.839] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:26:0)
[22:34:40.839] Timer tick, asking Buildbucket for the build status
[22:34:41.695] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:41.695] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:27:0) after 1m0s
[22:35:41.784] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:27:0)
[22:35:41.784] Timer tick, asking Buildbucket for the build status
[22:35:41.946] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:41.947] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:28:0) after 1m0s
[22:36:42.092] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:28:0)
[22:36:42.092] Timer tick, asking Buildbucket for the build status
[22:36:42.225] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:42.225] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:29:0) after 1m0s
[22:37:42.320] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:29:0)
[22:37:42.320] Timer tick, asking Buildbucket for the build status
[22:37:43.198] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:43.198] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:30:0) after 1m0s
[22:38:43.216] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:30:0)
[22:38:43.216] Timer tick, asking Buildbucket for the build status
[22:38:43.774] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:43.774] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:31:0) after 1m0s
[22:39:43.814] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:31:0)
[22:39:43.814] Timer tick, asking Buildbucket for the build status
[22:39:44.127] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:44.127] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:32:0) after 1m0s
[22:40:44.155] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:32:0)
[22:40:44.155] Timer tick, asking Buildbucket for the build status
[22:40:46.611] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:46.611] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:33:0) after 1m0s
[22:41:46.683] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:33:0)
[22:41:46.683] Timer tick, asking Buildbucket for the build status
[22:41:47.114] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:47.114] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:34:0) after 1m0s
[22:42:47.144] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:34:0)
[22:42:47.144] Timer tick, asking Buildbucket for the build status
[22:42:48.754] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:48.754] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:35:0) after 1m0s
[22:43:48.792] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:35:0)
[22:43:48.792] Timer tick, asking Buildbucket for the build status
[22:43:49.191] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:49.191] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:36:0) after 1m0s
[22:44:49.510] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:36:0)
[22:44:49.510] Timer tick, asking Buildbucket for the build status
[22:44:49.618] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:49.618] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:37:0) after 1m0s
[22:45:49.842] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:37:0)
[22:45:49.842] Timer tick, asking Buildbucket for the build status
[22:45:50.009] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:50.010] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:38:0) after 1m0s
[22:46:50.307] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:38:0)
[22:46:50.307] Timer tick, asking Buildbucket for the build status
[22:46:50.443] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:50.443] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:39:0) after 1m0s
[22:47:50.591] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:39:0)
[22:47:50.591] Timer tick, asking Buildbucket for the build status
[22:47:51.173] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:51.173] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:40:0) after 1m0s
[22:48:51.276] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:40:0)
[22:48:51.276] Timer tick, asking Buildbucket for the build status
[22:48:52.223] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:52.224] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:41:0) after 1m0s
[22:49:52.226] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:41:0)
[22:49:52.226] Timer tick, asking Buildbucket for the build status
[22:49:52.475] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:52.475] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:42:0) after 1m0s
[22:50:52.606] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:42:0)
[22:50:52.606] Timer tick, asking Buildbucket for the build status
[22:50:53.557] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:53.557] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:43:0) after 1m0s
[22:51:53.676] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:43:0)
[22:51:53.676] Timer tick, asking Buildbucket for the build status
[22:51:53.853] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:53.853] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:44:0) after 1m0s
[22:52:54.063] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:44:0)
[22:52:54.063] Timer tick, asking Buildbucket for the build status
[22:52:54.341] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:54.341] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:45:0) after 1m0s
[22:53:54.372] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:45:0)
[22:53:54.372] Timer tick, asking Buildbucket for the build status
[22:53:54.941] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:54.941] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:46:0) after 1m0s
[22:54:54.983] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:46:0)
[22:54:54.983] Timer tick, asking Buildbucket for the build status
[22:54:55.940] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:55.940] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:47:0) after 1m0s
[22:55:56.091] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:47:0)
[22:55:56.091] Timer tick, asking Buildbucket for the build status
[22:55:56.259] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:56.259] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:48:0) after 1m0s
[22:56:56.351] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:48:0)
[22:56:56.351] Timer tick, asking Buildbucket for the build status
[22:56:56.528] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:56.528] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:49:0) after 1m0s
[22:57:56.656] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:49:0)
[22:57:56.656] Timer tick, asking Buildbucket for the build status
[22:57:57.049] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:57.049] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:50:0) after 1m0s
[22:58:57.081] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:50:0)
[22:58:57.081] Timer tick, asking Buildbucket for the build status
[22:58:57.303] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:57.303] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:51:0) after 1m0s
[22:59:57.433] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:51:0)
[22:59:57.433] Timer tick, asking Buildbucket for the build status
[22:59:57.656] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:57.656] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:52:0) after 1m0s
[23:00:57.740] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:52:0)
[23:00:57.740] Timer tick, asking Buildbucket for the build status
[23:00:57.898] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:57.898] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:53:0) after 1m0s
[23:01:57.950] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:53:0)
[23:01:57.950] Timer tick, asking Buildbucket for the build status
[23:01:59.518] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:59.518] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:54:0) after 1m0s
[23:02:59.617] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:54:0)
[23:02:59.617] Timer tick, asking Buildbucket for the build status
[23:02:59.783] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:59.783] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:55:0) after 1m0s
[23:03:59.812] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:55:0)
[23:03:59.812] Timer tick, asking Buildbucket for the build status
[23:03:59.962] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:59.962] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:56:0) after 1m0s
[23:04:59.999] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:56:0)
[23:04:59.999] Timer tick, asking Buildbucket for the build status
[23:05:00.305] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:00.305] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:57:0) after 1m0s
[23:06:00.289] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:57:0)
[23:06:00.289] Timer tick, asking Buildbucket for the build status
[23:06:01.341] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:01.341] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:58:0) after 1m0s
[23:07:01.435] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:58:0)
[23:07:01.435] Timer tick, asking Buildbucket for the build status
[23:07:01.710] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:01.710] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:59:0) after 1m0s
[23:08:01.743] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:59:0)
[23:08:01.743] Timer tick, asking Buildbucket for the build status
[23:08:02.336] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:02.336] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:60:0) after 1m0s
[23:09:02.364] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:60:0)
[23:09:02.364] Timer tick, asking Buildbucket for the build status
[23:09:02.881] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:02.881] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:61:0) after 1m0s
[23:10:02.959] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:61:0)
[23:10:02.959] Timer tick, asking Buildbucket for the build status
[23:10:03.208] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:03.208] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:62:0) after 1m0s
[23:11:03.269] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:62:0)
[23:11:03.269] Timer tick, asking Buildbucket for the build status
[23:11:06.690] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:06.690] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:63:0) after 1m0s
[23:12:06.787] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:63:0)
[23:12:06.787] Timer tick, asking Buildbucket for the build status
[23:12:08.485] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:08.485] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:64:0) after 1m0s
[23:13:08.534] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:64:0)
[23:13:08.534] Timer tick, asking Buildbucket for the build status
[23:13:09.139] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:09.139] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:65:0) after 1m0s
[23:14:09.182] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:65:0)
[23:14:09.182] Timer tick, asking Buildbucket for the build status
[23:14:09.419] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:09.419] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:66:0) after 1m0s
[23:15:09.440] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:66:0)
[23:15:09.440] Timer tick, asking Buildbucket for the build status
[23:15:11.498] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:11.498] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:67:0) after 1m0s
[23:16:11.722] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:67:0)
[23:16:11.722] Timer tick, asking Buildbucket for the build status
[23:16:12.368] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:12.368] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:68:0) after 1m0s
[23:17:12.487] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:68:0)
[23:17:12.487] Timer tick, asking Buildbucket for the build status
[23:17:12.786] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:12.786] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:69:0) after 1m0s
[23:18:12.831] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:69:0)
[23:18:12.831] Timer tick, asking Buildbucket for the build status
[23:18:13.124] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:13.124] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:70:0) after 1m0s
[23:19:13.201] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:70:0)
[23:19:13.201] Timer tick, asking Buildbucket for the build status
[23:19:13.447] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:13.447] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:71:0) after 1m0s
[23:20:13.504] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:71:0)
[23:20:13.504] Timer tick, asking Buildbucket for the build status
[23:20:13.650] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:13.650] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:72:0) after 1m0s
[23:21:13.810] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:72:0)
[23:21:13.810] Timer tick, asking Buildbucket for the build status
[23:21:14.011] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:14.011] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:73:0) after 1m0s
[23:22:14.071] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:73:0)
[23:22:14.071] Timer tick, asking Buildbucket for the build status
[23:22:14.268] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:14.268] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:74:0) after 1m0s
[23:23:14.298] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:74:0)
[23:23:14.298] Timer tick, asking Buildbucket for the build status
[23:23:20.603] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:20.603] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:75:0) after 1m0s
[23:24:20.657] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:75:0)
[23:24:20.657] Timer tick, asking Buildbucket for the build status
[23:24:20.890] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:20.890] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:76:0) after 1m0s
[23:25:21.039] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:76:0)
[23:25:21.039] Timer tick, asking Buildbucket for the build status
[23:25:21.252] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:21.252] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:77:0) after 1m0s
[23:26:21.383] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:77:0)
[23:26:21.383] Timer tick, asking Buildbucket for the build status
[23:26:22.018] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:22.018] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:78:0) after 1m0s
[23:27:22.206] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:78:0)
[23:27:22.206] Timer tick, asking Buildbucket for the build status
[23:27:22.547] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:22.547] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:79:0) after 1m0s
[23:28:22.708] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:79:0)
[23:28:22.708] Timer tick, asking Buildbucket for the build status
[23:28:23.418] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:23.418] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:80:0) after 1m0s
[23:29:23.404] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:80:0)
[23:29:23.404] Timer tick, asking Buildbucket for the build status
[23:29:23.634] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:23.634] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:81:0) after 1m0s
[23:30:23.666] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:81:0)
[23:30:23.666] Timer tick, asking Buildbucket for the build status
[23:30:24.519] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:24.520] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:82:0) after 1m0s
[23:31:24.571] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:82:0)
[23:31:24.571] Timer tick, asking Buildbucket for the build status
[23:31:24.765] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:24.765] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:83:0) after 1m0s
[23:32:24.791] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:83:0)
[23:32:24.791] Timer tick, asking Buildbucket for the build status
[23:32:24.974] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:24.974] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:84:0) after 1m0s
[23:33:24.982] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:84:0)
[23:33:24.982] Timer tick, asking Buildbucket for the build status
[23:33:25.418] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:25.418] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:85:0) after 1m0s
[23:34:25.469] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:85:0)
[23:34:25.469] Timer tick, asking Buildbucket for the build status
[23:34:25.605] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:25.605] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:86:0) after 1m0s
[23:35:25.634] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:86:0)
[23:35:25.634] Timer tick, asking Buildbucket for the build status
[23:35:25.784] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:25.784] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:87:0) after 1m0s
[23:36:25.812] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:87:0)
[23:36:25.812] Timer tick, asking Buildbucket for the build status
[23:36:25.946] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:25.946] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:88:0) after 1m0s
[23:37:26.049] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:88:0)
[23:37:26.049] Timer tick, asking Buildbucket for the build status
[23:37:26.906] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:26.906] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:89:0) after 1m0s
[23:38:26.943] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:89:0)
[23:38:26.943] Timer tick, asking Buildbucket for the build status
[23:38:27.254] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:27.254] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:90:0) after 1m0s
[23:39:27.244] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:90:0)
[23:39:27.244] Timer tick, asking Buildbucket for the build status
[23:39:27.715] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:27.715] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:91:0) after 1m0s
[23:40:27.807] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:91:0)
[23:40:27.807] Timer tick, asking Buildbucket for the build status
[23:40:28.618] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:28.618] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:92:0) after 1m0s
[23:41:28.667] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:92:0)
[23:41:28.667] Timer tick, asking Buildbucket for the build status
[23:41:28.981] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:28.981] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:93:0) after 1m0s
[23:42:29.163] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:93:0)
[23:42:29.163] Timer tick, asking Buildbucket for the build status
[23:42:29.363] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:29.363] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:94:0) after 1m0s
[23:43:29.397] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:94:0)
[23:43:29.397] Timer tick, asking Buildbucket for the build status
[23:43:30.061] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:30.061] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:95:0) after 1m0s
[23:44:30.162] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:95:0)
[23:44:30.162] Timer tick, asking Buildbucket for the build status
[23:44:30.515] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:30.515] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:96:0) after 1m0s
[23:45:30.564] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:96:0)
[23:45:30.564] Timer tick, asking Buildbucket for the build status
[23:45:31.132] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:31.132] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:97:0) after 1m0s
[23:46:31.188] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:97:0)
[23:46:31.188] Timer tick, asking Buildbucket for the build status
[23:46:31.334] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:31.335] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:98:0) after 1m0s
[23:47:31.391] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:98:0)
[23:47:31.391] Timer tick, asking Buildbucket for the build status
[23:47:31.728] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:31.728] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:99:0) after 1m0s
[23:48:31.792] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:99:0)
[23:48:31.792] Timer tick, asking Buildbucket for the build status
[23:48:32.535] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:32.535] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:100:0) after 1m0s
[23:49:32.618] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:100:0)
[23:49:32.618] Timer tick, asking Buildbucket for the build status
[23:49:32.731] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:32.731] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:101:0) after 1m0s
[23:50:32.917] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:101:0)
[23:50:32.917] Timer tick, asking Buildbucket for the build status
[23:50:33.169] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:33.169] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:102:0) after 1m0s
[23:51:33.201] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:102:0)
[23:51:33.201] Timer tick, asking Buildbucket for the build status
[23:51:33.318] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:33.318] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:103:0) after 1m0s
[23:52:33.536] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:103:0)
[23:52:33.536] Timer tick, asking Buildbucket for the build status
[23:52:39.948] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:39.948] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:104:0) after 1m0s
[23:53:40.007] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:104:0)
[23:53:40.007] Timer tick, asking Buildbucket for the build status
[23:53:40.844] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:40.844] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:105:0) after 1m0s
[23:54:40.875] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:105:0)
[23:54:40.875] Timer tick, asking Buildbucket for the build status
[23:54:41.792] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:41.792] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:106:0) after 1m0s
[23:55:41.927] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:106:0)
[23:55:41.927] Timer tick, asking Buildbucket for the build status
[23:55:42.207] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:42.207] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:107:0) after 1m0s
[23:56:42.255] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:107:0)
[23:56:42.255] Timer tick, asking Buildbucket for the build status
[23:56:42.426] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:42.426] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:108:0) after 1m0s
[23:57:42.464] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:108:0)
[23:57:42.464] Timer tick, asking Buildbucket for the build status
[23:57:42.610] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:42.610] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:109:0) after 1m0s
[23:58:42.684] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:109:0)
[23:58:42.684] Timer tick, asking Buildbucket for the build status
[23:58:43.534] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:43.534] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:110:0) after 1m0s
[23:59:43.537] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:110:0)
[23:59:43.537] Timer tick, asking Buildbucket for the build status
[23:59:44.382] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:44.382] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:111:0) after 1m0s
[00:00:45.391] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:111:0)
[00:00:45.391] Timer tick, asking Buildbucket for the build status
[00:00:46.153] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:46.153] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:112:0) after 1m0s
[00:01:46.315] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:112:0)
[00:01:46.315] Timer tick, asking Buildbucket for the build status
[00:01:46.808] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:46.808] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:113:0) after 1m0s
[00:02:46.885] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:113:0)
[00:02:46.885] Timer tick, asking Buildbucket for the build status
[00:02:47.798] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:47.798] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:114:0) after 1m0s
[00:03:47.884] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:114:0)
[00:03:47.884] Timer tick, asking Buildbucket for the build status
[00:03:49.601] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:49.601] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:115:0) after 1m0s
[00:04:49.853] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:115:0)
[00:04:49.853] Timer tick, asking Buildbucket for the build status
[00:04:50.673] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:50.673] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:116:0) after 1m0s
[00:05:50.755] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:116:0)
[00:05:50.755] Timer tick, asking Buildbucket for the build status
[00:05:50.983] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:50.983] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:117:0) after 1m0s
[00:06:51.054] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:117:0)
[00:06:51.054] Timer tick, asking Buildbucket for the build status
[00:06:51.201] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:51.201] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:118:0) after 1m0s
[00:07:51.436] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:118:0)
[00:07:51.436] Timer tick, asking Buildbucket for the build status
[00:07:51.883] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:51.883] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:119:0) after 1m0s
[00:08:51.956] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:119:0)
[00:08:51.956] Timer tick, asking Buildbucket for the build status
[00:08:52.577] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:52.577] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:120:0) after 1m0s
[00:09:52.604] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:120:0)
[00:09:52.604] Timer tick, asking Buildbucket for the build status
[00:09:52.981] Build 8907739099063786528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:52.981] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073169161425471264:121:0) after 1m0s
[00:10:38.142] Received PubSub notification, asking Buildbucket for the build status
[00:10:39.209] Build 8907739099063786528: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:10:39.209] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1563322236534771",
"created_by": "project:chromium",
"created_ts": "1563315026183643",
"id": "8907739099063786528",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"fd5efb2c13d09644df7564cf5873291c6687e5f2\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-trusty-8-37-cbdl\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 24126, \"got_angle_revision\": \"ec9ff8ce3909ec618842d1922aacf6c6cd961b2e\", \"got_dawn_revision\": \"4af9808400d993f58977ed7d320b1f912e92573f\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"fd5efb2c13d09644df7564cf5873291c6687e5f2\", \"got_revision_cp\": \"refs/heads/master@{#677994}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"ffee6baaeee1bcaa8d1bba5e981377d30b37bd88\", \"got_v8_revision_cp\": \"refs/heads/7.7.248@{#1}\", \"got_webrtc_revision\": \"08da49d0a488aaf915f90c33b1f9bdbfecbe4367\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28579}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"fd5efb2c13d09644df7564cf5873291c6687e5f2\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_28bbe8e6e9c00f2d4cca6bb7518e2e3abcc6dba52c0db172294f96352b49589a_v2\", \"builder_36472ddafb4960b563fa0dfd4883d4c097bf9805cea97d60ada20c6be0c80514_v2\", \"builder_5962259a05f00f2add6b886e805611a7d5779224d38d219d9f2179a6416f230e_v2\", \"builder_65fafd0c860c8cf0043a2ec0f6482d6e089dd429d22310040aa34c8b96106827_v2\", \"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-trusty-8-37-cbdl\"], \"image\": [\"chrome-trusty-19041600-95c8804d634\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4370-0e704a3\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1563315030153086",
"status": "COMPLETED",
"status_changed_ts": "1563322237423555",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/24126",
"builder:Deterministic Linux",
"buildset:commit/git/fd5efb2c13d09644df7564cf5873291c6687e5f2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fd5efb2c13d09644df7564cf5873291c6687e5f2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9073169161425471264",
"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/8907739099063786528/+/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:4615a7c584df9810",
"user_agent:luci-scheduler"
],
"updated_ts": "1563322237592249",
"url": "https://ci.chromium.org/b/8907739099063786528",
"utcnow_ts": "1563322239185661"
}
}
[00:10:39.209] Invocation finished in 2h0m14.662036717s with status SUCCEEDED