[04:27:16.843] New invocation is queued and will start shortly
[04:27:18.375] Starting the invocation (attempt 1)
[04:27:18.509] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:27:18.509] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:27:18.509] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9065988290395642656",
"parameters_json": "{\"builder_name\":\"fuzz-linux\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"cron\":{\"generation\":\"1218\"},\"id\":\"cron:v1:1218\"}]}}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:fuzz-linux",
"scheduler_invocation_id:9065988290395642656",
"scheduler_job_id:dart/fuzz-linux",
"user_agent:luci-scheduler"
]
}
[04:27:19.832] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"created_by": "project:dart",
"created_ts": "1570163238924535",
"id": "8900558227539862928",
"parameters_json": "{\"builder_name\": \"fuzz-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"1218\"}, \"id\": \"cron:v1:1218\"}]}}}",
"project": "dart",
"result_details_json": "{\"properties\": {}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1570163239654479",
"tags": [
"build_address:luci.dart.ci.sandbox/fuzz-linux/407",
"builder:fuzz-linux",
"scheduler_invocation_id:9065988290395642656",
"scheduler_job_id:dart/fuzz-linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8900558227539862928/+/annotations",
"swarming_tag:luci_project:dart",
"swarming_tag:recipe_name:dart/neo",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1570163239654637",
"url": "https://ci.chromium.org/b/8900558227539862928",
"utcnow_ts": "1570163239822221"
}
}
[04:27:19.832] Task URL: https://ci.chromium.org/b/8900558227539862928
[04:27:19.832] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:2:0) after 1m0s
[04:28:19.896] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:2:0)
[04:28:19.896] Timer tick, asking Buildbucket for the build status
[04:28:20.142] Build 8900558227539862928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:28:20.142] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:3:0) after 1m0s
[04:29:20.254] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:3:0)
[04:29:20.254] Timer tick, asking Buildbucket for the build status
[04:29:20.630] Build 8900558227539862928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:29:20.630] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:4:0) after 1m0s
[04:30:20.685] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:4:0)
[04:30:20.685] Timer tick, asking Buildbucket for the build status
[04:30:20.906] Build 8900558227539862928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:30:20.906] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:5:0) after 1m0s
[04:31:20.947] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:5:0)
[04:31:20.947] Timer tick, asking Buildbucket for the build status
[04:31:21.269] Build 8900558227539862928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:31:21.269] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:6:0) after 1m0s
[04:32:11.518] Received PubSub notification, asking Buildbucket for the build status
[04:32:11.923] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:21.316] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:6:0)
[04:32:21.316] Timer tick, asking Buildbucket for the build status
[04:32:21.448] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:21.448] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:8:0) after 1m0s
[04:33:21.595] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:8:0)
[04:33:21.595] Timer tick, asking Buildbucket for the build status
[04:33:22.199] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:22.199] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:9:0) after 1m0s
[04:34:22.218] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:9:0)
[04:34:22.218] Timer tick, asking Buildbucket for the build status
[04:34:22.384] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:22.384] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:10:0) after 1m0s
[04:35:22.409] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:10:0)
[04:35:22.409] Timer tick, asking Buildbucket for the build status
[04:35:22.585] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:22.585] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:11:0) after 1m0s
[04:36:22.712] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:11:0)
[04:36:22.712] Timer tick, asking Buildbucket for the build status
[04:36:22.935] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:22.935] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:12:0) after 1m0s
[04:37:23.046] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:12:0)
[04:37:23.046] Timer tick, asking Buildbucket for the build status
[04:37:23.463] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:23.463] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:13:0) after 1m0s
[04:38:23.523] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:13:0)
[04:38:23.523] Timer tick, asking Buildbucket for the build status
[04:38:24.798] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:24.798] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:14:0) after 1m0s
[04:39:24.900] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:14:0)
[04:39:24.900] Timer tick, asking Buildbucket for the build status
[04:39:25.351] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:25.351] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:15:0) after 1m0s
[04:40:25.531] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:15:0)
[04:40:25.531] Timer tick, asking Buildbucket for the build status
[04:40:25.719] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:25.719] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:16:0) after 1m0s
[04:41:25.948] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:16:0)
[04:41:25.948] Timer tick, asking Buildbucket for the build status
[04:41:26.426] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:26.426] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:17:0) after 1m0s
[04:42:26.628] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:17:0)
[04:42:26.628] Timer tick, asking Buildbucket for the build status
[04:42:26.845] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:26.845] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:18:0) after 1m0s
[04:43:26.917] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:18:0)
[04:43:26.917] Timer tick, asking Buildbucket for the build status
[04:43:27.455] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:27.455] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:19:0) after 1m0s
[04:44:27.653] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:19:0)
[04:44:27.653] Timer tick, asking Buildbucket for the build status
[04:44:28.589] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:28.589] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:20:0) after 1m0s
[04:45:28.680] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:20:0)
[04:45:28.680] Timer tick, asking Buildbucket for the build status
[04:45:29.529] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:29.529] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:21:0) after 1m0s
[04:46:29.639] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:21:0)
[04:46:29.639] Timer tick, asking Buildbucket for the build status
[04:46:30.296] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:30.296] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:22:0) after 1m0s
[04:47:30.414] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:22:0)
[04:47:30.414] Timer tick, asking Buildbucket for the build status
[04:47:30.825] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:30.825] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:23:0) after 1m0s
[04:48:30.980] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:23:0)
[04:48:30.980] Timer tick, asking Buildbucket for the build status
[04:48:31.276] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:31.276] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:24:0) after 1m0s
[04:49:31.520] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:24:0)
[04:49:31.520] Timer tick, asking Buildbucket for the build status
[04:49:32.355] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:32.355] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:25:0) after 1m0s
[04:50:32.562] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:25:0)
[04:50:32.562] Timer tick, asking Buildbucket for the build status
[04:50:32.807] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:32.807] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:26:0) after 1m0s
[04:51:32.849] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:26:0)
[04:51:32.849] Timer tick, asking Buildbucket for the build status
[04:51:33.113] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:33.113] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:27:0) after 1m0s
[04:52:33.200] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:27:0)
[04:52:33.200] Timer tick, asking Buildbucket for the build status
[04:52:33.685] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:33.685] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:28:0) after 1m0s
[04:53:33.859] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:28:0)
[04:53:33.859] Timer tick, asking Buildbucket for the build status
[04:53:34.075] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:34.075] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:29:0) after 1m0s
[04:54:34.134] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:29:0)
[04:54:34.134] Timer tick, asking Buildbucket for the build status
[04:54:35.569] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:35.569] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:30:0) after 1m0s
[04:55:35.599] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:30:0)
[04:55:35.599] Timer tick, asking Buildbucket for the build status
[04:55:35.781] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:35.781] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:31:0) after 1m0s
[04:56:35.835] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:31:0)
[04:56:35.835] Timer tick, asking Buildbucket for the build status
[04:56:36.039] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:36.039] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:32:0) after 1m0s
[04:57:36.014] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:32:0)
[04:57:36.014] Timer tick, asking Buildbucket for the build status
[04:57:36.195] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:36.195] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:33:0) after 1m0s
[04:58:36.305] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:33:0)
[04:58:36.305] Timer tick, asking Buildbucket for the build status
[04:58:36.599] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:36.599] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:34:0) after 1m0s
[04:59:36.643] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:34:0)
[04:59:36.643] Timer tick, asking Buildbucket for the build status
[04:59:36.862] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:36.862] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:35:0) after 1m0s
[05:00:36.977] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:35:0)
[05:00:36.977] Timer tick, asking Buildbucket for the build status
[05:00:38.143] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:38.143] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:36:0) after 1m0s
[05:01:38.189] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:36:0)
[05:01:38.189] Timer tick, asking Buildbucket for the build status
[05:01:38.385] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:38.385] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:37:0) after 1m0s
[05:02:38.381] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:37:0)
[05:02:38.381] Timer tick, asking Buildbucket for the build status
[05:02:38.576] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:38.576] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:38:0) after 1m0s
[05:03:38.775] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:38:0)
[05:03:38.775] Timer tick, asking Buildbucket for the build status
[05:03:38.971] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:38.971] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:39:0) after 1m0s
[05:04:39.035] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:39:0)
[05:04:39.035] Timer tick, asking Buildbucket for the build status
[05:04:39.622] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:39.622] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:40:0) after 1m0s
[05:05:39.781] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:40:0)
[05:05:39.781] Timer tick, asking Buildbucket for the build status
[05:05:40.929] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:40.929] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:41:0) after 1m0s
[05:06:41.027] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:41:0)
[05:06:41.027] Timer tick, asking Buildbucket for the build status
[05:06:41.431] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:41.431] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:42:0) after 1m0s
[05:07:41.506] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:42:0)
[05:07:41.506] Timer tick, asking Buildbucket for the build status
[05:07:41.882] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:41.882] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:43:0) after 1m0s
[05:08:42.040] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:43:0)
[05:08:42.040] Timer tick, asking Buildbucket for the build status
[05:08:42.455] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:42.455] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:44:0) after 1m0s
[05:09:42.563] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:44:0)
[05:09:42.563] Timer tick, asking Buildbucket for the build status
[05:09:42.962] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:42.962] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:45:0) after 1m0s
[05:10:42.981] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:45:0)
[05:10:42.981] Timer tick, asking Buildbucket for the build status
[05:10:43.492] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:43.492] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:46:0) after 1m0s
[05:11:43.515] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:46:0)
[05:11:43.515] Timer tick, asking Buildbucket for the build status
[05:11:44.538] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:44.538] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:47:0) after 1m0s
[05:12:44.560] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:47:0)
[05:12:44.560] Timer tick, asking Buildbucket for the build status
[05:12:47.274] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:47.274] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:48:0) after 1m0s
[05:13:47.382] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:48:0)
[05:13:47.382] Timer tick, asking Buildbucket for the build status
[05:13:47.889] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:47.889] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:49:0) after 1m0s
[05:14:47.943] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:49:0)
[05:14:47.943] Timer tick, asking Buildbucket for the build status
[05:14:48.336] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:48.336] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:50:0) after 1m0s
[05:15:48.452] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:50:0)
[05:15:48.452] Timer tick, asking Buildbucket for the build status
[05:15:48.622] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:48.622] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:51:0) after 1m0s
[05:16:48.701] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:51:0)
[05:16:48.701] Timer tick, asking Buildbucket for the build status
[05:16:51.019] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:51.019] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:52:0) after 1m0s
[05:17:51.060] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:52:0)
[05:17:51.060] Timer tick, asking Buildbucket for the build status
[05:17:51.399] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:51.399] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:53:0) after 1m0s
[05:18:51.449] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:53:0)
[05:18:51.449] Timer tick, asking Buildbucket for the build status
[05:18:51.895] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:51.895] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:54:0) after 1m0s
[05:19:51.918] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:54:0)
[05:19:51.918] Timer tick, asking Buildbucket for the build status
[05:19:54.101] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:54.101] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:55:0) after 1m0s
[05:20:54.117] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:55:0)
[05:20:54.117] Timer tick, asking Buildbucket for the build status
[05:20:54.248] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:54.248] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:56:0) after 1m0s
[05:21:54.349] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:56:0)
[05:21:54.349] Timer tick, asking Buildbucket for the build status
[05:21:54.849] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:54.849] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:57:0) after 1m0s
[05:22:54.926] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:57:0)
[05:22:54.926] Timer tick, asking Buildbucket for the build status
[05:22:55.276] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:55.276] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:58:0) after 1m0s
[05:23:55.379] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:58:0)
[05:23:55.379] Timer tick, asking Buildbucket for the build status
[05:23:55.535] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:55.535] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:59:0) after 1m0s
[05:24:55.593] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:59:0)
[05:24:55.593] Timer tick, asking Buildbucket for the build status
[05:24:55.957] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:55.957] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:60:0) after 1m0s
[05:25:56.022] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:60:0)
[05:25:56.022] Timer tick, asking Buildbucket for the build status
[05:25:56.311] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:56.311] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:61:0) after 1m0s
[05:26:56.338] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:61:0)
[05:26:56.338] Timer tick, asking Buildbucket for the build status
[05:26:57.199] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:57.199] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:62:0) after 1m0s
[05:27:57.319] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:62:0)
[05:27:57.319] Timer tick, asking Buildbucket for the build status
[05:27:57.617] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:57.617] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:63:0) after 1m0s
[05:28:57.654] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:63:0)
[05:28:57.654] Timer tick, asking Buildbucket for the build status
[05:28:57.988] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:57.988] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:64:0) after 1m0s
[05:29:58.051] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:64:0)
[05:29:58.051] Timer tick, asking Buildbucket for the build status
[05:29:58.256] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:58.256] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:65:0) after 1m0s
[05:30:58.295] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:65:0)
[05:30:58.295] Timer tick, asking Buildbucket for the build status
[05:30:59.643] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:59.643] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:66:0) after 1m0s
[05:31:59.684] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:66:0)
[05:31:59.684] Timer tick, asking Buildbucket for the build status
[05:31:59.946] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:59.946] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:67:0) after 1m0s
[05:33:00.022] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:67:0)
[05:33:00.022] Timer tick, asking Buildbucket for the build status
[05:33:00.733] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:00.733] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:68:0) after 1m0s
[05:34:00.769] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:68:0)
[05:34:00.769] Timer tick, asking Buildbucket for the build status
[05:34:03.009] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:03.009] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:69:0) after 1m0s
[05:35:03.036] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:69:0)
[05:35:03.036] Timer tick, asking Buildbucket for the build status
[05:35:03.443] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:03.443] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:70:0) after 1m0s
[05:36:03.555] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:70:0)
[05:36:03.555] Timer tick, asking Buildbucket for the build status
[05:36:04.108] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:04.108] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:71:0) after 1m0s
[05:37:04.195] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:71:0)
[05:37:04.195] Timer tick, asking Buildbucket for the build status
[05:37:04.376] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:04.376] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:72:0) after 1m0s
[05:38:04.392] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:72:0)
[05:38:04.392] Timer tick, asking Buildbucket for the build status
[05:38:04.991] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:04.991] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:73:0) after 1m0s
[05:39:05.073] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:73:0)
[05:39:05.073] Timer tick, asking Buildbucket for the build status
[05:39:05.380] Build 8900558227539862928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:05.380] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065988290395642656:74:0) after 1m0s
[05:39:13.851] Received PubSub notification, asking Buildbucket for the build status
[05:39:13.973] Build 8900558227539862928: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:39:13.973] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"completed_ts": "1570167552506588",
"created_by": "project:dart",
"created_ts": "1570163238924535",
"id": "8900558227539862928",
"parameters_json": "{\"builder_name\": \"fuzz-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"1218\"}, \"id\": \"cron:v1:1218\"}]}}}",
"project": "dart",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$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}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"1218\"}, \"id\": \"cron:v1:1218\"}]}, \"bot_id\": \"luci-dart-try-xenial-13-rrta\", \"buildername\": \"fuzz-linux\", \"buildnumber\": 407, \"clobber\": \"true\", \"got_revision\": \"5a6d17d3628f4cdc89884fa96383e6bf9967eab9\", \"path_config\": \"generic\", \"recipe\": \"dart/neo\"}, \"swarming\": {\"bot_dimensions\": {\"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-dart-try-xenial-13-rrta\"], \"image\": [\"chrome-xenial-19090600-ed917d8233f\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"dart.tests\", \"luci.dart.try\"], \"python\": [\"2.7.12\"], \"python3\": [\"3.5.2\"], \"server_version\": [\"4466-755d6a2\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1570163530565497",
"status": "COMPLETED",
"status_changed_ts": "1570167552958444",
"tags": [
"build_address:luci.dart.ci.sandbox/fuzz-linux/407",
"builder:fuzz-linux",
"scheduler_invocation_id:9065988290395642656",
"scheduler_job_id:dart/fuzz-linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8900558227539862928/+/annotations",
"swarming_tag:luci_project:dart",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:dart/neo",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:47add734f2f39e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1570167552966562",
"url": "https://ci.chromium.org/b/8900558227539862928",
"utcnow_ts": "1570167553961813"
}
}
[05:39:13.973] Invocation finished in 1h11m57.156231971s with status SUCCEEDED