[15:45:00.404] New invocation is queued and will start shortly
[15:45:00.404] Triggered by user:v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[15:45:01.541] Starting the invocation (attempt 1)
[15:45:01.586] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/148f3ab55793c13e01fdcce98a2392dfdb4be9c4"
[15:45:01.586] Reconstructed gitiles commit from tags
[15:45:01.586] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:45:01.586] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:45:01.586] Buildbucket request:
{
"requestId": "8988575842245948448",
"builder": {
"project": "v8",
"bucket": "ci.br.stable",
"builder": "V8 Mac64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"triggers": [
{
"buildbucket": {
"properties": {
"newest_gitiles_revision": "148f3ab55793c13e01fdcce98a2392dfdb4be9c4",
"oldest_gitiles_revision": "148f3ab55793c13e01fdcce98a2392dfdb4be9c4",
"parent_build": "https://cr-buildbucket.appspot.com/build/8823154530624488577",
"parent_buildername": "V8 Mac64 - builder",
"parent_gn_args": [
"dcheck_always_on = false",
"is_component_build = false",
"is_debug = false",
"target_cpu = \"x64\"",
"use_goma = true",
"v8_enable_google_benchmark = true"
],
"parent_got_revision": "148f3ab55793c13e01fdcce98a2392dfdb4be9c4",
"parent_got_revision_cp": "refs/branch-heads/9.8@{#19}",
"parent_test_spec": {
"swarming_dimensions": {
"cpu": "x86-64",
"os": "Mac-10.15"
},
"swarming_task_attrs": {
},
"tests": [
[
"mozilla",
1,
null,
"",
[
],
{
},
{
}
],
[
"test262",
3,
"default",
"default",
[
],
{
},
{
}
],
[
"v8testing",
3,
null,
"",
[
],
{
},
{
}
],
[
"v8testing",
3,
"extra",
"extra",
[
],
{
},
{
}
]
]
},
"revision": "148f3ab55793c13e01fdcce98a2392dfdb4be9c4",
"swarm_hashes": {
"bot_default": "f0249c17c42f2abad10507acf984be48371a9b1529c5db89317c9ffb482c303d/319",
"mozilla": "d4bd11b6fe4ba2dcbcf0481866f1e089a8828c678ec569503fbe6c59261ea3cd/318",
"test262": "f770a3db05bef196c2796706eaa49b4f0c9707876fa2a58332fe1ac53fefa08c/318"
}
},
"tags": [
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/148f3ab55793c13e01fdcce98a2392dfdb4be9c4",
"gitiles_ref:refs/branch-heads/9.8",
"parent_buildername:V8 Mac64 - builder",
"parent_buildnumber:69",
"user_agent:recipe"
]
},
"id": "8d1b4630-3c72-43f6-86a0-9a980b51503d",
"title": "V8 Mac64 - builder/69"
}
]
},
"newest_gitiles_revision": "148f3ab55793c13e01fdcce98a2392dfdb4be9c4",
"oldest_gitiles_revision": "148f3ab55793c13e01fdcce98a2392dfdb4be9c4",
"parent_build": "https://cr-buildbucket.appspot.com/build/8823154530624488577",
"parent_buildername": "V8 Mac64 - builder",
"parent_gn_args": [
"dcheck_always_on = false",
"is_component_build = false",
"is_debug = false",
"target_cpu = \"x64\"",
"use_goma = true",
"v8_enable_google_benchmark = true"
],
"parent_got_revision": "148f3ab55793c13e01fdcce98a2392dfdb4be9c4",
"parent_got_revision_cp": "refs/branch-heads/9.8@{#19}",
"parent_test_spec": {
"swarming_dimensions": {
"cpu": "x86-64",
"os": "Mac-10.15"
},
"swarming_task_attrs": {
},
"tests": [
[
"mozilla",
1,
null,
"",
[
],
{
},
{
}
],
[
"test262",
3,
"default",
"default",
[
],
{
},
{
}
],
[
"v8testing",
3,
null,
"",
[
],
{
},
{
}
],
[
"v8testing",
3,
"extra",
"extra",
[
],
{
},
{
}
]
]
},
"swarm_hashes": {
"bot_default": "f0249c17c42f2abad10507acf984be48371a9b1529c5db89317c9ffb482c303d/319",
"mozilla": "d4bd11b6fe4ba2dcbcf0481866f1e089a8828c678ec569503fbe6c59261ea3cd/318",
"test262": "f770a3db05bef196c2796706eaa49b4f0c9707876fa2a58332fe1ac53fefa08c/318"
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "148f3ab55793c13e01fdcce98a2392dfdb4be9c4",
"ref": "refs/branch-heads/9.8"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8988575842245948448"
},
{
"key": "scheduler_job_id",
"value": "v8/ci.br.stable-V8 Mac64"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "V8 Mac64 - builder"
},
{
"key": "parent_buildnumber",
"value": "69"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:45:02.270] Scheduled build:
{
"id": "8823145780237632049",
"builder": {
"project": "v8",
"bucket": "ci.br.stable",
"builder": "V8 Mac64"
},
"number": 242,
"createdBy": "project:v8",
"createTime": "2022-02-04T15:45:01.687488434Z",
"updateTime": "2022-02-04T15:45:01.687488434Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "148f3ab55793c13e01fdcce98a2392dfdb4be9c4",
"ref": "refs/branch-heads/9.8"
}
}
}
[15:45:02.270] Task URL: https://cr-buildbucket.appspot.com/build/8823145780237632049
[15:45:02.270] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:2:0) after 1m21s
[15:46:23.574] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:2:0)
[15:46:23.603] Build status: SCHEDULED
[15:46:23.603] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:3:0) after 8m25s
[15:54:48.658] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:3:0)
[15:54:48.686] Build status: SCHEDULED
[15:54:48.686] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:4:0) after 4m38s
[15:59:26.815] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:4:0)
[15:59:26.849] Build status: SCHEDULED
[15:59:26.849] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:5:0) after 6m26s
[16:05:53.087] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:5:0)
[16:05:53.119] Build status: SCHEDULED
[16:05:53.119] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:6:0) after 6m23s
[16:12:16.425] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:6:0)
[16:12:16.452] Build status: SCHEDULED
[16:12:16.452] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:7:0) after 6m9s
[16:18:25.669] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:7:0)
[16:18:25.713] Build status: SCHEDULED
[16:18:25.713] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:8:0) after 6m19s
[16:24:44.838] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:8:0)
[16:24:44.868] Build status: SCHEDULED
[16:24:44.868] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:9:0) after 1m46s
[16:26:31.128] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:9:0)
[16:26:31.160] Build status: SCHEDULED
[16:26:31.160] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:10:0) after 5m19s
[16:31:50.834] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:10:0)
[16:31:50.868] Build status: SCHEDULED
[16:31:50.868] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:11:0) after 4m38s
[16:36:29.065] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:11:0)
[16:36:29.097] Build status: SCHEDULED
[16:36:29.097] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:12:0) after 3m32s
[16:40:01.213] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:12:0)
[16:40:01.297] Build status: SCHEDULED
[16:40:01.297] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:13:0) after 6m49s
[16:46:50.322] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:13:0)
[16:46:50.451] Build status: SCHEDULED
[16:46:50.451] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:14:0) after 1m53s
[16:48:43.559] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:14:0)
[16:48:43.593] Build status: SCHEDULED
[16:48:43.593] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:15:0) after 1m29s
[16:50:12.726] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:15:0)
[16:50:12.748] Build status: SCHEDULED
[16:50:12.748] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:16:0) after 8m23s
[16:58:35.809] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:16:0)
[16:58:35.836] Build status: SCHEDULED
[16:58:35.836] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:17:0) after 9m10s
[17:07:45.854] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:17:0)
[17:07:45.894] Build status: SCHEDULED
[17:07:45.894] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:18:0) after 4m52s
[17:12:37.871] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:18:0)
[17:12:37.900] Build status: SCHEDULED
[17:12:37.900] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:19:0) after 9m2s
[17:21:40.285] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:19:0)
[17:21:40.330] Build status: SCHEDULED
[17:21:40.330] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:20:0) after 1m59s
[17:23:39.520] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:20:0)
[17:23:39.577] Build status: SCHEDULED
[17:23:39.577] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:21:0) after 5m50s
[17:29:29.606] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:21:0)
[17:29:29.648] Build status: SCHEDULED
[17:29:29.648] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:22:0) after 6m14s
[17:35:43.812] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:22:0)
[17:35:43.845] Build status: SCHEDULED
[17:35:43.845] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:23:0) after 5m51s
[17:41:34.900] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:23:0)
[17:41:34.930] Build status: SCHEDULED
[17:41:34.930] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:24:0) after 9m22s
[17:50:56.973] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:24:0)
[17:50:57.064] Build status: SCHEDULED
[17:50:57.064] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:25:0) after 3m33s
[17:54:30.084] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:25:0)
[17:54:30.116] Build status: SCHEDULED
[17:54:30.116] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:26:0) after 8m1s
[18:02:31.489] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:26:0)
[18:02:31.509] Build status: SCHEDULED
[18:02:31.509] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:27:0) after 7m8s
[18:09:39.530] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:27:0)
[18:09:39.561] Build status: SCHEDULED
[18:09:39.561] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:28:0) after 4m3s
[18:13:42.592] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:28:0)
[18:13:42.619] Build status: SCHEDULED
[18:13:42.619] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:29:0) after 3m11s
[18:16:54.696] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:29:0)
[18:16:54.730] Build status: SCHEDULED
[18:16:54.730] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:30:0) after 1m21s
[18:18:16.407] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:30:0)
[18:18:16.437] Build status: SCHEDULED
[18:18:16.437] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:31:0) after 7m32s
[18:25:48.593] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:31:0)
[18:25:48.624] Build status: SCHEDULED
[18:25:48.624] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:32:0) after 9m26s
[18:35:14.650] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:32:0)
[18:35:14.673] Build status: SCHEDULED
[18:35:14.673] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:33:0) after 4m54s
[18:40:08.693] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:33:0)
[18:40:08.723] Build status: SCHEDULED
[18:40:08.723] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:34:0) after 6m33s
[18:46:41.731] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:34:0)
[18:46:41.764] Build status: SCHEDULED
[18:46:41.764] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:35:0) after 1m24s
[18:48:06.112] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:35:0)
[18:48:06.242] Build status: SCHEDULED
[18:48:06.242] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:36:0) after 7m54s
[18:56:00.323] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:36:0)
[18:56:00.360] Build status: SCHEDULED
[18:56:00.360] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:37:0) after 3m16s
[18:59:16.440] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:37:0)
[18:59:16.483] Build status: SCHEDULED
[18:59:16.483] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:38:0) after 2m51s
[19:02:07.599] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:38:0)
[19:02:07.630] Build status: SCHEDULED
[19:02:07.630] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:39:0) after 7m59s
[19:09:50.414] Received PubSub notification, asking Buildbucket for the build status
[19:09:50.549] Build status: STARTED
[19:10:06.653] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:39:0)
[19:10:06.688] Build status: STARTED
[19:10:06.688] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:41:0) after 8m51s
[19:18:57.753] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:41:0)
[19:18:57.787] Build status: STARTED
[19:18:57.787] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Mac64:8988575842245948448:42:0) after 4m28s
[19:21:54.279] Received PubSub notification, asking Buildbucket for the build status
[19:21:54.312] Build:
{
"id": "8823145780237632049",
"builder": {
"project": "v8",
"bucket": "ci.br.stable",
"builder": "V8 Mac64"
},
"number": 242,
"createdBy": "project:v8",
"createTime": "2022-02-04T15:45:01.687488434Z",
"startTime": "2022-02-04T19:09:47.918113Z",
"endTime": "2022-02-04T19:21:53.169093695Z",
"updateTime": "2022-02-04T19:21:53.169093695Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "148f3ab55793c13e01fdcce98a2392dfdb4be9c4",
"ref": "refs/branch-heads/9.8"
}
}
}
[19:21:54.312] Invocation finished in 3h36m53.924089903s with status SUCCEEDED