[07:13:38.151] New invocation is queued and will start shortly
[07:13:39.244] Starting the invocation (attempt 1)
[07:13:39.282] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:13:39.282] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:13:39.282] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9049851564207920000",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4e4dddb114a7fc742e25819b2c49637351a86937\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9049851564207920000",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/4e4dddb114a7fc742e25819b2c49637351a86937",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4e4dddb114a7fc742e25819b2c49637351a86937",
"gitiles_ref:refs/heads/master"
]
}
[07:13:40.360] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1585552419377501",
"id": "8884421502257973328",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4e4dddb114a7fc742e25819b2c49637351a86937\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1585552420131627",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/27352",
"builder:Deterministic Linux",
"buildset:commit/git/4e4dddb114a7fc742e25819b2c49637351a86937",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4e4dddb114a7fc742e25819b2c49637351a86937",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9049851564207920000",
"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/8884421502257973328/+/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": "1585552420131786",
"url": "https://ci.chromium.org/b/8884421502257973328",
"utcnow_ts": "1585552420337701"
}
}
[07:13:40.360] Task URL: https://ci.chromium.org/b/8884421502257973328
[07:13:40.360] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:2:0) after 1m0s
[07:13:44.586] Received PubSub notification, asking Buildbucket for the build status
[07:13:44.655] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:40.535] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:2:0)
[07:14:40.535] Timer tick, asking Buildbucket for the build status
[07:14:40.741] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:40.741] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:4:0) after 1m0s
[07:15:40.955] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:4:0)
[07:15:40.955] Timer tick, asking Buildbucket for the build status
[07:15:41.055] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:41.055] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:5:0) after 1m0s
[07:16:41.365] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:5:0)
[07:16:41.365] Timer tick, asking Buildbucket for the build status
[07:16:41.944] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:41.945] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:6:0) after 1m0s
[07:17:43.152] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:6:0)
[07:17:43.152] Timer tick, asking Buildbucket for the build status
[07:17:43.446] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:43.446] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:7:0) after 1m0s
[07:18:43.502] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:7:0)
[07:18:43.502] Timer tick, asking Buildbucket for the build status
[07:18:43.690] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:43.690] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:8:0) after 1m0s
[07:19:43.728] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:8:0)
[07:19:43.728] Timer tick, asking Buildbucket for the build status
[07:19:43.921] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:43.921] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:9:0) after 1m0s
[07:20:43.967] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:9:0)
[07:20:43.967] Timer tick, asking Buildbucket for the build status
[07:20:44.230] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:44.230] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:10:0) after 1m0s
[07:21:44.322] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:10:0)
[07:21:44.322] Timer tick, asking Buildbucket for the build status
[07:21:44.519] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:44.519] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:11:0) after 1m0s
[07:22:44.610] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:11:0)
[07:22:44.610] Timer tick, asking Buildbucket for the build status
[07:22:44.778] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:44.778] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:12:0) after 1m0s
[07:23:44.831] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:12:0)
[07:23:44.831] Timer tick, asking Buildbucket for the build status
[07:23:45.000] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:45.000] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:13:0) after 1m0s
[07:24:45.129] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:13:0)
[07:24:45.129] Timer tick, asking Buildbucket for the build status
[07:24:45.295] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:45.295] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:14:0) after 1m0s
[07:25:45.370] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:14:0)
[07:25:45.370] Timer tick, asking Buildbucket for the build status
[07:25:45.697] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:45.697] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:15:0) after 1m0s
[07:26:45.738] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:15:0)
[07:26:45.738] Timer tick, asking Buildbucket for the build status
[07:26:45.941] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:45.941] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:16:0) after 1m0s
[07:27:46.065] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:16:0)
[07:27:46.065] Timer tick, asking Buildbucket for the build status
[07:27:46.269] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:46.269] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:17:0) after 1m0s
[07:28:46.355] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:17:0)
[07:28:46.356] Timer tick, asking Buildbucket for the build status
[07:28:46.523] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:46.523] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:18:0) after 1m0s
[07:29:46.555] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:18:0)
[07:29:46.555] Timer tick, asking Buildbucket for the build status
[07:29:46.951] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:46.951] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:19:0) after 1m0s
[07:30:47.041] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:19:0)
[07:30:47.042] Timer tick, asking Buildbucket for the build status
[07:30:47.976] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:47.976] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:20:0) after 1m0s
[07:31:48.001] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:20:0)
[07:31:48.001] Timer tick, asking Buildbucket for the build status
[07:31:48.183] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:48.183] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:21:0) after 1m0s
[07:32:48.187] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:21:0)
[07:32:48.187] Timer tick, asking Buildbucket for the build status
[07:32:48.308] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:48.308] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:22:0) after 1m0s
[07:33:48.375] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:22:0)
[07:33:48.375] Timer tick, asking Buildbucket for the build status
[07:33:48.488] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:48.488] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:23:0) after 1m0s
[07:34:48.527] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:23:0)
[07:34:48.527] Timer tick, asking Buildbucket for the build status
[07:34:48.966] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:48.966] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:24:0) after 1m0s
[07:35:48.995] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:24:0)
[07:35:48.995] Timer tick, asking Buildbucket for the build status
[07:35:49.298] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:49.298] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:25:0) after 1m0s
[07:36:49.331] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:25:0)
[07:36:49.331] Timer tick, asking Buildbucket for the build status
[07:36:49.913] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:49.913] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:26:0) after 1m0s
[07:37:49.933] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:26:0)
[07:37:49.933] Timer tick, asking Buildbucket for the build status
[07:37:50.162] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:50.162] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:27:0) after 1m0s
[07:38:50.199] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:27:0)
[07:38:50.199] Timer tick, asking Buildbucket for the build status
[07:38:50.442] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:50.442] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:28:0) after 1m0s
[07:39:50.570] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:28:0)
[07:39:50.570] Timer tick, asking Buildbucket for the build status
[07:39:50.782] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:50.782] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:29:0) after 1m0s
[07:40:50.801] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:29:0)
[07:40:50.801] Timer tick, asking Buildbucket for the build status
[07:40:50.931] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:50.931] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:30:0) after 1m0s
[07:41:50.970] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:30:0)
[07:41:50.970] Timer tick, asking Buildbucket for the build status
[07:41:51.111] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:51.111] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:31:0) after 1m0s
[07:42:51.358] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:31:0)
[07:42:51.358] Timer tick, asking Buildbucket for the build status
[07:42:51.732] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:51.732] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:32:0) after 1m0s
[07:43:51.809] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:32:0)
[07:43:51.809] Timer tick, asking Buildbucket for the build status
[07:43:54.567] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:54.567] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:33:0) after 1m0s
[07:44:54.643] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:33:0)
[07:44:54.643] Timer tick, asking Buildbucket for the build status
[07:44:54.839] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:54.839] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:34:0) after 1m0s
[07:45:54.991] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:34:0)
[07:45:54.991] Timer tick, asking Buildbucket for the build status
[07:45:55.174] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:55.174] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:35:0) after 1m0s
[07:46:55.275] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:35:0)
[07:46:55.275] Timer tick, asking Buildbucket for the build status
[07:46:55.598] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:55.598] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:36:0) after 1m0s
[07:47:55.850] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:36:0)
[07:47:55.850] Timer tick, asking Buildbucket for the build status
[07:47:56.007] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:56.007] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:37:0) after 1m0s
[07:48:56.239] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:37:0)
[07:48:56.239] Timer tick, asking Buildbucket for the build status
[07:48:56.489] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:56.489] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:38:0) after 1m0s
[07:49:56.555] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:38:0)
[07:49:56.555] Timer tick, asking Buildbucket for the build status
[07:49:57.011] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:57.011] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:39:0) after 1m0s
[07:50:57.134] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:39:0)
[07:50:57.134] Timer tick, asking Buildbucket for the build status
[07:50:58.321] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:58.321] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:40:0) after 1m0s
[07:51:58.409] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:40:0)
[07:51:58.409] Timer tick, asking Buildbucket for the build status
[07:51:58.655] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:58.655] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:41:0) after 1m0s
[07:52:58.890] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:41:0)
[07:52:58.890] Timer tick, asking Buildbucket for the build status
[07:52:59.160] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:59.160] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:42:0) after 1m0s
[07:53:59.190] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:42:0)
[07:53:59.190] Timer tick, asking Buildbucket for the build status
[07:53:59.675] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:59.675] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:43:0) after 1m0s
[07:54:59.861] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:43:0)
[07:54:59.861] Timer tick, asking Buildbucket for the build status
[07:55:00.063] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:00.064] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:44:0) after 1m0s
[07:56:00.110] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:44:0)
[07:56:00.110] Timer tick, asking Buildbucket for the build status
[07:56:00.395] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:00.396] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:45:0) after 1m0s
[07:57:00.423] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:45:0)
[07:57:00.423] Timer tick, asking Buildbucket for the build status
[07:57:00.539] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:00.539] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:46:0) after 1m0s
[07:58:00.581] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:46:0)
[07:58:00.581] Timer tick, asking Buildbucket for the build status
[07:58:01.229] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:01.229] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:47:0) after 1m0s
[07:59:01.263] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:47:0)
[07:59:01.263] Timer tick, asking Buildbucket for the build status
[07:59:01.362] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:01.362] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:48:0) after 1m0s
[08:00:01.441] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:48:0)
[08:00:01.441] Timer tick, asking Buildbucket for the build status
[08:00:01.574] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:01.574] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:49:0) after 1m0s
[08:01:01.612] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:49:0)
[08:01:01.612] Timer tick, asking Buildbucket for the build status
[08:01:01.963] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:01.963] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:50:0) after 1m0s
[08:02:02.008] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:50:0)
[08:02:02.008] Timer tick, asking Buildbucket for the build status
[08:02:02.879] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:02.879] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:51:0) after 1m0s
[08:03:02.911] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:51:0)
[08:03:02.911] Timer tick, asking Buildbucket for the build status
[08:03:03.424] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:03.424] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:52:0) after 1m0s
[08:04:03.431] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:52:0)
[08:04:03.431] Timer tick, asking Buildbucket for the build status
[08:04:04.442] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:04.442] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:53:0) after 1m0s
[08:05:04.474] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:53:0)
[08:05:04.474] Timer tick, asking Buildbucket for the build status
[08:05:04.868] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:04.868] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:54:0) after 1m0s
[08:06:04.971] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:54:0)
[08:06:04.971] Timer tick, asking Buildbucket for the build status
[08:06:05.651] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:05.651] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:55:0) after 1m0s
[08:07:05.740] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:55:0)
[08:07:05.740] Timer tick, asking Buildbucket for the build status
[08:07:06.186] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:06.186] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:56:0) after 1m0s
[08:08:06.285] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:56:0)
[08:08:06.285] Timer tick, asking Buildbucket for the build status
[08:08:06.682] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:06.682] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:57:0) after 1m0s
[08:09:06.951] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:57:0)
[08:09:06.951] Timer tick, asking Buildbucket for the build status
[08:09:07.910] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:07.910] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:58:0) after 1m0s
[08:10:07.941] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:58:0)
[08:10:07.941] Timer tick, asking Buildbucket for the build status
[08:10:08.207] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:08.207] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:59:0) after 1m0s
[08:11:08.296] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:59:0)
[08:11:08.296] Timer tick, asking Buildbucket for the build status
[08:11:08.469] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:08.469] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:60:0) after 1m0s
[08:12:08.609] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:60:0)
[08:12:08.609] Timer tick, asking Buildbucket for the build status
[08:12:08.818] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:08.818] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:61:0) after 1m0s
[08:13:08.867] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:61:0)
[08:13:08.867] Timer tick, asking Buildbucket for the build status
[08:13:09.179] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:09.179] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:62:0) after 1m0s
[08:14:09.313] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:62:0)
[08:14:09.313] Timer tick, asking Buildbucket for the build status
[08:14:09.517] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:09.517] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:63:0) after 1m0s
[08:15:09.608] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:63:0)
[08:15:09.608] Timer tick, asking Buildbucket for the build status
[08:15:09.765] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:09.765] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:64:0) after 1m0s
[08:16:10.145] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:64:0)
[08:16:10.145] Timer tick, asking Buildbucket for the build status
[08:16:10.338] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:10.338] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:65:0) after 1m0s
[08:17:10.481] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:65:0)
[08:17:10.481] Timer tick, asking Buildbucket for the build status
[08:17:11.243] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:11.243] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:66:0) after 1m0s
[08:18:11.366] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:66:0)
[08:18:11.366] Timer tick, asking Buildbucket for the build status
[08:18:12.028] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:12.028] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:67:0) after 1m0s
[08:19:12.155] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:67:0)
[08:19:12.155] Timer tick, asking Buildbucket for the build status
[08:19:12.295] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:12.295] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:68:0) after 1m0s
[08:20:12.411] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:68:0)
[08:20:12.411] Timer tick, asking Buildbucket for the build status
[08:20:12.893] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:12.893] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:69:0) after 1m0s
[08:21:13.024] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:69:0)
[08:21:13.024] Timer tick, asking Buildbucket for the build status
[08:21:15.312] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:15.312] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:70:0) after 1m0s
[08:22:15.333] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:70:0)
[08:22:15.333] Timer tick, asking Buildbucket for the build status
[08:22:16.377] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:16.377] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:71:0) after 1m0s
[08:23:16.463] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:71:0)
[08:23:16.463] Timer tick, asking Buildbucket for the build status
[08:23:17.174] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:17.174] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:72:0) after 1m0s
[08:24:17.220] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:72:0)
[08:24:17.220] Timer tick, asking Buildbucket for the build status
[08:24:17.589] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:17.589] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:73:0) after 1m0s
[08:25:17.596] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:73:0)
[08:25:17.596] Timer tick, asking Buildbucket for the build status
[08:25:18.785] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:18.785] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:74:0) after 1m0s
[08:26:18.842] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:74:0)
[08:26:18.842] Timer tick, asking Buildbucket for the build status
[08:26:19.121] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:19.121] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:75:0) after 1m0s
[08:27:19.232] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:75:0)
[08:27:19.232] Timer tick, asking Buildbucket for the build status
[08:27:20.917] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:20.917] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:76:0) after 1m0s
[08:28:20.956] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:76:0)
[08:28:20.956] Timer tick, asking Buildbucket for the build status
[08:28:21.515] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:21.515] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:77:0) after 1m0s
[08:29:21.589] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:77:0)
[08:29:21.589] Timer tick, asking Buildbucket for the build status
[08:29:21.822] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:21.822] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:78:0) after 1m0s
[08:30:21.869] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:78:0)
[08:30:21.869] Timer tick, asking Buildbucket for the build status
[08:30:22.122] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:22.122] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:79:0) after 1m0s
[08:31:22.199] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:79:0)
[08:31:22.199] Timer tick, asking Buildbucket for the build status
[08:31:22.889] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:22.889] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:80:0) after 1m0s
[08:32:22.958] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:80:0)
[08:32:22.958] Timer tick, asking Buildbucket for the build status
[08:32:23.197] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:23.197] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:81:0) after 1m0s
[08:33:23.246] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:81:0)
[08:33:23.246] Timer tick, asking Buildbucket for the build status
[08:33:24.211] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:24.212] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:82:0) after 1m0s
[08:34:24.288] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:82:0)
[08:34:24.288] Timer tick, asking Buildbucket for the build status
[08:34:24.577] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:24.577] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:83:0) after 1m0s
[08:35:24.661] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:83:0)
[08:35:24.661] Timer tick, asking Buildbucket for the build status
[08:35:24.803] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:24.803] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:84:0) after 1m0s
[08:36:24.872] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:84:0)
[08:36:24.872] Timer tick, asking Buildbucket for the build status
[08:36:25.066] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:25.066] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:85:0) after 1m0s
[08:37:25.094] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:85:0)
[08:37:25.094] Timer tick, asking Buildbucket for the build status
[08:37:25.278] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:25.278] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:86:0) after 1m0s
[08:38:25.298] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:86:0)
[08:38:25.298] Timer tick, asking Buildbucket for the build status
[08:38:26.021] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:26.021] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:87:0) after 1m0s
[08:39:26.151] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:87:0)
[08:39:26.151] Timer tick, asking Buildbucket for the build status
[08:39:26.490] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:26.490] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:88:0) after 1m0s
[08:40:26.580] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:88:0)
[08:40:26.581] Timer tick, asking Buildbucket for the build status
[08:40:26.746] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:26.746] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:89:0) after 1m0s
[08:41:26.841] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:89:0)
[08:41:26.841] Timer tick, asking Buildbucket for the build status
[08:41:27.752] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:27.752] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:90:0) after 1m0s
[08:42:27.799] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:90:0)
[08:42:27.799] Timer tick, asking Buildbucket for the build status
[08:42:27.982] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:27.982] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:91:0) after 1m0s
[08:43:28.106] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:91:0)
[08:43:28.106] Timer tick, asking Buildbucket for the build status
[08:43:28.302] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:28.302] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:92:0) after 1m0s
[08:44:28.384] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:92:0)
[08:44:28.384] Timer tick, asking Buildbucket for the build status
[08:44:28.949] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:28.949] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:93:0) after 1m0s
[08:45:29.044] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:93:0)
[08:45:29.044] Timer tick, asking Buildbucket for the build status
[08:45:29.186] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:29.186] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:94:0) after 1m0s
[08:46:29.224] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:94:0)
[08:46:29.224] Timer tick, asking Buildbucket for the build status
[08:46:29.398] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:29.398] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:95:0) after 1m0s
[08:47:29.539] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:95:0)
[08:47:29.539] Timer tick, asking Buildbucket for the build status
[08:47:29.720] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:29.720] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:96:0) after 1m0s
[08:48:29.752] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:96:0)
[08:48:29.752] Timer tick, asking Buildbucket for the build status
[08:48:30.815] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:30.815] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:97:0) after 1m0s
[08:49:30.988] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:97:0)
[08:49:30.988] Timer tick, asking Buildbucket for the build status
[08:49:31.144] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:31.144] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:98:0) after 1m0s
[08:50:31.234] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:98:0)
[08:50:31.234] Timer tick, asking Buildbucket for the build status
[08:50:31.437] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:31.437] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:99:0) after 1m0s
[08:51:31.521] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:99:0)
[08:51:31.521] Timer tick, asking Buildbucket for the build status
[08:51:31.818] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:31.818] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:100:0) after 1m0s
[08:52:31.921] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:100:0)
[08:52:31.921] Timer tick, asking Buildbucket for the build status
[08:52:32.097] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:32.097] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:101:0) after 1m0s
[08:53:32.111] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:101:0)
[08:53:32.111] Timer tick, asking Buildbucket for the build status
[08:53:32.712] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:32.712] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:102:0) after 1m0s
[08:54:32.841] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:102:0)
[08:54:32.841] Timer tick, asking Buildbucket for the build status
[08:54:33.453] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:33.453] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:103:0) after 1m0s
[08:55:33.820] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:103:0)
[08:55:33.820] Timer tick, asking Buildbucket for the build status
[08:55:34.031] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:34.031] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:104:0) after 1m0s
[08:56:34.067] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:104:0)
[08:56:34.067] Timer tick, asking Buildbucket for the build status
[08:56:34.326] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:34.326] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:105:0) after 1m0s
[08:57:34.473] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:105:0)
[08:57:34.473] Timer tick, asking Buildbucket for the build status
[08:57:34.602] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:34.602] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:106:0) after 1m0s
[08:58:34.647] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:106:0)
[08:58:34.647] Timer tick, asking Buildbucket for the build status
[08:58:35.283] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:35.283] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:107:0) after 1m0s
[08:59:35.381] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:107:0)
[08:59:35.381] Timer tick, asking Buildbucket for the build status
[08:59:35.690] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:35.690] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:108:0) after 1m0s
[09:00:35.723] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:108:0)
[09:00:35.723] Timer tick, asking Buildbucket for the build status
[09:00:36.415] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:36.415] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:109:0) after 1m0s
[09:01:36.555] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:109:0)
[09:01:36.555] Timer tick, asking Buildbucket for the build status
[09:01:36.724] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:36.724] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:110:0) after 1m0s
[09:02:36.785] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:110:0)
[09:02:36.785] Timer tick, asking Buildbucket for the build status
[09:02:37.567] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:37.567] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:111:0) after 1m0s
[09:03:37.689] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:111:0)
[09:03:37.689] Timer tick, asking Buildbucket for the build status
[09:03:37.869] Build 8884421502257973328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:37.869] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9049851564207920000:112:0) after 1m0s
[09:04:09.242] Received PubSub notification, asking Buildbucket for the build status
[09:04:09.300] Build 8884421502257973328: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:04:09.300] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1585559047547400",
"created_by": "project:chromium",
"created_ts": "1585552419377501",
"id": "8884421502257973328",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4e4dddb114a7fc742e25819b2c49637351a86937\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-38-vthn\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 27352, \"got_angle_revision\": \"1b2dd6f92a6ba4ac4738ae796692e4844bfd28c7\", \"got_dawn_revision\": \"81431f5034b4ce3a0cdc339709bd8ca8856fe427\", \"got_nacl_revision\": \"ebf11aaad97fde7f91b1c72e0dddaf1653d41f77\", \"got_revision\": \"4e4dddb114a7fc742e25819b2c49637351a86937\", \"got_revision_cp\": \"refs/heads/master@{#754415}\", \"got_swarming_client_revision\": \"cc958279ffd6853e0a1b227a7e957ca334fe56af\", \"got_swiftshader_revision\": \"1c29477aa06ea733994d1d11d6bf63ba27ac8359\", \"got_v8_revision\": \"5269c3133de0093c180c57cc51dac04406293e24\", \"got_v8_revision_cp\": \"refs/heads/8.3.102@{#1}\", \"got_webrtc_revision\": \"d19513f3ffbb939fd56b5377b678bb31d3154e14\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30881}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4e4dddb114a7fc742e25819b2c49637351a86937\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-38-vthn\"], \"image\": [\"chrome-xenial-20032200-f0f7a76907a\"], \"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\": [\"4903-75a8930\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1585552423783517",
"status": "COMPLETED",
"status_changed_ts": "1585559048431188",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/27352",
"builder:Deterministic Linux",
"buildset:commit/git/4e4dddb114a7fc742e25819b2c49637351a86937",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4e4dddb114a7fc742e25819b2c49637351a86937",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9049851564207920000",
"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/8884421502257973328/+/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:4b431b774c0f3b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1585559048452077",
"url": "https://ci.chromium.org/b/8884421502257973328",
"utcnow_ts": "1585559049292315"
}
}
[09:04:09.300] Invocation finished in 1h50m31.166541733s with status SUCCEEDED