[25.075212] Initializing watchdogs
[25.075255]   /dev/watchdog0
[25.083358] [001/171] (960s left) i915_module_load (load)
[25.140775] Starting subtest: load
[26.376157] Subtest load: SUCCESS (1.240s)
[26.400868] [002/171] (959s left) core_auth (basic-auth)
[26.455109] Starting subtest: basic-auth
[26.461173] Subtest basic-auth: SUCCESS (0.000s)
[26.501623] [003/171] (959s left) debugfs_test (read_all_entries)
[26.553060] Starting subtest: read_all_entries
[26.634246] Subtest read_all_entries: SUCCESS (0.079s)
[26.661535] [004/171] (958s left) debugfs_test (basic-hwmon)
[26.709243] Starting subtest: basic-hwmon
[26.720769] Subtest basic-hwmon: SKIP (0.000s)
[26.741894] [005/171] (958s left) fbdev (eof)
[27.063960] Subtest eof: SKIP (0.000s)
[27.084240] [006/171] (958s left) fbdev (info)
[27.138644] Subtest info: SKIP (0.000s)
[27.166665] [007/171] (958s left) fbdev (nullptr)
[27.232966] Subtest nullptr: SKIP (0.000s)
[27.256569] [008/171] (958s left) fbdev (read)
[27.321249] Subtest read: SKIP (0.000s)
[27.347673] [009/171] (958s left) fbdev (write)
[27.419362] Subtest write: SKIP (0.000s)
[27.445850] [010/171] (958s left) gem_basic (bad-close)
[27.496650] Starting subtest: bad-close
[27.507593] Subtest bad-close: SUCCESS (0.000s)
[27.538989] [011/171] (958s left) gem_basic (create-close)
[27.595465] Starting subtest: create-close
[27.606530] Subtest create-close: SUCCESS (0.000s)
[27.626399] [012/171] (958s left) gem_basic (create-fd-close)
[27.667417] Starting subtest: create-fd-close
[27.678412] Subtest create-fd-close: SUCCESS (0.000s)
[27.705340] [013/171] (958s left) gem_busy (busy@all-engines)
[27.764449] Starting subtest: busy
[27.769910] Starting dynamic subtest: all-engines
[27.781062] Dynamic subtest all-engines: SUCCESS (0.013s)
[27.786621] Subtest busy: SUCCESS (0.013s)
[28.063250] [014/171] (957s left) gem_close_race (basic-process)
[28.119780] Starting subtest: basic-process
[28.157847] Subtest basic-process: SUCCESS (0.038s)
[28.289476] [015/171] (957s left) gem_close_race (basic-threads)
[28.346198] Starting subtest: basic-threads
[29.546797] Subtest basic-threads: SUCCESS (1.200s)
[29.676720] [016/171] (956s left) gem_ctx_create (basic)
[29.726519] Starting subtest: basic
[29.732145] Subtest basic: SUCCESS (0.000s)
[29.864397] [017/171] (956s left) gem_ctx_create (basic-files)
[29.915011] Starting subtest: basic-files
[31.999406] Subtest basic-files: SUCCESS (2.075s)
[32.126177] [018/171] (953s left) gem_ctx_exec (basic)
[32.193043] Starting subtest: basic
[32.199145] Subtest basic: SUCCESS (0.002s)
[32.250854] [019/171] (953s left) gem_exec_basic (basic)
[32.301584] Starting subtest: basic
[32.307075] Starting dynamic subtest: rcs0-smem
[32.312582] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[32.322195] Starting dynamic subtest: bcs0-smem
[32.327884] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[32.340855] Starting dynamic subtest: vcs0-smem
[32.347433] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[32.358745] Starting dynamic subtest: vcs1-smem
[32.364281] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[32.375151] Starting dynamic subtest: vecs0-smem
[32.380898] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[32.386790] Subtest basic: SUCCESS (0.003s)
[32.436390] [020/171] (953s left) gem_exec_create (basic)
[32.489363] Starting subtest: basic
[32.494920] Starting dynamic subtest: smem
[34.569550] Dynamic subtest smem: SUCCESS (2.080s)
[34.575608] Subtest basic: SUCCESS (2.080s)
[34.705454] [021/171] (951s left) gem_exec_fence (basic-busy)
[34.886627] Starting subtest: basic-busy
[34.892486] Starting dynamic subtest: rcs0
[34.955081] Dynamic subtest rcs0: SUCCESS (0.068s)
[34.969116] Starting dynamic subtest: bcs0
[35.001891] Dynamic subtest bcs0: SUCCESS (0.047s)
[35.015230] Starting dynamic subtest: vcs0
[35.053326] Dynamic subtest vcs0: SUCCESS (0.051s)
[35.067519] Starting dynamic subtest: vcs1
[35.101255] Dynamic subtest vcs1: SUCCESS (0.047s)
[35.115113] Starting dynamic subtest: vecs0
[35.148882] Dynamic subtest vecs0: SUCCESS (0.048s)
[35.154873] Subtest basic-busy: SUCCESS (0.262s)
[35.594572] [022/171] (950s left) gem_exec_fence (basic-wait)
[35.768108] Starting subtest: basic-wait
[35.773736] Starting dynamic subtest: rcs0
[35.841131] Dynamic subtest rcs0: SUCCESS (0.073s)
[35.854688] Starting dynamic subtest: bcs0
[35.889435] Dynamic subtest bcs0: SUCCESS (0.048s)
[35.903445] Starting dynamic subtest: vcs0
[35.941564] Dynamic subtest vcs0: SUCCESS (0.052s)
[35.955583] Starting dynamic subtest: vcs1
[35.990525] Dynamic subtest vcs1: SUCCESS (0.049s)
[36.004699] Starting dynamic subtest: vecs0
[36.045482] Dynamic subtest vecs0: SUCCESS (0.055s)
[36.051996] Subtest basic-wait: SUCCESS (0.277s)
[36.464043] [023/171] (949s left) gem_exec_fence (basic-await)
[36.623543] Starting subtest: basic-await
[36.629689] Starting dynamic subtest: rcs0
[36.695586] Dynamic subtest rcs0: SUCCESS (0.072s)
[36.708699] Starting dynamic subtest: bcs0
[36.769123] Dynamic subtest bcs0: SUCCESS (0.074s)
[36.776720] Starting dynamic subtest: vcs0
[36.832625] Dynamic subtest vcs0: SUCCESS (0.063s)
[36.845926] Starting dynamic subtest: vcs1
[36.901822] Dynamic subtest vcs1: SUCCESS (0.069s)
[36.909355] Starting dynamic subtest: vecs0
[36.963692] Dynamic subtest vecs0: SUCCESS (0.062s)
[36.969134] Subtest basic-await: SUCCESS (0.341s)
[37.384869] [024/171] (948s left) gem_exec_fence (nb-await)
[37.548475] Starting subtest: nb-await
[37.554229] Starting dynamic subtest: rcs0
[37.612229] Dynamic subtest rcs0: SUCCESS (0.064s)
[37.624359] Starting dynamic subtest: bcs0
[37.673139] Dynamic subtest bcs0: SUCCESS (0.061s)
[37.687164] Starting dynamic subtest: vcs0
[37.732564] Dynamic subtest vcs0: SUCCESS (0.059s)
[37.745799] Starting dynamic subtest: vcs1
[37.790224] Dynamic subtest vcs1: SUCCESS (0.057s)
[37.803215] Starting dynamic subtest: vecs0
[37.849559] Dynamic subtest vecs0: SUCCESS (0.059s)
[37.855827] Subtest nb-await: SUCCESS (0.301s)
[38.261926] [025/171] (947s left) gem_exec_gttfill (basic)
[38.315112] Starting subtest: basic
[41.055840] Subtest basic: SUCCESS (2.745s)
[41.186745] [026/171] (945s left) gem_exec_parallel (engines)
[41.263630] Starting subtest: engines
[41.269145] Starting dynamic subtest: basic
[44.695893] Dynamic subtest basic: SUCCESS (3.437s)
[44.703830] Starting dynamic subtest: contexts
[47.091897] Dynamic subtest contexts: SUCCESS (2.396s)
[47.103273] Starting dynamic subtest: fds
[49.017708] Dynamic subtest fds: SUCCESS (1.926s)
[49.027371] Starting dynamic subtest: userptr
[51.323884] Dynamic subtest userptr: SUCCESS (2.306s)
[51.329733] Subtest engines: SUCCESS (10.065s)
[51.468075] [027/171] (934s left) gem_exec_store (basic)
[51.550990] Starting subtest: basic
[51.618584] Subtest basic: SUCCESS (0.083s)
[51.756216] [028/171] (934s left) gem_flink_basic (bad-flink)
[51.807906] Starting subtest: bad-flink
[51.813643] Subtest bad-flink: SUCCESS (0.000s)
[51.842283] [029/171] (934s left) gem_flink_basic (bad-open)
[51.908651] Starting subtest: bad-open
[51.914491] Subtest bad-open: SUCCESS (0.000s)
[51.943866] [030/171] (934s left) gem_flink_basic (basic)
[51.994567] Starting subtest: basic
[52.000297] Subtest basic: SUCCESS (0.000s)
[52.044607] [031/171] (934s left) gem_flink_basic (double-flink)
[52.107179] Starting subtest: double-flink
[52.112783] Subtest double-flink: SUCCESS (0.000s)
[52.148528] [032/171] (934s left) gem_flink_basic (flink-lifetime)
[52.210856] Starting subtest: flink-lifetime
[52.216762] Subtest flink-lifetime: SUCCESS (0.000s)
[52.259662] [033/171] (934s left) gem_huc_copy (huc-copy)
[52.315074] Starting subtest: huc-copy
[52.320689] Subtest huc-copy: SUCCESS (0.003s)
[52.374636] [034/171] (934s left) gem_linear_blits (basic)
[52.482693] Starting subtest: basic
[52.488696] Subtest basic: SUCCESS (0.004s)
[52.547381] [035/171] (933s left) gem_mmap (basic)
[52.634555] Starting subtest: basic
[52.662633] Subtest basic: SUCCESS (0.000s)
[52.691729] [036/171] (933s left) gem_mmap_gtt (basic)
[52.748642] Starting subtest: basic
[52.754055] Subtest basic: SUCCESS (0.000s)
[52.782974] [037/171] (933s left) gem_render_linear_blits (basic)
[52.851687] Starting subtest: basic
[52.879134] Subtest basic: SUCCESS (0.026s)
[52.938338] [038/171] (933s left) gem_render_tiled_blits (basic)
[52.988361] Starting subtest: basic
[53.020955] Subtest basic: SUCCESS (0.030s)
[53.076307] [039/171] (933s left) gem_ringfill (basic-all)
[53.447217] Starting subtest: basic-all
[54.560267] Subtest basic-all: SUCCESS (1.111s)
[54.603553] [040/171] (932s left) gem_softpin (allocator-basic)
[54.657508] Starting subtest: allocator-basic
[54.697386] Subtest allocator-basic: SUCCESS (0.042s)
[54.744085] [041/171] (931s left) gem_softpin (allocator-basic-reserve)
[54.796372] Starting subtest: allocator-basic-reserve
[54.830142] Subtest allocator-basic-reserve: SUCCESS (0.037s)
[54.870819] [042/171] (931s left) gem_softpin (safe-alignment)
[54.918717] Starting subtest: safe-alignment
[54.929771] Subtest safe-alignment: SUCCESS (0.009s)
[54.975290] [043/171] (931s left) gem_sync (basic-all)
[55.070883] Starting subtest: basic-all
[57.739389] Subtest basic-all: SUCCESS (2.707s)
[57.879873] [044/171] (928s left) gem_sync (basic-each)
[57.965855] Starting subtest: basic-each
[60.324600] Subtest basic-each: SUCCESS (2.395s)
[60.467149] [045/171] (926s left) gem_tiled_blits (basic)
[60.548250] Starting subtest: basic
[60.559518] Subtest basic: SUCCESS (0.009s)
[60.615144] [046/171] (926s left) gem_tiled_fence_blits (basic)
[60.742433] Starting subtest: basic
[60.755422] Subtest basic: SUCCESS (0.013s)
[60.816719] [047/171] (926s left) gem_tiled_pread_basic
[60.946489] [048/171] (925s left) gem_wait (busy@all-engines)
[61.004566] Starting subtest: busy
[61.009998] Starting dynamic subtest: all-engines
[61.548515] Dynamic subtest all-engines: SUCCESS (0.548s)
[61.554827] Subtest busy: SUCCESS (0.548s)
[61.699821] [049/171] (925s left) gem_wait (wait@all-engines)
[61.756372] Starting subtest: wait
[61.761829] Starting dynamic subtest: all-engines
[62.801320] Dynamic subtest all-engines: SUCCESS (1.049s)
[62.807563] Subtest wait: SUCCESS (1.050s)
[62.957210] [050/171] (924s left) i915_getparams_basic (basic-eu-total)
[63.023251] Starting subtest: basic-eu-total
[63.034160] Subtest basic-eu-total: SUCCESS (0.000s)
[63.059017] [051/171] (923s left) i915_getparams_basic (basic-subslice-total)
[63.101220] Starting subtest: basic-subslice-total
[63.112466] Subtest basic-subslice-total: SUCCESS (0.000s)
[63.141103] [052/171] (923s left) i915_hangman (error-state-basic)
[63.203192] Starting subtest: error-state-basic
[63.277517] Subtest error-state-basic: SUCCESS (0.076s)
[63.297914] [053/171] (923s left) i915_pciid
[63.401256] [054/171] (923s left) kms_addfb_basic (addfb25-bad-modifier)
[63.458135] Starting subtest: addfb25-bad-modifier
[63.463546] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[63.502894] [055/171] (923s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[63.559633] Starting subtest: addfb25-framebuffer-vs-set-tiling
[63.565046] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[63.597846] [056/171] (923s left) kms_addfb_basic (addfb25-modifier-no-flag)
[63.648616] Starting subtest: addfb25-modifier-no-flag
[63.653946] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[63.684854] [057/171] (923s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[63.734066] Starting subtest: addfb25-x-tiled-legacy
[63.739455] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[63.773768] [058/171] (923s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[63.821863] Starting subtest: addfb25-x-tiled-mismatch-legacy
[63.827307] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[63.859873] [059/171] (923s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[63.923490] Starting subtest: addfb25-yf-tiled-legacy
[63.928963] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[63.963363] [060/171] (923s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[64.037345] Starting subtest: addfb25-y-tiled-legacy
[64.042872] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[64.063642] [061/171] (923s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[64.127299] Starting subtest: addfb25-y-tiled-small-legacy
[64.132768] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[64.175644] [062/171] (923s left) kms_addfb_basic (bad-pitch-0)
[64.233132] Starting subtest: bad-pitch-0
[64.238644] Subtest bad-pitch-0: SUCCESS (0.000s)
[64.275118] [063/171] (923s left) kms_addfb_basic (bad-pitch-1024)
[64.328487] Starting subtest: bad-pitch-1024
[64.334107] Subtest bad-pitch-1024: SUCCESS (0.000s)
[64.380185] [064/171] (922s left) kms_addfb_basic (bad-pitch-128)
[64.441651] Starting subtest: bad-pitch-128
[64.447070] Subtest bad-pitch-128: SUCCESS (0.000s)
[64.492633] [065/171] (922s left) kms_addfb_basic (bad-pitch-256)
[64.547642] Starting subtest: bad-pitch-256
[64.553012] Subtest bad-pitch-256: SUCCESS (0.000s)
[64.579862] [066/171] (922s left) kms_addfb_basic (bad-pitch-32)
[64.627268] Starting subtest: bad-pitch-32
[64.633189] Subtest bad-pitch-32: SUCCESS (0.000s)
[64.667859] [067/171] (922s left) kms_addfb_basic (bad-pitch-63)
[64.715752] Starting subtest: bad-pitch-63
[64.721067] Subtest bad-pitch-63: SUCCESS (0.000s)
[64.754835] [068/171] (922s left) kms_addfb_basic (bad-pitch-65536)
[64.806930] Starting subtest: bad-pitch-65536
[64.812672] Subtest bad-pitch-65536: SUCCESS (0.000s)
[64.836252] [069/171] (922s left) kms_addfb_basic (bad-pitch-999)
[64.884221] Starting subtest: bad-pitch-999
[64.890017] Subtest bad-pitch-999: SUCCESS (0.000s)
[64.927933] [070/171] (922s left) kms_addfb_basic (basic)
[64.982101] Starting subtest: basic
[64.987836] Subtest basic: SUCCESS (0.000s)
[65.024827] [071/171] (922s left) kms_addfb_basic (basic-x-tiled-legacy)
[65.072816] Starting subtest: basic-x-tiled-legacy
[65.078672] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[65.116707] [072/171] (922s left) kms_addfb_basic (basic-y-tiled-legacy)
[65.169854] Starting subtest: basic-y-tiled-legacy
[65.175555] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[65.209641] [073/171] (922s left) kms_addfb_basic (bo-too-small)
[65.277286] Starting subtest: bo-too-small
[65.283178] Subtest bo-too-small: SUCCESS (0.000s)
[65.307803] [074/171] (922s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[65.373885] Starting subtest: bo-too-small-due-to-tiling
[65.379691] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[65.401315] [075/171] (922s left) kms_addfb_basic (clobberred-modifier)
[65.455243] Starting subtest: clobberred-modifier
[65.461188] Subtest clobberred-modifier: SUCCESS (0.000s)
[65.492824] [076/171] (922s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[65.544491] Starting subtest: framebuffer-vs-set-tiling
[65.550288] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[65.588021] [077/171] (921s left) kms_addfb_basic (invalid-get-prop)
[65.641398] Starting subtest: invalid-get-prop
[65.647172] Subtest invalid-get-prop: SUCCESS (0.000s)
[65.687745] [078/171] (921s left) kms_addfb_basic (invalid-get-prop-any)
[65.744969] Starting subtest: invalid-get-prop-any
[65.750493] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[65.776940] [079/171] (921s left) kms_addfb_basic (invalid-set-prop)
[65.824865] Starting subtest: invalid-set-prop
[65.830639] Subtest invalid-set-prop: SUCCESS (0.000s)
[65.858969] [080/171] (921s left) kms_addfb_basic (invalid-set-prop-any)
[65.905435] Starting subtest: invalid-set-prop-any
[65.910882] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[65.945741] [081/171] (921s left) kms_addfb_basic (no-handle)
[65.992931] Starting subtest: no-handle
[65.998543] Subtest no-handle: SUCCESS (0.000s)
[66.026086] [082/171] (921s left) kms_addfb_basic (size-max)
[66.085550] Starting subtest: size-max
[66.091048] Subtest size-max: SUCCESS (0.000s)
[66.112092] [083/171] (921s left) kms_addfb_basic (small-bo)
[66.174699] Starting subtest: small-bo
[66.180225] Subtest small-bo: SUCCESS (0.000s)
[66.204118] [084/171] (921s left) kms_addfb_basic (tile-pitch-mismatch)
[66.256033] Starting subtest: tile-pitch-mismatch
[66.261809] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[66.293126] [085/171] (921s left) kms_addfb_basic (too-high)
[66.354319] Starting subtest: too-high
[66.359715] Subtest too-high: SUCCESS (0.000s)
[66.380602] [086/171] (921s left) kms_addfb_basic (too-wide)
[66.441536] Starting subtest: too-wide
[66.447056] Subtest too-wide: SUCCESS (0.000s)
[66.467626] [087/171] (921s left) kms_addfb_basic (unused-handle)
[66.517265] Starting subtest: unused-handle
[66.522696] Subtest unused-handle: SUCCESS (0.000s)
[66.561650] [088/171] (921s left) kms_addfb_basic (unused-modifier)
[66.613613] Starting subtest: unused-modifier
[66.619128] Subtest unused-modifier: SUCCESS (0.000s)
[66.643707] [089/171] (921s left) kms_addfb_basic (unused-offsets)
[66.691379] Starting subtest: unused-offsets
[66.696817] Subtest unused-offsets: SUCCESS (0.000s)
[66.723052] [090/171] (921s left) kms_addfb_basic (unused-pitches)
[66.770163] Starting subtest: unused-pitches
[66.775521] Subtest unused-pitches: SUCCESS (0.000s)
[66.809724] [091/171] (921s left) kms_busy (basic)
[66.876376] Subtest basic: SKIP (0.000s)
[66.898705] [092/171] (920s left) kms_chamelium_hpd (dp-hpd-fast)
[66.977162] Subtest dp-hpd-fast: SKIP (0.000s)
[66.997501] [093/171] (920s left) kms_chamelium_edid (dp-edid-read)
[67.069568] Subtest dp-edid-read: SKIP (0.000s)
[67.089784] [094/171] (920s left) kms_chamelium_frames (dp-crc-fast)
[67.158959] Subtest dp-crc-fast: SKIP (0.000s)
[67.179185] [095/171] (920s left) kms_chamelium_hpd (hdmi-hpd-fast)
[67.241489] Subtest hdmi-hpd-fast: SKIP (0.000s)
[67.261783] [096/171] (920s left) kms_chamelium_edid (hdmi-edid-read)
[67.325796] Subtest hdmi-edid-read: SKIP (0.000s)
[67.346600] [097/171] (920s left) kms_chamelium_frames (hdmi-crc-fast)
[67.411879] Subtest hdmi-crc-fast: SKIP (0.000s)
[67.432313] [098/171] (920s left) kms_chamelium_hpd (vga-hpd-fast)
[67.501591] Subtest vga-hpd-fast: SKIP (0.000s)
[67.523794] [099/171] (920s left) kms_chamelium_edid (vga-edid-read)
[67.591376] Subtest vga-edid-read: SKIP (0.000s)
[67.611668] [100/171] (920s left) kms_prop_blob (basic)
[67.659578] Starting subtest: basic
[67.665084] Subtest basic: SUCCESS (0.000s)
[67.690169] [101/171] (920s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[67.806092] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[67.837669] [102/171] (920s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[67.944444] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[67.972705] [103/171] (920s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[68.073089] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[68.100017] [104/171] (920s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[68.188958] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s)
[68.225750] [105/171] (920s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[68.325638] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s)
[68.362683] [106/171] (920s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[68.473439] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[68.510474] [107/171] (920s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[68.622233] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s)
[68.658952] [108/171] (919s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[68.758551] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s)
[68.795648] [109/171] (919s left) kms_flip (basic-flip-vs-dpms)
[68.867426] Starting subtest: basic-flip-vs-dpms
[68.879345] Subtest basic-flip-vs-dpms: SKIP (0.001s)
[68.911714] [110/171] (919s left) kms_flip (basic-flip-vs-modeset)
[68.982649] Starting subtest: basic-flip-vs-modeset
[68.993641] Subtest basic-flip-vs-modeset: SKIP (0.001s)
[69.024251] [111/171] (919s left) kms_flip (basic-flip-vs-wf_vblank)
[69.092516] Starting subtest: basic-flip-vs-wf_vblank
[69.103627] Subtest basic-flip-vs-wf_vblank: SKIP (0.001s)
[69.124052] [112/171] (919s left) kms_flip (basic-plain-flip)
[69.176047] Starting subtest: basic-plain-flip
[69.187062] Subtest basic-plain-flip: SKIP (0.001s)
[69.213504] [113/171] (919s left) kms_force_connector_basic (force-connector-state)
[69.285257] Starting subtest: force-connector-state
[69.628265] Subtest force-connector-state: SUCCESS (0.343s)
[69.738478] [114/171] (919s left) kms_force_connector_basic (force-edid)
[69.797048] Starting subtest: force-edid
[69.945660] Subtest force-edid: SUCCESS (0.150s)
[70.012021] [115/171] (918s left) kms_force_connector_basic (force-load-detect)
[70.071031] Starting subtest: force-load-detect
[70.081855] Subtest force-load-detect: SKIP (0.000s)
[70.125729] [116/171] (918s left) kms_force_connector_basic (prune-stale-modes)
[70.179083] Starting subtest: prune-stale-modes
[70.337669] Subtest prune-stale-modes: SUCCESS (0.154s)
[70.400208] [117/171] (918s left) kms_frontbuffer_tracking (basic)
[70.474459] Subtest basic: SKIP (0.000s)
[70.511270] [118/171] (918s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[70.581034] Subtest compare-crc-sanitycheck: SKIP (0.000s)
[70.607170] [119/171] (918s left) kms_pipe_crc_basic (hang-read-crc)
[70.676315] Subtest hang-read-crc: SKIP (0.000s)
[70.702289] [120/171] (918s left) kms_pipe_crc_basic (nonblocking-crc)
[70.775708] Subtest nonblocking-crc: SKIP (0.000s)
[70.801349] [121/171] (918s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[70.874901] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s)
[70.900462] [122/171] (918s left) kms_pipe_crc_basic (read-crc)
[70.969831] Subtest read-crc: SKIP (0.000s)
[70.992099] [123/171] (917s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[71.069094] Subtest read-crc-frame-sequence: SKIP (0.000s)
[71.089960] [124/171] (917s left) kms_psr (primary_page_flip)
[71.146327] Subtest primary_page_flip: SKIP (0.000s)
[71.172706] [125/171] (917s left) kms_psr (cursor_plane_move)
[71.229719] Subtest cursor_plane_move: SKIP (0.000s)
[71.259195] [126/171] (917s left) kms_psr (sprite_plane_onoff)
[71.319141] Subtest sprite_plane_onoff: SKIP (0.000s)
[71.348242] [127/171] (917s left) kms_psr (primary_mmap_gtt)
[71.409391] Subtest primary_mmap_gtt: SKIP (0.000s)
[71.430853] [128/171] (917s left) kms_setmode (basic-clone-single-crtc)
[71.477668] Starting subtest: basic-clone-single-crtc
[71.494385] Subtest basic-clone-single-crtc: SKIP (0.000s)
[71.523595] [129/171] (917s left) i915_pm_backlight (basic-brightness)
[71.600443] Subtest basic-brightness: SKIP (0.000s)
[71.624270] [130/171] (917s left) i915_pm_rpm (basic-pci-d3-state)
[72.993981] Starting subtest: basic-pci-d3-state
[73.241872] Subtest basic-pci-d3-state: SUCCESS (0.243s)
[73.333881] [131/171] (915s left) i915_pm_rpm (basic-rte)
[73.382188] Starting subtest: basic-rte
[74.859565] Subtest basic-rte: SUCCESS (1.481s)
[75.158257] [132/171] (914s left) i915_pm_rps (basic-api)
[75.211674] Starting subtest: basic-api
[75.222558] Subtest basic-api: SKIP (0.001s)
[75.243678] [133/171] (913s left) prime_self_import (basic-llseek-bad)
[75.291257] Starting subtest: basic-llseek-bad
[75.296903] Subtest basic-llseek-bad: SUCCESS (0.001s)
[75.345861] [134/171] (913s left) prime_self_import (basic-llseek-size)
[75.395019] Starting subtest: basic-llseek-size
[75.400593] Subtest basic-llseek-size: SUCCESS (0.001s)
[75.445038] [135/171] (913s left) prime_self_import (basic-with_fd_dup)
[75.495089] Starting subtest: basic-with_fd_dup
[75.500566] Subtest basic-with_fd_dup: SUCCESS (0.001s)
[75.553269] [136/171] (913s left) prime_self_import (basic-with_one_bo)
[75.601119] Starting subtest: basic-with_one_bo
[75.606649] Subtest basic-with_one_bo: SUCCESS (0.001s)
[75.627899] [137/171] (913s left) prime_self_import (basic-with_one_bo_two_files)
[75.678610] Starting subtest: basic-with_one_bo_two_files
[75.684572] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s)
[75.725315] [138/171] (913s left) prime_self_import (basic-with_two_bos)
[75.777601] Starting subtest: basic-with_two_bos
[75.783610] Subtest basic-with_two_bos: SUCCESS (0.001s)
[75.823798] [139/171] (913s left) prime_vgem (basic-fence-flip)
[75.891541] Starting subtest: basic-fence-flip
[75.919463] Subtest basic-fence-flip: SKIP (0.021s)
[75.957191] [140/171] (913s left) prime_vgem (basic-fence-mmap)
[76.013024] Starting subtest: basic-fence-mmap
[76.024660] Subtest basic-fence-mmap: SUCCESS (0.014s)
[76.089621] [141/171] (913s left) prime_vgem (basic-fence-read)
[76.147091] Starting subtest: basic-fence-read
[76.158134] Subtest basic-fence-read: SKIP (0.004s)
[76.208613] [142/171] (913s left) prime_vgem (basic-gtt)
[76.267029] Starting subtest: basic-gtt
[76.278065] Subtest basic-gtt: SUCCESS (0.007s)
[76.333919] [143/171] (913s left) prime_vgem (basic-read)
[76.390577] Starting subtest: basic-read
[76.401632] Subtest basic-read: SKIP (0.004s)
[76.463821] [144/171] (912s left) prime_vgem (basic-write)
[76.530917] Starting subtest: basic-write
[76.541810] Subtest basic-write: SKIP (0.003s)
[76.587675] [145/171] (912s left) prime_vgem (basic-userptr)
[76.640062] Starting subtest: basic-userptr
[76.651030] Subtest basic-userptr: SKIP (0.003s)
[76.694308] [146/171] (912s left) vgem_basic (setversion)
[76.752503] Starting subtest: setversion
[76.767325] Subtest setversion: SUCCESS (0.000s)
[76.788578] [147/171] (912s left) vgem_basic (create)
[76.835232] Starting subtest: create
[76.840695] Subtest create: SUCCESS (0.000s)
[76.861832] [148/171] (912s left) vgem_basic (debugfs)
[76.914250] Starting subtest: debugfs
[76.919759] Subtest debugfs: SUCCESS (0.000s)
[76.940776] [149/171] (912s left) vgem_basic (dmabuf-export)
[76.997138] Starting subtest: dmabuf-export
[77.008081] Subtest dmabuf-export: SUCCESS (0.016s)
[77.077213] [150/171] (912s left) vgem_basic (dmabuf-fence)
[77.133974] Starting subtest: dmabuf-fence
[77.139600] Subtest dmabuf-fence: SUCCESS (0.000s)
[77.160817] [151/171] (912s left) vgem_basic (dmabuf-fence-before)
[77.211707] Starting subtest: dmabuf-fence-before
[77.216908] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[77.237590] [152/171] (912s left) vgem_basic (dmabuf-mmap)
[77.293965] Starting subtest: dmabuf-mmap
[77.299436] Subtest dmabuf-mmap: SUCCESS (0.010s)
[77.327048] [153/171] (912s left) vgem_basic (mmap)
[77.379844] Starting subtest: mmap
[77.385405] Subtest mmap: SUCCESS (0.006s)
[77.406278] [154/171] (912s left) vgem_basic (second-client)
[77.463849] Starting subtest: second-client
[77.475841] Subtest second-client: SUCCESS (0.011s)
[77.503354] [155/171] (912s left) vgem_basic (sysfs)
[77.551118] Starting subtest: sysfs
[77.556889] Subtest sysfs: SUCCESS (0.000s)
[77.579252] [156/171] (912s left) core_hotunplug (unbind-rebind)
[77.644559] Starting subtest: unbind-rebind
[79.244745] Subtest unbind-rebind: SUCCESS (1.599s)
[79.279086] [157/171] (910s left) vgem_basic (unload)
[79.326863] Starting subtest: unload
[107.986790] Subtest unload: SUCCESS (28.656s)
[108.021506] [158/171] (881s left) i915_module_load (reload)
[108.084919] Starting subtest: reload
[110.080795] Subtest reload: SUCCESS (2.000s)
[110.102264] [159/171] (879s left) gem_lmem_swapping (basic)
[110.155736] Subtest basic: SKIP (0.000s)
[110.179118] [160/171] (879s left) gem_lmem_swapping (parallel-random-engines)
[110.230599] Subtest parallel-random-engines: SKIP (0.000s)
[110.259719] [161/171] (879s left) gem_lmem_swapping (random-engines)
[110.316915] Subtest random-engines: SKIP (0.000s)
[110.337716] [162/171] (879s left) gem_lmem_swapping (verify-random)
[110.383974] Subtest verify-random: SKIP (0.000s)
[110.413728] [163/171] (879s left) i915_pm_rpm (module-reload)
[111.998739] Starting subtest: module-reload
[119.229908] Subtest module-reload: SUCCESS (7.223s)
[119.259724] [164/171] (870s left) i915_selftest (live)
[119.316648] Starting subtest: live
[119.322152] Starting dynamic subtest: sanitycheck
[120.849450] Dynamic subtest sanitycheck: SUCCESS (1.527s)
[120.857408] Starting dynamic subtest: uncore
[122.421252] Dynamic subtest uncore: SUCCESS (1.572s)
[122.429214] Starting dynamic subtest: workarounds
[124.933101] Dynamic subtest workarounds: SUCCESS (2.512s)
[124.940971] Starting dynamic subtest: gt_engines
[127.005922] Dynamic subtest gt_engines: SUCCESS (2.073s)
[127.013754] Starting dynamic subtest: gt_timelines
[149.252310] Dynamic subtest gt_timelines: SUCCESS (22.246s)
[149.260295] Starting dynamic subtest: gt_contexts
[150.767954] Dynamic subtest gt_contexts: SUCCESS (1.523s)
[150.775926] Starting dynamic subtest: gt_lrc
[155.399149] Dynamic subtest gt_lrc: SUCCESS (4.624s)
[155.407133] Starting dynamic subtest: gt_mocs
[157.359100] Dynamic subtest gt_mocs: SUCCESS (1.960s)
[157.368033] Starting dynamic subtest: gt_pm
[163.734503] Dynamic subtest gt_pm: FAIL (5.209s)
[163.742090] Starting dynamic subtest: gt_heartbeat
[164.253221] Dynamic subtest gt_heartbeat: SUCCESS (1.684s)
[164.260948] Starting dynamic subtest: requests
[173.668195] Dynamic subtest requests: SUCCESS (9.415s)
[173.676093] Starting dynamic subtest: migrate
[178.040933] Dynamic subtest migrate: SUCCESS (4.373s)
[178.050272] Starting dynamic subtest: active
[179.579170] Dynamic subtest active: SUCCESS (1.538s)
[179.587101] Starting dynamic subtest: objects
[181.503892] Dynamic subtest objects: SUCCESS (1.925s)
[181.512028] Starting dynamic subtest: mman
[275.057184] Inactivity timeout exceeded. Killing the current test with SIGQUIT.
[395.289798] Timeout. Killing the current test with SIGKILL.
[395.480496] Closing watchdogs
[395.482406] Initializing watchdogs
[395.482487]   /dev/watchdog0
[395.497292] [165/171] (594s left) dmabuf (all-tests)
[395.551937] Starting subtest: all-tests
[395.557769] Starting dynamic subtest: sanitycheck
[395.577890] Dynamic subtest sanitycheck: SUCCESS (0.029s)
[395.588575] Starting dynamic subtest: dma_fence
[395.708989] Dynamic subtest dma_fence: SUCCESS (0.131s)
[395.718782] Starting dynamic subtest: dma_fence_chain
[404.438206] Dynamic subtest dma_fence_chain: SUCCESS (8.729s)
[404.448169] Starting dynamic subtest: dma_fence_unwrap
[404.464769] Dynamic subtest dma_fence_unwrap: SUCCESS (0.027s)
[404.472973] Starting dynamic subtest: dma_resv
[404.498744] Dynamic subtest dma_resv: SUCCESS (0.034s)
[404.504424] Subtest all-tests: SUCCESS (8.951s)
[404.525168] [166/171] (585s left) i915_suspend (basic-s2idle-without-i915)
[404.572689] Starting subtest: basic-s2idle-without-i915
[490.072397] Subtest basic-s2idle-without-i915: SUCCESS (71.407s)
[490.131544] [167/171] (513s left) i915_suspend (basic-s3-without-i915)
[490.179076] Starting subtest: basic-s3-without-i915
[515.357865] Subtest basic-s3-without-i915: SUCCESS (9.460s)
[515.423026] [168/171] (504s left) gem_exec_suspend (basic-s0)
[515.476631] Starting subtest: basic-S0
[515.482213] Starting dynamic subtest: smem
[538.176810] Dynamic subtest smem: SUCCESS (8.226s)
[538.183771] Subtest basic-S0: SUCCESS (8.226s)
[538.324888] [169/171] (496s left) gem_exec_suspend (basic-s3)
[538.393318] Starting subtest: basic-S3
[538.398808] Starting dynamic subtest: smem
[564.669922] Dynamic subtest smem: SUCCESS (10.843s)
[564.676484] Subtest basic-S3: SUCCESS (10.843s)
[564.802226] [170/171] (485s left) kms_chamelium_hpd (common-hpd-after-suspend)
[564.872602] Subtest common-hpd-after-suspend: SKIP (0.000s)
[564.894752] [171/171] (484s left) kms_pipe_crc_basic (suspend-read-crc)
[564.958423] Subtest suspend-read-crc: SKIP (0.000s)
[564.974353] Closing watchdogs
Done.