[12:59:26.115] New invocation is queued and will start shortly
[12:59:27.194] Starting the invocation (attempt 1)
[12:59:27.233] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/6f14b897e5d2302b984947afe187bf1533406cf0"
[12:59:27.233] Popped gitiles commit info from properties and tags
[12:59:27.233] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[12:59:27.233] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[12:59:27.233] Buildbucket request:
{
"requestId": "9011507291602048880",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Win64 - dev image"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler-dev.appspot.com",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "87132919a42f0ddedee557145ee3d8336a8320c7"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/master@87132919a42f0ddedee557145ee3d8336a8320c7",
"title": "87132919a42f0ddedee557145ee3d8336a8320c7",
"url": "https://chromium.googlesource.com/v8/v8/+/87132919a42f0ddedee557145ee3d8336a8320c7"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "1955ef64b32b5fed7d214b6153233e521973c8f1"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/master@1955ef64b32b5fed7d214b6153233e521973c8f1",
"title": "1955ef64b32b5fed7d214b6153233e521973c8f1",
"url": "https://chromium.googlesource.com/v8/v8/+/1955ef64b32b5fed7d214b6153233e521973c8f1"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "22135c13b5c7043e55f915529677a4acf42bbcb3"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/master@22135c13b5c7043e55f915529677a4acf42bbcb3",
"title": "22135c13b5c7043e55f915529677a4acf42bbcb3",
"url": "https://chromium.googlesource.com/v8/v8/+/22135c13b5c7043e55f915529677a4acf42bbcb3"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "2542ce2562b46b9dcbfae762ecee835e75e9bb70"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/master@2542ce2562b46b9dcbfae762ecee835e75e9bb70",
"title": "2542ce2562b46b9dcbfae762ecee835e75e9bb70",
"url": "https://chromium.googlesource.com/v8/v8/+/2542ce2562b46b9dcbfae762ecee835e75e9bb70"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "f2fd431a19512c2bfa14829b5ea7aa81f94eeca1"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/master@f2fd431a19512c2bfa14829b5ea7aa81f94eeca1",
"title": "f2fd431a19512c2bfa14829b5ea7aa81f94eeca1",
"url": "https://chromium.googlesource.com/v8/v8/+/f2fd431a19512c2bfa14829b5ea7aa81f94eeca1"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "c80331af72e1d9ea7d5e083befe64c381f9536a8"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/master@c80331af72e1d9ea7d5e083befe64c381f9536a8",
"title": "c80331af72e1d9ea7d5e083befe64c381f9536a8",
"url": "https://chromium.googlesource.com/v8/v8/+/c80331af72e1d9ea7d5e083befe64c381f9536a8"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "64b7d34f42bce3943a050fd1f3f5b9a1c165739b"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/master@64b7d34f42bce3943a050fd1f3f5b9a1c165739b",
"title": "64b7d34f42bce3943a050fd1f3f5b9a1c165739b",
"url": "https://chromium.googlesource.com/v8/v8/+/64b7d34f42bce3943a050fd1f3f5b9a1c165739b"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "7a26488143eeb32fd65a2777780241fbbb295886"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/master@7a26488143eeb32fd65a2777780241fbbb295886",
"title": "7a26488143eeb32fd65a2777780241fbbb295886",
"url": "https://chromium.googlesource.com/v8/v8/+/7a26488143eeb32fd65a2777780241fbbb295886"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "1decfe647f430a2c59df9b1bb9cec6d7a89a34db"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/master@1decfe647f430a2c59df9b1bb9cec6d7a89a34db",
"title": "1decfe647f430a2c59df9b1bb9cec6d7a89a34db",
"url": "https://chromium.googlesource.com/v8/v8/+/1decfe647f430a2c59df9b1bb9cec6d7a89a34db"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "032ab3d2ecca1dd5286295164f5f5e603a8ee774"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/master@032ab3d2ecca1dd5286295164f5f5e603a8ee774",
"title": "032ab3d2ecca1dd5286295164f5f5e603a8ee774",
"url": "https://chromium.googlesource.com/v8/v8/+/032ab3d2ecca1dd5286295164f5f5e603a8ee774"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "6f14b897e5d2302b984947afe187bf1533406cf0"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/master@6f14b897e5d2302b984947afe187bf1533406cf0",
"title": "6f14b897e5d2302b984947afe187bf1533406cf0",
"url": "https://chromium.googlesource.com/v8/v8/+/6f14b897e5d2302b984947afe187bf1533406cf0"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "6f14b897e5d2302b984947afe187bf1533406cf0",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9011507291602048880"
},
{
"key": "scheduler_job_id",
"value": "v8/V8 Win64 - dev image"
},
{
"key": "user_agent",
"value": "luci-scheduler-dev"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
}
}
[12:59:27.919] Scheduled build:
{
"id": "8846077229590285457",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Win64 - dev image"
},
"number": 1587,
"createdBy": "project:v8",
"createTime": "2021-05-27T12:59:27.401018318Z",
"updateTime": "2021-05-27T12:59:27.700932060Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "6f14b897e5d2302b984947afe187bf1533406cf0",
"ref": "refs/heads/master"
}
}
}
[12:59:27.919] Task URL: https://cr-buildbucket-dev.appspot.com/build/8846077229590285457
[12:59:27.919] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:2:0) after 6m49s
[13:06:16.957] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:2:0)
[13:06:17.125] Build status: SCHEDULED
[13:06:17.125] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:3:0) after 1m33s
[13:07:50.175] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:3:0)
[13:07:50.250] Build status: SCHEDULED
[13:07:50.250] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:4:0) after 5m8s
[13:12:58.273] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:4:0)
[13:12:58.338] Build status: SCHEDULED
[13:12:58.338] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:5:0) after 9m12s
[13:22:10.371] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:5:0)
[13:22:10.436] Build status: SCHEDULED
[13:22:10.436] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:6:0) after 5m25s
[13:27:35.474] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:6:0)
[13:27:35.519] Build status: SCHEDULED
[13:27:35.519] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:7:0) after 7m17s
[13:34:52.540] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:7:0)
[13:34:52.598] Build status: SCHEDULED
[13:34:52.598] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:8:0) after 4m11s
[13:39:03.669] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:8:0)
[13:39:03.738] Build status: SCHEDULED
[13:39:03.738] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:9:0) after 6m11s
[13:45:15.364] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:9:0)
[13:45:15.409] Build status: SCHEDULED
[13:45:15.409] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:10:0) after 4m24s
[13:49:39.429] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:10:0)
[13:49:39.504] Build status: SCHEDULED
[13:49:39.504] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:11:0) after 2m15s
[13:51:54.530] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:11:0)
[13:51:54.583] Build status: SCHEDULED
[13:51:54.583] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:12:0) after 7m59s
[13:59:53.603] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:12:0)
[13:59:53.674] Build status: SCHEDULED
[13:59:53.674] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:13:0) after 9m52s
[14:09:45.696] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:13:0)
[14:09:45.761] Build status: SCHEDULED
[14:09:45.761] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:14:0) after 2m56s
[14:12:41.795] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:14:0)
[14:12:41.871] Build status: SCHEDULED
[14:12:41.871] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:15:0) after 5m34s
[14:18:15.962] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:15:0)
[14:18:16.018] Build status: SCHEDULED
[14:18:16.018] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:16:0) after 9m5s
[14:27:21.051] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:16:0)
[14:27:21.134] Build status: STARTED
[14:27:21.134] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:17:0) after 4m43s
[14:32:04.158] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9011507291602048880:17:0)
[14:32:04.229] Build:
{
"id": "8846077229590285457",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Win64 - dev image"
},
"number": 1587,
"createdBy": "project:v8",
"createTime": "2021-05-27T12:59:27.401018318Z",
"startTime": "2021-05-27T14:26:20.766005938Z",
"endTime": "2021-05-27T14:28:55.219745026Z",
"updateTime": "2021-05-27T14:28:55.220035678Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "6f14b897e5d2302b984947afe187bf1533406cf0",
"ref": "refs/heads/master"
}
}
}
[14:32:04.229] Invocation finished in 1h32m38.130249434s with status SUCCEEDED