[22:24:28.252] New invocation is queued and will start shortly
[22:24:28.252] Triggered by user:v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[22:24:29.627] Starting the invocation (attempt 1)
[22:24:29.684] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:24:29.684] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:24:29.684] Buildbucket request:
{
"bucket": "luci.v8.ci",
"client_operation_id": "9098354233411197424",
"parameters_json": "{\"builder_name\":\"V8 NumFuzz - debug\",\"properties\":{\"parent_build_config\":\"Debug\",\"parent_build_environment\":{\"gn_args\":\"is_component_build = true is_debug = true target_cpu = \\\"x64\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true\"},\"parent_buildername\":\"V8 Clusterfuzz Linux64 - debug builder\",\"parent_got_revision\":\"71898faf88ef02659aaf6055ac513171e338c8fe\",\"parent_got_revision_cp\":\"refs/heads/master@{#56581}\",\"parent_got_swarming_client_revision\":\"486c9b53c4d54dd4b95bb6ce0e31160e600dfc11\",\"revision\":\"71898faf88ef02659aaf6055ac513171e338c8fe\",\"swarm_hashes\":{\"d8_default\":\"97badaf9cdc7f52b6ee4fc64beb4c90de30dd546\",\"run-num-fuzzer\":\"55cef87b3d18499aca178329d13d3baf9c8e939e\"}}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:V8 NumFuzz - debug",
"scheduler_invocation_id:9098354233411197424",
"scheduler_job_id:v8/V8 NumFuzz - debug",
"user_agent:luci-scheduler",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/71898faf88ef02659aaf6055ac513171e338c8fe",
"gitiles_ref:refs/heads/master",
"parent_buildername:V8 Clusterfuzz Linux64 - debug builder",
"parent_buildnumber:3958",
"user_agent:recipe"
]
}
[22:24:30.843] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1539296669803093",
"id": "8932924171122590976",
"lease_expiration_ts": "1539424470616286",
"lease_key": "1110036976",
"parameters_json": "{\"builder_name\": \"V8 NumFuzz - debug\", \"properties\": {\"parent_build_config\": \"Debug\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = true is_debug = true target_cpu = \\\"x64\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true\"}, \"parent_buildername\": \"V8 Clusterfuzz Linux64 - debug builder\", \"parent_got_revision\": \"71898faf88ef02659aaf6055ac513171e338c8fe\", \"parent_got_revision_cp\": \"refs/heads/master@{#56581}\", \"parent_got_swarming_client_revision\": \"486c9b53c4d54dd4b95bb6ce0e31160e600dfc11\", \"revision\": \"71898faf88ef02659aaf6055ac513171e338c8fe\", \"swarm_hashes\": {\"d8_default\": \"97badaf9cdc7f52b6ee4fc64beb4c90de30dd546\", \"run-num-fuzzer\": \"55cef87b3d18499aca178329d13d3baf9c8e939e\"}}}",
"project": "v8",
"result_details_json": "null",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1539296670759855",
"tags": [
"build_address:luci.v8.ci/V8 NumFuzz - debug/3224",
"builder:V8 NumFuzz - debug",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/71898faf88ef02659aaf6055ac513171e338c8fe",
"gitiles_ref:refs/heads/master",
"parent_buildername:V8 Clusterfuzz Linux64 - debug builder",
"parent_buildnumber:3958",
"scheduler_invocation_id:9098354233411197424",
"scheduler_job_id:v8/V8 NumFuzz - debug",
"swarming_dimension:host_class:multibot",
"swarming_dimension:pool:luci.v8.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.v8.ci/V8 NumFuzz - debug/3224",
"swarming_tag:buildbucket_bucket:luci.v8.ci",
"swarming_tag:buildbucket_build_id:8932924171122590976",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4c790cbde9342069ed9b59b6709c8807b14f2913",
"swarming_tag:builder:V8 NumFuzz - debug",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/71898faf88ef02659aaf6055ac513171e338c8fe",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:host_class:multibot",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8932924171122590976/+/annotations",
"swarming_tag:luci_project:v8",
"swarming_tag:parent_buildername:V8 Clusterfuzz Linux64 - debug builder",
"swarming_tag:parent_buildnumber:3958",
"swarming_tag:pool:luci.v8.ci",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:v8",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9098354233411197424",
"swarming_tag:scheduler_job_id:v8/V8 NumFuzz - debug",
"swarming_tag:service_account:v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:02984296a6429d35f9eb152239263b748ed182ad",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:user_agent:recipe",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:407e0cba99e46e10",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1539296670759946",
"url": "https://ci.chromium.org/p/v8/builders/luci.v8.ci/V8 NumFuzz - debug/3224",
"utcnow_ts": "1539296670832138"
}
}
[22:24:30.843] Task URL: https://ci.chromium.org/p/v8/builders/luci.v8.ci/V8 NumFuzz - debug/3224
[22:24:30.843] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:2:0) after 1m0s
[22:24:32.532] Received PubSub notification, asking Buildbucket for the build status
[22:24:32.641] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:30.861] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:2:0)
[22:25:30.861] Timer tick, asking Buildbucket for the build status
[22:25:31.014] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:31.014] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:4:0) after 1m0s
[22:26:31.037] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:4:0)
[22:26:31.037] Timer tick, asking Buildbucket for the build status
[22:26:31.113] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:31.113] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:5:0) after 1m0s
[22:27:31.141] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:5:0)
[22:27:31.141] Timer tick, asking Buildbucket for the build status
[22:27:31.188] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:31.188] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:6:0) after 1m0s
[22:28:31.207] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:6:0)
[22:28:31.208] Timer tick, asking Buildbucket for the build status
[22:28:31.269] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:31.269] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:7:0) after 1m0s
[22:29:31.301] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:7:0)
[22:29:31.302] Timer tick, asking Buildbucket for the build status
[22:29:31.337] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:31.337] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:8:0) after 1m0s
[22:30:31.366] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:8:0)
[22:30:31.366] Timer tick, asking Buildbucket for the build status
[22:30:31.416] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:31.416] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:9:0) after 1m0s
[22:31:31.440] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:9:0)
[22:31:31.440] Timer tick, asking Buildbucket for the build status
[22:31:31.482] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:31.482] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:10:0) after 1m0s
[22:32:31.502] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:10:0)
[22:32:31.502] Timer tick, asking Buildbucket for the build status
[22:32:31.582] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:31.582] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:11:0) after 1m0s
[22:33:31.604] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:11:0)
[22:33:31.604] Timer tick, asking Buildbucket for the build status
[22:33:31.643] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:31.643] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:12:0) after 1m0s
[22:34:31.685] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:12:0)
[22:34:31.685] Timer tick, asking Buildbucket for the build status
[22:34:31.748] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:31.749] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:13:0) after 1m0s
[22:35:31.767] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:13:0)
[22:35:31.767] Timer tick, asking Buildbucket for the build status
[22:35:31.809] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:31.809] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:14:0) after 1m0s
[22:36:31.833] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:14:0)
[22:36:31.833] Timer tick, asking Buildbucket for the build status
[22:36:31.897] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:31.897] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:15:0) after 1m0s
[22:37:31.920] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:15:0)
[22:37:31.920] Timer tick, asking Buildbucket for the build status
[22:37:31.958] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:31.958] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:16:0) after 1m0s
[22:38:32.009] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:16:0)
[22:38:32.009] Timer tick, asking Buildbucket for the build status
[22:38:32.079] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:32.079] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:17:0) after 1m0s
[22:39:32.107] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:17:0)
[22:39:32.107] Timer tick, asking Buildbucket for the build status
[22:39:32.164] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:32.164] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:18:0) after 1m0s
[22:40:32.196] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:18:0)
[22:40:32.196] Timer tick, asking Buildbucket for the build status
[22:40:32.290] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:32.290] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:19:0) after 1m0s
[22:41:32.310] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:19:0)
[22:41:32.310] Timer tick, asking Buildbucket for the build status
[22:41:32.351] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:32.351] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:20:0) after 1m0s
[22:42:32.381] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:20:0)
[22:42:32.381] Timer tick, asking Buildbucket for the build status
[22:42:32.443] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:32.443] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:21:0) after 1m0s
[22:43:32.463] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:21:0)
[22:43:32.463] Timer tick, asking Buildbucket for the build status
[22:43:32.493] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:32.493] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:22:0) after 1m0s
[22:44:32.524] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:22:0)
[22:44:32.524] Timer tick, asking Buildbucket for the build status
[22:44:32.598] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:32.598] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:23:0) after 1m0s
[22:45:32.618] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:23:0)
[22:45:32.618] Timer tick, asking Buildbucket for the build status
[22:45:32.665] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:32.665] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:24:0) after 1m0s
[22:46:32.692] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:24:0)
[22:46:32.692] Timer tick, asking Buildbucket for the build status
[22:46:32.775] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:32.775] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:25:0) after 1m0s
[22:47:32.800] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:25:0)
[22:47:32.800] Timer tick, asking Buildbucket for the build status
[22:47:32.889] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:32.889] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:26:0) after 1m0s
[22:48:32.914] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:26:0)
[22:48:32.914] Timer tick, asking Buildbucket for the build status
[22:48:33.035] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:33.035] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:27:0) after 1m0s
[22:49:33.082] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:27:0)
[22:49:33.082] Timer tick, asking Buildbucket for the build status
[22:49:33.123] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:33.123] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:28:0) after 1m0s
[22:50:33.212] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:28:0)
[22:50:33.212] Timer tick, asking Buildbucket for the build status
[22:50:33.291] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:33.291] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:29:0) after 1m0s
[22:51:33.432] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:29:0)
[22:51:33.432] Timer tick, asking Buildbucket for the build status
[22:51:33.470] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:33.470] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:30:0) after 1m0s
[22:52:33.519] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:30:0)
[22:52:33.519] Timer tick, asking Buildbucket for the build status
[22:52:33.691] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:33.691] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:31:0) after 1m0s
[22:53:33.710] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:31:0)
[22:53:33.710] Timer tick, asking Buildbucket for the build status
[22:53:33.814] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:33.814] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:32:0) after 1m0s
[22:54:33.865] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:32:0)
[22:54:33.865] Timer tick, asking Buildbucket for the build status
[22:54:34.014] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:34.014] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:33:0) after 1m0s
[22:55:34.041] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:33:0)
[22:55:34.041] Timer tick, asking Buildbucket for the build status
[22:55:34.139] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:34.139] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:34:0) after 1m0s
[22:56:34.177] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:34:0)
[22:56:34.177] Timer tick, asking Buildbucket for the build status
[22:56:34.355] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:34.355] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:35:0) after 1m0s
[22:57:34.386] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:35:0)
[22:57:34.386] Timer tick, asking Buildbucket for the build status
[22:57:34.483] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:34.483] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:36:0) after 1m0s
[22:58:34.537] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:36:0)
[22:58:34.537] Timer tick, asking Buildbucket for the build status
[22:58:34.612] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:34.612] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:37:0) after 1m0s
[22:59:34.671] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:37:0)
[22:59:34.671] Timer tick, asking Buildbucket for the build status
[22:59:34.711] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:34.711] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:38:0) after 1m0s
[23:00:34.745] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:38:0)
[23:00:34.745] Timer tick, asking Buildbucket for the build status
[23:00:34.814] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:34.814] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:39:0) after 1m0s
[23:01:34.860] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:39:0)
[23:01:34.860] Timer tick, asking Buildbucket for the build status
[23:01:34.908] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:34.908] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:40:0) after 1m0s
[23:02:34.948] Handling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:40:0)
[23:02:34.949] Timer tick, asking Buildbucket for the build status
[23:02:35.026] Build 8932924171122590976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:35.121] Scheduling timer "check-buildbucket-build-status" (v8/V8 NumFuzz - debug:9098354233411197424:41:0) after 1m0s
[23:02:45.305] Received PubSub notification, asking Buildbucket for the build status
[23:02:45.346] Build 8932924171122590976: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[23:02:45.346] Buildbucket build:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "AUTO",
"completed_ts": "1539298963283753",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1539296669803093",
"failure_reason": "INFRA_FAILURE",
"id": "8932924171122590976",
"parameters_json": "{\"builder_name\": \"V8 NumFuzz - debug\", \"properties\": {\"parent_build_config\": \"Debug\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = true is_debug = true target_cpu = \\\"x64\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true\"}, \"parent_buildername\": \"V8 Clusterfuzz Linux64 - debug builder\", \"parent_got_revision\": \"71898faf88ef02659aaf6055ac513171e338c8fe\", \"parent_got_revision_cp\": \"refs/heads/master@{#56581}\", \"parent_got_swarming_client_revision\": \"486c9b53c4d54dd4b95bb6ce0e31160e600dfc11\", \"revision\": \"71898faf88ef02659aaf6055ac513171e338c8fe\", \"swarm_hashes\": {\"d8_default\": \"97badaf9cdc7f52b6ee4fc64beb4c90de30dd546\", \"run-num-fuzzer\": \"55cef87b3d18499aca178329d13d3baf9c8e939e\"}}}",
"project": "v8",
"result": "FAILURE",
"result_details_json": "{\"ui\": {\"info\": \"Failure Num Fuzz - endurance\\nFailure Uncaught Exception\"}, \"build_run_result\": {\"infraFailure\": {\"text\": \"recipe infra failure: Uncaught Exception: TypeError(\\\"object of type 'NoneType' has no len()\\\",)\", \"bootstrapperCallStack\": [], \"type\": \"RECIPE_INFRA_FAILURE\"}, \"recipeResult\": {\"failure\": {\"exception\": {\"traceback\": [\"Traceback (most recent call last):\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/recipe_engine/recipe_engine/run.py\\\", line 298, in _new_run\", \" recipe_result = recipe_script.run(api, self.properties, self.environ)\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/recipe_engine/recipe_engine/loader.py\\\", line 108, in run\", \" self.run_steps, properties, environ, self.PROPERTIES, api=api)\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/recipe_engine/recipe_engine/loader.py\\\", line 636, in invoke_with_properties\", \" arg_names, **additional_args)\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/recipe_engine/recipe_engine/loader.py\\\", line 599, in _invoke_with_properties\", \" return callable_obj(*props, **additional_args)\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/build/scripts/slave/recipes/v8.py\\\", line 131, in RunSteps\", \" test_results = v8.runtests(tests)\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/recipe_engine/recipe_engine/recipe_api.py\\\", line 765, in _inner\", \" return func(*a, **kw)\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/v8/api.py\\\", line 1019, in runtests\", \" test_results += t.run(coverage_context=coverage_context)\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/v8/testing.py\\\", line 583, in run\", \" return result + self.post_run(self.test, coverage_context)\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/v8/testing.py\\\", line 401, in post_run\", \" assert len(json_output) == 1\", \"TypeError: object of type 'NoneType' has no len()\"]}, \"humanReason\": \"Uncaught Exception: TypeError(\\\"object of type 'NoneType' has no len()\\\",)\"}}, \"recipeExitCode\": {\"value\": 1}, \"recipe\": {\"name\": \"v8\", \"repository\": \"\", \"revision\": \"\"}, \"annotationUrl\": \"logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8932924171122590976/+/annotations\"}, \"swarming\": {\"bot_dimensions\": {\"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-f\"], \"inside_docker\": [\"1\", \"stock\"], \"python\": [\"2.7.6\"], \"image\": [\"chrome-trusty-18042300-b7223b463e3\"], \"kvm\": [\"0\"], \"gpu\": [\"none\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Ivy_Bridge_GCE\"], \"server_version\": [\"3809-a31bbe1\"], \"machine_type\": [\"n1-standard-8\"], \"host_class\": [\"multibot\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"swarm-docker-3-c4--022\"], \"pool\": [\"luci.v8.ci\"], \"caches\": [\"vpython\"]}}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"buildnumber\": 3224, \"parent_buildername\": \"V8 Clusterfuzz Linux64 - debug builder\", \"parent_got_swarming_client_revision\": \"486c9b53c4d54dd4b95bb6ce0e31160e600dfc11\", \"buildername\": \"V8 NumFuzz - debug\", \"got_revision\": \"71898faf88ef02659aaf6055ac513171e338c8fe\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = true is_debug = true target_cpu = \\\"x64\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true\"}, \"recipe\": \"v8\", \"mastername\": \"client.v8.clusterfuzz\", \"parent_got_revision\": \"71898faf88ef02659aaf6055ac513171e338c8fe\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1539296669803093, \"tags\": [\"builder:V8 NumFuzz - debug\", \"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/71898faf88ef02659aaf6055ac513171e338c8fe\", \"gitiles_ref:refs/heads/master\", \"parent_buildername:V8 Clusterfuzz Linux64 - debug builder\", \"parent_buildnumber:3958\", \"scheduler_invocation_id:9098354233411197424\", \"scheduler_job_id:v8/V8 NumFuzz - debug\", \"user_agent:luci-scheduler\", \"user_agent:recipe\"], \"bucket\": \"luci.v8.ci\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"v8\", \"id\": \"8932924171122590976\"}}, \"got_revision_cp\": \"refs/heads/master@{#56581}\", \"swarm_hashes\": {\"d8_default\": \"97badaf9cdc7f52b6ee4fc64beb4c90de30dd546\", \"run-num-fuzzer\": \"55cef87b3d18499aca178329d13d3baf9c8e939e\"}, \"parent_got_revision_cp\": \"refs/heads/master@{#56581}\", \"path_config\": \"generic\", \"revision\": \"71898faf88ef02659aaf6055ac513171e338c8fe\", \"parent_build_config\": \"Debug\", \"bot_id\": \"swarm-docker-3-c4--022\"}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1539296671228476",
"status": "COMPLETED",
"status_changed_ts": "1539298964123271",
"tags": [
"build_address:luci.v8.ci/V8 NumFuzz - debug/3224",
"builder:V8 NumFuzz - debug",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/71898faf88ef02659aaf6055ac513171e338c8fe",
"gitiles_ref:refs/heads/master",
"parent_buildername:V8 Clusterfuzz Linux64 - debug builder",
"parent_buildnumber:3958",
"scheduler_invocation_id:9098354233411197424",
"scheduler_job_id:v8/V8 NumFuzz - debug",
"swarming_dimension:host_class:multibot",
"swarming_dimension:pool:luci.v8.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.v8.ci/V8 NumFuzz - debug/3224",
"swarming_tag:buildbucket_bucket:luci.v8.ci",
"swarming_tag:buildbucket_build_id:8932924171122590976",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4c790cbde9342069ed9b59b6709c8807b14f2913",
"swarming_tag:builder:V8 NumFuzz - debug",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/71898faf88ef02659aaf6055ac513171e338c8fe",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:host_class:multibot",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8932924171122590976/+/annotations",
"swarming_tag:luci_project:v8",
"swarming_tag:parent_buildername:V8 Clusterfuzz Linux64 - debug builder",
"swarming_tag:parent_buildnumber:3958",
"swarming_tag:pool:luci.v8.ci",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:v8",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9098354233411197424",
"swarming_tag:scheduler_job_id:v8/V8 NumFuzz - debug",
"swarming_tag:service_account:v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:02984296a6429d35f9eb152239263b748ed182ad",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:user_agent:recipe",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:407e0cba99e46e10",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1539298964125979",
"url": "https://ci.chromium.org/p/v8/builders/luci.v8.ci/V8 NumFuzz - debug/3224",
"utcnow_ts": "1539298965332777"
}
}
[23:02:45.346] Invocation finished in 38m17.109731987s with status FAILED