[40.898063] Initializing watchdogs
[40.898200]   /dev/watchdog0
[40.929676] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:1916 Intel Skylake (Gen9) Skylake GT2 [HD Graphics 520]
[40.938022] [001/162] (960s left) i915_module_load (load)
[41.210698] Starting subtest: load
[42.925514] Subtest load: SUCCESS (1.714s)
[43.003053] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[43.006558] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[43.011444] [002/162] (958s left) core_auth (basic-auth)
[43.096231] Starting subtest: basic-auth
[43.098370] Subtest basic-auth: SUCCESS (0.001s)
[43.240591] [003/162] (958s left) core_debugfs (read-all-entries)
[43.307287] Starting subtest: read-all-entries
[43.449170] Subtest read-all-entries: SUCCESS (0.142s)
[43.560723] [004/162] (958s left) core_sysfs (read-all-entries)
[43.628598] Starting subtest: read-all-entries
[43.637242] Subtest read-all-entries: SUCCESS (0.009s)
[43.749956] [005/162] (957s left) fbdev (eof)
[43.832547] Starting subtest: eof
[43.833647] Subtest eof: SUCCESS (0.001s)
[43.950325] [006/162] (957s left) fbdev (info)
[44.015486] Starting subtest: info
[44.016608] Subtest info: SUCCESS (0.000s)
[44.138125] [007/162] (957s left) fbdev (nullptr)
[44.215214] Starting subtest: nullptr
[44.216297] Subtest nullptr: SUCCESS (0.000s)
[44.356324] [008/162] (957s left) fbdev (read)
[44.431098] Starting subtest: read
[45.332849] Subtest read: SUCCESS (0.892s)
[45.447559] [009/162] (956s left) fbdev (write)
[45.531702] Starting subtest: write
[46.014694] Subtest write: SUCCESS (0.474s)
[46.116804] [010/162] (955s left) gem_basic (bad-close)
[46.186631] Starting subtest: bad-close
[46.188632] Subtest bad-close: SUCCESS (0.000s)
[46.298021] [011/162] (955s left) gem_basic (create-close)
[46.370154] Starting subtest: create-close
[46.372080] Subtest create-close: SUCCESS (0.000s)
[46.497171] [012/162] (955s left) gem_basic (create-fd-close)
[46.566344] Starting subtest: create-fd-close
[46.568573] Subtest create-fd-close: SUCCESS (0.000s)
[46.719618] [013/162] (955s left) gem_busy (busy@all-engines)
[46.812265] Starting subtest: busy
[46.813450] Starting dynamic subtest: all-engines
[46.890322] Dynamic subtest all-engines: SUCCESS (0.078s)
[46.891653] Subtest busy: SUCCESS (0.078s)
[47.382165] [014/162] (954s left) gem_close_race (basic-process)
[47.477184] Starting subtest: basic-process
[47.548745] Subtest basic-process: SUCCESS (0.072s)
[47.831844] [015/162] (954s left) gem_close_race (basic-threads)
[47.930318] Starting subtest: basic-threads
[49.222285] Subtest basic-threads: SUCCESS (1.292s)
[49.466514] [016/162] (953s left) gem_ctx_create (basic)
[49.553379] Starting subtest: basic
[49.554538] Subtest basic: SUCCESS (0.000s)
[49.813125] [017/162] (952s left) gem_ctx_create (basic-files)
[49.897882] Starting subtest: basic-files
[51.919987] Subtest basic-files: SUCCESS (2.011s)
[52.198240] [018/162] (950s left) gem_ctx_exec (basic)
[52.273130] Starting subtest: basic
[52.279087] Subtest basic: SUCCESS (0.007s)
[52.462735] [019/162] (950s left) gem_exec_basic (basic)
[52.540989] Starting subtest: basic
[52.542096] Starting dynamic subtest: rcs0-smem
[52.544487] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[52.559385] Starting dynamic subtest: bcs0-smem
[52.560643] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[52.573653] Starting dynamic subtest: vcs0-smem
[52.574904] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[52.587848] Starting dynamic subtest: vecs0-smem
[52.589249] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[52.590591] Subtest basic: SUCCESS (0.008s)
[52.841707] [020/162] (949s left) gem_exec_create (basic)
[52.930214] Starting subtest: basic
[52.931284] Starting dynamic subtest: smem
[54.987508] Dynamic subtest smem: SUCCESS (2.036s)
[54.988887] Subtest basic: SUCCESS (2.036s)
[55.280765] [021/162] (947s left) gem_exec_fence (basic-busy)
[55.525710] Starting subtest: basic-busy
[55.526836] Starting dynamic subtest: rcs0
[55.558256] Dynamic subtest rcs0: SUCCESS (0.032s)
[55.573827] Starting dynamic subtest: bcs0
[55.590232] Dynamic subtest bcs0: SUCCESS (0.031s)
[55.603956] Starting dynamic subtest: vcs0
[55.620310] Dynamic subtest vcs0: SUCCESS (0.029s)
[55.633784] Starting dynamic subtest: vecs0
[55.652289] Dynamic subtest vecs0: SUCCESS (0.031s)
[55.653515] Subtest basic-busy: SUCCESS (0.126s)
[56.439764] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[56.444429] [022/162] (946s left) gem_exec_fence (basic-wait)
[56.687545] Starting subtest: basic-wait
[56.689091] Starting dynamic subtest: rcs0
[56.720338] Dynamic subtest rcs0: SUCCESS (0.032s)
[56.735181] Starting dynamic subtest: bcs0
[56.742222] Dynamic subtest bcs0: SUCCESS (0.021s)
[56.755880] Starting dynamic subtest: vcs0
[56.766246] Dynamic subtest vcs0: SUCCESS (0.023s)
[56.781497] Starting dynamic subtest: vecs0
[56.786332] Dynamic subtest vecs0: SUCCESS (0.020s)
[56.787551] Subtest basic-wait: SUCCESS (0.099s)
[57.588334] [023/162] (945s left) gem_exec_fence (basic-await)
[57.823776] Starting subtest: basic-await
[57.824823] Starting dynamic subtest: rcs0
[57.925494] Dynamic subtest rcs0: SUCCESS (0.102s)
[57.942540] Starting dynamic subtest: bcs0
[58.028732] Dynamic subtest bcs0: SUCCESS (0.102s)
[58.044423] Starting dynamic subtest: vcs0
[58.134602] Dynamic subtest vcs0: SUCCESS (0.104s)
[58.154141] Starting dynamic subtest: vecs0
[58.258405] Dynamic subtest vecs0: SUCCESS (0.123s)
[58.259558] Subtest basic-await: SUCCESS (0.433s)
[59.067687] [024/162] (944s left) gem_exec_fence (nb-await)
[59.296909] Starting subtest: nb-await
[59.298075] Starting dynamic subtest: rcs0
[59.365290] Dynamic subtest rcs0: SUCCESS (0.069s)
[59.386305] Starting dynamic subtest: bcs0
[59.436759] Dynamic subtest bcs0: SUCCESS (0.068s)
[59.479529] Starting dynamic subtest: vcs0
[59.526730] Dynamic subtest vcs0: SUCCESS (0.089s)
[59.565544] Starting dynamic subtest: vecs0
[59.611864] Dynamic subtest vecs0: SUCCESS (0.081s)
[59.615303] Subtest nb-await: SUCCESS (0.314s)
[60.375962] [025/162] (942s left) gem_exec_gttfill (basic)
[60.463316] Starting subtest: basic
[66.186333] Subtest basic: SUCCESS (5.705s)
[66.502758] [026/162] (936s left) gem_exec_parallel (engines)
[66.668945] Starting subtest: engines
[66.671472] Starting dynamic subtest: basic
[69.815383] Dynamic subtest basic: SUCCESS (3.117s)
[69.829812] Starting dynamic subtest: contexts
[73.905690] Dynamic subtest contexts: SUCCESS (4.098s)
[73.923132] Starting dynamic subtest: fds
[83.883675] Dynamic subtest fds: SUCCESS (9.982s)
[83.899709] Starting dynamic subtest: userptr
[86.446061] Dynamic subtest userptr: SUCCESS (2.562s)
[86.447461] Subtest engines: SUCCESS (19.764s)
[86.742557] [027/162] (916s left) gem_exec_store (basic)
[86.829724] Starting subtest: basic
[86.890517] Subtest basic: SUCCESS (0.061s)
[87.180359] [028/162] (916s left) gem_flink_basic (bad-flink)
[87.249088] Starting subtest: bad-flink
[87.250116] Subtest bad-flink: SUCCESS (0.000s)
[87.365587] [029/162] (916s left) gem_flink_basic (bad-open)
[87.434590] Starting subtest: bad-open
[87.435643] Subtest bad-open: SUCCESS (0.000s)
[87.552320] [030/162] (916s left) gem_flink_basic (basic)
[87.621320] Starting subtest: basic
[87.622278] Subtest basic: SUCCESS (0.000s)
[87.819815] [031/162] (915s left) gem_flink_basic (double-flink)
[87.888486] Starting subtest: double-flink
[87.889433] Subtest double-flink: SUCCESS (0.000s)
[88.060309] [032/162] (915s left) gem_flink_basic (flink-lifetime)
[88.130016] Starting subtest: flink-lifetime
[88.132218] Subtest flink-lifetime: SUCCESS (0.002s)
[88.312571] [033/162] (915s left) gem_huc_copy (huc-copy)
[88.393139] Starting subtest: huc-copy
[88.395245] Subtest huc-copy: SKIP (0.000s)
[88.601179] [034/162] (915s left) gem_linear_blits (basic)
[88.814807] Starting subtest: basic
[88.827346] Subtest basic: SUCCESS (0.013s)
[89.060590] [035/162] (915s left) gem_mmap (basic)
[89.202484] Starting subtest: basic
[89.207428] Subtest basic: SUCCESS (0.000s)
[89.354884] [036/162] (914s left) gem_mmap_gtt (basic)
[89.426277] Starting subtest: basic
[89.427273] Subtest basic: SUCCESS (0.001s)
[89.609346] [037/162] (914s left) gem_render_linear_blits (basic)
[89.689056] Starting subtest: basic
[89.732269] Subtest basic: SUCCESS (0.043s)
[89.837055] [038/162] (914s left) gem_render_tiled_blits (basic)
[89.913540] Starting subtest: basic
[89.964461] Subtest basic: SUCCESS (0.051s)
[90.068521] [039/162] (914s left) gem_ringfill (basic-all)
[90.374438] Starting subtest: basic-all
[91.542856] Subtest basic-all: SUCCESS (1.159s)
[91.750373] [040/162] (912s left) gem_softpin (allocator-basic)
[91.830582] Starting subtest: allocator-basic
[92.026373] Subtest allocator-basic: SUCCESS (0.185s)
[92.205337] [041/162] (912s left) gem_softpin (allocator-basic-reserve)
[92.286354] Starting subtest: allocator-basic-reserve
[92.466055] Subtest allocator-basic-reserve: SUCCESS (0.171s)
[92.654495] [042/162] (912s left) gem_softpin (safe-alignment)
[92.733944] Starting subtest: safe-alignment
[92.752772] Subtest safe-alignment: SUCCESS (0.019s)
[92.948931] [043/162] (911s left) gem_sync (basic-all)
[93.039558] Starting subtest: basic-all
[95.489776] Subtest basic-all: SUCCESS (2.450s)
[95.768818] [044/162] (909s left) gem_sync (basic-each)
[95.857472] Starting subtest: basic-each
[98.091498] Subtest basic-each: SUCCESS (2.234s)
[98.450763] [045/162] (906s left) gem_tiled_blits (basic)
[98.630186] Starting subtest: basic
[98.653362] Subtest basic: SUCCESS (0.023s)
[98.859841] [046/162] (906s left) gem_tiled_fence_blits (basic)
[99.102976] Starting subtest: basic
[99.116554] Subtest basic: SUCCESS (0.015s)
[99.330089] [047/162] (905s left) gem_tiled_pread_basic (basic)
[99.460198] Starting subtest: basic
[99.643887] Subtest basic: SUCCESS (0.175s)
[99.817323] [048/162] (905s left) gem_wait (busy@all-engines)
[99.912501] Starting subtest: busy
[99.913560] Starting dynamic subtest: all-engines
[100.434041] Dynamic subtest all-engines: SUCCESS (0.521s)
[100.435130] Subtest busy: SUCCESS (0.521s)
[100.720730] [049/162] (904s left) gem_wait (wait@all-engines)
[100.814755] Starting subtest: wait
[100.815970] Starting dynamic subtest: all-engines
[101.859693] Dynamic subtest all-engines: SUCCESS (1.043s)
[101.862723] Subtest wait: SUCCESS (1.045s)
[102.204474] [050/162] (903s left) i915_getparams_basic (basic-eu-total)
[102.274072] Starting subtest: basic-eu-total
[102.276583] Subtest basic-eu-total: SUCCESS (0.000s)
[102.444127] [051/162] (903s left) i915_getparams_basic (basic-subslice-total)
[102.525579] Starting subtest: basic-subslice-total
[102.527775] Subtest basic-subslice-total: SUCCESS (0.000s)
[102.661713] [052/162] (902s left) i915_hangman (error-state-basic)
[102.752950] Starting subtest: error-state-basic
[102.766105] Subtest error-state-basic: SUCCESS (0.013s)
[102.905284] [053/162] (902s left) i915_pciid
[103.089235] [054/162] (902s left) intel_hwmon (hwmon-read)
[103.159448] Subtest hwmon-read: SKIP (0.000s)
[103.248415] [055/162] (902s left) intel_hwmon (hwmon-write)
[103.318954] Subtest hwmon-write: SKIP (0.000s)
[103.416229] [056/162] (902s left) kms_addfb_basic (addfb25-4-tiled)
[103.546183] Starting subtest: addfb25-4-tiled
[103.547228] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[103.673715] [057/162] (902s left) kms_addfb_basic (addfb25-bad-modifier)
[103.795287] Starting subtest: addfb25-bad-modifier
[103.796329] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[103.966809] [058/162] (902s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[104.097337] Starting subtest: addfb25-framebuffer-vs-set-tiling
[104.098330] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[104.248200] [059/162] (901s left) kms_addfb_basic (addfb25-modifier-no-flag)
[104.370263] Starting subtest: addfb25-modifier-no-flag
[104.371233] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[104.525783] [060/162] (901s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[104.650241] Starting subtest: addfb25-x-tiled-legacy
[104.651215] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[104.844528] [061/162] (901s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[104.978282] Starting subtest: addfb25-x-tiled-mismatch-legacy
[104.979216] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[105.116369] [062/162] (901s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[105.240228] Starting subtest: addfb25-yf-tiled-legacy
[105.241198] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[105.391562] [063/162] (901s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[105.519242] Starting subtest: addfb25-y-tiled-legacy
[105.520271] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[105.698761] [064/162] (900s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[105.828836] Starting subtest: addfb25-y-tiled-small-legacy
[105.829817] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[106.009616] [065/162] (900s left) kms_addfb_basic (bad-pitch-0)
[106.079214] Starting subtest: bad-pitch-0
[106.080199] Subtest bad-pitch-0: SUCCESS (0.000s)
[106.292928] [066/162] (900s left) kms_addfb_basic (bad-pitch-1024)
[106.365128] Starting subtest: bad-pitch-1024
[106.366128] Subtest bad-pitch-1024: SUCCESS (0.000s)
[106.576622] [067/162] (900s left) kms_addfb_basic (bad-pitch-128)
[106.653256] Starting subtest: bad-pitch-128
[106.654338] Subtest bad-pitch-128: SUCCESS (0.000s)
[106.888296] [068/162] (899s left) kms_addfb_basic (bad-pitch-256)
[106.958317] Starting subtest: bad-pitch-256
[106.959367] Subtest bad-pitch-256: SUCCESS (0.000s)
[107.216431] [069/162] (899s left) kms_addfb_basic (bad-pitch-32)
[107.286162] Starting subtest: bad-pitch-32
[107.287421] Subtest bad-pitch-32: SUCCESS (0.000s)
[107.505459] [070/162] (899s left) kms_addfb_basic (bad-pitch-63)
[107.575275] Starting subtest: bad-pitch-63
[107.576216] Subtest bad-pitch-63: SUCCESS (0.000s)
[107.790452] [071/162] (899s left) kms_addfb_basic (bad-pitch-65536)
[107.859262] Starting subtest: bad-pitch-65536
[107.860311] Subtest bad-pitch-65536: SUCCESS (0.000s)
[108.071629] [072/162] (899s left) kms_addfb_basic (bad-pitch-999)
[108.141462] Starting subtest: bad-pitch-999
[108.142438] Subtest bad-pitch-999: SUCCESS (0.000s)
[108.430228] [073/162] (898s left) kms_addfb_basic (basic)
[108.500397] Starting subtest: basic
[108.501394] Subtest basic: SUCCESS (0.000s)
[108.708365] [074/162] (898s left) kms_addfb_basic (basic-x-tiled-legacy)
[108.779200] Starting subtest: basic-x-tiled-legacy
[108.780093] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[109.005869] [075/162] (898s left) kms_addfb_basic (basic-y-tiled-legacy)
[109.076807] Starting subtest: basic-y-tiled-legacy
[109.077934] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[109.316675] [076/162] (898s left) kms_addfb_basic (bo-too-small)
[109.551789] Starting subtest: bo-too-small
[109.552858] Subtest bo-too-small: SUCCESS (0.001s)
[109.764480] [077/162] (897s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[109.947884] Starting subtest: bo-too-small-due-to-tiling
[109.950179] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[110.115609] [078/162] (897s left) kms_addfb_basic (clobberred-modifier)
[110.187494] Starting subtest: clobberred-modifier
[110.188632] Subtest clobberred-modifier: SUCCESS (0.000s)
[110.405785] [079/162] (897s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[110.477715] Starting subtest: framebuffer-vs-set-tiling
[110.478759] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[110.752568] [080/162] (897s left) kms_addfb_basic (invalid-get-prop)
[110.823367] Starting subtest: invalid-get-prop
[110.824265] Subtest invalid-get-prop: SUCCESS (0.000s)
[111.034525] [081/162] (897s left) kms_addfb_basic (invalid-get-prop-any)
[111.104983] Starting subtest: invalid-get-prop-any
[111.105953] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[111.324647] [082/162] (896s left) kms_addfb_basic (invalid-set-prop)
[111.395084] Starting subtest: invalid-set-prop
[111.396129] Subtest invalid-set-prop: SUCCESS (0.000s)
[111.616145] [083/162] (896s left) kms_addfb_basic (invalid-set-prop-any)
[111.686281] Starting subtest: invalid-set-prop-any
[111.687257] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[111.944071] [084/162] (896s left) kms_addfb_basic (no-handle)
[112.018285] Starting subtest: no-handle
[112.019312] Subtest no-handle: SUCCESS (0.000s)
[112.254269] [085/162] (896s left) kms_addfb_basic (size-max)
[112.378193] Starting subtest: size-max
[112.379195] Subtest size-max: SUCCESS (0.000s)
[112.519417] [086/162] (896s left) kms_addfb_basic (small-bo)
[112.647392] Starting subtest: small-bo
[112.648414] Subtest small-bo: SUCCESS (0.000s)
[112.803311] [087/162] (895s left) kms_addfb_basic (tile-pitch-mismatch)
[112.872479] Starting subtest: tile-pitch-mismatch
[112.873515] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[113.103303] [088/162] (895s left) kms_addfb_basic (too-high)
[113.229343] Starting subtest: too-high
[113.230404] Subtest too-high: SUCCESS (0.001s)
[113.395919] [089/162] (895s left) kms_addfb_basic (too-wide)
[113.518746] Starting subtest: too-wide
[113.519783] Subtest too-wide: SUCCESS (0.000s)
[113.690166] [090/162] (895s left) kms_addfb_basic (unused-handle)
[113.759768] Starting subtest: unused-handle
[113.760841] Subtest unused-handle: SUCCESS (0.000s)
[114.015017] [091/162] (894s left) kms_addfb_basic (unused-modifier)
[114.085176] Starting subtest: unused-modifier
[114.086312] Subtest unused-modifier: SUCCESS (0.000s)
[114.325079] [092/162] (894s left) kms_addfb_basic (unused-offsets)
[114.397806] Starting subtest: unused-offsets
[114.398879] Subtest unused-offsets: SUCCESS (0.000s)
[114.594144] [093/162] (894s left) kms_addfb_basic (unused-pitches)
[114.662381] Starting subtest: unused-pitches
[114.663508] Subtest unused-pitches: SUCCESS (0.000s)
[114.897390] [094/162] (894s left) kms_busy (basic)
[115.025229] Starting subtest: basic
[115.026230] Starting dynamic subtest: flip
[115.879266] Dynamic subtest flip: SUCCESS (0.853s)
[115.902224] Starting dynamic subtest: modeset
[119.503043] Dynamic subtest modeset: SUCCESS (3.619s)
[119.505367] Subtest basic: SUCCESS (4.475s)
[120.434208] [095/162] (888s left) kms_prop_blob (basic)
[120.503264] Starting subtest: basic
[120.504233] Subtest basic: SUCCESS (0.000s)
[120.689840] [096/162] (888s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[120.813501] Starting subtest: basic-busy-flip-before-cursor-atomic
[120.815452] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[120.939836] [097/162] (888s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[121.060341] Starting subtest: basic-busy-flip-before-cursor-legacy
[121.062294] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[121.202139] [098/162] (888s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[121.328327] Starting subtest: basic-flip-after-cursor-atomic
[122.635561] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.306s)
[123.489331] [099/162] (886s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[123.610354] Starting subtest: basic-flip-after-cursor-legacy
[124.858659] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.245s)
[125.811795] [100/162] (883s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[125.934875] Starting subtest: basic-flip-after-cursor-varying-size
[127.219214] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.284s)
[128.100048] [101/162] (881s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[128.227105] Starting subtest: basic-flip-before-cursor-atomic
[129.575319] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.344s)
[130.523939] [102/162] (879s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[130.656223] Starting subtest: basic-flip-before-cursor-legacy
[131.913625] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.256s)
[132.846151] [103/162] (877s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[132.966154] Starting subtest: basic-flip-before-cursor-varying-size
[134.252104] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.282s)
[135.125093] [104/162] (875s left) kms_dsc (dsc-basic)
[135.246087] Subtest dsc-basic: SKIP (0.000s)
[135.339752] [105/162] (874s left) kms_flip (basic-flip-vs-dpms)
[135.476016] Starting subtest: basic-flip-vs-dpms
[135.479386] Starting dynamic subtest: A-eDP1
[138.315393] Dynamic subtest A-eDP1: SUCCESS (2.834s)
[138.390086] Starting dynamic subtest: B-eDP1
[140.715632] Dynamic subtest B-eDP1: SUCCESS (2.392s)
[140.778819] Starting dynamic subtest: C-eDP1
[142.961365] Dynamic subtest C-eDP1: SUCCESS (2.241s)
[142.970539] Subtest basic-flip-vs-dpms: SUCCESS (7.494s)
[143.850212] [106/162] (866s left) kms_flip (basic-flip-vs-modeset)
[143.973343] Starting subtest: basic-flip-vs-modeset
[143.977554] Starting dynamic subtest: A-eDP1
[146.572145] Dynamic subtest A-eDP1: SUCCESS (2.591s)
[146.635592] Starting dynamic subtest: B-eDP1
[148.886558] Dynamic subtest B-eDP1: SUCCESS (2.309s)
[148.948987] Starting dynamic subtest: C-eDP1
[151.199968] Dynamic subtest C-eDP1: SUCCESS (2.300s)
[151.206270] Subtest basic-flip-vs-modeset: SUCCESS (7.231s)
[152.092368] [107/162] (858s left) kms_flip (basic-flip-vs-wf_vblank)
[152.215175] Starting subtest: basic-flip-vs-wf_vblank
[152.217709] Starting dynamic subtest: A-eDP1
[154.387235] Dynamic subtest A-eDP1: SUCCESS (2.167s)
[154.407899] Starting dynamic subtest: B-eDP1
[156.562251] Dynamic subtest B-eDP1: SUCCESS (2.176s)
[156.582092] Starting dynamic subtest: C-eDP1
[158.669298] Dynamic subtest C-eDP1: SUCCESS (2.105s)
[158.672831] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.458s)
[160.019850] [108/162] (850s left) kms_flip (basic-plain-flip)
[160.147613] Starting subtest: basic-plain-flip
[160.150253] Starting dynamic subtest: A-eDP1
[162.026434] Dynamic subtest A-eDP1: SUCCESS (1.875s)
[162.046694] Starting dynamic subtest: B-eDP1
[163.934633] Dynamic subtest B-eDP1: SUCCESS (1.903s)
[164.010882] Starting dynamic subtest: C-eDP1
[165.910059] Dynamic subtest C-eDP1: SUCCESS (1.971s)
[165.912777] Subtest basic-plain-flip: SUCCESS (5.766s)
[167.260529] [109/162] (843s left) kms_force_connector_basic (force-connector-state)
[167.361960] Starting subtest: force-connector-state
[167.928572] Subtest force-connector-state: SUCCESS (0.566s)
[169.132338] [110/162] (841s left) kms_force_connector_basic (force-edid)
[169.229403] Starting subtest: force-edid
[169.280595] Subtest force-edid: SUCCESS (0.037s)
[169.561619] [111/162] (841s left) kms_force_connector_basic (force-load-detect)
[169.660944] Starting subtest: force-load-detect
[169.663095] Subtest force-load-detect: SKIP (0.000s)
[169.844822] [112/162] (840s left) kms_force_connector_basic (prune-stale-modes)
[169.941389] Starting subtest: prune-stale-modes
[169.976954] Subtest prune-stale-modes: SUCCESS (0.035s)
[170.195594] [113/162] (840s left) kms_frontbuffer_tracking (basic)
[170.326536] Starting subtest: basic
[173.936481] Subtest basic: SUCCESS (3.610s)
[174.139175] [114/162] (836s left) kms_hdmi_inject (inject-audio)
[174.541906] Starting subtest: inject-audio
[174.670632] Subtest inject-audio: SUCCESS (0.130s)
[175.469285] [115/162] (835s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[175.594122] Starting subtest: compare-crc-sanitycheck-xr24
[175.595223] Starting dynamic subtest: pipe-A-eDP-1
[176.347572] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.743s)
[176.429073] Starting dynamic subtest: pipe-B-eDP-1
[177.812449] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.449s)
[177.893573] Starting dynamic subtest: pipe-C-eDP-1
[179.282314] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.463s)
[179.292886] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.693s)
[180.291887] [116/162] (830s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[180.417654] Starting subtest: compare-crc-sanitycheck-nv12
[180.418698] Starting dynamic subtest: pipe-A-eDP-1
[180.420776] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[180.444611] Starting dynamic subtest: pipe-B-eDP-1
[180.446490] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[180.462578] Starting dynamic subtest: pipe-C-eDP-1
[180.464702] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[180.466980] Subtest compare-crc-sanitycheck-nv12: SKIP (0.011s)
[180.551786] [117/162] (830s left) kms_pipe_crc_basic (hang-read-crc)
[180.682394] Starting subtest: hang-read-crc
[180.685398] Starting dynamic subtest: pipe-A-eDP-1
[183.280301] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.594s)
[183.356275] Starting dynamic subtest: pipe-B-eDP-1
[186.355580] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.052s)
[186.437129] Starting dynamic subtest: pipe-C-eDP-1
[189.542161] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.178s)
[189.553727] Subtest hang-read-crc: SUCCESS (8.863s)
[190.521587] [118/162] (820s left) kms_pipe_crc_basic (nonblocking-crc)
[190.648474] Starting subtest: nonblocking-crc
[190.652180] Starting dynamic subtest: pipe-A-eDP-1
[191.678170] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.025s)
[191.758846] Starting dynamic subtest: pipe-B-eDP-1
[193.339346] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.636s)
[193.416788] Starting dynamic subtest: pipe-C-eDP-1
[195.021527] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.670s)
[195.038118] Subtest nonblocking-crc: SUCCESS (4.377s)
[195.961734] [119/162] (815s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[196.092102] Starting subtest: nonblocking-crc-frame-sequence
[196.093417] Starting dynamic subtest: pipe-A-eDP-1
[197.069600] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.973s)
[197.118332] Starting dynamic subtest: pipe-B-eDP-1
[198.835252] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.745s)
[198.928178] Starting dynamic subtest: pipe-C-eDP-1
[200.481315] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.624s)
[200.483717] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.388s)
[201.391125] [120/162] (810s left) kms_pipe_crc_basic (read-crc)
[201.517159] Starting subtest: read-crc
[201.518209] Starting dynamic subtest: pipe-A-eDP-1
[202.543284] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.017s)
[202.626696] Starting dynamic subtest: pipe-B-eDP-1
[204.023235] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.465s)
[204.111083] Starting dynamic subtest: pipe-C-eDP-1
[205.540527] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.501s)
[205.542858] Subtest read-crc: SUCCESS (4.026s)
[206.418387] [121/162] (805s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[206.541454] Starting subtest: read-crc-frame-sequence
[206.542458] Starting dynamic subtest: pipe-A-eDP-1
[207.405301] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.859s)
[207.489226] Starting dynamic subtest: pipe-B-eDP-1
[209.058555] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.638s)
[209.141931] Starting dynamic subtest: pipe-C-eDP-1
[210.561627] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.483s)
[210.573421] Subtest read-crc-frame-sequence: SUCCESS (4.025s)
[211.446075] [122/162] (800s left) kms_pm_backlight (basic-brightness)
[211.573777] Starting subtest: basic-brightness
[211.634593] Starting dynamic subtest: eDP-1
[212.268912] Dynamic subtest eDP-1: SUCCESS (0.631s)
[212.271446] Subtest basic-brightness: SUCCESS (0.697s)
[213.199493] [123/162] (798s left) kms_pm_rpm (basic-pci-d3-state)
[214.937312] Starting subtest: basic-pci-d3-state
[215.588645] Subtest basic-pci-d3-state: SUCCESS (0.649s)
[215.807281] [124/162] (796s left) kms_pm_rpm (basic-rte)
[215.877526] Starting subtest: basic-rte
[218.107340] Subtest basic-rte: SUCCESS (2.227s)
[219.513456] [125/162] (792s left) kms_psr (psr-primary-page-flip)
[219.638896] Starting subtest: psr-primary-page-flip
[219.639970] Starting dynamic subtest: eDP-1
[221.660368] Dynamic subtest eDP-1: SUCCESS (2.014s)
[221.663442] Subtest psr-primary-page-flip: SUCCESS (2.022s)
[222.586520] [126/162] (789s left) kms_psr (psr-cursor-plane-move)
[222.711465] Starting subtest: psr-cursor-plane-move
[222.712396] Starting dynamic subtest: eDP-1
[224.668310] Dynamic subtest eDP-1: SUCCESS (1.950s)
[224.670989] Subtest psr-cursor-plane-move: SUCCESS (1.958s)
[225.600680] [127/162] (786s left) kms_psr (psr-sprite-plane-onoff)
[225.725578] Starting subtest: psr-sprite-plane-onoff
[225.728478] Starting dynamic subtest: eDP-1
[227.836973] Dynamic subtest eDP-1: SUCCESS (2.106s)
[227.847772] Subtest psr-sprite-plane-onoff: SUCCESS (2.113s)
[228.774538] [128/162] (783s left) kms_psr (psr-primary-mmap-gtt)
[228.895680] Starting subtest: psr-primary-mmap-gtt
[228.899390] Starting dynamic subtest: eDP-1
[230.812502] Dynamic subtest eDP-1: SUCCESS (1.912s)
[230.822852] Subtest psr-primary-mmap-gtt: SUCCESS (1.918s)
[231.731508] [129/162] (780s left) kms_setmode (basic-clone-single-crtc)
[231.804159] Starting subtest: basic-clone-single-crtc
[231.806948] Subtest basic-clone-single-crtc: SKIP (0.000s)
[231.935415] [130/162] (780s left) i915_pm_rps (basic-api)
[232.019251] Starting subtest: basic-api
[232.025061] Subtest basic-api: SUCCESS (0.006s)
[232.184908] [131/162] (780s left) prime_self_import (basic-llseek-bad)
[232.253387] Starting subtest: basic-llseek-bad
[232.258273] Subtest basic-llseek-bad: SUCCESS (0.003s)
[232.449877] [132/162] (780s left) prime_self_import (basic-llseek-size)
[232.517142] Starting subtest: basic-llseek-size
[232.525230] Subtest basic-llseek-size: SUCCESS (0.007s)
[232.684280] [133/162] (780s left) prime_self_import (basic-with_fd_dup)
[232.755887] Starting subtest: basic-with_fd_dup
[232.758026] Subtest basic-with_fd_dup: SUCCESS (0.005s)
[232.928936] [134/162] (779s left) prime_self_import (basic-with_one_bo)
[232.998186] Starting subtest: basic-with_one_bo
[233.003426] Subtest basic-with_one_bo: SUCCESS (0.004s)
[233.207690] [135/162] (779s left) prime_self_import (basic-with_one_bo_two_files)
[233.277100] Starting subtest: basic-with_one_bo_two_files
[233.282374] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s)
[233.451530] [136/162] (779s left) prime_self_import (basic-with_two_bos)
[233.520796] Starting subtest: basic-with_two_bos
[233.526434] Subtest basic-with_two_bos: SUCCESS (0.006s)
[233.684592] [137/162] (779s left) prime_vgem (basic-fence-flip)
[233.777818] Starting subtest: basic-fence-flip
[234.244793] Subtest basic-fence-flip: SUCCESS (0.463s)
[234.404658] [138/162] (778s left) prime_vgem (basic-fence-mmap)
[234.504850] Starting subtest: basic-fence-mmap
[234.544624] Subtest basic-fence-mmap: SUCCESS (0.040s)
[234.673508] [139/162] (778s left) prime_vgem (basic-fence-read)
[234.778388] Starting subtest: basic-fence-read
[234.863715] Subtest basic-fence-read: SUCCESS (0.085s)
[234.985756] [140/162] (778s left) prime_vgem (basic-gtt)
[235.069880] Starting subtest: basic-gtt
[235.090932] Subtest basic-gtt: SUCCESS (0.021s)
[235.241211] [141/162] (778s left) prime_vgem (basic-read)
[235.349326] Starting subtest: basic-read
[235.388624] Subtest basic-read: SUCCESS (0.042s)
[235.520196] [142/162] (777s left) prime_vgem (basic-write)
[235.602331] Starting subtest: basic-write
[235.642797] Subtest basic-write: SUCCESS (0.040s)
[235.770653] [143/162] (777s left) vgem_basic (setversion)
[235.843493] Starting subtest: setversion
[235.845395] Subtest setversion: SUCCESS (0.000s)
[235.953233] [144/162] (777s left) vgem_basic (create)
[236.028951] Starting subtest: create
[236.030095] Subtest create: SUCCESS (0.000s)
[236.137881] [145/162] (777s left) vgem_basic (debugfs)
[236.210042] Starting subtest: debugfs
[236.210980] Subtest debugfs: SUCCESS (0.001s)
[236.320082] [146/162] (777s left) vgem_basic (dmabuf-export)
[236.395886] Starting subtest: dmabuf-export
[236.409578] Subtest dmabuf-export: SUCCESS (0.014s)
[236.544985] [147/162] (777s left) vgem_basic (dmabuf-fence)
[236.628790] Starting subtest: dmabuf-fence
[236.629861] Subtest dmabuf-fence: SUCCESS (0.001s)
[236.767385] [148/162] (777s left) vgem_basic (dmabuf-fence-before)
[236.844548] Starting subtest: dmabuf-fence-before
[236.845484] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[236.953424] [149/162] (777s left) vgem_basic (dmabuf-mmap)
[237.028836] Starting subtest: dmabuf-mmap
[237.042346] Subtest dmabuf-mmap: SUCCESS (0.015s)
[237.177258] [150/162] (776s left) vgem_basic (mmap)
[237.262244] Starting subtest: mmap
[237.271361] Subtest mmap: SUCCESS (0.011s)
[237.432318] [151/162] (776s left) vgem_basic (second-client)
[237.512672] Starting subtest: second-client
[237.545939] Subtest second-client: SUCCESS (0.032s)
[237.655939] [152/162] (776s left) vgem_basic (sysfs)
[237.745165] Starting subtest: sysfs
[237.746319] Subtest sysfs: SUCCESS (0.001s)
[237.854624] [153/162] (776s left) core_hotunplug (unbind-rebind)
[238.016695] Starting subtest: unbind-rebind
[243.071225] Subtest unbind-rebind: SUCCESS (5.054s)
[243.152984] [154/162] (771s left) vgem_basic (unload)