[38.555032] Initializing watchdogs
[38.555098]   /dev/watchdog0
[38.560283] [001/171] (960s left) i915_module_load (load)
[38.612469] Starting subtest: load
[39.668654] Subtest load: SUCCESS (1.056s)
[39.692618] [002/171] (959s left) core_auth (basic-auth)
[39.834108] Starting subtest: basic-auth
[39.835012] Subtest basic-auth: SUCCESS (0.001s)
[39.930644] [003/171] (959s left) debugfs_test (read_all_entries)
[40.028847] Starting subtest: read_all_entries
[40.386009] Subtest read_all_entries: SUCCESS (0.356s)
[40.484841] [004/171] (958s left) debugfs_test (basic-hwmon)
[40.546456] Starting subtest: basic-hwmon
[40.549120] Subtest basic-hwmon: SUCCESS (0.002s)
[40.634287] [005/171] (958s left) fbdev (eof)
[40.702180] Starting subtest: eof
[40.703138] Subtest eof: SUCCESS (0.000s)
[40.752982] [006/171] (958s left) fbdev (info)
[40.806489] Starting subtest: info
[40.807686] Subtest info: SUCCESS (0.000s)
[40.868177] [007/171] (958s left) fbdev (nullptr)
[40.935147] Starting subtest: nullptr
[40.936239] Subtest nullptr: SUCCESS (0.000s)
[41.027364] [008/171] (958s left) fbdev (read)
[41.118379] Starting subtest: read
[51.695945] Subtest read: SUCCESS (10.543s)
[51.739224] [009/171] (947s left) fbdev (write)
[51.802377] Starting subtest: write
[57.118045] Subtest write: SUCCESS (5.306s)
[57.152169] [010/171] (942s left) gem_basic (bad-close)
[57.209053] Starting subtest: bad-close
[57.211445] Subtest bad-close: SUCCESS (0.000s)
[57.277297] [011/171] (941s left) gem_basic (create-close)
[57.337534] Starting subtest: create-close
[57.339069] Subtest create-close: SUCCESS (0.000s)
[57.436995] [012/171] (941s left) gem_basic (create-fd-close)
[57.492653] Starting subtest: create-fd-close
[57.494547] Subtest create-fd-close: SUCCESS (0.000s)
[57.615110] [013/171] (941s left) gem_busy (busy@all-engines)
[57.720789] Starting subtest: busy
[57.721669] Starting dynamic subtest: all-engines
[57.824948] Dynamic subtest all-engines: SUCCESS (0.104s)
[57.826053] Subtest busy: SUCCESS (0.104s)
[58.230588] [014/171] (941s left) gem_close_race (basic-process)
[58.342914] Starting subtest: basic-process
[58.388700] Subtest basic-process: SUCCESS (0.045s)
[58.616609] [015/171] (940s left) gem_close_race (basic-threads)
[58.723449] Starting subtest: basic-threads
[59.919721] Subtest basic-threads: SUCCESS (1.196s)
[60.162583] [016/171] (939s left) gem_ctx_create (basic)
[60.272124] Starting subtest: basic
[60.272934] Subtest basic: SUCCESS (0.000s)
[60.454191] [017/171] (938s left) gem_ctx_create (basic-files)
[60.549969] Starting subtest: basic-files
[62.561707] Subtest basic-files: SUCCESS (2.012s)
[63.370332] [018/171] (936s left) gem_ctx_exec (basic)
[63.443319] Starting subtest: basic
[63.446926] Subtest basic: SUCCESS (0.004s)
[63.509768] [019/171] (935s left) gem_exec_basic (basic)
[63.579570] Starting subtest: basic
[63.580485] Starting dynamic subtest: rcs0-smem
[63.582236] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[63.587164] Starting dynamic subtest: bcs0-smem
[63.587939] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[63.592850] Starting dynamic subtest: vcs0-smem
[63.593590] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[63.606655] Starting dynamic subtest: vcs1-smem
[63.610562] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[63.615154] Starting dynamic subtest: vecs0-smem
[63.615953] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[63.620615] Starting dynamic subtest: vecs1-smem
[63.621787] Dynamic subtest vecs1-smem: SUCCESS (0.000s)
[63.626450] Starting dynamic subtest: ccs0-smem
[63.627352] Dynamic subtest ccs0-smem: SUCCESS (0.000s)
[63.631945] Starting dynamic subtest: ccs1-smem
[63.633043] Dynamic subtest ccs1-smem: SUCCESS (0.000s)
[63.637758] Starting dynamic subtest: ccs2-smem
[63.638942] Dynamic subtest ccs2-smem: SUCCESS (0.000s)
[63.643531] Starting dynamic subtest: ccs3-smem
[63.644552] Dynamic subtest ccs3-smem: SUCCESS (0.000s)
[63.649194] Starting dynamic subtest: rcs0-lmem0
[63.650192] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[63.654879] Starting dynamic subtest: bcs0-lmem0
[63.656071] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[63.660663] Starting dynamic subtest: vcs0-lmem0
[63.661871] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[63.666627] Starting dynamic subtest: vcs1-lmem0
[63.667795] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[63.672518] Starting dynamic subtest: vecs0-lmem0
[63.673588] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[63.678175] Starting dynamic subtest: vecs1-lmem0
[63.679226] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[63.683916] Starting dynamic subtest: ccs0-lmem0
[63.685099] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[63.689653] Starting dynamic subtest: ccs1-lmem0
[63.690639] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[63.695177] Starting dynamic subtest: ccs2-lmem0
[63.695988] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[63.700472] Starting dynamic subtest: ccs3-lmem0
[63.701248] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[63.702065] Subtest basic: SUCCESS (0.011s)
[63.809689] [020/171] (935s left) gem_exec_create (basic)
[63.912442] Starting subtest: basic
[63.913430] Starting dynamic subtest: smem
[66.011316] Dynamic subtest smem: SUCCESS (2.099s)
[66.016761] Starting dynamic subtest: lmem0
[68.110686] Dynamic subtest lmem0: SUCCESS (2.099s)
[68.111874] Subtest basic: SUCCESS (4.198s)
[68.311896] [021/171] (931s left) gem_exec_fence (basic-busy)
[68.503738] Starting subtest: basic-busy
[68.505172] Starting dynamic subtest: rcs0
[68.626972] Dynamic subtest rcs0: SUCCESS (0.131s)
[68.636222] Starting dynamic subtest: bcs0
[68.677783] Dynamic subtest bcs0: SUCCESS (0.051s)
[68.687041] Starting dynamic subtest: vcs0
[68.738062] Dynamic subtest vcs0: SUCCESS (0.059s)
[68.757333] Starting dynamic subtest: vcs1
[68.796041] Dynamic subtest vcs1: SUCCESS (0.058s)
[68.815394] Starting dynamic subtest: vecs0
[68.854285] Dynamic subtest vecs0: SUCCESS (0.058s)
[68.863221] Starting dynamic subtest: vecs1
[68.907909] Dynamic subtest vecs1: SUCCESS (0.054s)
[68.918211] Starting dynamic subtest: ccs0
[68.964993] Dynamic subtest ccs0: SUCCESS (0.056s)
[68.985277] Starting dynamic subtest: ccs1
[69.022077] Dynamic subtest ccs1: SUCCESS (0.057s)
[69.042326] Starting dynamic subtest: ccs2
[69.082066] Dynamic subtest ccs2: SUCCESS (0.060s)
[69.102316] Starting dynamic subtest: ccs3
[69.143074] Dynamic subtest ccs3: SUCCESS (0.061s)
[69.144803] Subtest basic-busy: SUCCESS (0.648s)
[69.726961] [022/171] (929s left) gem_exec_fence (basic-wait)
[69.913172] Starting subtest: basic-wait
[69.914019] Starting dynamic subtest: rcs0
[70.008577] Dynamic subtest rcs0: SUCCESS (0.096s)
[70.016869] Starting dynamic subtest: bcs0
[70.055885] Dynamic subtest bcs0: SUCCESS (0.047s)
[70.065176] Starting dynamic subtest: vcs0
[70.115107] Dynamic subtest vcs0: SUCCESS (0.058s)
[70.135596] Starting dynamic subtest: vcs1
[70.174859] Dynamic subtest vcs1: SUCCESS (0.059s)
[70.195976] Starting dynamic subtest: vecs0
[70.232999] Dynamic subtest vecs0: SUCCESS (0.058s)
[70.253381] Starting dynamic subtest: vecs1
[70.292138] Dynamic subtest vecs1: SUCCESS (0.059s)
[70.312777] Starting dynamic subtest: ccs0
[70.351220] Dynamic subtest ccs0: SUCCESS (0.059s)
[70.371584] Starting dynamic subtest: ccs1
[70.411157] Dynamic subtest ccs1: SUCCESS (0.060s)
[70.431622] Starting dynamic subtest: ccs2
[70.471090] Dynamic subtest ccs2: SUCCESS (0.060s)
[70.491524] Starting dynamic subtest: ccs3
[70.532212] Dynamic subtest ccs3: SUCCESS (0.061s)
[70.534367] Subtest basic-wait: SUCCESS (0.620s)
[71.084433] [023/171] (928s left) gem_exec_fence (basic-await)
[71.277733] Starting subtest: basic-await
[71.285614] Starting dynamic subtest: rcs0
[71.383222] Dynamic subtest rcs0: SUCCESS (0.114s)
[71.388217] Starting dynamic subtest: bcs0
[71.474651] Dynamic subtest bcs0: SUCCESS (0.091s)
[71.480374] Starting dynamic subtest: vcs0
[71.568856] Dynamic subtest vcs0: SUCCESS (0.094s)
[71.574219] Starting dynamic subtest: vcs1
[71.659811] Dynamic subtest vcs1: SUCCESS (0.091s)
[71.665216] Starting dynamic subtest: vecs0
[71.751623] Dynamic subtest vecs0: SUCCESS (0.092s)
[71.757169] Starting dynamic subtest: vecs1
[71.842656] Dynamic subtest vecs1: SUCCESS (0.091s)
[71.847564] Starting dynamic subtest: ccs0
[71.932491] Dynamic subtest ccs0: SUCCESS (0.090s)
[71.938013] Starting dynamic subtest: ccs1
[72.025826] Dynamic subtest ccs1: SUCCESS (0.093s)
[72.031595] Starting dynamic subtest: ccs2
[72.118561] Dynamic subtest ccs2: SUCCESS (0.093s)
[72.123773] Starting dynamic subtest: ccs3
[72.209755] Dynamic subtest ccs3: SUCCESS (0.091s)
[72.210539] Subtest basic-await: SUCCESS (0.941s)
[72.820687] [024/171] (926s left) gem_exec_fence (nb-await)
[73.081581] Starting subtest: nb-await
[73.082532] Starting dynamic subtest: rcs0
[73.156949] Dynamic subtest rcs0: SUCCESS (0.086s)
[73.163472] Starting dynamic subtest: bcs0
[73.221305] Dynamic subtest bcs0: SUCCESS (0.064s)
[73.231240] Starting dynamic subtest: vcs0
[73.293254] Dynamic subtest vcs0: SUCCESS (0.071s)
[73.316121] Starting dynamic subtest: vcs1
[73.378736] Dynamic subtest vcs1: SUCCESS (0.086s)
[73.385387] Starting dynamic subtest: vecs0
[73.442148] Dynamic subtest vecs0: SUCCESS (0.063s)
[73.452235] Starting dynamic subtest: vecs1
[73.516801] Dynamic subtest vecs1: SUCCESS (0.074s)
[73.539765] Starting dynamic subtest: ccs0
[73.607936] Dynamic subtest ccs0: SUCCESS (0.091s)
[73.623900] Starting dynamic subtest: ccs1
[73.693741] Dynamic subtest ccs1: SUCCESS (0.085s)
[73.701324] Starting dynamic subtest: ccs2
[73.757560] Dynamic subtest ccs2: SUCCESS (0.065s)
[73.765210] Starting dynamic subtest: ccs3
[73.827124] Dynamic subtest ccs3: SUCCESS (0.068s)
[73.828920] Subtest nb-await: SUCCESS (0.755s)
[74.469671] [025/171] (925s left) gem_exec_gttfill (basic)
[74.542016] Starting subtest: basic
[79.425859] Subtest basic: SUCCESS (4.875s)
[79.671848] [026/171] (919s left) gem_exec_parallel (engines)
[79.778339] Starting subtest: engines
[79.779144] Starting dynamic subtest: basic
[81.642307] Dynamic subtest basic: SUCCESS (1.864s)
[81.648607] Starting dynamic subtest: contexts
[84.492901] Dynamic subtest contexts: SUCCESS (2.842s)
[84.498442] Starting dynamic subtest: fds
[88.124661] Dynamic subtest fds: SUCCESS (3.631s)
[88.129968] Starting dynamic subtest: userptr
[89.606444] Dynamic subtest userptr: SUCCESS (1.491s)
[89.607649] Subtest engines: SUCCESS (9.828s)
[89.835766] [027/171] (909s left) gem_exec_store (basic)
[89.927551] Starting subtest: basic
[90.073402] Subtest basic: SUCCESS (0.146s)
[90.302149] [028/171] (909s left) gem_flink_basic (bad-flink)
[90.367979] Starting subtest: bad-flink
[90.368857] Subtest bad-flink: SUCCESS (0.000s)
[90.424620] [029/171] (909s left) gem_flink_basic (bad-open)
[90.493278] Starting subtest: bad-open
[90.494095] Subtest bad-open: SUCCESS (0.000s)
[90.557144] [030/171] (909s left) gem_flink_basic (basic)
[90.614399] Starting subtest: basic
[90.615222] Subtest basic: SUCCESS (0.000s)
[90.695994] [031/171] (908s left) gem_flink_basic (double-flink)
[90.771422] Starting subtest: double-flink
[90.772433] Subtest double-flink: SUCCESS (0.000s)
[90.844652] [032/171] (908s left) gem_flink_basic (flink-lifetime)
[90.906915] Starting subtest: flink-lifetime
[90.907827] Subtest flink-lifetime: SUCCESS (0.001s)
[91.023338] [033/171] (908s left) gem_huc_copy (huc-copy)
[91.126637] Starting subtest: huc-copy
[91.132931] Subtest huc-copy: SUCCESS (0.006s)
[91.269944] [034/171] (908s left) gem_linear_blits (basic)
[91.411057] Starting subtest: basic
[91.429722] Subtest basic: SUCCESS (0.019s)
[91.596913] [035/171] (908s left) gem_mmap (basic)
[91.725527] Subtest basic: SKIP (0.000s)
[91.745310] [036/171] (907s left) gem_mmap_gtt (basic)
[91.804495] Subtest basic: SKIP (0.000s)
[91.828308] [037/171] (907s left) gem_render_linear_blits (basic)
[91.891978] Starting subtest: basic
[91.938102] Subtest basic: SUCCESS (0.046s)
[91.995681] [038/171] (907s left) gem_render_tiled_blits (basic)
[92.060195] Subtest basic: SKIP (0.000s)
[92.078713] [039/171] (907s left) gem_ringfill (basic-all)
[92.506802] Starting subtest: basic-all
[94.020166] Subtest basic-all: SUCCESS (1.507s)
[94.164569] [040/171] (905s left) gem_softpin (allocator-basic)
[94.227703] Starting subtest: allocator-basic
[94.394561] Subtest allocator-basic: SUCCESS (0.158s)
[94.520327] [041/171] (905s left) gem_softpin (allocator-basic-reserve)
[94.614228] Starting subtest: allocator-basic-reserve
[94.780852] Subtest allocator-basic-reserve: SUCCESS (0.158s)
[94.874332] [042/171] (904s left) gem_softpin (safe-alignment)
[94.936545] Starting subtest: safe-alignment
[94.978951] Subtest safe-alignment: SUCCESS (0.042s)
[95.087213] [043/171] (904s left) gem_sync (basic-all)
[95.200031] Starting subtest: basic-all
[98.814085] Subtest basic-all: SUCCESS (3.615s)
[98.976404] [044/171] (900s left) gem_sync (basic-each)
[99.049565] Starting subtest: basic-each
[101.829610] Subtest basic-each: SUCCESS (2.780s)
[102.015634] [045/171] (897s left) gem_tiled_blits (basic)
[102.082329] Subtest basic: SKIP (0.000s)
[102.121215] [046/171] (897s left) gem_tiled_fence_blits (basic)
[102.183960] Subtest basic: SKIP (0.000s)
[102.213860] [047/171] (897s left) gem_tiled_pread_basic
[102.313046] [048/171] (897s left) gem_wait (busy@all-engines)
[102.382350] Starting subtest: busy
[102.383311] Starting dynamic subtest: all-engines
[102.949172] Dynamic subtest all-engines: SUCCESS (0.567s)
[102.950028] Subtest busy: SUCCESS (0.567s)
[103.165872] [049/171] (896s left) gem_wait (wait@all-engines)
[103.240221] Starting subtest: wait
[103.241073] Starting dynamic subtest: all-engines
[104.320202] Dynamic subtest all-engines: SUCCESS (1.080s)
[104.321114] Subtest wait: SUCCESS (1.080s)
[104.557757] [050/171] (895s left) i915_getparams_basic (basic-eu-total)
[104.639801] Starting subtest: basic-eu-total
[104.641849] Subtest basic-eu-total: SUCCESS (0.000s)
[104.710707] [051/171] (895s left) i915_getparams_basic (basic-subslice-total)
[104.780913] Starting subtest: basic-subslice-total
[104.782990] Subtest basic-subslice-total: SUCCESS (0.000s)
[104.842627] [052/171] (895s left) i915_hangman (error-state-basic)
[104.914755] Starting subtest: error-state-basic
[105.089308] Subtest error-state-basic: SUCCESS (0.175s)
[105.165428] [053/171] (894s left) i915_pciid
[105.296699] [054/171] (894s left) kms_addfb_basic (addfb25-bad-modifier)
[105.358756] Starting subtest: addfb25-bad-modifier
[105.359673] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[105.475315] [055/171] (894s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[105.546277] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[105.659621] [056/171] (894s left) kms_addfb_basic (addfb25-modifier-no-flag)
[105.724142] Starting subtest: addfb25-modifier-no-flag
[105.724949] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[105.824720] [057/171] (894s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[105.890480] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[105.991534] [058/171] (894s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[106.056553] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[106.157430] [059/171] (893s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[106.246560] Starting subtest: addfb25-yf-tiled-legacy
[106.247407] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[106.324505] [060/171] (893s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[106.424472] Starting subtest: addfb25-y-tiled-legacy
[106.425286] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[106.508097] [061/171] (893s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[106.600107] Starting subtest: addfb25-y-tiled-small-legacy
[106.601693] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[106.691465] [062/171] (893s left) kms_addfb_basic (bad-pitch-0)
[106.751162] Starting subtest: bad-pitch-0
[106.751961] Subtest bad-pitch-0: SUCCESS (0.000s)
[106.857883] [063/171] (893s left) kms_addfb_basic (bad-pitch-1024)
[106.923384] Starting subtest: bad-pitch-1024
[106.924311] Subtest bad-pitch-1024: SUCCESS (0.000s)
[107.024635] [064/171] (893s left) kms_addfb_basic (bad-pitch-128)
[107.086850] Starting subtest: bad-pitch-128
[107.087739] Subtest bad-pitch-128: SUCCESS (0.000s)
[107.209991] [065/171] (892s left) kms_addfb_basic (bad-pitch-256)
[107.278662] Starting subtest: bad-pitch-256
[107.279550] Subtest bad-pitch-256: SUCCESS (0.000s)
[107.391944] [066/171] (892s left) kms_addfb_basic (bad-pitch-32)
[107.460582] Starting subtest: bad-pitch-32
[107.461482] Subtest bad-pitch-32: SUCCESS (0.000s)
[107.575616] [067/171] (892s left) kms_addfb_basic (bad-pitch-63)
[107.652217] Starting subtest: bad-pitch-63
[107.653217] Subtest bad-pitch-63: SUCCESS (0.000s)
[107.757898] [068/171] (892s left) kms_addfb_basic (bad-pitch-65536)
[107.819514] Starting subtest: bad-pitch-65536
[107.820341] Subtest bad-pitch-65536: SUCCESS (0.000s)
[107.929131] [069/171] (892s left) kms_addfb_basic (bad-pitch-999)
[107.997896] Starting subtest: bad-pitch-999
[107.998805] Subtest bad-pitch-999: SUCCESS (0.000s)
[108.107935] [070/171] (892s left) kms_addfb_basic (basic)
[108.172558] Starting subtest: basic
[108.173384] Subtest basic: SUCCESS (0.000s)
[108.275162] [071/171] (891s left) kms_addfb_basic (basic-x-tiled-legacy)
[108.343259] Starting subtest: basic-x-tiled-legacy
[108.344971] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[108.460091] [072/171] (891s left) kms_addfb_basic (basic-y-tiled-legacy)
[108.525451] Starting subtest: basic-y-tiled-legacy
[108.527015] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[108.642455] [073/171] (891s left) kms_addfb_basic (bo-too-small)
[108.750182] Starting subtest: bo-too-small
[108.751032] Subtest bo-too-small: SUCCESS (0.000s)
[108.824701] [074/171] (891s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[108.910889] Starting subtest: bo-too-small-due-to-tiling
[108.912515] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[108.974785] [075/171] (891s left) kms_addfb_basic (clobberred-modifier)
[109.037387] Starting subtest: clobberred-modifier
[109.039104] Subtest clobberred-modifier: SKIP (0.000s)
[109.141885] [076/171] (891s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[109.204797] Starting subtest: framebuffer-vs-set-tiling
[109.206504] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[109.308380] [077/171] (890s left) kms_addfb_basic (invalid-get-prop)
[109.373281] Starting subtest: invalid-get-prop
[109.374120] Subtest invalid-get-prop: SUCCESS (0.000s)
[109.493467] [078/171] (890s left) kms_addfb_basic (invalid-get-prop-any)
[109.564953] Starting subtest: invalid-get-prop-any
[109.565925] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[109.695521] [079/171] (890s left) kms_addfb_basic (invalid-set-prop)
[109.771404] Starting subtest: invalid-set-prop
[109.772200] Subtest invalid-set-prop: SUCCESS (0.000s)
[109.875428] [080/171] (890s left) kms_addfb_basic (invalid-set-prop-any)
[109.934787] Starting subtest: invalid-set-prop-any
[109.935562] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[110.042161] [081/171] (890s left) kms_addfb_basic (no-handle)
[110.106958] Starting subtest: no-handle
[110.107827] Subtest no-handle: SUCCESS (0.000s)
[110.208616] [082/171] (890s left) kms_addfb_basic (size-max)
[110.306780] Starting subtest: size-max
[110.307599] Subtest size-max: SUCCESS (0.000s)
[110.392219] [083/171] (889s left) kms_addfb_basic (small-bo)
[110.487905] Starting subtest: small-bo
[110.488756] Subtest small-bo: SUCCESS (0.000s)
[110.558273] [084/171] (889s left) kms_addfb_basic (tile-pitch-mismatch)
[110.617126] Starting subtest: tile-pitch-mismatch
[110.618716] Subtest tile-pitch-mismatch: SKIP (0.000s)
[110.725494] [085/171] (889s left) kms_addfb_basic (too-high)
[110.823760] Starting subtest: too-high
[110.824582] Subtest too-high: SUCCESS (0.000s)
[110.908094] [086/171] (889s left) kms_addfb_basic (too-wide)
[110.997941] Starting subtest: too-wide
[110.998771] Subtest too-wide: SUCCESS (0.000s)
[111.074832] [087/171] (889s left) kms_addfb_basic (unused-handle)
[111.133547] Starting subtest: unused-handle
[111.134439] Subtest unused-handle: SUCCESS (0.000s)
[111.242495] [088/171] (889s left) kms_addfb_basic (unused-modifier)
[111.307916] Starting subtest: unused-modifier
[111.308817] Subtest unused-modifier: SUCCESS (0.000s)
[111.426272] [089/171] (888s left) kms_addfb_basic (unused-offsets)
[111.500849] Starting subtest: unused-offsets
[111.501661] Subtest unused-offsets: SUCCESS (0.000s)
[111.626539] [090/171] (888s left) kms_addfb_basic (unused-pitches)
[111.686400] Starting subtest: unused-pitches
[111.687237] Subtest unused-pitches: SUCCESS (0.000s)
[111.791561] [091/171] (888s left) kms_busy (basic)
[111.897226] Starting subtest: basic
[111.898048] Starting dynamic subtest: flip
[112.614429] Dynamic subtest flip: SUCCESS (0.717s)
[112.620435] Starting dynamic subtest: modeset
[113.345435] Dynamic subtest modeset: SUCCESS (0.731s)
[113.346245] Subtest basic: SUCCESS (1.449s)
[113.500643] [092/171] (886s left) kms_chamelium_hpd (dp-hpd-fast)
[113.656525] Subtest dp-hpd-fast: SKIP (0.000s)
[113.740584] [093/171] (886s left) kms_chamelium_edid (dp-edid-read)
[113.907957] Subtest dp-edid-read: SKIP (0.000s)
[113.996556] [094/171] (886s left) kms_chamelium_frames (dp-crc-fast)
[114.160457] Subtest dp-crc-fast: SKIP (0.000s)
[114.244851] [095/171] (886s left) kms_chamelium_hpd (hdmi-hpd-fast)
[114.410421] Subtest hdmi-hpd-fast: SKIP (0.000s)
[114.494697] [096/171] (885s left) kms_chamelium_edid (hdmi-edid-read)
[114.658691] Subtest hdmi-edid-read: SKIP (0.000s)
[114.743642] [097/171] (885s left) kms_chamelium_frames (hdmi-crc-fast)
[114.909082] Subtest hdmi-crc-fast: SKIP (0.000s)
[114.992808] [098/171] (885s left) kms_chamelium_hpd (vga-hpd-fast)
[115.157694] Subtest vga-hpd-fast: SKIP (0.000s)
[115.241916] [099/171] (885s left) kms_chamelium_edid (vga-edid-read)
[115.407063] Subtest vga-edid-read: SKIP (0.000s)
[115.492657] [100/171] (885s left) kms_prop_blob (basic)
[115.551721] Starting subtest: basic
[115.552508] Subtest basic: SUCCESS (0.000s)
[115.617713] [101/171] (884s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[115.705784] Starting subtest: basic-busy-flip-before-cursor-atomic
[115.707333] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[115.768068] [102/171] (884s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[115.854654] Starting subtest: basic-busy-flip-before-cursor-legacy
[115.856223] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[115.917591] [103/171] (884s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[116.005145] Starting subtest: basic-flip-after-cursor-atomic
[117.022393] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.017s)
[117.180327] [104/171] (883s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[117.268010] Starting subtest: basic-flip-after-cursor-legacy
[118.300307] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.033s)
[118.454524] [105/171] (882s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[118.540930] Starting subtest: basic-flip-after-cursor-varying-size
[119.574474] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.035s)
[119.736319] [106/171] (880s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[119.828935] Starting subtest: basic-flip-before-cursor-atomic
[120.858385] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.030s)
[121.024647] [107/171] (879s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[121.110668] Starting subtest: basic-flip-before-cursor-legacy
[122.145838] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.035s)
[122.298454] [108/171] (878s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[122.389996] Starting subtest: basic-flip-before-cursor-varying-size
[123.438134] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.048s)
[123.598560] [109/171] (877s left) kms_flip (basic-flip-vs-dpms)
[123.672504] Starting subtest: basic-flip-vs-dpms
[123.675750] Starting dynamic subtest: A-DP3
[124.529708] Dynamic subtest A-DP3: SUCCESS (0.854s)
[124.535965] Starting dynamic subtest: B-DP3
[125.352793] Dynamic subtest B-DP3: SUCCESS (0.822s)
[125.359093] Starting dynamic subtest: C-DP3
[126.174764] Dynamic subtest C-DP3: SUCCESS (0.823s)
[126.181194] Starting dynamic subtest: D-DP3
[127.002628] Dynamic subtest D-DP3: SUCCESS (0.827s)
[127.003502] Subtest basic-flip-vs-dpms: SUCCESS (3.332s)
[127.168663] [110/171] (873s left) kms_flip (basic-flip-vs-modeset)
[127.243785] Starting subtest: basic-flip-vs-modeset
[127.247608] Starting dynamic subtest: A-DP3
[128.101917] Dynamic subtest A-DP3: SUCCESS (0.854s)
[128.108026] Starting dynamic subtest: B-DP3
[128.795643] Dynamic subtest B-DP3: SUCCESS (0.694s)
[128.802132] Starting dynamic subtest: C-DP3
[129.624063] Dynamic subtest C-DP3: SUCCESS (0.827s)
[129.630383] Starting dynamic subtest: D-DP3
[130.318983] Dynamic subtest D-DP3: SUCCESS (0.695s)
[130.319859] Subtest basic-flip-vs-modeset: SUCCESS (3.077s)
[130.469778] [111/171] (870s left) kms_flip (basic-flip-vs-wf_vblank)
[130.545968] Starting subtest: basic-flip-vs-wf_vblank
[130.549424] Starting dynamic subtest: A-DP3
[131.658099] Dynamic subtest A-DP3: SUCCESS (1.109s)
[131.664629] Starting dynamic subtest: B-DP3
[132.698559] Dynamic subtest B-DP3: SUCCESS (1.040s)
[132.705455] Starting dynamic subtest: C-DP3
[133.739243] Dynamic subtest C-DP3: SUCCESS (1.040s)
[133.745508] Starting dynamic subtest: D-DP3
[134.779128] Dynamic subtest D-DP3: SUCCESS (1.039s)
[134.780614] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.236s)
[135.019035] [112/171] (865s left) kms_flip (basic-plain-flip)
[135.094957] Starting subtest: basic-plain-flip
[135.098534] Starting dynamic subtest: A-DP3
[135.923533] Dynamic subtest A-DP3: SUCCESS (0.825s)
[135.930937] Starting dynamic subtest: B-DP3
[136.682007] Dynamic subtest B-DP3: SUCCESS (0.758s)
[136.688228] Starting dynamic subtest: C-DP3
[137.438979] Dynamic subtest C-DP3: SUCCESS (0.757s)
[137.445533] Starting dynamic subtest: D-DP3
[138.193150] Dynamic subtest D-DP3: SUCCESS (0.754s)
[138.194602] Subtest basic-plain-flip: SUCCESS (3.101s)
[138.414669] [113/171] (862s left) kms_force_connector_basic (force-connector-state)
[138.484011] Starting subtest: force-connector-state
[138.989746] Subtest force-connector-state: SUCCESS (0.505s)
[139.212591] [114/171] (861s left) kms_force_connector_basic (force-edid)
[139.281125] Starting subtest: force-edid
[139.295154] Subtest force-edid: SUCCESS (0.015s)
[139.429362] [115/171] (861s left) kms_force_connector_basic (force-load-detect)
[139.496120] Starting subtest: force-load-detect
[139.497747] Subtest force-load-detect: SKIP (0.000s)
[139.595723] [116/171] (861s left) kms_force_connector_basic (prune-stale-modes)
[139.660975] Starting subtest: prune-stale-modes
[139.671133] Subtest prune-stale-modes: SKIP (0.008s)
[139.795839] [117/171] (860s left) kms_frontbuffer_tracking (basic)
[139.906987] Starting subtest: basic
[143.593813] Subtest basic: SUCCESS (3.689s)
[143.695514] [118/171] (857s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[143.784197] Starting subtest: compare-crc-sanitycheck-xr24
[143.785165] Starting dynamic subtest: pipe-A-DP-3
[144.316337] Dynamic subtest pipe-A-DP-3: SUCCESS (0.531s)
[144.322774] Starting dynamic subtest: pipe-B-DP-3
[144.822461] Dynamic subtest pipe-B-DP-3: SUCCESS (0.505s)
[144.829176] Starting dynamic subtest: pipe-C-DP-3
[145.363994] Dynamic subtest pipe-C-DP-3: SUCCESS (0.540s)
[145.370447] Starting dynamic subtest: pipe-D-DP-3
[145.964036] Dynamic subtest pipe-D-DP-3: SUCCESS (0.598s)
[145.964814] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.181s)
[146.118607] [119/171] (854s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[146.205995] Starting subtest: compare-crc-sanitycheck-nv12
[146.206917] Starting dynamic subtest: pipe-A-DP-3
[147.471968] Dynamic subtest pipe-A-DP-3: SUCCESS (1.265s)
[147.478933] Starting dynamic subtest: pipe-B-DP-3
[148.619405] Dynamic subtest pipe-B-DP-3: SUCCESS (1.145s)
[148.626039] Starting dynamic subtest: pipe-C-DP-3
[149.842917] Dynamic subtest pipe-C-DP-3: SUCCESS (1.221s)
[149.849458] Starting dynamic subtest: pipe-D-DP-3
[151.140727] Dynamic subtest pipe-D-DP-3: SUCCESS (1.297s)
[151.141647] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.936s)
[151.299611] [120/171] (849s left) kms_pipe_crc_basic (hang-read-crc)
[151.387818] Starting subtest: hang-read-crc
[151.388705] Starting dynamic subtest: pipe-A-DP-3
[152.867203] Dynamic subtest pipe-A-DP-3: SUCCESS (1.478s)
[152.873459] Starting dynamic subtest: pipe-B-DP-3
[154.279234] Dynamic subtest pipe-B-DP-3: SUCCESS (1.410s)
[154.285513] Starting dynamic subtest: pipe-C-DP-3
[155.803171] Dynamic subtest pipe-C-DP-3: SUCCESS (1.522s)
[155.809343] Starting dynamic subtest: pipe-D-DP-3
[157.410655] Dynamic subtest pipe-D-DP-3: SUCCESS (1.606s)
[157.411562] Subtest hang-read-crc: SUCCESS (6.022s)
[157.570339] [121/171] (843s left) kms_pipe_crc_basic (nonblocking-crc)
[157.710147] Starting subtest: nonblocking-crc
[157.710956] Starting dynamic subtest: pipe-A-DP-3
[158.434529] Dynamic subtest pipe-A-DP-3: SUCCESS (0.720s)
[158.441723] Starting dynamic subtest: pipe-B-DP-3
[159.111509] Dynamic subtest pipe-B-DP-3: SUCCESS (0.671s)
[159.120816] Starting dynamic subtest: pipe-C-DP-3
[159.798299] Dynamic subtest pipe-C-DP-3: SUCCESS (0.692s)
[159.810236] Starting dynamic subtest: pipe-D-DP-3
[160.565929] Dynamic subtest pipe-D-DP-3: SUCCESS (0.766s)
[160.570054] Subtest nonblocking-crc: SUCCESS (2.856s)
[160.727240] [122/171] (840s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[160.814206] Starting subtest: nonblocking-crc-frame-sequence
[160.815112] Starting dynamic subtest: pipe-A-DP-3
[161.504332] Dynamic subtest pipe-A-DP-3: SUCCESS (0.689s)
[161.510764] Starting dynamic subtest: pipe-B-DP-3
[162.156365] Dynamic subtest pipe-B-DP-3: SUCCESS (0.651s)
[162.162829] Starting dynamic subtest: pipe-C-DP-3
[162.887018] Dynamic subtest pipe-C-DP-3: SUCCESS (0.729s)
[162.894360] Starting dynamic subtest: pipe-D-DP-3
[163.644629] Dynamic subtest pipe-D-DP-3: SUCCESS (0.755s)
[163.645513] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.830s)
[163.790578] [123/171] (837s left) kms_pipe_crc_basic (read-crc)
[163.877902] Starting subtest: read-crc
[163.878754] Starting dynamic subtest: pipe-A-DP-3
[164.494282] Dynamic subtest pipe-A-DP-3: SUCCESS (0.615s)
[164.500477] Starting dynamic subtest: pipe-B-DP-3
[165.064050] Dynamic subtest pipe-B-DP-3: SUCCESS (0.568s)
[165.070182] Starting dynamic subtest: pipe-C-DP-3
[165.692846] Dynamic subtest pipe-C-DP-3: SUCCESS (0.627s)
[165.699185] Starting dynamic subtest: pipe-D-DP-3
[166.381621] Dynamic subtest pipe-D-DP-3: SUCCESS (0.687s)
[166.382505] Subtest read-crc: SUCCESS (2.504s)
[166.527535] [124/171] (834s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[166.615872] Starting subtest: read-crc-frame-sequence
[166.616628] Starting dynamic subtest: pipe-A-DP-3
[167.231199] Dynamic subtest pipe-A-DP-3: SUCCESS (0.615s)
[167.237907] Starting dynamic subtest: pipe-B-DP-3
[167.821428] Dynamic subtest pipe-B-DP-3: SUCCESS (0.588s)
[167.828194] Starting dynamic subtest: pipe-C-DP-3
[168.452069] Dynamic subtest pipe-C-DP-3: SUCCESS (0.629s)
[168.459749] Starting dynamic subtest: pipe-D-DP-3
[169.155377] Dynamic subtest pipe-D-DP-3: SUCCESS (0.701s)
[169.156271] Subtest read-crc-frame-sequence: SUCCESS (2.540s)
[169.300503] [125/171] (831s left) kms_psr (primary_page_flip)
[169.363080] Subtest primary_page_flip: SKIP (0.000s)
[169.389762] [126/171] (831s left) kms_psr (cursor_plane_move)
[169.449859] Subtest cursor_plane_move: SKIP (0.000s)
[169.472998] [127/171] (831s left) kms_psr (sprite_plane_onoff)
[169.534300] Subtest sprite_plane_onoff: SKIP (0.000s)
[169.555691] [128/171] (831s left) kms_psr (primary_mmap_gtt)
[169.615014] Subtest primary_mmap_gtt: SKIP (0.000s)
[169.639940] [129/171] (831s left) kms_setmode (basic-clone-single-crtc)
[169.699807] Starting subtest: basic-clone-single-crtc
[169.702304] Subtest basic-clone-single-crtc: SKIP (0.000s)
[169.771540] [130/171] (831s left) i915_pm_backlight (basic-brightness)
[169.861937] Subtest basic-brightness: SKIP (0.000s)
[169.890423] [131/171] (831s left) i915_pm_rpm (basic-pci-d3-state)
[171.562838] Starting subtest: basic-pci-d3-state
[172.421397] Subtest basic-pci-d3-state: SUCCESS (0.859s)
[172.573532] [132/171] (828s left) i915_pm_rpm (basic-rte)
[172.631156] Starting subtest: basic-rte
[175.664112] Subtest basic-rte: SUCCESS (3.032s)
[176.220352] [133/171] (824s left) i915_pm_rps (basic-api)
[176.284306] Starting subtest: basic-api
[176.286153] Subtest basic-api: SKIP (0.000s)
[176.361270] [134/171] (824s left) prime_self_import (basic-llseek-bad)
[176.413615] Starting subtest: basic-llseek-bad
[176.425484] Subtest basic-llseek-bad: SUCCESS (0.011s)
[176.548416] [135/171] (824s left) prime_self_import (basic-llseek-size)
[176.643213] Starting subtest: basic-llseek-size
[176.655184] Subtest basic-llseek-size: SUCCESS (0.012s)
[176.753097] [136/171] (824s left) prime_self_import (basic-with_fd_dup)
[176.801238] Starting subtest: basic-with_fd_dup
[176.812664] Subtest basic-with_fd_dup: SUCCESS (0.012s)
[176.923852] [137/171] (824s left) prime_self_import (basic-with_one_bo)
[176.999656] Starting subtest: basic-with_one_bo
[177.012096] Subtest basic-with_one_bo: SUCCESS (0.012s)
[177.058618] [138/171] (824s left) prime_self_import (basic-with_one_bo_two_files)
[177.107190] Starting subtest: basic-with_one_bo_two_files
[177.124352] Subtest basic-with_one_bo_two_files: SUCCESS (0.011s)
[177.236746] [139/171] (823s left) prime_self_import (basic-with_two_bos)
[177.324101] Starting subtest: basic-with_two_bos
[177.335849] Subtest basic-with_two_bos: SUCCESS (0.012s)
[177.436383] [140/171] (823s left) prime_vgem (basic-fence-flip)
[177.527472] Starting subtest: basic-fence-flip
[177.586374] Subtest basic-fence-flip: SKIP (0.058s)
[177.671803] [141/171] (823s left) prime_vgem (basic-fence-mmap)
[177.768430] Starting subtest: basic-fence-mmap
[177.770475] Subtest basic-fence-mmap: SKIP (0.000s)
[177.881255] [142/171] (823s left) prime_vgem (basic-fence-read)
[177.967810] Starting subtest: basic-fence-read
[177.972829] Subtest basic-fence-read: SKIP (0.004s)
[178.083240] [143/171] (823s left) prime_vgem (basic-gtt)
[178.177300] Starting subtest: basic-gtt
[178.178886] Subtest basic-gtt: SKIP (0.000s)
[178.305988] [144/171] (822s left) prime_vgem (basic-read)
[178.398153] Starting subtest: basic-read
[178.403220] Subtest basic-read: SKIP (0.004s)
[178.513378] [145/171] (822s left) prime_vgem (basic-write)
[178.623129] Starting subtest: basic-write
[178.628232] Subtest basic-write: SKIP (0.004s)
[178.751956] [146/171] (822s left) vgem_basic (setversion)
[178.834589] Starting subtest: setversion
[178.837087] Subtest setversion: SUCCESS (0.000s)
[178.889645] [147/171] (822s left) vgem_basic (create)
[178.951154] Starting subtest: create
[178.952349] Subtest create: SUCCESS (0.000s)
[179.004952] [148/171] (822s left) vgem_basic (debugfs)
[179.068072] Starting subtest: debugfs
[179.069142] Subtest debugfs: SUCCESS (0.000s)
[179.122302] [149/171] (822s left) vgem_basic (dmabuf-export)
[179.201615] Starting subtest: dmabuf-export
[179.216345] Subtest dmabuf-export: SUCCESS (0.014s)
[179.334678] [150/171] (821s left) vgem_basic (dmabuf-fence)
[179.417878] Starting subtest: dmabuf-fence
[179.418655] Subtest dmabuf-fence: SUCCESS (0.000s)
[179.473781] [151/171] (821s left) vgem_basic (dmabuf-fence-before)
[179.534444] Starting subtest: dmabuf-fence-before
[179.535249] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[179.587328] [152/171] (821s left) vgem_basic (dmabuf-mmap)
[179.651007] Starting subtest: dmabuf-mmap
[179.659109] Subtest dmabuf-mmap: SUCCESS (0.009s)
[179.703589] [153/171] (821s left) vgem_basic (mmap)
[179.768043] Starting subtest: mmap
[179.773028] Subtest mmap: SUCCESS (0.006s)
[179.820605] [154/171] (821s left) vgem_basic (second-client)
[179.884543] Starting subtest: second-client
[179.918509] Subtest second-client: SUCCESS (0.033s)
[179.993908] [155/171] (821s left) vgem_basic (sysfs)
[180.068149] Starting subtest: sysfs
[180.069374] Subtest sysfs: SUCCESS (0.000s)
[180.125761] [156/171] (821s left) core_hotunplug (unbind-rebind)
[180.217500] Starting subtest: unbind-rebind
[182.360956] Subtest unbind-rebind: SUCCESS (2.143s)
[182.376570] [157/171] (819s left) vgem_basic (unload)
[182.433523] Starting subtest: unload
[211.375466] Subtest unload: SUCCESS (28.907s)
[211.443382] [158/171] (790s left) i915_module_load (reload)
[211.491114] Starting subtest: reload
[214.325055] Subtest reload: SUCCESS (2.834s)
[214.338382] [159/171] (787s left) gem_lmem_swapping (basic)
[217.384389] Starting subtest: basic
[217.385153] Starting dynamic subtest: lmem0
[234.633347] Dynamic subtest lmem0: SUCCESS (17.216s)
[234.634218] Subtest basic: SUCCESS (17.216s)
[236.958910] [160/171] (764s left) gem_lmem_swapping (parallel-random-engines)
[237.574030] Starting subtest: parallel-random-engines
[237.574907] Starting dynamic subtest: lmem0
[238.390119] Dynamic subtest lmem0: SUCCESS (0.816s)
[238.390918] Subtest parallel-random-engines: SUCCESS (0.816s)
[239.725121] [161/171] (761s left) gem_lmem_swapping (random-engines)
[240.373287] Starting subtest: random-engines
[240.374055] Starting dynamic subtest: lmem0
[241.090107] Dynamic subtest lmem0: SUCCESS (0.709s)
[241.090948] Subtest random-engines: SUCCESS (0.709s)
[242.469592] [162/171] (759s left) gem_lmem_swapping (verify-random)
[243.126392] Starting subtest: verify-random
[243.127216] Starting dynamic subtest: lmem0
[250.614160] Dynamic subtest lmem0: SUCCESS (7.480s)
[250.615118] Subtest verify-random: SUCCESS (7.481s)
[251.974503] [163/171] (749s left) i915_pm_rpm (module-reload)
[254.780425] Starting subtest: module-reload
[267.386727] Subtest module-reload: SUCCESS (12.597s)
[267.411967] [164/171] (734s left) i915_selftest (live)
[267.465965] Starting subtest: live
[267.466946] Starting dynamic subtest: sanitycheck
[268.898257] Dynamic subtest sanitycheck: SUCCESS (1.423s)
[268.904587] Starting dynamic subtest: uncore
[270.250208] Dynamic subtest uncore: SUCCESS (1.351s)
[270.255674] Starting dynamic subtest: workarounds
[274.623238] Dynamic subtest workarounds: SUCCESS (4.373s)
[274.628576] Starting dynamic subtest: gt_engines
[277.088415] Dynamic subtest gt_engines: SUCCESS (2.465s)
[277.094229] Starting dynamic subtest: gt_timelines
[304.662265] Dynamic subtest gt_timelines: SUCCESS (27.573s)
[304.668539] Starting dynamic subtest: gt_contexts
[306.112247] Dynamic subtest gt_contexts: SUCCESS (1.449s)
[306.117683] Starting dynamic subtest: gt_lrc
[314.015300] Dynamic subtest gt_lrc: SUCCESS (7.911s)
[314.021274] Starting dynamic subtest: gt_mocs
[317.910218] Dynamic subtest gt_mocs: SUCCESS (3.886s)
[317.916425] Starting dynamic subtest: gt_pm
[320.225463] Dynamic subtest gt_pm: SUCCESS (2.315s)
[320.232268] Starting dynamic subtest: gt_heartbeat
[321.824298] Dynamic subtest gt_heartbeat: SUCCESS (1.598s)
[321.830157] Starting dynamic subtest: gt_tlb
[333.883347] Dynamic subtest gt_tlb: SUCCESS (12.059s)
[333.888803] Starting dynamic subtest: requests
[351.387395] Dynamic subtest requests: SUCCESS (17.504s)
[351.393363] Starting dynamic subtest: migrate
[355.968346] Dynamic subtest migrate: SUCCESS (4.581s)
[355.973907] Starting dynamic subtest: active
[357.361214] Dynamic subtest active: SUCCESS (1.392s)
[357.367388] Starting dynamic subtest: objects
[359.566311] Dynamic subtest objects: SUCCESS (2.205s)
[359.571794] Starting dynamic subtest: mman
[367.996697] Dynamic subtest mman: SUCCESS (8.434s)
[368.001793] Starting dynamic subtest: dmabuf
[369.396885] Dynamic subtest dmabuf: SUCCESS (1.396s)
[369.401977] Starting dynamic subtest: vma
[370.804176] Dynamic subtest vma: SUCCESS (1.407s)
[370.809207] Starting dynamic subtest: coherency
[374.066975] Dynamic subtest coherency: SUCCESS (3.262s)
[374.072019] Starting dynamic subtest: gtt
[382.794478] Dynamic subtest gtt: SUCCESS (8.727s)
[382.800741] Starting dynamic subtest: gem
[384.201215] Dynamic subtest gem: SUCCESS (1.406s)
[384.207632] Starting dynamic subtest: evict
[387.729250] Dynamic subtest evict: SUCCESS (3.527s)
[387.735431] Starting dynamic subtest: hugepages
[405.017306] Dynamic subtest hugepages: SUCCESS (17.288s)
[405.023450] Starting dynamic subtest: gem_contexts
[445.633099] Dynamic subtest gem_contexts: SUCCESS (40.590s)
[445.638219] Starting dynamic subtest: client
[447.017488] Dynamic subtest client: SUCCESS (1.410s)
[447.023208] Starting dynamic subtest: gem_migrate
[452.025168] Dynamic subtest gem_migrate: SUCCESS (5.007s)
[452.030763] Starting dynamic subtest: reset
[453.481197] Dynamic subtest reset: SUCCESS (1.456s)
[453.487915] Starting dynamic subtest: memory_region
[456.358212] Dynamic subtest memory_region: SUCCESS (2.877s)
[456.363583] Starting dynamic subtest: hangcheck
[503.929403] Dynamic subtest hangcheck: SUCCESS (47.571s)
[503.935413] Starting dynamic subtest: execlists
[505.316421] Dynamic subtest execlists: SUCCESS (1.387s)
[505.322058] Starting dynamic subtest: ring_submission
[506.701203] Dynamic subtest ring_submission: SUCCESS (1.384s)
[506.706812] Starting dynamic subtest: perf
[508.208131] Dynamic subtest perf: SUCCESS (1.506s)
[508.213396] Starting dynamic subtest: slpc
[517.271217] Dynamic subtest slpc: SUCCESS (9.063s)
[517.276867] Starting dynamic subtest: guc
[520.056172] Dynamic subtest guc: SUCCESS (2.785s)
[520.062057] Starting dynamic subtest: guc_multi_lrc
[521.492646] Dynamic subtest guc_multi_lrc: SUCCESS (1.436s)
[521.498994] Starting dynamic subtest: guc_hang
[523.624325] Dynamic subtest guc_hang: SUCCESS (2.131s)
[523.630724] Starting dynamic subtest: late_gt_pm
[525.081663] Dynamic subtest late_gt_pm: SUCCESS (1.456s)
[525.083709] Subtest live: SUCCESS (257.607s)
[525.499375] [165/171] (476s left) dmabuf (all-tests)
[525.550296] Starting subtest: all-tests
[525.551775] Starting dynamic subtest: sanitycheck
[525.615529] Dynamic subtest sanitycheck: SUCCESS (0.065s)
[525.625935] Starting dynamic subtest: dma_fence
[525.796507] Dynamic subtest dma_fence: SUCCESS (0.180s)
[525.806996] Starting dynamic subtest: dma_fence_chain
[536.164503] Dynamic subtest dma_fence_chain: SUCCESS (10.366s)
[536.172169] Starting dynamic subtest: dma_fence_unwrap
[536.249473] Dynamic subtest dma_fence_unwrap: SUCCESS (0.084s)
[536.263745] Starting dynamic subtest: dma_resv
[536.326762] Dynamic subtest dma_resv: SUCCESS (0.076s)
[536.328057] Subtest all-tests: SUCCESS (10.776s)
[536.356430] [166/171] (465s left) i915_suspend (basic-s2idle-without-i915)
[536.447403] Starting subtest: basic-s2idle-without-i915
[555.401063] Subtest basic-s2idle-without-i915: SUCCESS (4.577s)
[555.530849] [167/171] (460s left) i915_suspend (basic-s3-without-i915)
[555.582503] Starting subtest: basic-s3-without-i915
[577.080481] Subtest basic-s3-without-i915: SUCCESS (5.640s)
[577.214549] [168/171] (454s left) gem_exec_suspend (basic-s0)
[577.289460] Starting subtest: basic-S0
[577.290275] Starting dynamic subtest: smem
[597.033480] Dynamic subtest smem: SUCCESS (4.626s)
[597.049196] Starting dynamic subtest: lmem0
[616.058438] Dynamic subtest lmem0: SUCCESS (4.532s)
[616.059716] Subtest basic-S0: SUCCESS (9.160s)
[616.263001] [169/171] (445s left) gem_exec_suspend (basic-s3)
[616.332318] Starting subtest: basic-S3
[616.333131] Starting dynamic subtest: smem
[637.401923] Dynamic subtest smem: SUCCESS (5.391s)
[637.412760] Starting dynamic subtest: lmem0
[658.394080] Dynamic subtest lmem0: SUCCESS (4.795s)
[658.395774] Subtest basic-S3: SUCCESS (10.188s)
[658.598751] [170/171] (434s left) kms_chamelium_hpd (common-hpd-after-suspend)
[658.776880] Subtest common-hpd-after-suspend: SKIP (0.000s)
[658.859731] [171/171] (434s left) kms_pipe_crc_basic (suspend-read-crc)
[658.947330] Starting subtest: suspend-read-crc
[658.948158] Starting dynamic subtest: pipe-A-DP-3
[677.963435] Dynamic subtest pipe-A-DP-3: SUCCESS (3.052s)
[677.971379] Starting dynamic subtest: pipe-B-DP-3
[697.006668] Dynamic subtest pipe-B-DP-3: SUCCESS (2.969s)
[697.016036] Starting dynamic subtest: pipe-C-DP-3
[716.064888] Dynamic subtest pipe-C-DP-3: SUCCESS (3.180s)
[716.073916] Starting dynamic subtest: pipe-D-DP-3
[735.157661] Dynamic subtest pipe-D-DP-3: SUCCESS (3.229s)
[735.158551] Subtest suspend-read-crc: SUCCESS (12.436s)
[735.273353] Closing watchdogs
Done.