[37.072437] Initializing watchdogs
[37.072533]   /dev/watchdog0
[37.079584] [001/171] (960s left) i915_module_load (load)
[37.162873] Starting subtest: load
[38.559470] Subtest load: SUCCESS (1.397s)
[38.575242] [002/171] (959s left) core_auth (basic-auth)
[38.719072] Starting subtest: basic-auth
[38.720149] Subtest basic-auth: SUCCESS (0.001s)
[38.782103] [003/171] (958s left) debugfs_test (read_all_entries)
[38.888065] Starting subtest: read_all_entries
[39.411400] Subtest read_all_entries: SUCCESS (0.522s)
[39.548534] [004/171] (958s left) debugfs_test (basic-hwmon)
[39.647562] Starting subtest: basic-hwmon
[39.652825] Subtest basic-hwmon: SUCCESS (0.004s)
[39.781585] [005/171] (957s left) fbdev (eof)
[39.876701] Starting subtest: eof
[39.877837] Subtest eof: SUCCESS (0.000s)
[39.946602] [006/171] (957s left) fbdev (info)
[40.022178] Starting subtest: info
[40.023298] Subtest info: SUCCESS (0.000s)
[40.097622] [007/171] (957s left) fbdev (nullptr)
[40.193179] Starting subtest: nullptr
[40.194306] Subtest nullptr: SUCCESS (0.000s)
[40.287129] [008/171] (957s left) fbdev (read)
[40.376609] Starting subtest: read
[52.788064] Subtest read: SUCCESS (12.377s)
[52.815750] [009/171] (944s left) fbdev (write)
[52.893416] Starting subtest: write
[59.038286] Subtest write: SUCCESS (6.136s)
[59.082625] [010/171] (938s left) gem_basic (bad-close)
[59.171016] Starting subtest: bad-close
[59.173063] Subtest bad-close: SUCCESS (0.000s)
[59.234454] [011/171] (938s left) gem_basic (create-close)
[59.325213] Starting subtest: create-close
[59.327256] Subtest create-close: SUCCESS (0.000s)
[59.431358] [012/171] (938s left) gem_basic (create-fd-close)
[59.548086] Starting subtest: create-fd-close
[59.549981] Subtest create-fd-close: SUCCESS (0.000s)
[59.653100] [013/171] (938s left) gem_busy (busy@all-engines)
[59.779604] Starting subtest: busy
[59.780744] Starting dynamic subtest: all-engines
[59.911836] Dynamic subtest all-engines: SUCCESS (0.132s)
[59.912827] Subtest busy: SUCCESS (0.132s)
[60.362565] [014/171] (937s left) gem_close_race (basic-process)
[60.515121] Starting subtest: basic-process
[60.563286] Subtest basic-process: SUCCESS (0.048s)
[60.796233] [015/171] (937s left) gem_close_race (basic-threads)
[60.924656] Starting subtest: basic-threads
[62.140439] Subtest basic-threads: SUCCESS (1.216s)
[62.390038] [016/171] (935s left) gem_ctx_create (basic)
[62.496584] Starting subtest: basic
[62.497601] Subtest basic: SUCCESS (0.000s)
[62.689260] [017/171] (935s left) gem_ctx_create (basic-files)
[62.792258] Starting subtest: basic-files
[64.807948] Subtest basic-files: SUCCESS (2.016s)
[65.175279] [018/171] (932s left) gem_ctx_exec (basic)
[65.270761] Starting subtest: basic
[65.275673] Subtest basic: SUCCESS (0.005s)
[65.381337] [019/171] (932s left) gem_exec_basic (basic)
[65.491155] Starting subtest: basic
[65.492235] Starting dynamic subtest: rcs0-smem
[65.494430] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[65.500693] Starting dynamic subtest: bcs0-smem
[65.507086] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[65.512990] Starting dynamic subtest: vcs0-smem
[65.514097] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[65.519967] Starting dynamic subtest: vcs1-smem
[65.521110] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[65.526955] Starting dynamic subtest: vecs0-smem
[65.528117] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[65.534059] Starting dynamic subtest: vecs1-smem
[65.535172] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[65.540994] Starting dynamic subtest: ccs0-smem
[65.542058] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[65.548040] Starting dynamic subtest: ccs1-smem
[65.549165] Dynamic subtest ccs1-smem: SUCCESS (0.001s)
[65.555067] Starting dynamic subtest: ccs2-smem
[65.556179] Dynamic subtest ccs2-smem: SUCCESS (0.001s)
[65.561910] Starting dynamic subtest: ccs3-smem
[65.562817] Dynamic subtest ccs3-smem: SUCCESS (0.001s)
[65.568776] Starting dynamic subtest: rcs0-lmem0
[65.569932] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[65.575887] Starting dynamic subtest: bcs0-lmem0
[65.577054] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[65.583045] Starting dynamic subtest: vcs0-lmem0
[65.584165] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[65.590108] Starting dynamic subtest: vcs1-lmem0
[65.591195] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[65.596965] Starting dynamic subtest: vecs0-lmem0
[65.598145] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[65.604097] Starting dynamic subtest: vecs1-lmem0
[65.605223] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[65.611052] Starting dynamic subtest: ccs0-lmem0
[65.612058] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[65.618063] Starting dynamic subtest: ccs1-lmem0
[65.619176] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[65.624892] Starting dynamic subtest: ccs2-lmem0
[65.625908] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[65.632149] Starting dynamic subtest: ccs3-lmem0
[65.633236] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[65.634326] Subtest basic: SUCCESS (0.015s)
[65.682974] [020/171] (932s left) gem_exec_create (basic)
[65.793086] Starting subtest: basic
[65.794045] Starting dynamic subtest: smem
[67.899709] Dynamic subtest smem: SUCCESS (2.108s)
[67.908112] Starting dynamic subtest: lmem0
[70.039374] Dynamic subtest lmem0: SUCCESS (2.139s)
[70.040434] Subtest basic: SUCCESS (4.247s)
[70.220357] [021/171] (927s left) gem_exec_fence (basic-busy)
[70.500745] Starting subtest: basic-busy
[70.501743] Starting dynamic subtest: rcs0
[70.593993] Dynamic subtest rcs0: SUCCESS (0.101s)
[70.609114] Starting dynamic subtest: bcs0
[70.646671] Dynamic subtest bcs0: SUCCESS (0.051s)
[70.673469] Starting dynamic subtest: vcs0
[70.708614] Dynamic subtest vcs0: SUCCESS (0.061s)
[70.734433] Starting dynamic subtest: vcs1
[70.771373] Dynamic subtest vcs1: SUCCESS (0.062s)
[70.797731] Starting dynamic subtest: vecs0
[70.834350] Dynamic subtest vecs0: SUCCESS (0.062s)
[70.861280] Starting dynamic subtest: vecs1
[70.902581] Dynamic subtest vecs1: SUCCESS (0.067s)
[70.928575] Starting dynamic subtest: ccs0
[70.962173] Dynamic subtest ccs0: SUCCESS (0.059s)
[70.988333] Starting dynamic subtest: ccs1
[71.019077] Dynamic subtest ccs1: SUCCESS (0.056s)
[71.042885] Starting dynamic subtest: ccs2
[71.071652] Dynamic subtest ccs2: SUCCESS (0.052s)
[71.093667] Starting dynamic subtest: ccs3
[71.126471] Dynamic subtest ccs3: SUCCESS (0.054s)
[71.129052] Subtest basic-busy: SUCCESS (0.633s)
[72.383572] [022/171] (925s left) gem_exec_fence (basic-wait)
[72.619207] Starting subtest: basic-wait
[72.620321] Starting dynamic subtest: rcs0
[72.717256] Dynamic subtest rcs0: SUCCESS (0.106s)
[72.745980] Starting dynamic subtest: bcs0
[72.779816] Dynamic subtest bcs0: SUCCESS (0.062s)
[72.807441] Starting dynamic subtest: vcs0
[72.835809] Dynamic subtest vcs0: SUCCESS (0.056s)
[72.850485] Starting dynamic subtest: vcs1
[72.893089] Dynamic subtest vcs1: SUCCESS (0.056s)
[72.924033] Starting dynamic subtest: vecs0
[72.948975] Dynamic subtest vecs0: SUCCESS (0.056s)
[72.965187] Starting dynamic subtest: vecs1
[73.004822] Dynamic subtest vecs1: SUCCESS (0.055s)
[73.037388] Starting dynamic subtest: ccs0
[73.065805] Dynamic subtest ccs0: SUCCESS (0.061s)
[73.079149] Starting dynamic subtest: ccs1
[73.119755] Dynamic subtest ccs1: SUCCESS (0.053s)
[73.152237] Starting dynamic subtest: ccs2
[73.181921] Dynamic subtest ccs2: SUCCESS (0.062s)
[73.195306] Starting dynamic subtest: ccs3
[73.233570] Dynamic subtest ccs3: SUCCESS (0.050s)
[73.236144] Subtest basic-wait: SUCCESS (0.622s)
[74.478986] [023/171] (923s left) gem_exec_fence (basic-await)
[74.758772] Starting subtest: basic-await
[74.759761] Starting dynamic subtest: rcs0
[74.897638] Dynamic subtest rcs0: SUCCESS (0.147s)
[74.903794] Starting dynamic subtest: bcs0
[75.012899] Dynamic subtest bcs0: SUCCESS (0.115s)
[75.019739] Starting dynamic subtest: vcs0
[75.128755] Dynamic subtest vcs0: SUCCESS (0.116s)
[75.134954] Starting dynamic subtest: vcs1
[75.243181] Dynamic subtest vcs1: SUCCESS (0.114s)
[75.249321] Starting dynamic subtest: vecs0
[75.358056] Dynamic subtest vecs0: SUCCESS (0.115s)
[75.364254] Starting dynamic subtest: vecs1
[75.474387] Dynamic subtest vecs1: SUCCESS (0.116s)
[75.480908] Starting dynamic subtest: ccs0
[75.591175] Dynamic subtest ccs0: SUCCESS (0.117s)
[75.597378] Starting dynamic subtest: ccs1
[75.706788] Dynamic subtest ccs1: SUCCESS (0.115s)
[75.714119] Starting dynamic subtest: ccs2
[75.830386] Dynamic subtest ccs2: SUCCESS (0.123s)
[75.836702] Starting dynamic subtest: ccs3
[75.944556] Dynamic subtest ccs3: SUCCESS (0.114s)
[75.945596] Subtest basic-await: SUCCESS (1.195s)
[77.253632] [024/171] (920s left) gem_exec_fence (nb-await)
[77.491847] Starting subtest: nb-await
[77.493059] Starting dynamic subtest: rcs0
[77.587231] Dynamic subtest rcs0: SUCCESS (0.104s)
[77.597142] Starting dynamic subtest: bcs0
[77.666463] Dynamic subtest bcs0: SUCCESS (0.078s)
[77.675735] Starting dynamic subtest: vcs0
[77.736977] Dynamic subtest vcs0: SUCCESS (0.071s)
[77.750317] Starting dynamic subtest: vcs1
[77.824310] Dynamic subtest vcs1: SUCCESS (0.086s)
[77.851634] Starting dynamic subtest: vecs0
[77.927274] Dynamic subtest vecs0: SUCCESS (0.104s)
[77.938582] Starting dynamic subtest: vecs1
[77.997605] Dynamic subtest vecs1: SUCCESS (0.070s)
[78.013938] Starting dynamic subtest: ccs0
[78.094321] Dynamic subtest ccs0: SUCCESS (0.094s)
[78.120350] Starting dynamic subtest: ccs1
[78.192295] Dynamic subtest ccs1: SUCCESS (0.099s)
[78.204198] Starting dynamic subtest: ccs2
[78.277249] Dynamic subtest ccs2: SUCCESS (0.084s)
[78.304458] Starting dynamic subtest: ccs3
[78.375041] Dynamic subtest ccs3: SUCCESS (0.098s)
[78.376475] Subtest nb-await: SUCCESS (0.892s)
[79.562725] [025/171] (918s left) gem_exec_gttfill (basic)
[79.670236] Starting subtest: basic
[86.952997] Subtest basic: SUCCESS (7.274s)
[87.234243] [026/171] (910s left) gem_exec_parallel (engines)
[87.390114] Starting subtest: engines
[87.391188] Starting dynamic subtest: basic
[89.347765] Dynamic subtest basic: SUCCESS (1.958s)
[89.356461] Starting dynamic subtest: contexts
[92.542492] Dynamic subtest contexts: SUCCESS (3.186s)
[92.549555] Starting dynamic subtest: fds
[95.913179] Dynamic subtest fds: SUCCESS (3.370s)
[95.919928] Starting dynamic subtest: userptr
[97.662210] Dynamic subtest userptr: SUCCESS (1.757s)
[97.663379] Subtest engines: SUCCESS (10.272s)
[97.969839] [027/171] (900s left) gem_exec_store (basic)
[98.094169] Starting subtest: basic
[98.245270] Subtest basic: SUCCESS (0.151s)
[98.500274] [028/171] (899s left) gem_flink_basic (bad-flink)
[98.591146] Starting subtest: bad-flink
[98.592131] Subtest bad-flink: SUCCESS (0.000s)
[98.649739] [029/171] (899s left) gem_flink_basic (bad-open)
[98.742179] Starting subtest: bad-open
[98.743261] Subtest bad-open: SUCCESS (0.000s)
[98.805648] [030/171] (899s left) gem_flink_basic (basic)
[98.900174] Starting subtest: basic
[98.901255] Subtest basic: SUCCESS (0.000s)
[99.003406] [031/171] (899s left) gem_flink_basic (double-flink)
[99.127350] Starting subtest: double-flink
[99.128410] Subtest double-flink: SUCCESS (0.000s)
[99.269459] [032/171] (898s left) gem_flink_basic (flink-lifetime)
[99.385225] Starting subtest: flink-lifetime
[99.387498] Subtest flink-lifetime: SUCCESS (0.002s)
[99.521819] [033/171] (898s left) gem_huc_copy (huc-copy)
[99.665361] Starting subtest: huc-copy
[99.673013] Subtest huc-copy: SUCCESS (0.008s)
[99.792016] [034/171] (898s left) gem_linear_blits (basic)
[100.011399] Starting subtest: basic
[100.051020] Subtest basic: SUCCESS (0.040s)
[100.196321] [035/171] (898s left) gem_mmap (basic)
[100.339539] Subtest basic: SKIP (0.000s)
[100.370187] [036/171] (897s left) gem_mmap_gtt (basic)
[100.464575] Subtest basic: SKIP (0.000s)
[100.503634] [037/171] (897s left) gem_render_linear_blits (basic)
[100.604175] Starting subtest: basic
[100.684573] Subtest basic: SUCCESS (0.081s)
[100.753653] [038/171] (897s left) gem_render_tiled_blits (basic)
[100.855409] Subtest basic: SKIP (0.000s)
[100.886998] [039/171] (897s left) gem_ringfill (basic-all)
[101.337280] Starting subtest: basic-all
[105.668643] Subtest basic-all: SUCCESS (4.321s)
[105.806115] [040/171] (892s left) gem_softpin (allocator-basic)
[105.913238] Starting subtest: allocator-basic
[106.178876] Subtest allocator-basic: SUCCESS (0.260s)
[106.300610] [041/171] (892s left) gem_softpin (allocator-basic-reserve)
[106.418118] Starting subtest: allocator-basic-reserve
[106.684918] Subtest allocator-basic-reserve: SUCCESS (0.258s)
[106.832787] [042/171] (891s left) gem_softpin (safe-alignment)
[106.938176] Starting subtest: safe-alignment
[107.006350] Subtest safe-alignment: SUCCESS (0.068s)
[107.148835] [043/171] (891s left) gem_sync (basic-all)
[107.267650] Starting subtest: basic-all
[110.974841] Subtest basic-all: SUCCESS (3.707s)
[111.184537] [044/171] (887s left) gem_sync (basic-each)
[111.294396] Starting subtest: basic-each
[113.914417] Subtest basic-each: SUCCESS (2.620s)
[114.086903] [045/171] (884s left) gem_tiled_blits (basic)
[114.188828] Subtest basic: SKIP (0.000s)
[114.220506] [046/171] (884s left) gem_tiled_fence_blits (basic)
[114.323725] Subtest basic: SKIP (0.000s)
[114.353612] [047/171] (884s left) gem_tiled_pread_basic
[114.487211] [048/171] (884s left) gem_wait (busy@all-engines)
[114.602929] Starting subtest: busy
[114.604153] Starting dynamic subtest: all-engines
[115.202247] Dynamic subtest all-engines: SUCCESS (0.599s)
[115.203276] Subtest busy: SUCCESS (0.600s)
[115.469313] [049/171] (883s left) gem_wait (wait@all-engines)
[115.581475] Starting subtest: wait
[115.582500] Starting dynamic subtest: all-engines
[116.684297] Dynamic subtest all-engines: SUCCESS (1.103s)
[116.685377] Subtest wait: SUCCESS (1.103s)
[116.947672] [050/171] (881s left) i915_getparams_basic (basic-eu-total)
[117.039037] Starting subtest: basic-eu-total
[117.041087] Subtest basic-eu-total: SUCCESS (0.000s)
[117.111797] [051/171] (881s left) i915_getparams_basic (basic-subslice-total)
[117.222478] Starting subtest: basic-subslice-total
[117.224515] Subtest basic-subslice-total: SUCCESS (0.000s)
[117.287424] [052/171] (881s left) i915_hangman (error-state-basic)
[117.399677] Starting subtest: error-state-basic
[117.602578] Subtest error-state-basic: SUCCESS (0.200s)
[117.705460] [053/171] (880s left) i915_pciid
[117.905463] [054/171] (880s left) kms_addfb_basic (addfb25-bad-modifier)
[118.002817] Starting subtest: addfb25-bad-modifier
[118.003791] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[118.175891] [055/171] (880s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[118.269237] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[118.418500] [056/171] (880s left) kms_addfb_basic (addfb25-modifier-no-flag)
[118.512144] Starting subtest: addfb25-modifier-no-flag
[118.513198] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[118.668237] [057/171] (880s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[118.760765] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[118.918673] [058/171] (879s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[119.014240] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[119.151749] [059/171] (879s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[119.307953] Starting subtest: addfb25-yf-tiled-legacy
[119.308959] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[119.401782] [060/171] (879s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[119.558749] Starting subtest: addfb25-y-tiled-legacy
[119.559739] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[119.635533] [061/171] (879s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[119.792018] Starting subtest: addfb25-y-tiled-small-legacy
[119.794063] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[119.868469] [062/171] (878s left) kms_addfb_basic (bad-pitch-0)
[119.961983] Starting subtest: bad-pitch-0
[119.963072] Subtest bad-pitch-0: SUCCESS (0.000s)
[120.101971] [063/171] (878s left) kms_addfb_basic (bad-pitch-1024)
[120.194214] Starting subtest: bad-pitch-1024
[120.195302] Subtest bad-pitch-1024: SUCCESS (0.000s)
[120.351787] [064/171] (878s left) kms_addfb_basic (bad-pitch-128)
[120.443208] Starting subtest: bad-pitch-128
[120.444244] Subtest bad-pitch-128: SUCCESS (0.000s)
[120.601798] [065/171] (878s left) kms_addfb_basic (bad-pitch-256)
[120.695154] Starting subtest: bad-pitch-256
[120.696181] Subtest bad-pitch-256: SUCCESS (0.000s)
[120.851791] [066/171] (878s left) kms_addfb_basic (bad-pitch-32)
[120.945317] Starting subtest: bad-pitch-32
[120.946374] Subtest bad-pitch-32: SUCCESS (0.000s)
[121.101857] [067/171] (877s left) kms_addfb_basic (bad-pitch-63)
[121.193216] Starting subtest: bad-pitch-63
[121.194284] Subtest bad-pitch-63: SUCCESS (0.000s)
[121.352027] [068/171] (877s left) kms_addfb_basic (bad-pitch-65536)
[121.445173] Starting subtest: bad-pitch-65536
[121.446204] Subtest bad-pitch-65536: SUCCESS (0.000s)
[121.602080] [069/171] (877s left) kms_addfb_basic (bad-pitch-999)
[121.694452] Starting subtest: bad-pitch-999
[121.695541] Subtest bad-pitch-999: SUCCESS (0.000s)
[121.851876] [070/171] (877s left) kms_addfb_basic (basic)
[121.945303] Starting subtest: basic
[121.946370] Subtest basic: SUCCESS (0.000s)
[122.101532] [071/171] (876s left) kms_addfb_basic (basic-x-tiled-legacy)
[122.197428] Starting subtest: basic-x-tiled-legacy
[122.199462] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[122.335286] [072/171] (876s left) kms_addfb_basic (basic-y-tiled-legacy)
[122.430916] Starting subtest: basic-y-tiled-legacy
[122.432703] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[122.585258] [073/171] (876s left) kms_addfb_basic (bo-too-small)
[122.741896] Starting subtest: bo-too-small
[122.742980] Subtest bo-too-small: SUCCESS (0.000s)
[122.819019] [074/171] (876s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[122.975541] Starting subtest: bo-too-small-due-to-tiling
[122.977338] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[123.052123] [075/171] (875s left) kms_addfb_basic (clobberred-modifier)
[123.144984] Starting subtest: clobberred-modifier
[123.146928] Subtest clobberred-modifier: SKIP (0.000s)
[123.301985] [076/171] (875s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[123.395358] Starting subtest: framebuffer-vs-set-tiling
[123.397354] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[123.535924] [077/171] (875s left) kms_addfb_basic (invalid-get-prop)
[123.629541] Starting subtest: invalid-get-prop
[123.630497] Subtest invalid-get-prop: SUCCESS (0.000s)
[123.768645] [078/171] (875s left) kms_addfb_basic (invalid-get-prop-any)
[123.862015] Starting subtest: invalid-get-prop-any
[123.863049] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[124.019102] [079/171] (875s left) kms_addfb_basic (invalid-set-prop)
[124.111167] Starting subtest: invalid-set-prop
[124.112223] Subtest invalid-set-prop: SUCCESS (0.000s)
[124.268658] [080/171] (874s left) kms_addfb_basic (invalid-set-prop-any)
[124.363312] Starting subtest: invalid-set-prop-any
[124.364376] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[124.501701] [081/171] (874s left) kms_addfb_basic (no-handle)
[124.593978] Starting subtest: no-handle
[124.594946] Subtest no-handle: SUCCESS (0.000s)
[124.735465] [082/171] (874s left) kms_addfb_basic (size-max)
[124.894399] Starting subtest: size-max
[124.895384] Subtest size-max: SUCCESS (0.000s)
[124.968755] [083/171] (874s left) kms_addfb_basic (small-bo)
[125.124708] Starting subtest: small-bo
[125.125787] Subtest small-bo: SUCCESS (0.000s)
[125.201910] [084/171] (873s left) kms_addfb_basic (tile-pitch-mismatch)
[125.295970] Starting subtest: tile-pitch-mismatch
[125.298063] Subtest tile-pitch-mismatch: SKIP (0.000s)
[125.452328] [085/171] (873s left) kms_addfb_basic (too-high)
[125.610632] Starting subtest: too-high
[125.611662] Subtest too-high: SUCCESS (0.001s)
[125.702613] [086/171] (873s left) kms_addfb_basic (too-wide)
[125.860565] Starting subtest: too-wide
[125.861578] Subtest too-wide: SUCCESS (0.000s)
[125.951882] [087/171] (873s left) kms_addfb_basic (unused-handle)
[126.045292] Starting subtest: unused-handle
[126.046355] Subtest unused-handle: SUCCESS (0.000s)
[126.185505] [088/171] (873s left) kms_addfb_basic (unused-modifier)
[126.280217] Starting subtest: unused-modifier
[126.281284] Subtest unused-modifier: SUCCESS (0.000s)
[126.418562] [089/171] (872s left) kms_addfb_basic (unused-offsets)
[126.510165] Starting subtest: unused-offsets
[126.511240] Subtest unused-offsets: SUCCESS (0.000s)
[126.652024] [090/171] (872s left) kms_addfb_basic (unused-pitches)
[126.746295] Starting subtest: unused-pitches
[126.747399] Subtest unused-pitches: SUCCESS (0.000s)
[126.885630] [091/171] (872s left) kms_busy (basic)
[127.048853] Starting subtest: basic
[127.049961] Starting dynamic subtest: flip
[127.786991] Dynamic subtest flip: SUCCESS (0.737s)
[127.795068] Starting dynamic subtest: modeset
[128.771356] Dynamic subtest modeset: SUCCESS (0.984s)
[128.772428] Subtest basic: SUCCESS (1.722s)
[129.010555] [092/171] (870s left) kms_chamelium_hpd (dp-hpd-fast)
[129.247227] Subtest dp-hpd-fast: SKIP (0.000s)
[129.389965] [093/171] (869s left) kms_chamelium_edid (dp-edid-read)
[129.634059] Subtest dp-edid-read: SKIP (0.000s)
[129.772510] [094/171] (869s left) kms_chamelium_frames (dp-crc-fast)
[130.003511] Subtest dp-crc-fast: SKIP (0.000s)
[130.171221] [095/171] (869s left) kms_chamelium_hpd (hdmi-hpd-fast)
[130.402538] Subtest hdmi-hpd-fast: SKIP (0.000s)
[130.542034] [096/171] (868s left) kms_chamelium_edid (hdmi-edid-read)
[130.772996] Subtest hdmi-edid-read: SKIP (0.000s)
[130.912074] [097/171] (868s left) kms_chamelium_frames (hdmi-crc-fast)
[131.142248] Subtest hdmi-crc-fast: SKIP (0.000s)
[131.281105] [098/171] (868s left) kms_chamelium_hpd (vga-hpd-fast)
[131.511825] Subtest vga-hpd-fast: SKIP (0.000s)
[131.651337] [099/171] (867s left) kms_chamelium_edid (vga-edid-read)
[131.880955] Subtest vga-edid-read: SKIP (0.000s)
[132.019245] [100/171] (867s left) kms_prop_blob (basic)
[132.113198] Starting subtest: basic
[132.114277] Subtest basic: SUCCESS (0.000s)
[132.179915] [101/171] (867s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[132.335665] Starting subtest: basic-busy-flip-before-cursor-atomic
[132.337754] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[132.396558] [102/171] (867s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[132.551504] Starting subtest: basic-busy-flip-before-cursor-legacy
[132.553542] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[132.613409] [103/171] (866s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[132.769144] Starting subtest: basic-flip-after-cursor-atomic
[133.832319] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.062s)
[134.047389] [104/171] (865s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[134.206651] Starting subtest: basic-flip-after-cursor-legacy
[135.282613] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.075s)
[135.492119] [105/171] (864s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[135.649965] Starting subtest: basic-flip-after-cursor-varying-size
[136.725164] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.076s)
[136.933439] [106/171] (862s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[137.089913] Starting subtest: basic-flip-before-cursor-atomic
[138.167121] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.078s)
[138.374101] [107/171] (861s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[138.530988] Starting subtest: basic-flip-before-cursor-legacy
[139.606982] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.077s)
[139.830033] [108/171] (859s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[139.990075] Starting subtest: basic-flip-before-cursor-varying-size
[141.062728] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.074s)
[141.286296] [109/171] (858s left) kms_flip (basic-flip-vs-dpms)
[141.427601] Starting subtest: basic-flip-vs-dpms
[141.431972] Starting dynamic subtest: A-DP1
[142.376941] Dynamic subtest A-DP1: SUCCESS (0.944s)
[142.384895] Starting dynamic subtest: B-DP1
[143.295859] Dynamic subtest B-DP1: SUCCESS (0.919s)
[143.306582] Starting dynamic subtest: C-DP1
[144.216772] Dynamic subtest C-DP1: SUCCESS (0.919s)
[144.227243] Starting dynamic subtest: D-DP1
[145.131806] Dynamic subtest D-DP1: SUCCESS (0.914s)
[145.136139] Subtest basic-flip-vs-dpms: SUCCESS (3.711s)
[145.359718] [110/171] (854s left) kms_flip (basic-flip-vs-modeset)
[145.500879] Starting subtest: basic-flip-vs-modeset
[145.504912] Starting dynamic subtest: A-DP1
[146.422869] Dynamic subtest A-DP1: SUCCESS (0.916s)
[146.433589] Starting dynamic subtest: B-DP1
[147.350519] Dynamic subtest B-DP1: SUCCESS (0.927s)
[147.358732] Starting dynamic subtest: C-DP1
[148.275199] Dynamic subtest C-DP1: SUCCESS (0.925s)
[148.285246] Starting dynamic subtest: D-DP1
[149.049413] Dynamic subtest D-DP1: SUCCESS (0.773s)
[149.054622] Subtest basic-flip-vs-modeset: SUCCESS (3.556s)
[149.281941] [111/171] (850s left) kms_flip (basic-flip-vs-wf_vblank)
[149.424537] Starting subtest: basic-flip-vs-wf_vblank
[149.430202] Starting dynamic subtest: A-DP1
[150.649499] Dynamic subtest A-DP1: SUCCESS (1.219s)
[150.659566] Starting dynamic subtest: B-DP1
[151.778285] Dynamic subtest B-DP1: SUCCESS (1.127s)
[151.788524] Starting dynamic subtest: C-DP1
[152.903174] Dynamic subtest C-DP1: SUCCESS (1.123s)
[152.913262] Starting dynamic subtest: D-DP1
[154.027248] Dynamic subtest D-DP1: SUCCESS (1.123s)
[154.032680] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.609s)
[154.300198] [112/171] (845s left) kms_flip (basic-plain-flip)
[154.441569] Starting subtest: basic-plain-flip
[154.446739] Starting dynamic subtest: A-DP1
[155.381644] Dynamic subtest A-DP1: SUCCESS (0.935s)
[155.391596] Starting dynamic subtest: B-DP1
[156.225991] Dynamic subtest B-DP1: SUCCESS (0.843s)
[156.235660] Starting dynamic subtest: C-DP1
[157.065880] Dynamic subtest C-DP1: SUCCESS (0.838s)
[157.076026] Starting dynamic subtest: D-DP1
[157.902923] Dynamic subtest D-DP1: SUCCESS (0.836s)
[157.908526] Subtest basic-plain-flip: SUCCESS (3.468s)
[158.174048] [113/171] (841s left) kms_force_connector_basic (force-connector-state)
[158.275115] Starting subtest: force-connector-state
[158.858414] Subtest force-connector-state: SUCCESS (0.585s)
[159.146173] [114/171] (840s left) kms_force_connector_basic (force-edid)
[159.243727] Starting subtest: force-edid
[159.263117] Subtest force-edid: SUCCESS (0.018s)
[159.430638] [115/171] (840s left) kms_force_connector_basic (force-load-detect)
[159.526452] Starting subtest: force-load-detect
[159.528408] Subtest force-load-detect: SKIP (0.000s)
[159.646120] [116/171] (840s left) kms_force_connector_basic (prune-stale-modes)
[159.744352] Starting subtest: prune-stale-modes
[159.754097] Subtest prune-stale-modes: SKIP (0.009s)
[159.929226] [117/171] (839s left) kms_frontbuffer_tracking (basic)
[160.093486] Starting subtest: basic
[164.139591] Subtest basic: SUCCESS (4.047s)
[164.262353] [118/171] (835s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[164.420608] Starting subtest: compare-crc-sanitycheck-xr24
[164.421679] Starting dynamic subtest: pipe-A-DP-1
[165.029587] Dynamic subtest pipe-A-DP-1: SUCCESS (0.608s)
[165.043157] Starting dynamic subtest: pipe-B-DP-1
[165.883201] Dynamic subtest pipe-B-DP-1: FAIL (0.783s)
[165.893541] Starting dynamic subtest: pipe-C-DP-1
[166.562825] Dynamic subtest pipe-C-DP-1: SUCCESS (0.744s)
[166.573868] Starting dynamic subtest: pipe-D-DP-1
[167.287751] Dynamic subtest pipe-D-DP-1: SUCCESS (0.722s)
[167.288773] Subtest compare-crc-sanitycheck-xr24: FAIL (2.869s)
[167.487671] [119/171] (832s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[167.646394] Starting subtest: compare-crc-sanitycheck-nv12
[167.647460] Starting dynamic subtest: pipe-A-DP-1
[168.887123] Dynamic subtest pipe-A-DP-1: SUCCESS (1.240s)
[168.897468] Starting dynamic subtest: pipe-B-DP-1
[170.200164] Dynamic subtest pipe-B-DP-1: SUCCESS (1.310s)
[170.210553] Starting dynamic subtest: pipe-C-DP-1
[171.406507] Dynamic subtest pipe-C-DP-1: SUCCESS (1.204s)
[171.416377] Starting dynamic subtest: pipe-D-DP-1
[172.723032] Dynamic subtest pipe-D-DP-1: SUCCESS (1.314s)
[172.723965] Subtest compare-crc-sanitycheck-nv12: SUCCESS (5.079s)
[172.934628] [120/171] (826s left) kms_pipe_crc_basic (hang-read-crc)
[173.092492] Starting subtest: hang-read-crc
[173.095225] Starting dynamic subtest: pipe-A-DP-1
[174.616351] Dynamic subtest pipe-A-DP-1: SUCCESS (1.522s)
[174.626519] Starting dynamic subtest: pipe-B-DP-1
[176.183125] Dynamic subtest pipe-B-DP-1: SUCCESS (1.564s)
[176.193420] Starting dynamic subtest: pipe-C-DP-1
[177.897793] Dynamic subtest pipe-C-DP-1: SUCCESS (1.713s)
[177.908182] Starting dynamic subtest: pipe-D-DP-1
[179.746441] Dynamic subtest pipe-D-DP-1: SUCCESS (1.846s)
[179.747332] Subtest hang-read-crc: SUCCESS (6.655s)
[179.957959] [121/171] (819s left) kms_pipe_crc_basic (nonblocking-crc)
[180.120855] Starting subtest: nonblocking-crc
[180.123800] Starting dynamic subtest: pipe-A-DP-1
[180.806916] Dynamic subtest pipe-A-DP-1: SUCCESS (0.684s)
[180.817225] Starting dynamic subtest: pipe-B-DP-1
[181.555436] Dynamic subtest pipe-B-DP-1: SUCCESS (0.746s)
[181.565352] Starting dynamic subtest: pipe-C-DP-1
[182.350889] Dynamic subtest pipe-C-DP-1: SUCCESS (0.792s)
[182.360962] Starting dynamic subtest: pipe-D-DP-1
[183.213481] Dynamic subtest pipe-D-DP-1: SUCCESS (0.861s)
[183.214438] Subtest nonblocking-crc: SUCCESS (3.094s)
[183.414382] [122/171] (816s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[183.571716] Starting subtest: nonblocking-crc-frame-sequence
[183.574511] Starting dynamic subtest: pipe-A-DP-1
[184.281936] Dynamic subtest pipe-A-DP-1: SUCCESS (0.707s)
[184.292189] Starting dynamic subtest: pipe-B-DP-1
[185.032444] Dynamic subtest pipe-B-DP-1: SUCCESS (0.749s)
[185.043262] Starting dynamic subtest: pipe-C-DP-1
[185.835362] Dynamic subtest pipe-C-DP-1: SUCCESS (0.798s)
[185.844992] Starting dynamic subtest: pipe-D-DP-1
[186.713647] Dynamic subtest pipe-D-DP-1: SUCCESS (0.876s)
[186.714596] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.142s)
[186.917571] [123/171] (812s left) kms_pipe_crc_basic (read-crc)
[187.084287] Starting subtest: read-crc
[187.085315] Starting dynamic subtest: pipe-A-DP-1
[187.717164] Dynamic subtest pipe-A-DP-1: SUCCESS (0.633s)
[187.733525] Starting dynamic subtest: pipe-B-DP-1
[188.381016] Dynamic subtest pipe-B-DP-1: SUCCESS (0.661s)
[188.391166] Starting dynamic subtest: pipe-C-DP-1
[189.114029] Dynamic subtest pipe-C-DP-1: SUCCESS (0.730s)
[189.124284] Starting dynamic subtest: pipe-D-DP-1
[189.911995] Dynamic subtest pipe-D-DP-1: SUCCESS (0.795s)
[189.913172] Subtest read-crc: SUCCESS (2.830s)
[190.110369] [124/171] (809s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[190.268275] Starting subtest: read-crc-frame-sequence
[190.269351] Starting dynamic subtest: pipe-A-DP-1
[190.892666] Dynamic subtest pipe-A-DP-1: SUCCESS (0.624s)
[190.902866] Starting dynamic subtest: pipe-B-DP-1
[191.555682] Dynamic subtest pipe-B-DP-1: SUCCESS (0.660s)
[191.566288] Starting dynamic subtest: pipe-C-DP-1
[192.286458] Dynamic subtest pipe-C-DP-1: SUCCESS (0.728s)
[192.297084] Starting dynamic subtest: pipe-D-DP-1
[193.082811] Dynamic subtest pipe-D-DP-1: SUCCESS (0.793s)
[193.083806] Subtest read-crc-frame-sequence: SUCCESS (2.816s)
[193.289513] [125/171] (806s left) kms_psr (primary_page_flip)
[193.387934] Subtest primary_page_flip: SKIP (0.000s)
[193.426160] [126/171] (806s left) kms_psr (cursor_plane_move)
[193.521417] Subtest cursor_plane_move: SKIP (0.000s)
[193.559422] [127/171] (806s left) kms_psr (sprite_plane_onoff)
[193.654714] Subtest sprite_plane_onoff: SKIP (0.000s)
[193.692820] [128/171] (806s left) kms_psr (primary_mmap_gtt)
[193.788931] Subtest primary_mmap_gtt: SKIP (0.000s)
[193.825699] [129/171] (806s left) kms_setmode (basic-clone-single-crtc)
[193.920672] Starting subtest: basic-clone-single-crtc
[193.923504] Subtest basic-clone-single-crtc: SKIP (0.001s)
[193.989189] [130/171] (806s left) i915_pm_backlight (basic-brightness)
[194.145722] Subtest basic-brightness: SKIP (0.000s)
[194.175898] [131/171] (805s left) i915_pm_rpm (basic-pci-d3-state)
[196.480178] Starting subtest: basic-pci-d3-state
[197.185539] Subtest basic-pci-d3-state: SUCCESS (0.705s)
[197.342725] [132/171] (802s left) i915_pm_rpm (basic-rte)
[197.419162] Starting subtest: basic-rte
[200.472410] Subtest basic-rte: SUCCESS (3.052s)
[201.594724] [133/171] (798s left) i915_pm_rps (basic-api)
[201.696611] Starting subtest: basic-api
[201.698552] Subtest basic-api: SKIP (0.000s)
[201.794439] [134/171] (798s left) prime_self_import (basic-llseek-bad)
[201.889238] Starting subtest: basic-llseek-bad
[201.907632] Subtest basic-llseek-bad: SUCCESS (0.018s)
[202.025473] [135/171] (798s left) prime_self_import (basic-llseek-size)
[202.106885] Starting subtest: basic-llseek-size
[202.125882] Subtest basic-llseek-size: SUCCESS (0.019s)
[202.243252] [136/171] (797s left) prime_self_import (basic-with_fd_dup)
[202.331543] Starting subtest: basic-with_fd_dup
[202.351394] Subtest basic-with_fd_dup: SUCCESS (0.019s)
[202.470036] [137/171] (797s left) prime_self_import (basic-with_one_bo)
[202.551142] Starting subtest: basic-with_one_bo
[202.570413] Subtest basic-with_one_bo: SUCCESS (0.020s)
[202.630083] [138/171] (797s left) prime_self_import (basic-with_one_bo_two_files)
[202.707846] Starting subtest: basic-with_one_bo_two_files
[202.724667] Subtest basic-with_one_bo_two_files: SUCCESS (0.018s)
[202.827193] [139/171] (797s left) prime_self_import (basic-with_two_bos)
[202.927781] Starting subtest: basic-with_two_bos
[202.948589] Subtest basic-with_two_bos: SUCCESS (0.020s)
[203.075941] [140/171] (797s left) prime_vgem (basic-fence-flip)
[203.210594] Starting subtest: basic-fence-flip
[203.324715] Subtest basic-fence-flip: SKIP (0.113s)
[203.443684] [141/171] (796s left) prime_vgem (basic-fence-mmap)
[203.560380] Starting subtest: basic-fence-mmap
[203.562501] Subtest basic-fence-mmap: SKIP (0.000s)
[203.650336] [142/171] (796s left) prime_vgem (basic-fence-read)
[203.760761] Starting subtest: basic-fence-read
[203.767533] Subtest basic-fence-read: SKIP (0.006s)
[203.875628] [143/171] (796s left) prime_vgem (basic-gtt)
[204.010542] Starting subtest: basic-gtt
[204.012757] Subtest basic-gtt: SKIP (0.000s)
[204.134216] [144/171] (796s left) prime_vgem (basic-read)
[204.260248] Starting subtest: basic-read
[204.267569] Subtest basic-read: SKIP (0.006s)
[204.370347] [145/171] (796s left) prime_vgem (basic-write)
[204.492897] Starting subtest: basic-write
[204.499796] Subtest basic-write: SKIP (0.006s)
[204.606984] [146/171] (795s left) vgem_basic (setversion)
[204.686139] Starting subtest: setversion
[204.688294] Subtest setversion: SUCCESS (0.000s)
[204.742635] [147/171] (795s left) vgem_basic (create)
[204.836212] Starting subtest: create
[204.837331] Subtest create: SUCCESS (0.000s)
[204.895818] [148/171] (795s left) vgem_basic (debugfs)
[204.986031] Starting subtest: debugfs
[204.987069] Subtest debugfs: SUCCESS (0.000s)
[205.058633] [149/171] (795s left) vgem_basic (dmabuf-export)
[205.152490] Starting subtest: dmabuf-export
[205.171921] Subtest dmabuf-export: SUCCESS (0.018s)
[205.275501] [150/171] (795s left) vgem_basic (dmabuf-fence)
[205.386078] Starting subtest: dmabuf-fence
[205.387221] Subtest dmabuf-fence: SUCCESS (0.000s)
[205.443996] [151/171] (795s left) vgem_basic (dmabuf-fence-before)
[205.536096] Starting subtest: dmabuf-fence-before
[205.537206] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[205.609665] [152/171] (794s left) vgem_basic (dmabuf-mmap)
[205.702732] Starting subtest: dmabuf-mmap
[205.716441] Subtest dmabuf-mmap: SUCCESS (0.014s)
[205.780594] [153/171] (794s left) vgem_basic (mmap)
[205.869218] Starting subtest: mmap
[205.877806] Subtest mmap: SUCCESS (0.009s)
[205.927227] [154/171] (794s left) vgem_basic (second-client)
[206.019345] Starting subtest: second-client
[206.052555] Subtest second-client: SUCCESS (0.033s)
[206.125504] [155/171] (794s left) vgem_basic (sysfs)
[206.219402] Starting subtest: sysfs
[206.220457] Subtest sysfs: SUCCESS (0.000s)
[206.279463] [156/171] (794s left) core_hotunplug (unbind-rebind)
[206.452416] Starting subtest: unbind-rebind
[209.344802] Subtest unbind-rebind: SUCCESS (2.892s)
[209.366708] [157/171] (791s left) vgem_basic (unload)
[209.446977] Starting subtest: unload
[238.475140] Subtest unload: SUCCESS (28.993s)
[238.566889] [158/171] (762s left) i915_module_load (reload)
[238.648922] Starting subtest: reload
[242.488099] Subtest reload: SUCCESS (3.839s)
[242.506938] [159/171] (758s left) gem_lmem_swapping (basic)
[246.498400] Starting subtest: basic
[246.499409] Starting dynamic subtest: lmem0
[274.498375] Dynamic subtest lmem0: SUCCESS (27.991s)
[274.499347] Subtest basic: SUCCESS (27.992s)
[277.522739] [160/171] (723s left) gem_lmem_swapping (parallel-random-engines)
[278.509997] Starting subtest: parallel-random-engines
[278.511067] Starting dynamic subtest: lmem0
[279.957105] Dynamic subtest lmem0: SUCCESS (1.438s)
[279.958020] Subtest parallel-random-engines: SUCCESS (1.439s)
[281.523864] [161/171] (719s left) gem_lmem_swapping (random-engines)
[282.556758] Starting subtest: random-engines
[282.557851] Starting dynamic subtest: lmem0
[283.798333] Dynamic subtest lmem0: SUCCESS (1.232s)
[283.799263] Subtest random-engines: SUCCESS (1.234s)
[285.366442] [162/171] (715s left) gem_lmem_swapping (verify-random)
[286.386576] Starting subtest: verify-random
[286.387546] Starting dynamic subtest: lmem0
[297.359787] Dynamic subtest lmem0: SUCCESS (10.962s)
[297.360704] Subtest verify-random: SUCCESS (10.964s)
[298.978663] [163/171] (701s left) i915_pm_rpm (module-reload)
[301.787160] Starting subtest: module-reload
[316.124514] Subtest module-reload: SUCCESS (14.328s)
[316.140525] [164/171] (684s left) i915_selftest (live)
[316.225590] Starting subtest: live
[316.226739] Starting dynamic subtest: sanitycheck
[318.383369] Dynamic subtest sanitycheck: SUCCESS (2.148s)
[318.389770] Starting dynamic subtest: uncore
[320.484597] Dynamic subtest uncore: SUCCESS (2.100s)
[320.492783] Starting dynamic subtest: workarounds
[325.170357] Dynamic subtest workarounds: SUCCESS (4.684s)
[325.177167] Starting dynamic subtest: gt_engines
[328.368351] Dynamic subtest gt_engines: SUCCESS (3.197s)
[328.375427] Starting dynamic subtest: gt_timelines
[366.012738] Dynamic subtest gt_timelines: SUCCESS (37.643s)
[366.025322] Starting dynamic subtest: gt_contexts
[368.194333] Dynamic subtest gt_contexts: SUCCESS (2.180s)
[368.200611] Starting dynamic subtest: gt_lrc
[377.426594] Dynamic subtest gt_lrc: SUCCESS (9.231s)
[377.433561] Starting dynamic subtest: gt_mocs
[381.453459] Dynamic subtest gt_mocs: SUCCESS (4.025s)
[381.460881] Starting dynamic subtest: gt_pm
[384.497626] Dynamic subtest gt_pm: SUCCESS (3.043s)
[384.509169] Starting dynamic subtest: gt_heartbeat
[386.865592] Dynamic subtest gt_heartbeat: SUCCESS (2.366s)
[386.873083] Starting dynamic subtest: gt_tlb
[403.583889] Dynamic subtest gt_tlb: SUCCESS (16.724s)
[403.590396] Starting dynamic subtest: requests
[422.028309] Dynamic subtest requests: SUCCESS (18.435s)
[422.037859] Starting dynamic subtest: migrate
[427.648372] Dynamic subtest migrate: SUCCESS (5.619s)
[427.655256] Starting dynamic subtest: active
[429.789830] Dynamic subtest active: SUCCESS (2.139s)
[429.797558] Starting dynamic subtest: objects
[433.323361] Dynamic subtest objects: SUCCESS (3.533s)
[433.333130] Starting dynamic subtest: mman
[444.490240] Dynamic subtest mman: SUCCESS (11.166s)
[444.496535] Starting dynamic subtest: dmabuf
[446.594248] Dynamic subtest dmabuf: SUCCESS (2.103s)
[446.600743] Starting dynamic subtest: vma
[448.708280] Dynamic subtest vma: SUCCESS (2.113s)
[448.714560] Starting dynamic subtest: coherency
[452.850168] Dynamic subtest coherency: SUCCESS (4.141s)
[452.857797] Starting dynamic subtest: gtt
[463.752353] Dynamic subtest gtt: SUCCESS (10.901s)
[463.759838] Starting dynamic subtest: gem
[465.855492] Dynamic subtest gem: SUCCESS (2.102s)
[465.862537] Starting dynamic subtest: evict
[470.626708] Dynamic subtest evict: SUCCESS (4.770s)
[470.634868] Starting dynamic subtest: hugepages
[488.948374] Dynamic subtest hugepages: SUCCESS (18.320s)
[488.955332] Starting dynamic subtest: gem_contexts
[536.752327] Dynamic subtest gem_contexts: SUCCESS (47.777s)
[536.758652] Starting dynamic subtest: client
[538.882514] Dynamic subtest client: SUCCESS (2.155s)
[538.889881] Starting dynamic subtest: gem_migrate
[544.024323] Dynamic subtest gem_migrate: SUCCESS (5.140s)
[544.030506] Starting dynamic subtest: reset
[546.226385] Dynamic subtest reset: SUCCESS (2.201s)
[546.233404] Starting dynamic subtest: memory_region
[549.866389] Dynamic subtest memory_region: SUCCESS (3.639s)
[549.872581] Starting dynamic subtest: hangcheck
[596.567023] Dynamic subtest hangcheck: SUCCESS (46.699s)
[596.575280] Starting dynamic subtest: execlists
[598.684700] Dynamic subtest execlists: SUCCESS (2.116s)
[598.695146] Starting dynamic subtest: ring_submission
[600.790368] Dynamic subtest ring_submission: SUCCESS (2.104s)
[600.797028] Starting dynamic subtest: perf
[603.035763] Dynamic subtest perf: SUCCESS (2.244s)
[603.043384] Starting dynamic subtest: slpc
[612.979508] Dynamic subtest slpc: SUCCESS (9.942s)
[612.985901] Starting dynamic subtest: guc
[616.692483] Dynamic subtest guc: SUCCESS (3.711s)
[616.699572] Starting dynamic subtest: guc_multi_lrc
[618.815925] Dynamic subtest guc_multi_lrc: SUCCESS (2.121s)
[618.823017] Starting dynamic subtest: guc_hang
[621.649289] Dynamic subtest guc_hang: SUCCESS (2.834s)
[621.655577] Starting dynamic subtest: late_gt_pm
[623.877631] Dynamic subtest late_gt_pm: SUCCESS (2.227s)
[623.878778] Subtest live: SUCCESS (307.644s)
[624.342989] [165/171] (376s left) dmabuf (all-tests)
[624.443045] Starting subtest: all-tests
[624.444708] Starting dynamic subtest: sanitycheck
[624.517889] Dynamic subtest sanitycheck: SUCCESS (0.073s)
[624.555456] Starting dynamic subtest: dma_fence
[624.712826] Dynamic subtest dma_fence: SUCCESS (0.190s)
[624.735165] Starting dynamic subtest: dma_fence_chain
[638.634798] Dynamic subtest dma_fence_chain: SUCCESS (13.910s)
[638.641642] Starting dynamic subtest: dma_fence_unwrap
[638.705225] Dynamic subtest dma_fence_unwrap: SUCCESS (0.072s)
[638.716489] Starting dynamic subtest: dma_resv
[638.787972] Dynamic subtest dma_resv: SUCCESS (0.078s)
[638.790609] Subtest all-tests: SUCCESS (14.347s)
[638.842386] [166/171] (362s left) i915_suspend (basic-s2idle-without-i915)
[638.942073] Starting subtest: basic-s2idle-without-i915
[659.982903] Subtest basic-s2idle-without-i915: SUCCESS (5.859s)
[660.201931] [167/171] (355s left) i915_suspend (basic-s3-without-i915)
[660.284443] Starting subtest: basic-s3-without-i915
[663.113884] Subtest basic-s3-without-i915: SKIP (2.819s)
[663.994998] [168/171] (352s left) gem_exec_suspend (basic-s0)
[664.115909] Starting subtest: basic-S0
[664.116970] Starting dynamic subtest: smem
[684.674764] Dynamic subtest smem: SUCCESS (5.827s)
[684.689684] Starting dynamic subtest: lmem0
[704.688387] Dynamic subtest lmem0: SUCCESS (5.846s)
[704.689395] Subtest basic-S0: SUCCESS (11.677s)
[704.917551] [169/171] (340s left) gem_exec_suspend (basic-s3)
[705.029802] Starting subtest: basic-S3
[705.030937] Starting dynamic subtest: smem
[725.688458] Dynamic subtest smem: SUCCESS (5.773s)
[725.729223] Starting dynamic subtest: lmem0
[745.689176] Dynamic subtest lmem0: SUCCESS (5.760s)
[745.697318] Subtest basic-S3: SUCCESS (11.542s)
[745.916823] [170/171] (328s left) kms_chamelium_hpd (common-hpd-after-suspend)
[746.185124] Subtest common-hpd-after-suspend: SKIP (0.000s)
[746.324076] [171/171] (327s left) kms_pipe_crc_basic (suspend-read-crc)
[746.482151] Starting subtest: suspend-read-crc
[746.483210] Starting dynamic subtest: pipe-A-DP-1
[764.041431] Dynamic subtest pipe-A-DP-1: SUCCESS (2.851s)
[764.054904] Starting dynamic subtest: pipe-B-DP-1
[782.076940] Dynamic subtest pipe-B-DP-1: SUCCESS (2.930s)
[782.088064] Starting dynamic subtest: pipe-C-DP-1
[784.820813] Dynamic subtest pipe-C-DP-1: SUCCESS (2.739s)
[784.829908] Starting dynamic subtest: pipe-D-DP-1
[803.195498] Dynamic subtest pipe-D-DP-1: SUCCESS (3.141s)
[803.196453] Subtest suspend-read-crc: SUCCESS (11.673s)
[803.370824] Closing watchdogs
Done.