[08:50:56.434] New invocation is queued and will start shortly
[08:50:57.720] Starting the invocation (attempt 1)
[08:50:57.754] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:50:57.755] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:50:57.755] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9050298427193475440",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"9583c724a689fbf22ae53120ce5fa522559f740f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9050298427193475440",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/9583c724a689fbf22ae53120ce5fa522559f740f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9583c724a689fbf22ae53120ce5fa522559f740f",
"gitiles_ref:refs/heads/master"
]
}
[08:50:58.361] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1585126257838175",
"id": "8884868365019925072",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9583c724a689fbf22ae53120ce5fa522559f740f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1585126258233757",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/170159",
"builder:Linux Builder (dbg)",
"buildset:commit/git/9583c724a689fbf22ae53120ce5fa522559f740f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9583c724a689fbf22ae53120ce5fa522559f740f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050298427193475440",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8884868365019925072/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1585126258233879",
"url": "https://ci.chromium.org/b/8884868365019925072",
"utcnow_ts": "1585126258353927"
}
}
[08:50:58.361] Task URL: https://ci.chromium.org/b/8884868365019925072
[08:50:58.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:2:0) after 1m0s
[08:51:58.377] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:2:0)
[08:51:58.377] Timer tick, asking Buildbucket for the build status
[08:51:58.849] Build 8884868365019925072: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:51:58.849] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:3:0) after 1m0s
[08:52:58.865] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:3:0)
[08:52:58.865] Timer tick, asking Buildbucket for the build status
[08:52:58.985] Build 8884868365019925072: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:52:58.985] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:4:0) after 1m0s
[08:53:59.050] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:4:0)
[08:53:59.050] Timer tick, asking Buildbucket for the build status
[08:53:59.223] Build 8884868365019925072: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:53:59.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:5:0) after 1m0s
[08:54:59.259] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:5:0)
[08:54:59.259] Timer tick, asking Buildbucket for the build status
[08:54:59.412] Build 8884868365019925072: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:54:59.412] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:6:0) after 1m0s
[08:55:59.394] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:6:0)
[08:55:59.394] Timer tick, asking Buildbucket for the build status
[08:55:59.501] Build 8884868365019925072: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:55:59.501] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:7:0) after 1m0s
[08:56:02.872] Received PubSub notification, asking Buildbucket for the build status
[08:56:02.962] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:59.553] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:7:0)
[08:56:59.553] Timer tick, asking Buildbucket for the build status
[08:56:59.710] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:59.710] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:9:0) after 1m0s
[08:57:59.682] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:9:0)
[08:57:59.682] Timer tick, asking Buildbucket for the build status
[08:57:59.771] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:59.771] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:10:0) after 1m0s
[08:58:59.801] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:10:0)
[08:58:59.801] Timer tick, asking Buildbucket for the build status
[08:58:59.937] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:59.937] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:11:0) after 1m0s
[08:59:59.960] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:11:0)
[08:59:59.960] Timer tick, asking Buildbucket for the build status
[09:00:00.135] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:00.135] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:12:0) after 1m0s
[09:01:00.228] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:12:0)
[09:01:00.228] Timer tick, asking Buildbucket for the build status
[09:01:00.363] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:00.363] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:13:0) after 1m0s
[09:02:00.391] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:13:0)
[09:02:00.391] Timer tick, asking Buildbucket for the build status
[09:02:00.547] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:00.547] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:14:0) after 1m0s
[09:03:00.629] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:14:0)
[09:03:00.629] Timer tick, asking Buildbucket for the build status
[09:03:00.953] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:00.953] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:15:0) after 1m0s
[09:04:00.976] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:15:0)
[09:04:00.976] Timer tick, asking Buildbucket for the build status
[09:04:01.135] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:01.135] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:16:0) after 1m0s
[09:05:01.155] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:16:0)
[09:05:01.155] Timer tick, asking Buildbucket for the build status
[09:05:01.286] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:01.286] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:17:0) after 1m0s
[09:06:01.312] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:17:0)
[09:06:01.312] Timer tick, asking Buildbucket for the build status
[09:06:01.463] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:01.463] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:18:0) after 1m0s
[09:07:01.483] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:18:0)
[09:07:01.483] Timer tick, asking Buildbucket for the build status
[09:07:01.938] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:01.938] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:19:0) after 1m0s
[09:08:02.000] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:19:0)
[09:08:02.000] Timer tick, asking Buildbucket for the build status
[09:08:02.175] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:02.175] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:20:0) after 1m0s
[09:09:02.197] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:20:0)
[09:09:02.197] Timer tick, asking Buildbucket for the build status
[09:09:04.024] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:04.024] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:21:0) after 1m0s
[09:10:04.082] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:21:0)
[09:10:04.082] Timer tick, asking Buildbucket for the build status
[09:10:04.150] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:04.150] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:22:0) after 1m0s
[09:11:04.264] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:22:0)
[09:11:04.264] Timer tick, asking Buildbucket for the build status
[09:11:04.669] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:04.669] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:23:0) after 1m0s
[09:12:04.682] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:23:0)
[09:12:04.682] Timer tick, asking Buildbucket for the build status
[09:12:04.847] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:04.847] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:24:0) after 1m0s
[09:13:04.950] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:24:0)
[09:13:04.950] Timer tick, asking Buildbucket for the build status
[09:13:05.127] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:05.127] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:25:0) after 1m0s
[09:14:05.186] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:25:0)
[09:14:05.186] Timer tick, asking Buildbucket for the build status
[09:14:05.295] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:05.295] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:26:0) after 1m0s
[09:15:05.334] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:26:0)
[09:15:05.334] Timer tick, asking Buildbucket for the build status
[09:15:05.595] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:05.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:27:0) after 1m0s
[09:16:05.650] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:27:0)
[09:16:05.650] Timer tick, asking Buildbucket for the build status
[09:16:05.795] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:05.795] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:28:0) after 1m0s
[09:17:05.778] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:28:0)
[09:17:05.778] Timer tick, asking Buildbucket for the build status
[09:17:06.353] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:06.354] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:29:0) after 1m0s
[09:18:06.372] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:29:0)
[09:18:06.372] Timer tick, asking Buildbucket for the build status
[09:18:06.514] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:06.514] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:30:0) after 1m0s
[09:19:06.548] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:30:0)
[09:19:06.548] Timer tick, asking Buildbucket for the build status
[09:19:06.669] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:06.669] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:31:0) after 1m0s
[09:20:06.712] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:31:0)
[09:20:06.712] Timer tick, asking Buildbucket for the build status
[09:20:08.566] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:08.566] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:32:0) after 1m0s
[09:21:08.832] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:32:0)
[09:21:08.832] Timer tick, asking Buildbucket for the build status
[09:21:08.939] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:08.939] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:33:0) after 1m0s
[09:22:09.105] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:33:0)
[09:22:09.105] Timer tick, asking Buildbucket for the build status
[09:22:09.253] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:09.253] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:34:0) after 1m0s
[09:23:09.339] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:34:0)
[09:23:09.339] Timer tick, asking Buildbucket for the build status
[09:23:09.563] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:09.563] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:35:0) after 1m0s
[09:24:09.650] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:35:0)
[09:24:09.650] Timer tick, asking Buildbucket for the build status
[09:24:09.965] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:09.965] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:36:0) after 1m0s
[09:25:10.052] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:36:0)
[09:25:10.052] Timer tick, asking Buildbucket for the build status
[09:25:10.235] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:10.235] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:37:0) after 1m0s
[09:26:10.261] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:37:0)
[09:26:10.261] Timer tick, asking Buildbucket for the build status
[09:26:10.473] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:10.473] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:38:0) after 1m0s
[09:27:10.495] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:38:0)
[09:27:10.495] Timer tick, asking Buildbucket for the build status
[09:27:10.627] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:10.627] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:39:0) after 1m0s
[09:28:10.742] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:39:0)
[09:28:10.742] Timer tick, asking Buildbucket for the build status
[09:28:10.847] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:10.847] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:40:0) after 1m0s
[09:29:10.982] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:40:0)
[09:29:10.982] Timer tick, asking Buildbucket for the build status
[09:29:11.055] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:11.055] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:41:0) after 1m0s
[09:30:11.199] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:41:0)
[09:30:11.199] Timer tick, asking Buildbucket for the build status
[09:30:11.329] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:11.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:42:0) after 1m0s
[09:31:11.382] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:42:0)
[09:31:11.382] Timer tick, asking Buildbucket for the build status
[09:31:11.704] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:11.704] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:43:0) after 1m0s
[09:32:11.840] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:43:0)
[09:32:11.840] Timer tick, asking Buildbucket for the build status
[09:32:12.112] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:12.112] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:44:0) after 1m0s
[09:33:12.219] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:44:0)
[09:33:12.219] Timer tick, asking Buildbucket for the build status
[09:33:12.404] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:12.404] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:45:0) after 1m0s
[09:34:12.589] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:45:0)
[09:34:12.589] Timer tick, asking Buildbucket for the build status
[09:34:12.699] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:12.699] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:46:0) after 1m0s
[09:35:12.802] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:46:0)
[09:35:12.802] Timer tick, asking Buildbucket for the build status
[09:35:12.929] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:12.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:47:0) after 1m0s
[09:36:12.986] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:47:0)
[09:36:12.986] Timer tick, asking Buildbucket for the build status
[09:36:13.173] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:13.173] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:48:0) after 1m0s
[09:37:13.188] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:48:0)
[09:37:13.188] Timer tick, asking Buildbucket for the build status
[09:37:13.263] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:13.263] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:49:0) after 1m0s
[09:38:13.330] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:49:0)
[09:38:13.330] Timer tick, asking Buildbucket for the build status
[09:38:13.488] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:13.488] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:50:0) after 1m0s
[09:39:13.569] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:50:0)
[09:39:13.569] Timer tick, asking Buildbucket for the build status
[09:39:13.878] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:13.878] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:51:0) after 1m0s
[09:40:13.988] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:51:0)
[09:40:13.988] Timer tick, asking Buildbucket for the build status
[09:40:14.796] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:14.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:52:0) after 1m0s
[09:41:14.843] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:52:0)
[09:41:14.843] Timer tick, asking Buildbucket for the build status
[09:41:14.989] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:14.989] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:53:0) after 1m0s
[09:42:14.996] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:53:0)
[09:42:14.996] Timer tick, asking Buildbucket for the build status
[09:42:15.225] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:15.225] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:54:0) after 1m0s
[09:43:15.210] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:54:0)
[09:43:15.210] Timer tick, asking Buildbucket for the build status
[09:43:15.315] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:15.315] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:55:0) after 1m0s
[09:44:15.334] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:55:0)
[09:44:15.334] Timer tick, asking Buildbucket for the build status
[09:44:15.559] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:15.559] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:56:0) after 1m0s
[09:45:15.569] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:56:0)
[09:45:15.569] Timer tick, asking Buildbucket for the build status
[09:45:15.849] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:15.849] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:57:0) after 1m0s
[09:46:15.938] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:57:0)
[09:46:15.938] Timer tick, asking Buildbucket for the build status
[09:46:16.049] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:16.049] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:58:0) after 1m0s
[09:47:16.096] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:58:0)
[09:47:16.096] Timer tick, asking Buildbucket for the build status
[09:47:16.204] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:16.204] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:59:0) after 1m0s
[09:48:16.283] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:59:0)
[09:48:16.283] Timer tick, asking Buildbucket for the build status
[09:48:16.418] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:16.418] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:60:0) after 1m0s
[09:49:16.444] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:60:0)
[09:49:16.444] Timer tick, asking Buildbucket for the build status
[09:49:16.768] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:16.768] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:61:0) after 1m0s
[09:50:16.793] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:61:0)
[09:50:16.793] Timer tick, asking Buildbucket for the build status
[09:50:16.914] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:16.914] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:62:0) after 1m0s
[09:51:16.943] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:62:0)
[09:51:16.943] Timer tick, asking Buildbucket for the build status
[09:51:17.105] Build 8884868365019925072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:17.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050298427193475440:63:0) after 1m0s
[09:51:20.768] Received PubSub notification, asking Buildbucket for the build status
[09:51:20.869] Build 8884868365019925072: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:51:20.869] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1585129879936565",
"created_by": "project:chromium",
"created_ts": "1585126257838175",
"id": "8884868365019925072",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9583c724a689fbf22ae53120ce5fa522559f740f\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/chromium_tests\": {\"bucketed_triggers\": true}, \"$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-2-kh5a\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 170159, \"got_angle_revision\": \"107e4e989e94e70c594eb91b090d3f4a0108bea5\", \"got_dawn_revision\": \"b867e14cac14aabe1836e414640f48f7b14daef9\", \"got_nacl_revision\": \"ffed96d1528df9f114a30b14d4eb06120c8fb022\", \"got_revision\": \"9583c724a689fbf22ae53120ce5fa522559f740f\", \"got_revision_cp\": \"refs/heads/master@{#753159}\", \"got_swarming_client_revision\": \"cc958279ffd6853e0a1b227a7e957ca334fe56af\", \"got_swiftshader_revision\": \"540bdf92531d0c325d7b5c770ec33e869b56059f\", \"got_v8_revision\": \"3b9e4cb4a5d75f7a8fccd9807443b97a85de4561\", \"got_v8_revision_cp\": \"refs/heads/8.3.72@{#1}\", \"got_webrtc_revision\": \"26d52e1ba0907f6a5a4dd525659ba78c344c4cc1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30873}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9583c724a689fbf22ae53120ce5fa522559f740f\", \"swarm_hashes_refs/heads/master(at){#753159}_without_patch\": {\"accessibility_unittests\": \"5a78ff19c94568b0b6e9981412f22c8435f47317\", \"angle_unittests\": \"64d9a5d0874c915d5a830205a8dce56a05c9d0e2\", \"app_shell_unittests\": \"c3337dc41aee7bfb1ec62593f77eb7ba918c2827\", \"aura_unittests\": \"0e477f4cd1adabdb58dab67557400282e794ba34\", \"base_unittests\": \"8271047bb89ab2670b111a2eb04793ff811d9f23\", \"base_util_unittests\": \"e92e9de05a8ae45701c86545b3ca33141336a08f\", \"blink_common_unittests\": \"e7a97a2adfbf4da4bb0e9de2f20216f54aec6da8\", \"blink_fuzzer_unittests\": \"886eb70bfae30c8787e4dccc39b0c3e23ac53ae4\", \"blink_heap_unittests\": \"da3c520976c02eef7db20d5ad56710c35278d8b5\", \"blink_platform_unittests\": \"fc1e1ee5f8f31335cdcc0b5b5b0daa6efb8bbeef\", \"blink_python_tests\": \"c6aedcc74d414a5d3f36f5ace06a7c95d67208a2\", \"blink_unittests\": \"4a337d9c3287fd7e5e8abcacd655a666ccae6eb4\", \"blink_web_tests\": \"7e88e901ed41391d713379721667537696abb55f\", \"boringssl_crypto_tests\": \"df460a348c6f5816fdf56dfaa88bbf9ef46dcc1f\", \"boringssl_ssl_tests\": \"f9db89d0a330e8699480e74cad00f076576813bd\", \"browser_tests\": \"7df8288984ebed4232f23e6eca2dba7e5f59ede4\", \"cacheinvalidation_unittests\": \"524f1c72e38e0a5e334e1f5b45eec07dc45c9583\", \"capture_unittests\": \"589edc2809e03981a4f1bf511ccbfd8fefdd4c4d\", \"cast_unittests\": \"7ffcac82c0dda5e55f26a68a6bb3aaaea0c662f4\", \"cc_unittests\": \"5ade1efa163f8254655662356967bdc7d9651b67\", \"chrome_app_unittests\": \"75cef785c5a99a88e1045b5f115f84e3553ce0a4\", \"chromedriver_unittests\": \"097c377b6e0e47743ccf14f0261c3a0aa2d69766\", \"components_browsertests\": \"1df102dc1238a4fe76cab0096ca874aaa846e233\", \"components_unittests\": \"4724121641254b39d61e6a6427558c85d31d68bd\", \"compositor_unittests\": \"46dea483a4f7d67fbb1af56dec878a2d28e157ec\", \"content_browsertests\": \"71aa474028b23a9b4aec1440573e01c14619be4c\", \"content_shell_crash_test\": \"ccefba278ecc7281f93057587b558e2a7da1a9c7\", \"content_unittests\": \"873b04f48b61bd356f7aca3d19a4c83cfe152afe\", \"crashpad_tests\": \"16ac6bf16e91292166fa4ffb43d47b00c7ed48c0\", \"cronet_tests\": \"5aced7c9717bb788abc963f536dc1652a99f7c5e\", \"cronet_unittests\": \"1da2549c2cb5851fab3b42d2d90cebd0a42ad0ed\", \"crypto_unittests\": \"1d87cea5bd7a867cdbd7e712deff68f30408d072\", \"dbus_unittests\": \"7236755bf53337b112e5cc3989ee115dfaf0e700\", \"device_unittests\": \"938296d3ca35b0ff3ced509644f226ebd0e3b0cb\", \"display_unittests\": \"9e75a6dd9733e7e9e1808051411e7b9f8e0bb3a5\", \"events_unittests\": \"45eaa0b804b89a87ac40cd8e3543a8b91b72478d\", \"extensions_browsertests\": \"e21dd62d37d088b5c217150d5c3418d507f085ce\", \"extensions_unittests\": \"658d145b401adcccd3d90d67c7af83cfaea388de\", \"filesystem_service_unittests\": \"872263d31ab277565a82a2e5fa61130485933430\", \"flatbuffers_unittests\": \"50e47be8364b1aba201300b5e504c8137bc62062\", \"gcm_unit_tests\": \"a407291ea242016b908312a95da9170f4e56617f\", \"gfx_unittests\": \"d85eb56ccc362364715659940e09fdd0a0fe9d6d\", \"gin_unittests\": \"589adf90529ffef59379fa27487aeebcd5708968\", \"google_apis_unittests\": \"6621d0e6913768688f7e44c747c9cda8be52dca3\", \"gpu_unittests\": \"385ffd244813facb12752c890c7dca7ed0555907\", \"grit_python_unittests\": \"afbbe1df7c81809157ec9d2af582b8cb9256fe66\", \"gwp_asan_unittests\": \"2f0f5b753ebfbb6bdac5e62266cd1aa6139f97c6\", \"headless_browsertests\": \"aa90b50da97fede9db3c250075cac02dc0a2bd8b\", \"headless_unittests\": \"9f92c058cabf9d2ff87c30c5f4cc0528cea735f8\", \"interactive_ui_tests\": \"68af2de1628767b70e1ce4470b12f982b4ee9e86\", \"ipc_tests\": \"94b44bfa376267eccc27ef56f7bf61258906dd46\", \"jingle_unittests\": \"1d92c2b43c27d64f10b6b16cb23100c6c089c074\", \"latency_unittests\": \"d21f7098a40adb09b6bd26142739e5e5208f328e\", \"libjingle_xmpp_unittests\": \"5a7df26b04c9697ac5019e2ac5d5d897d0fbb33a\", \"media_blink_unittests\": \"c4447e1b9916aebd66c21234e0d90d3d9fc22afa\", \"media_service_unittests\": \"4e7d1b83f563e09577206c32950065bc6bfa6657\", \"media_unittests\": \"78261f8d7e429b5c981764d80be5b801e50b6e76\", \"message_center_unittests\": \"48a8b66ad24e93075d16d6e245badde4a894203d\", \"metrics_python_tests\": \"1f0ec8e8121a603de5cb1039259ff132aab270a9\", \"midi_unittests\": \"522a1e4e17409706df52d4f66c5d8412f4919eda\", \"mojo_core_unittests\": \"6db26f3aaf9143de0473df330663600af3483aff\", \"mojo_unittests\": \"71df81e5ba0fe78ae17d4cd92413e3b36696c923\", \"nacl_helper_nonsfi_unittests\": \"e293d5d5e9b6e0a48ecb27f8f67c3481cf5343af\", \"nacl_loader_unittests\": \"720fb55ab0b8d59d1ff31842391a6073d914f631\", \"native_theme_unittests\": \"b6265837403efb1cfd91fa2f4c749f40b44184e8\", \"net_unittests\": \"bfca91c0c01ce437a65da3dc66d6d23e7c46ab35\", \"pdf_unittests\": \"af756ab6b05ac810ef817acddfe966a369928a8b\", \"perfetto_unittests\": \"526b4fd0ed6467919b1b7301488a9c33ff6b037f\", \"ppapi_unittests\": \"9cb95b538df64722f5d5048244fd840a33f0f239\", \"printing_unittests\": \"59b6fb5e58c014b1360e8bcab7d299300fb92b6d\", \"remoting_unittests\": \"3ada2fd3f114a6982de55032755212f5b2f670bf\", \"sandbox_linux_unittests\": \"6b9cb9029d791dc928854e146034dc32bf24a833\", \"service_manager_unittests\": \"e9eb2d2c94b5a4bd3e5fa264f28ae6f165d47c7f\", \"services_unittests\": \"00bd83ed7ac597f0812c1cf84e4377c4375c9b1f\", \"shell_dialogs_unittests\": \"74381e0ecffba37884ad49151c03d0627adb1276\", \"skia_unittests\": \"e98bba6b6f5163feba6187e752a89fe3cec64b93\", \"snapshot_unittests\": \"23e188ad374a2fc85a59c5766a9d08f97bc26bbb\", \"sql_unittests\": \"7737fc73e35ba5ed214956a3f8fb05ed2ac5fa9e\", \"storage_unittests\": \"3121200424336c028431553fc69559d7c76dd714\", \"sync_integration_tests\": \"f2fa5c6f1ebff604691421640fe8bbfdc2eae633\", \"telemetry_gpu_unittests\": \"2488f32fad188d90f532259eeed97b38c8c7327c\", \"telemetry_perf_unittests\": \"51e1f8af5ca0b6953ca5d1995b48757ab7e227dd\", \"telemetry_unittests\": \"91cb7fd54926cb4aaf96afc0cb32d4d2f1355aac\", \"traffic_annotation_auditor_unittests\": \"e53cbe5d6ce870f21cf8f03a64d822fd6793298d\", \"ui_base_unittests\": \"b5b71b6962776a2481bad1aa1357d0ec67146cca\", \"ui_touch_selection_unittests\": \"678285e3bc7a5b263d651f6a16930184bf43d743\", \"unit_tests\": \"1954b8fa0e590f3fbc4d4710a574f4a98ed7930e\", \"url_unittests\": \"fba59725ddb9d877e67e20ff96ee6d657837393b\", \"views_perftests\": \"feba5342f1344076f3fea9e6b8d95694c9ca5bdc\", \"views_unittests\": \"c17b0b7c0d0fb436142831176ef8affce6ee0e82\", \"viz_unittests\": \"91a999da4331568d0446330c93b1a3a90f129677\", \"vr_common_unittests\": \"8bb49b1ec5ac9a29b7f30d0cc7987dd0014a1655\", \"vr_pixeltests\": \"f9dc8f02c87cb217c4a611667893464081a6be22\", \"webdriver_wpt_tests\": \"02c4803e4a56d4cba7705f36c32ba03bb2dba682\", \"weblayer_browsertests\": \"2f8f42e3e39a23c83b282b6b1c32b972810ec50a\", \"wm_unittests\": \"981611bc9ead478d1112e07da479bec894e77424\", \"wtf_unittests\": \"3b028da2cffcca49735ed1e8dadb2333f96d615c\", \"xr_browser_tests\": \"43a35e5160b9a1b8206e83d7c7d1a4c2d4734b8d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"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-2-kh5a\"], \"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\": [\"4895-ce889b2\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1585126561141967",
"status": "COMPLETED",
"status_changed_ts": "1585129880207034",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/170159",
"builder:Linux Builder (dbg)",
"buildset:commit/git/9583c724a689fbf22ae53120ce5fa522559f740f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9583c724a689fbf22ae53120ce5fa522559f740f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050298427193475440",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8884868365019925072/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4b29b4d9ef305210",
"user_agent:luci-scheduler"
],
"updated_ts": "1585129880211311",
"url": "https://ci.chromium.org/b/8884868365019925072",
"utcnow_ts": "1585129880859904"
}
}
[09:51:20.869] Invocation finished in 1h0m24.488216631s with status SUCCEEDED