[04:24:10.151] New invocation is queued and will start shortly
[04:24:11.226] Starting the invocation (attempt 1)
[04:24:11.265] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:24:11.265] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:24:11.265] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9054120283549440560",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3b1fd5e700b1862a8dcf003a8257dfcc3960d118\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9054120283549440560",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/3b1fd5e700b1862a8dcf003a8257dfcc3960d118",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3b1fd5e700b1862a8dcf003a8257dfcc3960d118",
"gitiles_ref:refs/heads/master"
]
}
[04:24:12.737] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1581481451802237",
"id": "8888690221153437904",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3b1fd5e700b1862a8dcf003a8257dfcc3960d118\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1581481452542204",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168502",
"builder:Linux Builder (dbg)",
"buildset:commit/git/3b1fd5e700b1862a8dcf003a8257dfcc3960d118",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3b1fd5e700b1862a8dcf003a8257dfcc3960d118",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054120283549440560",
"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/8888690221153437904/+/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": "1581481452543042",
"url": "https://ci.chromium.org/b/8888690221153437904",
"utcnow_ts": "1581481452731197"
}
}
[04:24:12.737] Task URL: https://ci.chromium.org/b/8888690221153437904
[04:24:12.737] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:2:0) after 1m0s
[04:24:42.768] Received PubSub notification, asking Buildbucket for the build status
[04:24:42.912] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:12.861] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:2:0)
[04:25:12.861] Timer tick, asking Buildbucket for the build status
[04:25:14.119] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:14.119] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:4:0) after 1m0s
[04:26:14.180] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:4:0)
[04:26:14.180] Timer tick, asking Buildbucket for the build status
[04:26:14.321] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:14.321] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:5:0) after 1m0s
[04:27:14.355] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:5:0)
[04:27:14.355] Timer tick, asking Buildbucket for the build status
[04:27:14.609] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:14.609] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:6:0) after 1m0s
[04:28:14.621] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:6:0)
[04:28:14.621] Timer tick, asking Buildbucket for the build status
[04:28:15.689] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:15.689] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:7:0) after 1m0s
[04:29:15.700] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:7:0)
[04:29:15.700] Timer tick, asking Buildbucket for the build status
[04:29:16.252] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:16.252] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:8:0) after 1m0s
[04:30:16.258] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:8:0)
[04:30:16.258] Timer tick, asking Buildbucket for the build status
[04:30:16.454] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:16.454] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:9:0) after 1m0s
[04:31:16.580] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:9:0)
[04:31:16.580] Timer tick, asking Buildbucket for the build status
[04:31:16.808] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:16.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:10:0) after 1m0s
[04:32:16.833] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:10:0)
[04:32:16.833] Timer tick, asking Buildbucket for the build status
[04:32:17.666] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:17.666] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:11:0) after 1m0s
[04:33:17.693] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:11:0)
[04:33:17.693] Timer tick, asking Buildbucket for the build status
[04:33:17.938] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:17.938] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:12:0) after 1m0s
[04:34:18.094] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:12:0)
[04:34:18.094] Timer tick, asking Buildbucket for the build status
[04:34:19.261] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:19.262] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:13:0) after 1m0s
[04:35:19.321] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:13:0)
[04:35:19.321] Timer tick, asking Buildbucket for the build status
[04:35:19.489] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:19.489] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:14:0) after 1m0s
[04:36:19.619] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:14:0)
[04:36:19.619] Timer tick, asking Buildbucket for the build status
[04:36:19.878] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:19.878] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:15:0) after 1m0s
[04:37:19.960] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:15:0)
[04:37:19.960] Timer tick, asking Buildbucket for the build status
[04:37:20.217] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:20.217] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:16:0) after 1m0s
[04:38:20.346] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:16:0)
[04:38:20.346] Timer tick, asking Buildbucket for the build status
[04:38:20.524] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:20.524] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:17:0) after 1m0s
[04:39:20.718] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:17:0)
[04:39:20.718] Timer tick, asking Buildbucket for the build status
[04:39:20.849] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:20.849] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:18:0) after 1m0s
[04:40:20.934] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:18:0)
[04:40:20.934] Timer tick, asking Buildbucket for the build status
[04:40:21.086] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:21.087] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:19:0) after 1m0s
[04:41:21.133] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:19:0)
[04:41:21.133] Timer tick, asking Buildbucket for the build status
[04:41:21.284] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:21.284] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:20:0) after 1m0s
[04:42:21.327] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:20:0)
[04:42:21.327] Timer tick, asking Buildbucket for the build status
[04:42:21.484] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:21.484] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:21:0) after 1m0s
[04:43:21.564] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:21:0)
[04:43:21.564] Timer tick, asking Buildbucket for the build status
[04:43:21.714] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:21.714] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:22:0) after 1m0s
[04:44:21.781] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:22:0)
[04:44:21.781] Timer tick, asking Buildbucket for the build status
[04:44:21.927] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:21.927] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:23:0) after 1m0s
[04:45:22.040] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:23:0)
[04:45:22.040] Timer tick, asking Buildbucket for the build status
[04:45:22.203] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:22.203] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:24:0) after 1m0s
[04:46:22.329] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:24:0)
[04:46:22.329] Timer tick, asking Buildbucket for the build status
[04:46:22.586] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:22.586] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:25:0) after 1m0s
[04:47:22.658] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:25:0)
[04:47:22.658] Timer tick, asking Buildbucket for the build status
[04:47:22.838] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:22.838] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:26:0) after 1m0s
[04:48:22.875] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:26:0)
[04:48:22.875] Timer tick, asking Buildbucket for the build status
[04:48:23.141] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:23.141] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:27:0) after 1m0s
[04:49:23.323] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:27:0)
[04:49:23.323] Timer tick, asking Buildbucket for the build status
[04:49:23.651] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:23.651] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:28:0) after 1m0s
[04:50:23.674] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:28:0)
[04:50:23.674] Timer tick, asking Buildbucket for the build status
[04:50:23.811] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:23.811] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:29:0) after 1m0s
[04:51:23.886] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:29:0)
[04:51:23.886] Timer tick, asking Buildbucket for the build status
[04:51:24.067] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:24.067] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:30:0) after 1m0s
[04:52:24.167] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:30:0)
[04:52:24.167] Timer tick, asking Buildbucket for the build status
[04:52:24.362] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:24.362] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:31:0) after 1m0s
[04:53:24.411] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:31:0)
[04:53:24.411] Timer tick, asking Buildbucket for the build status
[04:53:24.921] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:24.921] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:32:0) after 1m0s
[04:54:25.019] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:32:0)
[04:54:25.019] Timer tick, asking Buildbucket for the build status
[04:54:25.685] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:25.685] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:33:0) after 1m0s
[04:55:25.771] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:33:0)
[04:55:25.771] Timer tick, asking Buildbucket for the build status
[04:55:25.973] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:25.973] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:34:0) after 1m0s
[04:56:26.095] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:34:0)
[04:56:26.095] Timer tick, asking Buildbucket for the build status
[04:56:26.271] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:26.271] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:35:0) after 1m0s
[04:57:26.364] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:35:0)
[04:57:26.364] Timer tick, asking Buildbucket for the build status
[04:57:26.537] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:26.537] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:36:0) after 1m0s
[04:58:26.635] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:36:0)
[04:58:26.635] Timer tick, asking Buildbucket for the build status
[04:58:26.795] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:26.795] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:37:0) after 1m0s
[04:59:26.830] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:37:0)
[04:59:26.830] Timer tick, asking Buildbucket for the build status
[04:59:26.957] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:26.957] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:38:0) after 1m0s
[05:00:26.988] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:38:0)
[05:00:26.988] Timer tick, asking Buildbucket for the build status
[05:00:28.849] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:28.849] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:39:0) after 1m0s
[05:01:28.957] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:39:0)
[05:01:28.957] Timer tick, asking Buildbucket for the build status
[05:01:29.192] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:29.192] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:40:0) after 1m0s
[05:02:29.302] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:40:0)
[05:02:29.302] Timer tick, asking Buildbucket for the build status
[05:02:29.754] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:29.754] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:41:0) after 1m0s
[05:03:29.803] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:41:0)
[05:03:29.803] Timer tick, asking Buildbucket for the build status
[05:03:30.064] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:30.064] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:42:0) after 1m0s
[05:04:30.163] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:42:0)
[05:04:30.163] Timer tick, asking Buildbucket for the build status
[05:04:30.652] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:30.652] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:43:0) after 1m0s
[05:05:30.731] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:43:0)
[05:05:30.731] Timer tick, asking Buildbucket for the build status
[05:05:31.258] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:31.258] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:44:0) after 1m0s
[05:06:31.373] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:44:0)
[05:06:31.373] Timer tick, asking Buildbucket for the build status
[05:06:31.801] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:31.801] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:45:0) after 1m0s
[05:07:31.822] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:45:0)
[05:07:31.822] Timer tick, asking Buildbucket for the build status
[05:07:32.605] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:32.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:46:0) after 1m0s
[05:08:32.631] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:46:0)
[05:08:32.631] Timer tick, asking Buildbucket for the build status
[05:08:33.229] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:33.229] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:47:0) after 1m0s
[05:09:33.267] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:47:0)
[05:09:33.267] Timer tick, asking Buildbucket for the build status
[05:09:33.719] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:33.719] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:48:0) after 1m0s
[05:10:33.760] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:48:0)
[05:10:33.761] Timer tick, asking Buildbucket for the build status
[05:10:34.353] Build 8888690221153437904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:34.353] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054120283549440560:49:0) after 1m0s
[05:10:51.571] Received PubSub notification, asking Buildbucket for the build status
[05:10:52.250] Build 8888690221153437904: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:10:52.250] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1581484250972661",
"created_by": "project:chromium",
"created_ts": "1581481451802237",
"id": "8888690221153437904",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3b1fd5e700b1862a8dcf003a8257dfcc3960d118\"}}",
"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-83-xzw4\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168502, \"got_angle_revision\": \"e1ccac7ff9f088c841a4393b633be402012cfb92\", \"got_dawn_revision\": \"2fd618192985122aafb494ac5e9a39f572ef46fc\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"3b1fd5e700b1862a8dcf003a8257dfcc3960d118\", \"got_revision_cp\": \"refs/heads/master@{#740556}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"6cbb02e0dc934ac1e21b182f0f632b4e806449a6\", \"got_v8_revision\": \"56ab990e69987df228757938e23a9bafccab2fe5\", \"got_v8_revision_cp\": \"refs/heads/8.2.57@{#1}\", \"got_webrtc_revision\": \"d4c3c3a454215b21f02d2a772a729b4c87d6b33e\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30486}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3b1fd5e700b1862a8dcf003a8257dfcc3960d118\", \"swarm_hashes_refs/heads/master(at){#740556}_without_patch\": {\"accessibility_unittests\": \"a694aaf0e68ecfc4b81914dae20247d16f8aa305\", \"angle_unittests\": \"1c11af93e0bf8397aabae070796ca366e775950a\", \"app_shell_unittests\": \"d7b15cf5547e14c49bf2fc2bb1a14ab4c990beb0\", \"aura_unittests\": \"f483c2e99908fb48347e351af818cb3df6eea5e7\", \"base_unittests\": \"40007b4d86480d33baafaaf82cd01e803aa08cb8\", \"base_util_unittests\": \"fec655806adb25aa0455b1c1dc55f38e1c6cb58f\", \"blink_common_unittests\": \"5356a2b19f0a1ea12c1fcb35248e5e9545dda206\", \"blink_fuzzer_unittests\": \"eb4f84034969f024dd2eb4914886c1ea383c28d1\", \"blink_heap_unittests\": \"162dc9a319d675e71048e2da4c5a8aa518aea58e\", \"blink_platform_unittests\": \"09c5d1b29f67f612c857cbf0641de639abba4d62\", \"blink_python_tests\": \"66909fb4e1499e7733c5eb95536ed9ce6fc49608\", \"blink_unittests\": \"14a6543a035500659e36c7ff04327e19fb8bbf84\", \"blink_web_tests\": \"a65ab74f89bdb21c4bec5fe0ab724580ae64d12c\", \"boringssl_crypto_tests\": \"b431d9c10e0e691f8114025cb8a7758b7354828e\", \"boringssl_ssl_tests\": \"3174629a785aa144356ee3fb009e7e76637b6c17\", \"browser_tests\": \"9d84fb056fdb24bafeb0e4227326e09842a52136\", \"cacheinvalidation_unittests\": \"8bb66ebe1fd63a9109e966a966d2366dce23df05\", \"capture_unittests\": \"628fbf599823087109160ed8cba4dc6fa74df6b0\", \"cast_unittests\": \"f166853bc4bd90ff39efe7f74381d14b616aca14\", \"cc_unittests\": \"76e975de8a5af21b2767f4e7a0b136df1ca77664\", \"chrome_app_unittests\": \"e13a319bc9de7e19eb025403e704ee17ff9482bb\", \"chromedriver_unittests\": \"09196bf0b2a24e11bbcc7be93e96571c7442b09b\", \"components_browsertests\": \"d1e0aab4672a1422582a458e5154567c77bab671\", \"components_unittests\": \"34e77f275a2c35d8d19270f6b697a40eb4f097c4\", \"compositor_unittests\": \"b985afe312fa6647d1d57f8bf25fc3fe3640fe3a\", \"content_browsertests\": \"d937805a55067e5c6d5aa4af8ea77946ccb2fdc9\", \"content_shell_crash_test\": \"4f812f0ec75fa270a41bad5476645847f691096e\", \"content_unittests\": \"9975c207fd3075d968241fc975bf7b33d7fec457\", \"crashpad_tests\": \"ec75d37dc8fad08c60c1feeadacbbd76a35e82b4\", \"cronet_tests\": \"50ac60992a4ff8f579e7cf7657e4980633f5dbee\", \"cronet_unittests\": \"8fa2d8576f22517111eb889c8c02be815d39131e\", \"crypto_unittests\": \"a25a335f76c04c794b33f3d50fc599b73cbefca3\", \"dbus_unittests\": \"6dd1ce165c8b3c581f1b5cb07ab2f79b51ab5693\", \"device_unittests\": \"f6f7baabc09f4aba55eb6d5f635f77c9dd0961d9\", \"display_unittests\": \"251f909a5cb1cb935d1ef2b7d60295cfe5672ff8\", \"events_unittests\": \"104ecf6b687b1eec85e05a67ba49627a634a04d5\", \"extensions_browsertests\": \"78b988499e1a98af34437932a10ebf8dd5f06542\", \"extensions_unittests\": \"a07b20bd6b4fb41f3b7b9aba21e1f75861986a3d\", \"filesystem_service_unittests\": \"e8beca5466babbe21f822b923e5da0853ef728b3\", \"flatbuffers_unittests\": \"9eab69acab0f6bd1460710d9ac6e8475de73625c\", \"gcm_unit_tests\": \"c89ef6a8d2fd2ce76160db819aee1de1c72f3f50\", \"gfx_unittests\": \"f85238c58e261480027f0761651d8fe471da29de\", \"gin_unittests\": \"f0b3e71fbeb09b035e6e5415145f6467da2c564f\", \"google_apis_unittests\": \"d019f1b299b68af3aaa70f2fc963e77bf81a9b20\", \"gpu_unittests\": \"5d38845d10be9fb06fc9e215e2cb5b33a6b80b80\", \"grit_python_unittests\": \"07488c096d20bb2a4e6d9280813fca6afbee6dc0\", \"gwp_asan_unittests\": \"f8db7f6d16cfb86de0453cd3fd01c1fb75daaa4d\", \"headless_browsertests\": \"441f1017504921db75fd98e05476e8e98bbe8c16\", \"headless_unittests\": \"5d4a88f7b3cd3ace88bfec42664213a5492f7f1e\", \"interactive_ui_tests\": \"840dd3fa884c4a7929326fc4d3023e83f7b03ba9\", \"ipc_tests\": \"e7e3666711459b7defb2c9eeadb5b7c84ff542b8\", \"jingle_unittests\": \"600f29cd773eb799a6529c5638700d22da125d2f\", \"latency_unittests\": \"58ec2286986e38a08fd7c323aeb5e8e32e6cb351\", \"libjingle_xmpp_unittests\": \"1fafd9711094fecb4293bc2f62369dbd2550ad5b\", \"media_blink_unittests\": \"e158940689c2c86b340f32adb2205c197ce94a71\", \"media_service_unittests\": \"9df167eb314b32bb4b2361ca04bf637893127c48\", \"media_unittests\": \"f821fd065cc0ef6626e7e6c6db10d955036259f0\", \"message_center_unittests\": \"406aee73c2cc47603f9c687fc36b753c092eb522\", \"metrics_python_tests\": \"baae824a2f2ef97e413e6c117dbc6ab9f3467a87\", \"midi_unittests\": \"22dad53ed0cde4bee032d037594c09ec103b0470\", \"mojo_core_unittests\": \"baa40b90d445e56571704070c6fab3c333a1e6e1\", \"mojo_unittests\": \"c7b60397228864a22539ae07f314523804907a7e\", \"nacl_helper_nonsfi_unittests\": \"a33f7c68729f10c173a87595856239d628714681\", \"nacl_loader_unittests\": \"cb86a8dd4c9d36b3be7c60aa1b4a32134844db41\", \"native_theme_unittests\": \"32f67017cf2100dceee0607286bd7992ba4e37ff\", \"net_unittests\": \"44e33cade02be3654259d457d719840bc990ec3e\", \"pdf_unittests\": \"7d88a23db7a1bf633310a358c0be2693f6958590\", \"perfetto_unittests\": \"ce6431570c88a01311ecd13fc058fb2b2700a6ad\", \"ppapi_unittests\": \"6d7651ef1fcca64651e090d46089542dcc9fe544\", \"printing_unittests\": \"2f6223d19690d9b3a73cd81d230300b71bf67f3e\", \"remoting_unittests\": \"ff627e29d8113bf9303cb5b9003a77504e393786\", \"sandbox_linux_unittests\": \"36d18bc0e90dc8d1020d2cd6162a5f7c7c134607\", \"service_manager_unittests\": \"072a4cd2292d303da1f596012701987b0c5df878\", \"services_unittests\": \"cad8cc16b29b1d8e996424168468788a9218710f\", \"shell_dialogs_unittests\": \"304adf82720526353b532dae8fb01c94af49cc64\", \"skia_unittests\": \"71c28bf260d10645b98b225b92fbac519137bac6\", \"snapshot_unittests\": \"b1268c8649d77f6a0edd49e1758ebbc46e82907d\", \"sql_unittests\": \"b1d6675db201737c7dd9ca6e7440af9bc9f9670b\", \"storage_unittests\": \"7d59167902b34164bb00e3db1fa76c40b4cff00e\", \"sync_integration_tests\": \"eb5e85eda44aa1de57394c12a1601fdca5c0ea06\", \"telemetry_gpu_unittests\": \"aa1af2292dd72bc2480d97265210e0893a024d91\", \"telemetry_perf_unittests\": \"28789a5c908552be1856d4493f5c2b6c7d8a24b9\", \"telemetry_unittests\": \"b97d03749466fd1f8f0f6da0e90e2177379ecb07\", \"traffic_annotation_auditor_unittests\": \"ff1cef85b5f21821757efa081b29b5442e845e66\", \"ui_base_unittests\": \"95a0d12e177aa494047167418f8512bdd07b113e\", \"ui_touch_selection_unittests\": \"d725b382e48bb5ff83873f552da732ab25112650\", \"unit_tests\": \"976e1adc704b8cf8661dece6f3af98c01e7e337f\", \"url_unittests\": \"cee860a07e8eb33c1973f780b006aa32e84c7089\", \"views_perftests\": \"53eecd8e63a810e845dee9ad7b8158a844e10f49\", \"views_unittests\": \"3f4f4c6dcd910d318495028a2924128fd55a4bd1\", \"viz_unittests\": \"71cdd70c269097fb4ed5dad888a34deceabc03f1\", \"vr_common_unittests\": \"c0128149cbe8dc61efdcff04896351d22cfcbdd9\", \"vr_pixeltests\": \"6e6680d35fe41685c23e06e053217fd580fa94d4\", \"webdriver_wpt_tests\": \"55ee69bd0afe18870609559bec71d291aab97b1f\", \"weblayer_browsertests\": \"d396d485be327dc483a033937eeea1dee8c34095\", \"wm_unittests\": \"844183dc0cf87f884ff1652bd991d706df51bce2\", \"wtf_unittests\": \"bb08e1035835efed28c31eb073e9ca1a87fd32d9\", \"xr_browser_tests\": \"7e036927cecd06eaee665304ae22b5175225db44\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_5018db700e530f8e7ae860b5b3feab2b02d3dedf1bbd3e704c6c59fde1b308dd_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-83-xzw4\"], \"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\": [\"4812-ea7e8fc\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1581481481884248",
"status": "COMPLETED",
"status_changed_ts": "1581484251255281",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168502",
"builder:Linux Builder (dbg)",
"buildset:commit/git/3b1fd5e700b1862a8dcf003a8257dfcc3960d118",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3b1fd5e700b1862a8dcf003a8257dfcc3960d118",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054120283549440560",
"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/8888690221153437904/+/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:4a50756e79d51310",
"user_agent:luci-scheduler"
],
"updated_ts": "1581484251264731",
"url": "https://ci.chromium.org/b/8888690221153437904",
"utcnow_ts": "1581484252238616"
}
}
[05:10:52.250] Invocation finished in 46m42.115873668s with status SUCCEEDED