[04:58:12.337] New invocation is queued and will start shortly
[04:58:13.517] Starting the invocation (attempt 1)
[04:58:13.552] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:58:13.552] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:58:13.552] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9048048145413288240",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4b2ec3886cb4928544149c39df5bc4437ef62b22\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9048048145413288240",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/4b2ec3886cb4928544149c39df5bc4437ef62b22",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4b2ec3886cb4928544149c39df5bc4437ef62b22",
"gitiles_ref:refs/heads/master"
]
}
[04:58:14.681] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1587272293671637",
"id": "8882618083349652064",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4b2ec3886cb4928544149c39df5bc4437ef62b22\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1587272294408962",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/27594",
"builder:Deterministic Linux",
"buildset:commit/git/4b2ec3886cb4928544149c39df5bc4437ef62b22",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4b2ec3886cb4928544149c39df5bc4437ef62b22",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9048048145413288240",
"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/8882618083349652064/+/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": "1587272294409558",
"url": "https://ci.chromium.org/b/8882618083349652064",
"utcnow_ts": "1587272294666138"
}
}
[04:58:14.681] Task URL: https://ci.chromium.org/b/8882618083349652064
[04:58:14.681] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:2:0) after 1m0s
[04:58:21.608] Received PubSub notification, asking Buildbucket for the build status
[04:58:21.694] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:14.756] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:2:0)
[04:59:14.756] Timer tick, asking Buildbucket for the build status
[04:59:15.042] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:15.042] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:4:0) after 1m0s
[05:00:15.180] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:4:0)
[05:00:15.180] Timer tick, asking Buildbucket for the build status
[05:00:15.734] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:15.734] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:5:0) after 1m0s
[05:01:15.752] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:5:0)
[05:01:15.752] Timer tick, asking Buildbucket for the build status
[05:01:15.959] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:15.959] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:6:0) after 1m0s
[05:02:16.065] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:6:0)
[05:02:16.065] Timer tick, asking Buildbucket for the build status
[05:02:16.297] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:16.297] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:7:0) after 1m0s
[05:03:16.340] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:7:0)
[05:03:16.340] Timer tick, asking Buildbucket for the build status
[05:03:16.461] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:16.461] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:8:0) after 1m0s
[05:04:16.506] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:8:0)
[05:04:16.506] Timer tick, asking Buildbucket for the build status
[05:04:16.710] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:16.710] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:9:0) after 1m0s
[05:05:16.924] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:9:0)
[05:05:16.924] Timer tick, asking Buildbucket for the build status
[05:05:17.061] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:17.061] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:10:0) after 1m0s
[05:06:17.092] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:10:0)
[05:06:17.092] Timer tick, asking Buildbucket for the build status
[05:06:17.484] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:17.484] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:11:0) after 1m0s
[05:07:17.503] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:11:0)
[05:07:17.503] Timer tick, asking Buildbucket for the build status
[05:07:17.594] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:17.595] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:12:0) after 1m0s
[05:08:17.610] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:12:0)
[05:08:17.610] Timer tick, asking Buildbucket for the build status
[05:08:17.897] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:17.897] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:13:0) after 1m0s
[05:09:17.909] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:13:0)
[05:09:17.909] Timer tick, asking Buildbucket for the build status
[05:09:18.064] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:18.064] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:14:0) after 1m0s
[05:10:18.093] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:14:0)
[05:10:18.093] Timer tick, asking Buildbucket for the build status
[05:10:18.274] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:18.274] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:15:0) after 1m0s
[05:11:18.391] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:15:0)
[05:11:18.391] Timer tick, asking Buildbucket for the build status
[05:11:18.576] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:18.576] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:16:0) after 1m0s
[05:12:18.610] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:16:0)
[05:12:18.610] Timer tick, asking Buildbucket for the build status
[05:12:18.718] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:18.718] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:17:0) after 1m0s
[05:13:18.749] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:17:0)
[05:13:18.749] Timer tick, asking Buildbucket for the build status
[05:13:18.933] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:18.933] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:18:0) after 1m0s
[05:14:18.955] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:18:0)
[05:14:18.955] Timer tick, asking Buildbucket for the build status
[05:14:19.275] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:19.276] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:19:0) after 1m0s
[05:15:19.299] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:19:0)
[05:15:19.299] Timer tick, asking Buildbucket for the build status
[05:15:20.091] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:20.091] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:20:0) after 1m0s
[05:16:20.308] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:20:0)
[05:16:20.308] Timer tick, asking Buildbucket for the build status
[05:16:20.449] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:20.449] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:21:0) after 1m0s
[05:17:20.552] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:21:0)
[05:17:20.552] Timer tick, asking Buildbucket for the build status
[05:17:20.783] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:20.784] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:22:0) after 1m0s
[05:18:20.859] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:22:0)
[05:18:20.859] Timer tick, asking Buildbucket for the build status
[05:18:21.030] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:21.030] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:23:0) after 1m0s
[05:19:21.072] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:23:0)
[05:19:21.072] Timer tick, asking Buildbucket for the build status
[05:19:21.562] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:21.562] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:24:0) after 1m0s
[05:20:21.609] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:24:0)
[05:20:21.609] Timer tick, asking Buildbucket for the build status
[05:20:21.900] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:21.900] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:25:0) after 1m0s
[05:21:21.923] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:25:0)
[05:21:21.923] Timer tick, asking Buildbucket for the build status
[05:21:22.234] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:22.234] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:26:0) after 1m0s
[05:22:22.276] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:26:0)
[05:22:22.276] Timer tick, asking Buildbucket for the build status
[05:22:22.494] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:22.494] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:27:0) after 1m0s
[05:23:22.517] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:27:0)
[05:23:22.517] Timer tick, asking Buildbucket for the build status
[05:23:22.794] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:22.794] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:28:0) after 1m0s
[05:24:22.820] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:28:0)
[05:24:22.820] Timer tick, asking Buildbucket for the build status
[05:24:23.046] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:23.046] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:29:0) after 1m0s
[05:25:23.085] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:29:0)
[05:25:23.085] Timer tick, asking Buildbucket for the build status
[05:25:23.211] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:23.211] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:30:0) after 1m0s
[05:26:23.233] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:30:0)
[05:26:23.233] Timer tick, asking Buildbucket for the build status
[05:26:23.336] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:23.336] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:31:0) after 1m0s
[05:27:23.362] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:31:0)
[05:27:23.362] Timer tick, asking Buildbucket for the build status
[05:27:23.614] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:23.614] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:32:0) after 1m0s
[05:28:23.645] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:32:0)
[05:28:23.645] Timer tick, asking Buildbucket for the build status
[05:28:24.106] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:24.106] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:33:0) after 1m0s
[05:29:24.134] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:33:0)
[05:29:24.134] Timer tick, asking Buildbucket for the build status
[05:29:24.420] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:24.420] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:34:0) after 1m0s
[05:30:24.489] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:34:0)
[05:30:24.489] Timer tick, asking Buildbucket for the build status
[05:30:25.643] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:25.643] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:35:0) after 1m0s
[05:31:25.666] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:35:0)
[05:31:25.666] Timer tick, asking Buildbucket for the build status
[05:31:25.913] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:25.913] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:36:0) after 1m0s
[05:32:25.955] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:36:0)
[05:32:25.955] Timer tick, asking Buildbucket for the build status
[05:32:26.157] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:26.157] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:37:0) after 1m0s
[05:33:26.238] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:37:0)
[05:33:26.238] Timer tick, asking Buildbucket for the build status
[05:33:26.501] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:26.501] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:38:0) after 1m0s
[05:34:26.552] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:38:0)
[05:34:26.552] Timer tick, asking Buildbucket for the build status
[05:34:26.784] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:26.784] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:39:0) after 1m0s
[05:35:26.860] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:39:0)
[05:35:26.860] Timer tick, asking Buildbucket for the build status
[05:35:27.124] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:27.124] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:40:0) after 1m0s
[05:36:27.156] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:40:0)
[05:36:27.156] Timer tick, asking Buildbucket for the build status
[05:36:27.425] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:27.425] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:41:0) after 1m0s
[05:37:27.448] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:41:0)
[05:37:27.448] Timer tick, asking Buildbucket for the build status
[05:37:27.635] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:27.635] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:42:0) after 1m0s
[05:38:27.663] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:42:0)
[05:38:27.663] Timer tick, asking Buildbucket for the build status
[05:38:27.811] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:27.811] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:43:0) after 1m0s
[05:39:27.915] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:43:0)
[05:39:27.915] Timer tick, asking Buildbucket for the build status
[05:39:28.396] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:28.396] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:44:0) after 1m0s
[05:40:28.436] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:44:0)
[05:40:28.436] Timer tick, asking Buildbucket for the build status
[05:40:28.611] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:28.611] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:45:0) after 1m0s
[05:41:28.608] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:45:0)
[05:41:28.608] Timer tick, asking Buildbucket for the build status
[05:41:28.934] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:28.934] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:46:0) after 1m0s
[05:42:28.994] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:46:0)
[05:42:28.994] Timer tick, asking Buildbucket for the build status
[05:42:29.137] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:29.137] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:47:0) after 1m0s
[05:43:29.179] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:47:0)
[05:43:29.179] Timer tick, asking Buildbucket for the build status
[05:43:31.148] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:31.148] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:48:0) after 1m0s
[05:44:31.176] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:48:0)
[05:44:31.176] Timer tick, asking Buildbucket for the build status
[05:44:31.302] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:31.302] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:49:0) after 1m0s
[05:45:31.326] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:49:0)
[05:45:31.326] Timer tick, asking Buildbucket for the build status
[05:45:31.482] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:31.483] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:50:0) after 1m0s
[05:46:31.532] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:50:0)
[05:46:31.532] Timer tick, asking Buildbucket for the build status
[05:46:31.696] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:31.696] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:51:0) after 1m0s
[05:47:31.715] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:51:0)
[05:47:31.715] Timer tick, asking Buildbucket for the build status
[05:47:31.854] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:31.854] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:52:0) after 1m0s
[05:48:31.875] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:52:0)
[05:48:31.875] Timer tick, asking Buildbucket for the build status
[05:48:32.125] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:32.125] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:53:0) after 1m0s
[05:49:32.113] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:53:0)
[05:49:32.113] Timer tick, asking Buildbucket for the build status
[05:49:33.123] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:33.123] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:54:0) after 1m0s
[05:50:33.211] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:54:0)
[05:50:33.211] Timer tick, asking Buildbucket for the build status
[05:50:35.136] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:35.136] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:55:0) after 1m0s
[05:51:35.161] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:55:0)
[05:51:35.161] Timer tick, asking Buildbucket for the build status
[05:51:35.380] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:35.380] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:56:0) after 1m0s
[05:52:35.416] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:56:0)
[05:52:35.416] Timer tick, asking Buildbucket for the build status
[05:52:35.610] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:35.610] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:57:0) after 1m0s
[05:53:36.143] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:57:0)
[05:53:36.143] Timer tick, asking Buildbucket for the build status
[05:53:36.950] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:36.950] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:58:0) after 1m0s
[05:54:37.457] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:58:0)
[05:54:37.457] Timer tick, asking Buildbucket for the build status
[05:54:37.643] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:37.643] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:59:0) after 1m0s
[05:55:37.755] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:59:0)
[05:55:37.755] Timer tick, asking Buildbucket for the build status
[05:55:38.089] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:38.089] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:60:0) after 1m0s
[05:56:38.193] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:60:0)
[05:56:38.193] Timer tick, asking Buildbucket for the build status
[05:56:38.549] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:38.549] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:61:0) after 1m0s
[05:57:38.646] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:61:0)
[05:57:38.646] Timer tick, asking Buildbucket for the build status
[05:57:39.027] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:39.027] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:62:0) after 1m0s
[05:58:39.262] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:62:0)
[05:58:39.262] Timer tick, asking Buildbucket for the build status
[05:58:39.493] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:39.493] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:63:0) after 1m0s
[05:59:39.678] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:63:0)
[05:59:39.678] Timer tick, asking Buildbucket for the build status
[05:59:39.824] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:39.824] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:64:0) after 1m0s
[06:00:39.978] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:64:0)
[06:00:39.978] Timer tick, asking Buildbucket for the build status
[06:00:41.090] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:41.090] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:65:0) after 1m0s
[06:01:41.297] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:65:0)
[06:01:41.297] Timer tick, asking Buildbucket for the build status
[06:01:41.680] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:41.680] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:66:0) after 1m0s
[06:02:41.714] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:66:0)
[06:02:41.714] Timer tick, asking Buildbucket for the build status
[06:02:44.814] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:44.815] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:67:0) after 1m0s
[06:03:44.878] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:67:0)
[06:03:44.878] Timer tick, asking Buildbucket for the build status
[06:03:50.318] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:50.318] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:68:0) after 1m0s
[06:04:50.378] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:68:0)
[06:04:50.378] Timer tick, asking Buildbucket for the build status
[06:04:51.131] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:51.131] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:69:0) after 1m0s
[06:05:51.156] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:69:0)
[06:05:51.156] Timer tick, asking Buildbucket for the build status
[06:05:51.720] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:51.720] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:70:0) after 1m0s
[06:06:51.752] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:70:0)
[06:06:51.752] Timer tick, asking Buildbucket for the build status
[06:06:52.605] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:52.605] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:71:0) after 1m0s
[06:07:52.795] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:71:0)
[06:07:52.795] Timer tick, asking Buildbucket for the build status
[06:07:54.245] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:54.245] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:72:0) after 1m0s
[06:08:54.307] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:72:0)
[06:08:54.307] Timer tick, asking Buildbucket for the build status
[06:08:54.700] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:54.700] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:73:0) after 1m0s
[06:09:54.756] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:73:0)
[06:09:54.756] Timer tick, asking Buildbucket for the build status
[06:09:54.925] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:54.925] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:74:0) after 1m0s
[06:10:55.231] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:74:0)
[06:10:55.231] Timer tick, asking Buildbucket for the build status
[06:10:56.773] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:56.773] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:75:0) after 1m0s
[06:11:56.794] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:75:0)
[06:11:56.794] Timer tick, asking Buildbucket for the build status
[06:11:57.111] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:57.111] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:76:0) after 1m0s
[06:12:57.139] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:76:0)
[06:12:57.139] Timer tick, asking Buildbucket for the build status
[06:12:58.619] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:58.619] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:77:0) after 1m0s
[06:13:58.659] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:77:0)
[06:13:58.659] Timer tick, asking Buildbucket for the build status
[06:13:59.255] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:59.255] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:78:0) after 1m0s
[06:14:59.349] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:78:0)
[06:14:59.349] Timer tick, asking Buildbucket for the build status
[06:14:59.876] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:59.876] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:79:0) after 1m0s
[06:16:00.077] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:79:0)
[06:16:00.077] Timer tick, asking Buildbucket for the build status
[06:16:02.029] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:02.029] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:80:0) after 1m0s
[06:17:02.200] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:80:0)
[06:17:02.200] Timer tick, asking Buildbucket for the build status
[06:17:02.473] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:02.473] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:81:0) after 1m0s
[06:18:02.502] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:81:0)
[06:18:02.502] Timer tick, asking Buildbucket for the build status
[06:18:02.917] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:02.917] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:82:0) after 1m0s
[06:19:02.947] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:82:0)
[06:19:02.947] Timer tick, asking Buildbucket for the build status
[06:19:04.192] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:04.192] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:83:0) after 1m0s
[06:20:04.217] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:83:0)
[06:20:04.217] Timer tick, asking Buildbucket for the build status
[06:20:05.123] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:05.123] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:84:0) after 1m0s
[06:21:05.248] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:84:0)
[06:21:05.248] Timer tick, asking Buildbucket for the build status
[06:21:06.114] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:06.114] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:85:0) after 1m0s
[06:22:06.138] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:85:0)
[06:22:06.138] Timer tick, asking Buildbucket for the build status
[06:22:07.008] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:07.008] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:86:0) after 1m0s
[06:23:07.053] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:86:0)
[06:23:07.053] Timer tick, asking Buildbucket for the build status
[06:23:07.257] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:07.257] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:87:0) after 1m0s
[06:24:07.320] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:87:0)
[06:24:07.320] Timer tick, asking Buildbucket for the build status
[06:24:09.183] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:09.183] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:88:0) after 1m0s
[06:25:09.401] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:88:0)
[06:25:09.401] Timer tick, asking Buildbucket for the build status
[06:25:09.717] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:09.717] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:89:0) after 1m0s
[06:26:09.741] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:89:0)
[06:26:09.741] Timer tick, asking Buildbucket for the build status
[06:26:12.935] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:12.935] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:90:0) after 1m0s
[06:27:12.959] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:90:0)
[06:27:12.959] Timer tick, asking Buildbucket for the build status
[06:27:13.301] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:13.301] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:91:0) after 1m0s
[06:28:13.416] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:91:0)
[06:28:13.416] Timer tick, asking Buildbucket for the build status
[06:28:13.723] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:13.723] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:92:0) after 1m0s
[06:29:13.766] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:92:0)
[06:29:13.766] Timer tick, asking Buildbucket for the build status
[06:29:13.970] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:13.970] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:93:0) after 1m0s
[06:30:13.998] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:93:0)
[06:30:13.998] Timer tick, asking Buildbucket for the build status
[06:30:14.469] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:14.469] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:94:0) after 1m0s
[06:31:14.488] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:94:0)
[06:31:14.488] Timer tick, asking Buildbucket for the build status
[06:31:16.152] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:16.152] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:95:0) after 1m0s
[06:32:16.173] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:95:0)
[06:32:16.173] Timer tick, asking Buildbucket for the build status
[06:32:18.999] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:18.999] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:96:0) after 1m0s
[06:33:19.024] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:96:0)
[06:33:19.024] Timer tick, asking Buildbucket for the build status
[06:33:19.179] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:19.179] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:97:0) after 1m0s
[06:34:19.202] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:97:0)
[06:34:19.202] Timer tick, asking Buildbucket for the build status
[06:34:20.109] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:20.110] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:98:0) after 1m0s
[06:35:20.133] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:98:0)
[06:35:20.133] Timer tick, asking Buildbucket for the build status
[06:35:20.305] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:20.305] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:99:0) after 1m0s
[06:36:20.340] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:99:0)
[06:36:20.340] Timer tick, asking Buildbucket for the build status
[06:36:20.549] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:20.549] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:100:0) after 1m0s
[06:37:20.574] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:100:0)
[06:37:20.574] Timer tick, asking Buildbucket for the build status
[06:37:20.754] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:20.754] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:101:0) after 1m0s
[06:38:20.779] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:101:0)
[06:38:20.779] Timer tick, asking Buildbucket for the build status
[06:38:20.935] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:20.935] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:102:0) after 1m0s
[06:39:21.057] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:102:0)
[06:39:21.057] Timer tick, asking Buildbucket for the build status
[06:39:21.331] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:21.331] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:103:0) after 1m0s
[06:40:21.397] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:103:0)
[06:40:21.397] Timer tick, asking Buildbucket for the build status
[06:40:22.985] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:22.985] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:104:0) after 1m0s
[06:41:23.022] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:104:0)
[06:41:23.022] Timer tick, asking Buildbucket for the build status
[06:41:23.505] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:23.505] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:105:0) after 1m0s
[06:42:23.532] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:105:0)
[06:42:23.532] Timer tick, asking Buildbucket for the build status
[06:42:23.662] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:23.662] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:106:0) after 1m0s
[06:43:23.693] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:106:0)
[06:43:23.693] Timer tick, asking Buildbucket for the build status
[06:43:24.586] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:24.586] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:107:0) after 1m0s
[06:44:24.613] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:107:0)
[06:44:24.613] Timer tick, asking Buildbucket for the build status
[06:44:26.694] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:26.694] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:108:0) after 1m0s
[06:45:26.718] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:108:0)
[06:45:26.718] Timer tick, asking Buildbucket for the build status
[06:45:26.951] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:26.951] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:109:0) after 1m0s
[06:46:26.976] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:109:0)
[06:46:26.977] Timer tick, asking Buildbucket for the build status
[06:46:27.104] Build 8882618083349652064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:27.104] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048048145413288240:110:0) after 1m0s
[06:47:01.155] Received PubSub notification, asking Buildbucket for the build status
[06:47:01.290] Build 8882618083349652064: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:47:01.290] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1587278820563806",
"created_by": "project:chromium",
"created_ts": "1587272293671637",
"id": "8882618083349652064",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4b2ec3886cb4928544149c39df5bc4437ef62b22\"}}",
"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-52-17wf\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 27594, \"got_angle_revision\": \"33b58ebb7ea83ef98c19d746aa44a846ac2f88fd\", \"got_dawn_revision\": \"0ff7ed41ecc5ad70b0c16844fdfced62b0b324b8\", \"got_nacl_revision\": \"d304d90ecc17351ce0fdab3e7452052a469c0976\", \"got_revision\": \"4b2ec3886cb4928544149c39df5bc4437ef62b22\", \"got_revision_cp\": \"refs/heads/master@{#760344}\", \"got_swarming_client_revision\": \"160b445a44e0daacf6f3f8570ca2707ec451f374\", \"got_swiftshader_revision\": \"068611f07d28255b3efc56df506eabfb049d9411\", \"got_v8_revision\": \"171cc405301be9f491c97c7bac87b87b4c99d975\", \"got_v8_revision_cp\": \"refs/heads/8.4.133@{#1}\", \"got_webrtc_revision\": \"87eece9421e14660f5e9352118ae7712563565f2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31105}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4b2ec3886cb4928544149c39df5bc4437ef62b22\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1313787165392eb219c57f145b1b9e0fbbb62d544385caa60e27617303515107_v2\", \"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-52-17wf\"], \"image\": [\"chrome-xenial-20041200-f56df5dd7ad\"], \"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\": [\"4985-2a273fe\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1587272300251620",
"status": "COMPLETED",
"status_changed_ts": "1587278820844684",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/27594",
"builder:Deterministic Linux",
"buildset:commit/git/4b2ec3886cb4928544149c39df5bc4437ef62b22",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4b2ec3886cb4928544149c39df5bc4437ef62b22",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9048048145413288240",
"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/8882618083349652064/+/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:4ba99eaa4eb41110",
"user_agent:luci-scheduler"
],
"updated_ts": "1587278820848854",
"url": "https://ci.chromium.org/b/8882618083349652064",
"utcnow_ts": "1587278821272235"
}
}
[06:47:01.290] Invocation finished in 1h48m48.970447767s with status SUCCEEDED