[16:37:59.211] New invocation is queued and will start shortly
[16:38:01.718] Starting the invocation (attempt 1)
[16:38:01.777] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:38:01.777] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:38:01.777] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031153083242300208",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"08eb43cabbccab7c68a9c172091dec9c4590e9e0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9031153083242300208",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/08eb43cabbccab7c68a9c172091dec9c4590e9e0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/08eb43cabbccab7c68a9c172091dec9c4590e9e0",
"gitiles_ref:refs/heads/master"
]
}
[16:38:02.455] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603384681918239",
"id": "8865723019731434992",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"08eb43cabbccab7c68a9c172091dec9c4590e9e0\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603384682310255",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176931",
"builder:Linux Builder (dbg)",
"buildset:commit/git/08eb43cabbccab7c68a9c172091dec9c4590e9e0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/08eb43cabbccab7c68a9c172091dec9c4590e9e0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031153083242300208",
"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/8865723019731434992/+/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": "1603384682310400",
"url": "https://ci.chromium.org/b/8865723019731434992",
"utcnow_ts": "1603384682445991"
}
}
[16:38:02.455] Task URL: https://ci.chromium.org/b/8865723019731434992
[16:38:02.455] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:2:0) after 1m0s
[16:38:05.591] Received PubSub notification, asking Buildbucket for the build status
[16:38:05.701] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:02.484] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:2:0)
[16:39:02.484] Timer tick, asking Buildbucket for the build status
[16:39:02.679] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:02.679] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:4:0) after 1m0s
[16:40:02.725] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:4:0)
[16:40:02.725] Timer tick, asking Buildbucket for the build status
[16:40:02.798] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:02.798] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:5:0) after 1m0s
[16:41:02.809] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:5:0)
[16:41:02.809] Timer tick, asking Buildbucket for the build status
[16:41:02.922] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:02.922] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:6:0) after 1m0s
[16:42:02.964] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:6:0)
[16:42:02.964] Timer tick, asking Buildbucket for the build status
[16:42:03.327] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:03.327] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:7:0) after 1m0s
[16:43:03.344] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:7:0)
[16:43:03.344] Timer tick, asking Buildbucket for the build status
[16:43:10.613] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:10.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:8:0) after 1m0s
[16:44:10.979] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:8:0)
[16:44:10.979] Timer tick, asking Buildbucket for the build status
[16:44:11.058] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:11.058] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:9:0) after 1m0s
[16:45:11.183] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:9:0)
[16:45:11.183] Timer tick, asking Buildbucket for the build status
[16:45:11.242] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:11.242] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:10:0) after 1m0s
[16:46:11.337] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:10:0)
[16:46:11.337] Timer tick, asking Buildbucket for the build status
[16:46:11.436] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:11.436] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:11:0) after 1m0s
[16:47:11.475] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:11:0)
[16:47:11.475] Timer tick, asking Buildbucket for the build status
[16:47:12.101] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:12.101] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:12:0) after 1m0s
[16:48:12.154] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:12:0)
[16:48:12.154] Timer tick, asking Buildbucket for the build status
[16:48:12.392] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:12.392] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:13:0) after 1m0s
[16:49:12.413] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:13:0)
[16:49:12.413] Timer tick, asking Buildbucket for the build status
[16:49:12.481] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:12.481] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:14:0) after 1m0s
[16:50:12.739] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:14:0)
[16:50:12.739] Timer tick, asking Buildbucket for the build status
[16:50:12.808] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:12.808] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:15:0) after 1m0s
[16:51:12.977] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:15:0)
[16:51:12.977] Timer tick, asking Buildbucket for the build status
[16:51:13.054] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:13.054] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:16:0) after 1m0s
[16:52:13.172] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:16:0)
[16:52:13.172] Timer tick, asking Buildbucket for the build status
[16:52:13.277] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:13.277] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:17:0) after 1m0s
[16:53:13.357] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:17:0)
[16:53:13.357] Timer tick, asking Buildbucket for the build status
[16:53:13.811] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:13.811] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:18:0) after 1m0s
[16:54:13.811] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:18:0)
[16:54:13.811] Timer tick, asking Buildbucket for the build status
[16:54:13.870] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:13.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:19:0) after 1m0s
[16:55:13.919] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:19:0)
[16:55:13.919] Timer tick, asking Buildbucket for the build status
[16:55:13.986] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:13.986] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:20:0) after 1m0s
[16:56:14.041] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:20:0)
[16:56:14.041] Timer tick, asking Buildbucket for the build status
[16:56:14.112] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:14.112] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:21:0) after 1m0s
[16:57:14.158] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:21:0)
[16:57:14.158] Timer tick, asking Buildbucket for the build status
[16:57:14.228] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:14.228] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:22:0) after 1m0s
[16:58:14.713] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:22:0)
[16:58:14.713] Timer tick, asking Buildbucket for the build status
[16:58:14.883] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:14.883] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:23:0) after 1m0s
[16:59:14.996] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:23:0)
[16:59:14.996] Timer tick, asking Buildbucket for the build status
[16:59:15.226] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:15.227] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:24:0) after 1m0s
[17:00:15.533] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:24:0)
[17:00:15.533] Timer tick, asking Buildbucket for the build status
[17:00:15.606] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:15.606] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:25:0) after 1m0s
[17:01:15.955] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:25:0)
[17:01:15.955] Timer tick, asking Buildbucket for the build status
[17:01:16.034] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:16.034] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:26:0) after 1m0s
[17:02:16.711] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:26:0)
[17:02:16.711] Timer tick, asking Buildbucket for the build status
[17:02:17.030] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:17.030] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:27:0) after 1m0s
[17:03:17.208] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:27:0)
[17:03:17.208] Timer tick, asking Buildbucket for the build status
[17:03:17.364] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:17.365] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:28:0) after 1m0s
[17:04:17.456] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:28:0)
[17:04:17.456] Timer tick, asking Buildbucket for the build status
[17:04:17.534] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:17.534] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:29:0) after 1m0s
[17:05:17.673] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:29:0)
[17:05:17.673] Timer tick, asking Buildbucket for the build status
[17:05:17.747] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:17.747] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:30:0) after 1m0s
[17:06:17.973] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:30:0)
[17:06:17.973] Timer tick, asking Buildbucket for the build status
[17:06:18.038] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:18.038] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:31:0) after 1m0s
[17:07:18.173] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:31:0)
[17:07:18.173] Timer tick, asking Buildbucket for the build status
[17:07:18.247] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:18.247] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:32:0) after 1m0s
[17:08:18.346] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:32:0)
[17:08:18.346] Timer tick, asking Buildbucket for the build status
[17:08:18.509] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:18.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:33:0) after 1m0s
[17:09:19.439] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:33:0)
[17:09:19.439] Timer tick, asking Buildbucket for the build status
[17:09:19.529] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:19.529] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:34:0) after 1m0s
[17:10:19.836] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:34:0)
[17:10:19.836] Timer tick, asking Buildbucket for the build status
[17:10:19.936] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:19.936] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:35:0) after 1m0s
[17:11:20.018] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:35:0)
[17:11:20.018] Timer tick, asking Buildbucket for the build status
[17:11:20.088] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:20.088] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:36:0) after 1m0s
[17:12:20.250] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:36:0)
[17:12:20.250] Timer tick, asking Buildbucket for the build status
[17:12:20.316] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:20.316] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:37:0) after 1m0s
[17:13:20.341] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:37:0)
[17:13:20.341] Timer tick, asking Buildbucket for the build status
[17:13:20.448] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:20.448] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:38:0) after 1m0s
[17:14:20.848] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:38:0)
[17:14:20.848] Timer tick, asking Buildbucket for the build status
[17:14:20.982] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:20.982] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:39:0) after 1m0s
[17:15:21.095] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:39:0)
[17:15:21.095] Timer tick, asking Buildbucket for the build status
[17:15:21.197] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:21.197] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:40:0) after 1m0s
[17:16:22.217] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:40:0)
[17:16:22.217] Timer tick, asking Buildbucket for the build status
[17:16:22.300] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:22.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:41:0) after 1m0s
[17:17:22.344] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:41:0)
[17:17:22.344] Timer tick, asking Buildbucket for the build status
[17:17:22.415] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:22.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:42:0) after 1m0s
[17:18:22.666] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:42:0)
[17:18:22.666] Timer tick, asking Buildbucket for the build status
[17:18:22.785] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:22.785] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:43:0) after 1m0s
[17:19:22.847] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:43:0)
[17:19:22.847] Timer tick, asking Buildbucket for the build status
[17:19:23.036] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:23.036] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:44:0) after 1m0s
[17:20:23.098] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:44:0)
[17:20:23.098] Timer tick, asking Buildbucket for the build status
[17:20:23.202] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:23.202] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:45:0) after 1m0s
[17:21:23.231] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:45:0)
[17:21:23.231] Timer tick, asking Buildbucket for the build status
[17:21:23.351] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:23.351] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:46:0) after 1m0s
[17:22:23.379] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:46:0)
[17:22:23.379] Timer tick, asking Buildbucket for the build status
[17:22:23.619] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:23.619] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:47:0) after 1m0s
[17:23:23.682] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:47:0)
[17:23:23.682] Timer tick, asking Buildbucket for the build status
[17:23:23.811] Build 8865723019731434992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:23.811] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031153083242300208:48:0) after 1m0s
[17:23:38.647] Received PubSub notification, asking Buildbucket for the build status
[17:23:38.720] Build 8865723019731434992: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:23:38.720] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603387417286617",
"created_by": "project:chromium",
"created_ts": "1603384681918239",
"id": "8865723019731434992",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"08eb43cabbccab7c68a9c172091dec9c4590e9e0\"}}",
"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\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"08eb43cabbccab7c68a9c172091dec9c4590e9e0\", \"project\": \"chromium/src\"}], \"$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-178-r1ng\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 176931, \"got_angle_revision\": \"1c7f0284516ac7db02f4b9d9626d810488177b22\", \"got_dawn_revision\": \"22505a5afe1f75b402a00a27d49e313fbd6e2181\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"08eb43cabbccab7c68a9c172091dec9c4590e9e0\", \"got_revision_cp\": \"refs/heads/master@{#819865}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"d9ccb94fc2738d2c7bec626c287518c5e3ad14e9\", \"got_v8_revision_cp\": \"refs/heads/8.8.149@{#1}\", \"got_webrtc_revision\": \"7bc3356fbcb9b95ea2c810ae2f3152930d54577b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32449}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"08eb43cabbccab7c68a9c172091dec9c4590e9e0\", \"swarm_hashes_refs/heads/master(at){#819865}_without_patch\": {\"absl_hardening_tests\": \"9b2de9231a266e0e1aa2a656baeb20835fd08aee\", \"accessibility_unittests\": \"86cad6b5cbbe4b3164c20134a24cb9bc4af66220\", \"app_shell_unittests\": \"a4708e44c53e677f1f5edccb8cc6b1dd6d6dddd0\", \"aura_unittests\": \"21148bf6cf8fa2acc0f89f887b96a75a5ece4c9d\", \"base_unittests\": \"1b664c71c37c06e70b8cd83d3cd2cdf9a0e53b0d\", \"base_util_unittests\": \"45d20d0155963ea8241ce1b902348aab5a022daf\", \"blink_common_unittests\": \"6c8026c5853149eaee3edc715bf871b6fe7ef505\", \"blink_fuzzer_unittests\": \"43eb68bf694d3f04dda2a73bf4b2c3794f025e7e\", \"blink_heap_unittests\": \"1c24e9a24e59e722ef82f50874927c1483c06dd0\", \"blink_platform_unittests\": \"f4e3b76839929ef42e343b2276d5899cd9c020d3\", \"blink_python_tests\": \"247cfeb8605d18a8dc2d80b4522bdc3b262d4903\", \"blink_unittests\": \"3ba71f3ca5eb04fe2bd0a850805a0b6e9e170e4e\", \"blink_web_tests\": \"252fe0c5f5dde54dd5b06d29470ec2bbb5fa296e\", \"boringssl_crypto_tests\": \"1671c8effa479ab466acb3e3d661223925664bc6\", \"boringssl_ssl_tests\": \"9c86b1006574ee944380b123dd51bdfc6c6aa2fa\", \"browser_tests\": \"675c800a87d34bde4cd7a136398593ea33ea4f90\", \"capture_unittests\": \"52d8b396927463fae1fdaae5ff33f03fc25632d5\", \"cast_unittests\": \"5b041aaedd55eb21156bd7e4eed27723fdb45da5\", \"cc_unittests\": \"efd41f6b474675baaffa260bb0455866c6afba9f\", \"chrome_app_unittests\": \"cb7f9129b6ebfd28a2b6022671022d4f6add5391\", \"chromedriver_unittests\": \"c42a2726ad9c56c4cd9e9345da92ae94204be27c\", \"components_browsertests\": \"84b6c5d155eb1a753d68b660f8c1bb4b4ab1ad6f\", \"components_unittests\": \"26dca3a9ab39bff64e194e1574e241d10f80eac8\", \"compositor_unittests\": \"ce56b6ffcba6b25b0350c3e999e2d3a0f3c9a17b\", \"content_browsertests\": \"d4d700d73392bb18202bf1f596b463135e9f34bc\", \"content_shell_crash_test\": \"b45fd2d5d6613c0007154ef1cafe9d5e44c0770f\", \"content_unittests\": \"fd6af5de6444e3aff8533c98a13167cf2a7a44f0\", \"crashpad_tests\": \"793fc3816af20993ab1d63dbb23352ec09edde04\", \"cronet_tests\": \"cd02215a7eaf2aa2214c2916d4e8d722aa5ebd2c\", \"cronet_unittests\": \"791c6f2ef865916692f14dcb148ac7cdcd95961e\", \"crypto_unittests\": \"ba06258f913dd7fbf23aee8014bd0416169bbe7f\", \"dbus_unittests\": \"48b4d365bd2ba8ea5cedf86c4cb1fa5416894df4\", \"device_unittests\": \"20f4b5fd9c84466dcb5526e7879c313d8500dad3\", \"display_unittests\": \"6cbe767faabfe81c92708633d9d7d6f5ae821478\", \"events_unittests\": \"df335ed9758e65cbb13c388feb53e593232c1cfa\", \"extension_docserver_python_unittests\": \"5ce8706bf1bcd0e614c1d430b0fb04a1752cf91b\", \"extensions_browsertests\": \"338b5aecc54b219393b6b74927dfda0621cd7e0d\", \"extensions_unittests\": \"7cc0ac4cdfb5c8fc9ebf9f17a9f6848b62e8b874\", \"filesystem_service_unittests\": \"3991605027065641c7e63401d907b4e7166c3d04\", \"flatbuffers_unittests\": \"7c821f13730963d6e07deae074f4fffab315d766\", \"gcm_unit_tests\": \"57cb49d052a3db163a392f6fb6d9833a3ca66ec3\", \"gfx_unittests\": \"c26b44c58afdbaf63b952a77ed3e318fdac8be03\", \"gin_unittests\": \"b5af6645172a0ddeff3833c0e9a3dfec52d2c6a7\", \"google_apis_unittests\": \"c5fce7209153bd937cd34d2ebe5ae344e4014595\", \"gpu_unittests\": \"ece41c183eda114535f129c73d6b2c13e59838ca\", \"grit_python_unittests\": \"7dc5d02c4d4eada48c5118267a3b8d2d04c35fca\", \"gwp_asan_unittests\": \"e76759720c8fa7a48a10e0ecfd8d7bfa0e13aba3\", \"headless_browsertests\": \"886da7a5009d91600b3faec7c32193d1ab900df0\", \"headless_unittests\": \"1d50505ebe7cf291e351605fb717d082d22d9867\", \"interactive_ui_tests\": \"f5f002f87f202eb2ae32544ad1343d2aa783e11f\", \"ipc_tests\": \"bfbc3b1f766ea226c32d6fd56705db1014604391\", \"jingle_unittests\": \"5cf1f79941d5f075504113065611b2e9253a129f\", \"latency_unittests\": \"f99f25de3f97b8c863a1cd1d7e636b157a352ac2\", \"libjingle_xmpp_unittests\": \"412f1f712e8f0a1f579d66c7eaf957efdfa82cfb\", \"media_blink_unittests\": \"ae55fe523a0e4f32026d871fc7aa1c8b76087c12\", \"media_unittests\": \"6ca43f43418c40a5e51809fbb86fbf8e6343e1bb\", \"message_center_unittests\": \"7d33a98041dd58dba3a9925aaeca9bca2e614b9a\", \"metrics_python_tests\": \"2c0847ba2b0c1a2fe30d6d3f5c5e944918b7c20a\", \"midi_unittests\": \"941089aaa688eea69464e5e4323311c8e50c4dfc\", \"mojo_core_unittests\": \"407aeefaecc315241c8d80ca0335cc6964ed0446\", \"mojo_unittests\": \"5f36c76bec135f7e782bd71a52fda57ce96fcef1\", \"nacl_helper_nonsfi_unittests\": \"dafa284a3294a5473aebbf4566a3229263303095\", \"nacl_loader_unittests\": \"35d30ff3ebad12cb8c321e7f8eff4f217507548a\", \"native_theme_unittests\": \"dc5bf0fa0e940c0e8bdb852c9f873bc14005dad3\", \"net_unittests\": \"b33b6d1203b64e5d491ecdc1795b25b23a2715b0\", \"openscreen_unittests\": \"7b6c7d6f0db937071e63302cd4ef6a4d08c0d701\", \"pdf_unittests\": \"a07488bb2cc46e8b3c96dfcc1b7b9d709fdb7f91\", \"perfetto_unittests\": \"99cc4c4e0e1669fc198873d7ab4922e56c579179\", \"ppapi_unittests\": \"6126f0ca943035e99a693ce66951e6fae0bdd900\", \"printing_unittests\": \"971bdcc9c67774f5abf2d96985a18a65a5428b24\", \"remoting_unittests\": \"69dc6c2e66c4ef3fdd99a1a8df63459f86ce83f7\", \"sandbox_linux_unittests\": \"396b501762cd7460c749b30527018bd041dc4b5d\", \"service_manager_unittests\": \"f8f5865615bef7c6beea2881615952913a4409b0\", \"services_unittests\": \"4526c541b629e85fa6887b741be8965b37dfad30\", \"shell_dialogs_unittests\": \"9180b5b114d73290d09a634159e7411d8aba48bc\", \"skia_unittests\": \"16a28d67e971b969bbd700c5d16b3010ea4c39d6\", \"snapshot_unittests\": \"b07678af49b453175bca74917728c1abd03c7522\", \"sql_unittests\": \"89ea4a0200f39c9cd79556b8d23b4d3145210319\", \"standalone_angle_unittests\": \"a75b9950df5b58ee136186e4922f2ca7bfab55ba\", \"storage_unittests\": \"81ba5e8834fab972e2d8a842c08ff5228c370b21\", \"sync_integration_tests\": \"fd6c606505f25ffeb3b5f2a50d2704428ecc5be5\", \"telemetry_gpu_unittests\": \"02b99e0e1de29c4f6d02c8274cf42cffe1d86466\", \"telemetry_perf_unittests\": \"d21cba2119d9aefb667a75e7989f5dfffe9a09e8\", \"telemetry_unittests\": \"abfd23c37bc7a6b199979a4c291b14bdc0ff4550\", \"traffic_annotation_auditor_unittests\": \"317b05641b5e47d7b734429eabdddfadf21411f7\", \"ui_base_unittests\": \"996401e821ce98554a750a71b5561106f6be3f00\", \"ui_touch_selection_unittests\": \"9b15cd2957950f904dc645ec2a3b40ce9892e03d\", \"unit_tests\": \"b1818cbc59824f96b9b58a8d7fb8fafceee3669f\", \"url_unittests\": \"922d8830876f8b2ae8f79f0980b1ea1c9c36fb61\", \"views_perftests\": \"6e1275451393138e4e7d331ae3c81bcc315f3631\", \"views_unittests\": \"f25d867b342a7938c42df8328b4278be170674fa\", \"viz_unittests\": \"3b4052b299e9c046ececefe9cc958a2708ef9f93\", \"vr_common_unittests\": \"a53367cca7547357c7f606df8e4eff8a4bfd3b30\", \"vr_pixeltests\": \"c0f56cf9fe9f7f7b8f24a2fbd90e013f1926fa2e\", \"webdriver_wpt_tests\": \"ffde68980533c84d4a15609f94243b00dcc7c623\", \"weblayer_browsertests\": \"f69a17d84493e8cfac7acaf858a62b5bdd827de7\", \"weblayer_unittests\": \"501da19c7a0ea251e79de126a338d7fefa1b425e\", \"wm_unittests\": \"a67678c6b9752a848a1133a01cb45e4f012799b3\", \"wtf_unittests\": \"e411d7598bdeb96ee67d113275a55c7ff689a1b0\", \"x11_unittests\": \"3dc2aed3a881a305e667706a953a000059c912fa\", \"xr_browser_tests\": \"6b7017a9aaa87afc6148cfdd73e0a3054c43f159\", \"zlib_unittests\": \"8551000525e25f17069a9452d82ac4fad877360d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1b8c0e295e0040ae60b46798151163eecc632ef935bd1ea9777aec71f94caa4f_v2\", \"builder_439308a62373488b965450387292170d4ea9c14a8841f8eafa3bc91f493efcbf_v2\", \"builder_8e35dc9d0a811a7a5937b2845f7d6ff611dfc73c6ea10d73e1df62dc95746f2a_v2\", \"builder_9efb94071a208cb32f222f9589b2bf8c6e9d4ebc7884b1b49bd19cd2b21dc48e_v2\", \"builder_c6f1473df00e57847ed4ff0f74718f3dfb2a5d42012d3d3fe6b396b4c9a29f62_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-178-r1ng\"], \"image\": [\"chrome-xenial-20101600-2d400e1627f\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5612-26d29a7\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603384684981680",
"status": "COMPLETED",
"status_changed_ts": "1603387418060717",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176931",
"builder:Linux Builder (dbg)",
"buildset:commit/git/08eb43cabbccab7c68a9c172091dec9c4590e9e0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/08eb43cabbccab7c68a9c172091dec9c4590e9e0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031153083242300208",
"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/8865723019731434992/+/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:4f69fe30120c0010",
"user_agent:luci-scheduler"
],
"updated_ts": "1603387418096766",
"url": "https://ci.chromium.org/b/8865723019731434992",
"utcnow_ts": "1603387418710333"
}
}
[17:23:38.720] Invocation finished in 45m39.533934668s with status SUCCEEDED