[40.177449] Initializing watchdogs
[40.177601]   /dev/watchdog0
[40.185664] [001/171] (960s left) i915_module_load (load)
[40.314640] Starting subtest: load
[41.943261] Subtest load: SUCCESS (1.630s)
[41.968934] [002/171] (958s left) core_auth (basic-auth)
[42.099582] Starting subtest: basic-auth
[42.100942] Subtest basic-auth: SUCCESS (0.001s)
[42.170135] [003/171] (958s left) debugfs_test (read_all_entries)
[42.317342] Starting subtest: read_all_entries
[42.365242] Subtest read_all_entries: SUCCESS (0.051s)
[42.507957] [004/171] (958s left) debugfs_test (basic-hwmon)
[42.719956] Starting subtest: basic-hwmon
[42.722183] Subtest basic-hwmon: SKIP (0.000s)
[42.822928] [005/171] (957s left) fbdev (eof)
[42.949077] Starting subtest: eof
[42.950799] Subtest eof: SUCCESS (0.001s)
[43.005137] [006/171] (957s left) fbdev (info)
[43.125713] Starting subtest: info
[43.126842] Subtest info: SUCCESS (0.000s)
[43.189393] [007/171] (957s left) fbdev (nullptr)
[43.316962] Starting subtest: nullptr
[43.318357] Subtest nullptr: SUCCESS (0.000s)
[43.373861] [008/171] (957s left) fbdev (read)
[43.499935] Starting subtest: read
[43.727993] Subtest read: SUCCESS (0.227s)
[43.775390] [009/171] (957s left) fbdev (write)
[43.901187] Starting subtest: write
[44.027064] Subtest write: SUCCESS (0.125s)
[44.076939] [010/171] (956s left) gem_basic (bad-close)
[44.198625] Starting subtest: bad-close
[44.201817] Subtest bad-close: SUCCESS (0.000s)
[44.259008] [011/171] (956s left) gem_basic (create-close)
[44.383383] Starting subtest: create-close
[44.385703] Subtest create-close: SUCCESS (0.000s)
[44.460926] [012/171] (956s left) gem_basic (create-fd-close)
[44.585339] Starting subtest: create-fd-close
[44.587974] Subtest create-fd-close: SUCCESS (0.000s)
[44.661434] [013/171] (956s left) gem_busy (busy@all-engines)
[44.811148] Starting subtest: busy
[44.812799] Starting dynamic subtest: all-engines
[44.835644] Dynamic subtest all-engines: SUCCESS (0.025s)
[44.836893] Subtest busy: SUCCESS (0.026s)
[45.146347] [014/171] (955s left) gem_close_race (basic-process)
[45.305923] Starting subtest: basic-process
[45.353698] Subtest basic-process: SUCCESS (0.048s)
[45.531414] [015/171] (955s left) gem_close_race (basic-threads)
[45.669596] Starting subtest: basic-threads
[46.799503] Subtest basic-threads: SUCCESS (1.130s)
[46.986903] [016/171] (954s left) gem_ctx_create (basic)
[47.117927] Subtest basic: SKIP (0.000s)
[47.137387] [017/171] (953s left) gem_ctx_create (basic-files)
[47.267415] Subtest basic-files: SKIP (0.000s)
[47.288496] [018/171] (953s left) gem_ctx_exec (basic)
[47.415945] Subtest basic: SKIP (0.000s)
[47.490890] [019/171] (953s left) gem_exec_basic (basic)
[47.623194] Starting subtest: basic
[47.624280] Starting dynamic subtest: rcs0-smem
[47.625342] Dynamic subtest rcs0-smem: SUCCESS (0.000s)
[47.626428] Subtest basic: SUCCESS (0.001s)
[47.806370] [020/171] (953s left) gem_exec_create (basic)
[47.939225] Starting subtest: basic
[47.940639] Starting dynamic subtest: smem
[49.982840] Dynamic subtest smem: SUCCESS (2.042s)
[49.986778] Subtest basic: SUCCESS (2.046s)
[50.165132] [021/171] (950s left) gem_exec_fence (basic-busy)
[50.445860] Starting subtest: basic-busy
[50.446886] Starting dynamic subtest: rcs0
[50.457144] Dynamic subtest rcs0: SUCCESS (0.013s)
[50.458242] Subtest basic-busy: SUCCESS (0.014s)
[50.951422] [022/171] (950s left) gem_exec_fence (basic-wait)
[51.206796] Starting subtest: basic-wait
[51.207920] Starting dynamic subtest: rcs0
[51.218331] Dynamic subtest rcs0: SUCCESS (0.013s)
[51.219293] Subtest basic-wait: SUCCESS (0.013s)
[51.670888] [023/171] (949s left) gem_exec_fence (basic-await)
[51.929310] Starting subtest: basic-await
[51.930381] Starting dynamic subtest: rcs0
[51.990058] Dynamic subtest rcs0: SUCCESS (0.062s)
[51.991181] Subtest basic-await: SUCCESS (0.063s)
[52.422140] [024/171] (948s left) gem_exec_fence (nb-await)
[52.679703] Starting subtest: nb-await
[52.680929] Starting dynamic subtest: rcs0
[52.730326] Dynamic subtest rcs0: SUCCESS (0.052s)
[52.731574] Subtest nb-await: SUCCESS (0.053s)
[53.175249] [025/171] (948s left) gem_exec_gttfill (basic)
[53.310949] Starting subtest: basic
[56.507215] Subtest basic: SUCCESS (3.196s)
[56.691675] [026/171] (944s left) gem_exec_parallel (engines)
[56.944535] Starting subtest: engines
[56.947240] Starting dynamic subtest: basic
[58.747942] Dynamic subtest basic: SUCCESS (1.802s)
[58.756927] Starting dynamic subtest: contexts
[58.760757] Dynamic subtest contexts: SKIP (0.000s)
[58.769578] Starting dynamic subtest: fds
[58.771709] Dynamic subtest fds: SKIP (0.000s)
[58.779434] Starting dynamic subtest: userptr
[60.598510] Dynamic subtest userptr: SUCCESS (1.850s)
[60.599617] Subtest engines: SUCCESS (3.653s)
[60.785941] [027/171] (940s left) gem_exec_store (basic)
[60.922327] Starting subtest: basic
[60.937384] Subtest basic: SUCCESS (0.015s)
[61.119830] [028/171] (940s left) gem_flink_basic (bad-flink)
[61.241779] Starting subtest: bad-flink
[61.243819] Subtest bad-flink: SUCCESS (0.000s)
[61.303585] [029/171] (939s left) gem_flink_basic (bad-open)
[61.428096] Starting subtest: bad-open
[61.429254] Subtest bad-open: SUCCESS (0.000s)
[61.504159] [030/171] (939s left) gem_flink_basic (basic)
[61.625254] Starting subtest: basic
[61.626418] Subtest basic: SUCCESS (0.000s)
[61.704992] [031/171] (939s left) gem_flink_basic (double-flink)
[61.826691] Starting subtest: double-flink
[61.828725] Subtest double-flink: SUCCESS (0.000s)
[61.905533] [032/171] (939s left) gem_flink_basic (flink-lifetime)
[62.027392] Starting subtest: flink-lifetime
[62.028488] Subtest flink-lifetime: SUCCESS (0.001s)
[62.105295] [033/171] (939s left) gem_huc_copy (huc-copy)
[62.228752] Subtest huc-copy: SKIP (0.000s)
[62.257935] [034/171] (939s left) gem_linear_blits (basic)
[62.618503] Starting subtest: basic
[62.628624] Subtest basic: SUCCESS (0.012s)
[62.740417] [035/171] (938s left) gem_mmap (basic)
[62.980855] Starting subtest: basic
[62.987039] Subtest basic: SUCCESS (0.000s)
[63.059759] [036/171] (938s left) gem_mmap_gtt (basic)
[63.187148] Starting subtest: basic
[63.188200] Subtest basic: SUCCESS (0.001s)
[63.265324] [037/171] (938s left) gem_render_linear_blits (basic)
[63.387989] Starting subtest: basic
[63.432952] Subtest basic: SUCCESS (0.048s)
[63.479009] [038/171] (938s left) gem_render_tiled_blits (basic)
[63.606934] Starting subtest: basic
[63.645294] Subtest basic: SUCCESS (0.041s)
[63.697097] [039/171] (937s left) gem_ringfill (basic-all)
[63.843332] Starting subtest: basic-all
[64.947446] Subtest basic-all: SUCCESS (1.104s)
[65.018144] [040/171] (936s left) gem_softpin (allocator-basic)
[65.142955] Subtest allocator-basic: SKIP (0.000s)
[65.216687] [041/171] (936s left) gem_softpin (allocator-basic-reserve)
[65.341333] Subtest allocator-basic-reserve: SKIP (0.000s)
[65.400083] [042/171] (936s left) gem_softpin (safe-alignment)
[65.527038] Starting subtest: safe-alignment
[65.528142] Subtest safe-alignment: SUCCESS (0.006s)
[65.601349] [043/171] (935s left) gem_sync (basic-all)
[65.740044] Starting subtest: basic-all
[67.778219] Subtest basic-all: SUCCESS (2.038s)
[67.959990] [044/171] (933s left) gem_sync (basic-each)
[68.092047] Starting subtest: basic-each
[70.203951] Subtest basic-each: SUCCESS (2.112s)
[70.384939] [045/171] (931s left) gem_tiled_blits (basic)
[70.767706] Starting subtest: basic
[70.787118] Subtest basic: SUCCESS (0.020s)
[70.886082] [046/171] (930s left) gem_tiled_fence_blits (basic)
[71.429870] Starting subtest: basic
[71.443721] Subtest basic: SUCCESS (0.013s)
[71.554768] [047/171] (930s left) gem_tiled_pread_basic
[72.043675] [048/171] (929s left) gem_wait (busy@all-engines)
[72.185052] Starting subtest: busy
[72.186920] Starting dynamic subtest: all-engines
[72.697119] Dynamic subtest all-engines: SUCCESS (0.512s)
[72.698244] Subtest busy: SUCCESS (0.513s)
[72.910382] [049/171] (928s left) gem_wait (wait@all-engines)
[73.051151] Starting subtest: wait
[73.052289] Starting dynamic subtest: all-engines
[74.066550] Dynamic subtest all-engines: SUCCESS (1.015s)
[74.067699] Subtest wait: SUCCESS (1.016s)
[74.282336] [050/171] (927s left) i915_getparams_basic (basic-eu-total)
[74.402975] Starting subtest: basic-eu-total
[74.406179] Subtest basic-eu-total: SUCCESS (0.000s)
[74.465944] [051/171] (927s left) i915_getparams_basic (basic-subslice-total)
[74.589430] Starting subtest: basic-subslice-total
[74.591614] Subtest basic-subslice-total: SUCCESS (0.000s)
[74.650347] [052/171] (927s left) i915_hangman (error-state-basic)
[74.779102] Starting subtest: error-state-basic
[74.889293] Subtest error-state-basic: SUCCESS (0.113s)
[74.947565] [053/171] (926s left) i915_pciid
[75.143931] [054/171] (926s left) kms_addfb_basic (addfb25-bad-modifier)
[75.269712] Starting subtest: addfb25-bad-modifier
[75.272367] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[75.379697] [055/171] (926s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[75.505601] Starting subtest: addfb25-framebuffer-vs-set-tiling
[75.506847] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[75.613817] [056/171] (926s left) kms_addfb_basic (addfb25-modifier-no-flag)
[75.742791] Starting subtest: addfb25-modifier-no-flag
[75.743861] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[75.847343] [057/171] (926s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[75.974849] Starting subtest: addfb25-x-tiled-legacy
[75.975959] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[76.083442] [058/171] (925s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[76.211998] Starting subtest: addfb25-x-tiled-mismatch-legacy
[76.213134] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[76.314675] [059/171] (925s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[76.473309] Starting subtest: addfb25-yf-tiled-legacy
[76.474559] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[76.547740] [060/171] (925s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[76.706075] Starting subtest: addfb25-y-tiled-legacy
[76.707261] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[76.781566] [061/171] (925s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[76.924352] Starting subtest: addfb25-y-tiled-small-legacy
[76.926726] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[77.001218] [062/171] (925s left) kms_addfb_basic (bad-pitch-0)
[77.128139] Starting subtest: bad-pitch-0
[77.129241] Subtest bad-pitch-0: SUCCESS (0.000s)
[77.235976] [063/171] (924s left) kms_addfb_basic (bad-pitch-1024)
[77.363019] Starting subtest: bad-pitch-1024
[77.364202] Subtest bad-pitch-1024: SUCCESS (0.000s)
[77.468988] [064/171] (924s left) kms_addfb_basic (bad-pitch-128)
[77.592052] Starting subtest: bad-pitch-128
[77.593224] Subtest bad-pitch-128: SUCCESS (0.000s)
[77.704589] [065/171] (924s left) kms_addfb_basic (bad-pitch-256)
[77.828237] Starting subtest: bad-pitch-256
[77.829194] Subtest bad-pitch-256: SUCCESS (0.000s)
[77.936727] [066/171] (924s left) kms_addfb_basic (bad-pitch-32)
[78.062746] Starting subtest: bad-pitch-32
[78.063927] Subtest bad-pitch-32: SUCCESS (0.000s)
[78.172190] [067/171] (923s left) kms_addfb_basic (bad-pitch-63)
[78.293096] Starting subtest: bad-pitch-63
[78.295873] Subtest bad-pitch-63: SUCCESS (0.000s)
[78.406714] [068/171] (923s left) kms_addfb_basic (bad-pitch-65536)
[78.534325] Starting subtest: bad-pitch-65536
[78.535377] Subtest bad-pitch-65536: SUCCESS (0.000s)
[78.641600] [069/171] (923s left) kms_addfb_basic (bad-pitch-999)
[78.771258] Starting subtest: bad-pitch-999
[78.773328] Subtest bad-pitch-999: SUCCESS (0.000s)
[78.876980] [070/171] (923s left) kms_addfb_basic (basic)
[79.001948] Starting subtest: basic
[79.003123] Subtest basic: SUCCESS (0.000s)
[79.109921] [071/171] (923s left) kms_addfb_basic (basic-x-tiled-legacy)
[79.238144] Starting subtest: basic-x-tiled-legacy
[79.239267] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[79.344621] [072/171] (922s left) kms_addfb_basic (basic-y-tiled-legacy)
[79.470783] Starting subtest: basic-y-tiled-legacy
[79.471912] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[79.578075] [073/171] (922s left) kms_addfb_basic (bo-too-small)
[79.732843] Starting subtest: bo-too-small
[79.734458] Subtest bo-too-small: SUCCESS (0.000s)
[79.810568] [074/171] (922s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[79.967832] Starting subtest: bo-too-small-due-to-tiling
[79.969317] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[80.044299] [075/171] (922s left) kms_addfb_basic (clobberred-modifier)
[80.171101] Starting subtest: clobberred-modifier
[80.172169] Subtest clobberred-modifier: SUCCESS (0.000s)
[80.278541] [076/171] (922s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[80.402891] Starting subtest: framebuffer-vs-set-tiling
[80.404734] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[80.513372] [077/171] (921s left) kms_addfb_basic (invalid-get-prop)
[80.636216] Starting subtest: invalid-get-prop
[80.637310] Subtest invalid-get-prop: SUCCESS (0.000s)
[80.747861] [078/171] (921s left) kms_addfb_basic (invalid-get-prop-any)
[80.876397] Starting subtest: invalid-get-prop-any
[80.877533] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[80.982770] [079/171] (921s left) kms_addfb_basic (invalid-set-prop)
[81.111250] Starting subtest: invalid-set-prop
[81.112354] Subtest invalid-set-prop: SUCCESS (0.000s)
[81.215039] [080/171] (921s left) kms_addfb_basic (invalid-set-prop-any)
[81.343825] Starting subtest: invalid-set-prop-any
[81.344961] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[81.451641] [081/171] (920s left) kms_addfb_basic (no-handle)
[81.581247] Starting subtest: no-handle
[81.582355] Subtest no-handle: SUCCESS (0.000s)
[81.684368] [082/171] (920s left) kms_addfb_basic (size-max)
[81.843473] Starting subtest: size-max
[81.844673] Subtest size-max: SUCCESS (0.000s)
[81.916225] [083/171] (920s left) kms_addfb_basic (small-bo)
[82.056376] Starting subtest: small-bo
[82.057784] Subtest small-bo: SUCCESS (0.000s)
[82.135620] [084/171] (920s left) kms_addfb_basic (tile-pitch-mismatch)
[82.261524] Starting subtest: tile-pitch-mismatch
[82.262660] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[82.369882] [085/171] (920s left) kms_addfb_basic (too-high)
[82.527274] Starting subtest: too-high
[82.529261] Subtest too-high: SUCCESS (0.001s)
[82.601496] [086/171] (919s left) kms_addfb_basic (too-wide)
[82.761314] Starting subtest: too-wide
[82.762438] Subtest too-wide: SUCCESS (0.000s)
[82.835861] [087/171] (919s left) kms_addfb_basic (unused-handle)
[82.964223] Starting subtest: unused-handle
[82.965205] Subtest unused-handle: SUCCESS (0.000s)
[83.072636] [088/171] (919s left) kms_addfb_basic (unused-modifier)
[83.200237] Starting subtest: unused-modifier
[83.201381] Subtest unused-modifier: SUCCESS (0.000s)
[83.306809] [089/171] (919s left) kms_addfb_basic (unused-offsets)
[83.430672] Starting subtest: unused-offsets
[83.431844] Subtest unused-offsets: SUCCESS (0.000s)
[83.543773] [090/171] (919s left) kms_addfb_basic (unused-pitches)
[83.667927] Starting subtest: unused-pitches
[83.668978] Subtest unused-pitches: SUCCESS (0.000s)
[83.774918] [091/171] (918s left) kms_busy (basic)
[83.931774] Starting subtest: basic
[83.933529] Starting dynamic subtest: flip
[84.621038] Dynamic subtest flip: SUCCESS (0.687s)
[84.657128] Starting dynamic subtest: modeset
[84.664081] Dynamic subtest modeset: SKIP (0.000s)
[84.666733] Subtest basic: SUCCESS (0.689s)
[84.729240] [092/171] (917s left) kms_chamelium_hpd (dp-hpd-fast)
[84.882407] Subtest dp-hpd-fast: SKIP (0.000s)
[84.928189] [093/171] (917s left) kms_chamelium_edid (dp-edid-read)
[85.085291] Subtest dp-edid-read: SKIP (0.000s)
[85.128163] [094/171] (917s left) kms_chamelium_frames (dp-crc-fast)
[85.285559] Subtest dp-crc-fast: SKIP (0.000s)
[85.329380] [095/171] (917s left) kms_chamelium_hpd (hdmi-hpd-fast)
[85.485767] Subtest hdmi-hpd-fast: SKIP (0.000s)
[85.529566] [096/171] (917s left) kms_chamelium_edid (hdmi-edid-read)
[85.690859] Subtest hdmi-edid-read: SKIP (0.000s)
[85.729960] [097/171] (917s left) kms_chamelium_frames (hdmi-crc-fast)
[85.886690] Subtest hdmi-crc-fast: SKIP (0.000s)
[85.932627] [098/171] (916s left) kms_chamelium_hpd (vga-hpd-fast)
[86.089341] Subtest vga-hpd-fast: SKIP (0.000s)
[86.131351] [099/171] (916s left) kms_chamelium_edid (vga-edid-read)
[86.288870] Subtest vga-edid-read: SKIP (0.000s)
[86.332318] [100/171] (916s left) kms_prop_blob (basic)
[86.455659] Starting subtest: basic
[86.456816] Subtest basic: SUCCESS (0.000s)
[86.515969] [101/171] (916s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[86.674537] Starting subtest: basic-busy-flip-before-cursor-atomic
[86.680326] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.005s)
[86.753938] [102/171] (916s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[86.906803] Starting subtest: basic-busy-flip-before-cursor-legacy
[87.906928] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.000s)
[88.020659] [103/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[88.179356] Starting subtest: basic-flip-after-cursor-atomic
[88.181754] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[88.253095] [104/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[88.413178] Starting subtest: basic-flip-after-cursor-legacy
[89.414254] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.999s)
[89.525832] [105/171] (913s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[89.681449] Starting subtest: basic-flip-after-cursor-varying-size
[90.687410] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.006s)
[90.803212] [106/171] (912s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[90.960512] Starting subtest: basic-flip-before-cursor-atomic
[90.963119] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[91.035524] [107/171] (911s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[91.176251] Starting subtest: basic-flip-before-cursor-legacy
[92.176508] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.001s)
[92.300699] [108/171] (910s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[92.457521] Starting subtest: basic-flip-before-cursor-varying-size
[93.461529] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.004s)
[93.575597] [109/171] (909s left) kms_flip (basic-flip-vs-dpms)
[93.733706] Starting subtest: basic-flip-vs-dpms
[93.735073] Starting dynamic subtest: A-VGA1
[95.007941] Dynamic subtest A-VGA1: SUCCESS (1.273s)
[95.035870] Starting dynamic subtest: B-VGA1
[96.248559] Dynamic subtest B-VGA1: SUCCESS (1.239s)
[96.249584] Subtest basic-flip-vs-dpms: SUCCESS (2.514s)
[96.405270] [110/171] (906s left) kms_flip (basic-flip-vs-modeset)
[96.561844] Starting subtest: basic-flip-vs-modeset
[96.563129] Starting dynamic subtest: A-VGA1
[97.858944] Dynamic subtest A-VGA1: SUCCESS (1.287s)
[97.887095] Starting dynamic subtest: B-VGA1
[99.104672] Dynamic subtest B-VGA1: SUCCESS (1.237s)
[99.105966] Subtest basic-flip-vs-modeset: SUCCESS (2.545s)
[99.243151] [111/171] (903s left) kms_flip (basic-flip-vs-wf_vblank)
[99.399167] Starting subtest: basic-flip-vs-wf_vblank
[99.400365] Starting dynamic subtest: A-VGA1
[100.963039] Dynamic subtest A-VGA1: SUCCESS (1.553s)
[100.985924] Starting dynamic subtest: B-VGA1
[102.493767] Dynamic subtest B-VGA1: SUCCESS (1.518s)
[102.499791] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.085s)
[102.671654] [112/171] (900s left) kms_flip (basic-plain-flip)
[102.827685] Starting subtest: basic-plain-flip
[102.828928] Starting dynamic subtest: A-VGA1
[104.088743] Dynamic subtest A-VGA1: SUCCESS (1.250s)
[104.110898] Starting dynamic subtest: B-VGA1
[105.297929] Dynamic subtest B-VGA1: SUCCESS (1.202s)
[105.298977] Subtest basic-plain-flip: SUCCESS (2.470s)
[105.473157] [113/171] (897s left) kms_force_connector_basic (force-connector-state)
[105.661524] Starting subtest: force-connector-state
[105.865116] Subtest force-connector-state: SUCCESS (0.202s)
[106.111649] [114/171] (897s left) kms_force_connector_basic (force-edid)
[106.286397] Starting subtest: force-edid
[106.368707] Subtest force-edid: SUCCESS (0.081s)
[106.529707] [115/171] (896s left) kms_force_connector_basic (force-load-detect)
[106.702809] Starting subtest: force-load-detect
[106.897211] Subtest force-load-detect: SUCCESS (0.192s)
[107.118634] [116/171] (896s left) kms_force_connector_basic (prune-stale-modes)
[107.305793] Starting subtest: prune-stale-modes
[107.408369] Subtest prune-stale-modes: SUCCESS (0.102s)
[107.586082] [117/171] (895s left) kms_frontbuffer_tracking (basic)
[107.745452] Subtest basic: SKIP (0.000s)
[107.788915] [118/171] (895s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[107.944767] Starting subtest: compare-crc-sanitycheck-xr24
[107.945869] Starting dynamic subtest: pipe-A-VGA-1
[108.254035] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.299s)
[108.279320] Starting dynamic subtest: pipe-B-VGA-1
[108.611378] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.341s)
[108.612355] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.666s)
[108.733212] [119/171] (894s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[108.891651] Starting subtest: compare-crc-sanitycheck-nv12
[108.892856] Starting dynamic subtest: pipe-A-VGA-1
[108.895081] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s)
[108.904974] Starting dynamic subtest: pipe-B-VGA-1
[108.908038] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s)
[108.910109] Subtest compare-crc-sanitycheck-nv12: SKIP (0.004s)
[108.967178] [120/171] (894s left) kms_pipe_crc_basic (hang-read-crc)
[109.125610] Starting subtest: hang-read-crc
[109.126814] Starting dynamic subtest: pipe-A-VGA-1
[110.062039] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.932s)
[110.074860] Starting dynamic subtest: pipe-B-VGA-1
[111.043449] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.983s)
[111.044837] Subtest hang-read-crc: SUCCESS (1.918s)
[111.164989] [121/171] (892s left) kms_pipe_crc_basic (nonblocking-crc)
[111.321898] Starting subtest: nonblocking-crc
[111.324224] Starting dynamic subtest: pipe-A-VGA-1
[111.807514] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.483s)
[111.819864] Starting dynamic subtest: pipe-B-VGA-1
[112.353730] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.544s)
[112.354898] Subtest nonblocking-crc: SUCCESS (1.032s)
[112.475436] [122/171] (890s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[112.632877] Starting subtest: nonblocking-crc-frame-sequence
[112.635169] Starting dynamic subtest: pipe-A-VGA-1
[113.101857] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.466s)
[113.114886] Starting dynamic subtest: pipe-B-VGA-1
[113.621913] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.518s)
[113.623105] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.989s)
[113.741638] [123/171] (889s left) kms_pipe_crc_basic (read-crc)
[113.899912] Starting subtest: read-crc
[113.902197] Starting dynamic subtest: pipe-A-VGA-1
[114.336501] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.434s)
[114.348880] Starting dynamic subtest: pipe-B-VGA-1
[114.818863] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.480s)
[114.820054] Subtest read-crc: SUCCESS (0.919s)
[114.939510] [124/171] (888s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[115.098868] Starting subtest: read-crc-frame-sequence
[115.101234] Starting dynamic subtest: pipe-A-VGA-1
[115.534513] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.433s)
[115.548879] Starting dynamic subtest: pipe-B-VGA-1
[116.012707] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.475s)
[116.013861] Subtest read-crc-frame-sequence: SUCCESS (0.914s)
[116.132209] [125/171] (887s left) kms_psr (primary_page_flip)
[116.260600] Subtest primary_page_flip: SKIP (0.000s)
[116.302062] [126/171] (887s left) kms_psr (cursor_plane_move)
[116.428561] Subtest cursor_plane_move: SKIP (0.000s)
[116.469412] [127/171] (886s left) kms_psr (sprite_plane_onoff)
[116.593321] Subtest sprite_plane_onoff: SKIP (0.000s)
[116.636654] [128/171] (886s left) kms_psr (primary_mmap_gtt)
[116.772383] Subtest primary_mmap_gtt: SKIP (0.000s)
[116.824265] [129/171] (886s left) kms_setmode (basic-clone-single-crtc)
[116.956278] Starting subtest: basic-clone-single-crtc
[116.959868] Subtest basic-clone-single-crtc: SKIP (0.000s)
[117.034954] [130/171] (886s left) i915_pm_backlight (basic-brightness)
[117.193786] Subtest basic-brightness: SKIP (0.000s)
[117.238499] [131/171] (886s left) i915_pm_rpm (basic-pci-d3-state)
[128.559339] Subtest basic-pci-d3-state: SKIP (0.000s)
[128.577209] [132/171] (875s left) i915_pm_rpm (basic-rte)
[128.698403] Starting subtest: basic-rte
[139.910026] Subtest basic-rte: SKIP (11.195s)
[139.933383] [133/171] (863s left) i915_pm_rps (basic-api)
[140.064055] Subtest basic-api: SKIP (0.000s)
[140.102547] [134/171] (863s left) prime_self_import (basic-llseek-bad)
[140.223311] Starting subtest: basic-llseek-bad
[140.225655] Subtest basic-llseek-bad: SUCCESS (0.003s)
[140.301904] [135/171] (863s left) prime_self_import (basic-llseek-size)
[140.423816] Starting subtest: basic-llseek-size
[140.426203] Subtest basic-llseek-size: SUCCESS (0.003s)
[140.501207] [136/171] (863s left) prime_self_import (basic-with_fd_dup)
[140.622240] Starting subtest: basic-with_fd_dup
[140.624662] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[140.701417] [137/171] (862s left) prime_self_import (basic-with_one_bo)
[140.825055] Starting subtest: basic-with_one_bo
[140.828270] Subtest basic-with_one_bo: SUCCESS (0.004s)
[140.905006] [138/171] (862s left) prime_self_import (basic-with_one_bo_two_files)
[141.027049] Starting subtest: basic-with_one_bo_two_files
[141.029345] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[141.101434] [139/171] (862s left) prime_self_import (basic-with_two_bos)
[141.223275] Starting subtest: basic-with_two_bos
[141.225657] Subtest basic-with_two_bos: SUCCESS (0.003s)
[141.303787] [140/171] (862s left) prime_vgem (basic-fence-flip)
[141.453403] Starting subtest: basic-fence-flip
[141.849769] Subtest basic-fence-flip: SUCCESS (0.398s)
[141.939084] [141/171] (861s left) prime_vgem (basic-fence-mmap)
[142.069754] Starting subtest: basic-fence-mmap
[142.108209] Subtest basic-fence-mmap: SUCCESS (0.039s)
[142.189474] [142/171] (861s left) prime_vgem (basic-fence-read)
[142.320073] Starting subtest: basic-fence-read
[142.380260] Subtest basic-fence-read: SUCCESS (0.064s)
[142.458501] [143/171] (861s left) prime_vgem (basic-gtt)
[142.588380] Starting subtest: basic-gtt
[142.602751] Subtest basic-gtt: SUCCESS (0.017s)
[142.675577] [144/171] (861s left) prime_vgem (basic-read)
[142.806660] Starting subtest: basic-read
[142.831193] Subtest basic-read: SUCCESS (0.028s)
[142.909305] [145/171] (860s left) prime_vgem (basic-write)
[143.040127] Starting subtest: basic-write
[143.065919] Subtest basic-write: SUCCESS (0.031s)
[143.143776] [146/171] (860s left) vgem_basic (setversion)
[143.268701] Starting subtest: setversion
[143.270956] Subtest setversion: SUCCESS (0.000s)
[143.326992] [147/171] (860s left) vgem_basic (create)
[143.452345] Starting subtest: create
[143.453502] Subtest create: SUCCESS (0.001s)
[143.511133] [148/171] (860s left) vgem_basic (debugfs)
[143.636428] Starting subtest: debugfs
[143.637604] Subtest debugfs: SUCCESS (0.001s)
[143.695422] [149/171] (860s left) vgem_basic (dmabuf-export)
[143.822134] Starting subtest: dmabuf-export
[143.824558] Subtest dmabuf-export: SUCCESS (0.002s)
[143.896107] [150/171] (860s left) vgem_basic (dmabuf-fence)
[144.021354] Starting subtest: dmabuf-fence
[144.022613] Subtest dmabuf-fence: SUCCESS (0.001s)
[144.080135] [151/171] (859s left) vgem_basic (dmabuf-fence-before)
[144.203153] Starting subtest: dmabuf-fence-before
[144.204893] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[144.263616] [152/171] (859s left) vgem_basic (dmabuf-mmap)
[144.388287] Starting subtest: dmabuf-mmap
[144.407968] Subtest dmabuf-mmap: SUCCESS (0.022s)
[144.464785] [153/171] (859s left) vgem_basic (mmap)
[144.605263] Starting subtest: mmap
[144.620232] Subtest mmap: SUCCESS (0.015s)
[144.682268] [154/171] (859s left) vgem_basic (second-client)
[144.805723] Starting subtest: second-client
[144.839940] Subtest second-client: SUCCESS (0.033s)
[144.899854] [155/171] (859s left) vgem_basic (sysfs)
[145.022908] Starting subtest: sysfs
[145.024791] Subtest sysfs: SUCCESS (0.001s)
[145.083304] [156/171] (859s left) core_hotunplug (unbind-rebind)
[145.257046] Starting subtest: unbind-rebind
[146.064249] Subtest unbind-rebind: SUCCESS (0.808s)
[146.093443] [157/171] (858s left) vgem_basic (unload)
[146.278898] Starting subtest: unload
[175.224498] Subtest unload: SUCCESS (28.943s)
[175.325068] [158/171] (828s left) i915_module_load (reload)
[175.447052] Starting subtest: reload
[177.466878] Subtest reload: SUCCESS (2.014s)
[177.495545] [159/171] (826s left) gem_lmem_swapping (basic)
[177.661946] Subtest basic: SKIP (0.000s)
[177.705558] [160/171] (826s left) gem_lmem_swapping (parallel-random-engines)
[177.889147] Subtest parallel-random-engines: SKIP (0.000s)
[177.947387] [161/171] (826s left) gem_lmem_swapping (random-engines)
[178.101615] Subtest random-engines: SKIP (0.000s)
[178.141546] [162/171] (826s left) gem_lmem_swapping (verify-random)
[178.269534] Subtest verify-random: SKIP (0.000s)
[178.308752] [163/171] (825s left) i915_pm_rpm (module-reload)
[189.641824] Subtest module-reload: SKIP (0.000s)
[189.663899] [164/171] (814s left) i915_selftest (live)
[190.542859] Starting subtest: live
[190.544054] Starting dynamic subtest: sanitycheck
[191.266869] Dynamic subtest sanitycheck: SUCCESS (0.723s)
[191.278063] Starting dynamic subtest: uncore
[191.895082] Dynamic subtest uncore: SUCCESS (0.627s)
[191.908964] Starting dynamic subtest: workarounds
[192.537444] Dynamic subtest workarounds: SUCCESS (0.641s)
[192.549357] Starting dynamic subtest: gt_engines
[193.238768] Dynamic subtest gt_engines: SUCCESS (0.700s)
[193.249602] Starting dynamic subtest: gt_timelines
[196.132486] Dynamic subtest gt_timelines: SUCCESS (2.890s)
[196.141501] Starting dynamic subtest: gt_contexts
[196.777465] Dynamic subtest gt_contexts: SUCCESS (0.647s)
[196.789369] Starting dynamic subtest: gt_lrc
[197.444934] Dynamic subtest gt_lrc: SUCCESS (0.666s)
[197.455945] Starting dynamic subtest: gt_mocs
[198.094590] Dynamic subtest gt_mocs: SUCCESS (0.649s)
[198.105148] Starting dynamic subtest: gt_pm
[199.215933] Dynamic subtest gt_pm: SUCCESS (1.119s)
[199.226565] Starting dynamic subtest: gt_heartbeat
[199.888454] Dynamic subtest gt_heartbeat: SUCCESS (0.672s)
[199.897955] Starting dynamic subtest: gt_tlb
[200.578051] Dynamic subtest gt_tlb: SUCCESS (0.689s)
[200.588291] Starting dynamic subtest: requests
[203.778067] Dynamic subtest requests: SUCCESS (3.199s)
[203.789107] Starting dynamic subtest: migrate
[204.415650] Dynamic subtest migrate: SUCCESS (0.637s)
[204.426765] Starting dynamic subtest: active
[205.103033] Dynamic subtest active: SUCCESS (0.686s)
[205.113398] Starting dynamic subtest: objects
[206.115988] Dynamic subtest objects: SUCCESS (1.011s)
[206.126689] Starting dynamic subtest: mman
[211.094058] Dynamic subtest mman: SUCCESS (4.977s)
[211.104735] Starting dynamic subtest: dmabuf
[211.776666] Dynamic subtest dmabuf: SUCCESS (0.682s)
[211.787176] Starting dynamic subtest: vma
[212.467932] Dynamic subtest vma: SUCCESS (0.688s)
[212.477663] Starting dynamic subtest: coherency
[214.228986] Dynamic subtest coherency: SUCCESS (1.760s)
[214.238438] Starting dynamic subtest: gtt
[218.396149] Dynamic subtest gtt: SUCCESS (4.166s)
[218.405355] Starting dynamic subtest: gem
[219.132153] Dynamic subtest gem: SUCCESS (0.737s)
[219.143383] Starting dynamic subtest: evict
[219.780156] Dynamic subtest evict: SUCCESS (0.647s)
[219.789873] Starting dynamic subtest: hugepages
[220.436734] Dynamic subtest hugepages: SUCCESS (0.655s)
[220.448567] Starting dynamic subtest: gem_contexts
[221.091396] Dynamic subtest gem_contexts: SUCCESS (0.654s)
[221.098607] Starting dynamic subtest: client
[221.777922] Dynamic subtest client: SUCCESS (0.685s)
[221.789616] Starting dynamic subtest: gem_migrate
[222.439620] Dynamic subtest gem_migrate: SUCCESS (0.661s)
[222.450461] Starting dynamic subtest: reset
[223.472959] Dynamic subtest reset: SUCCESS (1.031s)
[223.482726] Starting dynamic subtest: memory_region
[224.113111] Dynamic subtest memory_region: SUCCESS (0.640s)
[224.123553] Starting dynamic subtest: hangcheck
[225.824153] Dynamic subtest hangcheck: SUCCESS (1.710s)
[225.833879] Starting dynamic subtest: execlists
[226.460980] Dynamic subtest execlists: SUCCESS (0.636s)
[226.471265] Starting dynamic subtest: ring_submission
[227.130684] Dynamic subtest ring_submission: SUCCESS (0.669s)
[227.142126] Starting dynamic subtest: perf
[227.900398] Dynamic subtest perf: SUCCESS (0.768s)
[227.913072] Starting dynamic subtest: slpc
[228.705040] Dynamic subtest slpc: SUCCESS (0.801s)
[228.720996] Starting dynamic subtest: guc
[229.552115] Dynamic subtest guc: SUCCESS (0.845s)
[229.564112] Starting dynamic subtest: guc_multi_lrc
[230.203434] Dynamic subtest guc_multi_lrc: SUCCESS (0.651s)
[230.214677] Starting dynamic subtest: guc_hang
[230.861871] Dynamic subtest guc_hang: SUCCESS (0.657s)
[230.873697] Starting dynamic subtest: late_gt_pm
[231.532454] Dynamic subtest late_gt_pm: SUCCESS (0.670s)
[231.533611] Subtest live: SUCCESS (40.991s)
[231.681221] [165/171] (772s left) dmabuf (all-tests)
[231.808036] Starting subtest: all-tests
[231.813184] Starting dynamic subtest: sanitycheck
[231.871622] Dynamic subtest sanitycheck: SUCCESS (0.062s)
[231.881226] Starting dynamic subtest: dma_fence
[232.047487] Dynamic subtest dma_fence: SUCCESS (0.177s)
[232.061852] Starting dynamic subtest: dma_fence_chain
[249.509036] Dynamic subtest dma_fence_chain: SUCCESS (17.459s)
[249.522231] Starting dynamic subtest: dma_fence_unwrap
[249.578091] Dynamic subtest dma_fence_unwrap: SUCCESS (0.068s)
[249.590081] Starting dynamic subtest: dma_resv
[249.637957] Dynamic subtest dma_resv: SUCCESS (0.057s)
[249.639038] Subtest all-tests: SUCCESS (17.830s)
[249.655361] [166/171] (754s left) i915_suspend (basic-s2idle-without-i915)
[249.773083] Starting subtest: basic-s2idle-without-i915
[268.542365] Subtest basic-s2idle-without-i915: SUCCESS (18.770s)
[271.137985] [167/171] (735s left) i915_suspend (basic-s3-without-i915)
[271.265770] Starting subtest: basic-s3-without-i915
[288.229014] Subtest basic-s3-without-i915: SUCCESS (2.314s)
[291.290113] [168/171] (733s left) gem_exec_suspend (basic-s0)
[291.432474] Starting subtest: basic-S0
[291.435144] Starting dynamic subtest: smem
[309.099817] Dynamic subtest smem: SUCCESS (17.666s)
[309.100996] Subtest basic-S0: SUCCESS (17.668s)
[311.817519] [169/171] (715s left) gem_exec_suspend (basic-s3)
[311.960140] Starting subtest: basic-S3
[311.961289] Starting dynamic subtest: smem
[330.193354] Dynamic subtest smem: SUCCESS (2.229s)
[330.194957] Subtest basic-S3: SUCCESS (2.230s)
[333.383311] [170/171] (712s left) kms_chamelium_hpd (common-hpd-after-suspend)
[333.560180] Subtest common-hpd-after-suspend: SKIP (0.000s)
[333.604609] [171/171] (712s left) kms_pipe_crc_basic (suspend-read-crc)
[333.761163] Starting subtest: suspend-read-crc
[333.764180] Starting dynamic subtest: pipe-A-VGA-1
[351.994490] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.778s)
[352.016084] Starting dynamic subtest: pipe-B-VGA-1
[369.974415] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.866s)
[369.975379] Subtest suspend-read-crc: SUCCESS (3.650s)
[384.120830] Closing watchdogs
Done.