[40.124783] Initializing watchdogs
[40.124865]   /dev/watchdog0
[40.140647] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:0412 Intel Haswell (Gen7) Xeon E3-1200 v3/4th Gen Core Processor Integrated Graphics Controller (ThinkCentre M83)
[40.145676] [001/162] (960s left) i915_module_load (load)
[40.201135] Starting subtest: load
[41.629783] Subtest load: SUCCESS (1.428s)
[41.662924] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[41.664702] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[41.667667] [002/162] (959s left) core_auth (basic-auth)
[41.715922] Starting subtest: basic-auth
[41.717069] Subtest basic-auth: SUCCESS (0.001s)
[41.818905] [003/162] (958s left) core_debugfs (read-all-entries)
[41.862562] Starting subtest: read-all-entries
[41.930750] Subtest read-all-entries: SUCCESS (0.068s)
[42.017142] [004/162] (958s left) core_sysfs (read-all-entries)
[42.062818] Starting subtest: read-all-entries
[42.065978] Subtest read-all-entries: SUCCESS (0.004s)
[42.170408] [005/162] (958s left) fbdev (eof)
[42.231651] Starting subtest: eof
[42.232776] Subtest eof: SUCCESS (0.000s)
[42.333558] [006/162] (958s left) fbdev (info)
[42.372547] Starting subtest: info
[42.373589] Subtest info: SUCCESS (0.000s)
[42.448962] [007/162] (958s left) fbdev (nullptr)
[42.495606] Starting subtest: nullptr
[42.496806] Subtest nullptr: SUCCESS (0.000s)
[42.567694] [008/162] (958s left) fbdev (read)
[42.611797] Starting subtest: read
[42.693972] Subtest read: SUCCESS (0.082s)
[42.767051] [009/162] (958s left) fbdev (write)
[42.813764] Starting subtest: write
[42.854543] Subtest write: SUCCESS (0.042s)
[42.950618] [010/162] (958s left) gem_basic (bad-close)
[42.991694] Starting subtest: bad-close
[42.993865] Subtest bad-close: SUCCESS (0.000s)
[43.066073] [011/162] (957s left) gem_basic (create-close)
[43.115901] Starting subtest: create-close
[43.117983] Subtest create-close: SUCCESS (0.000s)
[43.218043] [012/162] (957s left) gem_basic (create-fd-close)
[43.262705] Starting subtest: create-fd-close
[43.264900] Subtest create-fd-close: SUCCESS (0.000s)
[43.367701] [013/162] (957s left) gem_busy (busy@all-engines)
[43.424088] Starting subtest: busy
[43.425222] Starting dynamic subtest: all-engines
[43.450994] Dynamic subtest all-engines: SUCCESS (0.027s)
[43.452244] Subtest busy: SUCCESS (0.027s)
[43.782829] [014/162] (957s left) gem_close_race (basic-process)
[43.843275] Starting subtest: basic-process
[43.878663] Subtest basic-process: SUCCESS (0.036s)
[44.065163] [015/162] (957s left) gem_close_race (basic-threads)
[44.119274] Starting subtest: basic-threads
[45.278861] Subtest basic-threads: SUCCESS (1.176s)
[45.471662] [016/162] (955s left) gem_ctx_create (basic)
[45.521121] Starting subtest: basic
[45.522166] Subtest basic: SUCCESS (0.000s)
[45.707977] [017/162] (955s left) gem_ctx_create (basic-files)
[45.758793] Starting subtest: basic-files
[47.771754] Subtest basic-files: SUCCESS (2.036s)
[47.999505] [018/162] (953s left) gem_ctx_exec (basic)
[48.045709] Starting subtest: basic
[48.049368] Subtest basic: SUCCESS (0.004s)
[48.164401] [019/162] (953s left) gem_exec_basic (basic)
[48.211326] Starting subtest: basic
[48.212444] Starting dynamic subtest: rcs0-smem
[48.213478] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[48.222162] Starting dynamic subtest: bcs0-smem
[48.223286] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[48.231920] Starting dynamic subtest: vcs0-smem
[48.233217] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[48.242111] Starting dynamic subtest: vecs0-smem
[48.243387] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[48.244473] Subtest basic: SUCCESS (0.003s)
[48.394838] [020/162] (953s left) gem_exec_create (basic)
[48.445772] Starting subtest: basic
[48.446876] Starting dynamic subtest: smem
[50.492699] Dynamic subtest smem: SUCCESS (2.062s)
[50.493972] Subtest basic: SUCCESS (2.063s)
[50.673946] [021/162] (950s left) gem_exec_fence (basic-busy)
[50.845720] Starting subtest: basic-busy
[50.847674] Starting dynamic subtest: rcs0
[50.878653] Dynamic subtest rcs0: SUCCESS (0.033s)
[50.887822] Starting dynamic subtest: bcs0
[50.913450] Dynamic subtest bcs0: SUCCESS (0.035s)
[50.922665] Starting dynamic subtest: vcs0
[50.947321] Dynamic subtest vcs0: SUCCESS (0.034s)
[50.956720] Starting dynamic subtest: vecs0
[50.981419] Dynamic subtest vecs0: SUCCESS (0.034s)
[50.982542] Subtest basic-busy: SUCCESS (0.137s)
[51.475757] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[51.478092] [022/162] (950s left) gem_exec_fence (basic-wait)
[51.642642] Starting subtest: basic-wait
[51.643797] Starting dynamic subtest: rcs0
[51.678939] Dynamic subtest rcs0: SUCCESS (0.036s)
[51.688632] Starting dynamic subtest: bcs0
[51.708125] Dynamic subtest bcs0: SUCCESS (0.028s)
[51.718301] Starting dynamic subtest: vcs0
[51.741113] Dynamic subtest vcs0: SUCCESS (0.032s)
[51.750626] Starting dynamic subtest: vecs0
[51.768149] Dynamic subtest vecs0: SUCCESS (0.026s)
[51.769310] Subtest basic-wait: SUCCESS (0.127s)
[52.240708] [023/162] (949s left) gem_exec_fence (basic-await)
[52.408093] Starting subtest: basic-await
[52.409359] Starting dynamic subtest: rcs0
[52.483649] Dynamic subtest rcs0: SUCCESS (0.075s)
[52.494161] Starting dynamic subtest: bcs0
[52.557778] Dynamic subtest bcs0: SUCCESS (0.073s)
[52.568867] Starting dynamic subtest: vcs0
[52.640144] Dynamic subtest vcs0: SUCCESS (0.082s)
[52.651237] Starting dynamic subtest: vecs0
[52.717990] Dynamic subtest vecs0: SUCCESS (0.078s)
[52.719115] Subtest basic-await: SUCCESS (0.312s)
[53.182098] [024/162] (948s left) gem_exec_fence (nb-await)
[53.350046] Starting subtest: nb-await
[53.350951] Starting dynamic subtest: rcs0
[53.403329] Dynamic subtest rcs0: SUCCESS (0.055s)
[53.412796] Starting dynamic subtest: bcs0
[53.458919] Dynamic subtest bcs0: SUCCESS (0.054s)
[53.467666] Starting dynamic subtest: vcs0
[53.513965] Dynamic subtest vcs0: SUCCESS (0.054s)
[53.523226] Starting dynamic subtest: vecs0
[53.569319] Dynamic subtest vecs0: SUCCESS (0.055s)
[53.570386] Subtest nb-await: SUCCESS (0.222s)
[54.028089] [025/162] (947s left) gem_exec_gttfill (basic)
[54.080652] Starting subtest: basic
[57.488607] Subtest basic: SUCCESS (3.419s)
[57.682626] [026/162] (943s left) gem_exec_parallel (engines)
[57.799377] Starting subtest: engines
[57.800565] Starting dynamic subtest: basic
[60.582231] Dynamic subtest basic: SUCCESS (2.788s)
[60.592708] Starting dynamic subtest: contexts
[62.162833] Dynamic subtest contexts: SUCCESS (1.581s)
[62.174832] Starting dynamic subtest: fds
[63.963043] Dynamic subtest fds: SUCCESS (1.803s)
[63.973569] Starting dynamic subtest: userptr
[67.108594] Dynamic subtest userptr: SUCCESS (3.147s)
[67.109845] Subtest engines: SUCCESS (9.323s)
[67.306132] [027/162] (934s left) gem_exec_store (basic)
[67.360189] Starting subtest: basic
[67.397493] Subtest basic: SUCCESS (0.037s)
[67.581957] [028/162] (934s left) gem_flink_basic (bad-flink)
[67.625375] Starting subtest: bad-flink
[67.626429] Subtest bad-flink: SUCCESS (0.000s)
[67.716409] [029/162] (934s left) gem_flink_basic (bad-open)
[67.759477] Starting subtest: bad-open
[67.760523] Subtest bad-open: SUCCESS (0.000s)
[67.848151] [030/162] (934s left) gem_flink_basic (basic)
[67.890354] Starting subtest: basic
[67.891363] Subtest basic: SUCCESS (0.000s)
[67.982135] [031/162] (933s left) gem_flink_basic (double-flink)
[68.024308] Starting subtest: double-flink
[68.025332] Subtest double-flink: SUCCESS (0.000s)
[68.150092] [032/162] (933s left) gem_flink_basic (flink-lifetime)
[68.193948] Starting subtest: flink-lifetime
[68.195124] Subtest flink-lifetime: SUCCESS (0.001s)
[68.297539] [033/162] (933s left) gem_huc_copy (huc-copy)
[68.345920] Subtest huc-copy: SKIP (0.000s)
[68.393956] [034/162] (933s left) gem_linear_blits (basic)
[68.499529] Starting subtest: basic
[68.511219] Subtest basic: SUCCESS (0.010s)
[68.624875] [035/162] (933s left) gem_mmap (basic)
[68.743221] Starting subtest: basic
[68.748444] Subtest basic: SUCCESS (0.000s)
[68.849593] [036/162] (933s left) gem_mmap_gtt (basic)
[68.896355] Starting subtest: basic
[68.897371] Subtest basic: SUCCESS (0.001s)
[68.992746] [037/162] (933s left) gem_render_linear_blits (basic)
[69.040259] Starting subtest: basic
[69.059462] Subtest basic: SUCCESS (0.019s)
[69.126119] [038/162] (933s left) gem_render_tiled_blits (basic)
[69.172066] Starting subtest: basic
[69.194120] Subtest basic: SUCCESS (0.023s)
[69.261114] [039/162] (933s left) gem_ringfill (basic-all)
[69.477348] Starting subtest: basic-all
[70.584816] Subtest basic-all: SUCCESS (1.107s)
[70.695704] [040/162] (931s left) gem_softpin (allocator-basic)
[70.741318] Subtest allocator-basic: SKIP (0.000s)
[70.829514] [041/162] (931s left) gem_softpin (allocator-basic-reserve)
[70.875750] Subtest allocator-basic-reserve: SKIP (0.000s)
[70.962506] [042/162] (931s left) gem_softpin (safe-alignment)
[71.010408] Starting subtest: safe-alignment
[71.019207] Subtest safe-alignment: SUCCESS (0.011s)
[71.130199] [043/162] (931s left) gem_sync (basic-all)
[71.183520] Starting subtest: basic-all
[73.326219] Subtest basic-all: SUCCESS (2.143s)
[73.528238] [044/162] (928s left) gem_sync (basic-each)
[73.589064] Starting subtest: basic-each
[75.686944] Subtest basic-each: SUCCESS (2.098s)
[75.878066] [045/162] (926s left) gem_tiled_blits (basic)
[75.983207] Starting subtest: basic
[75.998083] Subtest basic: SUCCESS (0.015s)
[76.119521] [046/162] (926s left) gem_tiled_fence_blits (basic)
[76.298942] Starting subtest: basic
[76.307280] Subtest basic: SUCCESS (0.009s)
[76.454552] [047/162] (926s left) gem_tiled_pread_basic
[76.760124] [048/162] (925s left) gem_wait (busy@all-engines)
[76.817131] Starting subtest: busy
[76.818342] Starting dynamic subtest: all-engines
[77.338185] Dynamic subtest all-engines: SUCCESS (0.520s)
[77.339498] Subtest busy: SUCCESS (0.521s)
[77.545958] [049/162] (925s left) gem_wait (wait@all-engines)
[77.603822] Starting subtest: wait
[77.604854] Starting dynamic subtest: all-engines
[78.625304] Dynamic subtest all-engines: SUCCESS (1.021s)
[78.626382] Subtest wait: SUCCESS (1.022s)
[78.825477] [050/162] (923s left) i915_getparams_basic (basic-eu-total)
[78.868505] Starting subtest: basic-eu-total
[78.870571] Subtest basic-eu-total: SUCCESS (0.000s)
[78.959465] [051/162] (923s left) i915_getparams_basic (basic-subslice-total)
[79.003500] Starting subtest: basic-subslice-total
[79.006432] Subtest basic-subslice-total: SUCCESS (0.000s)
[79.091087] [052/162] (923s left) i915_hangman (error-state-basic)
[79.139471] Starting subtest: error-state-basic
[79.144097] Subtest error-state-basic: SUCCESS (0.005s)
[79.259339] [053/162] (923s left) i915_pciid
[79.394542] [054/162] (923s left) intel_hwmon (hwmon-read)
[79.442586] Subtest hwmon-read: SKIP (0.000s)
[79.488422] [055/162] (923s left) intel_hwmon (hwmon-write)
[79.531895] Subtest hwmon-write: SKIP (0.000s)
[79.587765] [056/162] (923s left) kms_addfb_basic (addfb25-4-tiled)
[79.682755] Starting subtest: addfb25-4-tiled
[79.683822] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[79.777694] [057/162] (923s left) kms_addfb_basic (addfb25-bad-modifier)
[79.862221] Starting subtest: addfb25-bad-modifier
[79.863261] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[79.958150] [058/162] (923s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[80.044051] Starting subtest: addfb25-framebuffer-vs-set-tiling
[80.045164] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[80.142523] [059/162] (923s left) kms_addfb_basic (addfb25-modifier-no-flag)
[80.227440] Starting subtest: addfb25-modifier-no-flag
[80.228435] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[80.326570] [060/162] (922s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[80.414816] Starting subtest: addfb25-x-tiled-legacy
[80.415900] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[80.526198] [061/162] (922s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[80.610686] Starting subtest: addfb25-x-tiled-mismatch-legacy
[80.611707] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[80.709624] [062/162] (922s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[80.792488] Starting subtest: addfb25-yf-tiled-legacy
[80.793588] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[80.910039] [063/162] (922s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[80.993066] Starting subtest: addfb25-y-tiled-legacy
[80.994139] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[81.089500] [064/162] (922s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[81.177326] Starting subtest: addfb25-y-tiled-small-legacy
[81.179351] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[81.293720] [065/162] (922s left) kms_addfb_basic (bad-pitch-0)
[81.337387] Starting subtest: bad-pitch-0
[81.338434] Subtest bad-pitch-0: SUCCESS (0.000s)
[81.492096] [066/162] (921s left) kms_addfb_basic (bad-pitch-1024)
[81.536837] Starting subtest: bad-pitch-1024
[81.538362] Subtest bad-pitch-1024: SUCCESS (0.000s)
[81.675422] [067/162] (921s left) kms_addfb_basic (bad-pitch-128)
[81.720239] Starting subtest: bad-pitch-128
[81.721335] Subtest bad-pitch-128: SUCCESS (0.000s)
[81.859125] [068/162] (921s left) kms_addfb_basic (bad-pitch-256)
[81.901993] Starting subtest: bad-pitch-256
[81.903163] Subtest bad-pitch-256: SUCCESS (0.000s)
[82.045943] [069/162] (921s left) kms_addfb_basic (bad-pitch-32)
[82.088383] Starting subtest: bad-pitch-32
[82.089367] Subtest bad-pitch-32: SUCCESS (0.000s)
[82.225756] [070/162] (921s left) kms_addfb_basic (bad-pitch-63)
[82.269898] Starting subtest: bad-pitch-63
[82.270942] Subtest bad-pitch-63: SUCCESS (0.000s)
[82.408872] [071/162] (921s left) kms_addfb_basic (bad-pitch-65536)
[82.453641] Starting subtest: bad-pitch-65536
[82.454704] Subtest bad-pitch-65536: SUCCESS (0.000s)
[82.622436] [072/162] (921s left) kms_addfb_basic (bad-pitch-999)
[82.664826] Starting subtest: bad-pitch-999
[82.665932] Subtest bad-pitch-999: SUCCESS (0.000s)
[82.808098] [073/162] (920s left) kms_addfb_basic (basic)
[82.851377] Starting subtest: basic
[82.852390] Subtest basic: SUCCESS (0.000s)
[82.992687] [074/162] (920s left) kms_addfb_basic (basic-x-tiled-legacy)
[83.037694] Starting subtest: basic-x-tiled-legacy
[83.038747] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[83.177088] [075/162] (920s left) kms_addfb_basic (basic-y-tiled-legacy)
[83.220767] Starting subtest: basic-y-tiled-legacy
[83.221886] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[83.358639] [076/162] (920s left) kms_addfb_basic (bo-too-small)
[83.441506] Starting subtest: bo-too-small
[83.442597] Subtest bo-too-small: SUCCESS (0.000s)
[83.542158] [077/162] (920s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[83.624382] Starting subtest: bo-too-small-due-to-tiling
[83.625402] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[83.726243] [078/162] (920s left) kms_addfb_basic (clobberred-modifier)
[83.769601] Starting subtest: clobberred-modifier
[83.770689] Subtest clobberred-modifier: SUCCESS (0.000s)
[83.908930] [079/162] (920s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[83.952862] Starting subtest: framebuffer-vs-set-tiling
[83.954642] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[84.109857] [080/162] (919s left) kms_addfb_basic (invalid-get-prop)
[84.152259] Starting subtest: invalid-get-prop
[84.153343] Subtest invalid-get-prop: SUCCESS (0.000s)
[84.292810] [081/162] (919s left) kms_addfb_basic (invalid-get-prop-any)
[84.335497] Starting subtest: invalid-get-prop-any
[84.336545] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[84.478674] [082/162] (919s left) kms_addfb_basic (invalid-set-prop)
[84.523030] Starting subtest: invalid-set-prop
[84.524089] Subtest invalid-set-prop: SUCCESS (0.000s)
[84.659295] [083/162] (919s left) kms_addfb_basic (invalid-set-prop-any)
[84.705262] Starting subtest: invalid-set-prop-any
[84.706293] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[84.860550] [084/162] (919s left) kms_addfb_basic (no-handle)
[84.903883] Starting subtest: no-handle
[84.904927] Subtest no-handle: SUCCESS (0.000s)
[85.059896] [085/162] (919s left) kms_addfb_basic (size-max)
[85.143500] Starting subtest: size-max
[85.144562] Subtest size-max: SUCCESS (0.000s)
[85.244025] [086/162] (919s left) kms_addfb_basic (small-bo)
[85.330312] Starting subtest: small-bo
[85.331449] Subtest small-bo: SUCCESS (0.000s)
[85.425138] [087/162] (918s left) kms_addfb_basic (tile-pitch-mismatch)
[85.469391] Starting subtest: tile-pitch-mismatch
[85.470429] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[85.609230] [088/162] (918s left) kms_addfb_basic (too-high)
[85.690761] Starting subtest: too-high
[85.691856] Subtest too-high: SUCCESS (0.001s)
[85.791774] [089/162] (918s left) kms_addfb_basic (too-wide)
[85.880972] Starting subtest: too-wide
[85.882060] Subtest too-wide: SUCCESS (0.000s)
[85.991072] [090/162] (918s left) kms_addfb_basic (unused-handle)
[86.033904] Starting subtest: unused-handle
[86.034928] Subtest unused-handle: SUCCESS (0.000s)
[86.176165] [091/162] (918s left) kms_addfb_basic (unused-modifier)
[86.219170] Starting subtest: unused-modifier
[86.220190] Subtest unused-modifier: SUCCESS (0.000s)
[86.358915] [092/162] (918s left) kms_addfb_basic (unused-offsets)
[86.404244] Starting subtest: unused-offsets
[86.405236] Subtest unused-offsets: SUCCESS (0.000s)
[86.544714] [093/162] (918s left) kms_addfb_basic (unused-pitches)
[86.590111] Starting subtest: unused-pitches
[86.591149] Subtest unused-pitches: SUCCESS (0.000s)
[86.726556] [094/162] (917s left) kms_busy (basic)
[86.813660] Starting subtest: basic
[86.814794] Starting dynamic subtest: flip
[87.206199] Dynamic subtest flip: SUCCESS (0.392s)
[87.218900] Starting dynamic subtest: modeset
[87.732223] Dynamic subtest modeset: SUCCESS (0.526s)
[87.733277] Subtest basic: SUCCESS (0.920s)
[87.908956] [095/162] (916s left) kms_prop_blob (basic)
[87.953985] Starting subtest: basic
[87.955076] Subtest basic: SUCCESS (0.000s)
[88.044856] [096/162] (916s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[88.129119] Starting subtest: basic-busy-flip-before-cursor-atomic
[89.053896] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.925s)
[89.223142] [097/162] (915s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[89.304417] Starting subtest: basic-busy-flip-before-cursor-legacy
[90.249063] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.944s)
[90.417020] [098/162] (914s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[90.498163] Starting subtest: basic-flip-after-cursor-atomic
[91.411581] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.913s)
[91.580722] [099/162] (913s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[91.663205] Starting subtest: basic-flip-after-cursor-legacy
[92.589779] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.927s)
[92.770027] [100/162] (912s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[92.852427] Starting subtest: basic-flip-after-cursor-varying-size
[93.778476] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.926s)
[93.946210] [101/162] (911s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[94.029883] Starting subtest: basic-flip-before-cursor-atomic
[94.975821] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.945s)
[95.141716] [102/162] (909s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[95.222392] Starting subtest: basic-flip-before-cursor-legacy
[96.136440] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.914s)
[96.303491] [103/162] (908s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[96.390365] Starting subtest: basic-flip-before-cursor-varying-size
[97.332317] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.942s)
[97.493109] [104/162] (907s left) kms_dsc (dsc-basic)
[97.574830] Subtest dsc-basic: SKIP (0.000s)
[97.622331] [105/162] (907s left) kms_flip (basic-flip-vs-dpms)
[97.706712] Starting subtest: basic-flip-vs-dpms
[97.707836] Starting dynamic subtest: A-VGA1
[98.551232] Dynamic subtest A-VGA1: SUCCESS (0.842s)
[98.562366] Starting dynamic subtest: B-VGA1
[99.473474] Dynamic subtest B-VGA1: SUCCESS (0.922s)
[99.483794] Starting dynamic subtest: C-VGA1
[100.281247] Dynamic subtest C-VGA1: SUCCESS (0.807s)
[100.283377] Subtest basic-flip-vs-dpms: SUCCESS (2.576s)
[100.471032] [106/162] (904s left) kms_flip (basic-flip-vs-modeset)
[100.556129] Starting subtest: basic-flip-vs-modeset
[100.558326] Starting dynamic subtest: A-VGA1
[101.459138] Dynamic subtest A-VGA1: SUCCESS (0.900s)
[101.469923] Starting dynamic subtest: B-VGA1
[102.321836] Dynamic subtest B-VGA1: SUCCESS (0.862s)
[102.334797] Starting dynamic subtest: C-VGA1
[103.184452] Dynamic subtest C-VGA1: SUCCESS (0.862s)
[103.186664] Subtest basic-flip-vs-modeset: SUCCESS (2.630s)
[103.345656] [107/162] (901s left) kms_flip (basic-flip-vs-wf_vblank)
[103.433442] Starting subtest: basic-flip-vs-wf_vblank
[103.434477] Starting dynamic subtest: A-VGA1
[104.583489] Dynamic subtest A-VGA1: SUCCESS (1.150s)
[104.596964] Starting dynamic subtest: B-VGA1
[105.713085] Dynamic subtest B-VGA1: SUCCESS (1.128s)
[105.725831] Starting dynamic subtest: C-VGA1
[106.843926] Dynamic subtest C-VGA1: SUCCESS (1.129s)
[106.847090] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.415s)
[107.046340] [108/162] (898s left) kms_flip (basic-plain-flip)
[107.132405] Starting subtest: basic-plain-flip
[107.133445] Starting dynamic subtest: A-VGA1
[108.004602] Dynamic subtest A-VGA1: SUCCESS (0.871s)
[108.017159] Starting dynamic subtest: B-VGA1
[108.885578] Dynamic subtest B-VGA1: SUCCESS (0.877s)
[108.899921] Starting dynamic subtest: C-VGA1
[109.746860] Dynamic subtest C-VGA1: SUCCESS (0.859s)
[109.750404] Subtest basic-plain-flip: SUCCESS (2.618s)
[109.945307] [109/162] (895s left) kms_force_connector_basic (force-connector-state)
[110.001984] Starting subtest: force-connector-state
[110.181930] Subtest force-connector-state: SUCCESS (0.178s)
[110.409469] [110/162] (895s left) kms_force_connector_basic (force-edid)
[110.467154] Starting subtest: force-edid
[110.491832] Subtest force-edid: SUCCESS (0.024s)
[110.626230] [111/162] (894s left) kms_force_connector_basic (force-load-detect)
[110.681816] Starting subtest: force-load-detect
[110.848131] Subtest force-load-detect: SUCCESS (0.167s)
[111.070693] [112/162] (894s left) kms_force_connector_basic (prune-stale-modes)
[111.126459] Starting subtest: prune-stale-modes
[111.143495] Subtest prune-stale-modes: SUCCESS (0.018s)
[111.270267] [113/162] (894s left) kms_frontbuffer_tracking (basic)
[111.360435] Starting subtest: basic
[113.295808] Subtest basic: SUCCESS (1.937s)
[113.406741] [114/162] (892s left) kms_hdmi_inject (inject-audio)
[113.485129] Starting subtest: inject-audio
[113.588462] Subtest inject-audio: SUCCESS (0.104s)
[113.840741] [115/162] (891s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[113.922901] Starting subtest: compare-crc-sanitycheck-xr24
[113.924012] Starting dynamic subtest: pipe-A-VGA-1
[114.208694] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.285s)
[114.220881] Starting dynamic subtest: pipe-B-VGA-1
[114.484680] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.273s)
[114.495503] Starting dynamic subtest: pipe-C-VGA-1
[114.756886] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.271s)
[114.757963] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.834s)
[114.934942] [116/162] (890s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[115.021735] Starting subtest: compare-crc-sanitycheck-nv12
[115.022822] Starting dynamic subtest: pipe-A-VGA-1
[115.024955] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s)
[115.035824] Starting dynamic subtest: pipe-B-VGA-1
[115.038149] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s)
[115.049228] Starting dynamic subtest: pipe-C-VGA-1
[115.051495] Dynamic subtest pipe-C-VGA-1: SKIP (0.000s)
[115.053697] Subtest compare-crc-sanitycheck-nv12: SKIP (0.005s)
[115.120700] [117/162] (890s left) kms_pipe_crc_basic (hang-read-crc)
[115.204934] Starting subtest: hang-read-crc
[115.206018] Starting dynamic subtest: pipe-A-VGA-1
[115.970121] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.765s)
[115.982399] Starting dynamic subtest: pipe-B-VGA-1
[116.722452] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.751s)
[116.736438] Starting dynamic subtest: pipe-C-VGA-1
[117.493844] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.769s)
[117.494960] Subtest hang-read-crc: SUCCESS (2.290s)
[117.645455] [118/162] (888s left) kms_pipe_crc_basic (nonblocking-crc)
[117.729886] Starting subtest: nonblocking-crc
[117.730995] Starting dynamic subtest: pipe-A-VGA-1
[118.189822] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.459s)
[118.200791] Starting dynamic subtest: pipe-B-VGA-1
[118.624868] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.434s)
[118.637086] Starting dynamic subtest: pipe-C-VGA-1
[119.063171] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.437s)
[119.064270] Subtest nonblocking-crc: SUCCESS (1.335s)
[119.216315] [119/162] (886s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[119.301136] Starting subtest: nonblocking-crc-frame-sequence
[119.302183] Starting dynamic subtest: pipe-A-VGA-1
[119.760474] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.460s)
[119.772586] Starting dynamic subtest: pipe-B-VGA-1
[120.197123] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.436s)
[120.212651] Starting dynamic subtest: pipe-C-VGA-1
[120.643824] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.445s)
[120.644859] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.345s)
[120.799922] [120/162] (885s left) kms_pipe_crc_basic (read-crc)
[120.885816] Starting subtest: read-crc
[120.886919] Starting dynamic subtest: pipe-A-VGA-1
[121.278778] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.393s)
[121.293234] Starting dynamic subtest: pipe-B-VGA-1
[121.647880] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.367s)
[121.660043] Starting dynamic subtest: pipe-C-VGA-1
[122.019434] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.369s)
[122.020476] Subtest read-crc: SUCCESS (1.134s)
[122.176304] [121/162] (883s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[122.263993] Starting subtest: read-crc-frame-sequence
[122.265388] Starting dynamic subtest: pipe-A-VGA-1
[122.650371] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.386s)
[122.665951] Starting dynamic subtest: pipe-B-VGA-1
[123.024143] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.369s)
[123.035153] Starting dynamic subtest: pipe-C-VGA-1
[123.406416] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.382s)
[123.407413] Subtest read-crc-frame-sequence: SUCCESS (1.143s)
[123.576149] [122/162] (882s left) kms_pm_backlight (basic-brightness)
[123.664957] Subtest basic-brightness: SKIP (0.000s)
[123.711663] [123/162] (882s left) kms_pm_rpm (basic-pci-d3-state)
[125.083310] Starting subtest: basic-pci-d3-state
[125.309217] Subtest basic-pci-d3-state: SUCCESS (0.225s)
[125.432903] [124/162] (880s left) kms_pm_rpm (basic-rte)
[125.479744] Starting subtest: basic-rte
[126.991733] Subtest basic-rte: SUCCESS (1.512s)
[127.316785] [125/162] (878s left) kms_psr (psr-primary-page-flip)
[127.407392] Subtest psr-primary-page-flip: SKIP (0.000s)
[127.460303] [126/162] (878s left) kms_psr (psr-cursor-plane-move)
[127.546902] Subtest psr-cursor-plane-move: SKIP (0.000s)
[127.593512] [127/162] (878s left) kms_psr (psr-sprite-plane-onoff)
[127.679112] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[127.728560] [128/162] (878s left) kms_psr (psr-primary-mmap-gtt)
[127.814138] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[127.861971] [129/162] (878s left) kms_setmode (basic-clone-single-crtc)
[127.908364] Starting subtest: basic-clone-single-crtc
[127.911459] Subtest basic-clone-single-crtc: SKIP (0.000s)
[127.999275] [130/162] (878s left) i915_pm_rps (basic-api)
[128.050731] Starting subtest: basic-api
[128.053803] Subtest basic-api: SUCCESS (0.003s)
[128.149051] [131/162] (878s left) prime_self_import (basic-llseek-bad)
[128.194437] Starting subtest: basic-llseek-bad
[128.196560] Subtest basic-llseek-bad: SUCCESS (0.002s)
[128.299161] [132/162] (878s left) prime_self_import (basic-llseek-size)
[128.340927] Starting subtest: basic-llseek-size
[128.343148] Subtest basic-llseek-size: SUCCESS (0.003s)
[128.451146] [133/162] (878s left) prime_self_import (basic-with_fd_dup)
[128.493761] Starting subtest: basic-with_fd_dup
[128.495963] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[128.600809] [134/162] (877s left) prime_self_import (basic-with_one_bo)
[128.644734] Starting subtest: basic-with_one_bo
[128.646958] Subtest basic-with_one_bo: SUCCESS (0.003s)
[128.762459] [135/162] (877s left) prime_self_import (basic-with_one_bo_two_files)
[128.804817] Starting subtest: basic-with_one_bo_two_files
[128.806964] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[128.915638] [136/162] (877s left) prime_self_import (basic-with_two_bos)
[128.959193] Starting subtest: basic-with_two_bos
[128.961310] Subtest basic-with_two_bos: SUCCESS (0.003s)
[129.067249] [137/162] (877s left) prime_vgem (basic-fence-flip)
[129.129675] Starting subtest: basic-fence-flip
[129.471629] Subtest basic-fence-flip: SUCCESS (0.343s)
[129.581981] [138/162] (877s left) prime_vgem (basic-fence-mmap)
[129.647170] Starting subtest: basic-fence-mmap
[129.669714] Subtest basic-fence-mmap: SUCCESS (0.024s)
[129.783556] [139/162] (876s left) prime_vgem (basic-fence-read)
[129.845123] Starting subtest: basic-fence-read
[129.894789] Subtest basic-fence-read: SUCCESS (0.050s)
[129.998971] [140/162] (876s left) prime_vgem (basic-gtt)
[130.061192] Starting subtest: basic-gtt
[130.073399] Subtest basic-gtt: SUCCESS (0.013s)
[130.181054] [141/162] (876s left) prime_vgem (basic-read)
[130.243054] Starting subtest: basic-read
[130.267603] Subtest basic-read: SUCCESS (0.024s)
[130.382390] [142/162] (876s left) prime_vgem (basic-write)
[130.445329] Starting subtest: basic-write
[130.469438] Subtest basic-write: SUCCESS (0.025s)
[130.565940] [143/162] (876s left) vgem_basic (setversion)
[130.624488] Starting subtest: setversion
[130.626660] Subtest setversion: SUCCESS (0.000s)
[130.698556] [144/162] (876s left) vgem_basic (create)
[130.757519] Starting subtest: create
[130.758747] Subtest create: SUCCESS (0.000s)
[130.831325] [145/162] (876s left) vgem_basic (debugfs)
[130.891194] Starting subtest: debugfs
[130.892324] Subtest debugfs: SUCCESS (0.000s)
[130.965953] [146/162] (876s left) vgem_basic (dmabuf-export)
[131.024180] Starting subtest: dmabuf-export
[131.026402] Subtest dmabuf-export: SUCCESS (0.002s)
[131.134397] [147/162] (876s left) vgem_basic (dmabuf-fence)
[131.191063] Starting subtest: dmabuf-fence
[131.192271] Subtest dmabuf-fence: SUCCESS (0.001s)
[131.267911] [148/162] (875s left) vgem_basic (dmabuf-fence-before)
[131.322909] Starting subtest: dmabuf-fence-before
[131.324062] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[131.400181] [149/162] (875s left) vgem_basic (dmabuf-mmap)
[131.456396] Starting subtest: dmabuf-mmap
[131.469354] Subtest dmabuf-mmap: SUCCESS (0.015s)
[131.549427] [150/162] (875s left) vgem_basic (mmap)
[131.607453] Starting subtest: mmap
[131.614744] Subtest mmap: SUCCESS (0.009s)
[131.683983] [151/162] (875s left) vgem_basic (second-client)
[131.738886] Starting subtest: second-client
[131.773982] Subtest second-client: SUCCESS (0.033s)
[131.849866] [152/162] (875s left) vgem_basic (sysfs)
[131.905350] Starting subtest: sysfs
[131.906454] Subtest sysfs: SUCCESS (0.001s)
[131.983840] [153/162] (875s left) core_hotunplug (unbind-rebind)
[132.107224] Starting subtest: unbind-rebind
[135.264252] Subtest unbind-rebind: SUCCESS (3.157s)
[135.311775] [154/162] (872s left) vgem_basic (unload)
[135.360733] Starting subtest: unload
[164.306440] Subtest unload: SUCCESS (28.946s)
[164.433872] [155/162] (843s left) i915_module_load (reload)
[164.480255] Starting subtest: reload
[166.995713] Subtest reload: SUCCESS (2.517s)
[167.054552] [156/162] (840s left) gem_lmem_swapping (basic)
[167.112630] Subtest basic: SKIP (0.000s)
[167.170028] [157/162] (840s left) gem_lmem_swapping (parallel-random-engines)
[167.218539] Subtest parallel-random-engines: SKIP (0.000s)
[167.268576] [158/162] (840s left) gem_lmem_swapping (random-engines)
[167.318226] Subtest random-engines: SKIP (0.000s)
[167.369562] [159/162] (840s left) gem_lmem_swapping (verify-random)
[167.417208] Subtest verify-random: SKIP (0.000s)
[167.468251] [160/162] (840s left) i915_pm_rpm (module-reload)
[179.041534] Starting subtest: module-reload
[206.688226] Subtest module-reload: SUCCESS (27.648s)
[206.721706] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[206.722754] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[206.725123] [161/162] (801s left) i915_selftest (live)
[206.780440] Starting subtest: live
[206.782243] Starting dynamic subtest: sanitycheck
[208.183591] Dynamic subtest sanitycheck: SUCCESS (1.401s)
[208.196684] Starting dynamic subtest: uncore
[209.661759] Dynamic subtest uncore: SUCCESS (1.474s)
[209.674245] Starting dynamic subtest: workarounds
[211.301985] Dynamic subtest workarounds: SUCCESS (1.638s)
[211.313805] Starting dynamic subtest: gt_engines
[212.845071] Dynamic subtest gt_engines: SUCCESS (1.541s)
[212.856256] Starting dynamic subtest: gt_timelines
[220.355907] Dynamic subtest gt_timelines: SUCCESS (7.510s)
[220.365759] Starting dynamic subtest: gt_contexts
[221.863546] Dynamic subtest gt_contexts: SUCCESS (1.506s)
[221.875495] Starting dynamic subtest: gt_lrc
[223.243207] Dynamic subtest gt_lrc: SUCCESS (1.377s)
[223.255260] Starting dynamic subtest: gt_mocs
[224.677722] Dynamic subtest gt_mocs: SUCCESS (1.431s)
[224.695220] Starting dynamic subtest: gt_pm
[239.339617] Dynamic subtest gt_pm: SUCCESS (14.659s)
[239.351405] Starting dynamic subtest: gt_heartbeat
[240.959652] Dynamic subtest gt_heartbeat: SUCCESS (1.617s)
[240.971454] Starting dynamic subtest: gt_tlb
[242.339835] Dynamic subtest gt_tlb: SUCCESS (1.377s)
[242.351572] Starting dynamic subtest: requests
[249.496842] Dynamic subtest requests: SUCCESS (7.154s)
[249.508356] Starting dynamic subtest: migrate
[251.094858] Dynamic subtest migrate: SUCCESS (1.595s)
[251.106794] Starting dynamic subtest: active
[252.737978] Dynamic subtest active: SUCCESS (1.640s)
[252.750212] Starting dynamic subtest: objects
[254.667805] Dynamic subtest objects: SUCCESS (1.927s)
[254.679807] Starting dynamic subtest: mman
[259.421450] Dynamic subtest mman: SUCCESS (4.751s)
[259.432890] Starting dynamic subtest: dmabuf
[261.054929] Dynamic subtest dmabuf: SUCCESS (1.631s)
[261.067370] Starting dynamic subtest: vma
[262.473956] Dynamic subtest vma: SUCCESS (1.415s)
[262.485823] Starting dynamic subtest: coherency
[264.648723] Dynamic subtest coherency: SUCCESS (2.172s)
[264.660513] Starting dynamic subtest: gtt
[269.544450] Dynamic subtest gtt: SUCCESS (4.893s)
[269.555952] Starting dynamic subtest: gem
[271.546964] Dynamic subtest gem: SUCCESS (1.999s)
[271.560310] Starting dynamic subtest: evict
[272.975706] Dynamic subtest evict: SUCCESS (1.424s)
[272.987757] Starting dynamic subtest: hugepages