[02:32:38.162] New invocation is queued and will start shortly
[02:32:39.256] Starting the invocation (attempt 1)
[02:32:39.307] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:32:39.307] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:32:39.307] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9053221330943057456",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"abcfacbb19e9e1bbb2bd9e678d38c9b2885d5867\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9053221330943057456",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/abcfacbb19e9e1bbb2bd9e678d38c9b2885d5867",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/abcfacbb19e9e1bbb2bd9e678d38c9b2885d5867",
"gitiles_ref:refs/heads/master"
]
}
[02:32:41.705] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1582338759568867",
"id": "8887791268805221728",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"abcfacbb19e9e1bbb2bd9e678d38c9b2885d5867\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1582338761148364",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168877",
"builder:Linux Builder (dbg)",
"buildset:commit/git/abcfacbb19e9e1bbb2bd9e678d38c9b2885d5867",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/abcfacbb19e9e1bbb2bd9e678d38c9b2885d5867",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053221330943057456",
"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/8887791268805221728/+/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": "1582338761148623",
"url": "https://ci.chromium.org/b/8887791268805221728",
"utcnow_ts": "1582338761678556"
}
}
[02:32:41.705] Task URL: https://ci.chromium.org/b/8887791268805221728
[02:32:41.705] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:2:0) after 1m0s
[02:33:41.723] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:2:0)
[02:33:41.723] Timer tick, asking Buildbucket for the build status
[02:33:41.904] Build 8887791268805221728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:33:41.904] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:3:0) after 1m0s
[02:34:41.923] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:3:0)
[02:34:41.923] Timer tick, asking Buildbucket for the build status
[02:34:42.032] Build 8887791268805221728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:34:42.032] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:4:0) after 1m0s
[02:35:42.055] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:4:0)
[02:35:42.055] Timer tick, asking Buildbucket for the build status
[02:35:42.153] Build 8887791268805221728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:35:42.153] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:5:0) after 1m0s
[02:36:42.229] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:5:0)
[02:36:42.229] Timer tick, asking Buildbucket for the build status
[02:36:42.701] Build 8887791268805221728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:36:42.701] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:6:0) after 1m0s
[02:37:07.373] Received PubSub notification, asking Buildbucket for the build status
[02:37:07.640] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:42.815] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:6:0)
[02:37:42.815] Timer tick, asking Buildbucket for the build status
[02:37:42.925] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:42.925] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:8:0) after 1m0s
[02:38:43.107] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:8:0)
[02:38:43.107] Timer tick, asking Buildbucket for the build status
[02:38:43.234] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:43.234] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:9:0) after 1m0s
[02:39:43.306] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:9:0)
[02:39:43.306] Timer tick, asking Buildbucket for the build status
[02:39:43.420] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:43.420] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:10:0) after 1m0s
[02:40:43.458] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:10:0)
[02:40:43.458] Timer tick, asking Buildbucket for the build status
[02:40:43.554] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:43.554] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:11:0) after 1m0s
[02:41:43.680] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:11:0)
[02:41:43.680] Timer tick, asking Buildbucket for the build status
[02:41:44.407] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:44.407] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:12:0) after 1m0s
[02:42:44.632] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:12:0)
[02:42:44.632] Timer tick, asking Buildbucket for the build status
[02:42:45.082] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:45.082] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:13:0) after 1m0s
[02:43:45.133] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:13:0)
[02:43:45.133] Timer tick, asking Buildbucket for the build status
[02:43:45.228] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:45.228] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:14:0) after 1m0s
[02:44:45.329] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:14:0)
[02:44:45.329] Timer tick, asking Buildbucket for the build status
[02:44:45.549] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:45.549] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:15:0) after 1m0s
[02:45:45.568] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:15:0)
[02:45:45.568] Timer tick, asking Buildbucket for the build status
[02:45:45.726] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:45.726] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:16:0) after 1m0s
[02:46:45.704] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:16:0)
[02:46:45.704] Timer tick, asking Buildbucket for the build status
[02:46:45.874] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:45.874] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:17:0) after 1m0s
[02:47:45.875] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:17:0)
[02:47:45.875] Timer tick, asking Buildbucket for the build status
[02:47:45.977] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:45.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:18:0) after 1m0s
[02:48:46.102] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:18:0)
[02:48:46.102] Timer tick, asking Buildbucket for the build status
[02:48:46.247] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:46.247] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:19:0) after 1m0s
[02:49:46.250] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:19:0)
[02:49:46.250] Timer tick, asking Buildbucket for the build status
[02:49:46.488] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:46.488] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:20:0) after 1m0s
[02:50:46.602] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:20:0)
[02:50:46.602] Timer tick, asking Buildbucket for the build status
[02:50:46.733] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:46.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:21:0) after 1m0s
[02:51:46.779] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:21:0)
[02:51:46.779] Timer tick, asking Buildbucket for the build status
[02:51:47.556] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:47.556] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:22:0) after 1m0s
[02:52:47.778] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:22:0)
[02:52:47.778] Timer tick, asking Buildbucket for the build status
[02:52:48.144] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:48.144] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:23:0) after 1m0s
[02:53:48.165] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:23:0)
[02:53:48.165] Timer tick, asking Buildbucket for the build status
[02:53:48.788] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:48.788] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:24:0) after 1m0s
[02:54:48.845] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:24:0)
[02:54:48.845] Timer tick, asking Buildbucket for the build status
[02:54:48.962] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:48.962] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:25:0) after 1m0s
[02:55:49.026] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:25:0)
[02:55:49.026] Timer tick, asking Buildbucket for the build status
[02:55:49.156] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:49.156] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:26:0) after 1m0s
[02:56:49.492] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:26:0)
[02:56:49.492] Timer tick, asking Buildbucket for the build status
[02:56:49.837] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:49.837] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:27:0) after 1m0s
[02:57:49.994] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:27:0)
[02:57:49.994] Timer tick, asking Buildbucket for the build status
[02:57:50.104] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:50.104] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:28:0) after 1m0s
[02:58:50.230] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:28:0)
[02:58:50.230] Timer tick, asking Buildbucket for the build status
[02:58:50.409] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:50.409] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:29:0) after 1m0s
[02:59:50.430] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:29:0)
[02:59:50.430] Timer tick, asking Buildbucket for the build status
[02:59:50.551] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:50.551] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:30:0) after 1m0s
[03:00:50.658] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:30:0)
[03:00:50.658] Timer tick, asking Buildbucket for the build status
[03:00:50.795] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:50.795] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:31:0) after 1m0s
[03:01:50.833] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:31:0)
[03:01:50.833] Timer tick, asking Buildbucket for the build status
[03:01:50.943] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:50.943] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:32:0) after 1m0s
[03:02:50.980] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:32:0)
[03:02:50.980] Timer tick, asking Buildbucket for the build status
[03:02:51.136] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:51.136] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:33:0) after 1m0s
[03:03:51.193] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:33:0)
[03:03:51.193] Timer tick, asking Buildbucket for the build status
[03:03:51.330] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:51.330] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:34:0) after 1m0s
[03:04:51.446] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:34:0)
[03:04:51.446] Timer tick, asking Buildbucket for the build status
[03:04:51.581] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:51.581] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:35:0) after 1m0s
[03:05:51.633] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:35:0)
[03:05:51.633] Timer tick, asking Buildbucket for the build status
[03:05:51.731] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:51.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:36:0) after 1m0s
[03:06:51.753] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:36:0)
[03:06:51.753] Timer tick, asking Buildbucket for the build status
[03:06:51.945] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:51.945] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:37:0) after 1m0s
[03:07:52.133] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:37:0)
[03:07:52.133] Timer tick, asking Buildbucket for the build status
[03:07:52.315] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:52.315] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:38:0) after 1m0s
[03:08:52.325] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:38:0)
[03:08:52.325] Timer tick, asking Buildbucket for the build status
[03:08:52.661] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:52.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:39:0) after 1m0s
[03:09:52.750] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:39:0)
[03:09:52.750] Timer tick, asking Buildbucket for the build status
[03:09:52.881] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:52.881] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:40:0) after 1m0s
[03:10:52.968] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:40:0)
[03:10:52.968] Timer tick, asking Buildbucket for the build status
[03:10:53.502] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:53.502] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:41:0) after 1m0s
[03:11:53.585] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:41:0)
[03:11:53.585] Timer tick, asking Buildbucket for the build status
[03:11:54.057] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:54.057] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:42:0) after 1m0s
[03:12:54.106] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:42:0)
[03:12:54.106] Timer tick, asking Buildbucket for the build status
[03:12:54.187] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:54.187] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:43:0) after 1m0s
[03:13:54.221] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:43:0)
[03:13:54.221] Timer tick, asking Buildbucket for the build status
[03:13:54.316] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:54.316] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:44:0) after 1m0s
[03:14:54.565] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:44:0)
[03:14:54.565] Timer tick, asking Buildbucket for the build status
[03:14:54.712] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:54.712] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:45:0) after 1m0s
[03:15:54.950] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:45:0)
[03:15:54.950] Timer tick, asking Buildbucket for the build status
[03:15:55.326] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:55.326] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:46:0) after 1m0s
[03:16:55.373] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:46:0)
[03:16:55.373] Timer tick, asking Buildbucket for the build status
[03:16:55.800] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:55.800] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:47:0) after 1m0s
[03:17:55.921] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:47:0)
[03:17:55.921] Timer tick, asking Buildbucket for the build status
[03:17:55.987] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:55.987] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:48:0) after 1m0s
[03:18:56.047] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:48:0)
[03:18:56.047] Timer tick, asking Buildbucket for the build status
[03:18:56.132] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:56.132] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:49:0) after 1m0s
[03:19:56.137] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:49:0)
[03:19:56.137] Timer tick, asking Buildbucket for the build status
[03:19:56.401] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:56.401] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:50:0) after 1m0s
[03:20:56.490] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:50:0)
[03:20:56.490] Timer tick, asking Buildbucket for the build status
[03:20:57.799] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:57.799] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:51:0) after 1m0s
[03:21:57.883] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:51:0)
[03:21:57.883] Timer tick, asking Buildbucket for the build status
[03:21:58.338] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:58.338] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:52:0) after 1m0s
[03:22:58.386] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:52:0)
[03:22:58.386] Timer tick, asking Buildbucket for the build status
[03:22:58.547] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:58.547] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:53:0) after 1m0s
[03:23:58.606] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:53:0)
[03:23:58.606] Timer tick, asking Buildbucket for the build status
[03:23:58.875] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:58.875] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:54:0) after 1m0s
[03:24:58.901] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:54:0)
[03:24:58.901] Timer tick, asking Buildbucket for the build status
[03:24:59.052] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:59.052] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:55:0) after 1m0s
[03:25:59.138] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:55:0)
[03:25:59.138] Timer tick, asking Buildbucket for the build status
[03:25:59.278] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:59.278] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:56:0) after 1m0s
[03:26:59.299] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:56:0)
[03:26:59.299] Timer tick, asking Buildbucket for the build status
[03:26:59.608] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:59.608] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:57:0) after 1m0s
[03:27:59.729] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:57:0)
[03:27:59.729] Timer tick, asking Buildbucket for the build status
[03:27:59.864] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:59.864] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:58:0) after 1m0s
[03:28:59.934] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:58:0)
[03:28:59.934] Timer tick, asking Buildbucket for the build status
[03:29:00.443] Build 8887791268805221728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:00.443] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053221330943057456:59:0) after 1m0s
[03:29:42.216] Received PubSub notification, asking Buildbucket for the build status
[03:29:42.281] Build 8887791268805221728: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:29:42.281] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1582342181460711",
"created_by": "project:chromium",
"created_ts": "1582338759568867",
"id": "8887791268805221728",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"abcfacbb19e9e1bbb2bd9e678d38c9b2885d5867\"}}",
"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-12-ziey\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168877, \"got_angle_revision\": \"eacec98a34990d832d59705562af02fd29d02b25\", \"got_dawn_revision\": \"bc34d908f60d458c6d9e416a7404eac4703e1192\", \"got_nacl_revision\": \"530e1f0dae34020864c81e5cd52be54d9c656690\", \"got_revision\": \"abcfacbb19e9e1bbb2bd9e678d38c9b2885d5867\", \"got_revision_cp\": \"refs/heads/master@{#743760}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"847856089dc3f740f46f6f6af1be4c7cde50cdb2\", \"got_v8_revision\": \"de47ef6c23c6846f3da46a515383d00d76f533ae\", \"got_v8_revision_cp\": \"refs/heads/8.2.149@{#1}\", \"got_webrtc_revision\": \"1dea1ea412021819bddbc9400dcca7d9dd2eba74\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30581}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"abcfacbb19e9e1bbb2bd9e678d38c9b2885d5867\", \"swarm_hashes_refs/heads/master(at){#743760}_without_patch\": {\"accessibility_unittests\": \"5df3d6014f3bd583bc05efd72f81bfa12ea3bcae\", \"angle_unittests\": \"28aa96f52f45af415433898b07a860857f905ad8\", \"app_shell_unittests\": \"cc7c7c3fc9c13c13d72fc1eace66aeefd160eca0\", \"aura_unittests\": \"ce4e5524703c6a486af98ae91edd80e6394cec50\", \"base_unittests\": \"a39062f80f2af6be2e9b97d0520b2ad32ddb5c63\", \"base_util_unittests\": \"709893934b8402f706b2b9f51084a665ddbc7f60\", \"blink_common_unittests\": \"30624a34655da5e4f717e10243ab57f2f2223a98\", \"blink_fuzzer_unittests\": \"c0a93f0bb11d8bcc3151c88dd6085b1d43b78b96\", \"blink_heap_unittests\": \"590de5be4406775364ca04013f76d8656376d804\", \"blink_platform_unittests\": \"12256d6e47015d2d231fa7b2007931bd27912801\", \"blink_python_tests\": \"c47a65a2721d9810c8d40eeb27a44fb7b7254c03\", \"blink_unittests\": \"af6d73268ffa6706eee3cc2e219fdbf67ff70e6c\", \"blink_web_tests\": \"c177069f8f5299a1baa0d3d3ae1efa5c9399baf8\", \"boringssl_crypto_tests\": \"232bcba2674d3dde52e8b95f9edb9c3717986d1a\", \"boringssl_ssl_tests\": \"3b880770546a25c043f4ebb7442c9bb8967f58a9\", \"browser_tests\": \"b99f8a69ab890b62788b5716c1dde49022238e70\", \"cacheinvalidation_unittests\": \"a4cd3a038698aa743277926e0d66c071be443055\", \"capture_unittests\": \"007e130a402e59407241e4d6ce0a6293baa9a1fd\", \"cast_unittests\": \"a23023a2fa177c61c2b1d16c40b2609e89bb210f\", \"cc_unittests\": \"79a496a1d53f9c8c7a7ca31a4facc2306af7415d\", \"chrome_app_unittests\": \"e0c9ec99914f926b8c02954e26bb8f503fd98677\", \"chromedriver_unittests\": \"43fb353ab0e80f1be496ee54d74c59e1eaf01f6e\", \"components_browsertests\": \"42bddae26bed7adf9eea9a3fdbb1e4a24e427371\", \"components_unittests\": \"f350db98438e8d5fd82a5f36933925e70895b44e\", \"compositor_unittests\": \"134580f0a6824d1ddfaf1399ca6128ee42b1400d\", \"content_browsertests\": \"f84b98c93673409e1cd208a61684870edba57227\", \"content_shell_crash_test\": \"9bf8f73ef00134c5ee83fd7f1246737012144575\", \"content_unittests\": \"c1e4fa7472c5bd0245312684b8ac7f14a0e508be\", \"crashpad_tests\": \"9ce1e8e5ba1f7086cc641256213d63361fa3dabc\", \"cronet_tests\": \"b8a1fb95ff5415d069f08b11bce87be18b5b6717\", \"cronet_unittests\": \"1e7ab1aad37804bbb5f188d5c9bef3be9ec4d0c4\", \"crypto_unittests\": \"5e7b73d6a255dba63887844222ece64e420b81ca\", \"dbus_unittests\": \"b6ef333c362baf1b1764d441c1d3d300d3ab4b58\", \"device_unittests\": \"401568afe5f6692096923c135ca9babac486c93b\", \"display_unittests\": \"b01a9304476b9a03cfd7004c92d370e15ea1bf5a\", \"events_unittests\": \"0f6abd5a652eef3dce72d1d9fe1094bb476b089e\", \"extensions_browsertests\": \"942d446c40da606be13f6ae0b7e57de8390b414f\", \"extensions_unittests\": \"22c7c08805961a98c34a50f281a93ca75844f993\", \"filesystem_service_unittests\": \"effe4547fb31a91aec92c11f4ae53bb017a4862a\", \"flatbuffers_unittests\": \"c3db37cb8981f7422026864ae3bd0765e7fa7de4\", \"gcm_unit_tests\": \"944ffa327d781c55c4790e9f6f2b3ab89cb1c5db\", \"gfx_unittests\": \"d5fb3753405983ec2fbb943d211d80065dad810c\", \"gin_unittests\": \"3b90bcbce1ffd212e585a13f85042c9e294a0807\", \"google_apis_unittests\": \"51db240383e402a96650f12d40337545459fe0b6\", \"gpu_unittests\": \"5ca0cc24f1f3a6d637b5c4d71e05d759b21131a0\", \"grit_python_unittests\": \"73624ac0238f8ac67cfd1de0fd5785fdae8fa44b\", \"gwp_asan_unittests\": \"6f7725e4d75b630c77a9c956713800485f9a89a9\", \"headless_browsertests\": \"2b9a9f4fe37f6be9305bf99f80302dac8cb70529\", \"headless_unittests\": \"d62bd64a5fb55e43ddcbc7307e19f038ef165ef3\", \"interactive_ui_tests\": \"39e8ae6737f732a576760598465c4538ce41cc71\", \"ipc_tests\": \"c903b587c0e82161ddadd7841b42eaff3b6d9149\", \"jingle_unittests\": \"f64a06e8d3258fe33ed72b64c71707be705887c5\", \"latency_unittests\": \"29f4a142ba8bc67111866d2ca475446bec8fa442\", \"libjingle_xmpp_unittests\": \"f29477f4b86720cc2b4d42b5ebf7b4e313210d52\", \"media_blink_unittests\": \"1cf0aadd1d9fd09896de756ffc57145a686c6ecc\", \"media_service_unittests\": \"247a3ccdb04e77e375b6490ffbd6c4fbcd9c5b57\", \"media_unittests\": \"9d42e5999b657349cd370668a0546cb3697bbab8\", \"message_center_unittests\": \"bf4de03b709cc98fe599b08a31176c17891fd14c\", \"metrics_python_tests\": \"70ed2114bbd5ab048d8b8966c1e37d6538672fc3\", \"midi_unittests\": \"060c94e8b72442febf4b38c65a4554c9779d5e38\", \"mojo_core_unittests\": \"63ed2c6f6ce4d4fd968577446ee56c6839a0ebef\", \"mojo_unittests\": \"ac1d1a0748dbb9d7d8b08a16f3df4adb9eb01233\", \"nacl_helper_nonsfi_unittests\": \"3e0aad9eb8ba2cfd0c1b319ec5e035dd5d228563\", \"nacl_loader_unittests\": \"594b998910ac0515cea1190eeca3e44bfb98524f\", \"native_theme_unittests\": \"006a2321cdcad1cb7698785f08345a5e64daeaf4\", \"net_unittests\": \"886a13c34731f49b4b4139df395b2509d9a9390a\", \"pdf_unittests\": \"71388e5021f2d8fc6b664c83c687207f481c28d6\", \"perfetto_unittests\": \"08d942efb0e5f6d49920b90f743c5a8fa810524f\", \"ppapi_unittests\": \"8050c15a560dc31a8ab325889d54980e6f0bb541\", \"printing_unittests\": \"f683b4f1c506f8ea9f25386b2d4f3d4a3de7f264\", \"remoting_unittests\": \"4117ea40e619ed2732929a668c20679194b66e57\", \"sandbox_linux_unittests\": \"ca20553c5ae59046999f62fa7c8871e80cde47f0\", \"service_manager_unittests\": \"0c0c7a33deb0ccf63e348802f4b206bdce6eb5f7\", \"services_unittests\": \"49d9a6bde56687f07b90be583e11458e9000b867\", \"shell_dialogs_unittests\": \"931f4e2ff5b831b73a480b4a5dbd82474623bb2d\", \"skia_unittests\": \"07f6047f417609ca045fe4ca9d3023b431518453\", \"snapshot_unittests\": \"6f53045372a2df0fc6dff5bca0fedb5ceb0c1a44\", \"sql_unittests\": \"893c4d0797e7a6cf34ececff680a31bce1c01975\", \"storage_unittests\": \"1b166a97319f73892261f63882b3a09abd305a85\", \"sync_integration_tests\": \"4ec876b9a3b32f8b163af2765580a20a62560636\", \"telemetry_gpu_unittests\": \"7367216cdf2dbffbaf0a22265ed49cb67760f326\", \"telemetry_perf_unittests\": \"7eb9e219719510304ded1d7e732005e52c54a9be\", \"telemetry_unittests\": \"47ffd6c103c76f7da408c8e35ee7337d6d7e54b7\", \"traffic_annotation_auditor_unittests\": \"4e2cdbda17cd6ea28c74c8dc183fddca51e06a88\", \"ui_base_unittests\": \"2d38bbf7329169c0ede18352d8e4cec605c92a81\", \"ui_touch_selection_unittests\": \"223ceae0e469f0f87af11f79d1aeee00fa9b33e2\", \"unit_tests\": \"251a60349b61d9c50a1af271a104c7bfe4aedf91\", \"url_unittests\": \"6e39fa5e5da288d4e3047026a8a363a50fcdfa01\", \"views_perftests\": \"34d882349a97fa424d12692f177d77ee5b2813ea\", \"views_unittests\": \"1306c34fe096b792caf0ff7d8acca28d98ef27d9\", \"viz_unittests\": \"ce68839e5e811c453eb6845be12002eaef0a0035\", \"vr_common_unittests\": \"1cf6441413bde15d774baf0b099ccd3defbcdc79\", \"vr_pixeltests\": \"d0a49601717bd15d3e8e7e9d3317cbb93f62201e\", \"webdriver_wpt_tests\": \"5df9c951a7078d9bd06316e1cdfcc2f128e2557f\", \"weblayer_browsertests\": \"03d36f1a7a949ffcd9cb49a6dd443d2a68babab9\", \"wm_unittests\": \"19a45248bebf89cb27ea6975c0bf5102db058e2e\", \"wtf_unittests\": \"234443fa53214483d122c7d9fdba3b98dba36df2\", \"xr_browser_tests\": \"1fc75d4307ef2152ad1de65ff6c77985f33c7ba9\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_51603c189459d949c9f9b05c6193f37cd30704e77931c7dc651854102fbe3f3d_v2\", \"builder_65ed874bd033a5984c3cbb528261ef1b136b40627f077f473aaaca27b3fa3caf_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"builder_c6f1473df00e57847ed4ff0f74718f3dfb2a5d42012d3d3fe6b396b4c9a29f62_v2\", \"builder_eeb4aed1f5957a78d1f0fe1c00bdb778895591d08c1bb63c47ebb234324ef661_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-12-ziey\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"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\": [\"4825-3d129d6\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1582339026494552",
"status": "COMPLETED",
"status_changed_ts": "1582342181856664",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168877",
"builder:Linux Builder (dbg)",
"buildset:commit/git/abcfacbb19e9e1bbb2bd9e678d38c9b2885d5867",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/abcfacbb19e9e1bbb2bd9e678d38c9b2885d5867",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053221330943057456",
"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/8887791268805221728/+/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:4a838eebbfc18e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1582342181865203",
"url": "https://ci.chromium.org/b/8887791268805221728",
"utcnow_ts": "1582342182271658"
}
}
[03:29:42.281] Invocation finished in 57m4.135144147s with status SUCCEEDED