[29.366991] Initializing watchdogs
[29.367157]   /dev/watchdog0
[29.374555] [001/165] (960s left) i915_module_load (load)
[29.467635] Starting subtest: load
[30.966604] Subtest load: SUCCESS (1.498s)
[30.986553] [002/165] (958s left) core_auth (basic-auth)
[31.077958] Starting subtest: basic-auth
[31.079142] Subtest basic-auth: SUCCESS (0.001s)
[31.142267] [003/165] (958s left) debugfs_test (read_all_entries)
[31.232602] Starting subtest: read_all_entries
[31.285139] Subtest read_all_entries: SUCCESS (0.054s)
[31.408492] [004/165] (958s left) debugfs_test (basic-hwmon)
[31.561056] Starting subtest: basic-hwmon
[31.563297] Subtest basic-hwmon: SKIP (0.000s)
[31.657968] [005/165] (958s left) fbdev (eof)
[31.754621] Starting subtest: eof
[31.755752] Subtest eof: SUCCESS (0.001s)
[31.810907] [006/165] (958s left) fbdev (info)
[31.892128] Starting subtest: info
[31.893258] Subtest info: SUCCESS (0.000s)
[31.964054] [007/165] (958s left) fbdev (nullptr)
[32.056584] Starting subtest: nullptr
[32.058149] Subtest nullptr: SUCCESS (0.000s)
[32.112392] [008/165] (957s left) fbdev (read)
[32.205220] Starting subtest: read
[32.435958] Subtest read: SUCCESS (0.230s)
[32.495646] [009/165] (957s left) fbdev (write)
[32.589868] Starting subtest: write
[32.707137] Subtest write: SUCCESS (0.116s)
[32.762317] [010/165] (957s left) gem_basic (bad-close)
[32.849610] Starting subtest: bad-close
[32.851850] Subtest bad-close: SUCCESS (0.000s)
[32.915594] [011/165] (957s left) gem_basic (create-close)
[32.998853] Starting subtest: create-close
[33.001484] Subtest create-close: SUCCESS (0.000s)
[33.065398] [012/165] (957s left) gem_basic (create-fd-close)
[33.151345] Starting subtest: create-fd-close
[33.153522] Subtest create-fd-close: SUCCESS (0.000s)
[33.214306] [013/165] (956s left) gem_busy (busy@all-engines)
[33.314728] Starting subtest: busy
[33.315799] Starting dynamic subtest: all-engines
[33.341060] Dynamic subtest all-engines: SUCCESS (0.027s)
[33.342069] Subtest busy: SUCCESS (0.028s)
[33.668448] [014/165] (956s left) gem_close_race (basic-process)
[33.774290] Starting subtest: basic-process
[33.812474] Subtest basic-process: SUCCESS (0.041s)
[33.990341] [015/165] (956s left) gem_close_race (basic-threads)
[34.164905] Starting subtest: basic-threads
[35.301671] Subtest basic-threads: SUCCESS (1.137s)
[35.472690] [016/165] (954s left) gem_ctx_create (basic)
[35.578494] Subtest basic: SKIP (0.000s)
[35.624915] [017/165] (954s left) gem_ctx_create (basic-files)
[35.744948] Subtest basic-files: SKIP (0.000s)
[35.776839] [018/165] (954s left) gem_ctx_exec (basic)
[35.866439] Subtest basic: SKIP (0.000s)
[35.927551] [019/165] (954s left) gem_exec_basic (basic)
[36.021405] Starting subtest: basic
[36.024431] Starting dynamic subtest: rcs0-smem
[36.025540] Dynamic subtest rcs0-smem: SUCCESS (0.000s)
[36.026662] Subtest basic: SUCCESS (0.002s)
[36.210399] [020/165] (954s left) gem_exec_create (basic)
[36.305148] Starting subtest: basic
[36.307615] Starting dynamic subtest: smem
[38.340358] Dynamic subtest smem: SUCCESS (2.035s)
[38.341487] Subtest basic: SUCCESS (2.035s)
[38.518461] [021/165] (951s left) gem_exec_fence (basic-busy)
[38.762933] Starting subtest: basic-busy
[38.763997] Starting dynamic subtest: rcs0
[38.780280] Dynamic subtest rcs0: SUCCESS (0.019s)
[38.781470] Subtest basic-busy: SUCCESS (0.020s)
[39.271279] [022/165] (951s left) gem_exec_fence (basic-wait)
[39.491101] Starting subtest: basic-wait
[39.492210] Starting dynamic subtest: rcs0
[39.500295] Dynamic subtest rcs0: SUCCESS (0.012s)
[39.501417] Subtest basic-wait: SUCCESS (0.013s)
[39.940756] [023/165] (950s left) gem_exec_fence (basic-await)
[40.168088] Starting subtest: basic-await
[40.169100] Starting dynamic subtest: rcs0
[40.227769] Dynamic subtest rcs0: SUCCESS (0.062s)
[40.228872] Subtest basic-await: SUCCESS (0.063s)
[40.676561] [024/165] (949s left) gem_exec_fence (nb-await)
[40.893732] Starting subtest: nb-await
[40.894907] Starting dynamic subtest: rcs0
[40.945273] Dynamic subtest rcs0: SUCCESS (0.053s)
[40.946465] Subtest nb-await: SUCCESS (0.054s)
[41.394778] [025/165] (948s left) gem_exec_gttfill (basic)
[41.491985] Starting subtest: basic
[44.740710] Subtest basic: SUCCESS (3.248s)
[44.927957] [026/165] (945s left) gem_exec_parallel (engines)
[45.150085] Starting subtest: engines
[45.151995] Starting dynamic subtest: basic
[47.293831] Dynamic subtest basic: SUCCESS (2.141s)
[47.301800] Starting dynamic subtest: contexts
[47.304122] Dynamic subtest contexts: SKIP (0.000s)
[47.315142] Starting dynamic subtest: fds
[47.317402] Dynamic subtest fds: SKIP (0.000s)
[47.328291] Starting dynamic subtest: userptr
[49.484666] Dynamic subtest userptr: SUCCESS (2.193s)
[49.485932] Subtest engines: SUCCESS (4.336s)
[49.676977] [027/165] (940s left) gem_exec_store (basic)
[49.793820] Starting subtest: basic
[49.815467] Subtest basic: SUCCESS (0.022s)
[49.993696] [028/165] (940s left) gem_flink_basic (bad-flink)
[50.082383] Starting subtest: bad-flink
[50.083579] Subtest bad-flink: SUCCESS (0.000s)
[50.140450] [029/165] (940s left) gem_flink_basic (bad-open)
[50.226832] Starting subtest: bad-open
[50.227885] Subtest bad-open: SUCCESS (0.000s)
[50.295276] [030/165] (940s left) gem_flink_basic (basic)
[50.378303] Starting subtest: basic
[50.379362] Subtest basic: SUCCESS (0.000s)
[50.443605] [031/165] (940s left) gem_flink_basic (double-flink)
[50.528799] Starting subtest: double-flink
[50.529899] Subtest double-flink: SUCCESS (0.000s)
[50.593983] [032/165] (939s left) gem_flink_basic (flink-lifetime)
[50.682427] Starting subtest: flink-lifetime
[50.683499] Subtest flink-lifetime: SUCCESS (0.001s)
[50.761349] [033/165] (939s left) gem_huc_copy (huc-copy)
[50.849388] Subtest huc-copy: SKIP (0.000s)
[50.880323] [034/165] (939s left) gem_linear_blits (basic)
[51.274236] Starting subtest: basic
[51.289829] Subtest basic: SUCCESS (0.016s)
[51.413760] [035/165] (939s left) gem_mmap (basic)
[51.613991] Starting subtest: basic
[51.621131] Subtest basic: SUCCESS (0.001s)
[51.681553] [036/165] (938s left) gem_mmap_gtt (basic)
[51.770728] Starting subtest: basic
[51.771768] Subtest basic: SUCCESS (0.001s)
[51.851141] [037/165] (938s left) gem_render_linear_blits (basic)
[51.938771] Starting subtest: basic
[51.991361] Subtest basic: SUCCESS (0.052s)
[52.036419] [038/165] (938s left) gem_render_tiled_blits (basic)
[52.123407] Starting subtest: basic
[52.167024] Subtest basic: SUCCESS (0.043s)
[52.200199] [039/165] (938s left) gem_ringfill (basic-all)
[52.312404] Starting subtest: basic-all
[53.421198] Subtest basic-all: SUCCESS (1.104s)
[53.489585] [040/165] (937s left) gem_softpin (allocator-basic)
[53.577569] Subtest allocator-basic: SKIP (0.000s)
[53.637526] [041/165] (937s left) gem_softpin (allocator-basic-reserve)
[53.724048] Subtest allocator-basic-reserve: SKIP (0.000s)
[53.789196] [042/165] (936s left) gem_softpin (safe-alignment)
[53.877804] Starting subtest: safe-alignment
[53.882165] Subtest safe-alignment: SUCCESS (0.007s)
[53.955765] [043/165] (936s left) gem_sync (basic-all)
[54.054660] Starting subtest: basic-all
[56.137859] Subtest basic-all: SUCCESS (2.084s)
[56.315434] [044/165] (934s left) gem_sync (basic-each)
[56.414021] Starting subtest: basic-each
[58.487581] Subtest basic-each: SUCCESS (2.074s)
[58.672530] [045/165] (932s left) gem_tiled_blits (basic)
[59.046213] Starting subtest: basic
[59.071211] Subtest basic: SUCCESS (0.023s)
[59.170911] [046/165] (931s left) gem_tiled_fence_blits (basic)
[59.649456] Starting subtest: basic
[59.663611] Subtest basic: SUCCESS (0.013s)
[59.778360] [047/165] (931s left) gem_tiled_pread_basic
[60.244794] [048/165] (930s left) gem_wait (busy@all-engines)
[60.350782] Starting subtest: busy
[60.351834] Starting dynamic subtest: all-engines
[60.862315] Dynamic subtest all-engines: SUCCESS (0.509s)
[60.863407] Subtest busy: SUCCESS (0.510s)
[61.081143] [049/165] (929s left) gem_wait (wait@all-engines)
[61.184426] Starting subtest: wait
[61.186041] Starting dynamic subtest: all-engines
[62.202760] Dynamic subtest all-engines: SUCCESS (1.016s)
[62.203844] Subtest wait: SUCCESS (1.017s)
[62.419182] [050/165] (928s left) i915_getparams_basic (basic-eu-total)
[62.507133] Starting subtest: basic-eu-total
[62.509246] Subtest basic-eu-total: SUCCESS (0.000s)
[62.568983] [051/165] (928s left) i915_getparams_basic (basic-subslice-total)
[62.651190] Starting subtest: basic-subslice-total
[62.653350] Subtest basic-subslice-total: SUCCESS (0.000s)
[62.719447] [052/165] (928s left) i915_hangman (error-state-basic)
[62.809082] Starting subtest: error-state-basic
[62.931138] Subtest error-state-basic: SUCCESS (0.121s)
[62.986117] [053/165] (928s left) i915_pciid
[63.135356] [054/165] (927s left) kms_addfb_basic (addfb25-4-tiled)
[63.260873] Starting subtest: addfb25-4-tiled
[63.262059] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[63.335350] [055/165] (927s left) kms_addfb_basic (addfb25-bad-modifier)
[63.417874] Starting subtest: addfb25-bad-modifier
[63.421334] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[63.519244] [056/165] (927s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[63.602782] Starting subtest: addfb25-framebuffer-vs-set-tiling
[63.603863] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[63.703386] [057/165] (927s left) kms_addfb_basic (addfb25-modifier-no-flag)
[63.790725] Starting subtest: addfb25-modifier-no-flag
[63.791825] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[63.904663] [058/165] (927s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[63.995374] Starting subtest: addfb25-x-tiled-legacy
[63.996519] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[64.088674] [059/165] (927s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[64.173130] Starting subtest: addfb25-x-tiled-mismatch-legacy
[64.174646] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[64.287950] [060/165] (926s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[64.397833] Starting subtest: addfb25-yf-tiled-legacy
[64.398941] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[64.471196] [061/165] (926s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[64.581234] Starting subtest: addfb25-y-tiled-legacy
[64.582328] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[64.656186] [062/165] (926s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[64.762057] Starting subtest: addfb25-y-tiled-small-legacy
[64.764544] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[64.841377] [063/165] (926s left) kms_addfb_basic (bad-pitch-0)
[64.927562] Starting subtest: bad-pitch-0
[64.928984] Subtest bad-pitch-0: SUCCESS (0.000s)
[65.042446] [064/165] (926s left) kms_addfb_basic (bad-pitch-1024)
[65.127288] Starting subtest: bad-pitch-1024
[65.128853] Subtest bad-pitch-1024: SUCCESS (0.000s)
[65.224362] [065/165] (926s left) kms_addfb_basic (bad-pitch-128)
[65.309219] Starting subtest: bad-pitch-128
[65.310285] Subtest bad-pitch-128: SUCCESS (0.000s)
[65.410060] [066/165] (925s left) kms_addfb_basic (bad-pitch-256)
[65.495387] Starting subtest: bad-pitch-256
[65.496445] Subtest bad-pitch-256: SUCCESS (0.000s)
[65.609367] [067/165] (925s left) kms_addfb_basic (bad-pitch-32)
[65.700984] Starting subtest: bad-pitch-32
[65.704075] Subtest bad-pitch-32: SUCCESS (0.000s)
[65.826767] [068/165] (925s left) kms_addfb_basic (bad-pitch-63)
[65.924263] Starting subtest: bad-pitch-63
[65.925345] Subtest bad-pitch-63: SUCCESS (0.000s)
[66.026386] [069/165] (925s left) kms_addfb_basic (bad-pitch-65536)
[66.115316] Starting subtest: bad-pitch-65536
[66.116363] Subtest bad-pitch-65536: SUCCESS (0.000s)
[66.229778] [070/165] (925s left) kms_addfb_basic (bad-pitch-999)
[66.312339] Starting subtest: bad-pitch-999
[66.313411] Subtest bad-pitch-999: SUCCESS (0.000s)
[66.431431] [071/165] (924s left) kms_addfb_basic (basic)
[66.517802] Starting subtest: basic
[66.522569] Subtest basic: SUCCESS (0.000s)
[66.629596] [072/165] (924s left) kms_addfb_basic (basic-x-tiled-legacy)
[66.715100] Starting subtest: basic-x-tiled-legacy
[66.716221] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[66.814648] [073/165] (924s left) kms_addfb_basic (basic-y-tiled-legacy)
[66.902449] Starting subtest: basic-y-tiled-legacy
[66.903541] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[67.015510] [074/165] (924s left) kms_addfb_basic (bo-too-small)
[67.139657] Starting subtest: bo-too-small
[67.140836] Subtest bo-too-small: SUCCESS (0.000s)
[67.213158] [075/165] (924s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[67.322971] Starting subtest: bo-too-small-due-to-tiling
[67.324193] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[67.399882] [076/165] (924s left) kms_addfb_basic (clobberred-modifier)
[67.487075] Starting subtest: clobberred-modifier
[67.488126] Subtest clobberred-modifier: SUCCESS (0.000s)
[67.602369] [077/165] (923s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[67.688552] Starting subtest: framebuffer-vs-set-tiling
[67.689661] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[67.800315] [078/165] (923s left) kms_addfb_basic (invalid-get-prop)
[67.884921] Starting subtest: invalid-get-prop
[67.886733] Subtest invalid-get-prop: SUCCESS (0.000s)
[67.985668] [079/165] (923s left) kms_addfb_basic (invalid-get-prop-any)
[68.073249] Starting subtest: invalid-get-prop-any
[68.074420] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[68.186291] [080/165] (923s left) kms_addfb_basic (invalid-set-prop)
[68.273692] Starting subtest: invalid-set-prop
[68.274840] Subtest invalid-set-prop: SUCCESS (0.000s)
[68.386681] [081/165] (923s left) kms_addfb_basic (invalid-set-prop-any)
[68.470905] Starting subtest: invalid-set-prop-any
[68.471976] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[68.570887] [082/165] (923s left) kms_addfb_basic (no-handle)
[68.657244] Starting subtest: no-handle
[68.658343] Subtest no-handle: SUCCESS (0.000s)
[68.769751] [083/165] (922s left) kms_addfb_basic (size-max)
[68.876474] Starting subtest: size-max
[68.877636] Subtest size-max: SUCCESS (0.000s)
[68.955669] [084/165] (922s left) kms_addfb_basic (small-bo)
[69.061530] Starting subtest: small-bo
[69.062685] Subtest small-bo: SUCCESS (0.000s)
[69.141247] [085/165] (922s left) kms_addfb_basic (tile-pitch-mismatch)
[69.229096] Starting subtest: tile-pitch-mismatch
[69.230065] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[69.339973] [086/165] (922s left) kms_addfb_basic (too-high)
[69.444572] Starting subtest: too-high
[69.445727] Subtest too-high: SUCCESS (0.001s)
[69.522453] [087/165] (922s left) kms_addfb_basic (too-wide)
[69.646262] Starting subtest: too-wide
[69.647413] Subtest too-wide: SUCCESS (0.000s)
[69.723731] [088/165] (922s left) kms_addfb_basic (unused-handle)
[69.809242] Starting subtest: unused-handle
[69.810419] Subtest unused-handle: SUCCESS (0.000s)
[69.908904] [089/165] (921s left) kms_addfb_basic (unused-modifier)
[69.994036] Starting subtest: unused-modifier
[69.995108] Subtest unused-modifier: SUCCESS (0.000s)
[70.109113] [090/165] (921s left) kms_addfb_basic (unused-offsets)
[70.194372] Starting subtest: unused-offsets
[70.195424] Subtest unused-offsets: SUCCESS (0.000s)
[70.309980] [091/165] (921s left) kms_addfb_basic (unused-pitches)
[70.397324] Starting subtest: unused-pitches
[70.398423] Subtest unused-pitches: SUCCESS (0.000s)
[70.510961] [092/165] (921s left) kms_busy (basic)
[70.633633] Starting subtest: basic
[70.634889] Starting dynamic subtest: flip
[71.203212] Dynamic subtest flip: SUCCESS (0.569s)
[71.223116] Starting dynamic subtest: modeset
[71.225242] Dynamic subtest modeset: SKIP (0.000s)
[71.226337] Subtest basic: SUCCESS (0.571s)
[71.306094] [093/165] (920s left) kms_prop_blob (basic)
[71.394780] Starting subtest: basic
[71.395839] Subtest basic: SUCCESS (0.000s)
[71.455770] [094/165] (920s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[71.562959] Starting subtest: basic-busy-flip-before-cursor-atomic
[71.566307] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.004s)
[71.649300] [095/165] (920s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[71.762974] Starting subtest: basic-busy-flip-before-cursor-legacy
[72.753781] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.987s)
[72.872703] [096/165] (919s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[72.995433] Starting subtest: basic-flip-after-cursor-atomic
[72.997706] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[73.070030] [097/165] (918s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[73.173724] Starting subtest: basic-flip-after-cursor-legacy
[74.178257] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.003s)
[74.293403] [098/165] (917s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[74.413859] Starting subtest: basic-flip-after-cursor-varying-size
[75.404425] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.987s)
[75.512269] [099/165] (916s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[75.617670] Starting subtest: basic-flip-before-cursor-atomic
[75.620172] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[75.694931] [100/165] (916s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[75.818423] Starting subtest: basic-flip-before-cursor-legacy
[76.817870] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.998s)
[76.942187] [101/165] (915s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[77.048146] Starting subtest: basic-flip-before-cursor-varying-size
[78.050071] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.003s)
[78.169082] [102/165] (913s left) kms_dsc (dsc-basic)
[78.295075] Subtest dsc-basic: SKIP (0.000s)
[78.337754] [103/165] (913s left) kms_flip (basic-flip-vs-dpms)
[78.459903] Starting subtest: basic-flip-vs-dpms
[78.461029] Starting dynamic subtest: A-VGA1
[79.755585] Dynamic subtest A-VGA1: SUCCESS (1.298s)
[79.773068] Starting dynamic subtest: B-VGA1
[80.985260] Dynamic subtest B-VGA1: SUCCESS (1.228s)
[80.986367] Subtest basic-flip-vs-dpms: SUCCESS (2.528s)
[81.134359] [104/165] (911s left) kms_flip (basic-flip-vs-modeset)
[81.259095] Starting subtest: basic-flip-vs-modeset
[81.260199] Starting dynamic subtest: A-VGA1
[82.504620] Dynamic subtest A-VGA1: SUCCESS (1.247s)
[82.528111] Starting dynamic subtest: B-VGA1
[83.690051] Dynamic subtest B-VGA1: SUCCESS (1.179s)
[83.698041] Subtest basic-flip-vs-modeset: SUCCESS (2.428s)
[83.816388] [105/165] (908s left) kms_flip (basic-flip-vs-wf_vblank)
[83.938250] Starting subtest: basic-flip-vs-wf_vblank
[83.939308] Starting dynamic subtest: A-VGA1
[85.471894] Dynamic subtest A-VGA1: SUCCESS (1.530s)
[85.481590] Starting dynamic subtest: B-VGA1
[86.971290] Dynamic subtest B-VGA1: SUCCESS (1.499s)
[86.973102] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.032s)
[87.141843] [106/165] (905s left) kms_flip (basic-plain-flip)
[87.268600] Starting subtest: basic-plain-flip
[87.269751] Starting dynamic subtest: A-VGA1
[88.513160] Dynamic subtest A-VGA1: SUCCESS (1.246s)
[88.527134] Starting dynamic subtest: B-VGA1
[89.728097] Dynamic subtest B-VGA1: SUCCESS (1.210s)
[89.729169] Subtest basic-plain-flip: SUCCESS (2.458s)
[89.876802] [107/165] (902s left) kms_force_connector_basic (force-connector-state)
[90.014560] Starting subtest: force-connector-state
[90.200869] Subtest force-connector-state: SUCCESS (0.184s)
[90.431408] [108/165] (901s left) kms_force_connector_basic (force-edid)
[90.565946] Starting subtest: force-edid
[90.651573] Subtest force-edid: SUCCESS (0.083s)
[90.797811] [109/165] (901s left) kms_force_connector_basic (force-load-detect)
[90.938282] Starting subtest: force-load-detect
[91.122879] Subtest force-load-detect: SUCCESS (0.185s)
[91.334836] [110/165] (900s left) kms_force_connector_basic (prune-stale-modes)
[91.471108] Starting subtest: prune-stale-modes
[91.554298] Subtest prune-stale-modes: SUCCESS (0.083s)
[91.710369] [111/165] (900s left) kms_frontbuffer_tracking (basic)
[91.830755] Subtest basic: SKIP (0.000s)
[91.868700] [112/165] (900s left) kms_hdmi_inject (inject-audio)
[91.959363] Subtest inject-audio: SKIP (0.000s)
[91.986628] [113/165] (900s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[92.099592] Starting subtest: compare-crc-sanitycheck-xr24
[92.100734] Starting dynamic subtest: pipe-A-VGA-1
[92.379055] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.281s)
[92.406866] Starting dynamic subtest: pipe-B-VGA-1
[92.681740] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.300s)
[92.682799] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.586s)
[92.797834] [114/165] (899s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[92.905866] Starting subtest: compare-crc-sanitycheck-nv12
[92.907951] Starting dynamic subtest: pipe-A-VGA-1
[92.910150] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s)
[92.921088] Starting dynamic subtest: pipe-B-VGA-1
[92.923224] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s)
[92.925455] Subtest compare-crc-sanitycheck-nv12: SKIP (0.003s)
[92.981362] [115/165] (899s left) kms_pipe_crc_basic (hang-read-crc)
[93.088637] Starting subtest: hang-read-crc
[93.089875] Starting dynamic subtest: pipe-A-VGA-1
[93.943802] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.853s)
[93.953367] Starting dynamic subtest: pipe-B-VGA-1
[94.781507] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.836s)
[94.783388] Subtest hang-read-crc: SUCCESS (1.692s)
[94.896412] [116/165] (897s left) kms_pipe_crc_basic (nonblocking-crc)
[95.021625] Starting subtest: nonblocking-crc
[95.024050] Starting dynamic subtest: pipe-A-VGA-1
[95.485685] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.463s)
[95.495298] Starting dynamic subtest: pipe-B-VGA-1
[95.960201] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.473s)
[95.961780] Subtest nonblocking-crc: SUCCESS (0.940s)
[96.063548] [117/165] (896s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[96.170784] Starting subtest: nonblocking-crc-frame-sequence
[96.171977] Starting dynamic subtest: pipe-A-VGA-1
[96.621291] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.450s)
[96.639719] Starting dynamic subtest: pipe-B-VGA-1
[97.093691] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.472s)
[97.095313] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.925s)
[97.194573] [118/165] (895s left) kms_pipe_crc_basic (read-crc)
[97.304171] Starting subtest: read-crc
[97.305204] Starting dynamic subtest: pipe-A-VGA-1
[97.696993] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.394s)
[97.725930] Starting dynamic subtest: pipe-B-VGA-1
[98.109297] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.409s)
[98.110818] Subtest read-crc: SUCCESS (0.806s)
[98.223402] [119/165] (894s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[98.331887] Starting subtest: read-crc-frame-sequence
[98.333021] Starting dynamic subtest: pipe-A-VGA-1
[98.730800] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.400s)
[98.742101] Starting dynamic subtest: pipe-B-VGA-1
[99.135988] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.404s)
[99.139314] Subtest read-crc-frame-sequence: SUCCESS (0.807s)
[99.249029] [120/165] (893s left) kms_pm_backlight (basic-brightness)
[99.381833] Subtest basic-brightness: SKIP (0.000s)
[99.418219] [121/165] (893s left) kms_pm_rpm (basic-pci-d3-state)
[110.694240] Subtest basic-pci-d3-state: SKIP (0.000s)
[110.727322] [122/165] (881s left) kms_pm_rpm (basic-rte)
[110.816269] Starting subtest: basic-rte
[121.995220] Subtest basic-rte: SKIP (11.164s)
[122.032614] [123/165] (870s left) kms_psr (psr-primary-page-flip)
[122.150446] Subtest psr-primary-page-flip: SKIP (0.000s)
[122.193686] [124/165] (870s left) kms_psr (psr-cursor-plane-move)
[122.318382] Subtest psr-cursor-plane-move: SKIP (0.000s)
[122.361571] [125/165] (870s left) kms_psr (psr-sprite-plane-onoff)
[122.486137] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[122.528549] [126/165] (870s left) kms_psr (psr-primary-mmap-gtt)
[122.653168] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[122.698491] [127/165] (870s left) kms_setmode (basic-clone-single-crtc)
[122.784437] Starting subtest: basic-clone-single-crtc
[122.787862] Subtest basic-clone-single-crtc: SKIP (0.000s)
[122.862104] [128/165] (869s left) i915_pm_rps (basic-api)
[122.949625] Subtest basic-api: SKIP (0.000s)
[122.980499] [129/165] (869s left) prime_self_import (basic-llseek-bad)
[123.062956] Starting subtest: basic-llseek-bad
[123.066754] Subtest basic-llseek-bad: SUCCESS (0.005s)
[123.147218] [130/165] (869s left) prime_self_import (basic-llseek-size)
[123.230678] Starting subtest: basic-llseek-size
[123.233984] Subtest basic-llseek-size: SUCCESS (0.003s)
[123.314454] [131/165] (869s left) prime_self_import (basic-with_fd_dup)
[123.399727] Starting subtest: basic-with_fd_dup
[123.401960] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[123.481885] [132/165] (869s left) prime_self_import (basic-with_one_bo)
[123.566041] Starting subtest: basic-with_one_bo
[123.568465] Subtest basic-with_one_bo: SUCCESS (0.003s)
[123.616192] [133/165] (869s left) prime_self_import (basic-with_one_bo_two_files)
[123.700028] Starting subtest: basic-with_one_bo_two_files
[123.702131] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[123.784563] [134/165] (869s left) prime_self_import (basic-with_two_bos)
[123.869338] Starting subtest: basic-with_two_bos
[123.871748] Subtest basic-with_two_bos: SUCCESS (0.004s)
[123.950042] [135/165] (868s left) prime_vgem (basic-fence-flip)
[124.043903] Starting subtest: basic-fence-flip
[124.444578] Subtest basic-fence-flip: SUCCESS (0.399s)
[124.536964] [136/165] (868s left) prime_vgem (basic-fence-mmap)
[124.628421] Starting subtest: basic-fence-mmap
[124.673717] Subtest basic-fence-mmap: SUCCESS (0.044s)
[124.752834] [137/165] (868s left) prime_vgem (basic-fence-read)
[124.847253] Starting subtest: basic-fence-read
[124.915673] Subtest basic-fence-read: SUCCESS (0.067s)
[124.987744] [138/165] (867s left) prime_vgem (basic-gtt)
[125.080361] Starting subtest: basic-gtt
[125.099842] Subtest basic-gtt: SUCCESS (0.020s)
[125.171292] [139/165] (867s left) prime_vgem (basic-read)
[125.264904] Starting subtest: basic-read
[125.295230] Subtest basic-read: SUCCESS (0.031s)
[125.371175] [140/165] (867s left) prime_vgem (basic-write)
[125.467931] Starting subtest: basic-write
[125.498486] Subtest basic-write: SUCCESS (0.033s)
[125.571302] [141/165] (867s left) vgem_basic (setversion)
[125.662710] Starting subtest: setversion
[125.665079] Subtest setversion: SUCCESS (0.000s)
[125.721596] [142/165] (867s left) vgem_basic (create)
[125.812989] Starting subtest: create
[125.814066] Subtest create: SUCCESS (0.000s)
[125.870580] [143/165] (867s left) vgem_basic (debugfs)
[125.964583] Starting subtest: debugfs
[125.965774] Subtest debugfs: SUCCESS (0.001s)
[126.023642] [144/165] (867s left) vgem_basic (dmabuf-export)
[126.114182] Starting subtest: dmabuf-export
[126.116826] Subtest dmabuf-export: SUCCESS (0.002s)
[126.189652] [145/165] (866s left) vgem_basic (dmabuf-fence)
[126.282314] Starting subtest: dmabuf-fence
[126.283486] Subtest dmabuf-fence: SUCCESS (0.001s)
[126.341780] [146/165] (866s left) vgem_basic (dmabuf-fence-before)
[126.432181] Starting subtest: dmabuf-fence-before
[126.433315] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[126.492229] [147/165] (866s left) vgem_basic (dmabuf-mmap)
[126.582539] Starting subtest: dmabuf-mmap
[126.602198] Subtest dmabuf-mmap: SUCCESS (0.021s)
[126.658531] [148/165] (866s left) vgem_basic (mmap)
[126.749274] Starting subtest: mmap
[126.761964] Subtest mmap: SUCCESS (0.014s)
[126.825424] [149/165] (866s left) vgem_basic (second-client)
[126.916153] Starting subtest: second-client
[126.950803] Subtest second-client: SUCCESS (0.033s)
[127.009990] [150/165] (866s left) vgem_basic (sysfs)
[127.101840] Starting subtest: sysfs
[127.102989] Subtest sysfs: SUCCESS (0.001s)
[127.160483] [151/165] (866s left) core_hotunplug (unbind-rebind)
[127.300152] Starting subtest: unbind-rebind
[130.035259] Subtest unbind-rebind: SUCCESS (2.735s)
[130.062519] [152/165] (863s left) vgem_basic (unload)
[130.149226] Starting subtest: unload
[159.004412] Subtest unload: SUCCESS (28.854s)
[159.114852] [153/165] (834s left) i915_module_load (reload)
[159.197236] Starting subtest: reload
[160.927648] Subtest reload: SUCCESS (1.732s)
[160.951776] [154/165] (832s left) gem_lmem_swapping (basic)
[161.051336] Subtest basic: SKIP (0.000s)
[161.091331] [155/165] (832s left) gem_lmem_swapping (parallel-random-engines)
[161.178779] Subtest parallel-random-engines: SKIP (0.000s)
[161.207655] [156/165] (832s left) gem_lmem_swapping (random-engines)
[161.315489] Subtest random-engines: SKIP (0.000s)
[161.364911] [157/165] (832s left) gem_lmem_swapping (verify-random)
[161.498075] Subtest verify-random: SKIP (0.000s)
[161.541389] [158/165] (831s left) i915_pm_rpm (module-reload)
[172.819897] Subtest module-reload: SKIP (0.000s)
[172.847133] [159/165] (820s left) i915_selftest (live)
[173.436270] Starting subtest: live
[173.437667] Starting dynamic subtest: sanitycheck
[174.107240] Dynamic subtest sanitycheck: SUCCESS (0.668s)
[174.116879] Starting dynamic subtest: uncore
[174.740132] Dynamic subtest uncore: SUCCESS (0.634s)
[174.750193] Starting dynamic subtest: workarounds
[175.371196] Dynamic subtest workarounds: SUCCESS (0.630s)
[175.381179] Starting dynamic subtest: gt_engines
[175.992190] Dynamic subtest gt_engines: SUCCESS (0.620s)
[176.002105] Starting dynamic subtest: gt_timelines
[178.896347] Dynamic subtest gt_timelines: SUCCESS (2.903s)
[178.906450] Starting dynamic subtest: gt_contexts
[179.570368] Dynamic subtest gt_contexts: SUCCESS (0.673s)
[179.580692] Starting dynamic subtest: gt_lrc
[180.198060] Dynamic subtest gt_lrc: SUCCESS (0.627s)
[180.208167] Starting dynamic subtest: gt_mocs
[180.845536] Dynamic subtest gt_mocs: SUCCESS (0.646s)
[180.854830] Starting dynamic subtest: gt_pm
[181.942157] Dynamic subtest gt_pm: SUCCESS (1.096s)
[181.952265] Starting dynamic subtest: gt_heartbeat
[182.616226] Dynamic subtest gt_heartbeat: SUCCESS (0.673s)
[182.626038] Starting dynamic subtest: gt_tlb
[183.235077] Dynamic subtest gt_tlb: SUCCESS (0.618s)
[183.246078] Starting dynamic subtest: requests
[186.448240] Dynamic subtest requests: SUCCESS (3.212s)
[186.458209] Starting dynamic subtest: migrate
[187.093324] Dynamic subtest migrate: SUCCESS (0.644s)
[187.103121] Starting dynamic subtest: active
[187.714286] Dynamic subtest active: SUCCESS (0.620s)
[187.724727] Starting dynamic subtest: objects
[188.646125] Dynamic subtest objects: SUCCESS (0.929s)
[188.655819] Starting dynamic subtest: mman
[193.522670] Dynamic subtest mman: SUCCESS (4.878s)
[193.530983] Starting dynamic subtest: dmabuf
[194.186876] Dynamic subtest dmabuf: SUCCESS (0.663s)
[194.197140] Starting dynamic subtest: vma
[194.809966] Dynamic subtest vma: SUCCESS (0.622s)
[194.820158] Starting dynamic subtest: coherency
[196.553224] Dynamic subtest coherency: SUCCESS (1.742s)
[196.562610] Starting dynamic subtest: gtt
[200.746873] Dynamic subtest gtt: SUCCESS (4.192s)
[200.756853] Starting dynamic subtest: gem
[201.405849] Dynamic subtest gem: SUCCESS (0.658s)
[201.415914] Starting dynamic subtest: evict
[202.024366] Dynamic subtest evict: SUCCESS (0.617s)
[202.033901] Starting dynamic subtest: hugepages
[202.658071] Dynamic subtest hugepages: SUCCESS (0.633s)
[202.668364] Starting dynamic subtest: gem_contexts
[203.282056] Dynamic subtest gem_contexts: SUCCESS (0.623s)
[203.291420] Starting dynamic subtest: client
[203.909142] Dynamic subtest client: SUCCESS (0.624s)
[203.919237] Starting dynamic subtest: gem_migrate
[204.511422] Dynamic subtest gem_migrate: SUCCESS (0.604s)
[204.519863] Starting dynamic subtest: reset
[205.490288] Dynamic subtest reset: SUCCESS (0.977s)
[205.499600] Starting dynamic subtest: memory_region
[206.101088] Dynamic subtest memory_region: SUCCESS (0.610s)
[206.111422] Starting dynamic subtest: hangcheck
[207.787360] Dynamic subtest hangcheck: SUCCESS (1.685s)
[207.797329] Starting dynamic subtest: execlists
[208.417185] Dynamic subtest execlists: SUCCESS (0.629s)
[208.426841] Starting dynamic subtest: ring_submission
[209.046357] Dynamic subtest ring_submission: SUCCESS (0.628s)
[209.056254] Starting dynamic subtest: perf
[209.663958] Dynamic subtest perf: SUCCESS (0.617s)
[209.674512] Starting dynamic subtest: slpc
[210.296249] Dynamic subtest slpc: SUCCESS (0.631s)
[210.306636] Starting dynamic subtest: guc
[210.918305] Dynamic subtest guc: SUCCESS (0.621s)
[210.929159] Starting dynamic subtest: guc_multi_lrc
[211.538451] Dynamic subtest guc_multi_lrc: SUCCESS (0.619s)
[211.548879] Starting dynamic subtest: guc_hang
[212.154279] Dynamic subtest guc_hang: SUCCESS (0.612s)
[212.163666] Starting dynamic subtest: late_gt_pm
[212.779290] Dynamic subtest late_gt_pm: SUCCESS (0.626s)
[212.780437] Subtest live: SUCCESS (39.343s)
[212.803681] [160/165] (780s left) dmabuf (all-tests)
[212.896524] Starting subtest: all-tests
[212.897714] Starting dynamic subtest: sanitycheck
[212.951218] Dynamic subtest sanitycheck: SUCCESS (0.057s)
[212.967030] Starting dynamic subtest: dma_fence
[213.126035] Dynamic subtest dma_fence: SUCCESS (0.173s)
[213.135535] Starting dynamic subtest: dma_fence_chain
[230.513634] Dynamic subtest dma_fence_chain: SUCCESS (17.384s)
[230.528785] Starting dynamic subtest: dma_fence_unwrap
[230.565919] Dynamic subtest dma_fence_unwrap: SUCCESS (0.052s)
[230.578946] Starting dynamic subtest: dma_resv
[230.626635] Dynamic subtest dma_resv: SUCCESS (0.063s)
[230.628068] Subtest all-tests: SUCCESS (17.736s)
[230.650676] [161/165] (762s left) i915_suspend (basic-s2idle-without-i915)
[230.736034] Starting subtest: basic-s2idle-without-i915
[249.256658] Subtest basic-s2idle-without-i915: SUCCESS (18.521s)
[255.304571] [162/165] (744s left) i915_suspend (basic-s3-without-i915)
[255.397508] Starting subtest: basic-s3-without-i915
[271.965184] Subtest basic-s3-without-i915: SUCCESS (1.828s)
[275.063648] [163/165] (742s left) gem_exec_suspend (basic-s0)
[275.172570] Starting subtest: basic-S0
[275.174211] Starting dynamic subtest: smem
[291.876451] Dynamic subtest smem: SUCCESS (16.701s)
[291.877605] Subtest basic-S0: SUCCESS (16.702s)
[298.062753] [164/165] (725s left) gem_exec_suspend (basic-s3)
[298.171242] Starting subtest: basic-S3
[298.172270] Starting dynamic subtest: smem
[315.886146] Dynamic subtest smem: SUCCESS (1.859s)
[315.887351] Subtest basic-S3: SUCCESS (1.860s)
[321.081193] [165/165] (723s left) kms_pipe_crc_basic (suspend-read-crc)
[321.196717] Starting subtest: suspend-read-crc
[321.197922] Starting dynamic subtest: pipe-A-VGA-1
[338.823323] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.562s)
[338.844583] Starting dynamic subtest: pipe-B-VGA-1
[356.817499] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.575s)
[356.824324] Subtest suspend-read-crc: SUCCESS (3.141s)
[362.931489] Closing watchdogs
Done.