[15:59:58.617] New invocation is queued and will start shortly
[15:59:58.617] Triggered by user:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[15:59:59.827] Starting the invocation (attempt 1)
[15:59:59.851] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/387815d74c1e1da04c64cc432f63b60449bcc72d"
[15:59:59.851] Popped gitiles commit info from properties and tags
[15:59:59.851] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:59:59.851] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:59:59.852] Buildbucket request:
{
"requestId": "8916822103001104832",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "WebKit Win10"
},
"properties": {
"$bootstrap/trigger": {
"commits": [
{
"host": "chromium.googlesource.com",
"id": "387815d74c1e1da04c64cc432f63b60449bcc72d",
"project": "chromium/src",
"ref": "refs/heads/main"
}
]
},
"deps_revision_overrides": {
"src": "387815d74c1e1da04c64cc432f63b60449bcc72d"
},
"parent_build_id": "8751393473110648945",
"parent_builder_group": "chromium.win",
"parent_buildername": "Win Builder",
"parent_got_angle_revision": "49e63e0751263a23b3c79f99c49175ac800ddda2",
"parent_got_dawn_revision": "9fa8edf5c4ec7eead01cc9328ef5196fe15998cc",
"parent_got_revision": "387815d74c1e1da04c64cc432f63b60449bcc72d",
"parent_got_revision_cp": "refs/heads/main@{#1283592}",
"parent_got_swiftshader_revision": "62c59c41e194c288c06739788bb0aad3c86b19bf",
"parent_got_v8_revision": "d05142a52ddd270fb385ede6625833a09c67fd31",
"parent_got_v8_revision_cp": "refs/heads/12.5.169@{#1}",
"parent_got_webrtc_revision": "9bd68dad4d40fb022905545fb698e22963424cf5",
"parent_got_webrtc_revision_cp": "refs/heads/main@{#42003}",
"swarm_hashes": {
"blink_web_tests": "567a4eb3c5b17c3013737409ab92cc6983d88374eb75843410ee45a5d3d78ac9/565",
"blink_wpt_tests": "846cd63fab134b11a754709b41b39aadae3798291fe3ede9337580b135db551d/565"
},
"swarming_command_lines_cwd": "out\\Release",
"swarming_command_lines_digest": "21ceac6fffb9fba639c22e1ab18c7ca27056f83f7d365d2e79705b3d04b81cbc/93"
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "387815d74c1e1da04c64cc432f63b60449bcc72d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8916822103001104832"
},
{
"key": "scheduler_job_id",
"value": "chromium/WebKit Win10"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "Win Builder"
},
{
"key": "parent_buildnumber",
"value": "198570"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[16:00:00.454] Scheduled build:
{
"id": "8751392040997090753",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "WebKit Win10"
},
"number": 131885,
"createdBy": "project:chromium",
"createTime": "2024-04-06T15:59:59.907963461Z",
"updateTime": "2024-04-06T15:59:59.907963461Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "387815d74c1e1da04c64cc432f63b60449bcc72d",
"ref": "refs/heads/main"
}
},
"canary": true
}
[16:00:00.454] Task URL: https://cr-buildbucket.appspot.com/build/8751392040997090753
[16:00:00.454] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916822103001104832:2:0) after 4m2s
[16:00:01.385] Received PubSub notification, asking Buildbucket for the build status
[16:00:01.430] Build status: SCHEDULED
[16:00:07.431] Received PubSub notification, asking Buildbucket for the build status
[16:00:07.502] Build status: STARTED
[16:04:02.594] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916822103001104832:2:0)
[16:04:02.617] Build status: STARTED
[16:04:02.617] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916822103001104832:5:0) after 5m28s
[16:09:30.639] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916822103001104832:5:0)
[16:09:30.659] Build status: STARTED
[16:09:30.659] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916822103001104832:6:0) after 8m41s
[16:18:11.839] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916822103001104832:6:0)
[16:18:11.868] Build status: STARTED
[16:18:11.868] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916822103001104832:7:0) after 4m12s
[16:22:24.064] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916822103001104832:7:0)
[16:22:24.095] Build status: STARTED
[16:22:24.095] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916822103001104832:8:0) after 1m30s
[16:23:54.110] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916822103001104832:8:0)
[16:23:54.150] Build status: STARTED
[16:23:54.150] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916822103001104832:9:0) after 6m17s
[16:24:42.148] Received PubSub notification, asking Buildbucket for the build status
[16:24:42.168] Build:
{
"id": "8751392040997090753",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "WebKit Win10"
},
"number": 131885,
"createdBy": "project:chromium",
"createTime": "2024-04-06T15:59:59.907963461Z",
"startTime": "2024-04-06T16:00:06.611495701Z",
"endTime": "2024-04-06T16:24:41.936455736Z",
"updateTime": "2024-04-06T16:24:41.936455736Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "387815d74c1e1da04c64cc432f63b60449bcc72d",
"ref": "refs/heads/main"
}
},
"canary": true
}
[16:24:42.168] Invocation finished in 24m43.556578559s with status SUCCEEDED