[53.398426] Initializing watchdogs [53.398498] /dev/watchdog0 [53.414647] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:591d Intel Kabylake (Gen9) HD Graphics P630 [53.422927] [001/162] (960s left) i915_module_load (load) [53.487505] Starting subtest: load [55.508401] Subtest load: SUCCESS (2.002s) [55.540847] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [55.542211] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [55.546947] [002/162] (958s left) core_auth (basic-auth) [55.608941] Starting subtest: basic-auth [55.612648] Subtest basic-auth: SUCCESS (0.001s) [55.651363] [003/162] (958s left) core_debugfs (read-all-entries) [55.700471] Starting subtest: read-all-entries [55.703670] Subtest read-all-entries: SUCCESS (0.002s) [55.745656] [004/162] (958s left) core_sysfs (read-all-entries) [55.794103] Starting subtest: read-all-entries [55.797212] Subtest read-all-entries: SUCCESS (0.003s) [55.836129] [005/162] (958s left) fbdev (eof) [55.894650] Subtest eof: SKIP (0.000s) [55.933183] [006/162] (958s left) fbdev (info) [55.985700] Subtest info: SKIP (0.000s) [56.023969] [007/162] (958s left) fbdev (nullptr) [56.088186] Subtest nullptr: SKIP (0.000s) [56.126959] [008/162] (958s left) fbdev (read) [56.182197] Subtest read: SKIP (0.000s) [56.221595] [009/162] (958s left) fbdev (write) [56.274176] Subtest write: SKIP (0.000s) [56.312449] [010/162] (957s left) gem_basic (bad-close) [56.364183] Starting subtest: bad-close [56.370651] Subtest bad-close: SUCCESS (0.000s) [56.409915] [011/162] (957s left) gem_basic (create-close) [56.462166] Starting subtest: create-close [56.468534] Subtest create-close: SUCCESS (0.000s) [56.515850] [012/162] (957s left) gem_basic (create-fd-close) [56.562213] Starting subtest: create-fd-close [56.569116] Subtest create-fd-close: SUCCESS (0.000s) [56.625691] [013/162] (957s left) gem_busy (busy@all-engines) [56.687757] Starting subtest: busy [56.690935] Starting dynamic subtest: all-engines [56.714634] Dynamic subtest all-engines: SUCCESS (0.027s) [56.717813] Subtest busy: SUCCESS (0.027s) [57.049750] [014/162] (957s left) gem_close_race (basic-process) [57.109281] Starting subtest: basic-process [57.174851] Subtest basic-process: SUCCESS (0.065s) [57.326887] [015/162] (957s left) gem_close_race (basic-threads) [57.382865] Starting subtest: basic-threads [58.668704] Subtest basic-threads: SUCCESS (1.279s) [58.820669] [016/162] (955s left) gem_ctx_create (basic) [58.878418] Starting subtest: basic [58.881724] Subtest basic: SUCCESS (0.000s) [59.022804] [017/162] (955s left) gem_ctx_create (basic-files) [59.081364] Starting subtest: basic-files [61.090517] Subtest basic-files: SUCCESS (2.003s) [61.303119] [018/162] (953s left) gem_ctx_exec (basic) [61.355909] Starting subtest: basic [61.359174] Subtest basic: SUCCESS (0.004s) [61.436028] [019/162] (953s left) gem_exec_basic (basic) [61.487551] Starting subtest: basic [61.490771] Starting dynamic subtest: rcs0-smem [61.493969] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [61.504702] Starting dynamic subtest: bcs0-smem [61.507761] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [61.518214] Starting dynamic subtest: vcs0-smem [61.521222] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [61.531726] Starting dynamic subtest: vecs0-smem [61.534970] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [61.538258] Subtest basic: SUCCESS (0.006s) [61.665509] [020/162] (953s left) gem_exec_create (basic) [61.745948] Starting subtest: basic [61.748855] Starting dynamic subtest: smem [63.758995] Dynamic subtest smem: SUCCESS (2.031s) [63.762265] Subtest basic: SUCCESS (2.032s) [63.906545] [021/162] (950s left) gem_exec_fence (basic-busy) [64.080479] Starting subtest: basic-busy [64.084010] Starting dynamic subtest: rcs0 [64.114409] Dynamic subtest rcs0: SUCCESS (0.034s) [64.132811] Starting dynamic subtest: bcs0 [64.147350] Dynamic subtest bcs0: SUCCESS (0.032s) [64.158352] Starting dynamic subtest: vcs0 [64.177175] Dynamic subtest vcs0: SUCCESS (0.030s) [64.189534] Starting dynamic subtest: vecs0 [64.200118] Dynamic subtest vecs0: SUCCESS (0.021s) [64.203276] Subtest basic-busy: SUCCESS (0.118s) [64.730819] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [64.734892] [022/162] (950s left) gem_exec_fence (basic-wait) [64.907059] Starting subtest: basic-wait [64.910199] Starting dynamic subtest: rcs0 [64.938780] Dynamic subtest rcs0: SUCCESS (0.031s) [64.952828] Starting dynamic subtest: bcs0 [64.965348] Dynamic subtest bcs0: SUCCESS (0.027s) [64.977857] Starting dynamic subtest: vcs0 [64.991154] Dynamic subtest vcs0: SUCCESS (0.026s) [65.005075] Starting dynamic subtest: vecs0 [65.018186] Dynamic subtest vecs0: SUCCESS (0.027s) [65.021480] Subtest basic-wait: SUCCESS (0.111s) [65.493039] [023/162] (949s left) gem_exec_fence (basic-await) [65.669284] Starting subtest: basic-await [65.673270] Starting dynamic subtest: rcs0 [65.742289] Dynamic subtest rcs0: SUCCESS (0.078s) [65.761108] Starting dynamic subtest: bcs0 [65.830504] Dynamic subtest bcs0: SUCCESS (0.088s) [65.851270] Starting dynamic subtest: vcs0 [65.920689] Dynamic subtest vcs0: SUCCESS (0.090s) [65.940319] Starting dynamic subtest: vecs0 [66.007464] Dynamic subtest vecs0: SUCCESS (0.085s) [66.011177] Subtest basic-await: SUCCESS (0.343s) [66.500725] [024/162] (948s left) gem_exec_fence (nb-await) [66.670591] Starting subtest: nb-await [66.673660] Starting dynamic subtest: rcs0 [66.728337] Dynamic subtest rcs0: SUCCESS (0.061s) [66.740371] Starting dynamic subtest: bcs0 [66.786776] Dynamic subtest bcs0: SUCCESS (0.058s) [66.798034] Starting dynamic subtest: vcs0 [66.843687] Dynamic subtest vcs0: SUCCESS (0.056s) [66.855228] Starting dynamic subtest: vecs0 [66.902121] Dynamic subtest vecs0: SUCCESS (0.057s) [66.906254] Subtest nb-await: SUCCESS (0.235s) [67.585673] [025/162] (947s left) gem_exec_gttfill (basic) [67.660134] Starting subtest: basic [70.981694] Subtest basic: SUCCESS (3.317s) [71.143382] [026/162] (943s left) gem_exec_parallel (engines) [71.272194] Starting subtest: engines [71.275471] Starting dynamic subtest: basic [72.999701] Dynamic subtest basic: SUCCESS (1.726s) [73.011868] Starting dynamic subtest: contexts [75.142383] Dynamic subtest contexts: SUCCESS (2.141s) [75.154267] Starting dynamic subtest: fds [77.542857] Dynamic subtest fds: SUCCESS (2.399s) [77.555368] Starting dynamic subtest: userptr [79.613664] Dynamic subtest userptr: SUCCESS (2.069s) [79.616885] Subtest engines: SUCCESS (8.336s) [79.784169] [027/162] (935s left) gem_exec_store (basic) [79.855189] Starting subtest: basic [79.915192] Subtest basic: SUCCESS (0.066s) [80.071703] [028/162] (935s left) gem_flink_basic (bad-flink) [80.119839] Starting subtest: bad-flink [80.122817] Subtest bad-flink: SUCCESS (0.000s) [80.167361] [029/162] (934s left) gem_flink_basic (bad-open) [80.214526] Starting subtest: bad-open [80.217578] Subtest bad-open: SUCCESS (0.000s) [80.260835] [030/162] (934s left) gem_flink_basic (basic) [80.309174] Starting subtest: basic [80.312434] Subtest basic: SUCCESS (0.000s) [80.371691] [031/162] (934s left) gem_flink_basic (double-flink) [80.419184] Starting subtest: double-flink [80.422459] Subtest double-flink: SUCCESS (0.000s) [80.480795] [032/162] (934s left) gem_flink_basic (flink-lifetime) [80.533528] Starting subtest: flink-lifetime [80.536773] Subtest flink-lifetime: SUCCESS (0.001s) [80.603985] [033/162] (934s left) gem_huc_copy (huc-copy) [80.658905] Starting subtest: huc-copy [80.665514] Subtest huc-copy: SKIP (0.000s) [80.735826] [034/162] (934s left) gem_linear_blits (basic) [80.857781] Starting subtest: basic [80.865286] Subtest basic: SUCCESS (0.006s) [80.970189] [035/162] (934s left) gem_mmap (basic) [81.143811] Starting subtest: basic [81.159280] Subtest basic: SUCCESS (0.000s) [81.203693] [036/162] (934s left) gem_mmap_gtt (basic) [81.254513] Starting subtest: basic [81.257662] Subtest basic: SUCCESS (0.001s) [81.301065] [037/162] (934s left) gem_render_linear_blits (basic) [81.352965] Starting subtest: basic [81.381267] Subtest basic: SUCCESS (0.029s) [81.440862] [038/162] (934s left) gem_render_tiled_blits (basic) [81.492869] Starting subtest: basic [81.521734] Subtest basic: SUCCESS (0.030s) [81.577796] [039/162] (934s left) gem_ringfill (basic-all) [81.811041] Starting subtest: basic-all [82.952707] Subtest basic-all: SUCCESS (1.136s) [83.029922] [040/162] (932s left) gem_softpin (allocator-basic) [83.088455] Starting subtest: allocator-basic [83.182613] Subtest allocator-basic: SUCCESS (0.095s) [83.255662] [041/162] (932s left) gem_softpin (allocator-basic-reserve) [83.303675] Starting subtest: allocator-basic-reserve [83.397253] Subtest allocator-basic-reserve: SUCCESS (0.095s) [83.471687] [042/162] (932s left) gem_softpin (safe-alignment) [83.530116] Starting subtest: safe-alignment [83.536484] Subtest safe-alignment: SUCCESS (0.010s) [83.608225] [043/162] (932s left) gem_sync (basic-all) [83.688375] Starting subtest: basic-all [85.745448] Subtest basic-all: SUCCESS (2.077s) [85.899078] [044/162] (929s left) gem_sync (basic-each) [85.973429] Starting subtest: basic-each [88.049559] Subtest basic-each: SUCCESS (2.093s) [88.200821] [045/162] (927s left) gem_tiled_blits (basic) [88.306764] Starting subtest: basic [88.320597] Subtest basic: SUCCESS (0.013s) [88.411951] [046/162] (927s left) gem_tiled_fence_blits (basic) [88.608701] Starting subtest: basic [88.617384] Subtest basic: SUCCESS (0.007s) [88.714638] [047/162] (927s left) gem_tiled_pread_basic (basic) [88.845227] Starting subtest: basic [88.962383] Subtest basic: SUCCESS (0.122s) [89.027431] [048/162] (927s left) gem_wait (busy@all-engines) [89.088478] Starting subtest: busy [89.091722] Starting dynamic subtest: all-engines [89.616377] Dynamic subtest all-engines: SUCCESS (0.528s) [89.619467] Subtest busy: SUCCESS (0.528s) [89.782372] [049/162] (926s left) gem_wait (wait@all-engines) [89.841408] Starting subtest: wait [89.844513] Starting dynamic subtest: all-engines [90.883295] Dynamic subtest all-engines: SUCCESS (1.041s) [90.886516] Subtest wait: SUCCESS (1.042s) [91.044743] [050/162] (925s left) i915_getparams_basic (basic-eu-total) [91.094463] Starting subtest: basic-eu-total [91.100448] Subtest basic-eu-total: SUCCESS (0.000s) [91.144244] [051/162] (925s left) i915_getparams_basic (basic-subslice-total) [91.192618] Starting subtest: basic-subslice-total [91.198589] Subtest basic-subslice-total: SUCCESS (0.000s) [91.241753] [052/162] (924s left) i915_hangman (error-state-basic) [91.299275] Starting subtest: error-state-basic [91.307642] Subtest error-state-basic: SUCCESS (0.006s) [91.376903] [053/162] (924s left) i915_pciid [91.473518] [054/162] (924s left) intel_hwmon (hwmon-read) [91.526219] Subtest hwmon-read: SKIP (0.000s) [91.570841] [055/162] (924s left) intel_hwmon (hwmon-write) [91.625399] Subtest hwmon-write: SKIP (0.000s) [91.739916] [056/162] (924s left) kms_addfb_basic (addfb25-4-tiled) [92.509542] Starting subtest: addfb25-4-tiled [92.574990] Subtest addfb25-4-tiled: SUCCESS (0.000s) [92.999546] [057/162] (924s left) kms_addfb_basic (addfb25-bad-modifier) [93.155962] Starting subtest: addfb25-bad-modifier [93.159250] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [93.223696] [058/162] (923s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [93.301911] Starting subtest: addfb25-framebuffer-vs-set-tiling [93.305306] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [93.365741] [059/162] (923s left) kms_addfb_basic (addfb25-modifier-no-flag) [93.445129] Starting subtest: addfb25-modifier-no-flag [93.448120] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [93.505664] [060/162] (923s left) kms_addfb_basic (addfb25-x-tiled-legacy) [93.588341] Starting subtest: addfb25-x-tiled-legacy [93.591487] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [93.650811] [061/162] (923s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [93.730258] Starting subtest: addfb25-x-tiled-mismatch-legacy [93.733224] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [93.790825] [062/162] (923s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [93.869874] Starting subtest: addfb25-yf-tiled-legacy [93.873150] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [93.938320] [063/162] (923s left) kms_addfb_basic (addfb25-y-tiled-legacy) [94.019337] Starting subtest: addfb25-y-tiled-legacy [94.022561] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [94.081165] [064/162] (923s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [94.158308] Starting subtest: addfb25-y-tiled-small-legacy [94.161346] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [94.224759] [065/162] (923s left) kms_addfb_basic (bad-pitch-0) [94.276035] Starting subtest: bad-pitch-0 [94.280323] Subtest bad-pitch-0: SUCCESS (0.000s) [94.367800] [066/162] (923s left) kms_addfb_basic (bad-pitch-1024) [94.416026] Starting subtest: bad-pitch-1024 [94.419746] Subtest bad-pitch-1024: SUCCESS (0.000s) [94.502129] [067/162] (922s left) kms_addfb_basic (bad-pitch-128) [94.551735] Starting subtest: bad-pitch-128 [94.555594] Subtest bad-pitch-128: SUCCESS (0.000s) [94.643721] [068/162] (922s left) kms_addfb_basic (bad-pitch-256) [94.698377] Starting subtest: bad-pitch-256 [94.701673] Subtest bad-pitch-256: SUCCESS (0.000s) [94.783148] [069/162] (922s left) kms_addfb_basic (bad-pitch-32) [94.833649] Starting subtest: bad-pitch-32 [94.837891] Subtest bad-pitch-32: SUCCESS (0.000s) [94.921803] [070/162] (922s left) kms_addfb_basic (bad-pitch-63) [94.972886] Starting subtest: bad-pitch-63 [94.976787] Subtest bad-pitch-63: SUCCESS (0.000s) [95.069097] [071/162] (922s left) kms_addfb_basic (bad-pitch-65536) [95.118893] Starting subtest: bad-pitch-65536 [95.123746] Subtest bad-pitch-65536: SUCCESS (0.000s) [95.211479] [072/162] (922s left) kms_addfb_basic (bad-pitch-999) [95.265647] Starting subtest: bad-pitch-999 [95.268563] Subtest bad-pitch-999: SUCCESS (0.000s) [95.348794] [073/162] (922s left) kms_addfb_basic (basic) [95.411350] Starting subtest: basic [95.414401] Subtest basic: SUCCESS (0.000s) [95.495580] [074/162] (922s left) kms_addfb_basic (basic-x-tiled-legacy) [95.550315] Starting subtest: basic-x-tiled-legacy [95.553825] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [95.631119] [075/162] (922s left) kms_addfb_basic (basic-y-tiled-legacy) [95.684089] Starting subtest: basic-y-tiled-legacy [95.687057] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [95.767066] [076/162] (922s left) kms_addfb_basic (bo-too-small) [95.848332] Starting subtest: bo-too-small [95.851678] Subtest bo-too-small: SUCCESS (0.000s) [95.910778] [077/162] (922s left) kms_addfb_basic (bo-too-small-due-to-tiling) [95.992153] Starting subtest: bo-too-small-due-to-tiling [95.995363] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [96.054882] [078/162] (921s left) kms_addfb_basic (clobberred-modifier) [96.108355] Starting subtest: clobberred-modifier [96.112180] Subtest clobberred-modifier: SUCCESS (0.000s) [96.185404] [079/162] (921s left) kms_addfb_basic (framebuffer-vs-set-tiling) [96.236949] Starting subtest: framebuffer-vs-set-tiling [96.240745] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [96.333372] [080/162] (921s left) kms_addfb_basic (invalid-get-prop) [96.384645] Starting subtest: invalid-get-prop [96.387986] Subtest invalid-get-prop: SUCCESS (0.000s) [96.464709] [081/162] (921s left) kms_addfb_basic (invalid-get-prop-any) [96.515581] Starting subtest: invalid-get-prop-any [96.519463] Subtest invalid-get-prop-any: SUCCESS (0.000s) [96.601722] [082/162] (921s left) kms_addfb_basic (invalid-set-prop) [96.655983] Starting subtest: invalid-set-prop [96.659203] Subtest invalid-set-prop: SUCCESS (0.000s) [96.745734] [083/162] (921s left) kms_addfb_basic (invalid-set-prop-any) [96.795605] Starting subtest: invalid-set-prop-any [96.798918] Subtest invalid-set-prop-any: SUCCESS (0.000s) [96.891956] [084/162] (921s left) kms_addfb_basic (no-handle) [96.945039] Starting subtest: no-handle [96.948143] Subtest no-handle: SUCCESS (0.000s) [97.036036] [085/162] (921s left) kms_addfb_basic (size-max) [97.112697] Starting subtest: size-max [97.115846] Subtest size-max: SUCCESS (0.000s) [97.177960] [086/162] (921s left) kms_addfb_basic (small-bo) [97.256479] Starting subtest: small-bo [97.259360] Subtest small-bo: SUCCESS (0.000s) [97.318196] [087/162] (921s left) kms_addfb_basic (tile-pitch-mismatch) [97.368120] Starting subtest: tile-pitch-mismatch [97.371973] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [97.457173] [088/162] (920s left) kms_addfb_basic (too-high) [97.537545] Starting subtest: too-high [97.540624] Subtest too-high: SUCCESS (0.001s) [97.601039] [089/162] (920s left) kms_addfb_basic (too-wide) [97.679560] Starting subtest: too-wide [97.682676] Subtest too-wide: SUCCESS (0.000s) [97.735810] [090/162] (920s left) kms_addfb_basic (unused-handle) [97.787545] Starting subtest: unused-handle [97.790898] Subtest unused-handle: SUCCESS (0.000s) [97.882960] [091/162] (920s left) kms_addfb_basic (unused-modifier) [97.934334] Starting subtest: unused-modifier [97.938652] Subtest unused-modifier: SUCCESS (0.000s) [98.028539] [092/162] (920s left) kms_addfb_basic (unused-offsets) [98.080568] Starting subtest: unused-offsets [98.085050] Subtest unused-offsets: SUCCESS (0.000s) [98.172124] [093/162] (920s left) kms_addfb_basic (unused-pitches) [98.225875] Starting subtest: unused-pitches [98.229346] Subtest unused-pitches: SUCCESS (0.000s) [98.317688] [094/162] (920s left) kms_busy (basic) [98.403260] Subtest basic: SKIP (0.000s) [98.445778] [095/162] (920s left) kms_prop_blob (basic) [98.495598] Starting subtest: basic [98.498555] Subtest basic: SUCCESS (0.000s) [98.541910] [096/162] (920s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [98.645501] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [98.690981] [097/162] (920s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [98.788505] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [98.834478] [098/162] (920s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [98.934360] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [98.980644] [099/162] (919s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [99.079380] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [99.124923] [100/162] (919s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [99.223739] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [99.268975] [101/162] (919s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [99.369110] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [99.414509] [102/162] (919s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [99.513409] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [99.561584] [103/162] (919s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [99.661656] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [99.708298] [104/162] (919s left) kms_dsc (dsc-basic) [99.789562] Subtest dsc-basic: SKIP (0.000s) [99.833311] [105/162] (919s left) kms_flip (basic-flip-vs-dpms) [99.915657] Starting subtest: basic-flip-vs-dpms [99.921829] Subtest basic-flip-vs-dpms: SKIP (0.001s) [99.966185] [106/162] (919s left) kms_flip (basic-flip-vs-modeset) [100.048239] Starting subtest: basic-flip-vs-modeset [100.054713] Subtest basic-flip-vs-modeset: SKIP (0.001s) [100.118336] [107/162] (919s left) kms_flip (basic-flip-vs-wf_vblank) [100.196165] Starting subtest: basic-flip-vs-wf_vblank [100.201920] Subtest basic-flip-vs-wf_vblank: SKIP (0.001s) [100.245306] [108/162] (919s left) kms_flip (basic-plain-flip) [100.334441] Starting subtest: basic-plain-flip [100.340495] Subtest basic-plain-flip: SKIP (0.001s) [100.529770] [109/162] (918s left) kms_force_connector_basic (force-connector-state) [100.982642] Starting subtest: force-connector-state [101.049424] Subtest force-connector-state: SUCCESS (0.079s) [101.577570] [110/162] (918s left) kms_force_connector_basic (force-edid) [101.972847] Starting subtest: force-edid [102.149029] Subtest force-edid: SUCCESS (0.175s) [102.233802] [111/162] (917s left) kms_force_connector_basic (force-load-detect) [102.389209] Starting subtest: force-load-detect [102.397466] Subtest force-load-detect: SKIP (0.000s) [102.460388] [112/162] (917s left) kms_force_connector_basic (prune-stale-modes) [102.605942] Starting subtest: prune-stale-modes [102.778970] Subtest prune-stale-modes: SUCCESS (0.176s) [102.866984] [113/162] (917s left) kms_frontbuffer_tracking (basic) [102.947770] Subtest basic: SKIP (0.000s) [103.006588] [114/162] (917s left) kms_hdmi_inject (inject-audio) [103.056985] Starting subtest: inject-audio [103.063143] Subtest inject-audio: SKIP (0.000s) [103.108072] [115/162] (917s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [103.186525] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [103.229869] [116/162] (917s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [103.309884] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [103.353954] [117/162] (916s left) kms_pipe_crc_basic (hang-read-crc) [103.434517] Subtest hang-read-crc: SKIP (0.000s) [103.477221] [118/162] (916s left) kms_pipe_crc_basic (nonblocking-crc) [103.556669] Subtest nonblocking-crc: SKIP (0.000s) [103.599948] [119/162] (916s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [103.679113] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [103.722579] [120/162] (916s left) kms_pipe_crc_basic (read-crc) [103.807606] Subtest read-crc: SKIP (0.000s) [103.850297] [121/162] (916s left) kms_pipe_crc_basic (read-crc-frame-sequence) [103.934141] Subtest read-crc-frame-sequence: SKIP (0.000s) [103.983030] [122/162] (916s left) kms_pm_backlight (basic-brightness) [104.061924] Subtest basic-brightness: SKIP (0.000s) [104.106041] [123/162] (916s left) kms_pm_rpm (basic-pci-d3-state) [115.417970] Starting subtest: basic-pci-d3-state [115.605217] Subtest basic-pci-d3-state: SUCCESS (0.180s) [115.656539] [124/162] (904s left) kms_pm_rpm (basic-rte) [115.708396] Starting subtest: basic-rte [127.220764] Subtest basic-rte: SUCCESS (11.516s) [127.531121] [125/162] (893s left) kms_psr (psr-primary-page-flip) [127.611665] Subtest psr-primary-page-flip: SKIP (0.000s) [127.658354] [126/162] (893s left) kms_psr (psr-cursor-plane-move) [127.742999] Subtest psr-cursor-plane-move: SKIP (0.000s) [127.788015] [127/162] (893s left) kms_psr (psr-sprite-plane-onoff) [127.865172] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [127.909877] [128/162] (892s left) kms_psr (psr-primary-mmap-gtt) [127.991494] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [128.035666] [129/162] (892s left) kms_setmode (basic-clone-single-crtc) [128.086703] Starting subtest: basic-clone-single-crtc [128.096192] Subtest basic-clone-single-crtc: SKIP (0.000s) [128.144144] [130/162] (892s left) i915_pm_rps (basic-api) [128.198718] Starting subtest: basic-api [128.201788] Subtest basic-api: SUCCESS (0.003s) [128.249356] [131/162] (892s left) prime_self_import (basic-llseek-bad) [128.299308] Starting subtest: basic-llseek-bad [128.305571] Subtest basic-llseek-bad: SUCCESS (0.002s) [128.369944] [132/162] (892s left) prime_self_import (basic-llseek-size) [128.417398] Starting subtest: basic-llseek-size [128.423728] Subtest basic-llseek-size: SUCCESS (0.002s) [128.487674] [133/162] (892s left) prime_self_import (basic-with_fd_dup) [128.532570] Starting subtest: basic-with_fd_dup [128.539333] Subtest basic-with_fd_dup: SUCCESS (0.002s) [128.602218] [134/162] (892s left) prime_self_import (basic-with_one_bo) [128.651159] Starting subtest: basic-with_one_bo [128.657635] Subtest basic-with_one_bo: SUCCESS (0.003s) [128.702952] [135/162] (892s left) prime_self_import (basic-with_one_bo_two_files) [128.748673] Starting subtest: basic-with_one_bo_two_files [128.755279] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [128.819960] [136/162] (892s left) prime_self_import (basic-with_two_bos) [128.866939] Starting subtest: basic-with_two_bos [128.873213] Subtest basic-with_two_bos: SUCCESS (0.003s) [128.942533] [137/162] (892s left) prime_vgem (basic-fence-flip) [128.999260] Starting subtest: basic-fence-flip [129.059011] Subtest basic-fence-flip: SKIP (0.059s) [129.106035] [138/162] (892s left) prime_vgem (basic-fence-mmap) [129.163994] Starting subtest: basic-fence-mmap [129.183633] Subtest basic-fence-mmap: SUCCESS (0.023s) [129.251833] [139/162] (892s left) prime_vgem (basic-fence-read) [129.304178] Starting subtest: basic-fence-read [129.349115] Subtest basic-fence-read: SUCCESS (0.045s) [129.422887] [140/162] (891s left) prime_vgem (basic-gtt) [129.477820] Starting subtest: basic-gtt [129.485628] Subtest basic-gtt: SUCCESS (0.011s) [129.554595] [141/162] (891s left) prime_vgem (basic-read) [129.609497] Starting subtest: basic-read [129.628207] Subtest basic-read: SUCCESS (0.022s) [129.706730] [142/162] (891s left) prime_vgem (basic-write) [129.759301] Starting subtest: basic-write [129.780396] Subtest basic-write: SUCCESS (0.022s) [129.831734] [143/162] (891s left) vgem_basic (setversion) [129.883384] Starting subtest: setversion [129.889505] Subtest setversion: SUCCESS (0.000s) [129.950383] [144/162] (891s left) vgem_basic (create) [129.999199] Starting subtest: create [130.002635] Subtest create: SUCCESS (0.000s) [130.054436] [145/162] (891s left) vgem_basic (debugfs) [130.105122] Starting subtest: debugfs [130.108561] Subtest debugfs: SUCCESS (0.000s) [130.161092] [146/162] (891s left) vgem_basic (dmabuf-export) [130.211508] Starting subtest: dmabuf-export [130.217485] Subtest dmabuf-export: SUCCESS (0.002s) [130.275771] [147/162] (891s left) vgem_basic (dmabuf-fence) [130.328211] Starting subtest: dmabuf-fence [130.331672] Subtest dmabuf-fence: SUCCESS (0.001s) [130.379536] [148/162] (891s left) vgem_basic (dmabuf-fence-before) [130.431844] Starting subtest: dmabuf-fence-before [130.435193] Subtest dmabuf-fence-before: SUCCESS (0.000s) [130.484590] [149/162] (891s left) vgem_basic (dmabuf-mmap) [130.535587] Starting subtest: dmabuf-mmap [130.542278] Subtest dmabuf-mmap: SUCCESS (0.009s) [130.589565] [150/162] (891s left) vgem_basic (mmap) [130.645352] Starting subtest: mmap [130.648799] Subtest mmap: SUCCESS (0.006s) [130.698906] [151/162] (891s left) vgem_basic (second-client) [130.750969] Starting subtest: second-client [130.757072] Subtest second-client: SUCCESS (0.002s) [130.813957] [152/162] (891s left) vgem_basic (sysfs) [130.866162] Starting subtest: sysfs [130.869222] Subtest sysfs: SUCCESS (0.000s) [130.919120] [153/162] (891s left) core_hotunplug (unbind-rebind) [131.031568] Starting subtest: unbind-rebind [134.497697] Subtest unbind-rebind: SUCCESS (3.463s) [134.543157] [154/162] (887s left) vgem_basic (unload) [134.591103] Starting subtest: unload [163.438529] Subtest unload: SUCCESS (28.851s) [163.503374] [155/162] (858s left) i915_module_load (reload) [163.552245] Starting subtest: reload [166.012604] Subtest reload: SUCCESS (2.463s) [166.188705] [156/162] (856s left) gem_lmem_swapping (basic) [166.699170] Subtest basic: SKIP (0.000s) [167.113798] [157/162] (855s left) gem_lmem_swapping (parallel-random-engines) [167.498415] Subtest parallel-random-engines: SKIP (0.000s) [167.542109] [158/162] (855s left) gem_lmem_swapping (random-engines) [167.597209] Subtest random-engines: SKIP (0.000s) [167.639659] [159/162] (855s left) gem_lmem_swapping (verify-random) [167.695600] Subtest verify-random: SKIP (0.000s) [167.739409] [160/162] (855s left) i915_pm_rpm (module-reload) [179.048339] Starting subtest: module-reload [206.667168] Subtest module-reload: SUCCESS (27.622s) [206.699788] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [206.700933] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [206.705130] [161/162] (816s left) i915_selftest (live) [206.755417] Starting subtest: live [206.758622] Starting dynamic subtest: sanitycheck [208.951530] Dynamic subtest sanitycheck: SUCCESS (2.197s) [208.964572] Starting dynamic subtest: uncore [211.080273] Dynamic subtest uncore: SUCCESS (2.119s) [211.093946] Starting dynamic subtest: workarounds [213.380486] Dynamic subtest workarounds: SUCCESS (2.301s) [213.391492] Starting dynamic subtest: gt_engines [216.025585] Dynamic subtest gt_engines: SUCCESS (2.591s) [216.089957] Starting dynamic subtest: gt_timelines [224.829714] Dynamic subtest gt_timelines: SUCCESS (8.865s) [224.841131] Starting dynamic subtest: gt_contexts [227.050567] Dynamic subtest gt_contexts: SUCCESS (2.213s) [227.061854] Starting dynamic subtest: gt_lrc [231.655694] Dynamic subtest gt_lrc: SUCCESS (4.611s) [231.667289] Starting dynamic subtest: gt_mocs [233.890970] Dynamic subtest gt_mocs: SUCCESS (2.225s) [233.902082] Starting dynamic subtest: gt_pm [240.294783] Dynamic subtest gt_pm: SUCCESS (6.412s) [240.310172] Starting dynamic subtest: gt_heartbeat [242.431252] Dynamic subtest gt_heartbeat: SUCCESS (2.131s) [242.442927] Starting dynamic subtest: gt_tlb [245.821307] Dynamic subtest gt_tlb: SUCCESS (3.390s) [245.837292] Starting dynamic subtest: requests [254.218888] Dynamic subtest requests: SUCCESS (8.400s) [254.230215] Starting dynamic subtest: migrate [259.477944] Dynamic subtest migrate: SUCCESS (5.258s) [259.489851] Starting dynamic subtest: active [261.638407] Dynamic subtest active: SUCCESS (2.113s) [261.702635] Starting dynamic subtest: objects [264.245589] Dynamic subtest objects: SUCCESS (2.653s) [264.260961] Starting dynamic subtest: mman [269.515533] Dynamic subtest mman: SUCCESS (5.269s) [269.527158] Starting dynamic subtest: dmabuf [271.672347] Dynamic subtest dmabuf: SUCCESS (2.152s) [271.683987] Starting dynamic subtest: vma [273.812036] Dynamic subtest vma: SUCCESS (2.133s) [273.823146] Starting dynamic subtest: coherency [276.770380] Dynamic subtest coherency: SUCCESS (2.965s) [276.783158] Starting dynamic subtest: gtt [286.255698] Dynamic subtest gtt: SUCCESS (9.486s) [286.267509] Starting dynamic subtest: gem [288.532544] Dynamic subtest gem: SUCCESS (2.273s) [288.544523] Starting dynamic subtest: evict [291.828827] Dynamic subtest evict: SUCCESS (3.298s) [291.842478] Starting dynamic subtest: hugepages [300.387988] Dynamic subtest hugepages: SUCCESS (8.558s) [300.403447] Starting dynamic subtest: gem_contexts [315.129893] Dynamic subtest gem_contexts: SUCCESS (14.741s) [315.142660] Starting dynamic subtest: client [317.454245] Dynamic subtest client: SUCCESS (2.268s) [317.465724] Starting dynamic subtest: gem_migrate [319.642906] Dynamic subtest gem_migrate: SUCCESS (2.235s) [319.658927] Starting dynamic subtest: reset [322.004898] Dynamic subtest reset: SUCCESS (2.369s) [322.016883] Starting dynamic subtest: memory_region [324.133490] Dynamic subtest memory_region: SUCCESS (2.124s) [324.147229] Starting dynamic subtest: hangcheck [349.340085] Dynamic subtest hangcheck: SUCCESS (25.209s) [349.356213] Starting dynamic subtest: execlists [359.618912] Dynamic subtest execlists: SUCCESS (10.278s) [359.630806] Starting dynamic subtest: ring_submission [361.743994] Dynamic subtest ring_submission: SUCCESS (2.124s) [361.759647] Starting dynamic subtest: perf [363.944714] Dynamic subtest perf: SUCCESS (2.200s) [363.956408] Starting dynamic subtest: slpc [366.043950] Dynamic subtest slpc: SUCCESS (2.092s) [366.056879] Starting dynamic subtest: guc [368.185124] Dynamic subtest guc: SUCCESS (2.146s) [368.198327] Starting dynamic subtest: guc_multi_lrc [370.314122] Dynamic subtest guc_multi_lrc: SUCCESS (2.125s) [370.325715] Starting dynamic subtest: guc_hang [372.480159] Dynamic subtest guc_hang: SUCCESS (2.116s) [372.548556] Starting dynamic subtest: late_gt_pm [374.624228] Dynamic subtest late_gt_pm: SUCCESS (2.186s) [374.627534] Subtest live: SUCCESS (167.857s) [374.664421] [162/162] (648s left) dmabuf (all-tests) [374.724591] Starting subtest: all-tests [374.730496] Subtest all-tests: SKIP (0.000s) [374.766570] 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.