[28.626373] Initializing watchdogs [28.626447] /dev/watchdog0 [28.640481] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:5912 Intel Kabylake (Gen9) HD Graphics 630 [28.646434] [001/162] (960s left) i915_module_load (load) [28.697127] Starting subtest: load [29.881461] Subtest load: SUCCESS (1.183s) [29.910332] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [29.911746] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [29.914980] [002/162] (959s left) core_auth (basic-auth) [29.986231] Starting subtest: basic-auth [29.987656] Subtest basic-auth: SUCCESS (0.002s) [30.045320] [003/162] (959s left) core_debugfs (read-all-entries) [30.085031] Starting subtest: read-all-entries [30.087298] Subtest read-all-entries: SUCCESS (0.002s) [30.117456] [004/162] (959s left) core_sysfs (read-all-entries) [30.160381] Starting subtest: read-all-entries [30.161634] Subtest read-all-entries: SUCCESS (0.003s) [30.191318] [005/162] (959s left) fbdev (eof) [30.238374] Subtest eof: SKIP (0.000s) [30.267431] [006/162] (959s left) fbdev (info) [30.315454] Subtest info: SKIP (0.000s) [30.344271] [007/162] (959s left) fbdev (nullptr) [30.394608] Subtest nullptr: SKIP (0.000s) [30.423438] [008/162] (958s left) fbdev (read) [30.471087] Subtest read: SKIP (0.000s) [30.499296] [009/162] (958s left) fbdev (write) [30.546121] Subtest write: SKIP (0.000s) [30.574859] [010/162] (958s left) gem_basic (bad-close) [30.614195] Starting subtest: bad-close [30.614945] Subtest bad-close: SUCCESS (0.000s) [30.644185] [011/162] (958s left) gem_basic (create-close) [30.683485] Starting subtest: create-close [30.684200] Subtest create-close: SUCCESS (0.000s) [30.741365] [012/162] (958s left) gem_basic (create-fd-close) [30.783448] Starting subtest: create-fd-close [30.784243] Subtest create-fd-close: SUCCESS (0.000s) [30.898061] [013/162] (958s left) gem_busy (busy@all-engines) [30.955406] Starting subtest: busy [30.955921] Starting dynamic subtest: all-engines [30.984391] Dynamic subtest all-engines: SUCCESS (0.029s) [30.984933] Subtest busy: SUCCESS (0.029s) [31.438432] [014/162] (958s left) gem_close_race (basic-process) [31.493583] Starting subtest: basic-process [31.568991] Subtest basic-process: SUCCESS (0.074s) [31.707448] [015/162] (957s left) gem_close_race (basic-threads) [31.760870] Starting subtest: basic-threads [32.929291] Subtest basic-threads: SUCCESS (1.169s) [33.120978] [016/162] (956s left) gem_ctx_create (basic) [33.170117] Starting subtest: basic [33.170740] Subtest basic: SUCCESS (0.000s) [33.349064] [017/162] (956s left) gem_ctx_create (basic-files) [33.399007] Starting subtest: basic-files [35.410913] Subtest basic-files: SUCCESS (2.012s) [35.632872] [018/162] (954s left) gem_ctx_exec (basic) [35.676208] Starting subtest: basic [35.680754] Subtest basic: SUCCESS (0.004s) [35.767778] [019/162] (954s left) gem_exec_basic (basic) [35.813412] Starting subtest: basic [35.814151] Starting dynamic subtest: rcs0-smem [35.815833] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [35.823714] Starting dynamic subtest: bcs0-smem [35.824273] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [35.830663] Starting dynamic subtest: vcs0-smem [35.831158] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [35.837204] Starting dynamic subtest: vecs0-smem [35.837860] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [35.838255] Subtest basic: SUCCESS (0.005s) [35.996762] [020/162] (953s left) gem_exec_create (basic) [36.047878] Starting subtest: basic [36.048448] Starting dynamic subtest: smem [38.099975] Dynamic subtest smem: SUCCESS (2.052s) [38.100579] Subtest basic: SUCCESS (2.052s) [38.303115] [021/162] (951s left) gem_exec_fence (basic-busy) [38.474026] Starting subtest: basic-busy [38.474570] Starting dynamic subtest: rcs0 [38.506910] Dynamic subtest rcs0: SUCCESS (0.033s) [38.515936] Starting dynamic subtest: bcs0 [38.538892] Dynamic subtest bcs0: SUCCESS (0.033s) [38.548383] Starting dynamic subtest: vcs0 [38.582325] Dynamic subtest vcs0: SUCCESS (0.042s) [38.615523] Starting dynamic subtest: vecs0 [38.629018] Dynamic subtest vecs0: SUCCESS (0.047s) [38.629776] Subtest basic-busy: SUCCESS (0.156s) [39.300599] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [39.305514] [022/162] (950s left) gem_exec_fence (basic-wait) [39.473783] Starting subtest: basic-wait [39.474869] Starting dynamic subtest: rcs0 [39.512044] Dynamic subtest rcs0: SUCCESS (0.038s) [39.525771] Starting dynamic subtest: bcs0 [39.542129] Dynamic subtest bcs0: SUCCESS (0.029s) [39.556243] Starting dynamic subtest: vcs0 [39.573029] Dynamic subtest vcs0: SUCCESS (0.031s) [39.586834] Starting dynamic subtest: vecs0 [39.606410] Dynamic subtest vecs0: SUCCESS (0.033s) [39.607496] Subtest basic-wait: SUCCESS (0.132s) [40.179216] [023/162] (949s left) gem_exec_fence (basic-await) [40.377912] Starting subtest: basic-await [40.378777] Starting dynamic subtest: rcs0 [40.464910] Dynamic subtest rcs0: SUCCESS (0.086s) [40.474216] Starting dynamic subtest: bcs0 [40.553343] Dynamic subtest bcs0: SUCCESS (0.087s) [40.563956] Starting dynamic subtest: vcs0 [40.641346] Dynamic subtest vcs0: SUCCESS (0.088s) [40.652638] Starting dynamic subtest: vecs0 [40.731865] Dynamic subtest vecs0: SUCCESS (0.091s) [40.732759] Subtest basic-await: SUCCESS (0.354s) [41.355298] [024/162] (948s left) gem_exec_fence (nb-await) [41.562254] Starting subtest: nb-await [41.563476] Starting dynamic subtest: rcs0 [41.634335] Dynamic subtest rcs0: SUCCESS (0.071s) [41.647520] Starting dynamic subtest: bcs0 [41.697993] Dynamic subtest bcs0: SUCCESS (0.066s) [41.730613] Starting dynamic subtest: vcs0 [41.787189] Dynamic subtest vcs0: SUCCESS (0.087s) [41.818423] Starting dynamic subtest: vecs0 [41.876716] Dynamic subtest vecs0: SUCCESS (0.086s) [41.878646] Subtest nb-await: SUCCESS (0.314s) [42.463928] [025/162] (947s left) gem_exec_gttfill (basic) [42.518324] Starting subtest: basic [49.682549] Subtest basic: SUCCESS (7.206s) [49.824960] [026/162] (940s left) gem_exec_parallel (engines) [49.938041] Starting subtest: engines [49.938457] Starting dynamic subtest: basic [51.914186] Dynamic subtest basic: SUCCESS (1.986s) [51.921244] Starting dynamic subtest: contexts [56.042688] Dynamic subtest contexts: SUCCESS (4.142s) [56.049920] Starting dynamic subtest: fds [60.571962] Dynamic subtest fds: SUCCESS (4.537s) [60.579025] Starting dynamic subtest: userptr [62.576253] Dynamic subtest userptr: SUCCESS (2.008s) [62.576729] Subtest engines: SUCCESS (12.674s) [62.737375] [027/162] (927s left) gem_exec_store (basic) [62.850422] Starting subtest: basic [63.447775] Subtest basic: SUCCESS (0.599s) [63.590739] [028/162] (926s left) gem_flink_basic (bad-flink) [63.656020] Starting subtest: bad-flink [63.656652] Subtest bad-flink: SUCCESS (0.000s) [63.687835] [029/162] (926s left) gem_flink_basic (bad-open) [63.730638] Starting subtest: bad-open [63.731114] Subtest bad-open: SUCCESS (0.000s) [63.762576] [030/162] (926s left) gem_flink_basic (basic) [63.801326] Starting subtest: basic [63.801798] Subtest basic: SUCCESS (0.000s) [63.859555] [031/162] (926s left) gem_flink_basic (double-flink) [63.898708] Starting subtest: double-flink [63.899126] Subtest double-flink: SUCCESS (0.000s) [63.964126] [032/162] (926s left) gem_flink_basic (flink-lifetime) [64.002428] Starting subtest: flink-lifetime [64.002815] Subtest flink-lifetime: SUCCESS (0.001s) [64.076239] [033/162] (926s left) gem_huc_copy (huc-copy) [64.122394] Starting subtest: huc-copy [64.124660] Subtest huc-copy: SUCCESS (0.002s) [64.217407] [034/162] (926s left) gem_linear_blits (basic) [64.331785] Starting subtest: basic [64.340755] Subtest basic: SUCCESS (0.009s) [64.438484] [035/162] (926s left) gem_mmap (basic) [64.548557] Starting subtest: basic [64.550191] Subtest basic: SUCCESS (0.000s) [64.622127] [036/162] (926s left) gem_mmap_gtt (basic) [64.662281] Starting subtest: basic [64.663077] Subtest basic: SUCCESS (0.001s) [64.698806] [037/162] (926s left) gem_render_linear_blits (basic) [64.743285] Starting subtest: basic [64.775524] Subtest basic: SUCCESS (0.032s) [64.821782] [038/162] (925s left) gem_render_tiled_blits (basic) [64.868726] Starting subtest: basic [64.903601] Subtest basic: SUCCESS (0.035s) [64.949159] [039/162] (925s left) gem_ringfill (basic-all) [65.172682] Starting subtest: basic-all [66.317155] Subtest basic-all: SUCCESS (1.136s) [66.454926] [040/162] (924s left) gem_softpin (allocator-basic) [66.499373] Starting subtest: allocator-basic [66.618217] Subtest allocator-basic: SUCCESS (0.113s) [66.761190] [041/162] (924s left) gem_softpin (allocator-basic-reserve) [66.805941] Starting subtest: allocator-basic-reserve [66.922277] Subtest allocator-basic-reserve: SUCCESS (0.114s) [66.987621] [042/162] (924s left) gem_softpin (safe-alignment) [67.033261] Starting subtest: safe-alignment [67.045417] Subtest safe-alignment: SUCCESS (0.012s) [67.147011] [043/162] (923s left) gem_sync (basic-all) [67.200812] Starting subtest: basic-all [69.440933] Subtest basic-all: SUCCESS (2.241s) [69.605266] [044/162] (921s left) gem_sync (basic-each) [69.656833] Starting subtest: basic-each [71.764919] Subtest basic-each: SUCCESS (2.109s) [72.014382] [045/162] (919s left) gem_tiled_blits (basic) [72.106461] Starting subtest: basic [72.127837] Subtest basic: SUCCESS (0.021s) [72.260999] [046/162] (919s left) gem_tiled_fence_blits (basic) [72.435319] Starting subtest: basic [72.445788] Subtest basic: SUCCESS (0.010s) [72.536055] [047/162] (918s left) gem_tiled_pread_basic [72.769090] [048/162] (918s left) gem_wait (busy@all-engines) [72.825558] Starting subtest: busy [72.826039] Starting dynamic subtest: all-engines [73.351893] Dynamic subtest all-engines: SUCCESS (0.527s) [73.352351] Subtest busy: SUCCESS (0.527s) [73.518061] [049/162] (917s left) gem_wait (wait@all-engines) [73.573084] Starting subtest: wait [73.573721] Starting dynamic subtest: all-engines [74.613165] Dynamic subtest all-engines: SUCCESS (1.037s) [74.613878] Subtest wait: SUCCESS (1.037s) [74.845177] [050/162] (916s left) i915_getparams_basic (basic-eu-total) [74.886115] Starting subtest: basic-eu-total [74.886933] Subtest basic-eu-total: SUCCESS (0.000s) [74.922495] [051/162] (916s left) i915_getparams_basic (basic-subslice-total) [74.960925] Starting subtest: basic-subslice-total [74.961811] Subtest basic-subslice-total: SUCCESS (0.000s) [74.996695] [052/162] (916s left) i915_hangman (error-state-basic) [75.050420] Starting subtest: error-state-basic [75.120505] Subtest error-state-basic: SUCCESS (0.070s) [75.162739] [053/162] (916s left) i915_pciid [75.274083] [054/162] (916s left) intel_hwmon (hwmon-read) [75.312765] Subtest hwmon-read: SKIP (0.000s) [75.348192] [055/162] (916s left) intel_hwmon (hwmon-write) [75.387519] Subtest hwmon-write: SKIP (0.000s) [75.425988] [056/162] (916s left) kms_addfb_basic (addfb25-4-tiled) [75.554977] Starting subtest: addfb25-4-tiled [75.555462] Subtest addfb25-4-tiled: SUCCESS (0.000s) [75.619488] [057/162] (916s left) kms_addfb_basic (addfb25-bad-modifier) [75.761147] Starting subtest: addfb25-bad-modifier [75.761565] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [75.817561] [058/162] (916s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [75.939098] Starting subtest: addfb25-framebuffer-vs-set-tiling [75.939539] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [75.996604] [059/162] (915s left) kms_addfb_basic (addfb25-modifier-no-flag) [76.119066] Starting subtest: addfb25-modifier-no-flag [76.119548] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [76.174293] [060/162] (915s left) kms_addfb_basic (addfb25-x-tiled-legacy) [76.294926] Starting subtest: addfb25-x-tiled-legacy [76.295425] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [76.350462] [061/162] (915s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [76.472131] Starting subtest: addfb25-x-tiled-mismatch-legacy [76.472647] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [76.528281] [062/162] (915s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [76.649131] Starting subtest: addfb25-yf-tiled-legacy [76.649635] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [76.706725] [063/162] (915s left) kms_addfb_basic (addfb25-y-tiled-legacy) [76.826237] Starting subtest: addfb25-y-tiled-legacy [76.826736] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [76.887763] [064/162] (915s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [77.014957] Starting subtest: addfb25-y-tiled-small-legacy [77.015347] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [77.088064] [065/162] (914s left) kms_addfb_basic (bad-pitch-0) [77.127849] Starting subtest: bad-pitch-0 [77.128239] Subtest bad-pitch-0: SUCCESS (0.000s) [77.281097] [066/162] (914s left) kms_addfb_basic (bad-pitch-1024) [77.321820] Starting subtest: bad-pitch-1024 [77.322179] Subtest bad-pitch-1024: SUCCESS (0.000s) [77.461030] [067/162] (914s left) kms_addfb_basic (bad-pitch-128) [77.501339] Starting subtest: bad-pitch-128 [77.501671] Subtest bad-pitch-128: SUCCESS (0.000s) [77.638406] [068/162] (914s left) kms_addfb_basic (bad-pitch-256) [77.678474] Starting subtest: bad-pitch-256 [77.678831] Subtest bad-pitch-256: SUCCESS (0.000s) [77.815123] [069/162] (914s left) kms_addfb_basic (bad-pitch-32) [77.854535] Starting subtest: bad-pitch-32 [77.854955] Subtest bad-pitch-32: SUCCESS (0.000s) [78.032502] [070/162] (914s left) kms_addfb_basic (bad-pitch-63) [78.073153] Starting subtest: bad-pitch-63 [78.073573] Subtest bad-pitch-63: SUCCESS (0.000s) [78.214985] [071/162] (914s left) kms_addfb_basic (bad-pitch-65536) [78.256354] Starting subtest: bad-pitch-65536 [78.256752] Subtest bad-pitch-65536: SUCCESS (0.000s) [78.398991] [072/162] (913s left) kms_addfb_basic (bad-pitch-999) [78.439219] Starting subtest: bad-pitch-999 [78.439628] Subtest bad-pitch-999: SUCCESS (0.000s) [78.579207] [073/162] (913s left) kms_addfb_basic (basic) [78.620637] Starting subtest: basic [78.621007] Subtest basic: SUCCESS (0.000s) [78.755974] [074/162] (913s left) kms_addfb_basic (basic-x-tiled-legacy) [78.796969] Starting subtest: basic-x-tiled-legacy [78.797361] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [78.997509] [075/162] (913s left) kms_addfb_basic (basic-y-tiled-legacy) [79.040577] Starting subtest: basic-y-tiled-legacy [79.040931] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [79.201139] [076/162] (913s left) kms_addfb_basic (bo-too-small) [79.321013] Starting subtest: bo-too-small [79.321540] Subtest bo-too-small: SUCCESS (0.000s) [79.373816] [077/162] (913s left) kms_addfb_basic (bo-too-small-due-to-tiling) [79.496037] Starting subtest: bo-too-small-due-to-tiling [79.496553] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [79.585853] [078/162] (913s left) kms_addfb_basic (clobberred-modifier) [79.626535] Starting subtest: clobberred-modifier [79.626943] Subtest clobberred-modifier: SUCCESS (0.000s) [79.769123] [079/162] (912s left) kms_addfb_basic (framebuffer-vs-set-tiling) [79.814553] Starting subtest: framebuffer-vs-set-tiling [79.814934] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [79.939052] [080/162] (912s left) kms_addfb_basic (invalid-get-prop) [79.979042] Starting subtest: invalid-get-prop [79.979525] Subtest invalid-get-prop: SUCCESS (0.000s) [80.129848] [081/162] (912s left) kms_addfb_basic (invalid-get-prop-any) [80.169886] Starting subtest: invalid-get-prop-any [80.170270] Subtest invalid-get-prop-any: SUCCESS (0.000s) [80.300320] [082/162] (912s left) kms_addfb_basic (invalid-set-prop) [80.339857] Starting subtest: invalid-set-prop [80.340218] Subtest invalid-set-prop: SUCCESS (0.000s) [80.480059] [083/162] (912s left) kms_addfb_basic (invalid-set-prop-any) [80.521577] Starting subtest: invalid-set-prop-any [80.521975] Subtest invalid-set-prop-any: SUCCESS (0.000s) [80.696061] [084/162] (912s left) kms_addfb_basic (no-handle) [80.734593] Starting subtest: no-handle [80.735073] Subtest no-handle: SUCCESS (0.000s) [80.882417] [085/162] (912s left) kms_addfb_basic (size-max) [81.007664] Starting subtest: size-max [81.008221] Subtest size-max: SUCCESS (0.000s) [81.076701] [086/162] (911s left) kms_addfb_basic (small-bo) [81.198973] Starting subtest: small-bo [81.200388] Subtest small-bo: SUCCESS (0.000s) [81.246078] [087/162] (911s left) kms_addfb_basic (tile-pitch-mismatch) [81.286663] Starting subtest: tile-pitch-mismatch [81.287117] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [81.450938] [088/162] (911s left) kms_addfb_basic (too-high) [81.576673] Starting subtest: too-high [81.577743] Subtest too-high: SUCCESS (0.001s) [81.656744] [089/162] (911s left) kms_addfb_basic (too-wide) [81.780222] Starting subtest: too-wide [81.780796] Subtest too-wide: SUCCESS (0.000s) [81.880077] [090/162] (911s left) kms_addfb_basic (unused-handle) [81.921085] Starting subtest: unused-handle [81.921513] Subtest unused-handle: SUCCESS (0.000s) [82.067954] [091/162] (911s left) kms_addfb_basic (unused-modifier) [82.107458] Starting subtest: unused-modifier [82.107865] Subtest unused-modifier: SUCCESS (0.000s) [82.267941] [092/162] (910s left) kms_addfb_basic (unused-offsets) [82.307602] Starting subtest: unused-offsets [82.307953] Subtest unused-offsets: SUCCESS (0.000s) [82.450722] [093/162] (910s left) kms_addfb_basic (unused-pitches) [82.490072] Starting subtest: unused-pitches [82.490438] Subtest unused-pitches: SUCCESS (0.000s) [82.644656] [094/162] (910s left) kms_busy (basic) [82.723106] Subtest basic: SKIP (0.000s) [82.757882] [095/162] (910s left) kms_prop_blob (basic) [82.796790] Starting subtest: basic [82.797161] Subtest basic: SUCCESS (0.000s) [82.833043] [096/162] (910s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [82.960186] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [82.993305] [097/162] (910s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [83.117231] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [83.150500] [098/162] (910s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [83.273544] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [83.306069] [099/162] (910s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [83.432905] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [83.466894] [100/162] (910s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [83.590459] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [83.626319] [101/162] (909s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [83.751519] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [83.784627] [102/162] (909s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [83.907887] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [83.941720] [103/162] (909s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [84.062474] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [84.095296] [104/162] (909s left) kms_dsc (dsc-basic) [84.219154] Subtest dsc-basic: SKIP (0.000s) [84.254218] [105/162] (909s left) kms_flip (basic-flip-vs-dpms) [84.376806] Starting subtest: basic-flip-vs-dpms [84.377742] Subtest basic-flip-vs-dpms: SKIP (0.001s) [84.448112] [106/162] (909s left) kms_flip (basic-flip-vs-modeset) [84.570210] Starting subtest: basic-flip-vs-modeset [84.571708] Subtest basic-flip-vs-modeset: SKIP (0.001s) [84.617123] [107/162] (909s left) kms_flip (basic-flip-vs-wf_vblank) [84.739888] Starting subtest: basic-flip-vs-wf_vblank [84.740696] Subtest basic-flip-vs-wf_vblank: SKIP (0.001s) [84.804969] [108/162] (909s left) kms_flip (basic-plain-flip) [84.927284] Starting subtest: basic-plain-flip [84.928473] Subtest basic-plain-flip: SKIP (0.001s) [85.001542] [109/162] (908s left) kms_force_connector_basic (force-connector-state) [85.130120] Starting subtest: force-connector-state [85.261251] Subtest force-connector-state: SUCCESS (0.132s) [85.332263] [110/162] (908s left) kms_force_connector_basic (force-edid) [85.458483] Starting subtest: force-edid [85.590406] Subtest force-edid: SUCCESS (0.132s) [85.823186] [111/162] (908s left) kms_force_connector_basic (force-load-detect) [85.889610] Starting subtest: force-load-detect [85.891071] Subtest force-load-detect: SKIP (0.000s) [86.046286] [112/162] (907s left) kms_force_connector_basic (prune-stale-modes) [86.125835] Starting subtest: prune-stale-modes [86.220618] Subtest prune-stale-modes: SUCCESS (0.094s) [86.384774] [113/162] (907s left) kms_frontbuffer_tracking (basic) [86.502732] Subtest basic: SKIP (0.000s) [86.557111] [114/162] (907s left) kms_hdmi_inject (inject-audio) [86.598443] Starting subtest: inject-audio [86.707010] Subtest inject-audio: SUCCESS (0.108s) [86.814087] [115/162] (907s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [86.926335] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [86.965627] [116/162] (907s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [87.036277] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [87.075577] [117/162] (907s left) kms_pipe_crc_basic (hang-read-crc) [87.150139] Subtest hang-read-crc: SKIP (0.000s) [87.188396] [118/162] (907s left) kms_pipe_crc_basic (nonblocking-crc) [87.263085] Subtest nonblocking-crc: SKIP (0.000s) [87.300955] [119/162] (906s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [87.377089] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [87.416480] [120/162] (906s left) kms_pipe_crc_basic (read-crc) [87.502104] Subtest read-crc: SKIP (0.000s) [87.542508] [121/162] (906s left) kms_pipe_crc_basic (read-crc-frame-sequence) [87.621265] Subtest read-crc-frame-sequence: SKIP (0.000s) [87.659595] [122/162] (906s left) kms_pm_backlight (basic-brightness) [87.735181] Subtest basic-brightness: SKIP (0.000s) [87.773481] [123/162] (906s left) kms_pm_rpm (basic-pci-d3-state) [89.115832] Starting subtest: basic-pci-d3-state [89.343457] Subtest basic-pci-d3-state: SUCCESS (0.231s) [89.410889] [124/162] (905s left) kms_pm_rpm (basic-rte) [89.449329] Starting subtest: basic-rte [90.950545] Subtest basic-rte: SUCCESS (1.501s) [91.291042] [125/162] (903s left) kms_psr (psr-primary-page-flip) [91.415445] Subtest psr-primary-page-flip: SKIP (0.000s) [91.453950] [126/162] (903s left) kms_psr (psr-cursor-plane-move) [91.545007] Subtest psr-cursor-plane-move: SKIP (0.000s) [91.588435] [127/162] (902s left) kms_psr (psr-sprite-plane-onoff) [91.685866] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [91.724494] [128/162] (902s left) kms_psr (psr-primary-mmap-gtt) [91.799120] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [91.837697] [129/162] (902s left) kms_setmode (basic-clone-single-crtc) [91.878288] Starting subtest: basic-clone-single-crtc [91.879484] Subtest basic-clone-single-crtc: SKIP (0.000s) [91.921149] [130/162] (902s left) i915_pm_rps (basic-api) [91.968505] Starting subtest: basic-api [91.971647] Subtest basic-api: SUCCESS (0.003s) [92.011841] [131/162] (902s left) prime_self_import (basic-llseek-bad) [92.049640] Starting subtest: basic-llseek-bad [92.050854] Subtest basic-llseek-bad: SUCCESS (0.002s) [92.116776] [132/162] (902s left) prime_self_import (basic-llseek-size) [92.154804] Starting subtest: basic-llseek-size [92.157413] Subtest basic-llseek-size: SUCCESS (0.003s) [92.222983] [133/162] (902s left) prime_self_import (basic-with_fd_dup) [92.261571] Starting subtest: basic-with_fd_dup [92.263150] Subtest basic-with_fd_dup: SUCCESS (0.003s) [92.323493] [134/162] (902s left) prime_self_import (basic-with_one_bo) [92.362347] Starting subtest: basic-with_one_bo [92.364370] Subtest basic-with_one_bo: SUCCESS (0.003s) [92.405034] [135/162] (902s left) prime_self_import (basic-with_one_bo_two_files) [92.442759] Starting subtest: basic-with_one_bo_two_files [92.444917] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [92.549881] [136/162] (902s left) prime_self_import (basic-with_two_bos) [92.589217] Starting subtest: basic-with_two_bos [92.591810] Subtest basic-with_two_bos: SUCCESS (0.003s) [92.684877] [137/162] (902s left) prime_vgem (basic-fence-flip) [92.732083] Starting subtest: basic-fence-flip [92.789960] Subtest basic-fence-flip: SKIP (0.057s) [92.860345] [138/162] (902s left) prime_vgem (basic-fence-mmap) [92.909863] Starting subtest: basic-fence-mmap [92.931036] Subtest basic-fence-mmap: SUCCESS (0.021s) [93.052743] [139/162] (902s left) prime_vgem (basic-fence-read) [93.099799] Starting subtest: basic-fence-read [93.149657] Subtest basic-fence-read: SUCCESS (0.050s) [93.219605] [140/162] (901s left) prime_vgem (basic-gtt) [93.265693] Starting subtest: basic-gtt [93.275802] Subtest basic-gtt: SUCCESS (0.010s) [93.342309] [141/162] (901s left) prime_vgem (basic-read) [93.388431] Starting subtest: basic-read [93.412526] Subtest basic-read: SUCCESS (0.023s) [93.498696] [142/162] (901s left) prime_vgem (basic-write) [93.545626] Starting subtest: basic-write [93.570547] Subtest basic-write: SUCCESS (0.025s) [93.640183] [143/162] (901s left) vgem_basic (setversion) [93.682770] Starting subtest: setversion [93.683452] Subtest setversion: SUCCESS (0.000s) [93.722532] [144/162] (901s left) vgem_basic (create) [93.764580] Starting subtest: create [93.764908] Subtest create: SUCCESS (0.000s) [93.804477] [145/162] (901s left) vgem_basic (debugfs) [93.845444] Starting subtest: debugfs [93.845803] Subtest debugfs: SUCCESS (0.000s) [93.883341] [146/162] (901s left) vgem_basic (dmabuf-export) [93.925054] Starting subtest: dmabuf-export [93.926142] Subtest dmabuf-export: SUCCESS (0.001s) [93.991444] [147/162] (901s left) vgem_basic (dmabuf-fence) [94.033491] Starting subtest: dmabuf-fence [94.033902] Subtest dmabuf-fence: SUCCESS (0.001s) [94.073519] [148/162] (901s left) vgem_basic (dmabuf-fence-before) [94.114840] Starting subtest: dmabuf-fence-before [94.115260] Subtest dmabuf-fence-before: SUCCESS (0.000s) [94.152685] [149/162] (901s left) vgem_basic (dmabuf-mmap) [94.195303] Starting subtest: dmabuf-mmap [94.204214] Subtest dmabuf-mmap: SUCCESS (0.010s) [94.241910] [150/162] (901s left) vgem_basic (mmap) [94.283795] Starting subtest: mmap [94.290044] Subtest mmap: SUCCESS (0.007s) [94.328565] [151/162] (901s left) vgem_basic (second-client) [94.368137] Starting subtest: second-client [94.371280] Subtest second-client: SUCCESS (0.002s) [94.408193] [152/162] (901s left) vgem_basic (sysfs) [94.447418] Starting subtest: sysfs [94.447801] Subtest sysfs: SUCCESS (0.000s) [94.485654] [153/162] (901s left) core_hotunplug (unbind-rebind) [94.576419] Starting subtest: unbind-rebind [97.686093] Subtest unbind-rebind: SUCCESS (3.110s) [97.723974] [154/162] (897s left) vgem_basic (unload) [97.770545] Starting subtest: unload [126.860817] Subtest unload: SUCCESS (29.085s) [126.912024] [155/162] (868s left) i915_module_load (reload) [126.953749] Starting subtest: reload [129.011377] Subtest reload: SUCCESS (2.061s) [129.057236] [156/162] (866s left) gem_lmem_swapping (basic) [129.110499] Subtest basic: SKIP (0.000s) [129.145201] [157/162] (866s left) gem_lmem_swapping (parallel-random-engines) [129.190722] Subtest parallel-random-engines: SKIP (0.000s) [129.225073] [158/162] (866s left) gem_lmem_swapping (random-engines) [129.269135] Subtest random-engines: SKIP (0.000s) [129.303204] [159/162] (866s left) gem_lmem_swapping (verify-random) [129.345931] Subtest verify-random: SKIP (0.000s) [129.381155] [160/162] (866s left) i915_pm_rpm (module-reload) [130.670270] Starting subtest: module-reload [138.071992] Subtest module-reload: SUCCESS (7.401s) [138.109254] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [138.110572] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [138.112192] [161/162] (857s left) i915_selftest (live)