[142.194289] Initializing watchdogs
[142.195215]   /dev/watchdog0
[142.270396] [001/171] (960s left) i915_module_load (load)
[143.383227] Starting subtest: load
[152.049150] Subtest load: SUCCESS (8.658s)
[152.474633] [002/171] (950s left) core_auth (basic-auth)
[154.506775] Starting subtest: basic-auth
[154.516302] Subtest basic-auth: SUCCESS (0.006s)
[154.853949] [003/171] (948s left) debugfs_test (read_all_entries)
[155.970154] Starting subtest: read_all_entries
[156.511396] Subtest read_all_entries: SUCCESS (0.608s)
[157.525526] [004/171] (946s left) debugfs_test (basic-hwmon)
[158.500304] Starting subtest: basic-hwmon
[158.517805] Subtest basic-hwmon: SKIP (0.000s)
[159.552199] [005/171] (944s left) fbdev (eof)
[160.791562] Starting subtest: eof
[160.798968] Subtest eof: SUCCESS (0.005s)
[161.098310] [006/171] (943s left) fbdev (info)
[162.016941] Starting subtest: info
[162.024897] Subtest info: SUCCESS (0.000s)
[162.382966] [007/171] (942s left) fbdev (nullptr)
[163.384638] Starting subtest: nullptr
[163.392835] Subtest nullptr: SUCCESS (0.000s)
[163.758499] [008/171] (941s left) fbdev (read)
[164.749981] Starting subtest: read
[167.320542] Subtest read: SUCCESS (2.490s)
[167.647254] [009/171] (937s left) fbdev (write)
[168.621332] Starting subtest: write
[169.969902] Subtest write: SUCCESS (1.273s)
[170.316848] [010/171] (935s left) gem_basic (bad-close)
[171.376331] Starting subtest: bad-close
[171.395618] Subtest bad-close: SUCCESS (0.001s)
[171.817181] [011/171] (933s left) gem_basic (create-close)
[172.759214] Starting subtest: create-close
[172.782124] Subtest create-close: SUCCESS (0.002s)
[173.249215] [012/171] (932s left) gem_basic (create-fd-close)
[174.222965] Starting subtest: create-fd-close
[174.239874] Subtest create-fd-close: SUCCESS (0.002s)
[174.734432] [013/171] (931s left) gem_busy (busy@all-engines)
[176.075493] Starting subtest: busy
[176.086951] Starting dynamic subtest: all-engines
[176.497098] Dynamic subtest all-engines: SUCCESS (0.435s)
[176.507175] Subtest busy: SUCCESS (0.438s)
[177.287326] [014/171] (929s left) gem_close_race (basic-process)
[178.536678] Starting subtest: basic-process
[178.868947] Subtest basic-process: SUCCESS (0.342s)
[179.384218] [015/171] (927s left) gem_close_race (basic-threads)
[180.543496] Starting subtest: basic-threads
[182.284493] Subtest basic-threads: SUCCESS (1.782s)
[182.892638] [016/171] (924s left) gem_ctx_create (basic)
[184.147916] Starting subtest: basic
[184.155943] Subtest basic: SUCCESS (0.001s)
[184.641563] [017/171] (922s left) gem_ctx_create (basic-files)
[185.753718] Starting subtest: basic-files
[187.947376] Subtest basic-files: SUCCESS (2.176s)
[188.453133] [018/171] (919s left) gem_ctx_exec (basic)
[189.501661] Starting subtest: basic
[189.542789] Subtest basic: SUCCESS (0.037s)
[189.914319] [019/171] (917s left) gem_exec_basic (basic)
[191.041225] Starting subtest: basic
[191.050974] Starting dynamic subtest: rcs0-smem
[191.058708] Dynamic subtest rcs0-smem: SUCCESS (0.016s)
[191.134848] Starting dynamic subtest: bcs0-smem
[191.142151] Dynamic subtest bcs0-smem: SUCCESS (0.009s)
[191.291988] Starting dynamic subtest: vcs0-smem
[191.300840] Dynamic subtest vcs0-smem: SUCCESS (0.005s)
[191.381441] Starting dynamic subtest: vecs0-smem
[191.395630] Dynamic subtest vecs0-smem: SUCCESS (0.006s)
[191.403848] Subtest basic: SUCCESS (0.043s)
[191.665299] [020/171] (916s left) gem_exec_create (basic)
[192.843933] Starting subtest: basic
[192.854391] Starting dynamic subtest: smem
[194.994310] Dynamic subtest smem: SUCCESS (2.236s)
[195.004380] Subtest basic: SUCCESS (2.238s)
[195.562305] [021/171] (912s left) gem_exec_fence (basic-busy)
[197.009749] Starting subtest: basic-busy
[197.034851] Starting dynamic subtest: rcs0
[197.055965] Dynamic subtest rcs0: SUCCESS (0.082s)
[197.208744] Starting dynamic subtest: bcs0
[197.240977] Dynamic subtest bcs0: SUCCESS (0.054s)
[197.326519] Starting dynamic subtest: vcs0
[197.346268] Dynamic subtest vcs0: SUCCESS (0.051s)
[197.452951] Starting dynamic subtest: vecs0
[197.500249] Dynamic subtest vecs0: SUCCESS (0.050s)
[197.508715] Subtest basic-busy: SUCCESS (0.246s)
[199.556616] [022/171] (908s left) gem_exec_fence (basic-wait)
[200.951577] Starting subtest: basic-wait
[200.971254] Starting dynamic subtest: rcs0
[200.989143] Dynamic subtest rcs0: SUCCESS (0.063s)
[201.147462] Starting dynamic subtest: bcs0
[201.165996] Dynamic subtest bcs0: SUCCESS (0.057s)
[201.267127] Starting dynamic subtest: vcs0
[201.274478] Dynamic subtest vcs0: SUCCESS (0.052s)
[201.414483] Starting dynamic subtest: vecs0
[201.421743] Dynamic subtest vecs0: SUCCESS (0.058s)
[201.429314] Subtest basic-wait: SUCCESS (0.240s)
[203.089757] [023/171] (905s left) gem_exec_fence (basic-await)
[204.382483] Starting subtest: basic-await
[204.392158] Starting dynamic subtest: rcs0
[204.860945] Dynamic subtest rcs0: SUCCESS (0.463s)
[204.956660] Starting dynamic subtest: bcs0
[205.298224] Dynamic subtest bcs0: SUCCESS (0.467s)
[205.388166] Starting dynamic subtest: vcs0
[205.766146] Dynamic subtest vcs0: SUCCESS (0.440s)
[205.920817] Starting dynamic subtest: vecs0
[206.207614] Dynamic subtest vecs0: SUCCESS (0.451s)
[206.227659] Subtest basic-await: SUCCESS (1.835s)
[208.075241] [024/171] (901s left) gem_exec_fence (nb-await)
[209.435137] Starting subtest: nb-await
[209.450227] Starting dynamic subtest: rcs0
[209.586878] Dynamic subtest rcs0: SUCCESS (0.170s)
[209.667830] Starting dynamic subtest: bcs0
[209.677629] Dynamic subtest bcs0: SUCCESS (0.136s)
[209.758882] Starting dynamic subtest: vcs0
[209.793304] Dynamic subtest vcs0: SUCCESS (0.130s)
[209.925892] Starting dynamic subtest: vecs0
[209.933826] Dynamic subtest vecs0: SUCCESS (0.131s)
[209.942963] Subtest nb-await: SUCCESS (0.581s)
[211.856384] [025/171] (897s left) gem_exec_gttfill (basic)
[213.060764] Starting subtest: basic
[218.225972] Subtest basic: SKIP (5.115s)
[218.825641] [026/171] (890s left) gem_exec_parallel (engines)
[220.571895] Starting subtest: engines
[220.579980] Starting dynamic subtest: basic
[233.704166] Dynamic subtest basic: SUCCESS (13.142s)
[233.856685] Starting dynamic subtest: contexts
[250.449911] Dynamic subtest contexts: SUCCESS (16.735s)
[250.600786] Starting dynamic subtest: fds
[269.945607] Dynamic subtest fds: SUCCESS (19.563s)
[270.093185] Starting dynamic subtest: userptr
[283.200185] Dynamic subtest userptr: SUCCESS (13.187s)
[283.207781] Subtest engines: SUCCESS (62.634s)
[283.837940] [027/171] (826s left) gem_exec_store (basic)
[285.084772] Starting subtest: basic
[285.193747] Subtest basic: SUCCESS (0.152s)
[285.760125] [028/171] (824s left) gem_flink_basic (bad-flink)
[286.758801] Starting subtest: bad-flink
[286.769958] Subtest bad-flink: SUCCESS (0.000s)
[287.189363] [029/171] (823s left) gem_flink_basic (bad-open)
[288.091787] Starting subtest: bad-open
[288.101519] Subtest bad-open: SUCCESS (0.000s)
[288.528685] [030/171] (822s left) gem_flink_basic (basic)
[289.439420] Starting subtest: basic
[289.447537] Subtest basic: SUCCESS (0.002s)
[289.935141] [031/171] (821s left) gem_flink_basic (double-flink)
[290.905669] Starting subtest: double-flink
[290.913113] Subtest double-flink: SUCCESS (0.001s)
[291.347970] [032/171] (820s left) gem_flink_basic (flink-lifetime)
[292.281457] Starting subtest: flink-lifetime
[292.290365] Subtest flink-lifetime: SUCCESS (0.011s)
[292.733914] [033/171] (819s left) gem_huc_copy (huc-copy)
[293.834144] Starting subtest: huc-copy
[293.849215] Subtest huc-copy: SKIP (0.000s)
[294.119720] [034/171] (817s left) gem_linear_blits (basic)
[296.242614] Subtest basic: SKIP (0.000s)
[296.595159] [035/171] (815s left) gem_mmap (basic)
[298.246762] Starting subtest: basic
[298.285834] Subtest basic: SUCCESS (0.004s)
[298.708837] [036/171] (813s left) gem_mmap_gtt (basic)
[299.743749] Starting subtest: basic
[299.752637] Subtest basic: SUCCESS (0.007s)
[300.181884] [037/171] (812s left) gem_render_linear_blits (basic)
[301.241989] Starting subtest: basic
[301.513158] Subtest basic: SUCCESS (0.270s)
[301.948301] [038/171] (811s left) gem_render_tiled_blits (basic)
[303.049936] Starting subtest: basic
[303.388750] Subtest basic: SUCCESS (0.338s)
[303.717553] [039/171] (809s left) gem_ringfill (basic-all)
[305.853921] Starting subtest: basic-all
[307.520766] Subtest basic-all: SUCCESS (1.657s)
[307.920211] [040/171] (805s left) gem_softpin (allocator-basic)
[308.993810] Starting subtest: allocator-basic
[310.252272] Subtest allocator-basic: SUCCESS (1.178s)
[310.694838] [041/171] (803s left) gem_softpin (allocator-basic-reserve)
[311.663742] Starting subtest: allocator-basic-reserve
[312.888874] Subtest allocator-basic-reserve: SUCCESS (1.142s)
[313.334855] [042/171] (800s left) gem_softpin (safe-alignment)
[314.290711] Starting subtest: safe-alignment
[314.472238] Subtest safe-alignment: SUCCESS (0.129s)
[314.786724] [043/171] (799s left) gem_sync (basic-all)
[315.933927] Starting subtest: basic-all
[320.491429] Subtest basic-all: SUCCESS (4.557s)
[321.104304] [044/171] (793s left) gem_sync (basic-each)
[322.128888] Starting subtest: basic-each
[325.620789] Subtest basic-each: SUCCESS (3.491s)
[326.196214] [045/171] (788s left) gem_tiled_blits (basic)
[328.349777] Subtest basic: SKIP (0.000s)
[328.574606] [046/171] (786s left) gem_tiled_fence_blits (basic)
[331.047774] Starting subtest: basic
[331.095087] Subtest basic: SUCCESS (0.109s)
[331.681800] [047/171] (783s left) gem_tiled_pread_basic
[334.799424] [048/171] (780s left) gem_wait (busy@all-engines)
[336.029772] Starting subtest: busy
[336.042421] Starting dynamic subtest: all-engines
[336.635578] Dynamic subtest all-engines: SUCCESS (0.662s)
[336.643383] Subtest busy: SUCCESS (0.665s)
[337.505212] [049/171] (778s left) gem_wait (wait@all-engines)
[338.626282] Starting subtest: wait
[338.634889] Starting dynamic subtest: all-engines
[339.786697] Dynamic subtest all-engines: SUCCESS (1.123s)
[339.794350] Subtest wait: SUCCESS (1.126s)
[340.469365] [050/171] (775s left) i915_getparams_basic (basic-eu-total)
[341.417899] Starting subtest: basic-eu-total
[341.436941] Subtest basic-eu-total: SUCCESS (0.002s)
[341.799926] [051/171] (774s left) i915_getparams_basic (basic-subslice-total)
[342.682943] Starting subtest: basic-subslice-total
[342.699356] Subtest basic-subslice-total: SUCCESS (0.001s)
[343.061310] [052/171] (773s left) i915_hangman (error-state-basic)
[344.193934] Starting subtest: error-state-basic
[344.250267] Subtest error-state-basic: SUCCESS (0.053s)
[344.689755] [053/171] (772s left) i915_pciid
[346.099314] [054/171] (770s left) kms_addfb_basic (addfb25-bad-modifier)
[347.072971] Starting subtest: addfb25-bad-modifier
[347.080882] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[348.450295] [055/171] (768s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[349.412700] Starting subtest: addfb25-framebuffer-vs-set-tiling
[349.421314] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.001s)
[350.430242] [056/171] (767s left) kms_addfb_basic (addfb25-modifier-no-flag)
[351.393111] Starting subtest: addfb25-modifier-no-flag
[351.401474] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[352.484218] [057/171] (765s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[353.436960] Starting subtest: addfb25-x-tiled-legacy
[353.444914] Subtest addfb25-x-tiled-legacy: SUCCESS (0.001s)
[354.503244] [058/171] (763s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[355.449089] Starting subtest: addfb25-x-tiled-mismatch-legacy
[355.455864] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[356.503305] [059/171] (761s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[358.114585] Starting subtest: addfb25-yf-tiled-legacy
[358.122116] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[358.462245] [060/171] (760s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[360.070641] Starting subtest: addfb25-y-tiled-legacy
[360.079299] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[360.438696] [061/171] (758s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[362.017727] Starting subtest: addfb25-y-tiled-small-legacy
[362.034811] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.002s)
[362.384295] [062/171] (756s left) kms_addfb_basic (bad-pitch-0)
[363.354181] Starting subtest: bad-pitch-0
[363.361853] Subtest bad-pitch-0: SUCCESS (0.000s)
[364.436898] [063/171] (755s left) kms_addfb_basic (bad-pitch-1024)
[365.375908] Starting subtest: bad-pitch-1024
[365.384193] Subtest bad-pitch-1024: SUCCESS (0.000s)
[366.405196] [064/171] (753s left) kms_addfb_basic (bad-pitch-128)
[367.349622] Starting subtest: bad-pitch-128
[367.358466] Subtest bad-pitch-128: SUCCESS (0.000s)
[368.371139] [065/171] (751s left) kms_addfb_basic (bad-pitch-256)
[369.348499] Starting subtest: bad-pitch-256
[369.360116] Subtest bad-pitch-256: SUCCESS (0.000s)
[370.384617] [066/171] (750s left) kms_addfb_basic (bad-pitch-32)
[371.337835] Starting subtest: bad-pitch-32
[371.346835] Subtest bad-pitch-32: SUCCESS (0.000s)
[372.348467] [067/171] (748s left) kms_addfb_basic (bad-pitch-63)
[373.316689] Starting subtest: bad-pitch-63
[373.326291] Subtest bad-pitch-63: SUCCESS (0.000s)
[374.399804] [068/171] (746s left) kms_addfb_basic (bad-pitch-65536)
[375.347089] Starting subtest: bad-pitch-65536
[375.355486] Subtest bad-pitch-65536: SUCCESS (0.002s)
[376.414322] [069/171] (744s left) kms_addfb_basic (bad-pitch-999)
[377.401370] Starting subtest: bad-pitch-999
[377.408938] Subtest bad-pitch-999: SUCCESS (0.002s)
[378.458346] [070/171] (743s left) kms_addfb_basic (basic)
[379.392727] Starting subtest: basic
[379.401346] Subtest basic: SUCCESS (0.001s)
[380.417444] [071/171] (741s left) kms_addfb_basic (basic-x-tiled-legacy)
[381.390392] Starting subtest: basic-x-tiled-legacy
[381.398749] Subtest basic-x-tiled-legacy: SUCCESS (0.001s)
[382.411182] [072/171] (739s left) kms_addfb_basic (basic-y-tiled-legacy)
[383.388998] Starting subtest: basic-y-tiled-legacy
[383.397534] Subtest basic-y-tiled-legacy: SUCCESS (0.003s)
[384.435495] [073/171] (738s left) kms_addfb_basic (bo-too-small)
[386.091781] Starting subtest: bo-too-small
[386.103263] Subtest bo-too-small: SUCCESS (0.002s)
[386.546637] [074/171] (736s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[388.166493] Starting subtest: bo-too-small-due-to-tiling
[388.178922] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[388.534331] [075/171] (734s left) kms_addfb_basic (clobberred-modifier)
[389.512581] Starting subtest: clobberred-modifier
[389.520597] Subtest clobberred-modifier: SUCCESS (0.001s)
[390.569395] [076/171] (733s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[391.556901] Starting subtest: framebuffer-vs-set-tiling
[391.565156] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[392.590540] [077/171] (731s left) kms_addfb_basic (invalid-get-prop)
[393.560684] Starting subtest: invalid-get-prop
[393.568994] Subtest invalid-get-prop: SUCCESS (0.000s)
[394.605212] [078/171] (729s left) kms_addfb_basic (invalid-get-prop-any)
[395.568421] Starting subtest: invalid-get-prop-any
[395.576569] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[396.544322] [079/171] (727s left) kms_addfb_basic (invalid-set-prop)
[397.497787] Starting subtest: invalid-set-prop
[397.507651] Subtest invalid-set-prop: SUCCESS (0.000s)
[398.489623] [080/171] (726s left) kms_addfb_basic (invalid-set-prop-any)
[399.452456] Starting subtest: invalid-set-prop-any
[399.460820] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[400.522336] [081/171] (724s left) kms_addfb_basic (no-handle)
[401.477575] Starting subtest: no-handle
[401.485251] Subtest no-handle: SUCCESS (0.000s)
[402.396209] [082/171] (722s left) kms_addfb_basic (size-max)
[404.030764] Starting subtest: size-max
[404.041627] Subtest size-max: SUCCESS (0.001s)
[404.421559] [083/171] (721s left) kms_addfb_basic (small-bo)
[406.164488] Starting subtest: small-bo
[406.173192] Subtest small-bo: SUCCESS (0.001s)
[406.635137] [084/171] (719s left) kms_addfb_basic (tile-pitch-mismatch)
[407.730807] Starting subtest: tile-pitch-mismatch
[407.738706] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[408.983148] [085/171] (717s left) kms_addfb_basic (too-high)
[410.674950] Starting subtest: too-high
[410.683823] Subtest too-high: SUCCESS (0.006s)
[411.049854] [086/171] (715s left) kms_addfb_basic (too-wide)
[412.673235] Starting subtest: too-wide
[412.683959] Subtest too-wide: SUCCESS (0.000s)
[413.048360] [087/171] (713s left) kms_addfb_basic (unused-handle)
[414.003426] Starting subtest: unused-handle
[414.011512] Subtest unused-handle: SUCCESS (0.000s)
[415.033976] [088/171] (712s left) kms_addfb_basic (unused-modifier)
[415.965124] Starting subtest: unused-modifier
[415.974149] Subtest unused-modifier: SUCCESS (0.000s)
[416.953291] [089/171] (710s left) kms_addfb_basic (unused-offsets)
[417.909610] Starting subtest: unused-offsets
[417.918391] Subtest unused-offsets: SUCCESS (0.000s)
[418.951671] [090/171] (708s left) kms_addfb_basic (unused-pitches)
[419.893103] Starting subtest: unused-pitches
[419.901896] Subtest unused-pitches: SUCCESS (0.000s)
[420.924819] [091/171] (707s left) kms_busy (basic)
[422.601209] Starting subtest: basic
[422.612271] Starting dynamic subtest: flip
[425.967324] Dynamic subtest flip: SUCCESS (3.357s)
[426.131886] Starting dynamic subtest: modeset
[430.926924] Dynamic subtest modeset: SUCCESS (4.953s)
[430.940569] Subtest basic: SUCCESS (8.326s)
[432.155600] [092/171] (696s left) kms_chamelium_hpd (dp-hpd-fast)
[434.410867] Subtest dp-hpd-fast: SKIP (0.000s)
[435.430809] [093/171] (693s left) kms_chamelium_edid (dp-edid-read)
[437.573981] Subtest dp-edid-read: SKIP (0.000s)
[438.580524] [094/171] (690s left) kms_chamelium_frames (dp-crc-fast)
[440.745700] Subtest dp-crc-fast: SKIP (0.000s)
[441.750314] [095/171] (687s left) kms_chamelium_hpd (hdmi-hpd-fast)
[443.768728] Subtest hdmi-hpd-fast: SKIP (0.000s)
[444.790571] [096/171] (684s left) kms_chamelium_edid (hdmi-edid-read)
[446.839858] Subtest hdmi-edid-read: SKIP (0.000s)
[447.846542] [097/171] (681s left) kms_chamelium_frames (hdmi-crc-fast)
[449.905548] Subtest hdmi-crc-fast: SKIP (0.000s)
[450.913989] [098/171] (678s left) kms_chamelium_hpd (vga-hpd-fast)
[452.981171] Subtest vga-hpd-fast: SKIP (0.000s)
[453.991397] [099/171] (676s left) kms_chamelium_edid (vga-edid-read)
[456.026915] Subtest vga-edid-read: SKIP (0.000s)
[457.082897] [100/171] (673s left) kms_prop_blob (basic)
[458.102902] Starting subtest: basic
[458.111969] Subtest basic: SUCCESS (0.000s)
[458.522135] [101/171] (672s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[460.207693] Starting subtest: basic-busy-flip-before-cursor-atomic
[460.226844] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[460.590329] [102/171] (670s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[462.190770] Starting subtest: basic-busy-flip-before-cursor-legacy
[462.206483] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[462.602315] [103/171] (668s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[464.203866] Starting subtest: basic-flip-after-cursor-atomic
[466.076395] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.864s)
[467.408239] [104/171] (664s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[468.981951] Starting subtest: basic-flip-after-cursor-legacy
[470.773934] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.786s)
[471.976401] [105/171] (659s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[473.579691] Starting subtest: basic-flip-after-cursor-varying-size
[475.385208] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.802s)
[476.577238] [106/171] (655s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[478.166196] Starting subtest: basic-flip-before-cursor-atomic
[480.029085] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.855s)
[481.222191] [107/171] (651s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[482.816611] Starting subtest: basic-flip-before-cursor-legacy
[484.619565] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.809s)
[485.808388] [108/171] (646s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[487.392831] Starting subtest: basic-flip-before-cursor-varying-size
[489.279768] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.880s)
[490.487378] [109/171] (642s left) kms_flip (basic-flip-vs-dpms)
[491.723152] Starting subtest: basic-flip-vs-dpms
[491.774313] Starting dynamic subtest: A-eDP1
[495.451771] Dynamic subtest A-eDP1: SUCCESS (3.689s)
[495.620159] Starting dynamic subtest: B-eDP1
[498.369922] Dynamic subtest B-eDP1: SUCCESS (2.890s)
[498.519237] Starting dynamic subtest: C-eDP1
[501.224438] Dynamic subtest C-eDP1: SUCCESS (2.847s)
[501.300919] Subtest basic-flip-vs-dpms: SUCCESS (9.567s)
[502.415708] [110/171] (630s left) kms_flip (basic-flip-vs-modeset)
[503.671321] Starting subtest: basic-flip-vs-modeset
[503.694837] Starting dynamic subtest: A-eDP1
[507.345279] Dynamic subtest A-eDP1: SUCCESS (3.644s)
[507.523617] Starting dynamic subtest: B-eDP1
[509.995640] Dynamic subtest B-eDP1: SUCCESS (2.653s)
[510.207134] Starting dynamic subtest: C-eDP1
[512.704427] Dynamic subtest C-eDP1: SUCCESS (2.687s)
[512.748515] Subtest basic-flip-vs-modeset: SUCCESS (9.104s)
[513.934798] [111/171] (619s left) kms_flip (basic-flip-vs-wf_vblank)
[515.179347] Starting subtest: basic-flip-vs-wf_vblank
[515.240331] Starting dynamic subtest: A-eDP1
[518.158922] Dynamic subtest A-eDP1: SUCCESS (2.894s)
[518.317093] Starting dynamic subtest: B-eDP1
[520.784484] Dynamic subtest B-eDP1: SUCCESS (2.588s)
[520.933669] Starting dynamic subtest: C-eDP1
[523.393448] Dynamic subtest C-eDP1: SUCCESS (2.567s)
[523.401192] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.187s)
[525.343738] [112/171] (608s left) kms_flip (basic-plain-flip)
[526.645147] Starting subtest: basic-plain-flip
[526.679301] Starting dynamic subtest: A-eDP1
[529.318809] Dynamic subtest A-eDP1: SUCCESS (2.573s)
[529.466867] Starting dynamic subtest: B-eDP1
[531.695102] Dynamic subtest B-eDP1: SUCCESS (2.351s)
[531.855703] Starting dynamic subtest: C-eDP1
[534.015677] Dynamic subtest C-eDP1: SUCCESS (2.302s)
[534.028339] Subtest basic-plain-flip: SUCCESS (7.371s)
[535.927318] [113/171] (598s left) kms_force_connector_basic (force-connector-state)
[537.520933] Starting subtest: force-connector-state
[540.521492] Subtest force-connector-state: SUCCESS (2.993s)
[543.098797] [114/171] (591s left) kms_force_connector_basic (force-edid)
[544.613961] Starting subtest: force-edid
[545.185173] Subtest force-edid: SUCCESS (0.564s)
[547.020777] [115/171] (587s left) kms_force_connector_basic (force-load-detect)
[548.561752] Starting subtest: force-load-detect
[548.579701] Subtest force-load-detect: SKIP (0.000s)
[550.108748] [116/171] (584s left) kms_force_connector_basic (prune-stale-modes)
[551.676773] Starting subtest: prune-stale-modes
[552.293846] Subtest prune-stale-modes: SUCCESS (0.596s)
[554.096749] [117/171] (581s left) kms_frontbuffer_tracking (basic)
[555.825666] Starting subtest: basic
[564.777366] Subtest basic: SUCCESS (8.954s)
[565.255851] [118/171] (570s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[566.946822] Starting subtest: compare-crc-sanitycheck-xr24
[566.975369] Starting dynamic subtest: pipe-A-eDP-1
[568.104323] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.129s)
[568.290282] Starting dynamic subtest: pipe-B-eDP-1
[570.151472] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.013s)
[570.313486] Starting dynamic subtest: pipe-C-eDP-1
[572.308078] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.122s)
[572.316229] Subtest compare-crc-sanitycheck-xr24: SUCCESS (5.358s)
[573.544660] [119/171] (562s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[575.192971] Starting subtest: compare-crc-sanitycheck-nv12
[575.202298] Starting dynamic subtest: pipe-A-eDP-1
[577.707351] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.452s)
[577.872532] Starting dynamic subtest: pipe-B-eDP-1
[580.892854] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.196s)
[581.072245] Starting dynamic subtest: pipe-C-eDP-1
[581.091143] Dynamic subtest pipe-C-eDP-1: SKIP (0.007s)
[581.099910] Subtest compare-crc-sanitycheck-nv12: SUCCESS (5.742s)
[582.134378] [120/171] (554s left) kms_pipe_crc_basic (hang-read-crc)
[583.761911] Starting subtest: hang-read-crc
[583.799318] Starting dynamic subtest: pipe-A-eDP-1
[587.133772] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.341s)
[587.290855] Starting dynamic subtest: pipe-B-eDP-1
[591.280440] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.122s)
[591.462325] Starting dynamic subtest: pipe-C-eDP-1
[595.878903] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.568s)
[595.889237] Subtest hang-read-crc: SUCCESS (12.108s)
[597.057904] [121/171] (539s left) kms_pipe_crc_basic (nonblocking-crc)
[598.688090] Starting subtest: nonblocking-crc
[598.696937] Starting dynamic subtest: pipe-A-eDP-1
[600.069483] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.379s)
[600.276583] Starting dynamic subtest: pipe-B-eDP-1
[602.130872] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.030s)
[602.317854] Starting dynamic subtest: pipe-C-eDP-1
[604.490483] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.302s)
[604.501409] Subtest nonblocking-crc: SUCCESS (5.790s)
[605.690588] [122/171] (531s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[607.335761] Starting subtest: nonblocking-crc-frame-sequence
[607.343839] Starting dynamic subtest: pipe-A-eDP-1
[608.730103] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.389s)
[608.943976] Starting dynamic subtest: pipe-B-eDP-1
[610.857491] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.087s)
[611.020786] Starting dynamic subtest: pipe-C-eDP-1
[613.180758] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.286s)
[613.189537] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.860s)
[614.391946] [123/171] (522s left) kms_pipe_crc_basic (read-crc)
[615.970532] Starting subtest: read-crc
[615.980495] Starting dynamic subtest: pipe-A-eDP-1
[617.272948] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.298s)
[617.452702] Starting dynamic subtest: pipe-B-eDP-1
[619.298799] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.002s)
[619.454215] Starting dynamic subtest: pipe-C-eDP-1
[621.628672] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.289s)
[621.639124] Subtest read-crc: SUCCESS (5.679s)
[622.820783] [124/171] (514s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[624.419782] Starting subtest: read-crc-frame-sequence
[624.446845] Starting dynamic subtest: pipe-A-eDP-1
[625.730160] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.292s)
[625.954492] Starting dynamic subtest: pipe-B-eDP-1
[627.777180] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.019s)
[627.986246] Starting dynamic subtest: pipe-C-eDP-1
[629.995724] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.172s)
[630.003307] Subtest read-crc-frame-sequence: SUCCESS (5.574s)
[631.224375] [125/171] (506s left) kms_psr (primary_page_flip)
[632.925232] Starting subtest: primary_page_flip
[635.784513] Subtest primary_page_flip: SUCCESS (2.831s)
[636.944599] [126/171] (501s left) kms_psr (cursor_plane_move)
[638.576852] Starting subtest: cursor_plane_move
[641.406345] Subtest cursor_plane_move: SUCCESS (2.847s)
[642.661138] [127/171] (495s left) kms_psr (sprite_plane_onoff)
[644.335297] Starting subtest: sprite_plane_onoff
[647.359341] Subtest sprite_plane_onoff: SUCCESS (3.044s)
[648.556842] [128/171] (490s left) kms_psr (primary_mmap_gtt)
[650.166798] Starting subtest: primary_mmap_gtt
[653.082854] Subtest primary_mmap_gtt: SUCCESS (2.927s)
[654.281625] [129/171] (484s left) kms_setmode (basic-clone-single-crtc)
[655.304850] Starting subtest: basic-clone-single-crtc
[655.329975] Subtest basic-clone-single-crtc: SKIP (0.006s)
[655.733158] [130/171] (483s left) i915_pm_backlight (basic-brightness)
[657.613818] Starting subtest: basic-brightness
[658.166846] Starting dynamic subtest: eDP-1
[658.858917] Dynamic subtest eDP-1: SUCCESS (0.753s)
[658.867429] Subtest basic-brightness: SUCCESS (1.264s)
[660.109927] [131/171] (479s left) i915_pm_rpm (basic-pci-d3-state)
[664.165705] Starting subtest: basic-pci-d3-state
[669.065660] Subtest basic-pci-d3-state: SUCCESS (4.889s)
[669.802779] [132/171] (470s left) i915_pm_rpm (basic-rte)
[670.771087] Starting subtest: basic-rte
[678.602598] Subtest basic-rte: SUCCESS (7.809s)
[681.262844] [133/171] (458s left) i915_pm_rps (basic-api)
[682.403381] Starting subtest: basic-api
[682.438833] Subtest basic-api: SUCCESS (0.036s)
[682.895614] [134/171] (457s left) prime_self_import (basic-llseek-bad)
[683.939881] Starting subtest: basic-llseek-bad
[683.958814] Subtest basic-llseek-bad: SUCCESS (0.017s)
[684.386445] [135/171] (456s left) prime_self_import (basic-llseek-size)
[685.307913] Starting subtest: basic-llseek-size
[685.325740] Subtest basic-llseek-size: SUCCESS (0.029s)
[685.748726] [136/171] (455s left) prime_self_import (basic-with_fd_dup)
[686.649125] Starting subtest: basic-with_fd_dup
[686.686946] Subtest basic-with_fd_dup: SUCCESS (0.027s)
[687.114558] [137/171] (454s left) prime_self_import (basic-with_one_bo)
[688.028709] Starting subtest: basic-with_one_bo
[688.065486] Subtest basic-with_one_bo: SUCCESS (0.033s)
[688.523284] [138/171] (453s left) prime_self_import (basic-with_one_bo_two_files)
[689.462505] Starting subtest: basic-with_one_bo_two_files
[689.478335] Subtest basic-with_one_bo_two_files: SUCCESS (0.024s)
[689.896301] [139/171] (451s left) prime_self_import (basic-with_two_bos)
[690.841278] Starting subtest: basic-with_two_bos
[690.855695] Subtest basic-with_two_bos: SUCCESS (0.030s)
[691.291169] [140/171] (450s left) prime_vgem (basic-fence-flip)
[692.429117] Starting subtest: basic-fence-flip
[694.143284] Subtest basic-fence-flip: SUCCESS (1.692s)
[694.668638] [141/171] (447s left) prime_vgem (basic-fence-mmap)
[695.658123] Starting subtest: basic-fence-mmap
[695.971117] Subtest basic-fence-mmap: SUCCESS (0.256s)
[696.298449] [142/171] (446s left) prime_vgem (basic-fence-read)
[697.313322] Starting subtest: basic-fence-read
[697.848929] Subtest basic-fence-read: SUCCESS (0.475s)
[698.219556] [143/171] (444s left) prime_vgem (basic-gtt)
[699.242846] Starting subtest: basic-gtt
[699.414412] Subtest basic-gtt: SUCCESS (0.126s)
[699.829635] [144/171] (443s left) prime_vgem (basic-read)
[701.145685] Starting subtest: basic-read
[701.331234] Subtest basic-read: SUCCESS (0.191s)
[701.795785] [145/171] (441s left) prime_vgem (basic-write)
[702.842530] Starting subtest: basic-write
[703.170933] Subtest basic-write: SUCCESS (0.256s)
[703.582941] [146/171] (440s left) vgem_basic (setversion)
[704.712149] Starting subtest: setversion
[704.727694] Subtest setversion: SUCCESS (0.000s)
[705.090713] [147/171] (439s left) vgem_basic (create)
[706.043111] Starting subtest: create
[706.052115] Subtest create: SUCCESS (0.002s)
[706.443517] [148/171] (438s left) vgem_basic (debugfs)
[707.405185] Starting subtest: debugfs
[707.413568] Subtest debugfs: SUCCESS (0.004s)
[707.788648] [149/171] (436s left) vgem_basic (dmabuf-export)
[708.764401] Starting subtest: dmabuf-export
[708.781393] Subtest dmabuf-export: SUCCESS (0.016s)
[709.194129] [150/171] (435s left) vgem_basic (dmabuf-fence)
[710.176474] Starting subtest: dmabuf-fence
[710.185489] Subtest dmabuf-fence: SUCCESS (0.005s)
[710.578590] [151/171] (434s left) vgem_basic (dmabuf-fence-before)
[711.553968] Starting subtest: dmabuf-fence-before
[711.562679] Subtest dmabuf-fence-before: SUCCESS (0.003s)
[711.931390] [152/171] (433s left) vgem_basic (dmabuf-mmap)
[712.897923] Starting subtest: dmabuf-mmap
[713.086208] Subtest dmabuf-mmap: SUCCESS (0.142s)
[713.412547] [153/171] (432s left) vgem_basic (mmap)
[714.369943] Starting subtest: mmap
[714.556588] Subtest mmap: SUCCESS (0.129s)
[714.895844] [154/171] (431s left) vgem_basic (second-client)
[715.859892] Starting subtest: second-client
[715.944850] Subtest second-client: SUCCESS (0.079s)
[716.353721] [155/171] (430s left) vgem_basic (sysfs)
[717.387792] Starting subtest: sysfs
[717.396375] Subtest sysfs: SUCCESS (0.005s)
[717.829446] [156/171] (428s left) core_hotunplug (unbind-rebind)
[719.410380] Starting subtest: unbind-rebind
[726.765817] Subtest unbind-rebind: SUCCESS (7.350s)
[727.279300] [157/171] (419s left) vgem_basic (unload)
[728.544547] Starting subtest: unload
[758.600666] Subtest unload: SUCCESS (29.997s)
[759.233410] [158/171] (388s left) i915_module_load (reload)
[760.325798] Starting subtest: reload
[772.656254] Subtest reload: SUCCESS (12.265s)
[773.006720] [159/171] (374s left) gem_lmem_swapping (basic)
[774.625710] Subtest basic: SKIP (0.000s)
[774.956495] [160/171] (373s left) gem_lmem_swapping (parallel-random-engines)
[775.969346] Subtest parallel-random-engines: SKIP (0.000s)
[776.351938] [161/171] (372s left) gem_lmem_swapping (random-engines)
[777.428834] Subtest random-engines: SKIP (0.000s)
[777.780464] [162/171] (370s left) gem_lmem_swapping (verify-random)
[778.767160] Subtest verify-random: SKIP (0.000s)
[779.100595] [163/171] (369s left) i915_pm_rpm (module-reload)
[783.783343] Starting subtest: module-reload
[816.801659] Subtest module-reload: SUCCESS (32.940s)
[816.980192] [164/171] (332s left) i915_selftest (live)
[818.111518] Starting subtest: live
[818.119327] Starting dynamic subtest: sanitycheck
[823.865148] Dynamic subtest sanitycheck: SUCCESS (5.764s)
[823.990759] Starting dynamic subtest: uncore
[829.484758] Dynamic subtest uncore: SUCCESS (5.598s)
[829.619735] Starting dynamic subtest: workarounds
[836.261643] Dynamic subtest workarounds: SUCCESS (6.765s)
[836.391723] Starting dynamic subtest: gt_engines
[842.260819] Dynamic subtest gt_engines: SUCCESS (5.985s)
[842.387635] Starting dynamic subtest: gt_timelines
[911.161943] Dynamic subtest gt_timelines: SUCCESS (68.902s)
[911.218671] Starting dynamic subtest: gt_contexts
[917.190747] Dynamic subtest gt_contexts: SUCCESS (5.994s)
[917.307449] Starting dynamic subtest: gt_lrc
[927.943364] Dynamic subtest gt_lrc: SUCCESS (10.739s)
[928.070591] Starting dynamic subtest: gt_mocs
[933.967445] Dynamic subtest gt_mocs: SUCCESS (6.009s)
[934.098827] Starting dynamic subtest: gt_pm
[945.041644] Dynamic subtest gt_pm: FAIL (9.281s)
[945.197996] Starting dynamic subtest: gt_heartbeat
[949.759998] Dynamic subtest gt_heartbeat: SUCCESS (6.453s)
[949.907573] Starting dynamic subtest: gt_tlb
[956.929923] Dynamic subtest gt_tlb: SUCCESS (7.234s)
[957.054359] Starting dynamic subtest: requests
[970.157491] Dynamic subtest requests: SUCCESS (13.158s)
[970.293789] Starting dynamic subtest: migrate
[981.695167] Dynamic subtest migrate: SUCCESS (11.526s)
[981.828807] Starting dynamic subtest: active
[987.318741] Dynamic subtest active: SUCCESS (5.611s)
[987.433309] Starting dynamic subtest: objects
[1003.349527] Dynamic subtest objects: SUCCESS (16.008s)
[1003.481567] Starting dynamic subtest: mman
[1026.073164] Dynamic subtest mman: SUCCESS (22.710s)
[1026.209310] Starting dynamic subtest: dmabuf
[1032.021641] Dynamic subtest dmabuf: SUCCESS (5.932s)
[1032.152825] Starting dynamic subtest: vma
[1037.844567] Dynamic subtest vma: SUCCESS (5.801s)
[1037.904823] Starting dynamic subtest: coherency
[1053.865695] Dynamic subtest coherency: SUCCESS (16.006s)
[1053.923400] Starting dynamic subtest: gtt
[1067.660763] Dynamic subtest gtt: SUCCESS (13.786s)
[1067.719704] Starting dynamic subtest: gem
[1074.876900] Dynamic subtest gem: SUCCESS (7.194s)
[1075.010845] Starting dynamic subtest: evict
[1093.565843] Dynamic subtest evict: SUCCESS (18.677s)
[1093.623171] Starting dynamic subtest: hugepages
[1105.898267] Dynamic subtest hugepages: SUCCESS (12.314s)
[1105.958100] Starting dynamic subtest: gem_contexts
[1156.806943] Dynamic subtest gem_contexts: SUCCESS (50.887s)
[1156.866173] Starting dynamic subtest: client
[1162.907632] Dynamic subtest client: SUCCESS (6.084s)
[1163.042111] Starting dynamic subtest: gem_migrate
[1168.507842] Dynamic subtest gem_migrate: SUCCESS (5.571s)
[1168.626741] Starting dynamic subtest: reset
[1178.968705] Dynamic subtest reset: SUCCESS (10.450s)
[1179.027140] Starting dynamic subtest: memory_region
[1184.653821] Dynamic subtest memory_region: SUCCESS (5.673s)
[1184.785900] Starting dynamic subtest: hangcheck
[1213.641660] Dynamic subtest hangcheck: SUCCESS (28.973s)
[1213.701554] Starting dynamic subtest: execlists
[1235.826740] Dynamic subtest execlists: SUCCESS (22.178s)
[1235.886477] Starting dynamic subtest: ring_submission
[1241.679252] Dynamic subtest ring_submission: SUCCESS (5.826s)
[1241.800501] Starting dynamic subtest: perf
[1247.693700] Dynamic subtest perf: SUCCESS (5.999s)
[1247.826882] Starting dynamic subtest: slpc
[1253.380289] Dynamic subtest slpc: SUCCESS (5.673s)
[1253.499636] Starting dynamic subtest: guc
[1259.188465] Dynamic subtest guc: SUCCESS (5.798s)
[1259.333632] Starting dynamic subtest: guc_multi_lrc
[1264.868170] Dynamic subtest guc_multi_lrc: SUCCESS (5.663s)
[1265.002778] Starting dynamic subtest: guc_hang
[1270.508972] Dynamic subtest guc_hang: SUCCESS (5.624s)
[1270.643105] Starting dynamic subtest: late_gt_pm
[1276.548405] Dynamic subtest late_gt_pm: SUCCESS (6.015s)
[1276.555946] Subtest live: FAIL (458.459s)
[1276.924403] Overall timeout time exceeded, stopping.
[1276.926649] Closing watchdogs
Done.