[23:51:19.774] New invocation is queued and will start shortly
[23:51:21.145] Starting the invocation (attempt 1)
[23:51:21.183] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:51:21.183] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:51:21.183] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9057580133859837776",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ef9730926f3677d17a919e1f4963d204603f0f07\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9057580133859837776",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/ef9730926f3677d17a919e1f4963d204603f0f07",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ef9730926f3677d17a919e1f4963d204603f0f07",
"gitiles_ref:refs/heads/master"
]
}
[23:51:23.422] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1578181882682117",
"id": "8892150070143072432",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ef9730926f3677d17a919e1f4963d204603f0f07\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1578181883295032",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26345",
"builder:Deterministic Linux",
"buildset:commit/git/ef9730926f3677d17a919e1f4963d204603f0f07",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ef9730926f3677d17a919e1f4963d204603f0f07",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9057580133859837776",
"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/8892150070143072432/+/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": "1578181883295149",
"url": "https://ci.chromium.org/b/8892150070143072432",
"utcnow_ts": "1578181883407182"
}
}
[23:51:23.422] Task URL: https://ci.chromium.org/b/8892150070143072432
[23:51:23.422] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:2:0) after 1m0s
[23:52:15.022] Received PubSub notification, asking Buildbucket for the build status
[23:52:15.178] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:23.439] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:2:0)
[23:52:23.439] Timer tick, asking Buildbucket for the build status
[23:52:24.415] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:24.415] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:4:0) after 1m0s
[23:53:24.490] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:4:0)
[23:53:24.490] Timer tick, asking Buildbucket for the build status
[23:53:24.981] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:24.981] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:5:0) after 1m0s
[23:54:25.003] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:5:0)
[23:54:25.003] Timer tick, asking Buildbucket for the build status
[23:54:25.219] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:25.219] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:6:0) after 1m0s
[23:55:25.237] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:6:0)
[23:55:25.237] Timer tick, asking Buildbucket for the build status
[23:55:26.388] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:26.388] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:7:0) after 1m0s
[23:56:26.424] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:7:0)
[23:56:26.424] Timer tick, asking Buildbucket for the build status
[23:56:28.506] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:28.506] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:8:0) after 1m0s
[23:57:28.623] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:8:0)
[23:57:28.623] Timer tick, asking Buildbucket for the build status
[23:57:28.963] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:28.963] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:9:0) after 1m0s
[23:58:29.008] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:9:0)
[23:58:29.008] Timer tick, asking Buildbucket for the build status
[23:58:30.063] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:30.063] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:10:0) after 1m0s
[23:59:30.185] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:10:0)
[23:59:30.185] Timer tick, asking Buildbucket for the build status
[23:59:30.346] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:30.346] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:11:0) after 1m0s
[00:00:30.536] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:11:0)
[00:00:30.536] Timer tick, asking Buildbucket for the build status
[00:00:30.742] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:30.742] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:12:0) after 1m0s
[00:01:30.839] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:12:0)
[00:01:30.839] Timer tick, asking Buildbucket for the build status
[00:01:32.735] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:32.735] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:13:0) after 1m0s
[00:02:32.742] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:13:0)
[00:02:32.742] Timer tick, asking Buildbucket for the build status
[00:02:33.084] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:33.084] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:14:0) after 1m0s
[00:03:33.219] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:14:0)
[00:03:33.219] Timer tick, asking Buildbucket for the build status
[00:03:34.175] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:34.175] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:15:0) after 1m0s
[00:04:34.281] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:15:0)
[00:04:34.281] Timer tick, asking Buildbucket for the build status
[00:04:35.780] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:35.780] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:16:0) after 1m0s
[00:05:35.808] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:16:0)
[00:05:35.808] Timer tick, asking Buildbucket for the build status
[00:05:36.356] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:36.356] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:17:0) after 1m0s
[00:06:36.460] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:17:0)
[00:06:36.460] Timer tick, asking Buildbucket for the build status
[00:06:36.622] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:36.622] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:18:0) after 1m0s
[00:07:36.644] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:18:0)
[00:07:36.644] Timer tick, asking Buildbucket for the build status
[00:07:37.788] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:37.788] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:19:0) after 1m0s
[00:08:37.807] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:19:0)
[00:08:37.807] Timer tick, asking Buildbucket for the build status
[00:08:38.228] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:38.228] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:20:0) after 1m0s
[00:09:38.275] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:20:0)
[00:09:38.275] Timer tick, asking Buildbucket for the build status
[00:09:39.182] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:39.182] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:21:0) after 1m0s
[00:10:39.238] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:21:0)
[00:10:39.238] Timer tick, asking Buildbucket for the build status
[00:10:40.562] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:40.562] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:22:0) after 1m0s
[00:11:40.630] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:22:0)
[00:11:40.630] Timer tick, asking Buildbucket for the build status
[00:11:42.634] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:42.634] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:23:0) after 1m0s
[00:12:42.608] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:23:0)
[00:12:42.608] Timer tick, asking Buildbucket for the build status
[00:12:42.790] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:42.790] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:24:0) after 1m0s
[00:13:42.811] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:24:0)
[00:13:42.811] Timer tick, asking Buildbucket for the build status
[00:13:42.999] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:42.999] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:25:0) after 1m0s
[00:14:43.047] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:25:0)
[00:14:43.047] Timer tick, asking Buildbucket for the build status
[00:14:43.328] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:43.328] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:26:0) after 1m0s
[00:15:43.355] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:26:0)
[00:15:43.355] Timer tick, asking Buildbucket for the build status
[00:15:44.578] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:44.578] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:27:0) after 1m0s
[00:16:44.646] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:27:0)
[00:16:44.646] Timer tick, asking Buildbucket for the build status
[00:16:45.540] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:45.540] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:28:0) after 1m0s
[00:17:45.585] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:28:0)
[00:17:45.585] Timer tick, asking Buildbucket for the build status
[00:17:46.683] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:46.683] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:29:0) after 1m0s
[00:18:46.827] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:29:0)
[00:18:46.827] Timer tick, asking Buildbucket for the build status
[00:18:47.199] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:47.199] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:30:0) after 1m0s
[00:19:47.251] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:30:0)
[00:19:47.251] Timer tick, asking Buildbucket for the build status
[00:19:47.491] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:47.491] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:31:0) after 1m0s
[00:20:47.511] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:31:0)
[00:20:47.511] Timer tick, asking Buildbucket for the build status
[00:20:47.660] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:47.660] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:32:0) after 1m0s
[00:21:47.682] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:32:0)
[00:21:47.682] Timer tick, asking Buildbucket for the build status
[00:21:48.022] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:48.022] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:33:0) after 1m0s
[00:22:48.061] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:33:0)
[00:22:48.061] Timer tick, asking Buildbucket for the build status
[00:22:48.955] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:48.955] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:34:0) after 1m0s
[00:23:48.977] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:34:0)
[00:23:48.978] Timer tick, asking Buildbucket for the build status
[00:23:49.180] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:49.180] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:35:0) after 1m0s
[00:24:49.173] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:35:0)
[00:24:49.173] Timer tick, asking Buildbucket for the build status
[00:24:49.842] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:49.842] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:36:0) after 1m0s
[00:25:49.862] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:36:0)
[00:25:49.862] Timer tick, asking Buildbucket for the build status
[00:25:50.005] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:50.005] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:37:0) after 1m0s
[00:26:50.049] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:37:0)
[00:26:50.049] Timer tick, asking Buildbucket for the build status
[00:26:50.376] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:50.376] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:38:0) after 1m0s
[00:27:50.406] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:38:0)
[00:27:50.406] Timer tick, asking Buildbucket for the build status
[00:27:50.554] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:50.554] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:39:0) after 1m0s
[00:28:50.574] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:39:0)
[00:28:50.574] Timer tick, asking Buildbucket for the build status
[00:28:51.055] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:51.055] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:40:0) after 1m0s
[00:29:51.159] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:40:0)
[00:29:51.159] Timer tick, asking Buildbucket for the build status
[00:29:52.296] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:52.296] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:41:0) after 1m0s
[00:30:52.397] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:41:0)
[00:30:52.397] Timer tick, asking Buildbucket for the build status
[00:30:52.793] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:52.793] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:42:0) after 1m0s
[00:31:53.136] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:42:0)
[00:31:53.136] Timer tick, asking Buildbucket for the build status
[00:31:53.512] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:53.512] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:43:0) after 1m0s
[00:32:53.989] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:43:0)
[00:32:53.990] Timer tick, asking Buildbucket for the build status
[00:32:55.208] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:55.208] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:44:0) after 1m0s
[00:33:55.414] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:44:0)
[00:33:55.414] Timer tick, asking Buildbucket for the build status
[00:33:55.608] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:55.608] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:45:0) after 1m0s
[00:34:55.711] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:45:0)
[00:34:55.711] Timer tick, asking Buildbucket for the build status
[00:34:56.638] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:56.638] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:46:0) after 1m0s
[00:35:56.897] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:46:0)
[00:35:56.897] Timer tick, asking Buildbucket for the build status
[00:35:57.069] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:57.069] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:47:0) after 1m0s
[00:36:57.392] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:47:0)
[00:36:57.392] Timer tick, asking Buildbucket for the build status
[00:36:58.571] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:58.571] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:48:0) after 1m0s
[00:37:58.866] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:48:0)
[00:37:58.866] Timer tick, asking Buildbucket for the build status
[00:37:59.013] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:59.013] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:49:0) after 1m0s
[00:38:59.064] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:49:0)
[00:38:59.064] Timer tick, asking Buildbucket for the build status
[00:38:59.850] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:59.850] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:50:0) after 1m0s
[00:40:00.036] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:50:0)
[00:40:00.036] Timer tick, asking Buildbucket for the build status
[00:40:00.240] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:00.240] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:51:0) after 1m0s
[00:41:00.358] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:51:0)
[00:41:00.358] Timer tick, asking Buildbucket for the build status
[00:41:01.657] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:01.657] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:52:0) after 1m0s
[00:42:01.679] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:52:0)
[00:42:01.679] Timer tick, asking Buildbucket for the build status
[00:42:04.200] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:04.200] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:53:0) after 1m0s
[00:43:04.308] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:53:0)
[00:43:04.308] Timer tick, asking Buildbucket for the build status
[00:43:04.468] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:04.468] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:54:0) after 1m0s
[00:44:04.537] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:54:0)
[00:44:04.537] Timer tick, asking Buildbucket for the build status
[00:44:04.896] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:04.896] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:55:0) after 1m0s
[00:45:05.002] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:55:0)
[00:45:05.002] Timer tick, asking Buildbucket for the build status
[00:45:05.482] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:05.482] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:56:0) after 1m0s
[00:46:05.607] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:56:0)
[00:46:05.607] Timer tick, asking Buildbucket for the build status
[00:46:05.962] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:05.962] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:57:0) after 1m0s
[00:47:05.980] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:57:0)
[00:47:05.980] Timer tick, asking Buildbucket for the build status
[00:47:06.391] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:06.391] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:58:0) after 1m0s
[00:48:06.415] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:58:0)
[00:48:06.415] Timer tick, asking Buildbucket for the build status
[00:48:06.699] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:06.699] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:59:0) after 1m0s
[00:49:06.778] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:59:0)
[00:49:06.778] Timer tick, asking Buildbucket for the build status
[00:49:07.744] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:07.744] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:60:0) after 1m0s
[00:50:07.789] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:60:0)
[00:50:07.789] Timer tick, asking Buildbucket for the build status
[00:50:07.925] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:07.925] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:61:0) after 1m0s
[00:51:08.045] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:61:0)
[00:51:08.045] Timer tick, asking Buildbucket for the build status
[00:51:08.504] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:08.504] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:62:0) after 1m0s
[00:52:08.527] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:62:0)
[00:52:08.527] Timer tick, asking Buildbucket for the build status
[00:52:08.697] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:08.697] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:63:0) after 1m0s
[00:53:08.728] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:63:0)
[00:53:08.728] Timer tick, asking Buildbucket for the build status
[00:53:09.172] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:09.172] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:64:0) after 1m0s
[00:54:09.300] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:64:0)
[00:54:09.300] Timer tick, asking Buildbucket for the build status
[00:54:10.362] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:10.362] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:65:0) after 1m0s
[00:55:10.453] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:65:0)
[00:55:10.453] Timer tick, asking Buildbucket for the build status
[00:55:11.071] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:11.071] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:66:0) after 1m0s
[00:56:11.139] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:66:0)
[00:56:11.139] Timer tick, asking Buildbucket for the build status
[00:56:11.311] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:11.311] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:67:0) after 1m0s
[00:57:11.376] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:67:0)
[00:57:11.376] Timer tick, asking Buildbucket for the build status
[00:57:12.253] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:12.253] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:68:0) after 1m0s
[00:58:12.274] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:68:0)
[00:58:12.274] Timer tick, asking Buildbucket for the build status
[00:58:12.533] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:12.533] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:69:0) after 1m0s
[00:59:12.555] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:69:0)
[00:59:12.555] Timer tick, asking Buildbucket for the build status
[00:59:13.203] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:13.203] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:70:0) after 1m0s
[01:00:13.276] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:70:0)
[01:00:13.276] Timer tick, asking Buildbucket for the build status
[01:00:13.435] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:13.435] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:71:0) after 1m0s
[01:01:13.481] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:71:0)
[01:01:13.481] Timer tick, asking Buildbucket for the build status
[01:01:13.859] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:13.859] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:72:0) after 1m0s
[01:02:13.881] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:72:0)
[01:02:13.881] Timer tick, asking Buildbucket for the build status
[01:02:14.036] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:14.036] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:73:0) after 1m0s
[01:03:14.073] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:73:0)
[01:03:14.073] Timer tick, asking Buildbucket for the build status
[01:03:14.894] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:14.894] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:74:0) after 1m0s
[01:04:14.899] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:74:0)
[01:04:14.899] Timer tick, asking Buildbucket for the build status
[01:04:15.208] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:15.208] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:75:0) after 1m0s
[01:05:15.232] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:75:0)
[01:05:15.232] Timer tick, asking Buildbucket for the build status
[01:05:15.441] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:15.441] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:76:0) after 1m0s
[01:06:15.599] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:76:0)
[01:06:15.599] Timer tick, asking Buildbucket for the build status
[01:06:15.765] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:15.765] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:77:0) after 1m0s
[01:07:15.880] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:77:0)
[01:07:15.880] Timer tick, asking Buildbucket for the build status
[01:07:16.625] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:16.625] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:78:0) after 1m0s
[01:08:16.745] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:78:0)
[01:08:16.745] Timer tick, asking Buildbucket for the build status
[01:08:17.455] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:17.455] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:79:0) after 1m0s
[01:09:17.606] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:79:0)
[01:09:17.606] Timer tick, asking Buildbucket for the build status
[01:09:18.304] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:18.304] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:80:0) after 1m0s
[01:10:18.461] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:80:0)
[01:10:18.461] Timer tick, asking Buildbucket for the build status
[01:10:19.721] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:19.721] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:81:0) after 1m0s
[01:11:19.819] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:81:0)
[01:11:19.819] Timer tick, asking Buildbucket for the build status
[01:11:19.963] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:19.963] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:82:0) after 1m0s
[01:12:20.104] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:82:0)
[01:12:20.104] Timer tick, asking Buildbucket for the build status
[01:12:20.836] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:20.836] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:83:0) after 1m0s
[01:13:20.895] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:83:0)
[01:13:20.895] Timer tick, asking Buildbucket for the build status
[01:13:21.153] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:21.153] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:84:0) after 1m0s
[01:14:21.177] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:84:0)
[01:14:21.177] Timer tick, asking Buildbucket for the build status
[01:14:21.656] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:21.656] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:85:0) after 1m0s
[01:15:21.721] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:85:0)
[01:15:21.721] Timer tick, asking Buildbucket for the build status
[01:15:21.897] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:21.897] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:86:0) after 1m0s
[01:16:21.921] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:86:0)
[01:16:21.921] Timer tick, asking Buildbucket for the build status
[01:16:22.579] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:22.579] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:87:0) after 1m0s
[01:17:22.601] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:87:0)
[01:17:22.601] Timer tick, asking Buildbucket for the build status
[01:17:22.788] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:22.788] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:88:0) after 1m0s
[01:18:22.817] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:88:0)
[01:18:22.817] Timer tick, asking Buildbucket for the build status
[01:18:23.684] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:23.684] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:89:0) after 1m0s
[01:19:23.718] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:89:0)
[01:19:23.718] Timer tick, asking Buildbucket for the build status
[01:19:23.959] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:23.959] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:90:0) after 1m0s
[01:20:23.981] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:90:0)
[01:20:23.981] Timer tick, asking Buildbucket for the build status
[01:20:24.339] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:24.339] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:91:0) after 1m0s
[01:21:24.379] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:91:0)
[01:21:24.379] Timer tick, asking Buildbucket for the build status
[01:21:25.193] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:25.193] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:92:0) after 1m0s
[01:22:25.219] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:92:0)
[01:22:25.219] Timer tick, asking Buildbucket for the build status
[01:22:25.347] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:25.347] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:93:0) after 1m0s
[01:23:25.381] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:93:0)
[01:23:25.381] Timer tick, asking Buildbucket for the build status
[01:23:25.583] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:25.583] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:94:0) after 1m0s
[01:24:25.624] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:94:0)
[01:24:25.624] Timer tick, asking Buildbucket for the build status
[01:24:25.776] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:25.776] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:95:0) after 1m0s
[01:25:25.798] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:95:0)
[01:25:25.798] Timer tick, asking Buildbucket for the build status
[01:25:28.759] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:28.759] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:96:0) after 1m0s
[01:26:28.781] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:96:0)
[01:26:28.781] Timer tick, asking Buildbucket for the build status
[01:26:28.921] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:28.921] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:97:0) after 1m0s
[01:27:28.914] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:97:0)
[01:27:28.914] Timer tick, asking Buildbucket for the build status
[01:27:29.133] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:29.133] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:98:0) after 1m0s
[01:28:29.374] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:98:0)
[01:28:29.374] Timer tick, asking Buildbucket for the build status
[01:28:29.981] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:29.982] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:99:0) after 1m0s
[01:29:30.004] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:99:0)
[01:29:30.004] Timer tick, asking Buildbucket for the build status
[01:29:30.202] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:30.203] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:100:0) after 1m0s
[01:30:30.324] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:100:0)
[01:30:30.324] Timer tick, asking Buildbucket for the build status
[01:30:30.527] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:30.527] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:101:0) after 1m0s
[01:31:30.776] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:101:0)
[01:31:30.776] Timer tick, asking Buildbucket for the build status
[01:31:30.967] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:30.967] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:102:0) after 1m0s
[01:32:31.199] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:102:0)
[01:32:31.199] Timer tick, asking Buildbucket for the build status
[01:32:31.697] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:31.697] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:103:0) after 1m0s
[01:33:31.702] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:103:0)
[01:33:31.702] Timer tick, asking Buildbucket for the build status
[01:33:31.888] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:31.888] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:104:0) after 1m0s
[01:34:36.131] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:104:0)
[01:34:36.131] Timer tick, asking Buildbucket for the build status
[01:34:36.299] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:36.300] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:105:0) after 1m0s
[01:35:36.344] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:105:0)
[01:35:36.344] Timer tick, asking Buildbucket for the build status
[01:35:39.421] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:39.421] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:106:0) after 1m0s
[01:36:39.478] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:106:0)
[01:36:39.478] Timer tick, asking Buildbucket for the build status
[01:36:40.313] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:40.313] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:107:0) after 1m0s
[01:37:40.393] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:107:0)
[01:37:40.393] Timer tick, asking Buildbucket for the build status
[01:37:40.992] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:40.992] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:108:0) after 1m0s
[01:38:40.985] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:108:0)
[01:38:40.985] Timer tick, asking Buildbucket for the build status
[01:38:41.132] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:41.132] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:109:0) after 1m0s
[01:39:41.164] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:109:0)
[01:39:41.164] Timer tick, asking Buildbucket for the build status
[01:39:41.627] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:41.627] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:110:0) after 1m0s
[01:40:41.733] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:110:0)
[01:40:41.733] Timer tick, asking Buildbucket for the build status
[01:40:42.004] Build 8892150070143072432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:42.004] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9057580133859837776:111:0) after 1m0s
[01:41:40.549] Received PubSub notification, asking Buildbucket for the build status
[01:41:40.667] Build 8892150070143072432: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:41:40.667] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1578188499694429",
"created_by": "project:chromium",
"created_ts": "1578181882682117",
"id": "8892150070143072432",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ef9730926f3677d17a919e1f4963d204603f0f07\"}}",
"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-136-sqbf\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 26345, \"got_angle_revision\": \"1031d2c65b5ea85a77013fe6fa17ec9d93e5ca22\", \"got_dawn_revision\": \"87d31381588b26edb3da1d75dd0588b2df4dd968\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"ef9730926f3677d17a919e1f4963d204603f0f07\", \"got_revision_cp\": \"refs/heads/master@{#728391}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"10a900e5ffaffdffe2806b1507af43a74acdfe9e\", \"got_v8_revision\": \"2de68515d603bebe3a3048fd3c34db3c48e0e958\", \"got_v8_revision_cp\": \"refs/heads/8.1.89@{#1}\", \"got_webrtc_revision\": \"cfe75c12ee04d17e7898ebc0a8ad1051b6627e53\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30150}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ef9730926f3677d17a919e1f4963d204603f0f07\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3f701152d865ce3ec8feb15f973214ad980aeace5cbda24477548a965269fca6_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-136-sqbf\"], \"image\": [\"chrome-xenial-19121500-b03549ec744\"], \"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\": [\"4733-6bd8c41\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1578181934326349",
"status": "COMPLETED",
"status_changed_ts": "1578188500029907",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26345",
"builder:Deterministic Linux",
"buildset:commit/git/ef9730926f3677d17a919e1f4963d204603f0f07",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ef9730926f3677d17a919e1f4963d204603f0f07",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9057580133859837776",
"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/8892150070143072432/+/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:498bc9feaff72210",
"user_agent:luci-scheduler"
],
"updated_ts": "1578188500043870",
"url": "https://ci.chromium.org/b/8892150070143072432",
"utcnow_ts": "1578188500653493"
}
}
[01:41:40.667] Invocation finished in 1h50m20.913404861s with status SUCCEEDED