[15:30:50.891] New invocation is queued and will start shortly
[15:30:52.654] Starting the invocation (attempt 1)
[15:30:52.703] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:30:52.704] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:30:52.704] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9059061172885484560",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"01ae63569ab9f29660ce4f345df6ed78adc1d2b9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9059061172885484560",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/01ae63569ab9f29660ce4f345df6ed78adc1d2b9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/01ae63569ab9f29660ce4f345df6ed78adc1d2b9",
"gitiles_ref:refs/heads/master"
]
}
[15:30:54.436] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1576769452911193",
"id": "8893631110103124496",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"01ae63569ab9f29660ce4f345df6ed78adc1d2b9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1576769453979037",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/166316",
"builder:Linux Builder (dbg)",
"buildset:commit/git/01ae63569ab9f29660ce4f345df6ed78adc1d2b9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/01ae63569ab9f29660ce4f345df6ed78adc1d2b9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059061172885484560",
"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/8893631110103124496/+/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": "1576769453979224",
"url": "https://ci.chromium.org/b/8893631110103124496",
"utcnow_ts": "1576769454418433"
}
}
[15:30:54.436] Task URL: https://ci.chromium.org/b/8893631110103124496
[15:30:54.436] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:2:0) after 1m0s
[15:31:54.463] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:2:0)
[15:31:54.463] Timer tick, asking Buildbucket for the build status
[15:31:54.670] Build 8893631110103124496: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:31:54.670] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:3:0) after 1m0s
[15:32:54.740] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:3:0)
[15:32:54.740] Timer tick, asking Buildbucket for the build status
[15:32:55.557] Build 8893631110103124496: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:32:55.557] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:4:0) after 1m0s
[15:33:55.575] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:4:0)
[15:33:55.575] Timer tick, asking Buildbucket for the build status
[15:33:56.303] Build 8893631110103124496: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:33:56.303] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:5:0) after 1m0s
[15:34:56.329] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:5:0)
[15:34:56.329] Timer tick, asking Buildbucket for the build status
[15:34:56.595] Build 8893631110103124496: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:34:56.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:6:0) after 1m0s
[15:35:56.637] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:6:0)
[15:35:56.637] Timer tick, asking Buildbucket for the build status
[15:35:56.936] Build 8893631110103124496: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:35:56.936] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:7:0) after 1m0s
[15:36:19.517] Received PubSub notification, asking Buildbucket for the build status
[15:36:19.633] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:56.954] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:7:0)
[15:36:56.954] Timer tick, asking Buildbucket for the build status
[15:36:57.603] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:57.603] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:9:0) after 1m0s
[15:37:57.659] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:9:0)
[15:37:57.659] Timer tick, asking Buildbucket for the build status
[15:37:58.313] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:58.313] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:10:0) after 1m0s
[15:38:58.325] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:10:0)
[15:38:58.325] Timer tick, asking Buildbucket for the build status
[15:38:58.674] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:58.674] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:11:0) after 1m0s
[15:39:58.765] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:11:0)
[15:39:58.765] Timer tick, asking Buildbucket for the build status
[15:39:59.171] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:59.171] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:12:0) after 1m0s
[15:40:59.321] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:12:0)
[15:40:59.321] Timer tick, asking Buildbucket for the build status
[15:40:59.477] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:59.477] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:13:0) after 1m0s
[15:41:59.453] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:13:0)
[15:41:59.453] Timer tick, asking Buildbucket for the build status
[15:42:02.057] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:02.057] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:14:0) after 1m0s
[15:43:02.087] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:14:0)
[15:43:02.087] Timer tick, asking Buildbucket for the build status
[15:43:02.644] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:02.645] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:15:0) after 1m0s
[15:44:02.674] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:15:0)
[15:44:02.674] Timer tick, asking Buildbucket for the build status
[15:44:03.173] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:03.173] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:16:0) after 1m0s
[15:45:03.293] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:16:0)
[15:45:03.293] Timer tick, asking Buildbucket for the build status
[15:45:04.021] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:04.021] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:17:0) after 1m0s
[15:46:04.085] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:17:0)
[15:46:04.085] Timer tick, asking Buildbucket for the build status
[15:46:04.261] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:04.261] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:18:0) after 1m0s
[15:47:04.353] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:18:0)
[15:47:04.353] Timer tick, asking Buildbucket for the build status
[15:47:04.597] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:04.597] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:19:0) after 1m0s
[15:48:04.856] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:19:0)
[15:48:04.856] Timer tick, asking Buildbucket for the build status
[15:48:05.336] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:05.336] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:20:0) after 1m0s
[15:49:05.353] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:20:0)
[15:49:05.353] Timer tick, asking Buildbucket for the build status
[15:49:05.608] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:05.608] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:21:0) after 1m0s
[15:50:05.689] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:21:0)
[15:50:05.689] Timer tick, asking Buildbucket for the build status
[15:50:06.579] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:06.579] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:22:0) after 1m0s
[15:51:06.653] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:22:0)
[15:51:06.653] Timer tick, asking Buildbucket for the build status
[15:51:07.022] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:07.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:23:0) after 1m0s
[15:52:07.116] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:23:0)
[15:52:07.116] Timer tick, asking Buildbucket for the build status
[15:52:08.275] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:08.275] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:24:0) after 1m0s
[15:53:08.336] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:24:0)
[15:53:08.336] Timer tick, asking Buildbucket for the build status
[15:53:12.482] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:12.482] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:25:0) after 1m0s
[15:54:12.610] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:25:0)
[15:54:12.610] Timer tick, asking Buildbucket for the build status
[15:54:12.925] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:12.925] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:26:0) after 1m0s
[15:55:13.224] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:26:0)
[15:55:13.224] Timer tick, asking Buildbucket for the build status
[15:55:13.716] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:13.716] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:27:0) after 1m0s
[15:56:13.787] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:27:0)
[15:56:13.787] Timer tick, asking Buildbucket for the build status
[15:56:14.317] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:14.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:28:0) after 1m0s
[15:57:14.460] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:28:0)
[15:57:14.460] Timer tick, asking Buildbucket for the build status
[15:57:14.788] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:14.788] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:29:0) after 1m0s
[15:58:14.933] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:29:0)
[15:58:14.933] Timer tick, asking Buildbucket for the build status
[15:58:15.508] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:15.508] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:30:0) after 1m0s
[15:59:15.514] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:30:0)
[15:59:15.514] Timer tick, asking Buildbucket for the build status
[15:59:15.679] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:15.679] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:31:0) after 1m0s
[16:00:15.896] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:31:0)
[16:00:15.896] Timer tick, asking Buildbucket for the build status
[16:00:18.777] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:18.777] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:32:0) after 1m0s
[16:01:18.804] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:32:0)
[16:01:18.804] Timer tick, asking Buildbucket for the build status
[16:01:21.605] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:21.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:33:0) after 1m0s
[16:02:21.602] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:33:0)
[16:02:21.602] Timer tick, asking Buildbucket for the build status
[16:02:21.758] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:21.758] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:34:0) after 1m0s
[16:03:21.863] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:34:0)
[16:03:21.863] Timer tick, asking Buildbucket for the build status
[16:03:22.598] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:22.598] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:35:0) after 1m0s
[16:04:22.808] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:35:0)
[16:04:22.808] Timer tick, asking Buildbucket for the build status
[16:04:24.610] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:24.610] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:36:0) after 1m0s
[16:05:24.740] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:36:0)
[16:05:24.740] Timer tick, asking Buildbucket for the build status
[16:05:25.028] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:25.028] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:37:0) after 1m0s
[16:06:25.050] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:37:0)
[16:06:25.050] Timer tick, asking Buildbucket for the build status
[16:06:25.735] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:25.735] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:38:0) after 1m0s
[16:07:25.728] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:38:0)
[16:07:25.728] Timer tick, asking Buildbucket for the build status
[16:07:26.722] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:26.722] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:39:0) after 1m0s
[16:08:26.779] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:39:0)
[16:08:26.779] Timer tick, asking Buildbucket for the build status
[16:08:26.931] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:26.931] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:40:0) after 1m0s
[16:09:26.961] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:40:0)
[16:09:26.961] Timer tick, asking Buildbucket for the build status
[16:09:27.265] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:27.265] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:41:0) after 1m0s
[16:10:27.303] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:41:0)
[16:10:27.303] Timer tick, asking Buildbucket for the build status
[16:10:28.095] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:28.095] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:42:0) after 1m0s
[16:11:28.195] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:42:0)
[16:11:28.195] Timer tick, asking Buildbucket for the build status
[16:11:28.402] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:28.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:43:0) after 1m0s
[16:12:28.536] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:43:0)
[16:12:28.536] Timer tick, asking Buildbucket for the build status
[16:12:28.731] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:28.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:44:0) after 1m0s
[16:13:28.925] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:44:0)
[16:13:28.925] Timer tick, asking Buildbucket for the build status
[16:13:32.279] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:32.279] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:45:0) after 1m0s
[16:14:32.396] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:45:0)
[16:14:32.396] Timer tick, asking Buildbucket for the build status
[16:14:32.751] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:32.751] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:46:0) after 1m0s
[16:15:32.826] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:46:0)
[16:15:32.826] Timer tick, asking Buildbucket for the build status
[16:15:33.661] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:33.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:47:0) after 1m0s
[16:16:33.716] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:47:0)
[16:16:33.716] Timer tick, asking Buildbucket for the build status
[16:16:34.114] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:34.114] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:48:0) after 1m0s
[16:17:34.165] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:48:0)
[16:17:34.165] Timer tick, asking Buildbucket for the build status
[16:17:35.431] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:35.431] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:49:0) after 1m0s
[16:18:35.428] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:49:0)
[16:18:35.428] Timer tick, asking Buildbucket for the build status
[16:18:35.785] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:35.785] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:50:0) after 1m0s
[16:19:35.815] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:50:0)
[16:19:35.815] Timer tick, asking Buildbucket for the build status
[16:19:36.555] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:36.555] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:51:0) after 1m0s
[16:20:36.596] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:51:0)
[16:20:36.596] Timer tick, asking Buildbucket for the build status
[16:20:37.640] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:37.640] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:52:0) after 1m0s
[16:21:37.760] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:52:0)
[16:21:37.760] Timer tick, asking Buildbucket for the build status
[16:21:38.870] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:38.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:53:0) after 1m0s
[16:22:38.931] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:53:0)
[16:22:38.931] Timer tick, asking Buildbucket for the build status
[16:22:39.235] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:39.235] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:54:0) after 1m0s
[16:23:39.281] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:54:0)
[16:23:39.281] Timer tick, asking Buildbucket for the build status
[16:23:39.729] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:39.729] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:55:0) after 1m0s
[16:24:39.816] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:55:0)
[16:24:39.816] Timer tick, asking Buildbucket for the build status
[16:24:40.769] Build 8893631110103124496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:40.769] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059061172885484560:56:0) after 1m0s
[16:24:42.279] Received PubSub notification, asking Buildbucket for the build status
[16:24:42.388] Build 8893631110103124496: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:24:42.388] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1576772681152907",
"created_by": "project:chromium",
"created_ts": "1576769452911193",
"id": "8893631110103124496",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"01ae63569ab9f29660ce4f345df6ed78adc1d2b9\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-21-icip\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 166316, \"got_angle_revision\": \"f321db9a8ea209392a9c6829603e51fb88825f9d\", \"got_dawn_revision\": \"cf788596f480f194de120c49e5780c7a6dcd12f3\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"01ae63569ab9f29660ce4f345df6ed78adc1d2b9\", \"got_revision_cp\": \"refs/heads/master@{#726382}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"4fd7fccd6db5ebb7a1f9cc7853afc2b6fea16b97\", \"got_v8_revision\": \"121ebd0364042208a9324158650f318310fe1007\", \"got_v8_revision_cp\": \"refs/heads/8.1.55@{#1}\", \"got_webrtc_revision\": \"768c5f438cad7b65a05f8a9fe79d4049329e5475\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30108}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"01ae63569ab9f29660ce4f345df6ed78adc1d2b9\", \"swarm_hashes_refs/heads/master(at){#726382}_without_patch\": {\"accessibility_unittests\": \"423a77730ad14927e5c89277c2c0b5ea63baa152\", \"angle_unittests\": \"cd6affa9811f2301a24bf185911059c398f5fef9\", \"app_shell_unittests\": \"bb28872ebfe26b2735778de340a14c9a6acab617\", \"aura_unittests\": \"aee1b1520968a2bb7e841934af5f0c327ad0c41d\", \"base_unittests\": \"c5b2aba06577b7d481796d428b8b5965da7ca7f5\", \"base_util_unittests\": \"a5bf9ca465a858508cae379cb333a083d084ce61\", \"blink_common_unittests\": \"45caf1adea0db308238387a1ed1805a49b8e42f4\", \"blink_fuzzer_unittests\": \"a371e8b389dec2f582c41d80fea9fb98ed7733f2\", \"blink_heap_unittests\": \"2f8a6263f7965186eb58b866701f35b7b23f229b\", \"blink_platform_unittests\": \"f5fee59dbfdc4cbace114761e78d5323a6b4f0c5\", \"blink_python_tests\": \"21e97b761a0cd764f65aed359636c3f8b44a0197\", \"blink_unittests\": \"6b710543ee3bb52155e78cb231119d55ca6441a9\", \"blink_web_tests\": \"c47b0aa966690dde7763972c7c43d8fb88ca1cd5\", \"boringssl_crypto_tests\": \"c63eff6fdf4d79424bd684b6d67439361532e37a\", \"boringssl_ssl_tests\": \"1b42190b7a482e4c20940dd0a0a2d1f07da21e61\", \"browser_tests\": \"7cccdc87a138d03483e3a042b9b720152b60ac21\", \"cacheinvalidation_unittests\": \"817f8dd056c4b7cd0796356471dae58914321824\", \"capture_unittests\": \"39fd2867b1db640ec59c6f743091fef189d6faad\", \"cast_unittests\": \"a22daf168bebb4244679ccedfdcf4292f9a2f023\", \"cc_unittests\": \"529f83fef143345664775083ad3373d02d195b0a\", \"chrome_app_unittests\": \"a265c08ff300ad8f3f3a66861b1a16cea91c27e3\", \"chromedriver_unittests\": \"61dedc085085a57972d42a05726a25900d9bd0f6\", \"components_browsertests\": \"d8f40305a3e60acaee1e9401bfb01010b982dda8\", \"components_unittests\": \"c80c905c377487e5b8a4c3a45d9edfb6845853a9\", \"compositor_unittests\": \"bb2d4b2e0eb85f1fd36c67d5bcaab08fa47dc3bf\", \"content_browsertests\": \"f18234efc53ab74f5d07117c60ceaf53e203940c\", \"content_shell_crash_test\": \"3bb29f03429a6936b54bf6bb89a21325f5fe7461\", \"content_unittests\": \"76c2d621c303434afdfc9c1359cfffc799038d83\", \"crashpad_tests\": \"6394904028fe1dcbf321d69c3252292548cf00d6\", \"cronet_tests\": \"7e356a8581750a7ac65fc4f7ddba9cbd71851e18\", \"cronet_unittests\": \"72eed97b4b5f918d1e0566413c433cbf17f4bff8\", \"crypto_unittests\": \"8bf4543d8c2eca814919334792cc6a803b89dadc\", \"dbus_unittests\": \"aa10c14dff307a2d4fdc793792657b5e85beda9d\", \"device_unittests\": \"4737937221ff4215a5735f7b256601e754ff44e9\", \"devtools_lint_check\": \"b66cb90d6831f86a0b7c48b7db4a02146a40927d\", \"devtools_type_check\": \"d54e2528bbf0af2e2bbf173ef128650e32c866fa\", \"display_unittests\": \"7a54027e397d231df79557025bb929fb51b1c248\", \"events_unittests\": \"2223318be8ef64955c098a121653f80164a2c857\", \"extensions_browsertests\": \"90887cd3fe15ab64d05064c1668bf08a13a1d551\", \"extensions_unittests\": \"534d56390973d396746f8f17964f340d6ba23ed4\", \"filesystem_service_unittests\": \"2d3335b5171c61ee43ab832d1cee35a823a0cf86\", \"flatbuffers_unittests\": \"034d1c63a8199a680c9bbf29b5866b1c851e28ee\", \"gcm_unit_tests\": \"6060ead6ad1f246ca86f151cfd3b1a24023ab9be\", \"gfx_unittests\": \"17650208b2b7bd761510e58859a9afd8a4b45b3c\", \"gin_unittests\": \"b7ab4f0eb3a81969fa0dca4746a10ff7a2b07421\", \"google_apis_unittests\": \"c0c5a5a481d34f29e2a275d399d1bcd80582403d\", \"gpu_unittests\": \"d39a73e2be19afb4e77235e38710a604fc0aed7b\", \"grit_python_unittests\": \"25dff9ef6327c596609d376409bc1d0e605b6d43\", \"gwp_asan_unittests\": \"b212aa41a345c97e8ec2946a96ae1db6e9e69325\", \"headless_browsertests\": \"6e98894dfeb860badb8a68fc2586094104ddb094\", \"headless_unittests\": \"03e81d64dfdfd35e3ace56f2ea844afc20d8bb92\", \"interactive_ui_tests\": \"74bf71c48a843d03319b9e01bc38e4744e25fbea\", \"ipc_tests\": \"a38a8c58bdcc98521d9f40903955892dcd6ea169\", \"jingle_unittests\": \"66a8e0c8db4db4500b3de5386e951eb8a77f19bf\", \"latency_unittests\": \"c54a60fed853dda821d1757760dd8ada84122f9e\", \"libjingle_xmpp_unittests\": \"01fa2ee61ef98c3ef0a2d6782129aa9377eebbfa\", \"media_blink_unittests\": \"f8209a7c6db2fbc4dfa31fe979958fbd7c2103a4\", \"media_service_unittests\": \"9c2aa4f0fad2825c057a606b4b349e13915b280e\", \"media_unittests\": \"f892e0c9fd11701fee970276940b34cbdfbf9762\", \"message_center_unittests\": \"cbaac85f14cde81bfaf53b4138f04aeb41e456de\", \"metrics_python_tests\": \"dd64898545458c78db3a6ce4ddc723b9dcffb857\", \"midi_unittests\": \"e5a070a220a14b1d8e1134802594c46bbc08e496\", \"mojo_core_unittests\": \"21ccb9bf43dfffd2033f386965ba5efb9baea686\", \"mojo_unittests\": \"eef8267084f6e27ba4aaaa39cc02f2875dd36c53\", \"nacl_helper_nonsfi_unittests\": \"2f67ec06c6469a8fb1f0bc7e8528ed638fe30f1b\", \"nacl_loader_unittests\": \"7f3d85f0f0f69bf60070733d3bf37be87046c503\", \"native_theme_unittests\": \"3b2488deef67d8f6f903816d2924eba65afa4c91\", \"net_unittests\": \"345a33b473107a6a8513746c2ce5b8ffe78bd8aa\", \"pdf_unittests\": \"9a5876b14a54c6e0a1da53fa2aa07eea6876df77\", \"perfetto_unittests\": \"43fd9eb6da080e1f8df7c1756eb5524ac0b3eb4c\", \"ppapi_unittests\": \"4a2559d98476e57cb0a9289fca88892710224e03\", \"printing_unittests\": \"31953362521376a22a8eac2df8c963eb9820686d\", \"remoting_unittests\": \"6dfd3b97b0515b27650a8602975d097c7073130f\", \"sandbox_linux_unittests\": \"730fd807c9ee6d36b992c1cade89c1482a74e0ac\", \"service_manager_unittests\": \"6224ee86c6b5f75ad19326748d2483f8c46f3d33\", \"services_unittests\": \"48faf8039d67bee13615bcb6c697365013b99188\", \"shell_dialogs_unittests\": \"304fdd90c085bf51a46026194169847852490646\", \"skia_unittests\": \"467efc5ea5351a999c0c0c48d58e947aee44d409\", \"snapshot_unittests\": \"9cd85e02c30450c3d76fa58a3e1a1e7026692836\", \"sql_unittests\": \"e23def6c284229e04a8f73c4bb8b3f81cd596baa\", \"storage_unittests\": \"48c8cf43dd3bcad4c916577f70edf42950acff7d\", \"sync_integration_tests\": \"f031137f0c369c7924e999c2a3022583e6eae47f\", \"telemetry_gpu_unittests\": \"e486b90ac0efc1012db6d95e19b99533eca8c4bb\", \"telemetry_perf_unittests\": \"d8cca7ec206211dfe9b70793a8a5e981cf22bda1\", \"telemetry_unittests\": \"68e6d427b217df2f679b2ba3adf206e77a89380c\", \"traffic_annotation_auditor_unittests\": \"a4bccde9a84344ca8e8194831b44beff5bf00d5b\", \"ui_base_unittests\": \"0cf4ef9297b8a274c0b7778d0516889006d1ef7c\", \"ui_touch_selection_unittests\": \"d8174fc6ccce86a15331c25302cf0ecaa758ea5e\", \"unit_tests\": \"eb705778b17b3dd2915d5056ae334364e7b29fdb\", \"url_unittests\": \"0b1650a7ce5bb2e3183de1933ef3d44cf1c6dfb6\", \"views_perftests\": \"ad9b22846843b4000e9988b08ba4d54ea8b6c6ba\", \"views_unittests\": \"1204ba8ac7db8765cae9c7996b16de217b22a0fa\", \"viz_unittests\": \"13bbaca4a23f161b6f3306b6264ea8bccc1fb888\", \"vr_common_unittests\": \"e37cba7d3384688f3db8ede8f65a92220dcc83f4\", \"vr_pixeltests\": \"0c4fe2b5bd082f7c21edf7bbcd59826048a81a04\", \"webdriver_wpt_tests\": \"6e1055e2830f9936deff14b862f531afaefaa3d1\", \"weblayer_browsertests\": \"f4b54bec221c1a678067f4f9d3b1b6b33c69af41\", \"wm_unittests\": \"71db45056428bde1d7584635d79eb9d0356fcedb\", \"wtf_unittests\": \"cc9a55b90e354ccbe786ba9636c454d3e1636566\", \"xr_browser_tests\": \"66eb92f0521a55137f0d77117a5498d41bb13464\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_20aad707bde81044119dd77cf5c9d90dd36ea4d1587e350d19bd0c1a6099dab7_v2\", \"builder_84395cd86c4615c28c38755187d54d1bbe2dcea268d302d74191d04ce3a055d0_v2\", \"builder_957c0f1a1c74c3ada6665996f2ff614223d5da32e2cc2316ff7cc4c9c4beae5c_v2\", \"builder_a27b44a1648dd298adda85735042ac3d0ffdcfd6d22ed3e792b03614ce2ee968_v2\", \"builder_f568157a4ec00fb9568da05a054c670841713183d1f68e80f18d1b79a7a19e1f_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-21-icip\"], \"image\": [\"chrome-xenial-19121500-b03549ec744\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4733-6bd8c41\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1576769778609709",
"status": "COMPLETED",
"status_changed_ts": "1576772681677762",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/166316",
"builder:Linux Builder (dbg)",
"buildset:commit/git/01ae63569ab9f29660ce4f345df6ed78adc1d2b9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/01ae63569ab9f29660ce4f345df6ed78adc1d2b9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059061172885484560",
"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/8893631110103124496/+/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:49379a5427149e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1576772681685803",
"url": "https://ci.chromium.org/b/8893631110103124496",
"utcnow_ts": "1576772682379482"
}
}
[16:24:42.388] Invocation finished in 53m51.514425697s with status SUCCEEDED