[08:59:16.252] New invocation is queued and will start shortly
[08:59:17.315] Starting the invocation (attempt 1)
[08:59:17.367] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:59:17.367] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:59:17.367] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9062890881395570640",
"parameters_json": "{\"builder_name\":\"Site Isolation Android\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3173f7c74f69511cc2327dc9c36de53b99e6f3f8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Site Isolation Android",
"scheduler_invocation_id:9062890881395570640",
"scheduler_job_id:chromium/Site Isolation Android",
"user_agent:luci-scheduler",
"buildset:commit/git/3173f7c74f69511cc2327dc9c36de53b99e6f3f8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3173f7c74f69511cc2327dc9c36de53b99e6f3f8",
"gitiles_ref:refs/heads/master"
]
}
[08:59:18.296] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1573117157566016",
"id": "8897460819346760576",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3173f7c74f69511cc2327dc9c36de53b99e6f3f8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1573117158125636",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/38581",
"builder:Site Isolation Android",
"buildset:commit/git/3173f7c74f69511cc2327dc9c36de53b99e6f3f8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3173f7c74f69511cc2327dc9c36de53b99e6f3f8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9062890881395570640",
"scheduler_job_id:chromium/Site Isolation Android",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8897460819346760576/+/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": "1573117158125745",
"url": "https://ci.chromium.org/b/8897460819346760576",
"utcnow_ts": "1573117158283029"
}
}
[08:59:18.296] Task URL: https://ci.chromium.org/b/8897460819346760576
[08:59:18.296] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:2:0) after 1m0s
[09:00:01.379] Received PubSub notification, asking Buildbucket for the build status
[09:00:01.659] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:18.388] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:2:0)
[09:00:18.388] Timer tick, asking Buildbucket for the build status
[09:00:18.853] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:18.853] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:4:0) after 1m0s
[09:01:18.900] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:4:0)
[09:01:18.900] Timer tick, asking Buildbucket for the build status
[09:01:19.156] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:19.156] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:5:0) after 1m0s
[09:02:21.139] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:5:0)
[09:02:21.139] Timer tick, asking Buildbucket for the build status
[09:02:22.299] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:22.299] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:6:0) after 1m0s
[09:03:22.358] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:6:0)
[09:03:22.359] Timer tick, asking Buildbucket for the build status
[09:03:23.003] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:23.003] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:7:0) after 1m0s
[09:04:23.033] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:7:0)
[09:04:23.033] Timer tick, asking Buildbucket for the build status
[09:04:23.537] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:23.537] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:8:0) after 1m0s
[09:05:23.582] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:8:0)
[09:05:23.582] Timer tick, asking Buildbucket for the build status
[09:05:24.267] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:24.267] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:9:0) after 1m0s
[09:06:24.264] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:9:0)
[09:06:24.264] Timer tick, asking Buildbucket for the build status
[09:06:24.614] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:24.614] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:10:0) after 1m0s
[09:07:24.708] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:10:0)
[09:07:24.708] Timer tick, asking Buildbucket for the build status
[09:07:25.158] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:25.159] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:11:0) after 1m0s
[09:08:25.146] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:11:0)
[09:08:25.146] Timer tick, asking Buildbucket for the build status
[09:08:26.677] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:26.677] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:12:0) after 1m0s
[09:09:26.693] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:12:0)
[09:09:26.693] Timer tick, asking Buildbucket for the build status
[09:09:27.571] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:27.571] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:13:0) after 1m0s
[09:10:27.652] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:13:0)
[09:10:27.652] Timer tick, asking Buildbucket for the build status
[09:10:27.905] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:27.905] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:14:0) after 1m0s
[09:11:27.879] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:14:0)
[09:11:27.879] Timer tick, asking Buildbucket for the build status
[09:11:28.204] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:28.204] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:15:0) after 1m0s
[09:12:28.191] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:15:0)
[09:12:28.191] Timer tick, asking Buildbucket for the build status
[09:12:29.185] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:29.185] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:16:0) after 1m0s
[09:13:29.260] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:16:0)
[09:13:29.260] Timer tick, asking Buildbucket for the build status
[09:13:30.237] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:30.237] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:17:0) after 1m0s
[09:14:30.262] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:17:0)
[09:14:30.262] Timer tick, asking Buildbucket for the build status
[09:14:30.783] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:30.783] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:18:0) after 1m0s
[09:15:30.947] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:18:0)
[09:15:30.947] Timer tick, asking Buildbucket for the build status
[09:15:31.922] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:31.922] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:19:0) after 1m0s
[09:16:32.100] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:19:0)
[09:16:32.100] Timer tick, asking Buildbucket for the build status
[09:16:32.440] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:32.440] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:20:0) after 1m0s
[09:17:32.506] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:20:0)
[09:17:32.506] Timer tick, asking Buildbucket for the build status
[09:17:36.459] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:36.460] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:21:0) after 1m0s
[09:18:36.575] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:21:0)
[09:18:36.575] Timer tick, asking Buildbucket for the build status
[09:18:36.853] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:36.853] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:22:0) after 1m0s
[09:19:36.867] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:22:0)
[09:19:36.867] Timer tick, asking Buildbucket for the build status
[09:19:37.316] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:37.316] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:23:0) after 1m0s
[09:20:37.342] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:23:0)
[09:20:37.342] Timer tick, asking Buildbucket for the build status
[09:20:37.538] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:37.538] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:24:0) after 1m0s
[09:21:37.640] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:24:0)
[09:21:37.640] Timer tick, asking Buildbucket for the build status
[09:21:38.058] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:38.058] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:25:0) after 1m0s
[09:22:38.279] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:25:0)
[09:22:38.279] Timer tick, asking Buildbucket for the build status
[09:22:38.591] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:38.591] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:26:0) after 1m0s
[09:23:38.775] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:26:0)
[09:23:38.775] Timer tick, asking Buildbucket for the build status
[09:23:39.635] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:39.635] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:27:0) after 1m0s
[09:24:39.629] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:27:0)
[09:24:39.629] Timer tick, asking Buildbucket for the build status
[09:24:40.368] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:40.368] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:28:0) after 1m0s
[09:25:40.749] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:28:0)
[09:25:40.749] Timer tick, asking Buildbucket for the build status
[09:25:41.134] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:41.134] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:29:0) after 1m0s
[09:26:41.756] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:29:0)
[09:26:41.756] Timer tick, asking Buildbucket for the build status
[09:26:41.954] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:41.954] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:30:0) after 1m0s
[09:27:42.366] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:30:0)
[09:27:42.366] Timer tick, asking Buildbucket for the build status
[09:27:42.614] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:42.614] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:31:0) after 1m0s
[09:28:42.991] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:31:0)
[09:28:42.991] Timer tick, asking Buildbucket for the build status
[09:28:46.591] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:46.591] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:32:0) after 1m0s
[09:29:46.776] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:32:0)
[09:29:46.776] Timer tick, asking Buildbucket for the build status
[09:29:47.053] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:47.053] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:33:0) after 1m0s
[09:30:47.084] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:33:0)
[09:30:47.084] Timer tick, asking Buildbucket for the build status
[09:30:47.215] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:47.215] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:34:0) after 1m0s
[09:31:47.419] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:34:0)
[09:31:47.419] Timer tick, asking Buildbucket for the build status
[09:31:47.671] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:47.671] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:35:0) after 1m0s
[09:32:47.734] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:35:0)
[09:32:47.734] Timer tick, asking Buildbucket for the build status
[09:32:48.345] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:48.345] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:36:0) after 1m0s
[09:33:48.461] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:36:0)
[09:33:48.461] Timer tick, asking Buildbucket for the build status
[09:33:51.572] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:51.572] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:37:0) after 1m0s
[09:34:51.905] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:37:0)
[09:34:51.905] Timer tick, asking Buildbucket for the build status
[09:34:52.131] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:52.131] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:38:0) after 1m0s
[09:35:54.225] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:38:0)
[09:35:54.225] Timer tick, asking Buildbucket for the build status
[09:35:56.246] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:56.246] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:39:0) after 1m0s
[09:36:56.474] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:39:0)
[09:36:56.474] Timer tick, asking Buildbucket for the build status
[09:36:56.930] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:56.930] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:40:0) after 1m0s
[09:37:57.060] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:40:0)
[09:37:57.060] Timer tick, asking Buildbucket for the build status
[09:37:57.439] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:57.439] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:41:0) after 1m0s
[09:38:57.476] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:41:0)
[09:38:57.476] Timer tick, asking Buildbucket for the build status
[09:38:57.694] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:57.694] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:42:0) after 1m0s
[09:39:57.710] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:42:0)
[09:39:57.710] Timer tick, asking Buildbucket for the build status
[09:40:00.908] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:00.908] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:43:0) after 1m0s
[09:41:00.937] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:43:0)
[09:41:00.937] Timer tick, asking Buildbucket for the build status
[09:41:03.702] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:03.703] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:44:0) after 1m0s
[09:42:03.735] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:44:0)
[09:42:03.735] Timer tick, asking Buildbucket for the build status
[09:42:04.279] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:04.279] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:45:0) after 1m0s
[09:43:04.416] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:45:0)
[09:43:04.416] Timer tick, asking Buildbucket for the build status
[09:43:05.035] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:05.036] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:46:0) after 1m0s
[09:44:05.055] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:46:0)
[09:44:05.055] Timer tick, asking Buildbucket for the build status
[09:44:05.341] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:05.341] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:47:0) after 1m0s
[09:45:05.376] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:47:0)
[09:45:05.376] Timer tick, asking Buildbucket for the build status
[09:45:06.088] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:06.088] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:48:0) after 1m0s
[09:46:06.181] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:48:0)
[09:46:06.181] Timer tick, asking Buildbucket for the build status
[09:46:06.404] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:06.404] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:49:0) after 1m0s
[09:47:06.504] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:49:0)
[09:47:06.504] Timer tick, asking Buildbucket for the build status
[09:47:08.246] Build 8897460819346760576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:08.246] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9062890881395570640:50:0) after 1m0s
[09:47:51.386] Received PubSub notification, asking Buildbucket for the build status
[09:47:51.882] Build 8897460819346760576: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:47:51.882] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1573120069203084",
"created_by": "project:chromium",
"created_ts": "1573117157566016",
"id": "8897460819346760576",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3173f7c74f69511cc2327dc9c36de53b99e6f3f8\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"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-21-tbqf\", \"branch\": \"refs/heads/master\", \"buildername\": \"Site Isolation Android\", \"buildnumber\": 38581, \"got_angle_revision\": \"cc0919dcb64b3129dbe36d31cd1b411c90c1803a\", \"got_dawn_revision\": \"64cfaeac4c5d9eaf3876a648258a1eefce912410\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"3173f7c74f69511cc2327dc9c36de53b99e6f3f8\", \"got_revision_cp\": \"refs/heads/master@{#713371}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"27a3d31d7a9d65bb49b83da404cc4830eb3ce06e\", \"got_v8_revision\": \"dfb12d9e0f644969d5a1e53fb1222fe344372ab6\", \"got_v8_revision_cp\": \"refs/heads/8.0.184@{#1}\", \"got_webrtc_revision\": \"70ec48ca281c360be46e093c4c2cc5f801e8224e\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29720}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3173f7c74f69511cc2327dc9c36de53b99e6f3f8\", \"swarm_hashes\": {\"components_browsertests\": \"6ea987a83818d2ecd4b50a5ecb9bdeff2aec8719\", \"components_unittests\": \"a82aa0b75bf5d62883f28205a794fb0e8a1377be\", \"content_browsertests\": \"38d3b56f677d19fa1bd6db232478c1ed29880a9e\", \"content_unittests\": \"bc209ea0d2e7239a22835ccbf2fbbe5f7fa5f4d6\", \"unit_tests\": \"d885cef9d0ae488ac77ded3decfa450e6a993888\"}, \"swarm_hashes_refs/heads/master(at){#713371}_without_patch\": {\"components_browsertests\": \"6ea987a83818d2ecd4b50a5ecb9bdeff2aec8719\", \"components_unittests\": \"a82aa0b75bf5d62883f28205a794fb0e8a1377be\", \"content_browsertests\": \"38d3b56f677d19fa1bd6db232478c1ed29880a9e\", \"content_unittests\": \"bc209ea0d2e7239a22835ccbf2fbbe5f7fa5f4d6\", \"unit_tests\": \"d885cef9d0ae488ac77ded3decfa450e6a993888\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_06f1ed350fecda52f561db3eb00cb39e105b14f5c02d94078111c7babc8da8c6_v2\", \"builder_a3249012ab2e105b4f1a10f0dc352b422f692fd701d889292e5c6170d198db4b_v2\", \"builder_b9f10e617e36b89b59cf2468f05559e0083126a9b3741fee04e133349127cbf2_v2\", \"builder_e961d9d7e9bca679490a4aaa8599bd975f9b7e0b713a988ed6895a059d04d2ac_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-21-tbqf\"], \"image\": [\"chrome-xenial-19102400-d35fedf5a0d\"], \"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\": [\"4621-f8a5b1c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1573117200166680",
"status": "COMPLETED",
"status_changed_ts": "1573120069724087",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/38581",
"builder:Site Isolation Android",
"buildset:commit/git/3173f7c74f69511cc2327dc9c36de53b99e6f3f8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3173f7c74f69511cc2327dc9c36de53b99e6f3f8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9062890881395570640",
"scheduler_job_id:chromium/Site Isolation Android",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8897460819346760576/+/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:485de89e0b172d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1573120069797298",
"url": "https://ci.chromium.org/b/8897460819346760576",
"utcnow_ts": "1573120071873640"
}
}
[09:47:51.882] Invocation finished in 48m35.65417965s with status SUCCEEDED