[00:02:20.340] New invocation is queued and will start shortly
[00:02:21.420] Starting the invocation (attempt 1)
[00:02:21.462] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:02:21.462] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:02:21.462] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9063105856156504592",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"5a934f16018e774d5ef5264b87ebeb25e9cdddd9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9063105856156504592",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/5a934f16018e774d5ef5264b87ebeb25e9cdddd9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5a934f16018e774d5ef5264b87ebeb25e9cdddd9",
"gitiles_ref:refs/heads/master"
]
}
[00:02:22.598] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1572912141703254",
"id": "8897675794059423936",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5a934f16018e774d5ef5264b87ebeb25e9cdddd9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1572912142360913",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/25557",
"builder:Deterministic Linux",
"buildset:commit/git/5a934f16018e774d5ef5264b87ebeb25e9cdddd9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5a934f16018e774d5ef5264b87ebeb25e9cdddd9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9063105856156504592",
"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/8897675794059423936/+/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": "1572912142361144",
"url": "https://ci.chromium.org/b/8897675794059423936",
"utcnow_ts": "1572912142583276"
}
}
[00:02:22.598] Task URL: https://ci.chromium.org/b/8897675794059423936
[00:02:22.598] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:2:0) after 1m0s
[00:03:22.941] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:2:0)
[00:03:22.941] Timer tick, asking Buildbucket for the build status
[00:03:23.573] Build 8897675794059423936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:03:23.573] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:3:0) after 1m0s
[00:03:38.717] Received PubSub notification, asking Buildbucket for the build status
[00:03:39.213] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:23.707] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:3:0)
[00:04:23.707] Timer tick, asking Buildbucket for the build status
[00:04:24.362] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:24.362] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:5:0) after 1m0s
[00:05:24.679] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:5:0)
[00:05:24.679] Timer tick, asking Buildbucket for the build status
[00:05:24.974] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:24.974] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:6:0) after 1m0s
[00:06:25.043] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:6:0)
[00:06:25.043] Timer tick, asking Buildbucket for the build status
[00:06:25.238] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:25.238] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:7:0) after 1m0s
[00:07:25.245] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:7:0)
[00:07:25.245] Timer tick, asking Buildbucket for the build status
[00:07:25.504] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:25.504] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:8:0) after 1m0s
[00:08:25.632] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:8:0)
[00:08:25.632] Timer tick, asking Buildbucket for the build status
[00:08:25.915] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:25.915] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:9:0) after 1m0s
[00:09:25.936] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:9:0)
[00:09:25.936] Timer tick, asking Buildbucket for the build status
[00:09:26.951] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:26.951] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:10:0) after 1m0s
[00:10:26.975] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:10:0)
[00:10:26.975] Timer tick, asking Buildbucket for the build status
[00:10:29.313] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:29.313] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:11:0) after 1m0s
[00:11:29.469] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:11:0)
[00:11:29.469] Timer tick, asking Buildbucket for the build status
[00:11:30.556] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:30.556] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:12:0) after 1m0s
[00:12:30.687] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:12:0)
[00:12:30.687] Timer tick, asking Buildbucket for the build status
[00:12:30.927] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:30.927] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:13:0) after 1m0s
[00:13:30.978] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:13:0)
[00:13:30.978] Timer tick, asking Buildbucket for the build status
[00:13:31.247] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:31.247] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:14:0) after 1m0s
[00:14:31.274] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:14:0)
[00:14:31.274] Timer tick, asking Buildbucket for the build status
[00:14:31.631] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:31.631] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:15:0) after 1m0s
[00:15:31.656] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:15:0)
[00:15:31.656] Timer tick, asking Buildbucket for the build status
[00:15:34.122] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:34.122] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:16:0) after 1m0s
[00:16:34.112] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:16:0)
[00:16:34.112] Timer tick, asking Buildbucket for the build status
[00:16:35.191] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:35.191] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:17:0) after 1m0s
[00:17:35.302] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:17:0)
[00:17:35.302] Timer tick, asking Buildbucket for the build status
[00:17:35.869] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:35.869] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:18:0) after 1m0s
[00:18:35.947] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:18:0)
[00:18:35.947] Timer tick, asking Buildbucket for the build status
[00:18:37.099] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:37.099] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:19:0) after 1m0s
[00:19:37.236] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:19:0)
[00:19:37.236] Timer tick, asking Buildbucket for the build status
[00:19:38.148] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:38.148] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:20:0) after 1m0s
[00:20:38.159] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:20:0)
[00:20:38.159] Timer tick, asking Buildbucket for the build status
[00:20:38.919] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:38.919] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:21:0) after 1m0s
[00:21:38.992] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:21:0)
[00:21:38.992] Timer tick, asking Buildbucket for the build status
[00:21:39.475] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:39.475] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:22:0) after 1m0s
[00:22:39.498] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:22:0)
[00:22:39.498] Timer tick, asking Buildbucket for the build status
[00:22:42.847] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:42.847] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:23:0) after 1m0s
[00:23:43.005] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:23:0)
[00:23:43.005] Timer tick, asking Buildbucket for the build status
[00:23:43.522] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:43.522] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:24:0) after 1m0s
[00:24:43.639] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:24:0)
[00:24:43.639] Timer tick, asking Buildbucket for the build status
[00:24:44.670] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:44.671] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:25:0) after 1m0s
[00:25:44.744] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:25:0)
[00:25:44.744] Timer tick, asking Buildbucket for the build status
[00:25:45.557] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:45.557] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:26:0) after 1m0s
[00:26:45.644] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:26:0)
[00:26:45.644] Timer tick, asking Buildbucket for the build status
[00:26:46.166] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:46.166] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:27:0) after 1m0s
[00:27:46.176] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:27:0)
[00:27:46.176] Timer tick, asking Buildbucket for the build status
[00:27:46.798] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:46.799] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:28:0) after 1m0s
[00:28:46.848] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:28:0)
[00:28:46.848] Timer tick, asking Buildbucket for the build status
[00:28:47.134] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:47.134] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:29:0) after 1m0s
[00:29:47.190] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:29:0)
[00:29:47.190] Timer tick, asking Buildbucket for the build status
[00:29:47.394] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:47.394] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:30:0) after 1m0s
[00:30:47.420] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:30:0)
[00:30:47.420] Timer tick, asking Buildbucket for the build status
[00:30:47.943] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:47.943] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:31:0) after 1m0s
[00:31:47.986] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:31:0)
[00:31:47.986] Timer tick, asking Buildbucket for the build status
[00:31:48.294] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:48.294] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:32:0) after 1m0s
[00:32:48.381] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:32:0)
[00:32:48.382] Timer tick, asking Buildbucket for the build status
[00:32:48.921] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:48.921] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:33:0) after 1m0s
[00:33:48.955] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:33:0)
[00:33:48.955] Timer tick, asking Buildbucket for the build status
[00:33:52.935] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:52.936] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:34:0) after 1m0s
[00:34:53.019] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:34:0)
[00:34:53.019] Timer tick, asking Buildbucket for the build status
[00:34:53.413] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:53.413] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:35:0) after 1m0s
[00:35:53.446] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:35:0)
[00:35:53.446] Timer tick, asking Buildbucket for the build status
[00:35:53.699] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:53.699] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:36:0) after 1m0s
[00:36:53.724] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:36:0)
[00:36:53.724] Timer tick, asking Buildbucket for the build status
[00:36:54.526] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:54.526] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:37:0) after 1m0s
[00:37:54.552] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:37:0)
[00:37:54.552] Timer tick, asking Buildbucket for the build status
[00:37:54.718] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:54.718] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:38:0) after 1m0s
[00:38:54.748] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:38:0)
[00:38:54.748] Timer tick, asking Buildbucket for the build status
[00:38:56.218] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:56.218] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:39:0) after 1m0s
[00:39:56.254] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:39:0)
[00:39:56.254] Timer tick, asking Buildbucket for the build status
[00:39:59.568] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:59.568] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:40:0) after 1m0s
[00:40:59.669] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:40:0)
[00:40:59.669] Timer tick, asking Buildbucket for the build status
[00:41:00.487] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:00.487] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:41:0) after 1m0s
[00:42:00.520] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:41:0)
[00:42:00.520] Timer tick, asking Buildbucket for the build status
[00:42:01.070] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:01.070] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:42:0) after 1m0s
[00:43:01.139] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:42:0)
[00:43:01.139] Timer tick, asking Buildbucket for the build status
[00:43:01.676] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:01.676] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:43:0) after 1m0s
[00:44:01.688] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:43:0)
[00:44:01.688] Timer tick, asking Buildbucket for the build status
[00:44:02.124] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:02.124] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:44:0) after 1m0s
[00:45:02.192] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:44:0)
[00:45:02.193] Timer tick, asking Buildbucket for the build status
[00:45:03.412] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:03.412] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:45:0) after 1m0s
[00:46:03.445] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:45:0)
[00:46:03.445] Timer tick, asking Buildbucket for the build status
[00:46:04.714] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:04.714] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:46:0) after 1m0s
[00:47:04.808] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:46:0)
[00:47:04.808] Timer tick, asking Buildbucket for the build status
[00:47:05.744] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:05.744] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:47:0) after 1m0s
[00:48:05.980] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:47:0)
[00:48:05.980] Timer tick, asking Buildbucket for the build status
[00:48:06.219] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:06.219] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:48:0) after 1m0s
[00:49:06.342] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:48:0)
[00:49:06.342] Timer tick, asking Buildbucket for the build status
[00:49:07.590] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:07.590] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:49:0) after 1m0s
[00:50:07.702] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:49:0)
[00:50:07.702] Timer tick, asking Buildbucket for the build status
[00:50:09.002] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:09.002] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:50:0) after 1m0s
[00:51:09.124] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:50:0)
[00:51:09.124] Timer tick, asking Buildbucket for the build status
[00:51:10.974] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:10.974] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:51:0) after 1m0s
[00:52:10.986] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:51:0)
[00:52:10.986] Timer tick, asking Buildbucket for the build status
[00:52:11.697] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:11.697] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:52:0) after 1m0s
[00:53:11.749] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:52:0)
[00:53:11.749] Timer tick, asking Buildbucket for the build status
[00:53:11.970] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:11.970] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:53:0) after 1m0s
[00:54:12.067] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:53:0)
[00:54:12.067] Timer tick, asking Buildbucket for the build status
[00:54:12.966] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:12.966] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:54:0) after 1m0s
[00:55:13.108] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:54:0)
[00:55:13.108] Timer tick, asking Buildbucket for the build status
[00:55:13.374] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:13.374] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:55:0) after 1m0s
[00:56:13.542] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:55:0)
[00:56:13.542] Timer tick, asking Buildbucket for the build status
[00:56:13.734] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:13.734] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:56:0) after 1m0s
[00:57:13.963] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:56:0)
[00:57:13.963] Timer tick, asking Buildbucket for the build status
[00:57:14.222] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:14.222] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:57:0) after 1m0s
[00:58:14.260] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:57:0)
[00:58:14.260] Timer tick, asking Buildbucket for the build status
[00:58:15.041] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:15.041] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:58:0) after 1m0s
[00:59:15.115] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:58:0)
[00:59:15.115] Timer tick, asking Buildbucket for the build status
[00:59:15.364] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:15.364] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:59:0) after 1m0s
[01:00:15.398] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:59:0)
[01:00:15.398] Timer tick, asking Buildbucket for the build status
[01:00:15.794] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:15.794] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:60:0) after 1m0s
[01:01:15.825] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:60:0)
[01:01:15.825] Timer tick, asking Buildbucket for the build status
[01:01:16.334] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:16.334] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:61:0) after 1m0s
[01:02:16.432] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:61:0)
[01:02:16.432] Timer tick, asking Buildbucket for the build status
[01:02:16.706] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:16.706] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:62:0) after 1m0s
[01:03:16.985] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:62:0)
[01:03:16.985] Timer tick, asking Buildbucket for the build status
[01:03:17.251] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:17.251] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:63:0) after 1m0s
[01:04:17.338] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:63:0)
[01:04:17.338] Timer tick, asking Buildbucket for the build status
[01:04:17.668] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:17.668] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:64:0) after 1m0s
[01:05:18.012] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:64:0)
[01:05:18.013] Timer tick, asking Buildbucket for the build status
[01:05:19.301] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:19.301] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:65:0) after 1m0s
[01:06:19.432] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:65:0)
[01:06:19.432] Timer tick, asking Buildbucket for the build status
[01:06:19.602] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:19.602] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:66:0) after 1m0s
[01:07:19.663] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:66:0)
[01:07:19.663] Timer tick, asking Buildbucket for the build status
[01:07:20.144] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:20.144] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:67:0) after 1m0s
[01:08:20.239] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:67:0)
[01:08:20.239] Timer tick, asking Buildbucket for the build status
[01:08:20.519] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:20.519] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:68:0) after 1m0s
[01:09:20.555] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:68:0)
[01:09:20.555] Timer tick, asking Buildbucket for the build status
[01:09:20.709] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:20.709] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:69:0) after 1m0s
[01:10:20.744] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:69:0)
[01:10:20.744] Timer tick, asking Buildbucket for the build status
[01:10:22.526] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:22.526] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:70:0) after 1m0s
[01:11:22.596] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:70:0)
[01:11:22.596] Timer tick, asking Buildbucket for the build status
[01:11:23.047] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:23.047] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:71:0) after 1m0s
[01:12:23.070] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:71:0)
[01:12:23.070] Timer tick, asking Buildbucket for the build status
[01:12:23.812] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:23.812] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:72:0) after 1m0s
[01:13:23.866] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:72:0)
[01:13:23.866] Timer tick, asking Buildbucket for the build status
[01:13:24.108] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:24.108] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:73:0) after 1m0s
[01:14:24.204] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:73:0)
[01:14:24.204] Timer tick, asking Buildbucket for the build status
[01:14:24.449] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:24.449] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:74:0) after 1m0s
[01:15:24.493] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:74:0)
[01:15:24.493] Timer tick, asking Buildbucket for the build status
[01:15:24.677] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:24.677] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:75:0) after 1m0s
[01:16:24.762] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:75:0)
[01:16:24.762] Timer tick, asking Buildbucket for the build status
[01:16:24.967] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:24.967] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:76:0) after 1m0s
[01:17:25.113] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:76:0)
[01:17:25.113] Timer tick, asking Buildbucket for the build status
[01:17:25.346] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:25.346] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:77:0) after 1m0s
[01:18:25.482] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:77:0)
[01:18:25.482] Timer tick, asking Buildbucket for the build status
[01:18:25.781] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:25.781] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:78:0) after 1m0s
[01:19:25.897] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:78:0)
[01:19:25.897] Timer tick, asking Buildbucket for the build status
[01:19:26.121] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:26.121] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:79:0) after 1m0s
[01:20:26.203] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:79:0)
[01:20:26.203] Timer tick, asking Buildbucket for the build status
[01:20:26.408] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:26.408] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:80:0) after 1m0s
[01:21:26.483] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:80:0)
[01:21:26.483] Timer tick, asking Buildbucket for the build status
[01:21:26.675] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:26.675] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:81:0) after 1m0s
[01:22:26.752] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:81:0)
[01:22:26.752] Timer tick, asking Buildbucket for the build status
[01:22:27.231] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:27.231] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:82:0) after 1m0s
[01:23:27.278] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:82:0)
[01:23:27.278] Timer tick, asking Buildbucket for the build status
[01:23:27.961] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:27.961] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:83:0) after 1m0s
[01:24:27.985] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:83:0)
[01:24:27.985] Timer tick, asking Buildbucket for the build status
[01:24:28.462] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:28.462] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:84:0) after 1m0s
[01:25:28.493] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:84:0)
[01:25:28.493] Timer tick, asking Buildbucket for the build status
[01:25:28.779] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:28.779] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:85:0) after 1m0s
[01:26:28.946] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:85:0)
[01:26:28.946] Timer tick, asking Buildbucket for the build status
[01:26:29.245] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:29.245] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:86:0) after 1m0s
[01:27:29.238] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:86:0)
[01:27:29.238] Timer tick, asking Buildbucket for the build status
[01:27:29.876] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:29.877] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:87:0) after 1m0s
[01:28:29.992] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:87:0)
[01:28:29.992] Timer tick, asking Buildbucket for the build status
[01:28:30.207] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:30.207] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:88:0) after 1m0s
[01:29:30.221] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:88:0)
[01:29:30.221] Timer tick, asking Buildbucket for the build status
[01:29:30.673] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:30.673] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:89:0) after 1m0s
[01:30:30.713] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:89:0)
[01:30:30.713] Timer tick, asking Buildbucket for the build status
[01:30:30.925] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:30.925] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:90:0) after 1m0s
[01:31:31.070] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:90:0)
[01:31:31.070] Timer tick, asking Buildbucket for the build status
[01:31:31.633] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:31.633] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:91:0) after 1m0s
[01:32:31.672] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:91:0)
[01:32:31.672] Timer tick, asking Buildbucket for the build status
[01:32:32.547] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:32.547] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:92:0) after 1m0s
[01:33:32.611] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:92:0)
[01:33:32.611] Timer tick, asking Buildbucket for the build status
[01:33:33.489] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:33.489] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:93:0) after 1m0s
[01:34:33.515] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:93:0)
[01:34:33.515] Timer tick, asking Buildbucket for the build status
[01:34:34.209] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:34.209] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:94:0) after 1m0s
[01:35:34.245] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:94:0)
[01:35:34.245] Timer tick, asking Buildbucket for the build status
[01:35:34.664] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:34.664] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:95:0) after 1m0s
[01:36:34.689] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:95:0)
[01:36:34.689] Timer tick, asking Buildbucket for the build status
[01:36:36.333] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:36.333] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:96:0) after 1m0s
[01:37:36.470] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:96:0)
[01:37:36.470] Timer tick, asking Buildbucket for the build status
[01:37:37.434] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:37.434] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:97:0) after 1m0s
[01:38:37.504] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:97:0)
[01:38:37.504] Timer tick, asking Buildbucket for the build status
[01:38:38.626] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:38.626] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:98:0) after 1m0s
[01:39:38.870] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:98:0)
[01:39:38.870] Timer tick, asking Buildbucket for the build status
[01:39:39.141] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:39.141] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:99:0) after 1m0s
[01:40:39.252] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:99:0)
[01:40:39.252] Timer tick, asking Buildbucket for the build status
[01:40:39.473] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:39.473] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:100:0) after 1m0s
[01:41:39.545] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:100:0)
[01:41:39.545] Timer tick, asking Buildbucket for the build status
[01:41:39.788] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:39.788] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:101:0) after 1m0s
[01:42:39.860] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:101:0)
[01:42:39.860] Timer tick, asking Buildbucket for the build status
[01:42:40.012] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:40.012] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:102:0) after 1m0s
[01:43:40.009] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:102:0)
[01:43:40.009] Timer tick, asking Buildbucket for the build status
[01:43:40.179] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:40.179] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:103:0) after 1m0s
[01:44:40.265] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:103:0)
[01:44:40.265] Timer tick, asking Buildbucket for the build status
[01:44:41.005] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:41.005] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:104:0) after 1m0s
[01:45:41.159] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:104:0)
[01:45:41.159] Timer tick, asking Buildbucket for the build status
[01:45:41.596] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:41.596] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:105:0) after 1m0s
[01:46:41.694] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:105:0)
[01:46:41.694] Timer tick, asking Buildbucket for the build status
[01:46:41.962] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:41.962] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:106:0) after 1m0s
[01:47:42.062] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:106:0)
[01:47:42.062] Timer tick, asking Buildbucket for the build status
[01:47:42.332] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:42.332] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:107:0) after 1m0s
[01:48:42.411] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:107:0)
[01:48:42.411] Timer tick, asking Buildbucket for the build status
[01:48:42.641] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:42.641] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:108:0) after 1m0s
[01:49:42.693] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:108:0)
[01:49:42.693] Timer tick, asking Buildbucket for the build status
[01:49:42.928] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:42.928] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:109:0) after 1m0s
[01:50:42.956] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:109:0)
[01:50:42.956] Timer tick, asking Buildbucket for the build status
[01:50:43.345] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:43.345] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:110:0) after 1m0s
[01:51:43.383] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:110:0)
[01:51:43.383] Timer tick, asking Buildbucket for the build status
[01:51:44.338] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:44.338] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:111:0) after 1m0s
[01:52:44.378] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:111:0)
[01:52:44.378] Timer tick, asking Buildbucket for the build status
[01:52:45.255] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:45.255] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:112:0) after 1m0s
[01:53:45.300] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:112:0)
[01:53:45.300] Timer tick, asking Buildbucket for the build status
[01:53:46.050] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:46.050] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:113:0) after 1m0s
[01:54:46.203] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:113:0)
[01:54:46.203] Timer tick, asking Buildbucket for the build status
[01:54:46.403] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:46.403] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:114:0) after 1m0s
[01:55:46.487] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:114:0)
[01:55:46.487] Timer tick, asking Buildbucket for the build status
[01:55:46.866] Build 8897675794059423936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:46.866] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9063105856156504592:115:0) after 1m0s
[01:56:39.785] Received PubSub notification, asking Buildbucket for the build status
[01:56:40.635] Build 8897675794059423936: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:56:40.635] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1572918998550469",
"created_by": "project:chromium",
"created_ts": "1572912141703254",
"id": "8897675794059423936",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5a934f16018e774d5ef5264b87ebeb25e9cdddd9\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-101-s45v\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 25557, \"got_angle_revision\": \"5cbb77739e8d4743e426735c38405c95ff49b4c1\", \"got_dawn_revision\": \"6df81ebf1dcf133c6bac7d2c208401b2c072b06d\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"5a934f16018e774d5ef5264b87ebeb25e9cdddd9\", \"got_revision_cp\": \"refs/heads/master@{#712346}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"aaa64b76c0b40c2958a18cfdc623157c8c6e1b7d\", \"got_v8_revision\": \"1776a0ea76121f8abde77f6fb8d75c0a11e4182d\", \"got_v8_revision_cp\": \"refs/heads/8.0.153@{#1}\", \"got_webrtc_revision\": \"ca585bb45729beacc3280fb5008ddf3dc00f1884\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29684}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5a934f16018e774d5ef5264b87ebeb25e9cdddd9\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2e9fdac7759932c89734e16e81a06fc7290a8f21b8b502c8ac5f4bb6f29f7fe5_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-xenial-us-central1-b-8-101-s45v\"], \"image\": [\"chrome-xenial-19102400-d35fedf5a0d\"], \"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\": [\"4621-f8a5b1c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1572912216587052",
"status": "COMPLETED",
"status_changed_ts": "1572918998997210",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/25557",
"builder:Deterministic Linux",
"buildset:commit/git/5a934f16018e774d5ef5264b87ebeb25e9cdddd9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5a934f16018e774d5ef5264b87ebeb25e9cdddd9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9063105856156504592",
"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/8897675794059423936/+/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:4851b0a4816b2b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1572918999038998",
"url": "https://ci.chromium.org/b/8897675794059423936",
"utcnow_ts": "1572919000605734"
}
}
[01:56:40.635] Invocation finished in 1h54m20.315156004s with status SUCCEEDED