[15:04:26.252] New invocation is queued and will start shortly
[15:04:27.380] Starting the invocation (attempt 1)
[15:04:27.411] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:04:27.413] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:04:27.413] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9017660020852886992",
"parameters_json": "{\"builder_name\":\"android-code-coverage-native\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"8373ebc7eb9ca8fe3cd58af41c2f6d09cc5a081c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-code-coverage-native",
"scheduler_invocation_id:9017660020852886992",
"scheduler_job_id:chromium/android-code-coverage-native",
"user_agent:luci-scheduler",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8373ebc7eb9ca8fe3cd58af41c2f6d09cc5a081c",
"gitiles_ref:refs/heads/master"
]
}
[15:04:28.003] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1616252667488620",
"id": "8852229958894081568",
"parameters_json": "{\"builder_name\": \"android-code-coverage-native\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8373ebc7eb9ca8fe3cd58af41c2f6d09cc5a081c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1616252667882705",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage-native/9352",
"builder:android-code-coverage-native",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8373ebc7eb9ca8fe3cd58af41c2f6d09cc5a081c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017660020852886992",
"scheduler_job_id:chromium/android-code-coverage-native",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852229958894081568/+/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": "1616252667882812",
"url": "https://ci.chromium.org/b/8852229958894081568",
"utcnow_ts": "1616252667996360"
}
}
[15:04:28.003] Task URL: https://ci.chromium.org/b/8852229958894081568
[15:04:28.003] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:2:0) after 1m0s
[15:05:28.117] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:2:0)
[15:05:28.142] Build status: SCHEDULED
[15:05:28.142] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:3:0) after 4m51s
[15:10:19.214] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:3:0)
[15:10:19.239] Build status: SCHEDULED
[15:10:19.239] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:4:0) after 3m56s
[15:14:15.255] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:4:0)
[15:14:15.279] Build status: SCHEDULED
[15:14:15.279] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:5:0) after 7m57s
[15:22:12.397] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:5:0)
[15:22:12.432] Build status: SCHEDULED
[15:22:12.432] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:6:0) after 3m27s
[15:25:39.416] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:6:0)
[15:25:39.458] Build status: SCHEDULED
[15:25:39.458] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:7:0) after 8m32s
[15:34:11.477] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:7:0)
[15:34:11.519] Build status: SCHEDULED
[15:34:11.519] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:8:0) after 9m42s
[15:41:48.601] Received PubSub notification, asking Buildbucket for the build status
[15:41:48.870] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:53.909] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:8:0)
[15:43:53.909] Timer tick, asking Buildbucket for the build status
[15:43:54.156] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:54.156] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:10:0) after 1m0s
[15:44:54.173] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:10:0)
[15:44:54.201] Build status: STARTED
[15:44:54.201] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:11:0) after 2m58s
[15:47:52.267] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:11:0)
[15:47:52.267] Timer tick, asking Buildbucket for the build status
[15:47:52.380] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:52.380] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:12:0) after 1m0s
[15:48:52.579] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:12:0)
[15:48:52.579] Timer tick, asking Buildbucket for the build status
[15:48:52.784] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:52.784] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:13:0) after 1m0s
[15:49:52.856] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:13:0)
[15:49:52.885] Build status: STARTED
[15:49:52.885] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:14:0) after 3m41s
[15:53:33.962] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:14:0)
[15:53:33.986] Build status: STARTED
[15:53:33.986] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:15:0) after 9m59s
[16:03:33.015] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:15:0)
[16:03:33.015] Timer tick, asking Buildbucket for the build status
[16:03:33.096] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:33.096] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:16:0) after 1m0s
[16:04:33.113] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:16:0)
[16:04:33.140] Build status: STARTED
[16:04:33.140] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:17:0) after 4m44s
[16:09:17.168] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:17:0)
[16:09:17.245] Build status: STARTED
[16:09:17.245] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:18:0) after 5m58s
[16:15:15.268] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:18:0)
[16:15:15.293] Build status: STARTED
[16:15:15.293] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:19:0) after 2m26s
[16:17:41.333] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:19:0)
[16:17:41.333] Timer tick, asking Buildbucket for the build status
[16:17:41.462] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:41.462] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:20:0) after 1m0s
[16:18:41.441] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:20:0)
[16:18:41.487] Build status: STARTED
[16:18:41.487] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:21:0) after 5m41s
[16:24:22.508] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:21:0)
[16:24:22.544] Build status: STARTED
[16:24:22.544] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:22:0) after 2m12s
[16:26:34.653] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:22:0)
[16:26:34.653] Timer tick, asking Buildbucket for the build status
[16:26:34.786] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:34.786] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:23:0) after 1m0s
[16:27:34.803] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:23:0)
[16:27:34.803] Timer tick, asking Buildbucket for the build status
[16:27:34.884] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:34.884] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:24:0) after 1m0s
[16:28:34.904] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:24:0)
[16:28:34.904] Timer tick, asking Buildbucket for the build status
[16:28:34.971] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:34.971] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:25:0) after 1m0s
[16:29:34.955] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:25:0)
[16:29:34.955] Timer tick, asking Buildbucket for the build status
[16:29:35.168] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:35.168] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:26:0) after 1m0s
[16:30:35.251] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:26:0)
[16:30:35.251] Timer tick, asking Buildbucket for the build status
[16:30:35.397] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:35.397] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:27:0) after 1m0s
[16:31:35.416] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:27:0)
[16:31:35.416] Timer tick, asking Buildbucket for the build status
[16:31:35.584] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:35.584] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:28:0) after 1m0s
[16:32:35.614] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:28:0)
[16:32:35.641] Build status: STARTED
[16:32:35.641] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:29:0) after 4m23s
[16:36:58.757] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:29:0)
[16:36:58.790] Build status: STARTED
[16:36:58.790] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:30:0) after 9m4s
[16:46:02.863] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:30:0)
[16:46:02.863] Timer tick, asking Buildbucket for the build status
[16:46:02.959] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:02.959] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:31:0) after 1m0s
[16:47:03.112] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:31:0)
[16:47:03.112] Timer tick, asking Buildbucket for the build status
[16:47:03.321] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:03.321] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:32:0) after 1m0s
[16:48:03.414] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:32:0)
[16:48:03.414] Timer tick, asking Buildbucket for the build status
[16:48:03.500] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:03.500] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:33:0) after 1m0s
[16:49:03.669] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:33:0)
[16:49:03.669] Timer tick, asking Buildbucket for the build status
[16:49:03.818] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:03.818] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:34:0) after 1m0s
[16:50:03.966] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:34:0)
[16:50:03.966] Timer tick, asking Buildbucket for the build status
[16:50:04.086] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:04.086] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:35:0) after 1m0s
[16:51:04.171] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:35:0)
[16:51:04.172] Timer tick, asking Buildbucket for the build status
[16:51:04.253] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:04.253] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:36:0) after 1m0s
[16:52:04.339] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:36:0)
[16:52:04.339] Timer tick, asking Buildbucket for the build status
[16:52:04.458] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:04.459] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:37:0) after 1m0s
[16:53:04.479] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:37:0)
[16:53:04.509] Build status: STARTED
[16:53:04.509] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:38:0) after 5m12s
[16:58:16.527] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:38:0)
[16:58:16.552] Build status: STARTED
[16:58:16.553] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:39:0) after 6m48s
[17:05:04.594] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:39:0)
[17:05:04.594] Timer tick, asking Buildbucket for the build status
[17:05:04.782] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:04.782] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:40:0) after 1m0s
[17:06:04.856] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:40:0)
[17:06:04.902] Build status: STARTED
[17:06:04.902] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:41:0) after 9m34s
[17:15:39.117] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:41:0)
[17:15:39.181] Build status: STARTED
[17:15:39.181] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:42:0) after 8m26s
[17:24:05.310] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:42:0)
[17:24:05.310] Timer tick, asking Buildbucket for the build status
[17:24:05.435] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:05.435] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:43:0) after 1m0s
[17:25:05.492] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:43:0)
[17:25:05.532] Build status: STARTED
[17:25:05.532] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:44:0) after 7m21s
[17:32:26.561] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:44:0)
[17:32:26.561] Timer tick, asking Buildbucket for the build status
[17:32:26.663] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:26.663] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:45:0) after 1m0s
[17:33:26.809] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:45:0)
[17:33:26.809] Timer tick, asking Buildbucket for the build status
[17:33:26.888] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:26.888] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:46:0) after 1m0s
[17:34:26.982] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:46:0)
[17:34:27.010] Build status: STARTED
[17:34:27.010] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:47:0) after 5m52s
[17:40:19.035] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:47:0)
[17:40:19.035] Timer tick, asking Buildbucket for the build status
[17:40:19.299] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:19.299] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:48:0) after 1m0s
[17:41:19.333] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:48:0)
[17:41:19.365] Build status: STARTED
[17:41:19.365] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:49:0) after 2m2s
[17:43:21.385] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:49:0)
[17:43:21.413] Build status: STARTED
[17:43:21.413] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:50:0) after 9m59s
[17:53:20.411] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:50:0)
[17:53:20.438] Build status: STARTED
[17:53:20.438] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:51:0) after 8m45s
[18:02:05.458] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:51:0)
[18:02:05.487] Build status: STARTED
[18:02:05.487] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:52:0) after 2m43s
[18:04:48.619] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:52:0)
[18:04:48.651] Build status: STARTED
[18:04:48.651] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:53:0) after 5m55s
[18:10:43.778] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:53:0)
[18:10:43.778] Timer tick, asking Buildbucket for the build status
[18:10:44.104] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:44.104] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:54:0) after 1m0s
[18:11:44.235] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:54:0)
[18:11:44.235] Timer tick, asking Buildbucket for the build status
[18:11:44.346] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:44.346] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:55:0) after 1m0s
[18:12:44.599] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:55:0)
[18:12:44.599] Timer tick, asking Buildbucket for the build status
[18:12:44.707] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:44.707] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:56:0) after 1m0s
[18:13:44.724] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:56:0)
[18:13:44.724] Timer tick, asking Buildbucket for the build status
[18:13:45.004] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:45.004] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:57:0) after 1m0s
[18:14:45.126] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:57:0)
[18:14:45.155] Build status: STARTED
[18:14:45.155] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:58:0) after 5m25s
[18:20:10.264] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:58:0)
[18:20:10.264] Timer tick, asking Buildbucket for the build status
[18:20:10.714] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:10.714] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:59:0) after 1m0s
[18:21:10.852] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:59:0)
[18:21:10.890] Build status: STARTED
[18:21:10.890] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:60:0) after 6m26s
[18:27:37.152] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:60:0)
[18:27:37.152] Timer tick, asking Buildbucket for the build status
[18:27:37.277] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:37.277] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:61:0) after 1m0s
[18:28:37.319] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:61:0)
[18:28:37.349] Build status: STARTED
[18:28:37.349] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:62:0) after 3m49s
[18:32:26.377] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:62:0)
[18:32:26.402] Build status: STARTED
[18:32:26.402] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:63:0) after 6m47s
[18:39:13.428] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:63:0)
[18:39:13.462] Build status: STARTED
[18:39:13.462] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:64:0) after 4m48s
[18:44:01.524] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:64:0)
[18:44:01.524] Timer tick, asking Buildbucket for the build status
[18:44:01.627] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:01.627] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:65:0) after 1m0s
[18:45:01.860] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:65:0)
[18:45:01.860] Timer tick, asking Buildbucket for the build status
[18:45:02.047] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:02.047] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:66:0) after 1m0s
[18:46:02.027] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:66:0)
[18:46:02.027] Timer tick, asking Buildbucket for the build status
[18:46:02.180] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:02.180] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:67:0) after 1m0s
[18:47:02.207] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:67:0)
[18:47:02.207] Timer tick, asking Buildbucket for the build status
[18:47:02.429] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:02.429] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:68:0) after 1m0s
[18:48:02.536] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:68:0)
[18:48:02.571] Build status: STARTED
[18:48:02.571] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:69:0) after 1m30s
[18:49:32.595] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:69:0)
[18:49:32.640] Build status: STARTED
[18:49:32.640] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:70:0) after 2m4s
[18:51:36.670] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:70:0)
[18:51:36.705] Build status: STARTED
[18:51:36.705] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:71:0) after 5m23s
[18:56:59.773] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:71:0)
[18:56:59.773] Timer tick, asking Buildbucket for the build status
[18:56:59.857] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:59.857] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:72:0) after 1m0s
[18:57:59.884] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:72:0)
[18:57:59.912] Build status: STARTED
[18:57:59.912] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:73:0) after 1m49s
[18:59:49.008] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:73:0)
[18:59:49.008] Timer tick, asking Buildbucket for the build status
[18:59:49.086] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:49.086] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:74:0) after 1m0s
[19:00:49.177] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:74:0)
[19:00:49.204] Build status: STARTED
[19:00:49.204] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:75:0) after 2m0s
[19:02:49.223] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:75:0)
[19:02:49.223] Timer tick, asking Buildbucket for the build status
[19:02:49.336] Build 8852229958894081568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:49.336] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:76:0) after 1m0s
[19:03:49.374] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:76:0)
[19:03:49.406] Build status: STARTED
[19:03:49.406] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:77:0) after 7m29s
[19:11:18.426] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:77:0)
[19:11:18.453] Build status: STARTED
[19:11:18.453] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:78:0) after 7m54s
[19:19:12.471] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:78:0)
[19:19:12.500] Build status: STARTED
[19:19:12.500] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:79:0) after 1m14s
[19:20:26.595] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:79:0)
[19:20:26.624] Build status: STARTED
[19:20:26.624] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9017660020852886992:80:0) after 5m25s
[19:22:39.038] Received PubSub notification, asking Buildbucket for the build status
[19:22:39.125] Build 8852229958894081568: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[19:22:39.125] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1616268158586849",
"created_by": "project:chromium",
"created_ts": "1616252667488620",
"failure_reason": "BUILD_FAILURE",
"id": "8852229958894081568",
"parameters_json": "{\"builder_name\": \"android-code-coverage-native\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8373ebc7eb9ca8fe3cd58af41c2f6d09cc5a081c\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 Test Suite(s) failed.\\n\\n**content_browsertests on Android device Pixel 2** failed because of:\\n\\n- BackForwardCacheBrowserTest.VideoSuspendAndResume\\n\\n**gl_tests_validating on Android device Pixel 2** failed because of:\\n\\n- TranslatorVariants/EXTBlendFuncExtendedES3DrawTest.ES3GettersArray/0\\n\\n- TranslatorVariants/EXTBlendFuncExtendedDrawTest.ESSL1FragColor/0\\n\\n- TranslatorVariants/EXTBlendFuncExtendedES3DrawTest.ESSL3Var/1\\n\\n- TranslatorVariants/EXTBlendFuncExtendedES3DrawTest.ESSL3BindArrayWithSimpleName/0\\n\\n- ...14 more failure(s) (18 total)...\"}, \"properties\": {\"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"8373ebc7eb9ca8fe3cd58af41c2f6d09cc5a081c\", \"project\": \"chromium/src\"}], \"coverage_gs_bucket\": \"code-coverage-data\", \"coverage_is_presubmit\": false, \"coverage_metadata_gs_paths\": [\"postsubmit/chromium.googlesource.com/chromium/src/8373ebc7eb9ca8fe3cd58af41c2f6d09cc5a081c/ci/android-code-coverage-native/8852229958894081568/metadata\"], \"got_angle_revision\": \"135385a1ae86bf857be37475f927dcf78c9476b4\", \"got_dawn_revision\": \"853b5d765e715fc11ea28c1d3754e48d38c283b1\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"8373ebc7eb9ca8fe3cd58af41c2f6d09cc5a081c\", \"got_revision_cp\": \"refs/heads/master@{#864950}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a98fb3f8380a3a5c9ae3e0175634ba88c85a434f\", \"got_v8_revision\": \"6092f990f654f2d7a4534ee8c5bbb5c4fb800bdc\", \"got_v8_revision_cp\": \"refs/heads/9.1.170@{#1}\", \"got_webrtc_revision\": \"2bab0efee4d9d163841b6d060c690c381e1768ac\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33511}\", \"is_cached\": true, \"isolate_server\": \"https://isolateserver.appspot.com\", \"merged_profdata_gs_paths\": [\"postsubmit/chromium.googlesource.com/chromium/src/8373ebc7eb9ca8fe3cd58af41c2f6d09cc5a081c/ci/android-code-coverage-native/8852229958894081568/merged.profdata\"], \"mimic_builder_names\": [\"android-code-coverage-native\"], \"mirrored_builders\": [\"tryserver.chromium.android:android-pie-arm64-coverage-rel\"], \"swarm_hashes_refs/heads/master(at){#864950}_without_patch\": {\"absl_hardening_tests\": \"ff450331b757951916b4815c8b883b73d490577f\", \"android_browsertests\": \"b16ced3a879081c402f161b489cde312a23a5d5d\", \"android_sync_integration_tests\": \"dcb37e94abf541aa83d36f14fe3bd89241bff7d7\", \"android_webview_unittests\": \"6dcdd8198d84ece90192586f354ec85b41253959\", \"angle_unittests\": \"93c6e80f45c9f9143b45d9723507ce72de971854\", \"base_unittests\": \"1e63a0efe57976b2cb5475794037566dfc5b0008\", \"base_util_unittests\": \"0355254c777f9f829010ddf4c7314fce01ed2277\", \"blink_common_unittests\": \"7022517d20b8537eed8a94707e880abe17804835\", \"blink_heap_unittests\": \"aec610923ab674d903203ebaa70fd0a6cc0cbe57\", \"blink_platform_unittests\": \"51d3cb4487c24ee5595b9c2512ba9aacf904dd1e\", \"blink_unittests\": \"3a8f47041b1df5420118b669ea82a617a77ca794\", \"boringssl_crypto_tests\": \"bb1d4386f991208bb2db4d463e6ecee35e84e93e\", \"boringssl_ssl_tests\": \"c44307e6384b1a8cbd16546a4703e9860b0032ab\", \"breakpad_unittests\": \"a4b15893d92a7ff838db68b5c87a01b33a4f005e\", \"capture_unittests\": \"193e89801e2c2810ce6495e6a72cc05efccbf266\", \"cast_unittests\": \"5130ce2116168ea80673ce39d6b50ac0aefbba28\", \"cc_unittests\": \"4cb9010b896b500862449ce01f60f5304ddf41a9\", \"components_browsertests\": \"9eb4b5e28002503ff335237891c40fd966a014a1\", \"components_unittests\": \"caaecf98fc492cfcdce1daab5c2ecb1dff03c370\", \"content_browsertests\": \"2d1d39fb04a89121383f16a621f092eb540318dd\", \"content_unittests\": \"85d5cb3465ce777046f655776e33b098ba20ddce\", \"crashpad_tests\": \"df9112274187a3b87fc26f85b0e25826680ba5b4\", \"crypto_unittests\": \"a88cd3236f4b1eb8839f3fdbce6373c7e0bdf773\", \"device_unittests\": \"de0ab415a5a9b4a7903d4142d65e2e469446190d\", \"display_unittests\": \"a0b216a2e98a6ce5707fd2b13ea6e47e93893dd5\", \"events_unittests\": \"c638c65e4c76f755791346de8c71d4b599d68263\", \"gcm_unit_tests\": \"530de162204ffceca3b21504201f357b498bc5bb\", \"gfx_unittests\": \"b962e4f7013a976e6d316216d789c5384125a576\", \"gin_unittests\": \"d06b32f81f73c93230aab727d86b68587c85fb69\", \"gl_tests\": \"930ffb8ecf5e4d65c7259f9f1ad00f1b66a250ab\", \"gl_unittests\": \"50ac93abbe6b820d184c5a7b1867080b7aade411\", \"google_apis_unittests\": \"8d7c120783341ac4c28722a67492dd59847ac3b3\", \"gpu_unittests\": \"80609a6b229eb4ab0c2f21ab1113ad6c1ccfbd13\", \"gwp_asan_unittests\": \"c61983389ca7647731c7fab1b0883b94e960d472\", \"ipc_tests\": \"6a834a3d94d1a0a015829d8a8ac4bf41d3b25ec8\", \"jingle_unittests\": \"96c8849b86683d76972137043ce7a6e38e2ec426\", \"latency_unittests\": \"d1588fee3ef5e2a7904bdc5b39c24ea097da370c\", \"libjingle_xmpp_unittests\": \"2b6c8b5f8d4cfcb84fb8357eb0056864a5058536\", \"liburlpattern_unittests\": \"f62367d6211ca237635e5477fba05610af0274a6\", \"media_blink_unittests\": \"f91d545b024cf51617eb499dd9aba20b928c612d\", \"media_unittests\": \"06b01ab5b79c53c8c824dd4eea95750d55a9eaa9\", \"midi_unittests\": \"101c0996844a3b65b05d6a29a3f3017500f066be\", \"mojo_unittests\": \"9c437f753282dcbc0b7321e9c694e1cfdd998496\", \"net_unittests\": \"90a8e09e4e5539d7f51bb583f1c23eecb7a8730e\", \"sandbox_linux_unittests\": \"fc8591331c22a0f42856d64c3c740a7e3a00529b\", \"services_unittests\": \"7c466047be117e150aaa0a3c9e152238a86e9e67\", \"shell_dialogs_unittests\": \"bfda2de70fec431af62b51cb0025b66d2c87f272\", \"skia_unittests\": \"4c96f7743bf1ad484308a16080d249d988c8883c\", \"sql_unittests\": \"d44599c60aa580d68147daf7ccd946b96effc252\", \"storage_unittests\": \"97090646ed3fad6f0093c519faf0d07f9cd21b9d\", \"ui_android_unittests\": \"2e6e1f199aa29d240d651556cc5836b90b809dd4\", \"ui_base_unittests\": \"00953bada5c6d989a1516b022f1160d247212f24\", \"ui_touch_selection_unittests\": \"7d9169b8e7bda343e69ee6622ebf4cbda90e10bc\", \"unit_tests\": \"3858ce712ad2cfcea3aeb7a5a6e7a18dafe35c36\", \"url_unittests\": \"d4351b1b092556795ecb1c9ee56395c7370f62e4\", \"viz_unittests\": \"e2b1188f6e417b63c5359664c6173f30839ac573\", \"vr_android_unittests\": \"3dc5131897e8095f98c03feaba4d5594667c95aa\", \"vr_common_unittests\": \"3657efcfd8f1bcfbcb8e711985f0047a1eaa7191\", \"vr_pixeltests\": \"c42cdf8dd1fc2cd28b15d6b04fde6279f0ceb61e\", \"wtf_unittests\": \"b6e70833f654ccfbce645c02307d96a626889d85\", \"zlib_unittests\": \"ac8b392724ad5df786e43cc8bf7da26fd1033bde\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1cf5addf4d1b07dee05bb817410abedd1ddd14dde2cca1baf3f95933882f5cfd_v2\", \"builder_84527c5af4d4441fc5a14374d256be65769803505d9e2e72cad7cb7913806658_v2\", \"builder_8c50e44da5ff5c73f18adbb271e3eef339abdfe09c12933026ede51eb427bfdf_v2\", \"builder_f2ac5903ab08ee4ddab389becac92d3a3647f6b791038f1abef5b06a03e08513_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"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-c-600-ssd-hm32-5-yfmq\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-highmem-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2\", \"2.7\", \"2.7.12\"], \"server_version\": [\"5776-cb9e157\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-c\"]}}, \"ui\": {\"info\": \"2 Test Suite(s) failed.\\n\\n**content_browsertests on Android device Pixel 2** failed because of:\\n\\n- BackForwardCacheBrowserTest.VideoSuspendAndResume\\n\\n**gl_tests_validating on Android device Pixel 2** failed because of:\\n\\n- TranslatorVariants/EXTBlendFuncExtendedES3DrawTest.ES3GettersArray/0\\n\\n- TranslatorVariants/EXTBlendFuncExtendedDrawTest.ESSL1FragColor/0\\n\\n- TranslatorVariants/EXTBlendFuncExtendedES3DrawTest.ESSL3Var/1\\n\\n- TranslatorVariants/EXTBlendFuncExtendedES3DrawTest.ESSL3BindArrayWithSimpleName/0\\n\\n- ...14 more failure(s) (18 total)...\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1616254904419446",
"status": "COMPLETED",
"status_changed_ts": "1616254907939652",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage-native/9352",
"builder:android-code-coverage-native",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8373ebc7eb9ca8fe3cd58af41c2f6d09cc5a081c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017660020852886992",
"scheduler_job_id:chromium/android-code-coverage-native",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852229958894081568/+/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:5268fc11386e0310",
"user_agent:luci-scheduler"
],
"updated_ts": "1616268158587154",
"url": "https://ci.chromium.org/b/8852229958894081568",
"utcnow_ts": "1616268159117784"
}
}
[19:22:39.125] Invocation finished in 4h18m12.888209842s with status FAILED