[49.118674] Initializing watchdogs [49.118793] /dev/watchdog0 [49.125173] [001/171] (960s left) i915_module_load (load) [49.341350] Starting subtest: load [50.333259] Subtest load: SUCCESS (0.992s) [50.356251] [002/171] (959s left) core_auth (basic-auth) [50.514727] Starting subtest: basic-auth [50.517167] Subtest basic-auth: SUCCESS (0.001s) [50.617915] [003/171] (959s left) debugfs_test (read_all_entries) [50.726958] Starting subtest: read_all_entries [50.812801] Subtest read_all_entries: SUCCESS (0.085s) [50.915791] [004/171] (958s left) debugfs_test (basic-hwmon) [51.021109] Starting subtest: basic-hwmon [51.023033] Subtest basic-hwmon: SKIP (0.000s) [51.137246] [005/171] (958s left) fbdev (eof) [51.250579] Starting subtest: eof [51.251523] Subtest eof: SUCCESS (0.000s) [51.311682] [006/171] (958s left) fbdev (info) [51.410449] Starting subtest: info [51.411529] Subtest info: SUCCESS (0.000s) [51.470556] [007/171] (958s left) fbdev (nullptr) [51.584090] Starting subtest: nullptr [51.585138] Subtest nullptr: SUCCESS (0.000s) [51.639624] [008/171] (958s left) fbdev (read) [51.750220] Starting subtest: read [52.597196] Subtest read: SUCCESS (0.838s) [52.639508] [009/171] (957s left) fbdev (write) [52.751261] Starting subtest: write [53.174797] Subtest write: SUCCESS (0.415s) [53.263309] [010/171] (956s left) gem_basic (bad-close) [53.364020] Starting subtest: bad-close [53.365656] Subtest bad-close: SUCCESS (0.000s) [53.485697] [011/171] (956s left) gem_basic (create-close) [53.597313] Starting subtest: create-close [53.599215] Subtest create-close: SUCCESS (0.000s) [53.713460] [012/171] (956s left) gem_basic (create-fd-close) [53.816575] Starting subtest: create-fd-close [53.818668] Subtest create-fd-close: SUCCESS (0.000s) [53.940247] [013/171] (955s left) gem_busy (busy@all-engines) [54.060747] Starting subtest: busy [54.061877] Starting dynamic subtest: all-engines [54.122466] Dynamic subtest all-engines: SUCCESS (0.062s) [54.123733] Subtest busy: SUCCESS (0.062s) [54.559980] [014/171] (955s left) gem_close_race (basic-process) [54.679258] Starting subtest: basic-process [54.748309] Subtest basic-process: SUCCESS (0.070s) [54.960330] [015/171] (954s left) gem_close_race (basic-threads) [55.079610] Starting subtest: basic-threads [56.237074] Subtest basic-threads: SUCCESS (1.157s) [56.531843] [016/171] (953s left) gem_ctx_create (basic) [56.655786] Starting subtest: basic [56.656827] Subtest basic: SUCCESS (0.000s) [56.898735] [017/171] (953s left) gem_ctx_create (basic-files) [57.017748] Starting subtest: basic-files [59.039558] Subtest basic-files: SUCCESS (2.022s) [59.347849] [018/171] (950s left) gem_ctx_exec (basic) [59.457259] Starting subtest: basic [59.460807] Subtest basic: SUCCESS (0.004s) [59.574452] [019/171] (950s left) gem_exec_basic (basic) [59.700638] Starting subtest: basic [59.701832] Starting dynamic subtest: rcs0-smem [59.702991] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [59.711777] Starting dynamic subtest: bcs0-smem [59.712774] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [59.719897] Starting dynamic subtest: vcs0-smem [59.721222] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [59.727995] Starting dynamic subtest: vecs0-smem [59.729285] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [59.730657] Subtest basic: SUCCESS (0.006s) [59.929148] [020/171] (950s left) gem_exec_create (basic) [60.045295] Starting subtest: basic [60.046409] Starting dynamic subtest: smem [62.091696] Dynamic subtest smem: SUCCESS (2.046s) [62.092811] Subtest basic: SUCCESS (2.046s) [62.322373] [021/171] (947s left) gem_exec_fence (basic-busy) [62.593391] Starting subtest: basic-busy [62.594644] Starting dynamic subtest: rcs0 [62.619355] Dynamic subtest rcs0: SUCCESS (0.026s) [62.627158] Starting dynamic subtest: bcs0 [62.648464] Dynamic subtest bcs0: SUCCESS (0.029s) [62.655662] Starting dynamic subtest: vcs0 [62.671316] Dynamic subtest vcs0: SUCCESS (0.023s) [62.678605] Starting dynamic subtest: vecs0 [62.694092] Dynamic subtest vecs0: SUCCESS (0.023s) [62.694998] Subtest basic-busy: SUCCESS (0.101s) [63.405855] [022/171] (946s left) gem_exec_fence (basic-wait) [63.684343] Starting subtest: basic-wait [63.685805] Starting dynamic subtest: rcs0 [63.714327] Dynamic subtest rcs0: SUCCESS (0.030s) [63.721906] Starting dynamic subtest: bcs0 [63.748425] Dynamic subtest bcs0: SUCCESS (0.034s) [63.756810] Starting dynamic subtest: vcs0 [63.774397] Dynamic subtest vcs0: SUCCESS (0.026s) [63.782834] Starting dynamic subtest: vecs0 [63.799563] Dynamic subtest vecs0: SUCCESS (0.025s) [63.800998] Subtest basic-wait: SUCCESS (0.116s) [64.465749] [023/171] (945s left) gem_exec_fence (basic-await) [64.725251] Starting subtest: basic-await [64.726318] Starting dynamic subtest: rcs0 [64.826898] Dynamic subtest rcs0: SUCCESS (0.106s) [64.836536] Starting dynamic subtest: bcs0 [64.927218] Dynamic subtest bcs0: SUCCESS (0.100s) [64.934990] Starting dynamic subtest: vcs0 [65.021469] Dynamic subtest vcs0: SUCCESS (0.094s) [65.033475] Starting dynamic subtest: vecs0 [65.132650] Dynamic subtest vecs0: SUCCESS (0.111s) [65.134125] Subtest basic-await: SUCCESS (0.412s) [65.883473] [024/171] (944s left) gem_exec_fence (nb-await) [66.146750] Starting subtest: nb-await [66.147972] Starting dynamic subtest: rcs0 [66.211972] Dynamic subtest rcs0: SUCCESS (0.064s) [66.228744] Starting dynamic subtest: bcs0 [66.291445] Dynamic subtest bcs0: SUCCESS (0.076s) [66.336872] Starting dynamic subtest: vcs0 [66.407158] Dynamic subtest vcs0: SUCCESS (0.115s) [66.448996] Starting dynamic subtest: vecs0 [66.513235] Dynamic subtest vecs0: SUCCESS (0.107s) [66.516731] Subtest nb-await: SUCCESS (0.364s) [67.274456] [025/171] (942s left) gem_exec_gttfill (basic) [67.398091] Starting subtest: basic [76.686291] Subtest basic: SUCCESS (9.280s) [76.874490] [026/171] (933s left) gem_exec_parallel (engines) [77.056691] Starting subtest: engines [77.057744] Starting dynamic subtest: basic [79.447338] Dynamic subtest basic: SUCCESS (2.391s) [79.456374] Starting dynamic subtest: contexts [82.478594] Dynamic subtest contexts: SUCCESS (3.022s) [82.486842] Starting dynamic subtest: fds [86.004889] Dynamic subtest fds: SUCCESS (3.535s) [86.014219] Starting dynamic subtest: userptr [88.401856] Dynamic subtest userptr: SUCCESS (2.397s) [88.402892] Subtest engines: SUCCESS (11.345s) [88.616141] [027/171] (921s left) gem_exec_store (basic) [88.739471] Starting subtest: basic [88.785531] Subtest basic: SUCCESS (0.046s) [89.012634] [028/171] (921s left) gem_flink_basic (bad-flink) [89.120103] Starting subtest: bad-flink [89.121082] Subtest bad-flink: SUCCESS (0.000s) [89.210478] [029/171] (921s left) gem_flink_basic (bad-open) [89.316108] Starting subtest: bad-open [89.317016] Subtest bad-open: SUCCESS (0.000s) [89.377135] [030/171] (920s left) gem_flink_basic (basic) [89.484819] Starting subtest: basic [89.485733] Subtest basic: SUCCESS (0.000s) [89.583136] [031/171] (920s left) gem_flink_basic (double-flink) [89.690487] Starting subtest: double-flink [89.691495] Subtest double-flink: SUCCESS (0.000s) [89.796154] [032/171] (920s left) gem_flink_basic (flink-lifetime) [89.903283] Starting subtest: flink-lifetime [89.904336] Subtest flink-lifetime: SUCCESS (0.001s) [90.007713] [033/171] (920s left) gem_huc_copy (huc-copy) [90.122052] Starting subtest: huc-copy [90.124227] Subtest huc-copy: SKIP (0.000s) [90.270319] [034/171] (920s left) gem_linear_blits (basic) [90.527197] Starting subtest: basic [90.536385] Subtest basic: SUCCESS (0.009s) [90.695723] [035/171] (919s left) gem_mmap (basic) [90.853431] Starting subtest: basic [90.858186] Subtest basic: SUCCESS (0.001s) [90.940564] [036/171] (919s left) gem_mmap_gtt (basic) [91.047148] Starting subtest: basic [91.048167] Subtest basic: SUCCESS (0.001s) [91.148116] [037/171] (919s left) gem_render_linear_blits (basic) [91.260634] Starting subtest: basic [91.301276] Subtest basic: SUCCESS (0.040s) [91.346347] [038/171] (919s left) gem_render_tiled_blits (basic) [91.461087] Starting subtest: basic [91.506445] Subtest basic: SUCCESS (0.045s) [91.546815] [039/171] (918s left) gem_ringfill (basic-all) [91.844202] Starting subtest: basic-all [93.013761] Subtest basic-all: SUCCESS (1.163s) [93.153973] [040/171] (917s left) gem_softpin (allocator-basic) [93.269359] Starting subtest: allocator-basic [93.406610] Subtest allocator-basic: SUCCESS (0.128s) [93.507486] [041/171] (916s left) gem_softpin (allocator-basic-reserve) [93.618064] Starting subtest: allocator-basic-reserve [93.756432] Subtest allocator-basic-reserve: SUCCESS (0.130s) [93.880828] [042/171] (916s left) gem_softpin (safe-alignment) [93.993356] Starting subtest: safe-alignment [94.010634] Subtest safe-alignment: SUCCESS (0.017s) [94.146428] [043/171] (916s left) gem_sync (basic-all) [94.269261] Starting subtest: basic-all [96.557903] Subtest basic-all: SUCCESS (2.273s) [96.772748] [044/171] (913s left) gem_sync (basic-each) [96.897176] Starting subtest: basic-each [99.101482] Subtest basic-each: SUCCESS (2.204s) [99.362105] [045/171] (911s left) gem_tiled_blits (basic) [99.623242] Starting subtest: basic [99.648251] Subtest basic: SUCCESS (0.025s) [99.808645] [046/171] (910s left) gem_tiled_fence_blits (basic) [100.121275] Starting subtest: basic [100.133474] Subtest basic: SUCCESS (0.013s) [100.286213] [047/171] (910s left) gem_tiled_pread_basic [100.665721] [048/171] (909s left) gem_wait (busy@all-engines) [100.793465] Starting subtest: busy [100.794502] Starting dynamic subtest: all-engines [101.318046] Dynamic subtest all-engines: SUCCESS (0.524s) [101.319473] Subtest busy: SUCCESS (0.524s) [101.572868] [049/171] (909s left) gem_wait (wait@all-engines) [101.702020] Starting subtest: wait [101.702971] Starting dynamic subtest: all-engines [102.756138] Dynamic subtest all-engines: SUCCESS (1.052s) [102.759725] Subtest wait: SUCCESS (1.052s) [103.041209] [050/171] (907s left) i915_getparams_basic (basic-eu-total) [103.147398] Starting subtest: basic-eu-total [103.149501] Subtest basic-eu-total: SUCCESS (0.000s) [103.239587] [051/171] (907s left) i915_getparams_basic (basic-subslice-total) [103.350158] Starting subtest: basic-subslice-total [103.352066] Subtest basic-subslice-total: SUCCESS (0.000s) [103.444666] [052/171] (907s left) i915_hangman (error-state-basic) [103.562394] Starting subtest: error-state-basic [103.572480] Subtest error-state-basic: SUCCESS (0.011s) [103.661445] [053/171] (907s left) i915_pciid [103.865934] [054/171] (906s left) kms_addfb_basic (addfb25-bad-modifier) [103.973429] Starting subtest: addfb25-bad-modifier [103.974302] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [104.150817] [055/171] (906s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [104.259401] Starting subtest: addfb25-framebuffer-vs-set-tiling [104.260411] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [104.402704] [056/171] (906s left) kms_addfb_basic (addfb25-modifier-no-flag) [104.505411] Starting subtest: addfb25-modifier-no-flag [104.506507] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [104.645339] [057/171] (906s left) kms_addfb_basic (addfb25-x-tiled-legacy) [104.750372] Starting subtest: addfb25-x-tiled-legacy [104.751405] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [104.884244] [058/171] (905s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [104.984722] Starting subtest: addfb25-x-tiled-mismatch-legacy [104.985666] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [105.121766] [059/171] (905s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [105.259563] Starting subtest: addfb25-yf-tiled-legacy [105.260555] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [105.356051] [060/171] (905s left) kms_addfb_basic (addfb25-y-tiled-legacy) [105.493629] Starting subtest: addfb25-y-tiled-legacy [105.494757] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [105.597134] [061/171] (905s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [105.734180] Starting subtest: addfb25-y-tiled-small-legacy [105.735167] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [105.828933] [062/171] (905s left) kms_addfb_basic (bad-pitch-0) [105.925506] Starting subtest: bad-pitch-0 [105.926507] Subtest bad-pitch-0: SUCCESS (0.000s) [106.065840] [063/171] (904s left) kms_addfb_basic (bad-pitch-1024) [106.164181] Starting subtest: bad-pitch-1024 [106.165147] Subtest bad-pitch-1024: SUCCESS (0.000s) [106.296993] [064/171] (904s left) kms_addfb_basic (bad-pitch-128) [106.395302] Starting subtest: bad-pitch-128 [106.396342] Subtest bad-pitch-128: SUCCESS (0.000s) [106.526439] [065/171] (904s left) kms_addfb_basic (bad-pitch-256) [106.625422] Starting subtest: bad-pitch-256 [106.626468] Subtest bad-pitch-256: SUCCESS (0.000s) [106.760755] [066/171] (904s left) kms_addfb_basic (bad-pitch-32) [106.860431] Starting subtest: bad-pitch-32 [106.861342] Subtest bad-pitch-32: SUCCESS (0.000s) [106.989456] [067/171] (904s left) kms_addfb_basic (bad-pitch-63) [107.087248] Starting subtest: bad-pitch-63 [107.088239] Subtest bad-pitch-63: SUCCESS (0.000s) [107.223036] [068/171] (903s left) kms_addfb_basic (bad-pitch-65536) [107.319214] Starting subtest: bad-pitch-65536 [107.320390] Subtest bad-pitch-65536: SUCCESS (0.000s) [107.453748] [069/171] (903s left) kms_addfb_basic (bad-pitch-999) [107.549389] Starting subtest: bad-pitch-999 [107.550382] Subtest bad-pitch-999: SUCCESS (0.000s) [107.686134] [070/171] (903s left) kms_addfb_basic (basic) [107.783497] Starting subtest: basic [107.784468] Subtest basic: SUCCESS (0.000s) [107.915906] [071/171] (903s left) kms_addfb_basic (basic-x-tiled-legacy) [108.013149] Starting subtest: basic-x-tiled-legacy [108.013997] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [108.155893] [072/171] (902s left) kms_addfb_basic (basic-y-tiled-legacy) [108.253170] Starting subtest: basic-y-tiled-legacy [108.254045] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [108.382484] [073/171] (902s left) kms_addfb_basic (bo-too-small) [108.511734] Starting subtest: bo-too-small [108.512789] Subtest bo-too-small: SUCCESS (0.000s) [108.604030] [074/171] (902s left) kms_addfb_basic (bo-too-small-due-to-tiling) [108.733924] Starting subtest: bo-too-small-due-to-tiling [108.734989] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [108.824368] [075/171] (902s left) kms_addfb_basic (clobberred-modifier) [108.920488] Starting subtest: clobberred-modifier [108.921457] Subtest clobberred-modifier: SUCCESS (0.000s) [109.055829] [076/171] (902s left) kms_addfb_basic (framebuffer-vs-set-tiling) [109.151984] Starting subtest: framebuffer-vs-set-tiling [109.152974] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [109.278730] [077/171] (901s left) kms_addfb_basic (invalid-get-prop) [109.374737] Starting subtest: invalid-get-prop [109.375792] Subtest invalid-get-prop: SUCCESS (0.000s) [109.510471] [078/171] (901s left) kms_addfb_basic (invalid-get-prop-any) [109.605222] Starting subtest: invalid-get-prop-any [109.606063] Subtest invalid-get-prop-any: SUCCESS (0.000s) [109.743409] [079/171] (901s left) kms_addfb_basic (invalid-set-prop) [109.838112] Starting subtest: invalid-set-prop [109.839142] Subtest invalid-set-prop: SUCCESS (0.000s) [109.976381] [080/171] (901s left) kms_addfb_basic (invalid-set-prop-any) [110.071572] Starting subtest: invalid-set-prop-any [110.072567] Subtest invalid-set-prop-any: SUCCESS (0.000s) [110.210439] [081/171] (901s left) kms_addfb_basic (no-handle) [110.305958] Starting subtest: no-handle [110.307071] Subtest no-handle: SUCCESS (0.000s) [110.452911] [082/171] (900s left) kms_addfb_basic (size-max) [110.583181] Starting subtest: size-max [110.584130] Subtest size-max: SUCCESS (0.000s) [110.680948] [083/171] (900s left) kms_addfb_basic (small-bo) [110.811437] Starting subtest: small-bo [110.812390] Subtest small-bo: SUCCESS (0.000s) [110.912199] [084/171] (900s left) kms_addfb_basic (tile-pitch-mismatch) [111.009163] Starting subtest: tile-pitch-mismatch [111.010085] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [111.146514] [085/171] (900s left) kms_addfb_basic (too-high) [111.277161] Starting subtest: too-high [111.278193] Subtest too-high: SUCCESS (0.001s) [111.380153] [086/171] (899s left) kms_addfb_basic (too-wide) [111.509310] Starting subtest: too-wide [111.510235] Subtest too-wide: SUCCESS (0.000s) [111.612095] [087/171] (899s left) kms_addfb_basic (unused-handle) [111.706866] Starting subtest: unused-handle [111.707959] Subtest unused-handle: SUCCESS (0.000s) [111.845542] [088/171] (899s left) kms_addfb_basic (unused-modifier) [111.941070] Starting subtest: unused-modifier [111.941918] Subtest unused-modifier: SUCCESS (0.000s) [112.077595] [089/171] (899s left) kms_addfb_basic (unused-offsets) [112.171732] Starting subtest: unused-offsets [112.172649] Subtest unused-offsets: SUCCESS (0.000s) [112.305810] [090/171] (899s left) kms_addfb_basic (unused-pitches) [112.400216] Starting subtest: unused-pitches [112.401184] Subtest unused-pitches: SUCCESS (0.000s) [112.540149] [091/171] (898s left) kms_busy (basic) [112.678019] Starting subtest: basic [112.680089] Starting dynamic subtest: flip [113.618808] Dynamic subtest flip: SUCCESS (0.936s) [113.636633] Starting dynamic subtest: modeset [117.352924] Dynamic subtest modeset: SUCCESS (3.735s) [117.354104] Subtest basic: SUCCESS (4.674s) [118.287732] [092/171] (893s left) kms_chamelium_hpd (dp-hpd-fast) [118.743752] Subtest dp-hpd-fast: SKIP (0.000s) [119.629051] [093/171] (891s left) kms_chamelium_edid (dp-edid-read) [120.085641] Subtest dp-edid-read: SKIP (0.000s) [120.971121] [094/171] (890s left) kms_chamelium_frames (dp-crc-fast) [121.427671] Subtest dp-crc-fast: SKIP (0.000s) [122.318922] [095/171] (889s left) kms_chamelium_hpd (hdmi-hpd-fast) [122.753285] Subtest hdmi-hpd-fast: SKIP (0.000s) [123.662985] [096/171] (887s left) kms_chamelium_edid (hdmi-edid-read) [124.100082] Subtest hdmi-edid-read: SKIP (0.000s) [125.003501] [097/171] (886s left) kms_chamelium_frames (hdmi-crc-fast) [125.460508] Subtest hdmi-crc-fast: SKIP (0.000s) [126.347819] [098/171] (885s left) kms_chamelium_hpd (vga-hpd-fast) [126.788166] Subtest vga-hpd-fast: SKIP (0.000s) [127.700487] [099/171] (883s left) kms_chamelium_edid (vga-edid-read) [128.155848] Subtest vga-edid-read: SKIP (0.000s) [129.041393] [100/171] (882s left) kms_prop_blob (basic) [129.156384] Starting subtest: basic [129.157335] Subtest basic: SUCCESS (0.000s) [129.243252] [101/171] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [129.396434] Starting subtest: basic-busy-flip-before-cursor-atomic [129.398417] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [129.478108] [102/171] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [129.620052] Starting subtest: basic-busy-flip-before-cursor-legacy [129.622039] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [129.705940] [103/171] (882s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [129.852261] Starting subtest: basic-flip-after-cursor-atomic [131.147221] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.293s) [132.089287] [104/171] (879s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [132.234481] Starting subtest: basic-flip-after-cursor-legacy [133.483489] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.248s) [134.396946] [105/171] (877s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [134.539417] Starting subtest: basic-flip-after-cursor-varying-size [135.809458] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.265s) [136.764978] [106/171] (875s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [136.908445] Starting subtest: basic-flip-before-cursor-atomic [138.229975] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.320s) [139.128275] [107/171] (872s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [139.272408] Starting subtest: basic-flip-before-cursor-legacy [140.628338] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.356s) [141.560809] [108/171] (870s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [141.704536] Starting subtest: basic-flip-before-cursor-varying-size [142.979405] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.272s) [143.870954] [109/171] (867s left) kms_flip (basic-flip-vs-dpms) [143.992920] Starting subtest: basic-flip-vs-dpms [143.998413] Starting dynamic subtest: A-eDP1 [146.800460] Dynamic subtest A-eDP1: SUCCESS (2.803s) [146.811342] Starting dynamic subtest: B-eDP1 [149.189398] Dynamic subtest B-eDP1: SUCCESS (2.386s) [149.201677] Starting dynamic subtest: C-eDP1 [151.531229] Dynamic subtest C-eDP1: SUCCESS (2.341s) [151.538037] Subtest basic-flip-vs-dpms: SUCCESS (7.543s) [152.433933] [110/171] (859s left) kms_flip (basic-flip-vs-modeset) [152.556111] Starting subtest: basic-flip-vs-modeset [152.560200] Starting dynamic subtest: A-eDP1 [155.382367] Dynamic subtest A-eDP1: SUCCESS (2.815s) [155.394980] Starting dynamic subtest: B-eDP1 [157.746115] Dynamic subtest B-eDP1: SUCCESS (2.366s) [157.756100] Starting dynamic subtest: C-eDP1 [160.099787] Dynamic subtest C-eDP1: SUCCESS (2.354s) [160.104022] Subtest basic-flip-vs-modeset: SUCCESS (7.548s) [161.020768] [111/171] (850s left) kms_flip (basic-flip-vs-wf_vblank) [161.142564] Starting subtest: basic-flip-vs-wf_vblank [161.148726] Starting dynamic subtest: A-eDP1 [163.414334] Dynamic subtest A-eDP1: SUCCESS (2.267s) [163.424459] Starting dynamic subtest: B-eDP1 [165.720849] Dynamic subtest B-eDP1: SUCCESS (2.305s) [165.737296] Starting dynamic subtest: C-eDP1 [167.957098] Dynamic subtest C-eDP1: SUCCESS (2.235s) [167.961613] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.819s) [169.283778] [112/171] (842s left) kms_flip (basic-plain-flip) [169.406653] Starting subtest: basic-plain-flip [169.411197] Starting dynamic subtest: A-eDP1 [171.463593] Dynamic subtest A-eDP1: SUCCESS (2.040s) [171.482545] Starting dynamic subtest: B-eDP1 [173.496182] Dynamic subtest B-eDP1: SUCCESS (2.038s) [173.506042] Starting dynamic subtest: C-eDP1 [175.497491] Dynamic subtest C-eDP1: SUCCESS (1.992s) [175.508307] Subtest basic-plain-flip: SUCCESS (6.101s) [176.832571] [113/171] (835s left) kms_force_connector_basic (force-connector-state) [176.971812] Starting subtest: force-connector-state [177.590521] Subtest force-connector-state: SUCCESS (0.620s) [178.647273] [114/171] (833s left) kms_force_connector_basic (force-edid) [178.781248] Starting subtest: force-edid [178.813617] Subtest force-edid: SUCCESS (0.033s) [178.991451] [115/171] (832s left) kms_force_connector_basic (force-load-detect) [179.125376] Starting subtest: force-load-detect [179.127358] Subtest force-load-detect: SKIP (0.000s) [179.276433] [116/171] (832s left) kms_force_connector_basic (prune-stale-modes) [179.405787] Starting subtest: prune-stale-modes [179.439500] Subtest prune-stale-modes: SUCCESS (0.033s) [179.615261] [117/171] (832s left) kms_frontbuffer_tracking (basic) [179.763072] Starting subtest: basic [182.653708] Subtest basic: SUCCESS (2.890s) [182.760132] [118/171] (829s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [182.897177] Starting subtest: compare-crc-sanitycheck-xr24 [182.899621] Starting dynamic subtest: pipe-A-eDP-1 [183.533815] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.634s) [183.545521] Starting dynamic subtest: pipe-B-eDP-1 [184.858655] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.320s) [184.869960] Starting dynamic subtest: pipe-C-eDP-1 [186.179870] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.318s) [186.180897] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.281s) [187.119121] [119/171] (824s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [187.253405] Starting subtest: compare-crc-sanitycheck-nv12 [187.254715] Starting dynamic subtest: pipe-A-eDP-1 [187.256630] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [187.267386] Starting dynamic subtest: pipe-B-eDP-1 [187.269220] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [187.279352] Starting dynamic subtest: pipe-C-eDP-1 [187.281367] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [187.283277] Subtest compare-crc-sanitycheck-nv12: SKIP (0.008s) [187.343253] [120/171] (824s left) kms_pipe_crc_basic (hang-read-crc) [187.476247] Starting subtest: hang-read-crc [187.477228] Starting dynamic subtest: pipe-A-eDP-1 [189.659159] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.176s) [189.671096] Starting dynamic subtest: pipe-B-eDP-1 [192.561601] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.901s) [192.583824] Starting dynamic subtest: pipe-C-eDP-1 [195.489567] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.922s) [195.490976] Subtest hang-read-crc: SUCCESS (8.012s) [196.412606] [121/171] (815s left) kms_pipe_crc_basic (nonblocking-crc) [196.559135] Starting subtest: nonblocking-crc [196.560412] Starting dynamic subtest: pipe-A-eDP-1 [197.343464] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.782s) [197.365050] Starting dynamic subtest: pipe-B-eDP-1 [198.892088] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.535s) [198.908337] Starting dynamic subtest: pipe-C-eDP-1 [200.404213] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.509s) [200.405313] Subtest nonblocking-crc: SUCCESS (3.845s) [201.339139] [122/171] (810s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [201.485447] Starting subtest: nonblocking-crc-frame-sequence [201.486465] Starting dynamic subtest: pipe-A-eDP-1 [202.265764] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.779s) [202.286644] Starting dynamic subtest: pipe-B-eDP-1 [203.817618] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.540s) [203.833847] Starting dynamic subtest: pipe-C-eDP-1 [205.337604] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.513s) [205.339498] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.849s) [206.265792] [123/171] (805s left) kms_pipe_crc_basic (read-crc) [206.413905] Starting subtest: read-crc [206.417229] Starting dynamic subtest: pipe-A-eDP-1 [207.153542] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.736s) [207.171068] Starting dynamic subtest: pipe-B-eDP-1 [208.649607] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.487s) [208.672470] Starting dynamic subtest: pipe-C-eDP-1 [210.097937] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.441s) [210.099881] Subtest read-crc: SUCCESS (3.682s) [211.006585] [124/171] (801s left) kms_pipe_crc_basic (read-crc-frame-sequence) [211.154528] Starting subtest: read-crc-frame-sequence [211.156093] Starting dynamic subtest: pipe-A-eDP-1 [211.899096] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.741s) [211.912777] Starting dynamic subtest: pipe-B-eDP-1 [213.352928] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.449s) [213.372261] Starting dynamic subtest: pipe-C-eDP-1 [214.824873] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.465s) [214.826580] Subtest read-crc-frame-sequence: SUCCESS (3.667s) [215.744547] [125/171] (796s left) kms_psr (primary_page_flip) [215.897578] Starting subtest: primary_page_flip [217.886427] Subtest primary_page_flip: SUCCESS (1.987s) [218.809080] [126/171] (793s left) kms_psr (cursor_plane_move) [218.957952] Starting subtest: cursor_plane_move [220.867810] Subtest cursor_plane_move: SUCCESS (1.908s) [221.818267] [127/171] (790s left) kms_psr (sprite_plane_onoff) [221.967122] Starting subtest: sprite_plane_onoff [223.980774] Subtest sprite_plane_onoff: SUCCESS (2.012s) [224.889345] [128/171] (787s left) kms_psr (primary_mmap_gtt) [225.037400] Starting subtest: primary_mmap_gtt [226.989322] Subtest primary_mmap_gtt: SUCCESS (1.951s) [227.894747] [129/171] (784s left) kms_setmode (basic-clone-single-crtc) [228.002882] Starting subtest: basic-clone-single-crtc [228.005456] Subtest basic-clone-single-crtc: SKIP (0.001s) [228.125848] [130/171] (784s left) i915_pm_backlight (basic-brightness) [228.286384] Starting subtest: basic-brightness [228.391176] Starting dynamic subtest: eDP-1 [229.000430] Dynamic subtest eDP-1: SUCCESS (0.608s) [229.002506] Subtest basic-brightness: SUCCESS (0.714s) [229.947739] [131/171] (782s left) i915_pm_rpm (basic-pci-d3-state) [241.827304] Starting subtest: basic-pci-d3-state [246.306368] Subtest basic-pci-d3-state: SUCCESS (4.475s) [246.402049] [132/171] (765s left) i915_pm_rpm (basic-rte) [246.505847] Starting subtest: basic-rte [262.755046] Subtest basic-rte: SUCCESS (16.248s) [267.825830] [133/171] (744s left) i915_pm_rps (basic-api) [267.940850] Starting subtest: basic-api [267.945889] Subtest basic-api: SUCCESS (0.005s) [268.035980] [134/171] (744s left) prime_self_import (basic-llseek-bad) [268.143255] Starting subtest: basic-llseek-bad [268.145701] Subtest basic-llseek-bad: SUCCESS (0.002s) [268.276182] [135/171] (744s left) prime_self_import (basic-llseek-size) [268.379341] Starting subtest: basic-llseek-size [268.383861] Subtest basic-llseek-size: SUCCESS (0.003s) [268.512247] [136/171] (743s left) prime_self_import (basic-with_fd_dup) [268.620602] Starting subtest: basic-with_fd_dup [268.622691] Subtest basic-with_fd_dup: SUCCESS (0.003s) [268.759078] [137/171] (743s left) prime_self_import (basic-with_one_bo) [268.860676] Starting subtest: basic-with_one_bo [268.865329] Subtest basic-with_one_bo: SUCCESS (0.003s) [268.936316] [138/171] (743s left) prime_self_import (basic-with_one_bo_two_files) [269.042257] Starting subtest: basic-with_one_bo_two_files [269.047073] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [269.152157] [139/171] (743s left) prime_self_import (basic-with_two_bos) [269.256312] Starting subtest: basic-with_two_bos [269.260986] Subtest basic-with_two_bos: SUCCESS (0.003s) [269.380901] [140/171] (743s left) prime_vgem (basic-fence-flip) [269.527855] Starting subtest: basic-fence-flip [270.019035] Subtest basic-fence-flip: SUCCESS (0.491s) [270.112332] [141/171] (742s left) prime_vgem (basic-fence-mmap) [270.227754] Starting subtest: basic-fence-mmap [270.263616] Subtest basic-fence-mmap: SUCCESS (0.036s) [270.353956] [142/171] (742s left) prime_vgem (basic-fence-read) [270.500274] Starting subtest: basic-fence-read [270.558081] Subtest basic-fence-read: SUCCESS (0.058s) [270.657911] [143/171] (741s left) prime_vgem (basic-gtt) [270.801106] Starting subtest: basic-gtt [270.816501] Subtest basic-gtt: SUCCESS (0.015s) [270.921604] [144/171] (741s left) prime_vgem (basic-read) [271.056881] Starting subtest: basic-read [271.082801] Subtest basic-read: SUCCESS (0.026s) [271.193191] [145/171] (741s left) prime_vgem (basic-write) [271.330158] Starting subtest: basic-write [271.359355] Subtest basic-write: SUCCESS (0.029s) [271.438527] [146/171] (741s left) vgem_basic (setversion) [271.578194] Starting subtest: setversion [271.580097] Subtest setversion: SUCCESS (0.000s) [271.640650] [147/171] (741s left) vgem_basic (create) [271.783840] Starting subtest: create [271.785086] Subtest create: SUCCESS (0.000s) [271.869318] [148/171] (740s left) vgem_basic (debugfs) [271.997050] Starting subtest: debugfs [271.998136] Subtest debugfs: SUCCESS (0.001s) [272.059028] [149/171] (740s left) vgem_basic (dmabuf-export) [272.202192] Starting subtest: dmabuf-export [272.204378] Subtest dmabuf-export: SUCCESS (0.002s) [272.314943] [150/171] (740s left) vgem_basic (dmabuf-fence) [272.442191] Starting subtest: dmabuf-fence [272.443225] Subtest dmabuf-fence: SUCCESS (0.001s) [272.504816] [151/171] (740s left) vgem_basic (dmabuf-fence-before) [272.647794] Starting subtest: dmabuf-fence-before [272.648888] Subtest dmabuf-fence-before: SUCCESS (0.000s) [272.718736] [152/171] (740s left) vgem_basic (dmabuf-mmap) [272.858155] Starting subtest: dmabuf-mmap [272.876956] Subtest dmabuf-mmap: SUCCESS (0.019s) [272.934424] [153/171] (739s left) vgem_basic (mmap) [273.040957] Starting subtest: mmap [273.053531] Subtest mmap: SUCCESS (0.012s) [273.121874] [154/171] (739s left) vgem_basic (second-client) [273.265928] Starting subtest: second-client [273.312964] Subtest second-client: SUCCESS (0.048s) [273.375978] [155/171] (739s left) vgem_basic (sysfs) [273.521776] Starting subtest: sysfs [273.522879] Subtest sysfs: SUCCESS (0.001s) [273.579974] [156/171] (739s left) core_hotunplug (unbind-rebind) [273.741767] Starting subtest: unbind-rebind [276.224688] Subtest unbind-rebind: SUCCESS (2.483s) [276.257071] [157/171] (736s left) vgem_basic (unload) [276.377531] Starting subtest: unload [305.412216] Subtest unload: SUCCESS (28.999s) [305.514828] [158/171] (707s left) i915_module_load (reload) [305.616428] Starting subtest: reload [309.154236] Subtest reload: SUCCESS (3.538s) [309.183279] [159/171] (703s left) gem_lmem_swapping (basic) [309.355673] Subtest basic: SKIP (0.000s) [309.394775] [160/171] (703s left) gem_lmem_swapping (parallel-random-engines) [309.505370] Subtest parallel-random-engines: SKIP (0.000s) [309.541145] [161/171] (703s left) gem_lmem_swapping (random-engines) [309.651908] Subtest random-engines: SKIP (0.000s) [309.692618] [162/171] (703s left) gem_lmem_swapping (verify-random) [309.803194] Subtest verify-random: SKIP (0.000s) [309.841610] [163/171] (703s left) i915_pm_rpm (module-reload) [322.314030] Starting subtest: module-reload [360.281150] Subtest module-reload: SUCCESS (37.961s) [360.321656] [164/171] (652s left) i915_selftest (live) [360.436416] Starting subtest: live [360.437491] Starting dynamic subtest: sanitycheck [362.083701] Dynamic subtest sanitycheck: SUCCESS (1.638s) [362.091615] Starting dynamic subtest: uncore [363.684573] Dynamic subtest uncore: SUCCESS (1.600s) [363.691917] Starting dynamic subtest: workarounds [365.492696] Dynamic subtest workarounds: SUCCESS (1.807s) [365.500361] Starting dynamic subtest: gt_engines [367.652678] Dynamic subtest gt_engines: SUCCESS (2.159s) [367.662376] Starting dynamic subtest: gt_timelines [377.613780] Dynamic subtest gt_timelines: SUCCESS (9.960s) [377.621710] Starting dynamic subtest: gt_contexts [379.376923] Dynamic subtest gt_contexts: SUCCESS (1.762s) [379.384893] Starting dynamic subtest: gt_lrc [383.533720] Dynamic subtest gt_lrc: SUCCESS (4.156s) [383.543378] Starting dynamic subtest: gt_mocs [385.318935] Dynamic subtest gt_mocs: SUCCESS (1.784s) [385.327888] Starting dynamic subtest: gt_pm [391.292693] Dynamic subtest gt_pm: SUCCESS (5.973s) [391.299990] Starting dynamic subtest: gt_heartbeat [393.060603] Dynamic subtest gt_heartbeat: SUCCESS (1.767s) [393.070414] Starting dynamic subtest: gt_tlb [395.506739] Dynamic subtest gt_tlb: SUCCESS (2.445s) [395.515299] Starting dynamic subtest: requests [402.976797] Dynamic subtest requests: SUCCESS (7.469s) [402.988023] Starting dynamic subtest: migrate [407.457697] Dynamic subtest migrate: SUCCESS (4.480s) [407.465926] Starting dynamic subtest: active [409.136758] Dynamic subtest active: SUCCESS (1.678s) [409.145027] Starting dynamic subtest: objects [411.945722] Dynamic subtest objects: SUCCESS (2.808s) [411.956439] Starting dynamic subtest: mman [417.100577] Dynamic subtest mman: SUCCESS (5.154s) [417.109859] Starting dynamic subtest: dmabuf [418.774709] Dynamic subtest dmabuf: SUCCESS (1.673s) [418.782310] Starting dynamic subtest: vma [420.373632] Dynamic subtest vma: SUCCESS (1.598s) [420.380949] Starting dynamic subtest: coherency [423.978668] Dynamic subtest coherency: SUCCESS (3.604s) [423.986062] Starting dynamic subtest: gtt [432.470867] Dynamic subtest gtt: SUCCESS (8.491s) [432.478919] Starting dynamic subtest: gem [434.402891] Dynamic subtest gem: SUCCESS (1.931s) [434.415561] Starting dynamic subtest: evict [437.617618] Dynamic subtest evict: SUCCESS (3.214s) [437.625536] Starting dynamic subtest: hugepages [443.620696] Dynamic subtest hugepages: SUCCESS (6.002s) [443.628836] Starting dynamic subtest: gem_contexts [458.190368] Dynamic subtest gem_contexts: SUCCESS (14.568s) [458.197787] Starting dynamic subtest: client [459.879950] Dynamic subtest client: SUCCESS (1.689s) [459.891726] Starting dynamic subtest: gem_migrate [461.529691] Dynamic subtest gem_migrate: SUCCESS (1.649s) [461.537154] Starting dynamic subtest: reset [463.838044] Dynamic subtest reset: SUCCESS (2.307s) [463.852586] Starting dynamic subtest: memory_region [465.508616] Dynamic subtest memory_region: SUCCESS (1.670s) [465.516381] Starting dynamic subtest: hangcheck [489.633685] Dynamic subtest hangcheck: SUCCESS (24.124s) [489.641092] Starting dynamic subtest: execlists [499.041695] Dynamic subtest execlists: SUCCESS (9.407s) [499.049055] Starting dynamic subtest: ring_submission [500.721733] Dynamic subtest ring_submission: SUCCESS (1.679s) [500.729170] Starting dynamic subtest: perf [502.582995] Dynamic subtest perf: SUCCESS (1.860s) [502.596241] Starting dynamic subtest: slpc [504.232692] Dynamic subtest slpc: SUCCESS (1.649s) [504.242657] Starting dynamic subtest: guc [505.898675] Dynamic subtest guc: SUCCESS (1.665s) [505.906093] Starting dynamic subtest: guc_multi_lrc [507.548709] Dynamic subtest guc_multi_lrc: SUCCESS (1.649s) [507.556362] Starting dynamic subtest: guc_hang [509.231871] Dynamic subtest guc_hang: SUCCESS (1.682s) [509.240344] Starting dynamic subtest: late_gt_pm [510.948769] Dynamic subtest late_gt_pm: SUCCESS (1.716s) [510.950068] Subtest live: SUCCESS (150.504s) [511.185779] [165/171] (501s left) dmabuf (all-tests) [511.311121] Starting subtest: all-tests [511.312370] Starting dynamic subtest: sanitycheck [511.384466] Dynamic subtest sanitycheck: SUCCESS (0.072s) [511.416100] Starting dynamic subtest: dma_fence [511.582778] Dynamic subtest dma_fence: SUCCESS (0.196s) [511.595786] Starting dynamic subtest: dma_fence_chain [527.710430] Dynamic subtest dma_fence_chain: SUCCESS (16.116s) [527.740598] Starting dynamic subtest: dma_fence_unwrap [527.777693] Dynamic subtest dma_fence_unwrap: SUCCESS (0.076s) [527.796328] Starting dynamic subtest: dma_resv [527.842407] Dynamic subtest dma_resv: SUCCESS (0.063s) [527.843520] Subtest all-tests: SUCCESS (16.531s) [527.869731] [166/171] (485s left) i915_suspend (basic-s2idle-without-i915) [527.979136] Starting subtest: basic-s2idle-without-i915 [547.845694] Subtest basic-s2idle-without-i915: SUCCESS (4.414s) [550.262360] [167/171] (480s left) i915_suspend (basic-s3-without-i915) [550.373269] Starting subtest: basic-s3-without-i915 [571.776491] Subtest basic-s3-without-i915: SUCCESS (4.665s) [574.149309] [168/171] (475s left) gem_exec_suspend (basic-s0) [574.310267] Starting subtest: basic-S0 [574.311350] Starting dynamic subtest: smem [592.866978] Dynamic subtest smem: SUCCESS (3.297s) [592.868021] Subtest basic-S0: SUCCESS (3.298s) [595.084040] [169/171] (471s left) gem_exec_suspend (basic-s3) [595.244883] Starting subtest: basic-S3 [595.245988] Starting dynamic subtest: smem [616.190645] Dynamic subtest smem: SUCCESS (4.695s) [616.191800] Subtest basic-S3: SUCCESS (4.696s) [618.489808] [170/171] (466s left) kms_chamelium_hpd (common-hpd-after-suspend) [618.943874] Subtest common-hpd-after-suspend: SKIP (0.000s) [619.869363] [171/171] (465s left) kms_pipe_crc_basic (suspend-read-crc) [620.014151] Starting subtest: suspend-read-crc [620.017707] Starting dynamic subtest: pipe-A-eDP-1 [640.186281] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.682s) [640.200163] Starting dynamic subtest: pipe-B-eDP-1 [671.072546] Dynamic subtest pipe-B-eDP-1: SUCCESS (14.277s) [671.089482] Starting dynamic subtest: pipe-C-eDP-1 [691.590346] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.717s) [691.591250] Subtest suspend-read-crc: SUCCESS (21.689s) [695.482847] Closing watchdogs Done.