[140.790593] Initializing watchdogs
[140.791735]   /dev/watchdog0
[140.840814] [001/171] (960s left) i915_module_load (load)
[143.376201] Starting subtest: load
[152.483518] Subtest load: SUCCESS (9.107s)
[152.747858] [002/171] (948s left) core_auth (basic-auth)
[154.567912] Starting subtest: basic-auth
[154.575880] Subtest basic-auth: SUCCESS (0.007s)
[154.950000] [003/171] (946s left) debugfs_test (read_all_entries)
[156.033172] Starting subtest: read_all_entries
[156.597729] Subtest read_all_entries: SUCCESS (0.576s)
[157.551799] [004/171] (944s left) debugfs_test (basic-hwmon)
[158.806568] Starting subtest: basic-hwmon
[158.832706] Subtest basic-hwmon: SKIP (0.000s)
[159.767350] [005/171] (942s left) fbdev (eof)
[160.768919] Starting subtest: eof
[160.778187] Subtest eof: SUCCESS (0.005s)
[161.037973] [006/171] (941s left) fbdev (info)
[161.955789] Starting subtest: info
[161.962704] Subtest info: SUCCESS (0.000s)
[162.311739] [007/171] (940s left) fbdev (nullptr)
[163.309303] Starting subtest: nullptr
[163.315907] Subtest nullptr: SUCCESS (0.001s)
[163.704380] [008/171] (939s left) fbdev (read)
[164.687665] Starting subtest: read
[167.215327] Subtest read: SUCCESS (2.451s)
[167.497965] [009/171] (935s left) fbdev (write)
[168.454817] Starting subtest: write
[169.808940] Subtest write: SUCCESS (1.275s)
[170.142664] [010/171] (933s left) gem_basic (bad-close)
[171.069857] Starting subtest: bad-close
[171.086447] Subtest bad-close: SUCCESS (0.000s)
[171.383865] [011/171] (932s left) gem_basic (create-close)
[172.287136] Starting subtest: create-close
[172.305183] Subtest create-close: SUCCESS (0.001s)
[172.686780] [012/171] (931s left) gem_basic (create-fd-close)
[173.573802] Starting subtest: create-fd-close
[173.591624] Subtest create-fd-close: SUCCESS (0.001s)
[173.968181] [013/171] (930s left) gem_busy (busy@all-engines)
[175.061617] Starting subtest: busy
[175.069285] Starting dynamic subtest: all-engines
[175.524268] Dynamic subtest all-engines: SUCCESS (0.472s)
[175.531921] Subtest busy: SUCCESS (0.477s)
[176.354419] [014/171] (928s left) gem_close_race (basic-process)
[177.422158] Starting subtest: basic-process
[177.743651] Subtest basic-process: SUCCESS (0.340s)
[178.202948] [015/171] (926s left) gem_close_race (basic-threads)
[179.294706] Starting subtest: basic-threads
[180.913457] Subtest basic-threads: SUCCESS (1.667s)
[181.500460] [016/171] (923s left) gem_ctx_create (basic)
[182.619145] Starting subtest: basic
[182.627818] Subtest basic: SUCCESS (0.000s)
[183.084425] [017/171] (922s left) gem_ctx_create (basic-files)
[184.179219] Starting subtest: basic-files
[186.412954] Subtest basic-files: SUCCESS (2.230s)
[186.866583] [018/171] (918s left) gem_ctx_exec (basic)
[187.785645] Starting subtest: basic
[187.826262] Subtest basic: SUCCESS (0.047s)
[188.121330] [019/171] (917s left) gem_exec_basic (basic)
[189.096654] Starting subtest: basic
[189.105852] Starting dynamic subtest: rcs0-smem
[189.126434] Dynamic subtest rcs0-smem: SUCCESS (0.019s)
[189.191172] Starting dynamic subtest: bcs0-smem
[189.197902] Dynamic subtest bcs0-smem: SUCCESS (0.012s)
[189.257854] Starting dynamic subtest: vcs0-smem
[189.265912] Dynamic subtest vcs0-smem: SUCCESS (0.006s)
[189.331149] Starting dynamic subtest: vecs0-smem
[189.337949] Dynamic subtest vecs0-smem: SUCCESS (0.004s)
[189.344840] Subtest basic: SUCCESS (0.053s)
[189.694910] [020/171] (916s left) gem_exec_create (basic)
[190.764873] Starting subtest: basic
[190.772649] Starting dynamic subtest: smem
[192.957269] Dynamic subtest smem: SUCCESS (2.252s)
[192.966153] Subtest basic: SUCCESS (2.255s)
[193.484182] [021/171] (912s left) gem_exec_fence (basic-busy)
[194.792705] Starting subtest: basic-busy
[194.803149] Starting dynamic subtest: rcs0
[194.818278] Dynamic subtest rcs0: SUCCESS (0.069s)
[194.942989] Starting dynamic subtest: bcs0
[194.962438] Dynamic subtest bcs0: SUCCESS (0.063s)
[195.024641] Starting dynamic subtest: vcs0
[195.039433] Dynamic subtest vcs0: SUCCESS (0.070s)
[195.096644] Starting dynamic subtest: vecs0
[195.111636] Dynamic subtest vecs0: SUCCESS (0.044s)
[195.120986] Subtest basic-busy: SUCCESS (0.255s)
[197.331354] [022/171] (909s left) gem_exec_fence (basic-wait)
[198.636472] Starting subtest: basic-wait
[198.645143] Starting dynamic subtest: rcs0
[198.663718] Dynamic subtest rcs0: SUCCESS (0.075s)
[198.798621] Starting dynamic subtest: bcs0
[198.806739] Dynamic subtest bcs0: SUCCESS (0.072s)
[198.876160] Starting dynamic subtest: vcs0
[198.883440] Dynamic subtest vcs0: SUCCESS (0.066s)
[198.942388] Starting dynamic subtest: vecs0
[198.951898] Dynamic subtest vecs0: SUCCESS (0.043s)
[198.960173] Subtest basic-wait: SUCCESS (0.266s)
[200.783715] [023/171] (905s left) gem_exec_fence (basic-await)
[202.065790] Starting subtest: basic-await
[202.072765] Starting dynamic subtest: rcs0
[202.531334] Dynamic subtest rcs0: SUCCESS (0.461s)
[202.588619] Starting dynamic subtest: bcs0
[202.985390] Dynamic subtest bcs0: SUCCESS (0.451s)
[203.048759] Starting dynamic subtest: vcs0
[203.445895] Dynamic subtest vcs0: SUCCESS (0.458s)
[203.503446] Starting dynamic subtest: vecs0
[203.895929] Dynamic subtest vecs0: SUCCESS (0.449s)
[203.902854] Subtest basic-await: SUCCESS (1.832s)
[205.788138] [024/171] (901s left) gem_exec_fence (nb-await)
[207.130836] Starting subtest: nb-await
[207.138084] Starting dynamic subtest: rcs0
[207.286734] Dynamic subtest rcs0: SUCCESS (0.170s)
[207.349625] Starting dynamic subtest: bcs0
[207.382467] Dynamic subtest bcs0: SUCCESS (0.141s)
[207.448804] Starting dynamic subtest: vcs0
[207.514814] Dynamic subtest vcs0: SUCCESS (0.132s)
[207.579852] Starting dynamic subtest: vecs0
[207.700417] Dynamic subtest vecs0: SUCCESS (0.132s)
[207.707760] Subtest nb-await: SUCCESS (0.585s)
[209.574694] [025/171] (897s left) gem_exec_gttfill (basic)
[210.654982] Starting subtest: basic
[217.264113] Subtest basic: SKIP (6.540s)
[217.754595] [026/171] (889s left) gem_exec_parallel (engines)
[219.341799] Starting subtest: engines
[219.349933] Starting dynamic subtest: basic
[232.453340] Dynamic subtest basic: SUCCESS (13.128s)
[232.517545] Starting dynamic subtest: contexts
[249.077692] Dynamic subtest contexts: SUCCESS (16.606s)
[249.203906] Starting dynamic subtest: fds
[267.986145] Dynamic subtest fds: SUCCESS (18.904s)
[268.132562] Starting dynamic subtest: userptr
[281.134392] Dynamic subtest userptr: SUCCESS (13.164s)
[281.141794] Subtest engines: SUCCESS (61.809s)
[281.737503] [027/171] (825s left) gem_exec_store (basic)
[282.891869] Starting subtest: basic
[283.040880] Subtest basic: SUCCESS (0.159s)
[283.568647] [028/171] (824s left) gem_flink_basic (bad-flink)
[284.504258] Starting subtest: bad-flink
[284.512300] Subtest bad-flink: SUCCESS (0.000s)
[284.917070] [029/171] (823s left) gem_flink_basic (bad-open)
[285.797765] Starting subtest: bad-open
[285.806629] Subtest bad-open: SUCCESS (0.000s)
[286.212372] [030/171] (822s left) gem_flink_basic (basic)
[287.114824] Starting subtest: basic
[287.123755] Subtest basic: SUCCESS (0.001s)
[287.521851] [031/171] (821s left) gem_flink_basic (double-flink)
[288.397076] Starting subtest: double-flink
[288.407290] Subtest double-flink: SUCCESS (0.001s)
[288.766649] [032/171] (820s left) gem_flink_basic (flink-lifetime)
[289.625928] Starting subtest: flink-lifetime
[289.634602] Subtest flink-lifetime: SUCCESS (0.011s)
[290.021456] [033/171] (819s left) gem_huc_copy (huc-copy)
[291.016864] Starting subtest: huc-copy
[291.031174] Subtest huc-copy: SKIP (0.000s)
[291.366060] [034/171] (817s left) gem_linear_blits (basic)
[293.427700] Subtest basic: SKIP (0.000s)
[293.793175] [035/171] (815s left) gem_mmap (basic)
[295.185603] Starting subtest: basic
[295.226906] Subtest basic: SUCCESS (0.004s)
[295.576422] [036/171] (814s left) gem_mmap_gtt (basic)
[296.585524] Starting subtest: basic
[296.602870] Subtest basic: SUCCESS (0.010s)
[296.989836] [037/171] (812s left) gem_render_linear_blits (basic)
[297.947916] Starting subtest: basic
[298.216930] Subtest basic: SUCCESS (0.273s)
[298.546195] [038/171] (811s left) gem_render_tiled_blits (basic)
[299.582728] Starting subtest: basic
[299.931190] Subtest basic: SUCCESS (0.342s)
[300.298994] [039/171] (810s left) gem_ringfill (basic-all)
[302.515934] Starting subtest: basic-all
[304.290410] Subtest basic-all: SUCCESS (1.731s)
[304.682338] [040/171] (805s left) gem_softpin (allocator-basic)
[305.720792] Starting subtest: allocator-basic
[306.919847] Subtest allocator-basic: SUCCESS (1.139s)
[307.409617] [041/171] (803s left) gem_softpin (allocator-basic-reserve)
[308.352914] Starting subtest: allocator-basic-reserve
[309.566390] Subtest allocator-basic-reserve: SUCCESS (1.154s)
[310.133887] [042/171] (801s left) gem_softpin (safe-alignment)
[311.132721] Starting subtest: safe-alignment
[311.360599] Subtest safe-alignment: SUCCESS (0.136s)
[311.689244] [043/171] (799s left) gem_sync (basic-all)
[312.874453] Starting subtest: basic-all
[317.745195] Subtest basic-all: SUCCESS (4.878s)
[318.324374] [044/171] (793s left) gem_sync (basic-each)
[319.336145] Starting subtest: basic-each
[322.662353] Subtest basic-each: SUCCESS (3.327s)
[323.221380] [045/171] (788s left) gem_tiled_blits (basic)
[325.307175] Subtest basic: SKIP (0.000s)
[325.605160] [046/171] (786s left) gem_tiled_fence_blits (basic)
[328.093676] Starting subtest: basic
[328.134622] Subtest basic: SUCCESS (0.104s)
[328.673169] [047/171] (783s left) gem_tiled_pread_basic
[331.431452] [048/171] (781s left) gem_wait (busy@all-engines)
[332.578934] Starting subtest: busy
[332.586964] Starting dynamic subtest: all-engines
[333.184842] Dynamic subtest all-engines: SUCCESS (0.648s)
[333.193130] Subtest busy: SUCCESS (0.651s)
[333.921981] [049/171] (778s left) gem_wait (wait@all-engines)
[335.049780] Starting subtest: wait
[335.057900] Starting dynamic subtest: all-engines
[336.168456] Dynamic subtest all-engines: SUCCESS (1.125s)
[336.174899] Subtest wait: SUCCESS (1.128s)
[336.907621] [050/171] (776s left) i915_getparams_basic (basic-eu-total)
[337.839320] Starting subtest: basic-eu-total
[337.856960] Subtest basic-eu-total: SUCCESS (0.000s)
[338.231413] [051/171] (775s left) i915_getparams_basic (basic-subslice-total)
[339.107857] Starting subtest: basic-subslice-total
[339.121756] Subtest basic-subslice-total: SUCCESS (0.000s)
[339.505368] [052/171] (774s left) i915_hangman (error-state-basic)
[340.635718] Starting subtest: error-state-basic
[340.703882] Subtest error-state-basic: SUCCESS (0.060s)
[341.073184] [053/171] (772s left) i915_pciid
[342.387145] [054/171] (771s left) kms_addfb_basic (addfb25-bad-modifier)
[343.391898] Starting subtest: addfb25-bad-modifier
[343.399557] Subtest addfb25-bad-modifier: SUCCESS (0.003s)
[344.800761] [055/171] (769s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[345.766946] Starting subtest: addfb25-framebuffer-vs-set-tiling
[345.775304] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[346.804730] [056/171] (767s left) kms_addfb_basic (addfb25-modifier-no-flag)
[347.807347] Starting subtest: addfb25-modifier-no-flag
[347.814665] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[348.856834] [057/171] (765s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[349.782957] Starting subtest: addfb25-x-tiled-legacy
[349.789792] Subtest addfb25-x-tiled-legacy: SUCCESS (0.001s)
[350.822539] [058/171] (764s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[351.747202] Starting subtest: addfb25-x-tiled-mismatch-legacy
[351.753851] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[352.792311] [059/171] (762s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[354.387524] Starting subtest: addfb25-yf-tiled-legacy
[354.395891] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[354.780528] [060/171] (760s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[356.384857] Starting subtest: addfb25-y-tiled-legacy
[356.394847] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[356.765355] [061/171] (759s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[358.387267] Starting subtest: addfb25-y-tiled-small-legacy
[358.397141] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.002s)
[358.823369] [062/171] (757s left) kms_addfb_basic (bad-pitch-0)
[359.846715] Starting subtest: bad-pitch-0
[359.856582] Subtest bad-pitch-0: SUCCESS (0.000s)
[360.879115] [063/171] (755s left) kms_addfb_basic (bad-pitch-1024)
[361.825892] Starting subtest: bad-pitch-1024
[361.834747] Subtest bad-pitch-1024: SUCCESS (0.000s)
[362.861983] [064/171] (753s left) kms_addfb_basic (bad-pitch-128)
[363.794491] Starting subtest: bad-pitch-128
[363.802152] Subtest bad-pitch-128: SUCCESS (0.000s)
[364.848878] [065/171] (752s left) kms_addfb_basic (bad-pitch-256)
[365.812616] Starting subtest: bad-pitch-256
[365.820726] Subtest bad-pitch-256: SUCCESS (0.000s)
[366.844149] [066/171] (750s left) kms_addfb_basic (bad-pitch-32)
[367.810650] Starting subtest: bad-pitch-32
[367.818352] Subtest bad-pitch-32: SUCCESS (0.000s)
[368.885359] [067/171] (748s left) kms_addfb_basic (bad-pitch-63)
[369.816734] Starting subtest: bad-pitch-63
[369.824794] Subtest bad-pitch-63: SUCCESS (0.000s)
[370.857504] [068/171] (747s left) kms_addfb_basic (bad-pitch-65536)
[371.772566] Starting subtest: bad-pitch-65536
[371.779960] Subtest bad-pitch-65536: SUCCESS (0.003s)
[372.831691] [069/171] (745s left) kms_addfb_basic (bad-pitch-999)
[373.772757] Starting subtest: bad-pitch-999
[373.782610] Subtest bad-pitch-999: SUCCESS (0.000s)
[374.804358] [070/171] (743s left) kms_addfb_basic (basic)
[375.784249] Starting subtest: basic
[375.792811] Subtest basic: SUCCESS (0.000s)
[376.862297] [071/171] (741s left) kms_addfb_basic (basic-x-tiled-legacy)
[377.809787] Starting subtest: basic-x-tiled-legacy
[377.818480] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[378.847612] [072/171] (740s left) kms_addfb_basic (basic-y-tiled-legacy)
[379.777364] Starting subtest: basic-y-tiled-legacy
[379.785521] Subtest basic-y-tiled-legacy: SUCCESS (0.003s)
[380.828574] [073/171] (738s left) kms_addfb_basic (bo-too-small)
[382.419423] Starting subtest: bo-too-small
[382.426779] Subtest bo-too-small: SUCCESS (0.003s)
[382.820842] [074/171] (736s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[384.396911] Starting subtest: bo-too-small-due-to-tiling
[384.405727] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[384.794203] [075/171] (735s left) kms_addfb_basic (clobberred-modifier)
[385.777361] Starting subtest: clobberred-modifier
[385.786681] Subtest clobberred-modifier: SUCCESS (0.001s)
[386.786461] [076/171] (733s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[387.706656] Starting subtest: framebuffer-vs-set-tiling
[387.715160] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[388.745658] [077/171] (731s left) kms_addfb_basic (invalid-get-prop)
[389.669865] Starting subtest: invalid-get-prop
[389.677715] Subtest invalid-get-prop: SUCCESS (0.000s)
[390.708492] [078/171] (730s left) kms_addfb_basic (invalid-get-prop-any)
[391.645809] Starting subtest: invalid-get-prop-any
[391.654465] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[392.681641] [079/171] (728s left) kms_addfb_basic (invalid-set-prop)
[393.667867] Starting subtest: invalid-set-prop
[393.674810] Subtest invalid-set-prop: SUCCESS (0.000s)
[394.675785] [080/171] (726s left) kms_addfb_basic (invalid-set-prop-any)
[395.606276] Starting subtest: invalid-set-prop-any
[395.614926] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[396.655331] [081/171] (724s left) kms_addfb_basic (no-handle)
[397.579791] Starting subtest: no-handle
[397.588937] Subtest no-handle: SUCCESS (0.000s)
[398.621177] [082/171] (723s left) kms_addfb_basic (size-max)
[400.275933] Starting subtest: size-max
[400.284661] Subtest size-max: SUCCESS (0.001s)
[400.659319] [083/171] (721s left) kms_addfb_basic (small-bo)
[402.252951] Starting subtest: small-bo
[402.260957] Subtest small-bo: SUCCESS (0.000s)
[402.656949] [084/171] (719s left) kms_addfb_basic (tile-pitch-mismatch)
[403.625150] Starting subtest: tile-pitch-mismatch
[403.633342] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[404.663330] [085/171] (718s left) kms_addfb_basic (too-high)
[406.250850] Starting subtest: too-high
[406.258859] Subtest too-high: SUCCESS (0.006s)
[406.618221] [086/171] (716s left) kms_addfb_basic (too-wide)
[408.196636] Starting subtest: too-wide
[408.205681] Subtest too-wide: SUCCESS (0.000s)
[408.577176] [087/171] (714s left) kms_addfb_basic (unused-handle)
[409.512987] Starting subtest: unused-handle
[409.520145] Subtest unused-handle: SUCCESS (0.000s)
[410.557603] [088/171] (712s left) kms_addfb_basic (unused-modifier)
[411.473187] Starting subtest: unused-modifier
[411.482147] Subtest unused-modifier: SUCCESS (0.001s)
[412.497514] [089/171] (711s left) kms_addfb_basic (unused-offsets)
[413.415923] Starting subtest: unused-offsets
[413.425753] Subtest unused-offsets: SUCCESS (0.000s)
[414.461915] [090/171] (709s left) kms_addfb_basic (unused-pitches)
[415.371450] Starting subtest: unused-pitches
[415.380787] Subtest unused-pitches: SUCCESS (0.000s)
[416.385901] [091/171] (707s left) kms_busy (basic)
[418.061983] Starting subtest: basic
[418.089348] Starting dynamic subtest: flip
[421.528874] Dynamic subtest flip: SUCCESS (3.454s)
[421.693692] Starting dynamic subtest: modeset
[426.508089] Dynamic subtest modeset: SUCCESS (4.963s)
[426.520498] Subtest basic: SUCCESS (8.433s)
[427.706874] [092/171] (696s left) kms_chamelium_hpd (dp-hpd-fast)
[429.881669] Subtest dp-hpd-fast: SKIP (0.000s)
[430.860492] [093/171] (693s left) kms_chamelium_edid (dp-edid-read)
[433.004913] Subtest dp-edid-read: SKIP (0.000s)
[433.958674] [094/171] (691s left) kms_chamelium_frames (dp-crc-fast)
[436.067093] Subtest dp-crc-fast: SKIP (0.000s)
[437.064455] [095/171] (688s left) kms_chamelium_hpd (hdmi-hpd-fast)
[439.137175] Subtest hdmi-hpd-fast: SKIP (0.000s)
[440.131110] [096/171] (685s left) kms_chamelium_edid (hdmi-edid-read)
[442.181954] Subtest hdmi-edid-read: SKIP (0.000s)
[443.172853] [097/171] (682s left) kms_chamelium_frames (hdmi-crc-fast)
[445.207700] Subtest hdmi-crc-fast: SKIP (0.000s)
[446.198664] [098/171] (679s left) kms_chamelium_hpd (vga-hpd-fast)
[448.269898] Subtest vga-hpd-fast: SKIP (0.000s)
[449.259717] [099/171] (676s left) kms_chamelium_edid (vga-edid-read)
[451.336198] Subtest vga-edid-read: SKIP (0.000s)
[452.318402] [100/171] (674s left) kms_prop_blob (basic)
[453.338135] Starting subtest: basic
[453.347497] Subtest basic: SUCCESS (0.000s)
[453.678187] [101/171] (672s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[455.283562] Starting subtest: basic-busy-flip-before-cursor-atomic
[455.298929] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[455.648477] [102/171] (671s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[457.230572] Starting subtest: basic-busy-flip-before-cursor-legacy
[457.247437] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.001s)
[457.576888] [103/171] (669s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[459.135737] Starting subtest: basic-flip-after-cursor-atomic
[461.017742] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.882s)
[462.213982] [104/171] (665s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[463.806573] Starting subtest: basic-flip-after-cursor-legacy
[465.597874] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.788s)
[466.763964] [105/171] (660s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[468.348982] Starting subtest: basic-flip-after-cursor-varying-size
[470.145713] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.803s)
[471.396892] [106/171] (656s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[472.967938] Starting subtest: basic-flip-before-cursor-atomic
[474.833889] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.869s)
[476.028888] [107/171] (652s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[477.633528] Starting subtest: basic-flip-before-cursor-legacy
[479.418168] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.793s)
[480.579367] [108/171] (647s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[482.191923] Starting subtest: basic-flip-before-cursor-varying-size
[484.094179] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.902s)
[485.316822] [109/171] (643s left) kms_flip (basic-flip-vs-dpms)
[486.585578] Starting subtest: basic-flip-vs-dpms
[486.623350] Starting dynamic subtest: A-eDP1
[490.333752] Dynamic subtest A-eDP1: SUCCESS (3.700s)
[490.478762] Starting dynamic subtest: B-eDP1
[493.218438] Dynamic subtest B-eDP1: SUCCESS (2.873s)
[493.362499] Starting dynamic subtest: C-eDP1
[496.156193] Dynamic subtest C-eDP1: SUCCESS (2.931s)
[496.198195] Subtest basic-flip-vs-dpms: SUCCESS (9.627s)
[497.333875] [110/171] (631s left) kms_flip (basic-flip-vs-modeset)
[498.564923] Starting subtest: basic-flip-vs-modeset
[498.616997] Starting dynamic subtest: A-eDP1
[502.228631] Dynamic subtest A-eDP1: SUCCESS (3.615s)
[502.388535] Starting dynamic subtest: B-eDP1
[504.951959] Dynamic subtest B-eDP1: SUCCESS (2.707s)
[505.097542] Starting dynamic subtest: C-eDP1
[507.655080] Dynamic subtest C-eDP1: SUCCESS (2.693s)
[507.705530] Subtest basic-flip-vs-modeset: SUCCESS (9.154s)
[508.871621] [111/171] (620s left) kms_flip (basic-flip-vs-wf_vblank)
[510.169994] Starting subtest: basic-flip-vs-wf_vblank
[510.201157] Starting dynamic subtest: A-eDP1
[513.102685] Dynamic subtest A-eDP1: SUCCESS (2.855s)
[513.239757] Starting dynamic subtest: B-eDP1
[515.800506] Dynamic subtest B-eDP1: SUCCESS (2.642s)
[515.955859] Starting dynamic subtest: C-eDP1
[518.385121] Dynamic subtest C-eDP1: SUCCESS (2.607s)
[518.403259] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.249s)
[520.445960] [112/171] (609s left) kms_flip (basic-plain-flip)
[521.635636] Starting subtest: basic-plain-flip
[521.712503] Starting dynamic subtest: A-eDP1
[524.365659] Dynamic subtest A-eDP1: SUCCESS (2.616s)
[524.507265] Starting dynamic subtest: B-eDP1
[526.725487] Dynamic subtest B-eDP1: SUCCESS (2.341s)
[526.872320] Starting dynamic subtest: C-eDP1
[529.044700] Dynamic subtest C-eDP1: SUCCESS (2.300s)
[529.068298] Subtest basic-plain-flip: SUCCESS (7.424s)
[531.033638] [113/171] (598s left) kms_force_connector_basic (force-connector-state)
[532.648726] Starting subtest: force-connector-state
[535.625682] Subtest force-connector-state: SUCCESS (2.960s)
[538.261576] [114/171] (592s left) kms_force_connector_basic (force-edid)
[539.779858] Starting subtest: force-edid
[540.333874] Subtest force-edid: SUCCESS (0.549s)
[542.196193] [115/171] (588s left) kms_force_connector_basic (force-load-detect)
[543.716419] Starting subtest: force-load-detect
[543.733923] Subtest force-load-detect: SKIP (0.000s)
[545.434450] [116/171] (585s left) kms_force_connector_basic (prune-stale-modes)
[546.981699] Starting subtest: prune-stale-modes
[547.585931] Subtest prune-stale-modes: SUCCESS (0.600s)
[549.414472] [117/171] (581s left) kms_frontbuffer_tracking (basic)
[551.141105] Starting subtest: basic
[560.333069] Subtest basic: SUCCESS (9.191s)
[560.803191] [118/171] (570s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[562.616359] Starting subtest: compare-crc-sanitycheck-xr24
[562.629571] Starting dynamic subtest: pipe-A-eDP-1
[563.752995] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.151s)
[563.956784] Starting dynamic subtest: pipe-B-eDP-1
[565.709844] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.934s)
[565.884773] Starting dynamic subtest: pipe-C-eDP-1
[567.906748] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.150s)
[567.915452] Subtest compare-crc-sanitycheck-xr24: SUCCESS (5.318s)
[569.141530] [119/171] (562s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[570.761707] Starting subtest: compare-crc-sanitycheck-nv12
[570.778099] Starting dynamic subtest: pipe-A-eDP-1
[572.594508] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.802s)
[572.768365] Starting dynamic subtest: pipe-B-eDP-1
[575.175074] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.565s)
[575.360410] Starting dynamic subtest: pipe-C-eDP-1
[575.380917] Dynamic subtest pipe-C-eDP-1: SKIP (0.007s)
[575.388863] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.463s)
[576.393207] [120/171] (555s left) kms_pipe_crc_basic (hang-read-crc)
[578.005435] Starting subtest: hang-read-crc
[578.012403] Starting dynamic subtest: pipe-A-eDP-1
[581.298176] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.294s)
[581.514308] Starting dynamic subtest: pipe-B-eDP-1
[585.383714] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.043s)
[585.573962] Starting dynamic subtest: pipe-C-eDP-1
[589.940877] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.546s)
[589.950144] Subtest hang-read-crc: SUCCESS (11.969s)
[591.185103] [121/171] (541s left) kms_pipe_crc_basic (nonblocking-crc)
[592.851781] Starting subtest: nonblocking-crc
[592.878632] Starting dynamic subtest: pipe-A-eDP-1
[594.212869] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.345s)
[594.406446] Starting dynamic subtest: pipe-B-eDP-1
[596.376169] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.122s)
[596.551523] Starting dynamic subtest: pipe-C-eDP-1
[598.702094] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.294s)
[598.710891] Subtest nonblocking-crc: SUCCESS (5.843s)
[599.940994] [122/171] (532s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[601.618817] Starting subtest: nonblocking-crc-frame-sequence
[601.631875] Starting dynamic subtest: pipe-A-eDP-1
[602.999307] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.366s)
[603.173462] Starting dynamic subtest: pipe-B-eDP-1
[605.084571] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.080s)
[605.277590] Starting dynamic subtest: pipe-C-eDP-1
[607.423240] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.294s)
[607.431584] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.822s)
[608.640511] [123/171] (524s left) kms_pipe_crc_basic (read-crc)
[610.267736] Starting subtest: read-crc
[610.275415] Starting dynamic subtest: pipe-A-eDP-1
[611.595380] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.316s)
[611.767829] Starting dynamic subtest: pipe-B-eDP-1
[613.628499] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.003s)
[613.804419] Starting dynamic subtest: pipe-C-eDP-1
[615.938869] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.293s)
[615.946977] Subtest read-crc: SUCCESS (5.696s)
[617.155958] [124/171] (516s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[618.778798] Starting subtest: read-crc-frame-sequence
[618.788153] Starting dynamic subtest: pipe-A-eDP-1
[620.069504] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.276s)
[620.269151] Starting dynamic subtest: pipe-B-eDP-1
[622.160735] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.056s)
[622.379802] Starting dynamic subtest: pipe-C-eDP-1
[624.495778] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.309s)
[624.503937] Subtest read-crc-frame-sequence: SUCCESS (5.739s)
[625.674919] [125/171] (507s left) kms_psr (primary_page_flip)
[627.343989] Starting subtest: primary_page_flip
[630.263317] Subtest primary_page_flip: SUCCESS (2.917s)
[631.447834] [126/171] (502s left) kms_psr (cursor_plane_move)
[633.063890] Starting subtest: cursor_plane_move
[635.935403] Subtest cursor_plane_move: SUCCESS (2.884s)
[637.125162] [127/171] (497s left) kms_psr (sprite_plane_onoff)
[638.775553] Starting subtest: sprite_plane_onoff
[641.744611] Subtest sprite_plane_onoff: SUCCESS (2.975s)
[642.906818] [128/171] (491s left) kms_psr (primary_mmap_gtt)
[644.549224] Starting subtest: primary_mmap_gtt
[647.480505] Subtest primary_mmap_gtt: SUCCESS (2.942s)
[648.693283] [129/171] (486s left) kms_setmode (basic-clone-single-crtc)
[649.726160] Starting subtest: basic-clone-single-crtc
[649.750779] Subtest basic-clone-single-crtc: SKIP (0.007s)
[650.102915] [130/171] (484s left) i915_pm_backlight (basic-brightness)
[651.895606] Starting subtest: basic-brightness
[652.457905] Starting dynamic subtest: eDP-1
[653.184224] Dynamic subtest eDP-1: SUCCESS (0.769s)
[653.194913] Subtest basic-brightness: SUCCESS (1.286s)
[654.353644] [131/171] (480s left) i915_pm_rpm (basic-pci-d3-state)
[658.361679] Starting subtest: basic-pci-d3-state
[663.246779] Subtest basic-pci-d3-state: SUCCESS (4.880s)
[663.879131] [132/171] (471s left) i915_pm_rpm (basic-rte)
[664.790875] Starting subtest: basic-rte
[672.707194] Subtest basic-rte: SUCCESS (7.907s)
[675.289345] [133/171] (460s left) i915_pm_rps (basic-api)
[676.358111] Starting subtest: basic-api
[676.395836] Subtest basic-api: SUCCESS (0.039s)
[676.782459] [134/171] (459s left) prime_self_import (basic-llseek-bad)
[677.707565] Starting subtest: basic-llseek-bad
[677.724862] Subtest basic-llseek-bad: SUCCESS (0.017s)
[678.091912] [135/171] (458s left) prime_self_import (basic-llseek-size)
[679.008978] Starting subtest: basic-llseek-size
[679.046573] Subtest basic-llseek-size: SUCCESS (0.027s)
[679.467442] [136/171] (457s left) prime_self_import (basic-with_fd_dup)
[680.399773] Starting subtest: basic-with_fd_dup
[680.429734] Subtest basic-with_fd_dup: SUCCESS (0.030s)
[680.890465] [137/171] (455s left) prime_self_import (basic-with_one_bo)
[681.811931] Starting subtest: basic-with_one_bo
[681.848462] Subtest basic-with_one_bo: SUCCESS (0.030s)
[682.331091] [138/171] (454s left) prime_self_import (basic-with_one_bo_two_files)
[683.242605] Starting subtest: basic-with_one_bo_two_files
[683.280734] Subtest basic-with_one_bo_two_files: SUCCESS (0.021s)
[683.747624] [139/171] (453s left) prime_self_import (basic-with_two_bos)
[684.652787] Starting subtest: basic-with_two_bos
[684.687727] Subtest basic-with_two_bos: SUCCESS (0.026s)
[685.113813] [140/171] (452s left) prime_vgem (basic-fence-flip)
[686.215803] Starting subtest: basic-fence-flip
[687.954728] Subtest basic-fence-flip: SUCCESS (1.693s)
[688.466496] [141/171] (449s left) prime_vgem (basic-fence-mmap)
[689.486588] Starting subtest: basic-fence-mmap
[689.787873] Subtest basic-fence-mmap: SUCCESS (0.265s)
[690.128206] [142/171] (448s left) prime_vgem (basic-fence-read)
[691.134458] Starting subtest: basic-fence-read
[691.595863] Subtest basic-fence-read: SUCCESS (0.424s)
[691.981658] [143/171] (446s left) prime_vgem (basic-gtt)
[693.020919] Starting subtest: basic-gtt
[693.199698] Subtest basic-gtt: SUCCESS (0.124s)
[693.578467] [144/171] (445s left) prime_vgem (basic-read)
[694.718674] Starting subtest: basic-read
[694.930395] Subtest basic-read: SUCCESS (0.209s)
[695.371813] [145/171] (443s left) prime_vgem (basic-write)
[696.392652] Starting subtest: basic-write
[696.702121] Subtest basic-write: SUCCESS (0.248s)
[697.050858] [146/171] (442s left) vgem_basic (setversion)
[698.064792] Starting subtest: setversion
[698.079829] Subtest setversion: SUCCESS (0.000s)
[698.444418] [147/171] (441s left) vgem_basic (create)
[699.416090] Starting subtest: create
[699.424154] Subtest create: SUCCESS (0.003s)
[699.790272] [148/171] (440s left) vgem_basic (debugfs)
[700.760346] Starting subtest: debugfs
[700.769080] Subtest debugfs: SUCCESS (0.005s)
[701.132867] [149/171] (438s left) vgem_basic (dmabuf-export)
[702.096911] Starting subtest: dmabuf-export
[702.113588] Subtest dmabuf-export: SUCCESS (0.016s)
[702.511432] [150/171] (437s left) vgem_basic (dmabuf-fence)
[703.492515] Starting subtest: dmabuf-fence
[703.501550] Subtest dmabuf-fence: SUCCESS (0.004s)
[703.877189] [151/171] (436s left) vgem_basic (dmabuf-fence-before)
[704.847971] Starting subtest: dmabuf-fence-before
[704.856678] Subtest dmabuf-fence-before: SUCCESS (0.004s)
[705.230058] [152/171] (435s left) vgem_basic (dmabuf-mmap)
[706.226966] Starting subtest: dmabuf-mmap
[706.432764] Subtest dmabuf-mmap: SUCCESS (0.145s)
[706.772780] [153/171] (434s left) vgem_basic (mmap)
[707.724667] Starting subtest: mmap
[707.810627] Subtest mmap: SUCCESS (0.096s)
[708.186624] [154/171] (433s left) vgem_basic (second-client)
[709.169100] Starting subtest: second-client
[709.252969] Subtest second-client: SUCCESS (0.076s)
[709.632624] [155/171] (432s left) vgem_basic (sysfs)
[710.619868] Starting subtest: sysfs
[710.628879] Subtest sysfs: SUCCESS (0.006s)
[710.999304] [156/171] (431s left) core_hotunplug (unbind-rebind)
[712.362735] Starting subtest: unbind-rebind
[719.961153] Subtest unbind-rebind: SUCCESS (7.512s)
[720.385411] [157/171] (422s left) vgem_basic (unload)
[721.616708] Starting subtest: unload
[751.832753] Subtest unload: SUCCESS (30.183s)
[752.462875] [158/171] (390s left) i915_module_load (reload)
[753.453796] Starting subtest: reload
[765.576747] Subtest reload: SUCCESS (12.113s)
[766.061831] [159/171] (377s left) gem_lmem_swapping (basic)
[767.675097] Subtest basic: SKIP (0.000s)
[767.998277] [160/171] (375s left) gem_lmem_swapping (parallel-random-engines)
[768.988261] Subtest parallel-random-engines: SKIP (0.000s)
[769.305677] [161/171] (374s left) gem_lmem_swapping (random-engines)
[770.396166] Subtest random-engines: SKIP (0.000s)
[770.730911] [162/171] (373s left) gem_lmem_swapping (verify-random)
[771.706594] Subtest verify-random: SKIP (0.000s)
[772.038564] [163/171] (372s left) i915_pm_rpm (module-reload)
[776.777791] Starting subtest: module-reload
[810.412111] Subtest module-reload: SUCCESS (33.585s)
[810.601899] [164/171] (333s left) i915_selftest (live)
[811.651780] Starting subtest: live
[811.659994] Starting dynamic subtest: sanitycheck
[817.615506] Dynamic subtest sanitycheck: SUCCESS (5.900s)
[817.731713] Starting dynamic subtest: uncore
[823.436080] Dynamic subtest uncore: SUCCESS (5.798s)
[823.564840] Starting dynamic subtest: workarounds
[830.243346] Dynamic subtest workarounds: SUCCESS (6.782s)
[830.389830] Starting dynamic subtest: gt_engines
[836.303126] Dynamic subtest gt_engines: SUCCESS (6.070s)
[836.358428] Starting dynamic subtest: gt_timelines
[905.720569] Dynamic subtest gt_timelines: SUCCESS (69.385s)
[905.849191] Starting dynamic subtest: gt_contexts
[911.814323] Dynamic subtest gt_contexts: SUCCESS (6.095s)
[911.940955] Starting dynamic subtest: gt_lrc
[922.738515] Dynamic subtest gt_lrc: SUCCESS (10.887s)
[922.871687] Starting dynamic subtest: gt_mocs
[928.887992] Dynamic subtest gt_mocs: SUCCESS (6.137s)
[929.020684] Starting dynamic subtest: gt_pm
[939.775821] Dynamic subtest gt_pm: FAIL (9.154s)
[939.920488] Starting dynamic subtest: gt_heartbeat
[944.272870] Dynamic subtest gt_heartbeat: SUCCESS (6.219s)
[944.329976] Starting dynamic subtest: gt_tlb
[951.582803] Dynamic subtest gt_tlb: SUCCESS (7.272s)
[951.698906] Starting dynamic subtest: requests
[964.689561] Dynamic subtest requests: SUCCESS (13.097s)
[964.820819] Starting dynamic subtest: migrate
[976.417620] Dynamic subtest migrate: SUCCESS (11.707s)
[976.554680] Starting dynamic subtest: active
[982.263082] Dynamic subtest active: SUCCESS (5.830s)
[982.393754] Starting dynamic subtest: objects
[997.768223] Dynamic subtest objects: SUCCESS (15.480s)
[997.898108] Starting dynamic subtest: mman
[1020.033970] Dynamic subtest mman: SUCCESS (22.257s)
[1020.163967] Starting dynamic subtest: dmabuf
[1025.883711] Dynamic subtest dmabuf: SUCCESS (5.835s)
[1026.020597] Starting dynamic subtest: vma
[1031.697194] Dynamic subtest vma: SUCCESS (5.795s)
[1031.836132] Starting dynamic subtest: coherency
[1047.005894] Dynamic subtest coherency: SUCCESS (15.297s)
[1047.135793] Starting dynamic subtest: gtt
[1061.031125] Dynamic subtest gtt: SUCCESS (14.010s)
[1061.158637] Starting dynamic subtest: gem
[1068.265816] Dynamic subtest gem: SUCCESS (7.221s)
[1068.397882] Starting dynamic subtest: evict
[1087.577238] Dynamic subtest evict: SUCCESS (19.315s)
[1087.635539] Starting dynamic subtest: hugepages
[1099.908684] Dynamic subtest hugepages: SUCCESS (12.316s)
[1099.967500] Starting dynamic subtest: gem_contexts
[1151.474738] Dynamic subtest gem_contexts: SUCCESS (51.533s)
[1151.537733] Starting dynamic subtest: client
[1157.438681] Dynamic subtest client: SUCCESS (5.948s)
[1157.580124] Starting dynamic subtest: gem_migrate
[1163.253959] Dynamic subtest gem_migrate: SUCCESS (5.792s)
[1163.394366] Starting dynamic subtest: reset
[1173.967125] Dynamic subtest reset: SUCCESS (10.698s)
[1174.026285] Starting dynamic subtest: memory_region
[1179.632886] Dynamic subtest memory_region: SUCCESS (5.648s)
[1179.771389] Starting dynamic subtest: hangcheck
[1208.911909] Dynamic subtest hangcheck: SUCCESS (29.267s)
[1208.970836] Starting dynamic subtest: execlists
[1230.953789] Dynamic subtest execlists: SUCCESS (22.021s)
[1231.014700] Starting dynamic subtest: ring_submission
[1236.639117] Dynamic subtest ring_submission: SUCCESS (5.670s)
[1236.774305] Starting dynamic subtest: perf
[1242.818821] Dynamic subtest perf: SUCCESS (6.159s)
[1242.952299] Starting dynamic subtest: slpc
[1248.506754] Dynamic subtest slpc: SUCCESS (5.666s)
[1248.641837] Starting dynamic subtest: guc
[1254.340398] Dynamic subtest guc: SUCCESS (5.816s)
[1254.470791] Starting dynamic subtest: guc_multi_lrc
[1260.079913] Dynamic subtest guc_multi_lrc: SUCCESS (5.728s)
[1260.193997] Starting dynamic subtest: guc_hang
[1265.734950] Dynamic subtest guc_hang: SUCCESS (5.638s)
[1265.868936] Starting dynamic subtest: late_gt_pm
[1271.695732] Dynamic subtest late_gt_pm: SUCCESS (5.945s)
[1271.703175] Subtest live: FAIL (459.992s)
[1272.084270] Overall timeout time exceeded, stopping.
[1272.086544] Closing watchdogs
Done.