[17:31:54.086] New invocation is queued and will start shortly
[17:31:55.171] Starting the invocation (attempt 1)
[17:31:55.208] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:31:55.209] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:31:55.209] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9051896396528955600",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4e6e084bef98fa1cc598d826d5360ddb6072a85d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9051896396528955600",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/4e6e084bef98fa1cc598d826d5360ddb6072a85d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4e6e084bef98fa1cc598d826d5360ddb6072a85d",
"gitiles_ref:refs/heads/master"
]
}
[17:31:56.334] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1583602315304585",
"id": "8886466334586010256",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4e6e084bef98fa1cc598d826d5360ddb6072a85d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1583602315808850",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169455",
"builder:Linux Builder (dbg)",
"buildset:commit/git/4e6e084bef98fa1cc598d826d5360ddb6072a85d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4e6e084bef98fa1cc598d826d5360ddb6072a85d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9051896396528955600",
"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/8886466334586010256/+/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": "1583602315808955",
"url": "https://ci.chromium.org/b/8886466334586010256",
"utcnow_ts": "1583602316323954"
}
}
[17:31:56.334] Task URL: https://ci.chromium.org/b/8886466334586010256
[17:31:56.334] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:2:0) after 1m0s
[17:32:56.853] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:2:0)
[17:32:56.853] Timer tick, asking Buildbucket for the build status
[17:32:56.981] Build 8886466334586010256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:32:56.981] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:3:0) after 1m0s
[17:33:56.998] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:3:0)
[17:33:56.998] Timer tick, asking Buildbucket for the build status
[17:33:57.387] Build 8886466334586010256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:33:57.387] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:4:0) after 1m0s
[17:34:57.389] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:4:0)
[17:34:57.389] Timer tick, asking Buildbucket for the build status
[17:34:57.504] Build 8886466334586010256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:34:57.504] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:5:0) after 1m0s
[17:35:57.489] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:5:0)
[17:35:57.489] Timer tick, asking Buildbucket for the build status
[17:35:57.755] Build 8886466334586010256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:35:57.755] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:6:0) after 1m0s
[17:36:11.112] Received PubSub notification, asking Buildbucket for the build status
[17:36:11.523] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:57.759] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:6:0)
[17:36:57.759] Timer tick, asking Buildbucket for the build status
[17:36:57.831] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:57.831] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:8:0) after 1m0s
[17:37:57.813] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:8:0)
[17:37:57.813] Timer tick, asking Buildbucket for the build status
[17:37:57.916] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:57.916] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:9:0) after 1m0s
[17:38:57.948] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:9:0)
[17:38:57.948] Timer tick, asking Buildbucket for the build status
[17:38:58.144] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:58.144] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:10:0) after 1m0s
[17:39:58.167] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:10:0)
[17:39:58.167] Timer tick, asking Buildbucket for the build status
[17:39:58.350] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:58.350] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:11:0) after 1m0s
[17:40:58.375] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:11:0)
[17:40:58.375] Timer tick, asking Buildbucket for the build status
[17:40:58.754] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:58.754] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:12:0) after 1m0s
[17:41:58.732] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:12:0)
[17:41:58.732] Timer tick, asking Buildbucket for the build status
[17:41:58.859] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:58.859] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:13:0) after 1m0s
[17:42:58.878] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:13:0)
[17:42:58.878] Timer tick, asking Buildbucket for the build status
[17:42:59.041] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:59.041] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:14:0) after 1m0s
[17:43:59.077] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:14:0)
[17:43:59.077] Timer tick, asking Buildbucket for the build status
[17:43:59.180] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:59.180] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:15:0) after 1m0s
[17:44:59.239] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:15:0)
[17:44:59.239] Timer tick, asking Buildbucket for the build status
[17:44:59.513] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:59.513] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:16:0) after 1m0s
[17:45:59.538] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:16:0)
[17:45:59.538] Timer tick, asking Buildbucket for the build status
[17:45:59.781] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:59.781] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:17:0) after 1m0s
[17:46:59.962] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:17:0)
[17:46:59.962] Timer tick, asking Buildbucket for the build status
[17:47:00.125] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:00.125] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:18:0) after 1m0s
[17:48:00.121] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:18:0)
[17:48:00.121] Timer tick, asking Buildbucket for the build status
[17:48:00.229] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:00.229] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:19:0) after 1m0s
[17:49:00.233] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:19:0)
[17:49:00.233] Timer tick, asking Buildbucket for the build status
[17:49:00.587] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:00.587] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:20:0) after 1m0s
[17:50:00.608] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:20:0)
[17:50:00.608] Timer tick, asking Buildbucket for the build status
[17:50:00.993] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:00.993] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:21:0) after 1m0s
[17:51:01.014] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:21:0)
[17:51:01.014] Timer tick, asking Buildbucket for the build status
[17:51:01.153] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:01.153] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:22:0) after 1m0s
[17:52:01.205] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:22:0)
[17:52:01.205] Timer tick, asking Buildbucket for the build status
[17:52:01.446] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:01.446] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:23:0) after 1m0s
[17:53:01.511] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:23:0)
[17:53:01.511] Timer tick, asking Buildbucket for the build status
[17:53:01.637] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:01.637] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:24:0) after 1m0s
[17:54:01.700] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:24:0)
[17:54:01.700] Timer tick, asking Buildbucket for the build status
[17:54:02.046] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:02.046] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:25:0) after 1m0s
[17:55:02.089] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:25:0)
[17:55:02.089] Timer tick, asking Buildbucket for the build status
[17:55:02.244] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:02.244] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:26:0) after 1m0s
[17:56:02.276] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:26:0)
[17:56:02.276] Timer tick, asking Buildbucket for the build status
[17:56:02.562] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:02.562] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:27:0) after 1m0s
[17:57:02.630] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:27:0)
[17:57:02.630] Timer tick, asking Buildbucket for the build status
[17:57:02.744] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:02.744] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:28:0) after 1m0s
[17:58:02.776] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:28:0)
[17:58:02.776] Timer tick, asking Buildbucket for the build status
[17:58:03.202] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:03.202] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:29:0) after 1m0s
[17:59:03.271] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:29:0)
[17:59:03.271] Timer tick, asking Buildbucket for the build status
[17:59:03.436] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:03.436] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:30:0) after 1m0s
[18:00:03.518] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:30:0)
[18:00:03.518] Timer tick, asking Buildbucket for the build status
[18:00:03.662] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:03.663] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:31:0) after 1m0s
[18:01:03.708] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:31:0)
[18:01:03.708] Timer tick, asking Buildbucket for the build status
[18:01:03.982] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:03.982] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:32:0) after 1m0s
[18:02:04.008] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:32:0)
[18:02:04.008] Timer tick, asking Buildbucket for the build status
[18:02:04.139] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:04.140] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:33:0) after 1m0s
[18:03:04.217] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:33:0)
[18:03:04.217] Timer tick, asking Buildbucket for the build status
[18:03:04.347] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:04.347] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:34:0) after 1m0s
[18:04:04.371] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:34:0)
[18:04:04.371] Timer tick, asking Buildbucket for the build status
[18:04:04.544] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:04.544] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:35:0) after 1m0s
[18:05:04.576] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:35:0)
[18:05:04.576] Timer tick, asking Buildbucket for the build status
[18:05:04.677] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:04.677] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:36:0) after 1m0s
[18:06:04.755] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:36:0)
[18:06:04.755] Timer tick, asking Buildbucket for the build status
[18:06:04.909] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:04.909] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:37:0) after 1m0s
[18:07:04.946] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:37:0)
[18:07:04.946] Timer tick, asking Buildbucket for the build status
[18:07:05.059] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:05.059] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:38:0) after 1m0s
[18:08:05.086] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:38:0)
[18:08:05.086] Timer tick, asking Buildbucket for the build status
[18:08:05.213] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:05.213] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:39:0) after 1m0s
[18:09:05.282] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:39:0)
[18:09:05.282] Timer tick, asking Buildbucket for the build status
[18:09:05.391] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:05.391] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:40:0) after 1m0s
[18:10:05.420] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:40:0)
[18:10:05.420] Timer tick, asking Buildbucket for the build status
[18:10:05.632] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:05.632] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:41:0) after 1m0s
[18:11:05.651] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:41:0)
[18:11:05.651] Timer tick, asking Buildbucket for the build status
[18:11:05.945] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:05.945] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:42:0) after 1m0s
[18:12:05.969] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:42:0)
[18:12:05.969] Timer tick, asking Buildbucket for the build status
[18:12:06.237] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:06.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:43:0) after 1m0s
[18:13:06.360] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:43:0)
[18:13:06.360] Timer tick, asking Buildbucket for the build status
[18:13:06.528] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:06.528] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:44:0) after 1m0s
[18:14:06.564] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:44:0)
[18:14:06.564] Timer tick, asking Buildbucket for the build status
[18:14:06.846] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:06.846] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:45:0) after 1m0s
[18:15:06.871] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:45:0)
[18:15:06.871] Timer tick, asking Buildbucket for the build status
[18:15:06.971] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:06.971] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:46:0) after 1m0s
[18:16:07.044] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:46:0)
[18:16:07.044] Timer tick, asking Buildbucket for the build status
[18:16:07.225] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:07.225] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:47:0) after 1m0s
[18:17:07.278] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:47:0)
[18:17:07.278] Timer tick, asking Buildbucket for the build status
[18:17:07.435] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:07.435] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:48:0) after 1m0s
[18:18:07.454] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:48:0)
[18:18:07.454] Timer tick, asking Buildbucket for the build status
[18:18:07.626] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:07.626] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:49:0) after 1m0s
[18:19:07.648] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:49:0)
[18:19:07.648] Timer tick, asking Buildbucket for the build status
[18:19:07.765] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:07.765] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:50:0) after 1m0s
[18:20:07.793] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:50:0)
[18:20:07.793] Timer tick, asking Buildbucket for the build status
[18:20:07.922] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:07.922] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:51:0) after 1m0s
[18:21:07.960] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:51:0)
[18:21:07.960] Timer tick, asking Buildbucket for the build status
[18:21:08.098] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:08.098] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:52:0) after 1m0s
[18:22:08.123] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:52:0)
[18:22:08.123] Timer tick, asking Buildbucket for the build status
[18:22:08.252] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:08.252] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:53:0) after 1m0s
[18:23:08.300] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:53:0)
[18:23:08.300] Timer tick, asking Buildbucket for the build status
[18:23:08.372] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:08.372] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:54:0) after 1m0s
[18:24:08.392] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:54:0)
[18:24:08.392] Timer tick, asking Buildbucket for the build status
[18:24:08.581] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:08.581] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:55:0) after 1m0s
[18:25:08.614] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:55:0)
[18:25:08.614] Timer tick, asking Buildbucket for the build status
[18:25:08.975] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:08.975] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:56:0) after 1m0s
[18:26:09.012] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:56:0)
[18:26:09.012] Timer tick, asking Buildbucket for the build status
[18:26:09.458] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:09.458] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:57:0) after 1m0s
[18:27:09.535] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:57:0)
[18:27:09.535] Timer tick, asking Buildbucket for the build status
[18:27:09.677] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:09.677] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:58:0) after 1m0s
[18:28:09.723] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:58:0)
[18:28:09.723] Timer tick, asking Buildbucket for the build status
[18:28:10.066] Build 8886466334586010256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:10.066] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051896396528955600:59:0) after 1m0s
[18:28:34.992] Received PubSub notification, asking Buildbucket for the build status
[18:28:35.062] Build 8886466334586010256: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:28:35.062] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1583605714226094",
"created_by": "project:chromium",
"created_ts": "1583602315304585",
"id": "8886466334586010256",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4e6e084bef98fa1cc598d826d5360ddb6072a85d\"}}",
"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-central1-b-8-41-onte\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 169455, \"got_angle_revision\": \"03ed5f6c4698e7d158448b8845dd1be1b53b02fc\", \"got_dawn_revision\": \"7d20b4450182b8e25dfd315019623d7a746cc290\", \"got_nacl_revision\": \"35bcc9f6d5e81c3c39ad57de97ef9cd22301ee9e\", \"got_revision\": \"4e6e084bef98fa1cc598d826d5360ddb6072a85d\", \"got_revision_cp\": \"refs/heads/master@{#748021}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"b44162fdbb25996e4710026007bc98b7201f2a1d\", \"got_v8_revision\": \"d4ed59c4ed609eacc9062bd22ebca409ef7c6d1c\", \"got_v8_revision_cp\": \"refs/heads/8.2.263@{#1}\", \"got_webrtc_revision\": \"04f7bfc4192f5ce444b312afd287203ea53c99b6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30715}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4e6e084bef98fa1cc598d826d5360ddb6072a85d\", \"swarm_hashes_refs/heads/master(at){#748021}_without_patch\": {\"accessibility_unittests\": \"6f09cc59b2e5ba5fed190e008977f465b3df7793\", \"angle_unittests\": \"086d89bd4d93da2b6bf81b7f4d112be548627b12\", \"app_shell_unittests\": \"eca9f6e35036801c601cc92fc5f8c2661a54c013\", \"aura_unittests\": \"6c8a464a90b785661566feacb71b5faa0705199c\", \"base_unittests\": \"b7e933210fed63af9c9f66cf75c793580e74a388\", \"base_util_unittests\": \"d1e8abfec817fd1252468e11a55764aa9ce19038\", \"blink_common_unittests\": \"f8547187e42b71d1cb8ee291d0ef4f473cd32bd5\", \"blink_fuzzer_unittests\": \"e38243149e869356c1776abc6fd38f8316679929\", \"blink_heap_unittests\": \"c48f5d0d5b14a810fed41cbfe6b7511136b6dada\", \"blink_platform_unittests\": \"3619884ada60e6cdc2fb0afc45a716e5c25db1f2\", \"blink_python_tests\": \"0292db2a2aab85c1d3140a4898b35b3e6a28eac3\", \"blink_unittests\": \"fd9844c5706b166ee92b05bf83ced1d7d5cabf9a\", \"blink_web_tests\": \"6ffcb174e94a36885a4797479c500077b2dc1ee0\", \"boringssl_crypto_tests\": \"d8fd1d98548abcd6eea92e26c9b328f46483c656\", \"boringssl_ssl_tests\": \"18ac8c64ead4b9984b07a3717efdc103e8e7577e\", \"browser_tests\": \"78fa0780093afe0ac8287ae2f7254969dc08bd4c\", \"cacheinvalidation_unittests\": \"58369ddf2e000614d6142c7d62bda777dd1726ad\", \"capture_unittests\": \"81b8d11d32ed49d8479796a0c6db6c98c7315461\", \"cast_unittests\": \"cbf4c799740846c761701b877276ac51203563fa\", \"cc_unittests\": \"2877b59199b7d3700ffd0b8fcd76c47eade4c049\", \"chrome_app_unittests\": \"e8d6853c55b395c705261cf8e233f6bb6879d1e6\", \"chromedriver_unittests\": \"19c7edfd3af13d82f528b86c2f6b4f6b9a29430b\", \"components_browsertests\": \"99613ce52c8b65aa96a3b5951b80379d02631631\", \"components_unittests\": \"866abe88a63176d62f10724b601c454747fcf4ff\", \"compositor_unittests\": \"f99c8956ec9194401863be45359607183262da3e\", \"content_browsertests\": \"418de4fc77abeaa3c612ed5df17e3ad324969416\", \"content_shell_crash_test\": \"597e0aa2ba57778af5890b698eff9e9dddf26696\", \"content_unittests\": \"e7254d41153b82efac88b7355463ac1ddb55e52a\", \"crashpad_tests\": \"3f75bf2d1ed713ca0b910503d14f6cf5baf08dff\", \"cronet_tests\": \"b4e0ba8b9739accbd92eeda6f40e2b4c7d25471c\", \"cronet_unittests\": \"31640ccd5acdfb3cc6f365653ca67772f75b2986\", \"crypto_unittests\": \"be512070d9ae9c13b8b6f99438d55c093a4b3706\", \"dbus_unittests\": \"fc36b049d8a3277bc0d60262795af238002c1f43\", \"device_unittests\": \"5f33c1db74116af871a2560969e571178d3137ad\", \"display_unittests\": \"f7bd0a9c30d5c071d2f200b9226773c0d81f1af0\", \"events_unittests\": \"a3ed5efe3e02801b3077cf8ba6ed515d8c16ddb6\", \"extensions_browsertests\": \"0f5240c213a6c44d50a7f8c4b36a74aa96513ed5\", \"extensions_unittests\": \"3b60a7352eba4a7a6a44dfb26840bf38f423a089\", \"filesystem_service_unittests\": \"94db17eb1175d1b9053e2fdc67faeda9c7d22211\", \"flatbuffers_unittests\": \"050844e0d26621703adfe93dfd2f97054fb85d6c\", \"gcm_unit_tests\": \"0908b4092214b71429e7cbd51e57ae569c5c4fd1\", \"gfx_unittests\": \"d4e2fdb71a18adb20cbeeaa9c62b6ede6beb934d\", \"gin_unittests\": \"6c1fffe1d429a06ab9ad798b3fa5463d37aac5c8\", \"google_apis_unittests\": \"8e3f5d1fd3699784dcdded6f0fae7c8f1c339a8e\", \"gpu_unittests\": \"094db59ab205caae9e50bb28ef5b315fbe57c70c\", \"grit_python_unittests\": \"300ea8455288eab00cd459e887bd99a4f6468e8a\", \"gwp_asan_unittests\": \"2fa735098a4f4332e2aee433c11a089a09296de2\", \"headless_browsertests\": \"adafca9dc169aa21cd9f3055bddca1427a54099c\", \"headless_unittests\": \"67b6f047a1b4072365c8180028f322032862a63c\", \"interactive_ui_tests\": \"3df7522dbbbb7e53ca7a00231f98b946a623e524\", \"ipc_tests\": \"915fd5b783218a06cb3a38a4ff1e1ef12c93e056\", \"jingle_unittests\": \"d4095c6caf86bc83391103a428e4c55bd463e3e1\", \"latency_unittests\": \"9a42b632b714cca3496f22355c128e524a1e3fe9\", \"libjingle_xmpp_unittests\": \"5f7031b7b57b5256e75eb512e38ea8d956db3653\", \"media_blink_unittests\": \"a896481aa2397ed5600083308dd078a98b57960f\", \"media_service_unittests\": \"9da4cea5a13b47ebdbd1a545f2759e4b800a93de\", \"media_unittests\": \"3d3dc75565635f42be8b03a085cb55d866aafab4\", \"message_center_unittests\": \"3a208ec2017ebac1af3cef9434213b23b5478b11\", \"metrics_python_tests\": \"4ba74b2560929665bc4def3a2dc4d01d81cd9534\", \"midi_unittests\": \"e98a919c23d7def4489864551bff8c814d0cbf70\", \"mojo_core_unittests\": \"5cddb676170a6268e3432f328830ff89eeedc0de\", \"mojo_unittests\": \"59b4f11bf5dc2b9eb980591d13d60bbee5a8d0c9\", \"nacl_helper_nonsfi_unittests\": \"dffc5670f5c4d9c24684ed48258df2aa0159eb2c\", \"nacl_loader_unittests\": \"35456af2f0a5e39e33cd824fdbea07eceb837ee8\", \"native_theme_unittests\": \"cfb6f3dffdb27f47252b4e92f0f0bdb97c7a2400\", \"net_unittests\": \"9fa6a61dc5aa9af7924f22b7a13411b575b2dac8\", \"pdf_unittests\": \"5bfba4ffae3722b5324d275590ad8fef75300fec\", \"perfetto_unittests\": \"19ea90905cbab47c939d0ec2307ead3efe4c228b\", \"ppapi_unittests\": \"54f7450b489dfb136d2d4534f45af34b91c9f08d\", \"printing_unittests\": \"0760087a6f917407c5e818dd7d027099f22c7d00\", \"remoting_unittests\": \"703bcca142beba5ccdc4d8d25c6ad63de2ae8036\", \"sandbox_linux_unittests\": \"36496d61bd43c286c7a27b2989c477e02860ebc1\", \"service_manager_unittests\": \"fadb73e2abe0f6862b048d4706502b0937726019\", \"services_unittests\": \"af251e714841ca957a7ed7ca77bf7fe4b4026c12\", \"shell_dialogs_unittests\": \"a025aa5da8fd44c8a1697b2e338fb06c1e050384\", \"skia_unittests\": \"130e595a4397af6ce6bd8b943e027dee81aa7c26\", \"snapshot_unittests\": \"1f7f9a60703763dac8fe2bd15f341f7f9f869711\", \"sql_unittests\": \"6ea2542f55f247260649ec666d661ccbc1291eee\", \"storage_unittests\": \"91fab72ee2703c96c0f1f86f3f7b7caee6179447\", \"sync_integration_tests\": \"7ad9788dd038ff2a580b9a028d55bb40284865ce\", \"telemetry_gpu_unittests\": \"cffa2e329d1e8206c025ef8f706dcc53bf99c2e3\", \"telemetry_perf_unittests\": \"07d5c32eff5f7391dccb6861f61a6afef3f6272a\", \"telemetry_unittests\": \"3c9ef706b3f2593d6a0bdc7a8c15ff3259f07120\", \"traffic_annotation_auditor_unittests\": \"c2755bf5dfd0d18deb17497d5e6659f7d2844727\", \"ui_base_unittests\": \"e13255bc656c539b9effe575db43a9c15ca4a3ba\", \"ui_touch_selection_unittests\": \"a90fa878c3b580b44c413554e6315670ea346e1e\", \"unit_tests\": \"ac98916545c2166ec11d1c705abd21bc64ba25bc\", \"url_unittests\": \"ea43cb6bc2954b553dda6eef9c501fbb59d75c1f\", \"views_perftests\": \"7bc45fb44e82a9d517610d1b1aba24f13b19f4f1\", \"views_unittests\": \"6d9eb480ba1ca2b4b8aa9e997d1946601aa8139f\", \"viz_unittests\": \"c5d52a435a556c837e14bf366b39ea963f545176\", \"vr_common_unittests\": \"011660c8781f014ee35447c1d643ad50f84ad543\", \"vr_pixeltests\": \"243c7af0b1714255cfc4ac35ae89950c8889ac15\", \"webdriver_wpt_tests\": \"d5bf87cc9c2c9083bb1e6be688abdde84998f7f6\", \"weblayer_browsertests\": \"f7668fe3f0233d8a45533e6be694fe1edc9a4a18\", \"wm_unittests\": \"cd29cf0a8880d41f96c192a0658ba90590f5901d\", \"wtf_unittests\": \"18306cd9b10245421daa1ccc89ee0c86e459b8e9\", \"xr_browser_tests\": \"772924c0ef9658814e7906028e04e4391b0aa7cf\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_349392596e0d17d3422c55529f4e230875f36ec061130c176581539a4c7cd365_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_8f1f1a811acb8ac7cee91f001f34cb98db55e889611ed2a31914ce7c854c1541_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"builder_beb776337cf5e2ff0f3cb2908a8270f1e35b65aa6652b9e320dd7c6c902817db_v2\", \"builder_c4692ee50382bcd35d592bcc0950e009bfc7efa8bba012f560f58cf3ab714e75_v2\", \"builder_dbb86507a6c3fadd4cf4e1827f5f960c6207016e30a949100a00998d3583e722_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-central1-b-8-41-onte\"], \"image\": [\"chrome-xenial-20030100-2bddf837f90\"], \"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\": [\"4851-268d16b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1583602570403752",
"status": "COMPLETED",
"status_changed_ts": "1583605714681498",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169455",
"builder:Linux Builder (dbg)",
"buildset:commit/git/4e6e084bef98fa1cc598d826d5360ddb6072a85d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4e6e084bef98fa1cc598d826d5360ddb6072a85d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9051896396528955600",
"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/8886466334586010256/+/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:4acedf3cdcccbc10",
"user_agent:luci-scheduler"
],
"updated_ts": "1583605714693922",
"url": "https://ci.chromium.org/b/8886466334586010256",
"utcnow_ts": "1583605715050921"
}
}
[18:28:35.062] Invocation finished in 56m40.9938548s with status SUCCEEDED