[39.722631] Initializing watchdogs
[39.722694]   /dev/watchdog0
[39.727800] [001/170] (960s left) i915_module_load (load)
[39.780390] Starting subtest: load
[40.892741] Subtest load: SUCCESS (1.111s)
[40.935618] [002/170] (959s left) core_auth (basic-auth)
[41.046823] Starting subtest: basic-auth
[41.047650] Subtest basic-auth: SUCCESS (0.001s)
[41.143069] [003/170] (959s left) debugfs_test (read_all_entries)
[41.253429] Starting subtest: read_all_entries
[41.641531] Subtest read_all_entries: SUCCESS (0.388s)
[41.740121] [004/170] (958s left) debugfs_test (basic-hwmon)
[41.801326] Starting subtest: basic-hwmon
[41.804145] Subtest basic-hwmon: SUCCESS (0.003s)
[41.908343] [005/170] (958s left) fbdev (eof)
[41.974914] Starting subtest: eof
[41.975830] Subtest eof: SUCCESS (0.000s)
[42.024225] [006/170] (958s left) fbdev (info)
[42.071834] Starting subtest: info
[42.072937] Subtest info: SUCCESS (0.000s)
[42.126578] [007/170] (958s left) fbdev (nullptr)
[42.191470] Starting subtest: nullptr
[42.192379] Subtest nullptr: SUCCESS (0.000s)
[42.259466] [008/170] (958s left) fbdev (read)
[42.358553] Starting subtest: read
[54.670519] Subtest read: SUCCESS (12.277s)
[54.693780] [009/170] (945s left) fbdev (write)
[54.742377] Starting subtest: write
[60.870477] Subtest write: SUCCESS (6.119s)
[60.910012] [010/170] (939s left) gem_basic (bad-close)
[60.967518] Starting subtest: bad-close
[60.969623] Subtest bad-close: SUCCESS (0.000s)
[61.044297] [011/170] (939s left) gem_basic (create-close)
[61.101767] Starting subtest: create-close
[61.103657] Subtest create-close: SUCCESS (0.000s)
[61.193178] [012/170] (939s left) gem_basic (create-fd-close)
[61.281441] Starting subtest: create-fd-close
[61.283404] Subtest create-fd-close: SUCCESS (0.000s)
[61.363974] [013/170] (939s left) gem_busy (busy@all-engines)
[61.456896] Starting subtest: busy
[61.457918] Starting dynamic subtest: all-engines
[61.550628] Dynamic subtest all-engines: SUCCESS (0.094s)
[61.551432] Subtest busy: SUCCESS (0.094s)
[61.973470] [014/170] (938s left) gem_close_race (basic-process)
[62.069577] Starting subtest: basic-process
[62.112167] Subtest basic-process: SUCCESS (0.043s)
[62.336745] [015/170] (938s left) gem_close_race (basic-threads)
[62.418607] Starting subtest: basic-threads
[63.602438] Subtest basic-threads: SUCCESS (1.184s)
[63.842956] [016/170] (936s left) gem_ctx_create (basic)
[63.952398] Starting subtest: basic
[63.953622] Subtest basic: SUCCESS (0.000s)
[64.156109] [017/170] (936s left) gem_ctx_create (basic-files)
[64.226211] Starting subtest: basic-files
[66.235974] Subtest basic-files: SUCCESS (2.010s)
[66.786672] [018/170] (933s left) gem_ctx_exec (basic)
[66.846361] Starting subtest: basic
[66.849015] Subtest basic: SUCCESS (0.003s)
[66.933279] [019/170] (933s left) gem_exec_basic (basic)
[66.999384] Starting subtest: basic
[67.000201] Starting dynamic subtest: rcs0-smem
[67.000997] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[67.006170] Starting dynamic subtest: bcs0-smem
[67.006948] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[67.011689] Starting dynamic subtest: vcs0-smem
[67.012454] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[67.016867] Starting dynamic subtest: vcs1-smem
[67.017639] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[67.022534] Starting dynamic subtest: vecs0-smem
[67.023678] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[67.028378] Starting dynamic subtest: vecs1-smem
[67.029595] Dynamic subtest vecs1-smem: SUCCESS (0.000s)
[67.034160] Starting dynamic subtest: ccs0-smem
[67.035235] Dynamic subtest ccs0-smem: SUCCESS (0.000s)
[67.040010] Starting dynamic subtest: ccs1-smem
[67.041217] Dynamic subtest ccs1-smem: SUCCESS (0.001s)
[67.045837] Starting dynamic subtest: ccs2-smem
[67.046771] Dynamic subtest ccs2-smem: SUCCESS (0.000s)
[67.051372] Starting dynamic subtest: ccs3-smem
[67.052323] Dynamic subtest ccs3-smem: SUCCESS (0.000s)
[67.057047] Starting dynamic subtest: rcs0-lmem0
[67.058238] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[67.062718] Starting dynamic subtest: bcs0-lmem0
[67.063751] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[67.068412] Starting dynamic subtest: vcs0-lmem0
[67.069503] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[67.074212] Starting dynamic subtest: vcs1-lmem0
[67.075397] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[67.080099] Starting dynamic subtest: vecs0-lmem0
[67.081129] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[67.085779] Starting dynamic subtest: vecs1-lmem0
[67.086969] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[67.091632] Starting dynamic subtest: ccs0-lmem0
[67.092782] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[67.097491] Starting dynamic subtest: ccs1-lmem0
[67.098632] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[67.103226] Starting dynamic subtest: ccs2-lmem0
[67.104433] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[67.109049] Starting dynamic subtest: ccs3-lmem0
[67.109882] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[67.110693] Subtest basic: SUCCESS (0.010s)
[67.188212] [020/170] (933s left) gem_exec_create (basic)
[67.259100] Starting subtest: basic
[67.259947] Starting dynamic subtest: smem
[69.354826] Dynamic subtest smem: SUCCESS (2.096s)
[69.359660] Starting dynamic subtest: lmem0
[71.458837] Dynamic subtest lmem0: SUCCESS (2.104s)
[71.459877] Subtest basic: SUCCESS (4.200s)
[71.652872] [021/170] (928s left) gem_exec_fence (basic-busy)
[71.896218] Starting subtest: basic-busy
[71.897753] Starting dynamic subtest: rcs0
[71.989874] Dynamic subtest rcs0: SUCCESS (0.102s)
[71.997063] Starting dynamic subtest: bcs0
[72.043059] Dynamic subtest bcs0: SUCCESS (0.052s)
[72.051366] Starting dynamic subtest: vcs0
[72.095061] Dynamic subtest vcs0: SUCCESS (0.051s)
[72.104535] Starting dynamic subtest: vcs1
[72.145847] Dynamic subtest vcs1: SUCCESS (0.051s)
[72.164573] Starting dynamic subtest: vecs0
[72.199939] Dynamic subtest vecs0: SUCCESS (0.054s)
[72.218932] Starting dynamic subtest: vecs1
[72.259924] Dynamic subtest vecs1: SUCCESS (0.060s)
[72.278336] Starting dynamic subtest: ccs0
[72.319885] Dynamic subtest ccs0: SUCCESS (0.060s)
[72.329147] Starting dynamic subtest: ccs1
[72.373888] Dynamic subtest ccs1: SUCCESS (0.054s)
[72.381407] Starting dynamic subtest: ccs2
[72.430138] Dynamic subtest ccs2: SUCCESS (0.056s)
[72.443594] Starting dynamic subtest: ccs3
[72.481951] Dynamic subtest ccs3: SUCCESS (0.051s)
[72.483685] Subtest basic-busy: SUCCESS (0.594s)
[73.096716] [022/170] (927s left) gem_exec_fence (basic-wait)
[73.276726] Starting subtest: basic-wait
[73.277621] Starting dynamic subtest: rcs0
[73.371600] Dynamic subtest rcs0: SUCCESS (0.095s)
[73.380145] Starting dynamic subtest: bcs0
[73.419825] Dynamic subtest bcs0: SUCCESS (0.048s)
[73.428337] Starting dynamic subtest: vcs0
[73.478095] Dynamic subtest vcs0: SUCCESS (0.057s)
[73.498683] Starting dynamic subtest: vcs1
[73.535119] Dynamic subtest vcs1: SUCCESS (0.057s)
[73.556518] Starting dynamic subtest: vecs0
[73.600740] Dynamic subtest vecs0: SUCCESS (0.065s)
[73.621328] Starting dynamic subtest: vecs1
[73.657096] Dynamic subtest vecs1: SUCCESS (0.056s)
[73.677878] Starting dynamic subtest: ccs0
[73.717324] Dynamic subtest ccs0: SUCCESS (0.059s)
[73.738189] Starting dynamic subtest: ccs1
[73.769993] Dynamic subtest ccs1: SUCCESS (0.054s)
[73.790737] Starting dynamic subtest: ccs2
[73.828056] Dynamic subtest ccs2: SUCCESS (0.058s)
[73.848617] Starting dynamic subtest: ccs3
[73.886935] Dynamic subtest ccs3: SUCCESS (0.059s)
[73.888690] Subtest basic-wait: SUCCESS (0.610s)
[74.456289] [023/170] (926s left) gem_exec_fence (basic-await)
[74.677837] Starting subtest: basic-await
[74.678798] Starting dynamic subtest: rcs0
[74.788927] Dynamic subtest rcs0: SUCCESS (0.111s)
[74.794053] Starting dynamic subtest: bcs0
[74.878717] Dynamic subtest bcs0: SUCCESS (0.090s)
[74.884177] Starting dynamic subtest: vcs0
[74.972857] Dynamic subtest vcs0: SUCCESS (0.094s)
[74.977812] Starting dynamic subtest: vcs1
[75.062692] Dynamic subtest vcs1: SUCCESS (0.090s)
[75.067447] Starting dynamic subtest: vecs0
[75.151601] Dynamic subtest vecs0: SUCCESS (0.089s)
[75.156939] Starting dynamic subtest: vecs1
[75.242993] Dynamic subtest vecs1: SUCCESS (0.091s)
[75.248051] Starting dynamic subtest: ccs0
[75.332506] Dynamic subtest ccs0: SUCCESS (0.089s)
[75.337886] Starting dynamic subtest: ccs1
[75.423764] Dynamic subtest ccs1: SUCCESS (0.091s)
[75.428720] Starting dynamic subtest: ccs2
[75.512885] Dynamic subtest ccs2: SUCCESS (0.089s)
[75.518063] Starting dynamic subtest: ccs3
[75.602688] Dynamic subtest ccs3: SUCCESS (0.090s)
[75.603569] Subtest basic-await: SUCCESS (0.925s)
[76.193666] [024/170] (924s left) gem_exec_fence (nb-await)
[76.466078] Starting subtest: nb-await
[76.467701] Starting dynamic subtest: rcs0
[76.563216] Dynamic subtest rcs0: SUCCESS (0.106s)
[76.569300] Starting dynamic subtest: bcs0
[76.626024] Dynamic subtest bcs0: SUCCESS (0.063s)
[76.636486] Starting dynamic subtest: vcs0
[76.699909] Dynamic subtest vcs0: SUCCESS (0.073s)
[76.722983] Starting dynamic subtest: vcs1
[76.791986] Dynamic subtest vcs1: SUCCESS (0.092s)
[76.812737] Starting dynamic subtest: vecs0
[76.883868] Dynamic subtest vecs0: SUCCESS (0.092s)
[76.903110] Starting dynamic subtest: vecs1
[76.969045] Dynamic subtest vecs1: SUCCESS (0.085s)
[76.987331] Starting dynamic subtest: ccs0
[77.056241] Dynamic subtest ccs0: SUCCESS (0.087s)
[77.064753] Starting dynamic subtest: ccs1
[77.120921] Dynamic subtest ccs1: SUCCESS (0.065s)
[77.127285] Starting dynamic subtest: ccs2
[77.186558] Dynamic subtest ccs2: SUCCESS (0.065s)
[77.202840] Starting dynamic subtest: ccs3
[77.272444] Dynamic subtest ccs3: SUCCESS (0.085s)
[77.274291] Subtest nb-await: SUCCESS (0.815s)
[77.813134] [025/170] (922s left) gem_exec_gttfill (basic)
[77.884322] Starting subtest: basic
[82.720935] Subtest basic: SUCCESS (4.828s)
[82.961911] [026/170] (917s left) gem_exec_parallel (engines)
[83.071193] Starting subtest: engines
[83.072044] Starting dynamic subtest: basic
[86.038136] Dynamic subtest basic: SUCCESS (2.966s)
[86.057558] Starting dynamic subtest: contexts
[89.129582] Dynamic subtest contexts: SUCCESS (3.083s)
[89.135119] Starting dynamic subtest: fds
[93.094720] Dynamic subtest fds: SUCCESS (3.965s)
[93.100139] Starting dynamic subtest: userptr
[94.560585] Dynamic subtest userptr: SUCCESS (1.473s)
[94.562108] Subtest engines: SUCCESS (11.489s)
[94.811879] [027/170] (905s left) gem_exec_store (basic)
[94.906567] Starting subtest: basic
[95.024324] Subtest basic: SUCCESS (0.118s)
[95.259394] [028/170] (905s left) gem_flink_basic (bad-flink)
[95.326957] Starting subtest: bad-flink
[95.327886] Subtest bad-flink: SUCCESS (0.000s)
[95.379942] [029/170] (905s left) gem_flink_basic (bad-open)
[95.438448] Starting subtest: bad-open
[95.439308] Subtest bad-open: SUCCESS (0.000s)
[95.497237] [030/170] (905s left) gem_flink_basic (basic)
[95.564736] Starting subtest: basic
[95.565582] Subtest basic: SUCCESS (0.000s)
[95.653284] [031/170] (905s left) gem_flink_basic (double-flink)
[95.719492] Starting subtest: double-flink
[95.720521] Subtest double-flink: SUCCESS (0.000s)
[95.846376] [032/170] (904s left) gem_flink_basic (flink-lifetime)
[95.941299] Starting subtest: flink-lifetime
[95.943196] Subtest flink-lifetime: SUCCESS (0.001s)
[96.043450] [033/170] (904s left) gem_huc_copy (huc-copy)
[96.146805] Starting subtest: huc-copy
[96.151359] Subtest huc-copy: SUCCESS (0.005s)
[96.249093] [034/170] (904s left) gem_linear_blits (basic)
[96.388380] Starting subtest: basic
[96.410332] Subtest basic: SUCCESS (0.022s)
[96.552960] [035/170] (904s left) gem_mmap (basic)
[96.692292] Subtest basic: SKIP (0.000s)
[96.719482] [036/170] (904s left) gem_mmap_gtt (basic)
[96.780595] Subtest basic: SKIP (0.000s)
[96.802738] [037/170] (904s left) gem_render_linear_blits (basic)
[96.867123] Starting subtest: basic
[96.914218] Subtest basic: SUCCESS (0.047s)
[96.985738] [038/170] (903s left) gem_render_tiled_blits (basic)
[97.052142] Subtest basic: SKIP (0.000s)
[97.086012] [039/170] (903s left) gem_ringfill (basic-all)
[97.442422] Starting subtest: basic-all
[99.003332] Subtest basic-all: SUCCESS (1.554s)
[99.155802] [040/170] (901s left) gem_softpin (allocator-basic)
[99.263598] Starting subtest: allocator-basic
[99.426168] Subtest allocator-basic: SUCCESS (0.154s)
[99.536181] [041/170] (901s left) gem_softpin (allocator-basic-reserve)
[99.601593] Starting subtest: allocator-basic-reserve
[99.768335] Subtest allocator-basic-reserve: SUCCESS (0.158s)
[99.866587] [042/170] (901s left) gem_softpin (safe-alignment)
[99.942694] Starting subtest: safe-alignment
[99.988254] Subtest safe-alignment: SUCCESS (0.046s)
[100.129557] [043/170] (900s left) gem_sync (basic-all)
[100.197811] Starting subtest: basic-all
[103.720387] Subtest basic-all: SUCCESS (3.523s)
[103.896984] [044/170] (897s left) gem_sync (basic-each)
[103.967402] Starting subtest: basic-each
[106.782396] Subtest basic-each: SUCCESS (2.816s)
[106.965056] [045/170] (894s left) gem_tiled_blits (basic)
[107.029868] Subtest basic: SKIP (0.000s)
[107.053287] [046/170] (893s left) gem_tiled_fence_blits (basic)
[107.117152] Subtest basic: SKIP (0.000s)
[107.136816] [047/170] (893s left) gem_tiled_pread_basic
[107.220402] [048/170] (893s left) gem_wait (busy@all-engines)
[107.290328] Starting subtest: busy
[107.291288] Starting dynamic subtest: all-engines
[107.858169] Dynamic subtest all-engines: SUCCESS (0.568s)
[107.859112] Subtest busy: SUCCESS (0.568s)
[108.085246] [049/170] (892s left) gem_wait (wait@all-engines)
[108.159471] Starting subtest: wait
[108.160356] Starting dynamic subtest: all-engines
[109.251193] Dynamic subtest all-engines: SUCCESS (1.092s)
[109.252139] Subtest wait: SUCCESS (1.092s)
[109.489419] [050/170] (891s left) i915_getparams_basic (basic-eu-total)
[109.567456] Starting subtest: basic-eu-total
[109.569364] Subtest basic-eu-total: SUCCESS (0.000s)
[109.632568] [051/170] (891s left) i915_getparams_basic (basic-subslice-total)
[109.695747] Starting subtest: basic-subslice-total
[109.697554] Subtest basic-subslice-total: SUCCESS (0.000s)
[109.767719] [052/170] (891s left) i915_hangman (error-state-basic)
[109.838231] Starting subtest: error-state-basic
[110.017731] Subtest error-state-basic: SUCCESS (0.180s)
[110.087127] [053/170] (891s left) i915_pciid
[110.233026] [054/170] (890s left) kms_addfb_basic (addfb25-bad-modifier)
[110.294970] Starting subtest: addfb25-bad-modifier
[110.295781] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[110.416687] [055/170] (890s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[110.477853] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[110.599587] [056/170] (890s left) kms_addfb_basic (addfb25-modifier-no-flag)
[110.666634] Starting subtest: addfb25-modifier-no-flag
[110.667455] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[110.764697] [057/170] (890s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[110.827980] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[110.931404] [058/170] (890s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[110.993737] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[111.097793] [059/170] (890s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[111.184639] Starting subtest: addfb25-yf-tiled-legacy
[111.185538] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[111.264982] [060/170] (889s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[111.357212] Starting subtest: addfb25-y-tiled-legacy
[111.358061] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[111.449545] [061/170] (889s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[111.549963] Starting subtest: addfb25-y-tiled-small-legacy
[111.551763] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[111.632141] [062/170] (889s left) kms_addfb_basic (bad-pitch-0)
[111.696460] Starting subtest: bad-pitch-0
[111.697375] Subtest bad-pitch-0: SUCCESS (0.000s)
[111.798721] [063/170] (889s left) kms_addfb_basic (bad-pitch-1024)
[111.866997] Starting subtest: bad-pitch-1024
[111.868015] Subtest bad-pitch-1024: SUCCESS (0.000s)
[111.982581] [064/170] (889s left) kms_addfb_basic (bad-pitch-128)
[112.052949] Starting subtest: bad-pitch-128
[112.053872] Subtest bad-pitch-128: SUCCESS (0.000s)
[112.166607] [065/170] (889s left) kms_addfb_basic (bad-pitch-256)
[112.234723] Starting subtest: bad-pitch-256
[112.235546] Subtest bad-pitch-256: SUCCESS (0.000s)
[112.331642] [066/170] (888s left) kms_addfb_basic (bad-pitch-32)
[112.399836] Starting subtest: bad-pitch-32
[112.400959] Subtest bad-pitch-32: SUCCESS (0.000s)
[112.498298] [067/170] (888s left) kms_addfb_basic (bad-pitch-63)
[112.554846] Starting subtest: bad-pitch-63
[112.555785] Subtest bad-pitch-63: SUCCESS (0.000s)
[112.665533] [068/170] (888s left) kms_addfb_basic (bad-pitch-65536)
[112.733048] Starting subtest: bad-pitch-65536
[112.733846] Subtest bad-pitch-65536: SUCCESS (0.000s)
[112.849510] [069/170] (888s left) kms_addfb_basic (bad-pitch-999)
[112.920776] Starting subtest: bad-pitch-999
[112.921640] Subtest bad-pitch-999: SUCCESS (0.000s)
[113.031923] [070/170] (888s left) kms_addfb_basic (basic)
[113.096762] Starting subtest: basic
[113.097665] Subtest basic: SUCCESS (0.000s)
[113.217667] [071/170] (888s left) kms_addfb_basic (basic-x-tiled-legacy)
[113.279546] Starting subtest: basic-x-tiled-legacy
[113.281260] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[113.429277] [072/170] (887s left) kms_addfb_basic (basic-y-tiled-legacy)
[113.530923] Starting subtest: basic-y-tiled-legacy
[113.532672] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[113.650207] [073/170] (887s left) kms_addfb_basic (bo-too-small)
[113.740115] Starting subtest: bo-too-small
[113.741034] Subtest bo-too-small: SUCCESS (0.000s)
[113.814607] [074/170] (887s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[113.907989] Starting subtest: bo-too-small-due-to-tiling
[113.909522] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[113.999748] [075/170] (887s left) kms_addfb_basic (clobberred-modifier)
[114.059720] Starting subtest: clobberred-modifier
[114.061500] Subtest clobberred-modifier: SKIP (0.000s)
[114.164755] [076/170] (887s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[114.227511] Starting subtest: framebuffer-vs-set-tiling
[114.229048] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[114.331662] [077/170] (887s left) kms_addfb_basic (invalid-get-prop)
[114.395499] Starting subtest: invalid-get-prop
[114.396397] Subtest invalid-get-prop: SUCCESS (0.000s)
[114.498097] [078/170] (886s left) kms_addfb_basic (invalid-get-prop-any)
[114.560266] Starting subtest: invalid-get-prop-any
[114.561066] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[114.665764] [079/170] (886s left) kms_addfb_basic (invalid-set-prop)
[114.724126] Starting subtest: invalid-set-prop
[114.724918] Subtest invalid-set-prop: SUCCESS (0.000s)
[114.851872] [080/170] (886s left) kms_addfb_basic (invalid-set-prop-any)
[114.911865] Starting subtest: invalid-set-prop-any
[114.912583] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[115.015355] [081/170] (886s left) kms_addfb_basic (no-handle)
[115.080672] Starting subtest: no-handle
[115.081555] Subtest no-handle: SUCCESS (0.000s)
[115.182167] [082/170] (886s left) kms_addfb_basic (size-max)
[115.273517] Starting subtest: size-max
[115.274329] Subtest size-max: SUCCESS (0.000s)
[115.348615] [083/170] (886s left) kms_addfb_basic (small-bo)
[115.441579] Starting subtest: small-bo
[115.442388] Subtest small-bo: SUCCESS (0.000s)
[115.533183] [084/170] (885s left) kms_addfb_basic (tile-pitch-mismatch)
[115.604768] Starting subtest: tile-pitch-mismatch
[115.606380] Subtest tile-pitch-mismatch: SKIP (0.000s)
[115.715143] [085/170] (885s left) kms_addfb_basic (too-high)
[115.807810] Starting subtest: too-high
[115.808710] Subtest too-high: SUCCESS (0.000s)
[115.899128] [086/170] (885s left) kms_addfb_basic (too-wide)
[116.001911] Starting subtest: too-wide
[116.002849] Subtest too-wide: SUCCESS (0.000s)
[116.102499] [087/170] (885s left) kms_addfb_basic (unused-handle)
[116.183871] Starting subtest: unused-handle
[116.184699] Subtest unused-handle: SUCCESS (0.000s)
[116.299541] [088/170] (885s left) kms_addfb_basic (unused-modifier)
[116.358923] Starting subtest: unused-modifier
[116.359818] Subtest unused-modifier: SUCCESS (0.000s)
[116.465594] [089/170] (885s left) kms_addfb_basic (unused-offsets)
[116.523754] Starting subtest: unused-offsets
[116.524584] Subtest unused-offsets: SUCCESS (0.000s)
[116.651301] [090/170] (884s left) kms_addfb_basic (unused-pitches)
[116.714709] Starting subtest: unused-pitches
[116.715502] Subtest unused-pitches: SUCCESS (0.000s)
[116.833198] [091/170] (884s left) kms_busy (basic)
[116.944751] Starting subtest: basic
[116.945516] Starting dynamic subtest: flip
[117.636596] Dynamic subtest flip: SUCCESS (0.691s)
[117.642654] Starting dynamic subtest: modeset
[118.355885] Dynamic subtest modeset: SUCCESS (0.719s)
[118.356758] Subtest basic: SUCCESS (1.411s)
[118.504366] [092/170] (883s left) kms_chamelium_hpd (dp-hpd-fast)
[118.661063] Subtest dp-hpd-fast: SKIP (0.000s)
[118.744236] [093/170] (882s left) kms_chamelium_edid (dp-edid-read)
[118.908286] Subtest dp-edid-read: SKIP (0.000s)
[118.990162] [094/170] (882s left) kms_chamelium_frames (dp-crc-fast)
[119.156605] Subtest dp-crc-fast: SKIP (0.000s)
[119.238908] [095/170] (882s left) kms_chamelium_hpd (hdmi-hpd-fast)
[119.403599] Subtest hdmi-hpd-fast: SKIP (0.000s)
[119.484917] [096/170] (882s left) kms_chamelium_edid (hdmi-edid-read)
[119.650373] Subtest hdmi-edid-read: SKIP (0.000s)
[119.734636] [097/170] (881s left) kms_chamelium_frames (hdmi-crc-fast)
[119.896187] Subtest hdmi-crc-fast: SKIP (0.000s)
[119.978849] [098/170] (881s left) kms_chamelium_hpd (vga-hpd-fast)
[120.144329] Subtest vga-hpd-fast: SKIP (0.000s)
[120.227067] [099/170] (881s left) kms_chamelium_edid (vga-edid-read)
[120.392978] Subtest vga-edid-read: SKIP (0.000s)
[120.475147] [100/170] (881s left) kms_prop_blob (basic)
[120.534362] Starting subtest: basic
[120.535178] Subtest basic: SUCCESS (0.000s)
[120.600196] [101/170] (881s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[120.685701] Starting subtest: basic-busy-flip-before-cursor-atomic
[120.687363] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[120.750378] [102/170] (880s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[120.835615] Starting subtest: basic-busy-flip-before-cursor-legacy
[120.837243] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[120.900603] [103/170] (880s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[120.985901] Starting subtest: basic-flip-after-cursor-atomic
[122.009133] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.018s)
[122.155366] [104/170] (879s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[122.251898] Starting subtest: basic-flip-after-cursor-legacy
[123.275258] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.033s)
[123.428870] [105/170] (878s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[123.514866] Starting subtest: basic-flip-after-cursor-varying-size
[124.549921] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.035s)
[124.698859] [106/170] (877s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[124.786365] Starting subtest: basic-flip-before-cursor-atomic
[125.802439] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.017s)
[125.958586] [107/170] (875s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[126.045280] Starting subtest: basic-flip-before-cursor-legacy
[127.079362] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.035s)
[127.238640] [108/170] (874s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[127.325900] Starting subtest: basic-flip-before-cursor-varying-size
[128.360804] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.035s)
[128.531991] [109/170] (873s left) kms_flip (basic-flip-vs-dpms)
[128.604584] Starting subtest: basic-flip-vs-dpms
[128.609105] Starting dynamic subtest: A-DP3
[129.446779] Dynamic subtest A-DP3: SUCCESS (0.837s)
[129.452725] Starting dynamic subtest: B-DP3
[130.249422] Dynamic subtest B-DP3: SUCCESS (0.802s)
[130.255496] Starting dynamic subtest: C-DP3
[131.057343] Dynamic subtest C-DP3: SUCCESS (0.809s)
[131.063521] Starting dynamic subtest: D-DP3
[131.857649] Dynamic subtest D-DP3: SUCCESS (0.800s)
[131.859687] Subtest basic-flip-vs-dpms: SUCCESS (3.254s)
[132.013120] [110/170] (869s left) kms_flip (basic-flip-vs-modeset)
[132.088460] Starting subtest: basic-flip-vs-modeset
[132.092219] Starting dynamic subtest: A-DP3
[132.935655] Dynamic subtest A-DP3: SUCCESS (0.843s)
[132.942045] Starting dynamic subtest: B-DP3
[133.746768] Dynamic subtest B-DP3: SUCCESS (0.810s)
[133.753127] Starting dynamic subtest: C-DP3
[134.560752] Dynamic subtest C-DP3: SUCCESS (0.814s)
[134.566707] Starting dynamic subtest: D-DP3
[135.367767] Dynamic subtest D-DP3: SUCCESS (0.807s)
[135.369671] Subtest basic-flip-vs-modeset: SUCCESS (3.281s)
[135.521794] [111/170] (866s left) kms_flip (basic-flip-vs-wf_vblank)
[135.596916] Starting subtest: basic-flip-vs-wf_vblank
[135.601225] Starting dynamic subtest: A-DP3
[136.704220] Dynamic subtest A-DP3: SUCCESS (1.103s)
[136.710509] Starting dynamic subtest: B-DP3
[137.738268] Dynamic subtest B-DP3: SUCCESS (1.034s)
[137.744518] Starting dynamic subtest: C-DP3
[138.774336] Dynamic subtest C-DP3: SUCCESS (1.036s)
[138.780561] Starting dynamic subtest: D-DP3
[139.811329] Dynamic subtest D-DP3: SUCCESS (1.037s)
[139.812759] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.217s)
[140.014875] [112/170] (861s left) kms_flip (basic-plain-flip)
[140.088410] Starting subtest: basic-plain-flip
[140.093072] Starting dynamic subtest: A-DP3
[140.915115] Dynamic subtest A-DP3: SUCCESS (0.822s)
[140.922539] Starting dynamic subtest: B-DP3
[141.666961] Dynamic subtest B-DP3: SUCCESS (0.751s)
[141.673165] Starting dynamic subtest: C-DP3
[142.418352] Dynamic subtest C-DP3: SUCCESS (0.751s)
[142.424450] Starting dynamic subtest: D-DP3
[143.169014] Dynamic subtest D-DP3: SUCCESS (0.750s)
[143.170670] Subtest basic-plain-flip: SUCCESS (3.083s)
[143.406251] [113/170] (858s left) kms_force_connector_basic (force-connector-state)
[143.474268] Starting subtest: force-connector-state
[143.660247] Subtest force-connector-state: SUCCESS (0.186s)
[143.857416] [114/170] (858s left) kms_force_connector_basic (force-edid)
[143.923486] Starting subtest: force-edid
[143.938217] Subtest force-edid: SUCCESS (0.014s)
[144.073896] [115/170] (857s left) kms_force_connector_basic (force-load-detect)
[144.142404] Starting subtest: force-load-detect
[144.143925] Subtest force-load-detect: SKIP (0.000s)
[144.240668] [116/170] (857s left) kms_force_connector_basic (prune-stale-modes)
[144.306156] Starting subtest: prune-stale-modes
[144.314984] Subtest prune-stale-modes: SKIP (0.008s)
[144.440859] [117/170] (857s left) kms_frontbuffer_tracking (basic)
[144.551059] Starting subtest: basic
[148.306024] Subtest basic: SUCCESS (3.757s)
[148.394447] [118/170] (853s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[148.486185] Starting subtest: compare-crc-sanitycheck
[148.487063] Starting dynamic subtest: pipe-A-DP-3
[149.011059] Dynamic subtest pipe-A-DP-3: SUCCESS (0.524s)
[149.017386] Starting dynamic subtest: pipe-B-DP-3
[149.465034] Dynamic subtest pipe-B-DP-3: SUCCESS (0.453s)
[149.471305] Starting dynamic subtest: pipe-C-DP-3
[149.915668] Dynamic subtest pipe-C-DP-3: SUCCESS (0.449s)
[149.921951] Starting dynamic subtest: pipe-D-DP-3
[150.370852] Dynamic subtest pipe-D-DP-3: SUCCESS (0.454s)
[150.371705] Subtest compare-crc-sanitycheck: SUCCESS (1.885s)
[150.515633] [119/170] (851s left) kms_pipe_crc_basic (hang-read-crc)
[150.602846] Starting subtest: hang-read-crc
[150.604985] Starting dynamic subtest: pipe-A-DP-3
[152.073811] Dynamic subtest pipe-A-DP-3: SUCCESS (1.469s)
[152.081301] Starting dynamic subtest: pipe-B-DP-3
[153.362768] Dynamic subtest pipe-B-DP-3: SUCCESS (1.288s)
[153.370375] Starting dynamic subtest: pipe-C-DP-3
[154.640742] Dynamic subtest pipe-C-DP-3: SUCCESS (1.277s)
[154.648369] Starting dynamic subtest: pipe-D-DP-3
[155.925163] Dynamic subtest pipe-D-DP-3: SUCCESS (1.282s)
[155.926100] Subtest hang-read-crc: SUCCESS (5.322s)
[156.070938] [120/170] (845s left) kms_pipe_crc_basic (nonblocking-crc)
[156.181270] Starting subtest: nonblocking-crc
[156.182216] Starting dynamic subtest: pipe-A-DP-3
[156.867338] Dynamic subtest pipe-A-DP-3: SUCCESS (0.686s)
[156.874422] Starting dynamic subtest: pipe-B-DP-3
[157.483135] Dynamic subtest pipe-B-DP-3: SUCCESS (0.622s)
[157.489320] Starting dynamic subtest: pipe-C-DP-3
[158.076488] Dynamic subtest pipe-C-DP-3: SUCCESS (0.587s)
[158.082925] Starting dynamic subtest: pipe-D-DP-3
[158.680132] Dynamic subtest pipe-D-DP-3: SUCCESS (0.607s)
[158.685575] Subtest nonblocking-crc: SUCCESS (2.508s)
[158.828534] [121/170] (843s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[158.929181] Starting subtest: nonblocking-crc-frame-sequence
[158.930059] Starting dynamic subtest: pipe-A-DP-3
[159.637365] Dynamic subtest pipe-A-DP-3: SUCCESS (0.702s)
[159.643826] Starting dynamic subtest: pipe-B-DP-3
[160.205562] Dynamic subtest pipe-B-DP-3: SUCCESS (0.568s)
[160.211932] Starting dynamic subtest: pipe-C-DP-3
[160.792145] Dynamic subtest pipe-C-DP-3: SUCCESS (0.589s)
[160.798357] Starting dynamic subtest: pipe-D-DP-3
[161.418475] Dynamic subtest pipe-D-DP-3: SUCCESS (0.625s)
[161.419346] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.491s)
[161.566018] [122/170] (840s left) kms_pipe_crc_basic (read-crc)
[161.655908] Starting subtest: read-crc
[161.656710] Starting dynamic subtest: pipe-A-DP-3
[162.268865] Dynamic subtest pipe-A-DP-3: SUCCESS (0.612s)
[162.275041] Starting dynamic subtest: pipe-B-DP-3
[162.787976] Dynamic subtest pipe-B-DP-3: SUCCESS (0.517s)
[162.794197] Starting dynamic subtest: pipe-C-DP-3
[163.332123] Dynamic subtest pipe-C-DP-3: SUCCESS (0.543s)
[163.339801] Starting dynamic subtest: pipe-D-DP-3
[163.858136] Dynamic subtest pipe-D-DP-3: SUCCESS (0.524s)
[163.859106] Subtest read-crc: SUCCESS (2.203s)
[164.008890] [123/170] (837s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[164.100225] Starting subtest: read-crc-frame-sequence
[164.101119] Starting dynamic subtest: pipe-A-DP-3
[164.727958] Dynamic subtest pipe-A-DP-3: SUCCESS (0.627s)
[164.735370] Starting dynamic subtest: pipe-B-DP-3
[165.251174] Dynamic subtest pipe-B-DP-3: SUCCESS (0.522s)
[165.258714] Starting dynamic subtest: pipe-C-DP-3
[165.789851] Dynamic subtest pipe-C-DP-3: SUCCESS (0.537s)
[165.796044] Starting dynamic subtest: pipe-D-DP-3
[166.316534] Dynamic subtest pipe-D-DP-3: SUCCESS (0.525s)
[166.317449] Subtest read-crc-frame-sequence: SUCCESS (2.217s)
[166.461487] [124/170] (835s left) kms_psr (primary_page_flip)
[166.522257] Subtest primary_page_flip: SKIP (0.000s)
[166.550561] [125/170] (835s left) kms_psr (cursor_plane_move)
[166.609331] Subtest cursor_plane_move: SKIP (0.000s)
[166.634390] [126/170] (835s left) kms_psr (sprite_plane_onoff)
[166.693615] Subtest sprite_plane_onoff: SKIP (0.000s)
[166.717210] [127/170] (835s left) kms_psr (primary_mmap_gtt)
[166.777073] Subtest primary_mmap_gtt: SKIP (0.000s)
[166.800832] [128/170] (835s left) kms_setmode (basic-clone-single-crtc)
[166.860785] Starting subtest: basic-clone-single-crtc
[166.863102] Subtest basic-clone-single-crtc: SKIP (0.000s)
[166.940243] [129/170] (835s left) i915_pm_backlight (basic-brightness)
[167.042848] Subtest basic-brightness: SKIP (0.000s)
[167.067116] [130/170] (835s left) i915_pm_rpm (basic-pci-d3-state)
[169.521900] Starting subtest: basic-pci-d3-state
[170.419321] Subtest basic-pci-d3-state: SUCCESS (0.898s)
[170.574741] [131/170] (831s left) i915_pm_rpm (basic-rte)
[170.633686] Starting subtest: basic-rte
[173.426489] Subtest basic-rte: SUCCESS (2.792s)
[174.373175] [132/170] (827s left) i915_pm_rps (basic-api)
[174.436575] Starting subtest: basic-api
[174.438223] Subtest basic-api: SKIP (0.000s)
[174.513355] [133/170] (827s left) prime_self_import (basic-llseek-bad)
[174.577164] Starting subtest: basic-llseek-bad
[174.586897] Subtest basic-llseek-bad: SUCCESS (0.011s)
[174.682521] [134/170] (827s left) prime_self_import (basic-llseek-size)
[174.735167] Starting subtest: basic-llseek-size
[174.747147] Subtest basic-llseek-size: SUCCESS (0.011s)
[174.872749] [135/170] (827s left) prime_self_import (basic-with_fd_dup)
[174.920246] Starting subtest: basic-with_fd_dup
[174.932099] Subtest basic-with_fd_dup: SUCCESS (0.011s)
[175.026071] [136/170] (827s left) prime_self_import (basic-with_one_bo)
[175.107072] Starting subtest: basic-with_one_bo
[175.118983] Subtest basic-with_one_bo: SUCCESS (0.012s)
[175.179659] [137/170] (827s left) prime_self_import (basic-with_one_bo_two_files)
[175.227610] Starting subtest: basic-with_one_bo_two_files
[175.238968] Subtest basic-with_one_bo_two_files: SUCCESS (0.011s)
[175.360450] [138/170] (826s left) prime_self_import (basic-with_two_bos)
[175.440119] Starting subtest: basic-with_two_bos
[175.451860] Subtest basic-with_two_bos: SUCCESS (0.011s)
[175.533591] [139/170] (826s left) prime_vgem (basic-fence-flip)
[175.619651] Starting subtest: basic-fence-flip
[175.678529] Subtest basic-fence-flip: SKIP (0.058s)
[175.782200] [140/170] (826s left) prime_vgem (basic-fence-mmap)
[175.863914] Starting subtest: basic-fence-mmap
[175.865487] Subtest basic-fence-mmap: SKIP (0.000s)
[175.992792] [141/170] (826s left) prime_vgem (basic-fence-read)
[176.103130] Starting subtest: basic-fence-read
[176.108419] Subtest basic-fence-read: SKIP (0.004s)
[176.237333] [142/170] (826s left) prime_vgem (basic-gtt)
[176.319884] Starting subtest: basic-gtt
[176.321558] Subtest basic-gtt: SKIP (0.000s)
[176.429042] [143/170] (825s left) prime_vgem (basic-read)
[176.515184] Starting subtest: basic-read
[176.520655] Subtest basic-read: SKIP (0.004s)
[176.628938] [144/170] (825s left) prime_vgem (basic-write)
[176.714170] Starting subtest: basic-write
[176.719143] Subtest basic-write: SKIP (0.004s)
[176.837224] [145/170] (825s left) vgem_basic (setversion)
[176.921531] Starting subtest: setversion
[176.923156] Subtest setversion: SUCCESS (0.000s)
[176.975751] [146/170] (825s left) vgem_basic (create)
[177.038288] Starting subtest: create
[177.039592] Subtest create: SUCCESS (0.000s)
[177.097699] [147/170] (825s left) vgem_basic (debugfs)
[177.154942] Starting subtest: debugfs
[177.156228] Subtest debugfs: SUCCESS (0.000s)
[177.207644] [148/170] (825s left) vgem_basic (dmabuf-export)
[177.271679] Starting subtest: dmabuf-export
[177.283154] Subtest dmabuf-export: SUCCESS (0.011s)
[177.367301] [149/170] (825s left) vgem_basic (dmabuf-fence)
[177.454942] Starting subtest: dmabuf-fence
[177.455843] Subtest dmabuf-fence: SUCCESS (0.000s)
[177.509067] [150/170] (824s left) vgem_basic (dmabuf-fence-before)
[177.571949] Starting subtest: dmabuf-fence-before
[177.573236] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[177.638089] [151/170] (824s left) vgem_basic (dmabuf-mmap)
[177.688056] Starting subtest: dmabuf-mmap
[177.695930] Subtest dmabuf-mmap: SUCCESS (0.008s)
[177.744277] [152/170] (824s left) vgem_basic (mmap)
[177.821869] Starting subtest: mmap
[177.826928] Subtest mmap: SUCCESS (0.006s)
[177.878017] [153/170] (824s left) vgem_basic (second-client)
[177.955575] Starting subtest: second-client
[178.005447] Subtest second-client: SUCCESS (0.050s)
[178.083235] [154/170] (824s left) vgem_basic (sysfs)
[178.154890] Starting subtest: sysfs
[178.156114] Subtest sysfs: SUCCESS (0.000s)
[178.211035] [155/170] (824s left) core_hotunplug (unbind-rebind)
[178.304606] Starting subtest: unbind-rebind
[180.293582] Subtest unbind-rebind: SUCCESS (1.989s)
[180.308554] [156/170] (822s left) vgem_basic (unload)
[180.359938] Starting subtest: unload
[209.336103] Subtest unload: SUCCESS (28.941s)
[209.407682] [157/170] (793s left) i915_module_load (reload)
[209.457739] Starting subtest: reload
[212.257957] Subtest reload: SUCCESS (2.800s)
[212.270608] [158/170] (790s left) gem_lmem_swapping (basic)
[215.301159] Starting subtest: basic
[215.301871] Starting dynamic subtest: lmem0
[232.223606] Dynamic subtest lmem0: SUCCESS (16.888s)
[232.224495] Subtest basic: SUCCESS (16.888s)
[233.930461] [159/170] (768s left) gem_lmem_swapping (parallel-random-engines)
[234.572356] Starting subtest: parallel-random-engines
[234.573150] Starting dynamic subtest: lmem0
[235.367182] Dynamic subtest lmem0: SUCCESS (0.794s)
[235.368012] Subtest parallel-random-engines: SUCCESS (0.795s)
[236.750564] [160/170] (765s left) gem_lmem_swapping (random-engines)
[237.372321] Starting subtest: random-engines
[237.374554] Starting dynamic subtest: lmem0
[238.100413] Dynamic subtest lmem0: SUCCESS (0.719s)
[238.101377] Subtest random-engines: SUCCESS (0.720s)
[239.442315] [161/170] (763s left) gem_lmem_swapping (verify-random)
[240.057628] Starting subtest: verify-random
[240.059196] Starting dynamic subtest: lmem0
[247.492855] Dynamic subtest lmem0: SUCCESS (7.426s)
[247.493714] Subtest verify-random: SUCCESS (7.427s)
[248.888107] [162/170] (753s left) i915_pm_rpm (module-reload)
[251.732469] Starting subtest: module-reload
[264.637661] Subtest module-reload: SUCCESS (12.897s)
[264.681969] [163/170] (738s left) i915_selftest (live)
[264.768568] Starting subtest: live
[264.769408] Starting dynamic subtest: sanitycheck
[266.177270] Dynamic subtest sanitycheck: SUCCESS (1.400s)
[266.182417] Starting dynamic subtest: uncore
[267.521443] Dynamic subtest uncore: SUCCESS (1.344s)
[267.526292] Starting dynamic subtest: workarounds
[271.946360] Dynamic subtest workarounds: SUCCESS (4.424s)
[271.953157] Starting dynamic subtest: gt_engines
[274.379267] Dynamic subtest gt_engines: SUCCESS (2.433s)
[274.385115] Starting dynamic subtest: gt_timelines
[301.793130] Dynamic subtest gt_timelines: SUCCESS (27.413s)
[301.799021] Starting dynamic subtest: gt_contexts
[303.232280] Dynamic subtest gt_contexts: SUCCESS (1.439s)
[303.238625] Starting dynamic subtest: gt_lrc
[310.970974] Dynamic subtest gt_lrc: SUCCESS (7.746s)
[310.976755] Starting dynamic subtest: gt_mocs
[314.831479] Dynamic subtest gt_mocs: SUCCESS (3.852s)
[314.838157] Starting dynamic subtest: gt_pm
[317.089296] Dynamic subtest gt_pm: SUCCESS (2.256s)
[317.098381] Starting dynamic subtest: gt_heartbeat
[318.644232] Dynamic subtest gt_heartbeat: SUCCESS (1.554s)
[318.650462] Starting dynamic subtest: gt_tlb
[330.687158] Dynamic subtest gt_tlb: SUCCESS (12.043s)
[330.693397] Starting dynamic subtest: requests
[348.023265] Dynamic subtest requests: SUCCESS (17.336s)
[348.028766] Starting dynamic subtest: migrate
[352.625375] Dynamic subtest migrate: SUCCESS (4.602s)
[352.631240] Starting dynamic subtest: active
[353.993336] Dynamic subtest active: SUCCESS (1.368s)
[353.999180] Starting dynamic subtest: objects
[356.215250] Dynamic subtest objects: SUCCESS (2.221s)
[356.221857] Starting dynamic subtest: mman
[364.588550] Dynamic subtest mman: SUCCESS (8.374s)
[364.593577] Starting dynamic subtest: dmabuf
[365.933972] Dynamic subtest dmabuf: SUCCESS (1.344s)
[365.938909] Starting dynamic subtest: vma
[367.304858] Dynamic subtest vma: SUCCESS (1.371s)
[367.309772] Starting dynamic subtest: coherency
[370.196906] Dynamic subtest coherency: SUCCESS (2.892s)
[370.202012] Starting dynamic subtest: gtt
[378.843261] Dynamic subtest gtt: SUCCESS (8.646s)
[378.849234] Starting dynamic subtest: gem
[380.243159] Dynamic subtest gem: SUCCESS (1.399s)
[380.249558] Starting dynamic subtest: evict
[383.773262] Dynamic subtest evict: SUCCESS (3.530s)
[383.779457] Starting dynamic subtest: hugepages
[400.370368] Dynamic subtest hugepages: SUCCESS (16.597s)
[400.375583] Starting dynamic subtest: gem_contexts
[439.875298] Dynamic subtest gem_contexts: SUCCESS (39.504s)
[439.881343] Starting dynamic subtest: client
[441.291582] Dynamic subtest client: SUCCESS (1.417s)
[441.297347] Starting dynamic subtest: gem_migrate
[445.967211] Dynamic subtest gem_migrate: SUCCESS (4.675s)
[445.972795] Starting dynamic subtest: reset
[447.410337] Dynamic subtest reset: SUCCESS (1.443s)
[447.416011] Starting dynamic subtest: memory_region
[450.264278] Dynamic subtest memory_region: SUCCESS (2.853s)
[450.270170] Starting dynamic subtest: hangcheck
[495.855219] Dynamic subtest hangcheck: SUCCESS (45.591s)
[495.860777] Starting dynamic subtest: execlists
[497.194044] Dynamic subtest execlists: SUCCESS (1.338s)
[497.199139] Starting dynamic subtest: ring_submission
[498.561229] Dynamic subtest ring_submission: SUCCESS (1.367s)
[498.567137] Starting dynamic subtest: perf
[500.011291] Dynamic subtest perf: SUCCESS (1.450s)
[500.016381] Starting dynamic subtest: slpc
[509.182363] Dynamic subtest slpc: SUCCESS (9.171s)
[509.188048] Starting dynamic subtest: guc
[511.928416] Dynamic subtest guc: SUCCESS (2.746s)
[511.934397] Starting dynamic subtest: guc_multi_lrc
[513.315124] Dynamic subtest guc_multi_lrc: SUCCESS (1.386s)
[513.320676] Starting dynamic subtest: guc_hang
[515.412160] Dynamic subtest guc_hang: SUCCESS (2.097s)
[515.417827] Starting dynamic subtest: late_gt_pm
[516.816321] Dynamic subtest late_gt_pm: SUCCESS (1.404s)
[516.817609] Subtest live: SUCCESS (252.039s)
[517.286669] [164/170] (485s left) dmabuf (all-tests)
[517.370047] Starting subtest: all-tests
[517.371266] Starting dynamic subtest: sanitycheck
[517.436564] Dynamic subtest sanitycheck: SUCCESS (0.066s)
[517.444542] Starting dynamic subtest: dma_fence
[517.616539] Dynamic subtest dma_fence: SUCCESS (0.179s)
[517.624378] Starting dynamic subtest: dma_fence_chain
[527.959425] Dynamic subtest dma_fence_chain: SUCCESS (10.342s)
[527.966853] Starting dynamic subtest: dma_fence_unwrap
[528.048103] Dynamic subtest dma_fence_unwrap: SUCCESS (0.088s)
[528.056041] Starting dynamic subtest: dma_resv
[528.119189] Dynamic subtest dma_resv: SUCCESS (0.070s)
[528.120892] Subtest all-tests: SUCCESS (10.749s)
[528.158126] [165/170] (474s left) i915_suspend (basic-s2idle-without-i915)
[528.228726] Starting subtest: basic-s2idle-without-i915
[547.252311] Subtest basic-s2idle-without-i915: SUCCESS (4.650s)
[547.389359] [166/170] (469s left) i915_suspend (basic-s3-without-i915)
[547.439896] Starting subtest: basic-s3-without-i915
[568.866951] Subtest basic-s3-without-i915: SUCCESS (5.584s)
[568.998037] [167/170] (464s left) gem_exec_suspend (basic-s0)
[569.072102] Starting subtest: basic-S0
[569.073053] Starting dynamic subtest: smem
[588.861304] Dynamic subtest smem: SUCCESS (4.452s)
[588.868927] Starting dynamic subtest: lmem0
[607.873152] Dynamic subtest lmem0: SUCCESS (4.522s)
[607.874564] Subtest basic-S0: SUCCESS (8.975s)
[608.049615] [168/170] (454s left) gem_exec_suspend (basic-s3)
[608.118388] Starting subtest: basic-S3
[608.119221] Starting dynamic subtest: smem
[629.233896] Dynamic subtest smem: SUCCESS (5.320s)
[629.241380] Starting dynamic subtest: lmem0
[650.206030] Dynamic subtest lmem0: SUCCESS (4.986s)
[650.206891] Subtest basic-S3: SUCCESS (10.307s)
[650.433929] [169/170] (444s left) kms_chamelium_hpd (common-hpd-after-suspend)
[650.623380] Subtest common-hpd-after-suspend: SKIP (0.000s)
[650.705760] [170/170] (444s left) kms_pipe_crc_basic (suspend-read-crc)
[650.792195] Starting subtest: suspend-read-crc
[650.793062] Starting dynamic subtest: pipe-A-DP-3
[669.826019] Dynamic subtest pipe-A-DP-3: SUCCESS (3.104s)
[669.835886] Starting dynamic subtest: pipe-B-DP-3
[688.815500] Dynamic subtest pipe-B-DP-3: SUCCESS (3.028s)
[688.824413] Starting dynamic subtest: pipe-C-DP-3
[707.881948] Dynamic subtest pipe-C-DP-3: SUCCESS (3.070s)
[707.891530] Starting dynamic subtest: pipe-D-DP-3
[726.938804] Dynamic subtest pipe-D-DP-3: SUCCESS (3.172s)
[726.939686] Subtest suspend-read-crc: SUCCESS (12.380s)
[727.052903] Closing watchdogs
Done.