[40.269878] Initializing watchdogs
[40.269969]   /dev/watchdog0
[40.277392] [001/171] (960s left) i915_module_load (load)
[40.359541] Starting subtest: load
[41.751781] Subtest load: SUCCESS (1.392s)
[41.770724] [002/171] (959s left) core_auth (basic-auth)
[41.922205] Starting subtest: basic-auth
[41.923213] Subtest basic-auth: SUCCESS (0.001s)
[41.994720] [003/171] (958s left) debugfs_test (read_all_entries)
[42.097244] Starting subtest: read_all_entries
[42.620291] Subtest read_all_entries: SUCCESS (0.522s)
[42.741502] [004/171] (958s left) debugfs_test (basic-hwmon)
[42.840285] Starting subtest: basic-hwmon
[42.844823] Subtest basic-hwmon: SUCCESS (0.004s)
[42.973324] [005/171] (957s left) fbdev (eof)
[43.068903] Starting subtest: eof
[43.070064] Subtest eof: SUCCESS (0.000s)
[43.139177] [006/171] (957s left) fbdev (info)
[43.217217] Starting subtest: info
[43.218461] Subtest info: SUCCESS (0.000s)
[43.289251] [007/171] (957s left) fbdev (nullptr)
[43.368513] Starting subtest: nullptr
[43.369743] Subtest nullptr: SUCCESS (0.000s)
[43.438428] [008/171] (957s left) fbdev (read)
[43.518976] Starting subtest: read
[55.926204] Subtest read: SUCCESS (12.372s)
[55.942288] [009/171] (944s left) fbdev (write)
[56.035809] Starting subtest: write
[62.181309] Subtest write: SUCCESS (6.137s)
[62.224104] [010/171] (938s left) gem_basic (bad-close)
[62.315897] Starting subtest: bad-close
[62.317620] Subtest bad-close: SUCCESS (0.000s)
[62.373100] [011/171] (938s left) gem_basic (create-close)
[62.463075] Starting subtest: create-close
[62.465036] Subtest create-close: SUCCESS (0.000s)
[62.542749] [012/171] (938s left) gem_basic (create-fd-close)
[62.634371] Starting subtest: create-fd-close
[62.636421] Subtest create-fd-close: SUCCESS (0.000s)
[62.756849] [013/171] (938s left) gem_busy (busy@all-engines)
[62.874216] Starting subtest: busy
[62.875282] Starting dynamic subtest: all-engines
[63.005509] Dynamic subtest all-engines: SUCCESS (0.131s)
[63.006576] Subtest busy: SUCCESS (0.131s)
[63.470672] [014/171] (937s left) gem_close_race (basic-process)
[63.616440] Starting subtest: basic-process
[63.662449] Subtest basic-process: SUCCESS (0.046s)
[63.901932] [015/171] (937s left) gem_close_race (basic-threads)
[64.036226] Starting subtest: basic-threads
[65.233572] Subtest basic-threads: SUCCESS (1.197s)
[65.499430] [016/171] (935s left) gem_ctx_create (basic)
[65.622868] Starting subtest: basic
[65.623962] Subtest basic: SUCCESS (0.000s)
[65.821931] [017/171] (935s left) gem_ctx_create (basic-files)
[65.925122] Starting subtest: basic-files
[67.941113] Subtest basic-files: SUCCESS (2.016s)
[68.390626] [018/171] (932s left) gem_ctx_exec (basic)
[68.484542] Starting subtest: basic
[68.490210] Subtest basic: SUCCESS (0.006s)
[68.618985] [019/171] (932s left) gem_exec_basic (basic)
[68.716430] Starting subtest: basic
[68.717482] Starting dynamic subtest: rcs0-smem
[68.719668] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[68.725585] Starting dynamic subtest: bcs0-smem
[68.726597] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[68.733092] Starting dynamic subtest: vcs0-smem
[68.734118] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[68.739816] Starting dynamic subtest: vcs1-smem
[68.740824] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[68.746515] Starting dynamic subtest: vecs0-smem
[68.747523] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[68.753369] Starting dynamic subtest: vecs1-smem
[68.754520] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[68.760279] Starting dynamic subtest: ccs0-smem
[68.761435] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[68.766999] Starting dynamic subtest: ccs1-smem
[68.767848] Dynamic subtest ccs1-smem: SUCCESS (0.001s)
[68.773558] Starting dynamic subtest: ccs2-smem
[68.774654] Dynamic subtest ccs2-smem: SUCCESS (0.001s)
[68.780359] Starting dynamic subtest: ccs3-smem
[68.781481] Dynamic subtest ccs3-smem: SUCCESS (0.001s)
[68.787181] Starting dynamic subtest: rcs0-lmem0
[68.788157] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[68.793807] Starting dynamic subtest: bcs0-lmem0
[68.794919] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[68.800659] Starting dynamic subtest: vcs0-lmem0
[68.801705] Dynamic subtest vcs0-lmem0: SUCCESS (0.001s)
[68.807423] Starting dynamic subtest: vcs1-lmem0
[68.808434] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[68.814134] Starting dynamic subtest: vecs0-lmem0
[68.815220] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[68.820676] Starting dynamic subtest: vecs1-lmem0
[68.821705] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[68.827418] Starting dynamic subtest: ccs0-lmem0
[68.828483] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[68.834055] Starting dynamic subtest: ccs1-lmem0
[68.835014] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[68.840794] Starting dynamic subtest: ccs2-lmem0
[68.841649] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[68.847378] Starting dynamic subtest: ccs3-lmem0
[68.848488] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[68.849593] Subtest basic: SUCCESS (0.016s)
[68.974641] [020/171] (932s left) gem_exec_create (basic)
[69.095245] Starting subtest: basic
[69.096370] Starting dynamic subtest: smem
[71.192549] Dynamic subtest smem: SUCCESS (2.097s)
[71.198724] Starting dynamic subtest: lmem0
[73.317982] Dynamic subtest lmem0: SUCCESS (2.125s)
[73.319183] Subtest basic: SUCCESS (4.223s)
[73.518323] [021/171] (927s left) gem_exec_fence (basic-busy)
[73.748872] Starting subtest: basic-busy
[73.749992] Starting dynamic subtest: rcs0
[73.856492] Dynamic subtest rcs0: SUCCESS (0.115s)
[73.865840] Starting dynamic subtest: bcs0
[73.908694] Dynamic subtest bcs0: SUCCESS (0.052s)
[73.933474] Starting dynamic subtest: vcs0
[73.964623] Dynamic subtest vcs0: SUCCESS (0.055s)
[73.990287] Starting dynamic subtest: vcs1
[74.025226] Dynamic subtest vcs1: SUCCESS (0.060s)
[74.051507] Starting dynamic subtest: vecs0
[74.090618] Dynamic subtest vecs0: SUCCESS (0.065s)
[74.117041] Starting dynamic subtest: vecs1
[74.156576] Dynamic subtest vecs1: SUCCESS (0.065s)
[74.182448] Starting dynamic subtest: ccs0
[74.218397] Dynamic subtest ccs0: SUCCESS (0.061s)
[74.243683] Starting dynamic subtest: ccs1
[74.286421] Dynamic subtest ccs1: SUCCESS (0.067s)
[74.312396] Starting dynamic subtest: ccs2
[74.359429] Dynamic subtest ccs2: SUCCESS (0.072s)
[74.386198] Starting dynamic subtest: ccs3
[74.426662] Dynamic subtest ccs3: SUCCESS (0.066s)
[74.429308] Subtest basic-busy: SUCCESS (0.685s)
[75.725771] [022/171] (925s left) gem_exec_fence (basic-wait)
[75.962328] Starting subtest: basic-wait
[75.963472] Starting dynamic subtest: rcs0
[76.064164] Dynamic subtest rcs0: SUCCESS (0.109s)
[76.074545] Starting dynamic subtest: bcs0
[76.115428] Dynamic subtest bcs0: SUCCESS (0.052s)
[76.126810] Starting dynamic subtest: vcs0
[76.166315] Dynamic subtest vcs0: SUCCESS (0.049s)
[76.192925] Starting dynamic subtest: vcs1
[76.227169] Dynamic subtest vcs1: SUCCESS (0.060s)
[76.249288] Starting dynamic subtest: vecs0
[76.283942] Dynamic subtest vecs0: SUCCESS (0.057s)
[76.304563] Starting dynamic subtest: vecs1
[76.337561] Dynamic subtest vecs1: SUCCESS (0.053s)
[76.346406] Starting dynamic subtest: ccs0
[76.385618] Dynamic subtest ccs0: SUCCESS (0.048s)
[76.396913] Starting dynamic subtest: ccs1
[76.441391] Dynamic subtest ccs1: SUCCESS (0.054s)
[76.468221] Starting dynamic subtest: ccs2
[76.499405] Dynamic subtest ccs2: SUCCESS (0.057s)
[76.524534] Starting dynamic subtest: ccs3
[76.556734] Dynamic subtest ccs3: SUCCESS (0.057s)
[76.558945] Subtest basic-wait: SUCCESS (0.602s)
[77.834825] [023/171] (923s left) gem_exec_fence (basic-await)
[78.072418] Starting subtest: basic-await
[78.073407] Starting dynamic subtest: rcs0
[78.207283] Dynamic subtest rcs0: SUCCESS (0.143s)
[78.213413] Starting dynamic subtest: bcs0
[78.321884] Dynamic subtest bcs0: SUCCESS (0.114s)
[78.328187] Starting dynamic subtest: vcs0
[78.436953] Dynamic subtest vcs0: SUCCESS (0.115s)
[78.444558] Starting dynamic subtest: vcs1
[78.564659] Dynamic subtest vcs1: SUCCESS (0.128s)
[78.571129] Starting dynamic subtest: vecs0
[78.685289] Dynamic subtest vecs0: SUCCESS (0.120s)
[78.691497] Starting dynamic subtest: vecs1
[78.805657] Dynamic subtest vecs1: SUCCESS (0.120s)
[78.811781] Starting dynamic subtest: ccs0
[78.920207] Dynamic subtest ccs0: SUCCESS (0.114s)
[78.926357] Starting dynamic subtest: ccs1
[79.034896] Dynamic subtest ccs1: SUCCESS (0.114s)
[79.042634] Starting dynamic subtest: ccs2
[79.155116] Dynamic subtest ccs2: SUCCESS (0.120s)
[79.163197] Starting dynamic subtest: ccs3
[79.274310] Dynamic subtest ccs3: SUCCESS (0.119s)
[79.275509] Subtest basic-await: SUCCESS (1.210s)
[80.567835] [024/171] (920s left) gem_exec_fence (nb-await)
[80.803019] Starting subtest: nb-await
[80.804122] Starting dynamic subtest: rcs0
[80.900185] Dynamic subtest rcs0: SUCCESS (0.104s)
[80.910063] Starting dynamic subtest: bcs0
[80.977347] Dynamic subtest bcs0: SUCCESS (0.075s)
[80.984118] Starting dynamic subtest: vcs0
[81.045086] Dynamic subtest vcs0: SUCCESS (0.069s)
[81.061363] Starting dynamic subtest: vcs1
[81.138398] Dynamic subtest vcs1: SUCCESS (0.092s)
[81.165260] Starting dynamic subtest: vecs0
[81.238572] Dynamic subtest vecs0: SUCCESS (0.100s)
[81.254343] Starting dynamic subtest: vecs1
[81.329251] Dynamic subtest vecs1: SUCCESS (0.089s)
[81.356082] Starting dynamic subtest: ccs0
[81.430398] Dynamic subtest ccs0: SUCCESS (0.102s)
[81.455238] Starting dynamic subtest: ccs1
[81.529826] Dynamic subtest ccs1: SUCCESS (0.099s)
[81.551831] Starting dynamic subtest: ccs2
[81.622521] Dynamic subtest ccs2: SUCCESS (0.092s)
[81.640911] Starting dynamic subtest: ccs3
[81.715441] Dynamic subtest ccs3: SUCCESS (0.092s)
[81.717086] Subtest nb-await: SUCCESS (0.919s)
[82.934141] [025/171] (918s left) gem_exec_gttfill (basic)
[83.045687] Starting subtest: basic
[90.320862] Subtest basic: SUCCESS (7.267s)
[90.608301] [026/171] (910s left) gem_exec_parallel (engines)
[90.768412] Starting subtest: engines
[90.769396] Starting dynamic subtest: basic
[92.729247] Dynamic subtest basic: SUCCESS (1.961s)
[92.736165] Starting dynamic subtest: contexts
[95.832832] Dynamic subtest contexts: SUCCESS (3.103s)
[95.840129] Starting dynamic subtest: fds
[99.399885] Dynamic subtest fds: SUCCESS (3.558s)
[99.406935] Starting dynamic subtest: userptr
[101.186818] Dynamic subtest userptr: SUCCESS (1.795s)
[101.187972] Subtest engines: SUCCESS (10.418s)
[101.475202] [027/171] (899s left) gem_exec_store (basic)
[101.593977] Starting subtest: basic
[101.743802] Subtest basic: SUCCESS (0.150s)
[101.999654] [028/171] (899s left) gem_flink_basic (bad-flink)
[102.094269] Starting subtest: bad-flink
[102.095377] Subtest bad-flink: SUCCESS (0.000s)
[102.159167] [029/171] (899s left) gem_flink_basic (bad-open)
[102.255405] Starting subtest: bad-open
[102.256461] Subtest bad-open: SUCCESS (0.000s)
[102.327862] [030/171] (898s left) gem_flink_basic (basic)
[102.420266] Starting subtest: basic
[102.421358] Subtest basic: SUCCESS (0.000s)
[102.538953] [031/171] (898s left) gem_flink_basic (double-flink)
[102.636402] Starting subtest: double-flink
[102.637485] Subtest double-flink: SUCCESS (0.000s)
[102.743436] [032/171] (898s left) gem_flink_basic (flink-lifetime)
[102.844126] Starting subtest: flink-lifetime
[102.846387] Subtest flink-lifetime: SUCCESS (0.002s)
[102.973154] [033/171] (898s left) gem_huc_copy (huc-copy)
[103.109200] Starting subtest: huc-copy
[103.115514] Subtest huc-copy: SUCCESS (0.006s)
[103.256935] [034/171] (898s left) gem_linear_blits (basic)
[103.473382] Starting subtest: basic
[103.515330] Subtest basic: SUCCESS (0.042s)
[103.677944] [035/171] (897s left) gem_mmap (basic)
[103.825539] Subtest basic: SKIP (0.000s)
[103.862270] [036/171] (897s left) gem_mmap_gtt (basic)
[103.958236] Subtest basic: SKIP (0.000s)
[103.995581] [037/171] (897s left) gem_render_linear_blits (basic)
[104.097254] Starting subtest: basic
[104.186502] Subtest basic: SUCCESS (0.089s)
[104.263967] [038/171] (897s left) gem_render_tiled_blits (basic)
[104.369812] Subtest basic: SKIP (0.000s)
[104.395433] [039/171] (897s left) gem_ringfill (basic-all)
[104.865751] Starting subtest: basic-all
[109.216897] Subtest basic-all: SUCCESS (4.317s)
[109.305855] [040/171] (892s left) gem_softpin (allocator-basic)
[109.411422] Starting subtest: allocator-basic
[109.683768] Subtest allocator-basic: SUCCESS (0.264s)
[109.791814] [041/171] (891s left) gem_softpin (allocator-basic-reserve)
[109.923054] Starting subtest: allocator-basic-reserve
[110.189627] Subtest allocator-basic-reserve: SUCCESS (0.258s)
[110.323574] [042/171] (891s left) gem_softpin (safe-alignment)
[110.438134] Starting subtest: safe-alignment
[110.510453] Subtest safe-alignment: SUCCESS (0.072s)
[110.661028] [043/171] (890s left) gem_sync (basic-all)
[110.788202] Starting subtest: basic-all
[114.735826] Subtest basic-all: SUCCESS (3.947s)
[114.932768] [044/171] (886s left) gem_sync (basic-each)
[115.058214] Starting subtest: basic-each
[117.645465] Subtest basic-each: SUCCESS (2.587s)
[117.844648] [045/171] (883s left) gem_tiled_blits (basic)
[117.945678] Subtest basic: SKIP (0.000s)
[117.979140] [046/171] (883s left) gem_tiled_fence_blits (basic)
[118.080584] Subtest basic: SKIP (0.000s)
[118.112138] [047/171] (883s left) gem_tiled_pread_basic
[118.245785] [048/171] (883s left) gem_wait (busy@all-engines)
[118.361329] Starting subtest: busy
[118.362353] Starting dynamic subtest: all-engines
[118.950507] Dynamic subtest all-engines: SUCCESS (0.589s)
[118.951482] Subtest busy: SUCCESS (0.589s)
[119.206430] [049/171] (882s left) gem_wait (wait@all-engines)
[119.327078] Starting subtest: wait
[119.328204] Starting dynamic subtest: all-engines
[120.424468] Dynamic subtest all-engines: SUCCESS (1.097s)
[120.425639] Subtest wait: SUCCESS (1.098s)
[120.707187] [050/171] (881s left) i915_getparams_basic (basic-eu-total)
[120.801196] Starting subtest: basic-eu-total
[120.803238] Subtest basic-eu-total: SUCCESS (0.000s)
[120.859304] [051/171] (880s left) i915_getparams_basic (basic-subslice-total)
[120.953165] Starting subtest: basic-subslice-total
[120.955220] Subtest basic-subslice-total: SUCCESS (0.000s)
[121.039565] [052/171] (880s left) i915_hangman (error-state-basic)
[121.162363] Starting subtest: error-state-basic
[121.373519] Subtest error-state-basic: SUCCESS (0.212s)
[121.448622] [053/171] (880s left) i915_pciid
[121.609603] [054/171] (880s left) kms_addfb_basic (addfb25-bad-modifier)
[121.705315] Starting subtest: addfb25-bad-modifier
[121.706300] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[121.862949] [055/171] (879s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[121.962181] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[122.096653] [056/171] (879s left) kms_addfb_basic (addfb25-modifier-no-flag)
[122.195171] Starting subtest: addfb25-modifier-no-flag
[122.196149] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[122.347732] [057/171] (879s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[122.446484] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[122.596826] [058/171] (879s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[122.692052] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[122.827226] [059/171] (879s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[122.985077] Starting subtest: addfb25-yf-tiled-legacy
[122.986135] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[123.060618] [060/171] (878s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[123.217184] Starting subtest: addfb25-y-tiled-legacy
[123.218224] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[123.310555] [061/171] (878s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[123.465522] Starting subtest: addfb25-y-tiled-small-legacy
[123.467214] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[123.543741] [062/171] (878s left) kms_addfb_basic (bad-pitch-0)
[123.635753] Starting subtest: bad-pitch-0
[123.636733] Subtest bad-pitch-0: SUCCESS (0.000s)
[123.794027] [063/171] (878s left) kms_addfb_basic (bad-pitch-1024)
[123.885956] Starting subtest: bad-pitch-1024
[123.886994] Subtest bad-pitch-1024: SUCCESS (0.000s)
[124.027673] [064/171] (877s left) kms_addfb_basic (bad-pitch-128)
[124.122440] Starting subtest: bad-pitch-128
[124.123518] Subtest bad-pitch-128: SUCCESS (0.000s)
[124.260597] [065/171] (877s left) kms_addfb_basic (bad-pitch-256)
[124.354011] Starting subtest: bad-pitch-256
[124.354989] Subtest bad-pitch-256: SUCCESS (0.000s)
[124.510621] [066/171] (877s left) kms_addfb_basic (bad-pitch-32)
[124.603971] Starting subtest: bad-pitch-32
[124.604924] Subtest bad-pitch-32: SUCCESS (0.000s)
[124.744224] [067/171] (877s left) kms_addfb_basic (bad-pitch-63)
[124.838202] Starting subtest: bad-pitch-63
[124.839235] Subtest bad-pitch-63: SUCCESS (0.000s)
[124.994065] [068/171] (877s left) kms_addfb_basic (bad-pitch-65536)
[125.088114] Starting subtest: bad-pitch-65536
[125.089145] Subtest bad-pitch-65536: SUCCESS (0.000s)
[125.227498] [069/171] (876s left) kms_addfb_basic (bad-pitch-999)
[125.321250] Starting subtest: bad-pitch-999
[125.322273] Subtest bad-pitch-999: SUCCESS (0.000s)
[125.461074] [070/171] (876s left) kms_addfb_basic (basic)
[125.555308] Starting subtest: basic
[125.556364] Subtest basic: SUCCESS (0.000s)
[125.710601] [071/171] (876s left) kms_addfb_basic (basic-x-tiled-legacy)
[125.805211] Starting subtest: basic-x-tiled-legacy
[125.807202] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[125.944021] [072/171] (876s left) kms_addfb_basic (basic-y-tiled-legacy)
[126.037913] Starting subtest: basic-y-tiled-legacy
[126.039674] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[126.194078] [073/171] (875s left) kms_addfb_basic (bo-too-small)
[126.350875] Starting subtest: bo-too-small
[126.351933] Subtest bo-too-small: SUCCESS (0.000s)
[126.427515] [074/171] (875s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[126.585238] Starting subtest: bo-too-small-due-to-tiling
[126.587226] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[126.660722] [075/171] (875s left) kms_addfb_basic (clobberred-modifier)
[126.754401] Starting subtest: clobberred-modifier
[126.756141] Subtest clobberred-modifier: SKIP (0.000s)
[126.894055] [076/171] (875s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[126.989182] Starting subtest: framebuffer-vs-set-tiling
[126.991195] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[127.127551] [077/171] (875s left) kms_addfb_basic (invalid-get-prop)
[127.221130] Starting subtest: invalid-get-prop
[127.222207] Subtest invalid-get-prop: SUCCESS (0.000s)
[127.361184] [078/171] (874s left) kms_addfb_basic (invalid-get-prop-any)
[127.454306] Starting subtest: invalid-get-prop-any
[127.455411] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[127.594478] [079/171] (874s left) kms_addfb_basic (invalid-set-prop)
[127.688287] Starting subtest: invalid-set-prop
[127.694964] Subtest invalid-set-prop: SUCCESS (0.000s)
[127.827778] [080/171] (874s left) kms_addfb_basic (invalid-set-prop-any)
[127.921181] Starting subtest: invalid-set-prop-any
[127.922221] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[128.060819] [081/171] (874s left) kms_addfb_basic (no-handle)
[128.155144] Starting subtest: no-handle
[128.156141] Subtest no-handle: SUCCESS (0.000s)
[128.310663] [082/171] (873s left) kms_addfb_basic (size-max)
[128.466150] Starting subtest: size-max
[128.467183] Subtest size-max: SUCCESS (0.000s)
[128.544284] [083/171] (873s left) kms_addfb_basic (small-bo)
[128.700317] Starting subtest: small-bo
[128.701400] Subtest small-bo: SUCCESS (0.000s)
[128.794368] [084/171] (873s left) kms_addfb_basic (tile-pitch-mismatch)
[128.889393] Starting subtest: tile-pitch-mismatch
[128.891445] Subtest tile-pitch-mismatch: SKIP (0.000s)
[129.027465] [085/171] (873s left) kms_addfb_basic (too-high)
[129.182863] Starting subtest: too-high
[129.183929] Subtest too-high: SUCCESS (0.001s)
[129.262255] [086/171] (873s left) kms_addfb_basic (too-wide)
[129.420048] Starting subtest: too-wide
[129.420961] Subtest too-wide: SUCCESS (0.000s)
[129.510687] [087/171] (872s left) kms_addfb_basic (unused-handle)
[129.605189] Starting subtest: unused-handle
[129.606191] Subtest unused-handle: SUCCESS (0.000s)
[129.760843] [088/171] (872s left) kms_addfb_basic (unused-modifier)
[129.854142] Starting subtest: unused-modifier
[129.855174] Subtest unused-modifier: SUCCESS (0.000s)
[130.010902] [089/171] (872s left) kms_addfb_basic (unused-offsets)
[130.105158] Starting subtest: unused-offsets
[130.106155] Subtest unused-offsets: SUCCESS (0.000s)
[130.260807] [090/171] (872s left) kms_addfb_basic (unused-pitches)
[130.353986] Starting subtest: unused-pitches
[130.354960] Subtest unused-pitches: SUCCESS (0.000s)
[130.510758] [091/171] (871s left) kms_busy (basic)
[130.674024] Starting subtest: basic
[130.675058] Starting dynamic subtest: flip
[131.413533] Dynamic subtest flip: SUCCESS (0.739s)
[131.424016] Starting dynamic subtest: modeset
[132.386875] Dynamic subtest modeset: SUCCESS (0.973s)
[132.387952] Subtest basic: SUCCESS (1.714s)
[132.630132] [092/171] (869s left) kms_chamelium_hpd (dp-hpd-fast)
[132.862033] Subtest dp-hpd-fast: SKIP (0.000s)
[132.998398] [093/171] (869s left) kms_chamelium_edid (dp-edid-read)
[133.229032] Subtest dp-edid-read: SKIP (0.000s)
[133.364551] [094/171] (869s left) kms_chamelium_frames (dp-crc-fast)
[133.611625] Subtest dp-crc-fast: SKIP (0.000s)
[133.746465] [095/171] (868s left) kms_chamelium_hpd (hdmi-hpd-fast)
[133.977650] Subtest hdmi-hpd-fast: SKIP (0.000s)
[134.116795] [096/171] (868s left) kms_chamelium_edid (hdmi-edid-read)
[134.364989] Subtest hdmi-edid-read: SKIP (0.000s)
[134.502839] [097/171] (868s left) kms_chamelium_frames (hdmi-crc-fast)
[134.733392] Subtest hdmi-crc-fast: SKIP (0.000s)
[134.869737] [098/171] (867s left) kms_chamelium_hpd (vga-hpd-fast)
[135.100449] Subtest vga-hpd-fast: SKIP (0.000s)
[135.236655] [099/171] (867s left) kms_chamelium_edid (vga-edid-read)
[135.467572] Subtest vga-edid-read: SKIP (0.000s)
[135.602740] [100/171] (867s left) kms_prop_blob (basic)
[135.696303] Starting subtest: basic
[135.697369] Subtest basic: SUCCESS (0.000s)
[135.763502] [101/171] (866s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[135.919099] Starting subtest: basic-busy-flip-before-cursor-atomic
[135.921121] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[135.980340] [102/171] (866s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[136.139602] Starting subtest: basic-busy-flip-before-cursor-legacy
[136.141489] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[136.213848] [103/171] (866s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[136.368758] Starting subtest: basic-flip-after-cursor-atomic
[137.432130] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.064s)
[137.667511] [104/171] (865s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[137.825427] Starting subtest: basic-flip-after-cursor-legacy
[138.923373] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.083s)
[139.116601] [105/171] (863s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[139.272060] Starting subtest: basic-flip-after-cursor-varying-size
[140.352156] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.080s)
[140.592706] [106/171] (862s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[140.750402] Starting subtest: basic-flip-before-cursor-atomic
[141.808911] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.059s)
[142.017253] [107/171] (860s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[142.173779] Starting subtest: basic-flip-before-cursor-legacy
[143.233618] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.062s)
[143.459452] [108/171] (859s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[143.615600] Starting subtest: basic-flip-before-cursor-varying-size
[144.692169] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.077s)
[144.910808] [109/171] (857s left) kms_flip (basic-flip-vs-dpms)
[145.051425] Starting subtest: basic-flip-vs-dpms
[145.056308] Starting dynamic subtest: A-DP1
[146.136465] Dynamic subtest A-DP1: SUCCESS (1.080s)
[146.144316] Starting dynamic subtest: B-DP1
[147.037999] Dynamic subtest B-DP1: SUCCESS (0.900s)
[147.046055] Starting dynamic subtest: C-DP1
[147.953869] Dynamic subtest C-DP1: SUCCESS (0.914s)
[147.961888] Starting dynamic subtest: D-DP1
[148.907425] Dynamic subtest D-DP1: SUCCESS (0.952s)
[148.911529] Subtest basic-flip-vs-dpms: SUCCESS (3.862s)
[149.132646] [110/171] (853s left) kms_flip (basic-flip-vs-modeset)
[149.275217] Starting subtest: basic-flip-vs-modeset
[149.281519] Starting dynamic subtest: A-DP1
[150.169016] Dynamic subtest A-DP1: SUCCESS (0.887s)
[150.176757] Starting dynamic subtest: B-DP1
[151.076922] Dynamic subtest B-DP1: SUCCESS (0.907s)
[151.085029] Starting dynamic subtest: C-DP1
[151.989199] Dynamic subtest C-DP1: SUCCESS (0.911s)
[151.998798] Starting dynamic subtest: D-DP1
[152.879385] Dynamic subtest D-DP1: SUCCESS (0.888s)
[152.884260] Subtest basic-flip-vs-modeset: SUCCESS (3.610s)
[153.093539] [111/171] (849s left) kms_flip (basic-flip-vs-wf_vblank)
[153.234184] Starting subtest: basic-flip-vs-wf_vblank
[153.240095] Starting dynamic subtest: A-DP1
[154.454879] Dynamic subtest A-DP1: SUCCESS (1.215s)
[154.464699] Starting dynamic subtest: B-DP1
[155.578260] Dynamic subtest B-DP1: SUCCESS (1.122s)
[155.588142] Starting dynamic subtest: C-DP1
[156.700979] Dynamic subtest C-DP1: SUCCESS (1.122s)
[156.710499] Starting dynamic subtest: D-DP1
[157.819680] Dynamic subtest D-DP1: SUCCESS (1.117s)
[157.825203] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.592s)
[158.090261] [112/171] (844s left) kms_flip (basic-plain-flip)
[158.231424] Starting subtest: basic-plain-flip
[158.236845] Starting dynamic subtest: A-DP1
[159.152404] Dynamic subtest A-DP1: SUCCESS (0.916s)
[159.162436] Starting dynamic subtest: B-DP1
[159.992651] Dynamic subtest B-DP1: SUCCESS (0.839s)
[160.002104] Starting dynamic subtest: C-DP1
[160.835752] Dynamic subtest C-DP1: SUCCESS (0.842s)
[160.845588] Starting dynamic subtest: D-DP1
[161.670721] Dynamic subtest D-DP1: SUCCESS (0.833s)
[161.676312] Subtest basic-plain-flip: SUCCESS (3.446s)
[161.941041] [113/171] (840s left) kms_force_connector_basic (force-connector-state)
[162.038888] Starting subtest: force-connector-state
[162.614176] Subtest force-connector-state: SUCCESS (0.574s)
[162.892116] [114/171] (839s left) kms_force_connector_basic (force-edid)
[162.989818] Starting subtest: force-edid
[163.007108] Subtest force-edid: SUCCESS (0.017s)
[163.175217] [115/171] (839s left) kms_force_connector_basic (force-load-detect)
[163.272652] Starting subtest: force-load-detect
[163.274462] Subtest force-load-detect: SKIP (0.000s)
[163.391644] [116/171] (839s left) kms_force_connector_basic (prune-stale-modes)
[163.488388] Starting subtest: prune-stale-modes
[163.499296] Subtest prune-stale-modes: SKIP (0.009s)
[163.658454] [117/171] (839s left) kms_frontbuffer_tracking (basic)
[163.821374] Starting subtest: basic
[167.818667] Subtest basic: SUCCESS (3.998s)
[167.952609] [118/171] (834s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[168.113427] Starting subtest: compare-crc-sanitycheck-xr24
[168.116103] Starting dynamic subtest: pipe-A-DP-1
[168.709733] Dynamic subtest pipe-A-DP-1: SUCCESS (0.594s)
[168.722944] Starting dynamic subtest: pipe-B-DP-1
[169.281739] Dynamic subtest pipe-B-DP-1: SUCCESS (0.568s)
[169.291364] Starting dynamic subtest: pipe-C-DP-1
[169.920976] Dynamic subtest pipe-C-DP-1: SUCCESS (0.636s)
[169.930657] Starting dynamic subtest: pipe-D-DP-1
[170.628369] Dynamic subtest pipe-D-DP-1: SUCCESS (0.705s)
[170.629426] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.515s)
[170.826114] [119/171] (832s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[170.983703] Starting subtest: compare-crc-sanitycheck-nv12
[170.986568] Starting dynamic subtest: pipe-A-DP-1
[172.274564] Dynamic subtest pipe-A-DP-1: SUCCESS (1.289s)
[172.284203] Starting dynamic subtest: pipe-B-DP-1
[173.542505] Dynamic subtest pipe-B-DP-1: SUCCESS (1.265s)
[173.552834] Starting dynamic subtest: pipe-C-DP-1
[174.843200] Dynamic subtest pipe-C-DP-1: SUCCESS (1.298s)
[174.853352] Starting dynamic subtest: pipe-D-DP-1
[176.071373] Dynamic subtest pipe-D-DP-1: SUCCESS (1.225s)
[176.072470] Subtest compare-crc-sanitycheck-nv12: SUCCESS (5.088s)
[176.276532] [120/171] (826s left) kms_pipe_crc_basic (hang-read-crc)
[176.432850] Starting subtest: hang-read-crc
[176.433923] Starting dynamic subtest: pipe-A-DP-1
[177.915601] Dynamic subtest pipe-A-DP-1: SUCCESS (1.481s)
[177.925373] Starting dynamic subtest: pipe-B-DP-1
[179.462641] Dynamic subtest pipe-B-DP-1: SUCCESS (1.545s)
[179.472883] Starting dynamic subtest: pipe-C-DP-1
[181.132381] Dynamic subtest pipe-C-DP-1: SUCCESS (1.667s)
[181.142478] Starting dynamic subtest: pipe-D-DP-1
[182.951085] Dynamic subtest pipe-D-DP-1: SUCCESS (1.816s)
[182.951964] Subtest hang-read-crc: SUCCESS (6.520s)
[183.157176] [121/171] (819s left) kms_pipe_crc_basic (nonblocking-crc)
[183.317446] Starting subtest: nonblocking-crc
[183.320273] Starting dynamic subtest: pipe-A-DP-1
[184.006756] Dynamic subtest pipe-A-DP-1: SUCCESS (0.687s)
[184.016958] Starting dynamic subtest: pipe-B-DP-1
[184.729396] Dynamic subtest pipe-B-DP-1: SUCCESS (0.720s)
[184.739028] Starting dynamic subtest: pipe-C-DP-1
[185.533251] Dynamic subtest pipe-C-DP-1: SUCCESS (0.801s)
[185.542899] Starting dynamic subtest: pipe-D-DP-1
[186.413293] Dynamic subtest pipe-D-DP-1: FAIL (0.811s)
[186.414293] Subtest nonblocking-crc: FAIL (3.030s)
[186.610202] [122/171] (816s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[186.767933] Starting subtest: nonblocking-crc-frame-sequence
[186.769015] Starting dynamic subtest: pipe-A-DP-1
[187.475567] Dynamic subtest pipe-A-DP-1: SUCCESS (0.706s)
[187.485718] Starting dynamic subtest: pipe-B-DP-1
[188.203509] Dynamic subtest pipe-B-DP-1: SUCCESS (0.726s)
[188.213734] Starting dynamic subtest: pipe-C-DP-1
[189.059307] Dynamic subtest pipe-C-DP-1: SUCCESS (0.853s)
[189.069016] Starting dynamic subtest: pipe-D-DP-1
[189.911815] Dynamic subtest pipe-D-DP-1: SUCCESS (0.850s)
[189.912951] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.145s)
[190.108098] [123/171] (812s left) kms_pipe_crc_basic (read-crc)
[190.268031] Starting subtest: read-crc
[190.269146] Starting dynamic subtest: pipe-A-DP-1
[190.907591] Dynamic subtest pipe-A-DP-1: SUCCESS (0.638s)
[190.917591] Starting dynamic subtest: pipe-B-DP-1
[191.561677] Dynamic subtest pipe-B-DP-1: SUCCESS (0.651s)
[191.571865] Starting dynamic subtest: pipe-C-DP-1
[192.279401] Dynamic subtest pipe-C-DP-1: SUCCESS (0.715s)
[192.289680] Starting dynamic subtest: pipe-D-DP-1
[193.064437] Dynamic subtest pipe-D-DP-1: SUCCESS (0.782s)
[193.065367] Subtest read-crc: SUCCESS (2.798s)
[193.274727] [124/171] (809s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[193.430675] Starting subtest: read-crc-frame-sequence
[193.433461] Starting dynamic subtest: pipe-A-DP-1
[194.057177] Dynamic subtest pipe-A-DP-1: SUCCESS (0.625s)
[194.066670] Starting dynamic subtest: pipe-B-DP-1
[194.710684] Dynamic subtest pipe-B-DP-1: SUCCESS (0.651s)
[194.720908] Starting dynamic subtest: pipe-C-DP-1
[195.437572] Dynamic subtest pipe-C-DP-1: SUCCESS (0.724s)
[195.448019] Starting dynamic subtest: pipe-D-DP-1
[196.221564] Dynamic subtest pipe-D-DP-1: SUCCESS (0.781s)
[196.222581] Subtest read-crc-frame-sequence: SUCCESS (2.791s)
[196.418100] [125/171] (806s left) kms_psr (primary_page_flip)
[196.519121] Subtest primary_page_flip: SKIP (0.000s)
[196.554720] [126/171] (806s left) kms_psr (cursor_plane_move)
[196.648575] Subtest cursor_plane_move: SKIP (0.000s)
[196.687886] [127/171] (806s left) kms_psr (sprite_plane_onoff)
[196.785939] Subtest sprite_plane_onoff: SKIP (0.000s)
[196.821132] [128/171] (806s left) kms_psr (primary_mmap_gtt)
[196.916921] Subtest primary_mmap_gtt: SKIP (0.000s)
[196.954454] [129/171] (806s left) kms_setmode (basic-clone-single-crtc)
[197.050430] Starting subtest: basic-clone-single-crtc
[197.053483] Subtest basic-clone-single-crtc: SKIP (0.001s)
[197.117928] [130/171] (806s left) i915_pm_backlight (basic-brightness)
[197.277153] Subtest basic-brightness: SKIP (0.000s)
[197.304775] [131/171] (805s left) i915_pm_rpm (basic-pci-d3-state)
[199.513675] Starting subtest: basic-pci-d3-state
[200.614641] Subtest basic-pci-d3-state: SUCCESS (1.102s)
[200.772043] [132/171] (802s left) i915_pm_rpm (basic-rte)
[200.849512] Starting subtest: basic-rte
[203.586047] Subtest basic-rte: SUCCESS (2.737s)
[204.920586] [133/171] (798s left) i915_pm_rps (basic-api)
[205.021559] Starting subtest: basic-api
[205.023477] Subtest basic-api: SKIP (0.000s)
[205.085426] [134/171] (798s left) prime_self_import (basic-llseek-bad)
[205.161882] Starting subtest: basic-llseek-bad
[205.180670] Subtest basic-llseek-bad: SUCCESS (0.018s)
[205.279822] [135/171] (797s left) prime_self_import (basic-llseek-size)
[205.361899] Starting subtest: basic-llseek-size
[205.381271] Subtest basic-llseek-size: SUCCESS (0.020s)
[205.482848] [136/171] (797s left) prime_self_import (basic-with_fd_dup)
[205.576201] Starting subtest: basic-with_fd_dup
[205.596475] Subtest basic-with_fd_dup: SUCCESS (0.019s)
[205.700994] [137/171] (797s left) prime_self_import (basic-with_one_bo)
[205.782377] Starting subtest: basic-with_one_bo
[205.802256] Subtest basic-with_one_bo: SUCCESS (0.020s)
[205.855820] [138/171] (797s left) prime_self_import (basic-with_one_bo_two_files)
[205.933877] Starting subtest: basic-with_one_bo_two_files
[205.954120] Subtest basic-with_one_bo_two_files: SUCCESS (0.020s)
[206.076052] [139/171] (797s left) prime_self_import (basic-with_two_bos)
[206.183118] Starting subtest: basic-with_two_bos
[206.204223] Subtest basic-with_two_bos: SUCCESS (0.021s)
[206.329425] [140/171] (797s left) prime_vgem (basic-fence-flip)
[206.470418] Starting subtest: basic-fence-flip
[206.582375] Subtest basic-fence-flip: SKIP (0.111s)
[206.685961] [141/171] (796s left) prime_vgem (basic-fence-mmap)
[206.803302] Starting subtest: basic-fence-mmap
[206.805585] Subtest basic-fence-mmap: SKIP (0.000s)
[206.893839] [142/171] (796s left) prime_vgem (basic-fence-read)
[207.035085] Starting subtest: basic-fence-read
[207.042181] Subtest basic-fence-read: SKIP (0.006s)
[207.163823] [143/171] (796s left) prime_vgem (basic-gtt)
[207.303709] Starting subtest: basic-gtt
[207.306017] Subtest basic-gtt: SKIP (0.000s)
[207.432173] [144/171] (796s left) prime_vgem (basic-read)
[207.554062] Starting subtest: basic-read
[207.560811] Subtest basic-read: SKIP (0.006s)
[207.668326] [145/171] (795s left) prime_vgem (basic-write)
[207.801995] Starting subtest: basic-write
[207.808555] Subtest basic-write: SKIP (0.006s)
[207.926123] [146/171] (795s left) vgem_basic (setversion)
[208.028855] Starting subtest: setversion
[208.031104] Subtest setversion: SUCCESS (0.000s)
[208.088072] [147/171] (795s left) vgem_basic (create)
[208.178668] Starting subtest: create
[208.179709] Subtest create: SUCCESS (0.000s)
[208.237312] [148/171] (795s left) vgem_basic (debugfs)
[208.328936] Starting subtest: debugfs
[208.329927] Subtest debugfs: SUCCESS (0.000s)
[208.386437] [149/171] (795s left) vgem_basic (dmabuf-export)
[208.478831] Starting subtest: dmabuf-export
[208.496673] Subtest dmabuf-export: SUCCESS (0.018s)
[208.606421] [150/171] (795s left) vgem_basic (dmabuf-fence)
[208.728917] Starting subtest: dmabuf-fence
[208.730126] Subtest dmabuf-fence: SUCCESS (0.000s)
[208.787539] [151/171] (794s left) vgem_basic (dmabuf-fence-before)
[208.878792] Starting subtest: dmabuf-fence-before
[208.879740] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[208.940447] [152/171] (794s left) vgem_basic (dmabuf-mmap)
[209.028838] Starting subtest: dmabuf-mmap
[209.042103] Subtest dmabuf-mmap: SUCCESS (0.014s)
[209.102247] [153/171] (794s left) vgem_basic (mmap)
[209.195485] Starting subtest: mmap
[209.204033] Subtest mmap: SUCCESS (0.009s)
[209.252557] [154/171] (794s left) vgem_basic (second-client)
[209.345382] Starting subtest: second-client
[209.379292] Subtest second-client: SUCCESS (0.033s)
[209.466582] [155/171] (794s left) vgem_basic (sysfs)
[209.562214] Starting subtest: sysfs
[209.563256] Subtest sysfs: SUCCESS (0.000s)
[209.618672] [156/171] (794s left) core_hotunplug (unbind-rebind)
[209.761963] Starting subtest: unbind-rebind
[212.770684] Subtest unbind-rebind: SUCCESS (3.009s)
[212.792626] [157/171] (791s left) vgem_basic (unload)
[212.872990] Starting subtest: unload
[241.866509] Subtest unload: SUCCESS (28.958s)
[241.940491] [158/171] (761s left) i915_module_load (reload)
[242.016737] Starting subtest: reload
[245.821886] Subtest reload: SUCCESS (3.805s)
[245.841610] [159/171] (757s left) gem_lmem_swapping (basic)
[249.865879] Starting subtest: basic
[249.866842] Starting dynamic subtest: lmem0
[277.894968] Dynamic subtest lmem0: SUCCESS (28.019s)
[277.896099] Subtest basic: SUCCESS (28.021s)
[280.539645] [160/171] (723s left) gem_lmem_swapping (parallel-random-engines)
[281.575032] Starting subtest: parallel-random-engines
[281.576617] Starting dynamic subtest: lmem0
[283.084675] Dynamic subtest lmem0: SUCCESS (1.501s)
[283.085673] Subtest parallel-random-engines: SUCCESS (1.502s)
[284.617251] [161/171] (719s left) gem_lmem_swapping (random-engines)
[285.633880] Starting subtest: random-engines
[285.634882] Starting dynamic subtest: lmem0
[286.885548] Dynamic subtest lmem0: SUCCESS (1.242s)
[286.886494] Subtest random-engines: SUCCESS (1.244s)
[288.436991] [162/171] (715s left) gem_lmem_swapping (verify-random)
[289.448345] Starting subtest: verify-random
[289.449334] Starting dynamic subtest: lmem0
[300.853426] Dynamic subtest lmem0: SUCCESS (11.394s)
[300.854456] Subtest verify-random: SUCCESS (11.396s)
[302.470294] [163/171] (701s left) i915_pm_rpm (module-reload)
[305.786576] Starting subtest: module-reload
[321.545815] Subtest module-reload: SUCCESS (15.750s)
[321.561391] [164/171] (682s left) i915_selftest (live)
[321.650270] Starting subtest: live
[321.651280] Starting dynamic subtest: sanitycheck
[323.810606] Dynamic subtest sanitycheck: SUCCESS (2.151s)
[323.818020] Starting dynamic subtest: uncore
[325.925446] Dynamic subtest uncore: SUCCESS (2.113s)
[325.932012] Starting dynamic subtest: workarounds
[330.582397] Dynamic subtest workarounds: SUCCESS (4.655s)
[330.588995] Starting dynamic subtest: gt_engines
[333.798389] Dynamic subtest gt_engines: SUCCESS (3.215s)
[333.805386] Starting dynamic subtest: gt_timelines
[370.035304] Dynamic subtest gt_timelines: SUCCESS (36.235s)
[370.041520] Starting dynamic subtest: gt_contexts
[372.198749] Dynamic subtest gt_contexts: SUCCESS (2.162s)
[372.205699] Starting dynamic subtest: gt_lrc
[381.275246] Dynamic subtest gt_lrc: SUCCESS (9.075s)
[381.281563] Starting dynamic subtest: gt_mocs
[385.424365] Dynamic subtest gt_mocs: SUCCESS (4.148s)
[385.430635] Starting dynamic subtest: gt_pm
[388.455954] Dynamic subtest gt_pm: SUCCESS (3.029s)
[388.462739] Starting dynamic subtest: gt_heartbeat
[390.818747] Dynamic subtest gt_heartbeat: SUCCESS (2.363s)
[390.826132] Starting dynamic subtest: gt_tlb
[407.524414] Dynamic subtest gt_tlb: SUCCESS (16.704s)
[407.530324] Starting dynamic subtest: requests
[426.192579] Dynamic subtest requests: SUCCESS (18.667s)
[426.201190] Starting dynamic subtest: migrate
[431.897367] Dynamic subtest migrate: SUCCESS (5.702s)
[431.914569] Starting dynamic subtest: active
[434.028664] Dynamic subtest active: SUCCESS (2.128s)
[434.035707] Starting dynamic subtest: objects
[437.510509] Dynamic subtest objects: SUCCESS (3.480s)
[437.517563] Starting dynamic subtest: mman
[448.230273] Dynamic subtest mman: SUCCESS (10.718s)
[448.236285] Starting dynamic subtest: dmabuf
[450.334148] Dynamic subtest dmabuf: SUCCESS (2.103s)
[450.342385] Starting dynamic subtest: vma
[452.443190] Dynamic subtest vma: SUCCESS (2.108s)
[452.449293] Starting dynamic subtest: coherency
[456.710181] Dynamic subtest coherency: SUCCESS (4.266s)
[456.716210] Starting dynamic subtest: gtt
[467.365385] Dynamic subtest gtt: SUCCESS (10.654s)
[467.372036] Starting dynamic subtest: gem
[469.493758] Dynamic subtest gem: SUCCESS (2.127s)
[469.500350] Starting dynamic subtest: evict
[474.063451] Dynamic subtest evict: SUCCESS (4.568s)
[474.070917] Starting dynamic subtest: hugepages
[493.521646] Dynamic subtest hugepages: SUCCESS (19.457s)
[493.532894] Starting dynamic subtest: gem_contexts
[541.655550] Dynamic subtest gem_contexts: SUCCESS (48.106s)
[541.661625] Starting dynamic subtest: client
[543.802352] Dynamic subtest client: SUCCESS (2.172s)
[543.808999] Starting dynamic subtest: gem_migrate
[548.895543] Dynamic subtest gem_migrate: SUCCESS (5.092s)
[548.902944] Starting dynamic subtest: reset
[551.109341] Dynamic subtest reset: SUCCESS (2.213s)
[551.116236] Starting dynamic subtest: memory_region
[554.768510] Dynamic subtest memory_region: SUCCESS (3.658s)
[554.776049] Starting dynamic subtest: hangcheck
[602.846334] Dynamic subtest hangcheck: SUCCESS (48.077s)
[602.853317] Starting dynamic subtest: execlists
[604.968919] Dynamic subtest execlists: SUCCESS (2.121s)
[604.974927] Starting dynamic subtest: ring_submission
[607.099373] Dynamic subtest ring_submission: SUCCESS (2.129s)
[607.105403] Starting dynamic subtest: perf
[609.355151] Dynamic subtest perf: SUCCESS (2.254s)
[609.365371] Starting dynamic subtest: slpc
[619.315396] Dynamic subtest slpc: SUCCESS (9.959s)
[619.321556] Starting dynamic subtest: guc
[622.841492] Dynamic subtest guc: SUCCESS (3.525s)
[622.848498] Starting dynamic subtest: guc_multi_lrc
[625.004654] Dynamic subtest guc_multi_lrc: SUCCESS (2.162s)
[625.011843] Starting dynamic subtest: guc_hang
[627.862635] Dynamic subtest guc_hang: SUCCESS (2.856s)
[627.869866] Starting dynamic subtest: late_gt_pm
[630.034430] Dynamic subtest late_gt_pm: SUCCESS (2.170s)
[630.035467] Subtest live: SUCCESS (308.376s)
[630.474683] [165/171] (373s left) dmabuf (all-tests)
[630.579754] Starting subtest: all-tests
[630.581186] Starting dynamic subtest: sanitycheck
[630.651811] Dynamic subtest sanitycheck: SUCCESS (0.071s)
[630.670999] Starting dynamic subtest: dma_fence
[630.843662] Dynamic subtest dma_fence: SUCCESS (0.189s)
[630.859610] Starting dynamic subtest: dma_fence_chain
[644.624093] Dynamic subtest dma_fence_chain: SUCCESS (13.770s)
[644.630433] Starting dynamic subtest: dma_fence_unwrap
[644.706251] Dynamic subtest dma_fence_unwrap: SUCCESS (0.086s)
[644.734339] Starting dynamic subtest: dma_resv
[644.807277] Dynamic subtest dma_resv: SUCCESS (0.095s)
[644.809258] Subtest all-tests: SUCCESS (14.229s)
[644.863329] [166/171] (359s left) i915_suspend (basic-s2idle-without-i915)
[644.971402] Starting subtest: basic-s2idle-without-i915
[665.938629] Subtest basic-s2idle-without-i915: SUCCESS (5.846s)
[666.142314] [167/171] (353s left) i915_suspend (basic-s3-without-i915)
[666.225952] Starting subtest: basic-s3-without-i915
[669.139952] Subtest basic-s3-without-i915: SKIP (2.901s)
[670.067258] [168/171] (349s left) gem_exec_suspend (basic-s0)
[670.186536] Starting subtest: basic-S0
[670.187485] Starting dynamic subtest: smem
[690.634999] Dynamic subtest smem: SUCCESS (5.868s)
[690.645724] Starting dynamic subtest: lmem0
[710.646235] Dynamic subtest lmem0: SUCCESS (5.857s)
[710.647392] Subtest basic-S0: SUCCESS (11.728s)
[710.871416] [169/171] (337s left) gem_exec_suspend (basic-s3)
[710.979046] Starting subtest: basic-S3
[710.980000] Starting dynamic subtest: smem
[731.644544] Dynamic subtest smem: SUCCESS (5.805s)
[731.655888] Starting dynamic subtest: lmem0
[751.613714] Dynamic subtest lmem0: SUCCESS (5.870s)
[751.615093] Subtest basic-S3: SUCCESS (11.679s)
[751.814999] [170/171] (325s left) kms_chamelium_hpd (common-hpd-after-suspend)
[752.051774] Subtest common-hpd-after-suspend: SKIP (0.000s)
[752.187160] [171/171] (324s left) kms_pipe_crc_basic (suspend-read-crc)
[752.346675] Starting subtest: suspend-read-crc
[752.347703] Starting dynamic subtest: pipe-A-DP-1
[769.952743] Dynamic subtest pipe-A-DP-1: SUCCESS (2.894s)
[769.963531] Starting dynamic subtest: pipe-B-DP-1
[788.016606] Dynamic subtest pipe-B-DP-1: SUCCESS (2.887s)
[788.027347] Starting dynamic subtest: pipe-C-DP-1
[806.077927] Dynamic subtest pipe-C-DP-1: SUCCESS (3.039s)
[806.091672] Starting dynamic subtest: pipe-D-DP-1
[824.149560] Dynamic subtest pipe-D-DP-1: SUCCESS (3.170s)
[824.150637] Subtest suspend-read-crc: SUCCESS (12.002s)
[824.310456] Closing watchdogs
Done.