[15:13:54.871] New invocation is queued and will start shortly
[15:13:54.871] Triggered by user:v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[15:13:56.042] Starting the invocation (attempt 1)
[15:13:56.082] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/8f264ba37c15262032ad18853c8d95ffaf4312b6"
[15:13:56.082] Reconstructed gitiles commit from tags
[15:13:56.082] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:13:56.082] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:13:56.083] Buildbucket request:
{
"requestId": "9000989582795881664",
"builder": {
"project": "v8",
"bucket": "ci.br.beta",
"builder": "V8 Win32 - debug"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"triggers": [
{
"buildbucket": {
"properties": {
"newest_gitiles_revision": "8f264ba37c15262032ad18853c8d95ffaf4312b6",
"oldest_gitiles_revision": "8f264ba37c15262032ad18853c8d95ffaf4312b6",
"parent_build_environment": {
"gn_args": "is_component_build = true is_debug = true symbol_level = 1 target_cpu = \"x86\" use_goma = true v8_enable_backtrace = true v8_enable_google_benchmark = true v8_enable_slow_dchecks = true"
},
"parent_buildername": "V8 Win32 - debug builder",
"parent_got_revision": "8f264ba37c15262032ad18853c8d95ffaf4312b6",
"parent_got_revision_cp": "refs/branch-heads/9.5@{#22}",
"parent_test_spec": {
"swarming_dimensions": {
"cpu": "x86-64",
"os": "Windows-7-SP1"
},
"swarming_task_attrs": {
},
"tests": [
[
"mozilla",
1,
null,
"",
[
],
{
},
{
}
],
[
"test262",
1,
"default",
"default",
[
],
{
},
{
}
],
[
"v8testing",
5,
null,
"",
[
],
{
},
{
}
]
]
},
"revision": "8f264ba37c15262032ad18853c8d95ffaf4312b6",
"swarm_hashes": {
"bot_default": "86427a92d6630e87ab8dd8e87aa524d93beac40cddc82d20cc66cce38695c724/319",
"mozilla": "37f4550301be931cc36ff1c83a658fd9378034e9bdbc8a3da6f0d535c8bdac6b/318",
"test262": "e9c46eafd62d05704a0ac386cabb106f5510268c8c9167b518e3a802bf9fa36c/318"
}
},
"tags": [
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/8f264ba37c15262032ad18853c8d95ffaf4312b6",
"gitiles_ref:refs/branch-heads/9.5",
"parent_buildername:V8 Win32 - debug builder",
"parent_buildnumber:354",
"user_agent:recipe"
]
},
"id": "c7fe3f5e-7d17-44b5-bc3f-1b47ba28c896",
"title": "V8 Win32 - debug builder/354"
}
]
},
"newest_gitiles_revision": "8f264ba37c15262032ad18853c8d95ffaf4312b6",
"oldest_gitiles_revision": "8f264ba37c15262032ad18853c8d95ffaf4312b6",
"parent_build_environment": {
"gn_args": "is_component_build = true is_debug = true symbol_level = 1 target_cpu = \"x86\" use_goma = true v8_enable_backtrace = true v8_enable_google_benchmark = true v8_enable_slow_dchecks = true"
},
"parent_buildername": "V8 Win32 - debug builder",
"parent_got_revision": "8f264ba37c15262032ad18853c8d95ffaf4312b6",
"parent_got_revision_cp": "refs/branch-heads/9.5@{#22}",
"parent_test_spec": {
"swarming_dimensions": {
"cpu": "x86-64",
"os": "Windows-7-SP1"
},
"swarming_task_attrs": {
},
"tests": [
[
"mozilla",
1,
null,
"",
[
],
{
},
{
}
],
[
"test262",
1,
"default",
"default",
[
],
{
},
{
}
],
[
"v8testing",
5,
null,
"",
[
],
{
},
{
}
]
]
},
"swarm_hashes": {
"bot_default": "86427a92d6630e87ab8dd8e87aa524d93beac40cddc82d20cc66cce38695c724/319",
"mozilla": "37f4550301be931cc36ff1c83a658fd9378034e9bdbc8a3da6f0d535c8bdac6b/318",
"test262": "e9c46eafd62d05704a0ac386cabb106f5510268c8c9167b518e3a802bf9fa36c/318"
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "8f264ba37c15262032ad18853c8d95ffaf4312b6",
"ref": "refs/branch-heads/9.5"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9000989582795881664"
},
{
"key": "scheduler_job_id",
"value": "v8/ci.br.beta-V8 Win32 - debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "V8 Win32 - debug builder"
},
{
"key": "parent_buildnumber",
"value": "354"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:13:56.700] Scheduled build:
{
"id": "8835559520792657777",
"builder": {
"project": "v8",
"bucket": "ci.br.beta",
"builder": "V8 Win32 - debug"
},
"number": 344,
"createdBy": "project:v8",
"createTime": "2021-09-20T15:13:56.149466533Z",
"updateTime": "2021-09-20T15:13:56.539543425Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "8f264ba37c15262032ad18853c8d95ffaf4312b6",
"ref": "refs/branch-heads/9.5"
}
}
}
[15:13:56.700] Task URL: https://cr-buildbucket.appspot.com/build/8835559520792657777
[15:13:56.700] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:2:0) after 4m57s
[15:18:53.825] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:2:0)
[15:18:53.866] Build status: SCHEDULED
[15:18:53.866] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:3:0) after 3m27s
[15:22:20.887] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:3:0)
[15:22:20.961] Build status: SCHEDULED
[15:22:20.961] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:4:0) after 4m17s
[15:26:37.989] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:4:0)
[15:26:38.118] Build status: SCHEDULED
[15:26:38.118] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:5:0) after 2m49s
[15:29:27.289] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:5:0)
[15:29:27.366] Build status: SCHEDULED
[15:29:27.366] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:6:0) after 2m44s
[15:32:11.421] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:6:0)
[15:32:11.493] Build status: SCHEDULED
[15:32:11.493] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:7:0) after 4m6s
[15:36:17.525] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:7:0)
[15:36:17.563] Build status: SCHEDULED
[15:36:17.563] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:8:0) after 8m31s
[15:44:48.680] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:8:0)
[15:44:48.713] Build status: SCHEDULED
[15:44:48.713] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:9:0) after 4m19s
[15:49:07.941] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:9:0)
[15:49:08.050] Build status: SCHEDULED
[15:49:08.050] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:10:0) after 2m39s
[15:51:47.707] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:10:0)
[15:51:47.732] Build status: SCHEDULED
[15:51:47.732] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:11:0) after 1m28s
[15:53:15.753] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:11:0)
[15:53:15.791] Build status: SCHEDULED
[15:53:15.791] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:12:0) after 3m33s
[15:56:48.813] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:12:0)
[15:56:48.843] Build status: SCHEDULED
[15:56:48.843] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:13:0) after 5m20s
[16:02:08.920] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:13:0)
[16:02:09.066] Build status: SCHEDULED
[16:02:09.066] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:14:0) after 3m59s
[16:06:08.221] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:14:0)
[16:06:08.249] Build status: SCHEDULED
[16:06:08.249] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:15:0) after 2m49s
[16:08:57.272] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:15:0)
[16:08:57.307] Build status: SCHEDULED
[16:08:57.307] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:16:0) after 4m38s
[16:13:35.325] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:16:0)
[16:13:35.362] Build status: SCHEDULED
[16:13:35.362] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:17:0) after 8m30s
[16:22:05.797] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:17:0)
[16:22:05.850] Build status: SCHEDULED
[16:22:05.850] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:18:0) after 6m0s
[16:28:05.873] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:18:0)
[16:28:05.908] Build status: SCHEDULED
[16:28:05.908] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:19:0) after 4m15s
[16:32:20.963] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:19:0)
[16:32:21.003] Build status: SCHEDULED
[16:32:21.004] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:20:0) after 9m21s
[16:41:42.155] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:20:0)
[16:41:42.186] Build status: SCHEDULED
[16:41:42.186] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:21:0) after 4m34s
[16:46:16.219] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:21:0)
[16:46:16.255] Build status: SCHEDULED
[16:46:16.255] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:22:0) after 8m52s
[16:55:08.706] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:22:0)
[16:55:08.828] Build status: SCHEDULED
[16:55:08.828] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:23:0) after 3m40s
[16:58:48.933] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:23:0)
[16:58:48.970] Build status: SCHEDULED
[16:58:48.970] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:24:0) after 5m44s
[17:04:33.118] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:24:0)
[17:04:33.164] Build status: SCHEDULED
[17:04:33.164] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:25:0) after 5m54s
[17:10:27.191] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:25:0)
[17:10:27.245] Build status: SCHEDULED
[17:10:27.245] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:26:0) after 1m49s
[17:12:16.551] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:26:0)
[17:12:16.585] Build status: SCHEDULED
[17:12:16.585] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:27:0) after 1m18s
[17:13:34.659] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:27:0)
[17:13:34.697] Build status: SCHEDULED
[17:13:34.697] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:28:0) after 2m24s
[17:15:58.820] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:28:0)
[17:15:58.855] Build status: SCHEDULED
[17:15:58.855] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:29:0) after 6m32s
[17:22:30.877] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:29:0)
[17:22:31.031] Build status: SCHEDULED
[17:22:31.032] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:30:0) after 8m18s
[17:30:49.383] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:30:0)
[17:30:49.423] Build status: SCHEDULED
[17:30:49.423] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:31:0) after 3m18s
[17:34:07.445] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:31:0)
[17:34:07.483] Build status: SCHEDULED
[17:34:07.483] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:32:0) after 7m11s
[17:41:18.743] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:32:0)
[17:41:18.784] Build status: SCHEDULED
[17:41:18.784] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:33:0) after 9m59s
[17:51:18.496] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:33:0)
[17:51:18.542] Build status: SCHEDULED
[17:51:18.542] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:34:0) after 6m40s
[17:57:58.583] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:34:0)
[17:57:58.612] Build status: SCHEDULED
[17:57:58.612] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:35:0) after 2m32s
[18:00:30.761] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:35:0)
[18:00:30.820] Build status: SCHEDULED
[18:00:30.820] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:36:0) after 6m43s
[18:07:13.841] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:36:0)
[18:07:13.888] Build status: SCHEDULED
[18:07:13.888] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:37:0) after 2m31s
[18:09:44.977] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:37:0)
[18:09:45.017] Build status: SCHEDULED
[18:09:45.017] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:38:0) after 2m21s
[18:12:06.037] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:38:0)
[18:12:06.071] Build status: SCHEDULED
[18:12:06.071] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:39:0) after 1m28s
[18:13:34.258] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:39:0)
[18:13:34.303] Build status: SCHEDULED
[18:13:34.303] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:40:0) after 8m21s
[18:21:55.324] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:40:0)
[18:21:55.361] Build status: SCHEDULED
[18:21:55.361] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:41:0) after 5m56s
[18:27:51.428] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:41:0)
[18:27:51.459] Build status: SCHEDULED
[18:27:51.459] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:42:0) after 6m59s
[18:34:50.485] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:42:0)
[18:34:50.519] Build status: SCHEDULED
[18:34:50.519] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:43:0) after 5m45s
[18:40:35.538] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:43:0)
[18:40:35.585] Build status: SCHEDULED
[18:40:35.585] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:44:0) after 2m37s
[18:43:12.612] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:44:0)
[18:43:12.683] Build status: SCHEDULED
[18:43:12.683] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:45:0) after 7m25s
[18:50:37.882] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:45:0)
[18:50:37.915] Build status: SCHEDULED
[18:50:37.915] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:46:0) after 4m55s
[18:55:33.036] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:46:0)
[18:55:33.109] Build status: SCHEDULED
[18:55:33.109] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:47:0) after 4m17s
[18:59:50.128] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:47:0)
[18:59:50.164] Build status: SCHEDULED
[18:59:50.164] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:48:0) after 6m22s
[19:06:12.259] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:48:0)
[19:06:12.301] Build status: SCHEDULED
[19:06:12.301] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:49:0) after 2m55s
[19:09:07.375] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:49:0)
[19:09:07.408] Build status: SCHEDULED
[19:09:07.408] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:50:0) after 5m27s
[19:14:34.524] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:50:0)
[19:14:34.587] Build status: SCHEDULED
[19:14:34.587] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:51:0) after 1m57s
[19:16:31.671] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:51:0)
[19:16:31.714] Build status: SCHEDULED
[19:16:31.714] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:52:0) after 4m11s
[19:20:42.817] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:52:0)
[19:20:42.843] Build status: SCHEDULED
[19:20:42.843] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:53:0) after 2m37s
[19:23:19.883] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:53:0)
[19:23:19.918] Build status: SCHEDULED
[19:23:19.918] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:54:0) after 6m11s
[19:29:31.408] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:54:0)
[19:29:31.446] Build status: SCHEDULED
[19:29:31.446] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:55:0) after 3m16s
[19:32:47.575] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:55:0)
[19:32:47.614] Build status: SCHEDULED
[19:32:47.614] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:56:0) after 4m29s
[19:37:16.657] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:56:0)
[19:37:16.686] Build status: SCHEDULED
[19:37:16.687] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:57:0) after 9m17s
[19:46:33.708] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:57:0)
[19:46:33.740] Build status: SCHEDULED
[19:46:33.740] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:58:0) after 2m25s
[19:48:58.761] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:58:0)
[19:48:58.797] Build status: SCHEDULED
[19:48:58.797] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:59:0) after 3m40s
[19:52:38.839] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:59:0)
[19:52:38.891] Build status: SCHEDULED
[19:52:38.891] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:60:0) after 5m42s
[19:58:20.912] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:60:0)
[19:58:20.962] Build status: SCHEDULED
[19:58:20.962] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:61:0) after 9m14s
[20:07:35.151] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:61:0)
[20:07:35.181] Build status: SCHEDULED
[20:07:35.181] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:62:0) after 6m3s
[20:13:38.321] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:62:0)
[20:13:38.405] Build status: SCHEDULED
[20:13:38.405] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:63:0) after 1m0s
[20:14:38.418] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:63:0)
[20:14:38.451] Build status: SCHEDULED
[20:14:38.451] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:64:0) after 1m46s
[20:16:24.546] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:64:0)
[20:16:24.585] Build status: SCHEDULED
[20:16:24.585] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:65:0) after 9m59s
[20:26:23.695] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:65:0)
[20:26:23.726] Build status: SCHEDULED
[20:26:23.726] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:66:0) after 6m10s
[20:32:33.879] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:66:0)
[20:32:33.913] Build status: SCHEDULED
[20:32:33.913] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:67:0) after 6m23s
[20:32:39.561] Received PubSub notification, asking Buildbucket for the build status
[20:32:39.608] Build status: STARTED
[20:38:56.892] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:67:0)
[20:38:56.922] Build status: STARTED
[20:38:56.922] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:69:0) after 5m33s
[20:44:29.964] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:69:0)
[20:44:30.032] Build status: STARTED
[20:44:30.032] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:70:0) after 9m23s
[20:53:53.440] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:70:0)
[20:53:53.492] Build status: STARTED
[20:53:53.492] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:71:0) after 6m43s
[21:00:36.680] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:71:0)
[21:00:36.713] Build status: STARTED
[21:00:36.713] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9000989582795881664:72:0) after 2m37s
[21:02:46.080] Received PubSub notification, asking Buildbucket for the build status
[21:02:46.135] Build:
{
"id": "8835559520792657777",
"builder": {
"project": "v8",
"bucket": "ci.br.beta",
"builder": "V8 Win32 - debug"
},
"number": 344,
"createdBy": "project:v8",
"createTime": "2021-09-20T15:13:56.149466533Z",
"startTime": "2021-09-20T20:32:37.930484Z",
"endTime": "2021-09-20T21:02:45.213770857Z",
"updateTime": "2021-09-20T21:02:45.214123471Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "8f264ba37c15262032ad18853c8d95ffaf4312b6",
"ref": "refs/branch-heads/9.5"
}
}
}
[21:02:46.135] Invocation finished in 5h48m51.279715914s with status SUCCEEDED