[56.607402] Initializing watchdogs [56.607512] /dev/watchdog0 [56.631345] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:5926 Intel Kabylake (Gen9) Iris Plus Graphics 640 [56.637685] [001/162] (960s left) i915_module_load (load) [56.703923] Starting subtest: load [59.289577] Subtest load: SUCCESS (2.584s) [59.350406] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.352385] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [59.366447] [002/162] (957s left) core_auth (basic-auth) [59.551231] Starting subtest: basic-auth [59.553255] Subtest basic-auth: SUCCESS (0.003s) [59.654564] [003/162] (957s left) core_debugfs (read-all-entries) [59.709983] Starting subtest: read-all-entries [59.713336] Subtest read-all-entries: SUCCESS (0.003s) [59.762227] [004/162] (957s left) core_sysfs (read-all-entries) [59.827835] Starting subtest: read-all-entries [59.830914] Subtest read-all-entries: SUCCESS (0.005s) [59.878671] [005/162] (957s left) fbdev (eof) [59.948587] Subtest eof: SKIP (0.000s) [59.993327] [006/162] (957s left) fbdev (info) [60.059339] Subtest info: SKIP (0.000s) [60.104288] [007/162] (957s left) fbdev (nullptr) [60.170992] Subtest nullptr: SKIP (0.000s) [60.216334] [008/162] (957s left) fbdev (read) [60.283685] Subtest read: SKIP (0.000s) [60.328287] [009/162] (957s left) fbdev (write) [60.395247] Subtest write: SKIP (0.000s) [60.439981] [010/162] (957s left) gem_basic (bad-close) [60.495119] Starting subtest: bad-close [60.496963] Subtest bad-close: SUCCESS (0.000s) [60.543935] [011/162] (957s left) gem_basic (create-close) [60.606977] Starting subtest: create-close [60.608862] Subtest create-close: SUCCESS (0.000s) [60.672460] [012/162] (957s left) gem_basic (create-fd-close) [60.731717] Starting subtest: create-fd-close [60.733507] Subtest create-fd-close: SUCCESS (0.000s) [60.792352] [013/162] (957s left) gem_busy (busy@all-engines) [60.870082] Starting subtest: busy [60.871116] Starting dynamic subtest: all-engines [60.929348] Dynamic subtest all-engines: SUCCESS (0.059s) [60.930292] Subtest busy: SUCCESS (0.060s) [61.324225] [014/162] (956s left) gem_close_race (basic-process) [61.409058] Starting subtest: basic-process [61.474169] Subtest basic-process: SUCCESS (0.065s) [61.717881] [015/162] (956s left) gem_close_race (basic-threads) [61.800808] Starting subtest: basic-threads [63.033387] Subtest basic-threads: SUCCESS (1.232s) [63.236834] [016/162] (954s left) gem_ctx_create (basic) [63.319092] Starting subtest: basic [63.320421] Subtest basic: SUCCESS (0.000s) [63.492663] [017/162] (954s left) gem_ctx_create (basic-files) [63.563530] Starting subtest: basic-files [65.580661] Subtest basic-files: SUCCESS (2.017s) [65.828204] [018/162] (952s left) gem_ctx_exec (basic) [65.899205] Starting subtest: basic [65.904666] Subtest basic: SUCCESS (0.006s) [65.974576] [019/162] (952s left) gem_exec_basic (basic) [66.043810] Starting subtest: basic [66.044965] Starting dynamic subtest: rcs0-smem [66.047272] Dynamic subtest rcs0-smem: SUCCESS (0.004s) [66.057256] Starting dynamic subtest: bcs0-smem [66.058335] Dynamic subtest bcs0-smem: SUCCESS (0.003s) [66.067958] Starting dynamic subtest: vcs0-smem [66.069743] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [66.079747] Starting dynamic subtest: vcs1-smem [66.081698] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [66.090918] Starting dynamic subtest: vecs0-smem [66.092196] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [66.093457] Subtest basic: SUCCESS (0.011s) [66.247584] [020/162] (952s left) gem_exec_create (basic) [66.320093] Starting subtest: basic [66.405703] Starting dynamic subtest: smem [68.419534] Dynamic subtest smem: SUCCESS (2.099s) [68.420697] Subtest basic: SUCCESS (2.099s) [68.580704] [021/162] (949s left) gem_exec_fence (basic-busy) [68.804130] Starting subtest: basic-busy [68.806422] Starting dynamic subtest: rcs0 [68.853396] Dynamic subtest rcs0: SUCCESS (0.050s) [68.890024] Starting dynamic subtest: bcs0 [68.893897] Dynamic subtest bcs0: SUCCESS (0.035s) [68.921019] Starting dynamic subtest: vcs0 [68.928560] Dynamic subtest vcs0: SUCCESS (0.038s) [68.942388] Starting dynamic subtest: vcs1 [68.950257] Dynamic subtest vcs1: SUCCESS (0.021s) [68.960069] Starting dynamic subtest: vecs0 [68.970402] Dynamic subtest vecs0: SUCCESS (0.020s) [68.971709] Subtest basic-busy: SUCCESS (0.169s) [69.635743] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [69.638218] [022/162] (948s left) gem_exec_fence (basic-wait) [69.867107] Starting subtest: basic-wait [69.868812] Starting dynamic subtest: rcs0 [69.905378] Dynamic subtest rcs0: SUCCESS (0.038s) [69.915929] Starting dynamic subtest: bcs0 [69.937484] Dynamic subtest bcs0: SUCCESS (0.032s) [69.949696] Starting dynamic subtest: vcs0 [69.964471] Dynamic subtest vcs0: SUCCESS (0.026s) [69.974494] Starting dynamic subtest: vcs1 [69.988439] Dynamic subtest vcs1: SUCCESS (0.025s) [69.999434] Starting dynamic subtest: vecs0 [70.008462] Dynamic subtest vecs0: SUCCESS (0.020s) [70.009832] Subtest basic-wait: SUCCESS (0.142s) [70.621437] [023/162] (947s left) gem_exec_fence (basic-await) [70.828456] Starting subtest: basic-await [70.830540] Starting dynamic subtest: rcs0 [70.942517] Dynamic subtest rcs0: SUCCESS (0.113s) [70.958885] Starting dynamic subtest: bcs0 [71.053637] Dynamic subtest bcs0: SUCCESS (0.111s) [71.071154] Starting dynamic subtest: vcs0 [71.166760] Dynamic subtest vcs0: SUCCESS (0.113s) [71.179594] Starting dynamic subtest: vcs1 [71.275887] Dynamic subtest vcs1: SUCCESS (0.109s) [71.287147] Starting dynamic subtest: vecs0 [71.380400] Dynamic subtest vecs0: SUCCESS (0.104s) [71.382110] Subtest basic-await: SUCCESS (0.552s) [72.072914] [024/162] (946s left) gem_exec_fence (nb-await) [72.299969] Starting subtest: nb-await [72.301295] Starting dynamic subtest: rcs0 [72.369607] Dynamic subtest rcs0: SUCCESS (0.071s) [72.381966] Starting dynamic subtest: bcs0 [72.437938] Dynamic subtest bcs0: SUCCESS (0.067s) [72.472736] Starting dynamic subtest: vcs0 [72.526586] Dynamic subtest vcs0: SUCCESS (0.088s) [72.557701] Starting dynamic subtest: vcs1 [72.617970] Dynamic subtest vcs1: SUCCESS (0.087s) [72.648614] Starting dynamic subtest: vecs0 [72.703860] Dynamic subtest vecs0: SUCCESS (0.087s) [72.706304] Subtest nb-await: SUCCESS (0.406s) [73.393342] [025/162] (945s left) gem_exec_gttfill (basic) [73.477538] Starting subtest: basic [78.184911] Subtest basic: SUCCESS (4.708s) [78.455949] [026/162] (940s left) gem_exec_parallel (engines) [78.607637] Starting subtest: engines [78.608792] Starting dynamic subtest: basic [81.062167] Dynamic subtest basic: SUCCESS (2.404s) [81.073363] Starting dynamic subtest: contexts [84.625492] Dynamic subtest contexts: SUCCESS (3.611s) [84.636876] Starting dynamic subtest: fds [88.045120] Dynamic subtest fds: SUCCESS (3.400s) [88.057903] Starting dynamic subtest: userptr [91.152198] Dynamic subtest userptr: SUCCESS (3.075s) [91.154186] Subtest engines: SUCCESS (12.492s) [91.329260] [027/162] (927s left) gem_exec_store (basic) [91.414652] Starting subtest: basic [91.468654] Subtest basic: SUCCESS (0.054s) [91.669347] [028/162] (927s left) gem_flink_basic (bad-flink) [91.729260] Starting subtest: bad-flink [91.730373] Subtest bad-flink: SUCCESS (0.000s) [91.786930] [029/162] (927s left) gem_flink_basic (bad-open) [91.844290] Starting subtest: bad-open [91.845442] Subtest bad-open: SUCCESS (0.000s) [91.948516] [030/162] (927s left) gem_flink_basic (basic) [92.239923] Starting subtest: basic [92.242175] Subtest basic: SUCCESS (0.000s) [92.311979] [031/162] (926s left) gem_flink_basic (double-flink) [92.368857] Starting subtest: double-flink [92.369809] Subtest double-flink: SUCCESS (0.000s) [92.439764] [032/162] (926s left) gem_flink_basic (flink-lifetime) [92.494295] Starting subtest: flink-lifetime [92.496417] Subtest flink-lifetime: SUCCESS (0.002s) [92.569816] [033/162] (926s left) gem_huc_copy (huc-copy) [92.637280] Starting subtest: huc-copy [92.640469] Subtest huc-copy: SKIP (0.000s) [92.715081] [034/162] (926s left) gem_linear_blits (basic) [92.891577] Starting subtest: basic [92.901894] Subtest basic: SUCCESS (0.010s) [92.995530] [035/162] (926s left) gem_mmap (basic) [93.103243] Starting subtest: basic [93.110256] Subtest basic: SUCCESS (0.000s) [93.170673] [036/162] (926s left) gem_mmap_gtt (basic) [93.227992] Starting subtest: basic [93.229074] Subtest basic: SUCCESS (0.001s) [93.286358] [037/162] (926s left) gem_render_linear_blits (basic) [93.352353] Starting subtest: basic [93.383485] Subtest basic: SUCCESS (0.031s) [93.457685] [038/162] (926s left) gem_render_tiled_blits (basic) [93.527180] Starting subtest: basic [93.568383] Subtest basic: SUCCESS (0.041s) [93.636350] [039/162] (925s left) gem_ringfill (basic-all) [93.917417] Starting subtest: basic-all [95.139763] Subtest basic-all: SUCCESS (1.167s) [95.202737] [040/162] (924s left) gem_softpin (allocator-basic) [95.277744] Starting subtest: allocator-basic [95.476950] Subtest allocator-basic: SUCCESS (0.142s) [95.529922] [041/162] (924s left) gem_softpin (allocator-basic-reserve) [95.604722] Starting subtest: allocator-basic-reserve [95.802783] Subtest allocator-basic-reserve: SUCCESS (0.141s) [95.854916] [042/162] (923s left) gem_softpin (safe-alignment) [95.933627] Starting subtest: safe-alignment [95.955683] Subtest safe-alignment: SUCCESS (0.021s) [96.037205] [043/162] (923s left) gem_sync (basic-all) [96.201314] Starting subtest: basic-all [98.432350] Subtest basic-all: SUCCESS (2.275s) [98.602893] [044/162] (921s left) gem_sync (basic-each) [98.682309] Starting subtest: basic-each [100.891580] Subtest basic-each: SUCCESS (2.209s) [101.137189] [045/162] (918s left) gem_tiled_blits (basic) [101.279647] Starting subtest: basic [101.299850] Subtest basic: SUCCESS (0.020s) [101.421989] [046/162] (918s left) gem_tiled_fence_blits (basic) [101.951331] Starting subtest: basic [101.962357] Subtest basic: SUCCESS (0.011s) [102.059654] [047/162] (918s left) gem_tiled_pread_basic [102.405680] [048/162] (917s left) gem_wait (busy@all-engines) [102.494710] Starting subtest: busy [102.495904] Starting dynamic subtest: all-engines [103.074253] Dynamic subtest all-engines: SUCCESS (0.577s) [103.076393] Subtest busy: SUCCESS (0.578s) [103.299878] [049/162] (916s left) gem_wait (wait@all-engines) [103.387727] Starting subtest: wait [103.388958] Starting dynamic subtest: all-engines [104.479581] Dynamic subtest all-engines: SUCCESS (1.045s) [104.482254] Subtest wait: SUCCESS (1.046s) [104.672408] [050/162] (915s left) i915_getparams_basic (basic-eu-total) [104.739029] Starting subtest: basic-eu-total [104.741176] Subtest basic-eu-total: SUCCESS (0.000s) [104.793885] [051/162] (915s left) i915_getparams_basic (basic-subslice-total) [104.849404] Starting subtest: basic-subslice-total [104.851568] Subtest basic-subslice-total: SUCCESS (0.000s) [104.904597] [052/162] (915s left) i915_hangman (error-state-basic) [104.981334] Starting subtest: error-state-basic [104.992597] Subtest error-state-basic: SUCCESS (0.010s) [105.177029] [053/162] (915s left) i915_pciid [105.508051] [054/162] (915s left) intel_hwmon (hwmon-read) [105.578132] Subtest hwmon-read: SKIP (0.000s) [105.639139] [055/162] (915s left) intel_hwmon (hwmon-write) [105.695875] Subtest hwmon-write: SKIP (0.000s) [105.751350] [056/162] (915s left) kms_addfb_basic (addfb25-4-tiled) [106.034977] Starting subtest: addfb25-4-tiled [106.036273] Subtest addfb25-4-tiled: SUCCESS (0.001s) [106.116549] [057/162] (914s left) kms_addfb_basic (addfb25-bad-modifier) [106.386476] Starting subtest: addfb25-bad-modifier [106.387645] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [106.465744] [058/162] (914s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [106.736223] Starting subtest: addfb25-framebuffer-vs-set-tiling [106.738098] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [106.818311] [059/162] (914s left) kms_addfb_basic (addfb25-modifier-no-flag) [107.089764] Starting subtest: addfb25-modifier-no-flag [107.091069] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [107.180088] [060/162] (913s left) kms_addfb_basic (addfb25-x-tiled-legacy) [107.463901] Starting subtest: addfb25-x-tiled-legacy [107.465168] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [107.542259] [061/162] (913s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [107.823560] Starting subtest: addfb25-x-tiled-mismatch-legacy [107.826253] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [107.925569] [062/162] (913s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [108.197356] Starting subtest: addfb25-yf-tiled-legacy [108.199664] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [108.280582] [063/162] (913s left) kms_addfb_basic (addfb25-y-tiled-legacy) [108.565387] Starting subtest: addfb25-y-tiled-legacy [108.566724] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [108.653336] [064/162] (912s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [108.924852] Starting subtest: addfb25-y-tiled-small-legacy [108.927200] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [109.004534] [065/162] (912s left) kms_addfb_basic (bad-pitch-0) [109.060667] Starting subtest: bad-pitch-0 [109.061675] Subtest bad-pitch-0: SUCCESS (0.000s) [109.359648] [066/162] (912s left) kms_addfb_basic (bad-pitch-1024) [109.416567] Starting subtest: bad-pitch-1024 [109.417626] Subtest bad-pitch-1024: SUCCESS (0.000s) [109.707390] [067/162] (911s left) kms_addfb_basic (bad-pitch-128) [109.764494] Starting subtest: bad-pitch-128 [109.765471] Subtest bad-pitch-128: SUCCESS (0.000s) [110.053014] [068/162] (911s left) kms_addfb_basic (bad-pitch-256) [110.109937] Starting subtest: bad-pitch-256 [110.111069] Subtest bad-pitch-256: SUCCESS (0.000s) [110.405409] [069/162] (911s left) kms_addfb_basic (bad-pitch-32) [110.462196] Starting subtest: bad-pitch-32 [110.463262] Subtest bad-pitch-32: SUCCESS (0.000s) [110.761145] [070/162] (910s left) kms_addfb_basic (bad-pitch-63) [110.817588] Starting subtest: bad-pitch-63 [110.818764] Subtest bad-pitch-63: SUCCESS (0.000s) [111.126186] [071/162] (910s left) kms_addfb_basic (bad-pitch-65536) [111.182364] Starting subtest: bad-pitch-65536 [111.183352] Subtest bad-pitch-65536: SUCCESS (0.000s) [111.475850] [072/162] (910s left) kms_addfb_basic (bad-pitch-999) [111.533354] Starting subtest: bad-pitch-999 [111.534379] Subtest bad-pitch-999: SUCCESS (0.000s) [111.852235] [073/162] (910s left) kms_addfb_basic (basic) [111.909171] Starting subtest: basic [111.910160] Subtest basic: SUCCESS (0.000s) [112.202109] [074/162] (909s left) kms_addfb_basic (basic-x-tiled-legacy) [112.259250] Starting subtest: basic-x-tiled-legacy [112.260721] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [112.549117] [075/162] (909s left) kms_addfb_basic (basic-y-tiled-legacy) [112.607835] Starting subtest: basic-y-tiled-legacy [112.608933] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [112.915342] [076/162] (909s left) kms_addfb_basic (bo-too-small) [113.187420] Starting subtest: bo-too-small [113.188816] Subtest bo-too-small: SUCCESS (0.001s) [113.275117] [077/162] (908s left) kms_addfb_basic (bo-too-small-due-to-tiling) [113.552174] Starting subtest: bo-too-small-due-to-tiling [113.554230] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [113.645049] [078/162] (908s left) kms_addfb_basic (clobberred-modifier) [113.701816] Starting subtest: clobberred-modifier [113.703379] Subtest clobberred-modifier: SUCCESS (0.000s) [114.000034] [079/162] (908s left) kms_addfb_basic (framebuffer-vs-set-tiling) [114.058193] Starting subtest: framebuffer-vs-set-tiling [114.059176] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [114.354125] [080/162] (908s left) kms_addfb_basic (invalid-get-prop) [114.409963] Starting subtest: invalid-get-prop [114.411224] Subtest invalid-get-prop: SUCCESS (0.000s) [114.715666] [081/162] (907s left) kms_addfb_basic (invalid-get-prop-any) [114.773233] Starting subtest: invalid-get-prop-any [114.774207] Subtest invalid-get-prop-any: SUCCESS (0.000s) [115.079063] [082/162] (907s left) kms_addfb_basic (invalid-set-prop) [115.136261] Starting subtest: invalid-set-prop [115.137265] Subtest invalid-set-prop: SUCCESS (0.000s) [115.439828] [083/162] (907s left) kms_addfb_basic (invalid-set-prop-any) [115.496207] Starting subtest: invalid-set-prop-any [115.497191] Subtest invalid-set-prop-any: SUCCESS (0.000s) [115.791681] [084/162] (906s left) kms_addfb_basic (no-handle) [115.848747] Starting subtest: no-handle [115.849935] Subtest no-handle: SUCCESS (0.000s) [116.151683] [085/162] (906s left) kms_addfb_basic (size-max) [116.427835] Starting subtest: size-max [116.429441] Subtest size-max: SUCCESS (0.000s) [116.514761] [086/162] (906s left) kms_addfb_basic (small-bo) [116.792779] Starting subtest: small-bo [116.794244] Subtest small-bo: SUCCESS (0.000s) [116.873282] [087/162] (906s left) kms_addfb_basic (tile-pitch-mismatch) [116.930528] Starting subtest: tile-pitch-mismatch [116.931525] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [117.227081] [088/162] (905s left) kms_addfb_basic (too-high) [117.497736] Starting subtest: too-high [117.499130] Subtest too-high: SUCCESS (0.002s) [117.584636] [089/162] (905s left) kms_addfb_basic (too-wide) [117.848991] Starting subtest: too-wide [117.850371] Subtest too-wide: SUCCESS (0.000s) [117.929855] [090/162] (905s left) kms_addfb_basic (unused-handle) [117.986312] Starting subtest: unused-handle [117.987302] Subtest unused-handle: SUCCESS (0.000s) [118.289835] [091/162] (904s left) kms_addfb_basic (unused-modifier) [118.346274] Starting subtest: unused-modifier [118.347232] Subtest unused-modifier: SUCCESS (0.000s) [118.655819] [092/162] (904s left) kms_addfb_basic (unused-offsets) [118.712402] Starting subtest: unused-offsets [118.713351] Subtest unused-offsets: SUCCESS (0.000s) [119.015455] [093/162] (904s left) kms_addfb_basic (unused-pitches) [119.072685] Starting subtest: unused-pitches [119.073808] Subtest unused-pitches: SUCCESS (0.000s) [119.383018] [094/162] (903s left) kms_busy (basic) [119.670985] Subtest basic: SKIP (0.000s) [119.738046] [095/162] (903s left) kms_prop_blob (basic) [119.794346] Starting subtest: basic [119.795303] Subtest basic: SUCCESS (0.000s) [119.850080] [096/162] (903s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [120.134072] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [120.194711] [097/162] (903s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [120.475523] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [120.560797] [098/162] (903s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [120.851810] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [120.902721] [099/162] (902s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [121.188553] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [121.290225] [100/162] (902s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [121.568764] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [121.624651] [101/162] (902s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [121.911270] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [121.972989] [102/162] (901s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [122.247898] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [122.310258] [103/162] (901s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [122.592580] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [122.647454] [104/162] (901s left) kms_dsc (dsc-basic) [122.922107] Subtest dsc-basic: SKIP (0.000s) [122.989063] [105/162] (901s left) kms_flip (basic-flip-vs-dpms) [123.267560] Starting subtest: basic-flip-vs-dpms [123.270844] Subtest basic-flip-vs-dpms: SKIP (0.003s) [123.343308] [106/162] (900s left) kms_flip (basic-flip-vs-modeset) [123.615826] Starting subtest: basic-flip-vs-modeset [123.620281] Subtest basic-flip-vs-modeset: SKIP (0.004s) [123.706603] [107/162] (900s left) kms_flip (basic-flip-vs-wf_vblank) [123.971512] Starting subtest: basic-flip-vs-wf_vblank [123.975243] Subtest basic-flip-vs-wf_vblank: SKIP (0.002s) [124.050793] [108/162] (900s left) kms_flip (basic-plain-flip) [124.318257] Starting subtest: basic-plain-flip [124.320445] Subtest basic-plain-flip: SKIP (0.002s) [124.402362] [109/162] (899s left) kms_force_connector_basic (force-connector-state) [124.789436] Starting subtest: force-connector-state [125.588048] Subtest force-connector-state: SUCCESS (0.800s) [126.187459] [110/162] (898s left) kms_force_connector_basic (force-edid) [126.583755] Starting subtest: force-edid [127.233416] Subtest force-edid: SUCCESS (0.649s) [127.744333] [111/162] (896s left) kms_force_connector_basic (force-load-detect) [128.124195] Starting subtest: force-load-detect [128.127286] Subtest force-load-detect: SKIP (0.000s) [128.507862] [112/162] (896s left) kms_force_connector_basic (prune-stale-modes) [128.901288] Starting subtest: prune-stale-modes [129.632241] Subtest prune-stale-modes: SUCCESS (0.730s) [130.132726] [113/162] (894s left) kms_frontbuffer_tracking (basic) [130.405279] Subtest basic: SKIP (0.000s) [130.480278] [114/162] (894s left) kms_hdmi_inject (inject-audio) [130.541123] Starting subtest: inject-audio [131.174746] Subtest inject-audio: SUCCESS (0.631s) [131.442883] [115/162] (893s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [131.719811] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [131.787014] [116/162] (893s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [132.057422] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [132.128924] [117/162] (892s left) kms_pipe_crc_basic (hang-read-crc) [132.391230] Subtest hang-read-crc: SKIP (0.000s) [132.461619] [118/162] (892s left) kms_pipe_crc_basic (nonblocking-crc) [132.729666] Subtest nonblocking-crc: SKIP (0.000s) [132.797150] [119/162] (892s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [133.066227] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [133.138047] [120/162] (891s left) kms_pipe_crc_basic (read-crc) [133.421151] Subtest read-crc: SKIP (0.000s) [133.484768] [121/162] (891s left) kms_pipe_crc_basic (read-crc-frame-sequence) [133.751330] Subtest read-crc-frame-sequence: SKIP (0.000s) [133.822600] [122/162] (891s left) kms_pm_backlight (basic-brightness) [134.099474] Subtest basic-brightness: SKIP (0.000s) [134.177663] [123/162] (891s left) kms_pm_rpm (basic-pci-d3-state) [135.808645] Starting subtest: basic-pci-d3-state [136.183361] Subtest basic-pci-d3-state: SUCCESS (0.347s) [136.333661] [124/162] (888s left) kms_pm_rpm (basic-rte) [136.397585] Starting subtest: basic-rte [138.281849] Subtest basic-rte: SUCCESS (1.880s) [138.788360] [125/162] (886s left) kms_psr (psr-primary-page-flip) [139.282198] Subtest psr-primary-page-flip: SKIP (0.000s) [139.357638] [126/162] (886s left) kms_psr (psr-cursor-plane-move) [139.627077] Subtest psr-cursor-plane-move: SKIP (0.000s) [139.698773] [127/162] (885s left) kms_psr (psr-sprite-plane-onoff) [139.966555] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [140.036965] [128/162] (885s left) kms_psr (psr-primary-mmap-gtt) [140.306963] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [140.384984] [129/162] (885s left) kms_setmode (basic-clone-single-crtc) [140.445105] Starting subtest: basic-clone-single-crtc [140.447698] Subtest basic-clone-single-crtc: SKIP (0.000s) [140.506619] [130/162] (885s left) i915_pm_rps (basic-api) [140.576973] Starting subtest: basic-api [140.581438] Subtest basic-api: SUCCESS (0.005s) [140.640392] [131/162] (885s left) prime_self_import (basic-llseek-bad) [140.697112] Starting subtest: basic-llseek-bad [140.700014] Subtest basic-llseek-bad: SUCCESS (0.003s) [140.776693] [132/162] (885s left) prime_self_import (basic-llseek-size) [140.831062] Starting subtest: basic-llseek-size [140.836114] Subtest basic-llseek-size: SUCCESS (0.005s) [140.918639] [133/162] (884s left) prime_self_import (basic-with_fd_dup) [140.977810] Starting subtest: basic-with_fd_dup [140.980128] Subtest basic-with_fd_dup: SUCCESS (0.005s) [141.074047] [134/162] (884s left) prime_self_import (basic-with_one_bo) [141.127469] Starting subtest: basic-with_one_bo [141.132176] Subtest basic-with_one_bo: SUCCESS (0.004s) [141.194665] [135/162] (884s left) prime_self_import (basic-with_one_bo_two_files) [141.248187] Starting subtest: basic-with_one_bo_two_files [141.251829] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [141.335761] [136/162] (884s left) prime_self_import (basic-with_two_bos) [141.394018] Starting subtest: basic-with_two_bos [141.396062] Subtest basic-with_two_bos: SUCCESS (0.004s) [141.478290] [137/162] (884s left) prime_vgem (basic-fence-flip) [141.546049] Starting subtest: basic-fence-flip [141.755452] Subtest basic-fence-flip: SKIP (0.208s) [141.832159] [138/162] (884s left) prime_vgem (basic-fence-mmap) [141.902392] Starting subtest: basic-fence-mmap [141.931556] Subtest basic-fence-mmap: SUCCESS (0.031s) [142.001631] [139/162] (884s left) prime_vgem (basic-fence-read) [142.068177] Starting subtest: basic-fence-read [142.137497] Subtest basic-fence-read: SUCCESS (0.069s) [142.203963] [140/162] (884s left) prime_vgem (basic-gtt) [142.284811] Starting subtest: basic-gtt [142.298463] Subtest basic-gtt: SUCCESS (0.013s) [142.376303] [141/162] (883s left) prime_vgem (basic-read) [142.444342] Starting subtest: basic-read [142.478284] Subtest basic-read: SUCCESS (0.032s) [142.562765] [142/162] (883s left) prime_vgem (basic-write) [142.630148] Starting subtest: basic-write [142.664344] Subtest basic-write: SUCCESS (0.035s) [142.729569] [143/162] (883s left) vgem_basic (setversion) [142.788898] Starting subtest: setversion [142.790942] Subtest setversion: SUCCESS (0.000s) [142.847667] [144/162] (883s left) vgem_basic (create) [142.906875] Starting subtest: create [142.907901] Subtest create: SUCCESS (0.000s) [142.968502] [145/162] (883s left) vgem_basic (debugfs) [143.027236] Starting subtest: debugfs [143.028158] Subtest debugfs: SUCCESS (0.001s) [143.088058] [146/162] (883s left) vgem_basic (dmabuf-export) [143.147333] Starting subtest: dmabuf-export [143.149285] Subtest dmabuf-export: SUCCESS (0.002s) [143.225178] [147/162] (883s left) vgem_basic (dmabuf-fence) [143.285791] Starting subtest: dmabuf-fence [143.286785] Subtest dmabuf-fence: SUCCESS (0.001s) [143.343627] [148/162] (883s left) vgem_basic (dmabuf-fence-before) [143.402365] Starting subtest: dmabuf-fence-before [143.403332] Subtest dmabuf-fence-before: SUCCESS (0.000s) [143.461400] [149/162] (883s left) vgem_basic (dmabuf-mmap) [143.519813] Starting subtest: dmabuf-mmap [143.530703] Subtest dmabuf-mmap: SUCCESS (0.012s) [143.591031] [150/162] (883s left) vgem_basic (mmap) [143.651272] Starting subtest: mmap [143.659276] Subtest mmap: SUCCESS (0.009s) [143.718682] [151/162] (883s left) vgem_basic (second-client) [143.778402] Starting subtest: second-client [143.780279] Subtest second-client: SUCCESS (0.004s) [143.838655] [152/162] (883s left) vgem_basic (sysfs) [143.897132] Starting subtest: sysfs [143.898121] Subtest sysfs: SUCCESS (0.001s) [143.957035] [153/162] (883s left) core_hotunplug (unbind-rebind) [144.070128] Starting subtest: unbind-rebind [148.439650] Subtest unbind-rebind: SUCCESS (4.363s) [148.492744] [154/162] (878s left) vgem_basic (unload) [148.558538] Starting subtest: unload [177.566155] Subtest unload: SUCCESS (28.951s) [177.619606] [155/162] (849s left) i915_module_load (reload) [177.685243] Starting subtest: reload [181.407569] Subtest reload: SUCCESS (3.724s) [181.496895] [156/162] (845s left) gem_lmem_swapping (basic) [181.780652] Subtest basic: SKIP (0.000s) [181.883341] [157/162] (845s left) gem_lmem_swapping (parallel-random-engines) [181.946348] Subtest parallel-random-engines: SKIP (0.000s) [182.001608] [158/162] (845s left) gem_lmem_swapping (random-engines) [182.064880] Subtest random-engines: SKIP (0.000s) [182.118759] [159/162] (845s left) gem_lmem_swapping (verify-random) [182.182073] Subtest verify-random: SKIP (0.000s) [182.237264] [160/162] (845s left) i915_pm_rpm (module-reload) [184.833630] Starting subtest: module-reload [199.960228] Subtest module-reload: SUCCESS (15.074s) [200.023343] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [200.024803] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [200.027086] [161/162] (827s left) i915_selftest (live) [200.102596] Starting subtest: live [200.103944] Starting dynamic subtest: sanitycheck [202.995964] Dynamic subtest sanitycheck: SUCCESS (2.837s) [203.006820] Starting dynamic subtest: uncore [205.861383] Dynamic subtest uncore: SUCCESS (2.864s) [205.872190] Starting dynamic subtest: workarounds [209.041139] Dynamic subtest workarounds: SUCCESS (3.179s) [209.051949] Starting dynamic subtest: gt_engines [212.413292] Dynamic subtest gt_engines: SUCCESS (3.371s) [212.424141] Starting dynamic subtest: gt_timelines [227.852651] Dynamic subtest gt_timelines: SUCCESS (15.438s) [227.863433] Starting dynamic subtest: gt_contexts [230.870062] Dynamic subtest gt_contexts: SUCCESS (3.017s) [230.880821] Starting dynamic subtest: gt_lrc [236.869150] Dynamic subtest gt_lrc: SUCCESS (5.998s) [236.880011] Starting dynamic subtest: gt_mocs [239.798237] Dynamic subtest gt_mocs: SUCCESS (2.928s) [239.812473] Starting dynamic subtest: gt_pm [251.328788] Dynamic subtest gt_pm: SUCCESS (11.529s) [251.343903] Starting dynamic subtest: gt_heartbeat [254.269015] Dynamic subtest gt_heartbeat: SUCCESS (2.939s) [254.280063] Starting dynamic subtest: gt_tlb [258.808883] Dynamic subtest gt_tlb: SUCCESS (4.539s) [258.819849] Starting dynamic subtest: requests [269.165386] Dynamic subtest requests: SUCCESS (10.355s) [269.176229] Starting dynamic subtest: migrate [275.046012] Dynamic subtest migrate: SUCCESS (5.880s) [275.060369] Starting dynamic subtest: active [277.910743] Dynamic subtest active: SUCCESS (2.864s) [277.921619] Starting dynamic subtest: objects [281.637895] Dynamic subtest objects: SUCCESS (3.726s) [281.649439] Starting dynamic subtest: mman [288.069044] Dynamic subtest mman: SUCCESS (6.430s) [288.079969] Starting dynamic subtest: dmabuf [290.969047] Dynamic subtest dmabuf: SUCCESS (2.899s) [290.979970] Starting dynamic subtest: vma [293.824047] Dynamic subtest vma: SUCCESS (2.854s) [293.834966] Starting dynamic subtest: coherency [297.863127] Dynamic subtest coherency: SUCCESS (4.038s) [297.877410] Starting dynamic subtest: gtt [307.900221] Dynamic subtest gtt: SUCCESS (10.065s) [307.911084] Starting dynamic subtest: gem [311.315910] Dynamic subtest gem: SUCCESS (3.384s) [311.330285] Starting dynamic subtest: evict [316.484950] Dynamic subtest evict: SUCCESS (5.168s) [316.495879] Starting dynamic subtest: hugepages [325.817805] Dynamic subtest hugepages: SUCCESS (9.331s) [325.828642] Starting dynamic subtest: gem_contexts [345.788618] Dynamic subtest gem_contexts: SUCCESS (19.969s) [345.799618] Starting dynamic subtest: client [348.740828] Dynamic subtest client: SUCCESS (2.950s) [348.755208] Starting dynamic subtest: gem_migrate [351.584946] Dynamic subtest gem_migrate: SUCCESS (2.842s) [351.596030] Starting dynamic subtest: reset [354.894865] Dynamic subtest reset: SUCCESS (3.308s) [354.909228] Starting dynamic subtest: memory_region [357.758202] Dynamic subtest memory_region: SUCCESS (2.861s) [357.772566] Starting dynamic subtest: hangcheck [389.342019] Dynamic subtest hangcheck: SUCCESS (31.582s) [389.352963] Starting dynamic subtest: execlists [405.299232] Dynamic subtest execlists: SUCCESS (15.955s) [405.310168] Starting dynamic subtest: ring_submission [408.158073] Dynamic subtest ring_submission: SUCCESS (2.857s) [408.169027] Starting dynamic subtest: perf [411.106015] Dynamic subtest perf: SUCCESS (2.946s) [411.117096] Starting dynamic subtest: slpc [413.961843] Dynamic subtest slpc: SUCCESS (2.854s) [413.972814] Starting dynamic subtest: guc [416.815052] Dynamic subtest guc: SUCCESS (2.851s) [416.829434] Starting dynamic subtest: guc_multi_lrc [419.671793] Dynamic subtest guc_multi_lrc: SUCCESS (2.855s) [419.682781] Starting dynamic subtest: guc_hang [422.536232] Dynamic subtest guc_hang: SUCCESS (2.862s) [422.547296] Starting dynamic subtest: late_gt_pm [425.423977] Dynamic subtest late_gt_pm: SUCCESS (2.886s) [425.426275] Subtest live: SUCCESS (225.265s) [425.494765] [162/162] (602s left) dmabuf (all-tests) [425.567990] Starting subtest: all-tests [425.569466] Starting dynamic subtest: sanitycheck [425.627886] Dynamic subtest sanitycheck: SUCCESS (0.059s) [425.666359] Starting dynamic subtest: dma_fence [425.847897] Dynamic subtest dma_fence: SUCCESS (0.216s) [425.872108] Starting dynamic subtest: dma_fence_chain [425.874810] Dynamic subtest dma_fence_chain: SKIP (0.001s) [425.899249] Starting dynamic subtest: dma_fence_unwrap [425.926087] Dynamic subtest dma_fence_unwrap: SUCCESS (0.071s) [425.957393] Starting dynamic subtest: dma_resv [426.005616] Dynamic subtest dma_resv: SUCCESS (0.074s) [426.008833] Subtest all-tests: SUCCESS (0.441s) [426.080849] Closing watchdogs results: parsing output: 0/ for test: i915_module_load results: parsing output: 1/ for test: core_auth results: parsing output: 2/ for test: core_debugfs results: parsing output: 3/ for test: core_sysfs results: parsing output: 4/ for test: fbdev results: parsing output: 5/ for test: fbdev results: parsing output: 6/ for test: fbdev results: parsing output: 7/ for test: fbdev results: parsing output: 8/ for test: fbdev results: parsing output: 9/ for test: gem_basic results: parsing output: 10/ for test: gem_basic results: parsing output: 11/ for test: gem_basic results: parsing output: 12/ for test: gem_busy results: parsing output: 13/ for test: gem_close_race results: parsing output: 14/ for test: gem_close_race results: parsing output: 15/ for test: gem_ctx_create results: parsing output: 16/ for test: gem_ctx_create results: parsing output: 17/ for test: gem_ctx_exec results: parsing output: 18/ for test: gem_exec_basic results: parsing output: 19/ for test: gem_exec_create results: parsing output: 20/ for test: gem_exec_fence results: parsing output: 21/ for test: gem_exec_fence results: parsing output: 22/ for test: gem_exec_fence results: parsing output: 23/ for test: gem_exec_fence results: parsing output: 24/ for test: gem_exec_gttfill results: parsing output: 25/ for test: gem_exec_parallel results: parsing output: 26/ for test: gem_exec_store results: parsing output: 27/ for test: gem_flink_basic results: parsing output: 28/ for test: gem_flink_basic results: parsing output: 29/ for test: gem_flink_basic results: parsing output: 30/ for test: gem_flink_basic results: parsing output: 31/ for test: gem_flink_basic results: parsing output: 32/ for test: gem_huc_copy results: parsing output: 33/ for test: gem_linear_blits results: parsing output: 34/ for test: gem_mmap results: parsing output: 35/ for test: gem_mmap_gtt results: parsing output: 36/ for test: gem_render_linear_blits results: parsing output: 37/ for test: gem_render_tiled_blits results: parsing output: 38/ for test: gem_ringfill results: parsing output: 39/ for test: gem_softpin results: parsing output: 40/ for test: gem_softpin results: parsing output: 41/ for test: gem_softpin results: parsing output: 42/ for test: gem_sync results: parsing output: 43/ for test: gem_sync results: parsing output: 44/ for test: gem_tiled_blits results: parsing output: 45/ for test: gem_tiled_fence_blits results: parsing output: 46/ for test: gem_tiled_pread_basic results: parsing output: 47/ for test: gem_wait results: parsing output: 48/ for test: gem_wait results: parsing output: 49/ for test: i915_getparams_basic results: parsing output: 50/ for test: i915_getparams_basic results: parsing output: 51/ for test: i915_hangman results: parsing output: 52/ for test: i915_pciid results: parsing output: 53/ for test: intel_hwmon results: parsing output: 54/ for test: intel_hwmon results: parsing output: 55/ for test: kms_addfb_basic results: parsing output: 56/ for test: kms_addfb_basic results: parsing output: 57/ for test: kms_addfb_basic results: parsing output: 58/ for test: kms_addfb_basic results: parsing output: 59/ for test: kms_addfb_basic results: parsing output: 60/ for test: kms_addfb_basic results: parsing output: 61/ for test: kms_addfb_basic results: parsing output: 62/ for test: kms_addfb_basic results: parsing output: 63/ for test: kms_addfb_basic results: parsing output: 64/ for test: kms_addfb_basic results: parsing output: 65/ for test: kms_addfb_basic results: parsing output: 66/ for test: kms_addfb_basic results: parsing output: 67/ for test: kms_addfb_basic results: parsing output: 68/ for test: kms_addfb_basic results: parsing output: 69/ for test: kms_addfb_basic results: parsing output: 70/ for test: kms_addfb_basic results: parsing output: 71/ for test: kms_addfb_basic results: parsing output: 72/ for test: kms_addfb_basic results: parsing output: 73/ for test: kms_addfb_basic results: parsing output: 74/ for test: kms_addfb_basic results: parsing output: 75/ for test: kms_addfb_basic results: parsing output: 76/ for test: kms_addfb_basic results: parsing output: 77/ for test: kms_addfb_basic results: parsing output: 78/ for test: kms_addfb_basic results: parsing output: 79/ for test: kms_addfb_basic results: parsing output: 80/ for test: kms_addfb_basic results: parsing output: 81/ for test: kms_addfb_basic results: parsing output: 82/ for test: kms_addfb_basic results: parsing output: 83/ for test: kms_addfb_basic results: parsing output: 84/ for test: kms_addfb_basic results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_addfb_basic results: parsing output: 87/ for test: kms_addfb_basic results: parsing output: 88/ for test: kms_addfb_basic results: parsing output: 89/ for test: kms_addfb_basic results: parsing output: 90/ for test: kms_addfb_basic results: parsing output: 91/ for test: kms_addfb_basic results: parsing output: 92/ for test: kms_addfb_basic results: parsing output: 93/ for test: kms_busy results: parsing output: 94/ for test: kms_prop_blob results: parsing output: 95/ for test: kms_cursor_legacy results: parsing output: 96/ for test: kms_cursor_legacy results: parsing output: 97/ for test: kms_cursor_legacy results: parsing output: 98/ for test: kms_cursor_legacy results: parsing output: 99/ for test: kms_cursor_legacy results: parsing output: 100/ for test: kms_cursor_legacy results: parsing output: 101/ for test: kms_cursor_legacy results: parsing output: 102/ for test: kms_cursor_legacy results: parsing output: 103/ for test: kms_dsc results: parsing output: 104/ for test: kms_flip results: parsing output: 105/ for test: kms_flip results: parsing output: 106/ for test: kms_flip results: parsing output: 107/ for test: kms_flip results: parsing output: 108/ for test: kms_force_connector_basic results: parsing output: 109/ for test: kms_force_connector_basic results: parsing output: 110/ for test: kms_force_connector_basic results: parsing output: 111/ for test: kms_force_connector_basic results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_hdmi_inject results: parsing output: 114/ for test: kms_pipe_crc_basic results: parsing output: 115/ for test: kms_pipe_crc_basic results: parsing output: 116/ for test: kms_pipe_crc_basic results: parsing output: 117/ for test: kms_pipe_crc_basic results: parsing output: 118/ for test: kms_pipe_crc_basic results: parsing output: 119/ for test: kms_pipe_crc_basic results: parsing output: 120/ for test: kms_pipe_crc_basic results: parsing output: 121/ for test: kms_pm_backlight results: parsing output: 122/ for test: kms_pm_rpm results: parsing output: 123/ for test: kms_pm_rpm results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: kms_psr results: parsing output: 127/ for test: kms_psr results: parsing output: 128/ for test: kms_setmode results: parsing output: 129/ for test: i915_pm_rps results: parsing output: 130/ for test: prime_self_import results: parsing output: 131/ for test: prime_self_import results: parsing output: 132/ for test: prime_self_import results: parsing output: 133/ for test: prime_self_import results: parsing output: 134/ for test: prime_self_import results: parsing output: 135/ for test: prime_self_import results: parsing output: 136/ for test: prime_vgem results: parsing output: 137/ for test: prime_vgem results: parsing output: 138/ for test: prime_vgem results: parsing output: 139/ for test: prime_vgem results: parsing output: 140/ for test: prime_vgem results: parsing output: 141/ for test: prime_vgem results: parsing output: 142/ for test: vgem_basic results: parsing output: 143/ for test: vgem_basic results: parsing output: 144/ for test: vgem_basic results: parsing output: 145/ for test: vgem_basic results: parsing output: 146/ for test: vgem_basic results: parsing output: 147/ for test: vgem_basic results: parsing output: 148/ for test: vgem_basic results: parsing output: 149/ for test: vgem_basic results: parsing output: 150/ for test: vgem_basic results: parsing output: 151/ for test: vgem_basic results: parsing output: 152/ for test: core_hotunplug results: parsing output: 153/ for test: vgem_basic results: parsing output: 154/ for test: i915_module_load results: parsing output: 155/ for test: gem_lmem_swapping results: parsing output: 156/ for test: gem_lmem_swapping results: parsing output: 157/ for test: gem_lmem_swapping results: parsing output: 158/ for test: gem_lmem_swapping results: parsing output: 159/ for test: i915_pm_rpm results: parsing output: 160/ for test: i915_selftest results: parsing output: 161/ for test: dmabuf Done.