#231 custom method tests do not pass
Closed 6 years ago Opened 6 years ago by clime.

With dev machines all upgraded to the latest package versions from master branch, some tests in copr-cli-basic-operation/runtest-custom-method.sh are failing. During the custom builds, there seems to be some problem:

INFO: Running in chroot: ['set -ex; chmod a+x /script; rm -rf /workdir; mkdir -p /workdir; chown mockbuild /workdir;']
Start: unpacking root cache
Finish: unpacking root cache
Start: chroot ['set -ex; chmod a+x /script; rm -rf /workdir; mkdir -p /workdir; chown mockbuild /workdir;']
+ chmod a+x /script
chmod: cannot access '/script': No such file or directory

Full build log is here: http://copr-be-dev.cloud.fedoraproject.org/results/dturecek/custom-1-TEST1519069386/srpm-builds/00652707/builder-live.log

Also this is quite strange:

:: [   FAIL   ] :: Command 'copr watch-build $BUILD_ID' (Expected 0, got 4)
:: [  BEGIN   ] :: Running 'copr download-build $BUILD_ID --dest $RESULTDIR'
--2018-02-19 19:45:14--  http://copr-be-dev.cloud.fedoraproject.org/results/dturecek/custom-1-TEST1519069386/fedora-rawhide-x86_64/
Resolving copr-be-dev.cloud.fedoraproject.org (copr-be-dev.cloud.fedoraproject.org)... 209.132.184.53
Connecting to copr-be-dev.cloud.fedoraproject.org (copr-be-dev.cloud.fedoraproject.org)|209.132.184.53|:80... connected.
HTTP request sent, awaiting response... 404 Not Found
2018-02-19 19:45:15 ERROR 404: Not Found.

And this:

:: [  BEGIN   ] :: Running 'FILES="success" check_resultdir quick-package-0-0'
./runtest-custom-method.sh: line 37: cd: /tmp/tmp.JCurChFMyL/fedora-rawhide-x86_64: No such file or directory

Full test log:

[root@test-env copr-cli-basic-operations]# ./runtest-custom-method.sh 

::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::
:: [   LOG    ] :: Test
::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::

:: [  BEGIN   ] :: Running 'export WORKDIR=`mktemp -d`'
:: [   PASS   ] :: Command 'export WORKDIR=`mktemp -d`' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'test -n "$WORKDIR"'
:: [   PASS   ] :: Command 'test -n "$WORKDIR"' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'cd "$WORKDIR"'
:: [   PASS   ] :: Command 'cd "$WORKDIR"' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'echo workdir: $WORKDIR'
workdir: /tmp/tmp.cK9g0H4hR9
:: [   PASS   ] :: Command 'echo workdir: $WORKDIR' (Expected 0, got 0)
:: [ 19:43:06 ] :: [ INFO    ] :: Create the project 
:: [  BEGIN   ] :: Running 'copr-cli create "$PROJECT" --chroot fedora-rawhide-x86_64'
New project was successfully created.
:: [   PASS   ] :: Command 'copr-cli create "$PROJECT" --chroot fedora-rawhide-x86_64' (Expected 0, got 0)
:: [ 19:43:08 ] :: [ INFO    ] :: Test add-package && build
:: [  BEGIN   ] :: Running 'cleanup_resultdir'
:: [   PASS   ] :: Command 'cleanup_resultdir' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'quick_package_script generate_specfile'
:: [   PASS   ] :: Command 'quick_package_script generate_specfile' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'copr add-package-custom "$PROJECT" \
        --name quick-package \
        --script script \
        --script-chroot fedora-rawhide-x86_64'
Create or edit operation was successful.
:: [   PASS   ] :: Command 'copr add-package-custom "$PROJECT" \
:: [   PASS   ] ::         --name quick-package \
:: [   PASS   ] ::         --script script \
:: [   PASS   ] ::         --script-chroot fedora-rawhide-x86_64' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'copr build-package "$PROJECT" --name quick-package --nowait'
Build was added to custom-1-TEST1519069386.
Created builds: 652699
:: [   PASS   ] :: Command 'copr build-package "$PROJECT" --name quick-package --nowait' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'parse_build_id'
:: [   PASS   ] :: Command 'parse_build_id' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'copr watch-build $BUILD_ID'
Watching build(s): (this may be safely interrupted)
  19:43:11 Build 652699: pending
  19:43:41 Build 652699: running
  19:45:13 Build 652699: failed

Build error: Build(s) 652699 failed.
:: [   FAIL   ] :: Command 'copr watch-build $BUILD_ID' (Expected 0, got 4)
:: [  BEGIN   ] :: Running 'copr download-build $BUILD_ID --dest $RESULTDIR'
--2018-02-19 19:45:14--  http://copr-be-dev.cloud.fedoraproject.org/results/dturecek/custom-1-TEST1519069386/fedora-rawhide-x86_64/
Resolving copr-be-dev.cloud.fedoraproject.org (copr-be-dev.cloud.fedoraproject.org)... 209.132.184.53
Connecting to copr-be-dev.cloud.fedoraproject.org (copr-be-dev.cloud.fedoraproject.org)|209.132.184.53|:80... connected.
HTTP request sent, awaiting response... 404 Not Found
2018-02-19 19:45:15 ERROR 404: Not Found.

:: [   PASS   ] :: Command 'copr download-build $BUILD_ID --dest $RESULTDIR' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'FILES="success" check_resultdir quick-package-0-0'
./runtest-custom-method.sh: line 37: cd: /tmp/tmp.JCurChFMyL/fedora-rawhide-x86_64: No such file or directory
:: [   FAIL   ] :: Command 'FILES="success" check_resultdir quick-package-0-0' (Expected 0, got 1)
:: [ 19:45:15 ] :: [ INFO    ] :: Test edit-package && --resultdir
:: [  BEGIN   ] :: Running 'cleanup_resultdir'
:: [   PASS   ] :: Command 'cleanup_resultdir' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'quick_package_script "DESTDIR=rrr generate_specfile"'
:: [   PASS   ] :: Command 'quick_package_script "DESTDIR=rrr generate_specfile"' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'copr edit-package-custom "$PROJECT" \
        --name quick-package \
        --script script \
        --script-chroot fedora-rawhide-x86_64'
Create or edit operation was successful.
:: [   PASS   ] :: Command 'copr edit-package-custom "$PROJECT" \
:: [   PASS   ] ::         --name quick-package \
:: [   PASS   ] ::         --script script \
:: [   PASS   ] ::         --script-chroot fedora-rawhide-x86_64' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'copr build-package "$PROJECT" --name quick-package --nowait'
Build was added to custom-1-TEST1519069386.
Created builds: 652700
:: [   PASS   ] :: Command 'copr build-package "$PROJECT" --name quick-package --nowait' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'parse_build_id'
:: [   PASS   ] :: Command 'parse_build_id' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'copr watch-build $BUILD_ID'
Watching build(s): (this may be safely interrupted)
  19:45:18 Build 652700: pending
  19:45:49 Build 652700: running
  19:47:20 Build 652700: failed

Build error: Build(s) 652700 failed.
:: [   PASS   ] :: Command 'copr watch-build $BUILD_ID' (Expected 4, got 4)
:: [  BEGIN   ] :: Running 'copr edit-package-custom "$PROJECT" \
        --name quick-package \
        --script script \
        --script-resultdir rrr \
        --script-chroot fedora-rawhide-x86_64'
Create or edit operation was successful.
:: [   PASS   ] :: Command 'copr edit-package-custom "$PROJECT" \
:: [   PASS   ] ::         --name quick-package \
:: [   PASS   ] ::         --script script \
:: [   PASS   ] ::         --script-resultdir rrr \
:: [   PASS   ] ::         --script-chroot fedora-rawhide-x86_64' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'copr build-package "$PROJECT" --name quick-package --nowait'
Build was added to custom-1-TEST1519069386.
Created builds: 652701
:: [   PASS   ] :: Command 'copr build-package "$PROJECT" --name quick-package --nowait' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'parse_build_id'
:: [   PASS   ] :: Command 'parse_build_id' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'copr watch-build $BUILD_ID'
Watching build(s): (this may be safely interrupted)
  19:47:23 Build 652701: pending
  19:47:54 Build 652701: running
  19:49:25 Build 652701: failed

Build error: Build(s) 652701 failed.
:: [   FAIL   ] :: Command 'copr watch-build $BUILD_ID' (Expected 0, got 4)
:: [  BEGIN   ] :: Running 'copr download-build $BUILD_ID --dest $RESULTDIR'
--2018-02-19 19:49:26--  http://copr-be-dev.cloud.fedoraproject.org/results/dturecek/custom-1-TEST1519069386/fedora-rawhide-x86_64/
Resolving copr-be-dev.cloud.fedoraproject.org (copr-be-dev.cloud.fedoraproject.org)... 209.132.184.53
Connecting to copr-be-dev.cloud.fedoraproject.org (copr-be-dev.cloud.fedoraproject.org)|209.132.184.53|:80... connected.
HTTP request sent, awaiting response... 404 Not Found
2018-02-19 19:49:26 ERROR 404: Not Found.

:: [   PASS   ] :: Command 'copr download-build $BUILD_ID --dest $RESULTDIR' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'FILES="success" check_resultdir quick-package-0-0'
./runtest-custom-method.sh: line 37: cd: /tmp/tmp.JCurChFMyL/fedora-rawhide-x86_64: No such file or directory
:: [   FAIL   ] :: Command 'FILES="success" check_resultdir quick-package-0-0' (Expected 0, got 1)
:: [ 19:49:26 ] :: [ INFO    ] :: Test that builddeps get propagated
:: [  BEGIN   ] :: Running 'cleanup_resultdir'
:: [   PASS   ] :: Command 'cleanup_resultdir' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'quick_package_script "BUILDDEPS=xxx generate_specfile"'
:: [   PASS   ] :: Command 'quick_package_script "BUILDDEPS=xxx generate_specfile"' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'copr edit-package-custom "$PROJECT" \
        --name quick-package \
        --script script \
        --script-builddeps "$builddeps" \
        --script-chroot fedora-rawhide-x86_64'
Create or edit operation was successful.
:: [   PASS   ] :: Command 'copr edit-package-custom "$PROJECT" \
:: [   PASS   ] ::         --name quick-package \
:: [   PASS   ] ::         --script script \
:: [   PASS   ] ::         --script-builddeps "$builddeps" \
:: [   PASS   ] ::         --script-chroot fedora-rawhide-x86_64' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'copr build-package "$PROJECT" --name quick-package --nowait'
Build was added to custom-1-TEST1519069386.
Created builds: 652702
:: [   PASS   ] :: Command 'copr build-package "$PROJECT" --name quick-package --nowait' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'parse_build_id'
:: [   PASS   ] :: Command 'parse_build_id' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'copr watch-build $BUILD_ID'
Watching build(s): (this may be safely interrupted)
  19:49:30 Build 652702: pending
  19:50:00 Build 652702: running
  19:52:02 Build 652702: failed

Build error: Build(s) 652702 failed.
:: [   PASS   ] :: Command 'copr watch-build $BUILD_ID' (Expected 4, got 4)
:: [  BEGIN   ] :: Running 'quick_package_script "BUILDDEPS=\"$builddeps\" generate_specfile"'
:: [   PASS   ] :: Command 'quick_package_script "BUILDDEPS=\"$builddeps\" generate_specfile"' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'copr edit-package-custom "$PROJECT" \
        --name quick-package \
        --script script \
        --script-builddeps "$builddeps" \
        --script-chroot fedora-rawhide-x86_64'
Create or edit operation was successful.
:: [   PASS   ] :: Command 'copr edit-package-custom "$PROJECT" \
:: [   PASS   ] ::         --name quick-package \
:: [   PASS   ] ::         --script script \
:: [   PASS   ] ::         --script-builddeps "$builddeps" \
:: [   PASS   ] ::         --script-chroot fedora-rawhide-x86_64' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'copr build-package "$PROJECT" --name quick-package --nowait'
Build was added to custom-1-TEST1519069386.
Created builds: 652703
:: [   PASS   ] :: Command 'copr build-package "$PROJECT" --name quick-package --nowait' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'parse_build_id'
:: [   PASS   ] :: Command 'parse_build_id' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'copr watch-build $BUILD_ID'
Watching build(s): (this may be safely interrupted)
  19:52:05 Build 652703: starting
  19:52:35 Build 652703: running
  19:54:37 Build 652703: failed

Build error: Build(s) 652703 failed.
:: [   FAIL   ] :: Command 'copr watch-build $BUILD_ID' (Expected 0, got 4)
:: [  BEGIN   ] :: Running 'copr download-build $BUILD_ID --dest $RESULTDIR'
--2018-02-19 19:54:38--  http://copr-be-dev.cloud.fedoraproject.org/results/dturecek/custom-1-TEST1519069386/fedora-rawhide-x86_64/
Resolving copr-be-dev.cloud.fedoraproject.org (copr-be-dev.cloud.fedoraproject.org)... 209.132.184.53
Connecting to copr-be-dev.cloud.fedoraproject.org (copr-be-dev.cloud.fedoraproject.org)|209.132.184.53|:80... connected.
HTTP request sent, awaiting response... 404 Not Found
2018-02-19 19:54:38 ERROR 404: Not Found.

:: [   PASS   ] :: Command 'copr download-build $BUILD_ID --dest $RESULTDIR' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'FILES="success" check_resultdir quick-package-0-0'
./runtest-custom-method.sh: line 37: cd: /tmp/tmp.JCurChFMyL/fedora-rawhide-x86_64: No such file or directory
:: [   FAIL   ] :: Command 'FILES="success" check_resultdir quick-package-0-0' (Expected 0, got 1)
:: [ 19:54:39 ] :: [ INFO    ] :: check that hook_payload get's created
:: [  BEGIN   ] :: Running 'cleanup_resultdir'
:: [   PASS   ] :: Command 'cleanup_resultdir' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'quick_package_script "HOOK_PAYLOAD=: generate_specfile"'
:: [   PASS   ] :: Command 'quick_package_script "HOOK_PAYLOAD=: generate_specfile"' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'copr edit-package-custom "$PROJECT" \
        --name quick-package \
        --script script \
        --script-chroot fedora-rawhide-x86_64 \
        --webhook-rebuild on'
Create or edit operation was successful.
:: [   PASS   ] :: Command 'copr edit-package-custom "$PROJECT" \
:: [   PASS   ] ::         --name quick-package \
:: [   PASS   ] ::         --script script \
:: [   PASS   ] ::         --script-chroot fedora-rawhide-x86_64 \
:: [   PASS   ] ::         --webhook-rebuild on' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'copr build-package "$PROJECT" --name quick-package --nowait'
Build was added to custom-1-TEST1519069386.
Created builds: 652704
:: [   PASS   ] :: Command 'copr build-package "$PROJECT" --name quick-package --nowait' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'parse_build_id'
:: [   PASS   ] :: Command 'parse_build_id' (Expected 0, got 0)
:: [ 19:54:41 ] :: [ INFO    ] :: Still should fail, since this build is not triggered by webhook.
:: [  BEGIN   ] :: Running 'copr watch-build $BUILD_ID'
Watching build(s): (this may be safely interrupted)
  19:54:42 Build 652704: pending
  19:55:12 Build 652704: running
  19:56:44 Build 652704: failed

Build error: Build(s) 652704 failed.
:: [   PASS   ] :: Command 'copr watch-build $BUILD_ID' (Expected 4, got 4)
:: [  BEGIN   ] :: Running 'curl -I "$trigger_url"'
  % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
                                 Dload  Upload   Total   Spent    Left  Speed
  0   178    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0
HTTP/1.1 405 METHOD NOT ALLOWED
Date: Mon, 19 Feb 2018 19:56:43 GMT
Server: Apache/2.4.29 (Fedora) OpenSSL/1.1.0g-fips mod_wsgi/4.5.15 Python/3.6
Content-Length: 178
Allow: OPTIONS, POST
Content-Type: text/html; charset=UTF-8

:: [   PASS   ] :: Command 'curl -I "$trigger_url"' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'check_http_status 405'
HTTP/1.1 405 METHOD NOT ALLOWED
:: [   PASS   ] :: Command 'check_http_status 405' (Expected 0, got 0)
:: [ 19:56:44 ] :: [ INFO    ] :: full cmd would be: curl -X POST  -H "Content-Type: application/json"  --data '{"a": "b"}' http://copr-fe-dev.cloud.fedoraproject.org/webhooks/custom//webhook_secret/quick-package/
:: [  BEGIN   ] :: Running 'build_id=$(curl -X POST  --data '{"a": "b"}' "http://copr-fe-dev.cloud.fedoraproject.org/webhooks/custom//webhook_secret/quick-package/")'
  % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
                                 Dload  Upload   Total   Spent    Left  Speed
100  7545  100  7535  100    10   7535     10  0:00:01  0:00:01 --:--:--  5351
:: [   PASS   ] :: Command 'build_id=$(curl -X POST  --data '{"a": "b"}' "http://copr-fe-dev.cloud.fedoraproject.org/webhooks/custom//webhook_secret/quick-package/")' (Expected 0, got 0)
:: [ 19:56:46 ] :: [ INFO    ] :: Still fails since the POST data are not json
:: [  BEGIN   ] :: Running 'copr watch-build $BUILD_ID'
Watching build(s): (this may be safely interrupted)
  19:56:47 Build 652704: failed

Build error: Build(s) 652704 failed.
:: [   PASS   ] :: Command 'copr watch-build $BUILD_ID' (Expected 4, got 4)
:: [ 19:56:47 ] :: [ INFO    ] :: Still fails since the POST data are not json
:: [  BEGIN   ] :: Running 'build_id=$(curl -X POST  -H "Content-Type: application/json"  --data '{"a": "b"}' "http://copr-fe-dev.cloud.fedoraproject.org/webhooks/custom//webhook_secret/quick-package/")'
  % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
                                 Dload  Upload   Total   Spent    Left  Speed
100  7545  100  7535  100    10   7535     10  0:00:01 --:--:--  0:00:01 20173
:: [   PASS   ] :: Command 'build_id=$(curl -X POST  -H "Content-Type: application/json"  --data '{"a": "b"}' "http://copr-fe-dev.cloud.fedoraproject.org/webhooks/custom//webhook_secret/quick-package/")' (Expected 0, got 0)
:: [ 19:56:47 ] :: [ INFO    ] :: Should succeed finally
:: [ 19:56:47 ] :: [ INFO    ] :: basic buildcustom command, with fedora-latest-x86_64 chroot (default)
:: [  BEGIN   ] :: Running 'cleanup_resultdir'
:: [   PASS   ] :: Command 'cleanup_resultdir' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'quick_package_script "generate_specfile"'
:: [   PASS   ] :: Command 'quick_package_script "generate_specfile"' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'copr buildcustom custom-1-TEST1519069386 --script script --nowait'
Build was added to custom-1-TEST1519069386:
  http://copr-fe-dev.cloud.fedoraproject.org/coprs/build/652705/
Created builds: 652705
:: [   PASS   ] :: Command 'copr buildcustom custom-1-TEST1519069386 --script script --nowait' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'parse_build_id'
:: [   PASS   ] :: Command 'parse_build_id' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'copr watch-build $BUILD_ID'
Watching build(s): (this may be safely interrupted)
  19:56:50 Build 652705: pending
  19:57:20 Build 652705: running
  19:58:51 Build 652705: failed

Build error: Build(s) 652705 failed.
:: [   FAIL   ] :: Command 'copr watch-build $BUILD_ID' (Expected 0, got 4)
:: [  BEGIN   ] :: Running 'copr download-build $BUILD_ID --dest $RESULTDIR'
--2018-02-19 19:58:52--  http://copr-be-dev.cloud.fedoraproject.org/results/dturecek/custom-1-TEST1519069386/fedora-rawhide-x86_64/
Resolving copr-be-dev.cloud.fedoraproject.org (copr-be-dev.cloud.fedoraproject.org)... 209.132.184.53
Connecting to copr-be-dev.cloud.fedoraproject.org (copr-be-dev.cloud.fedoraproject.org)|209.132.184.53|:80... connected.
HTTP request sent, awaiting response... 404 Not Found
2018-02-19 19:58:53 ERROR 404: Not Found.

:: [   PASS   ] :: Command 'copr download-build $BUILD_ID --dest $RESULTDIR' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'FILES="success" check_resultdir quick-package-0-0'
./runtest-custom-method.sh: line 37: cd: /tmp/tmp.JCurChFMyL/fedora-rawhide-x86_64: No such file or directory
:: [   FAIL   ] :: Command 'FILES="success" check_resultdir quick-package-0-0' (Expected 0, got 1)
:: [ 19:58:53 ] :: [ INFO    ] :: buildcustom with --builddeps
:: [  BEGIN   ] :: Running 'cleanup_resultdir'
:: [   PASS   ] :: Command 'cleanup_resultdir' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'quick_package_script 'BUILDDEPS="postgresql-devel" generate_specfile''
:: [   PASS   ] :: Command 'quick_package_script 'BUILDDEPS="postgresql-devel" generate_specfile'' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'copr buildcustom custom-1-TEST1519069386 --script script --script-builddeps "postgresql-devel" --nowait'
Build was added to custom-1-TEST1519069386:
  http://copr-fe-dev.cloud.fedoraproject.org/coprs/build/652706/
Created builds: 652706
:: [   PASS   ] :: Command 'copr buildcustom custom-1-TEST1519069386 --script script --script-builddeps "postgresql-devel" --nowait' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'parse_build_id'
:: [   PASS   ] :: Command 'parse_build_id' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'copr watch-build $BUILD_ID'
Watching build(s): (this may be safely interrupted)
  19:58:55 Build 652706: pending
  19:59:26 Build 652706: running
  20:01:27 Build 652706: failed

Build error: Build(s) 652706 failed.
:: [   FAIL   ] :: Command 'copr watch-build $BUILD_ID' (Expected 0, got 4)
:: [  BEGIN   ] :: Running 'copr download-build $BUILD_ID --dest $RESULTDIR'
--2018-02-19 20:01:28--  http://copr-be-dev.cloud.fedoraproject.org/results/dturecek/custom-1-TEST1519069386/fedora-rawhide-x86_64/
Resolving copr-be-dev.cloud.fedoraproject.org (copr-be-dev.cloud.fedoraproject.org)... 209.132.184.53
Connecting to copr-be-dev.cloud.fedoraproject.org (copr-be-dev.cloud.fedoraproject.org)|209.132.184.53|:80... connected.
HTTP request sent, awaiting response... 404 Not Found
2018-02-19 20:01:29 ERROR 404: Not Found.

:: [   PASS   ] :: Command 'copr download-build $BUILD_ID --dest $RESULTDIR' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'FILES="success" check_resultdir quick-package-0-0'
./runtest-custom-method.sh: line 37: cd: /tmp/tmp.JCurChFMyL/fedora-rawhide-x86_64: No such file or directory
:: [   FAIL   ] :: Command 'FILES="success" check_resultdir quick-package-0-0' (Expected 0, got 1)
:: [ 20:01:29 ] :: [ INFO    ] :: buildcustom with --builddeps and --resultdir
:: [  BEGIN   ] :: Running 'cleanup_resultdir'
:: [   PASS   ] :: Command 'cleanup_resultdir' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'quick_package_script 'BUILDDEPS="postgresql-devel" DESTDIR=abc generate_specfile''
:: [   PASS   ] :: Command 'quick_package_script 'BUILDDEPS="postgresql-devel" DESTDIR=abc generate_specfile'' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'copr buildcustom custom-1-TEST1519069386 --script script --script-resultdir=abc --script-builddeps "postgresql-devel" --nowait'
Build was added to custom-1-TEST1519069386:
  http://copr-fe-dev.cloud.fedoraproject.org/coprs/build/652707/
Created builds: 652707
:: [   PASS   ] :: Command 'copr buildcustom custom-1-TEST1519069386 --script script --script-resultdir=abc --script-builddeps "postgresql-devel" --nowait' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'parse_build_id'
:: [   PASS   ] :: Command 'parse_build_id' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'copr watch-build $BUILD_ID'
Watching build(s): (this may be safely interrupted)
  20:01:31 Build 652707: pending
  20:02:02 Build 652707: running
  20:04:03 Build 652707: failed

Build error: Build(s) 652707 failed.
:: [   FAIL   ] :: Command 'copr watch-build $BUILD_ID' (Expected 0, got 4)
:: [  BEGIN   ] :: Running 'copr download-build $BUILD_ID --dest $RESULTDIR'
--2018-02-19 20:04:05--  http://copr-be-dev.cloud.fedoraproject.org/results/dturecek/custom-1-TEST1519069386/fedora-rawhide-x86_64/
Resolving copr-be-dev.cloud.fedoraproject.org (copr-be-dev.cloud.fedoraproject.org)... 209.132.184.53
Connecting to copr-be-dev.cloud.fedoraproject.org (copr-be-dev.cloud.fedoraproject.org)|209.132.184.53|:80... connected.
HTTP request sent, awaiting response... 404 Not Found
2018-02-19 20:04:05 ERROR 404: Not Found.

:: [   PASS   ] :: Command 'copr download-build $BUILD_ID --dest $RESULTDIR' (Expected 0, got 0)
:: [  BEGIN   ] :: Running 'FILES="success" check_resultdir quick-package-0-0'
./runtest-custom-method.sh: line 37: cd: /tmp/tmp.JCurChFMyL/fedora-rawhide-x86_64: No such file or directory
:: [   FAIL   ] :: Command 'FILES="success" check_resultdir quick-package-0-0' (Expected 0, got 1)
:: [ 20:04:06 ] :: JOURNAL XML: /var/tmp/beakerlib-oL0XFPg/journal.xml
:: [ 20:04:06 ] :: JOURNAL TXT: /var/tmp/beakerlib-oL0XFPg/journal.txt

Strange, I run them against my docker environment and all tests passed.

I could also find this in copr-frontend error log:

 [SQL: 'SELECT "user".id AS user_id, "user".username AS user_username, "user".mail AS user_mail, "user".timezone AS user_timezone, "user".proven AS user_proven, "user".admin AS user_admin, "user".proxy AS user_proxy, "user".api_login AS user_api_login, "user".api_token AS user_api_token, "user".api_token_expiration AS user_api_token_expiration, "user".openid_groups AS user_openid_groups, copr.id AS copr_id, copr.name AS copr_name, copr.homepage AS copr_homepage, copr.contact AS copr_contact, copr.repos AS copr_repos, copr.created_on AS copr_created_on, copr.description AS copr_description, copr.instructions AS copr_instructions, copr.deleted AS copr_deleted, copr.playground AS copr_playground, copr.auto_createrepo AS copr_auto_createrepo, copr.user_id AS copr_user_id, copr.group_id AS copr_group_id, copr.forked_from_id AS copr_forked_from_id, copr.webhook_secret AS copr_webhook_secret, copr.build_enable_net AS copr_build_enable_net, copr.unlisted_on_hp AS copr_unlisted_on_hp, copr.latest_indexed_data_update AS copr_latest_indexed_data_update, copr.persistent AS copr_persistent, copr.auto_prune AS copr_auto_prune, copr.use_bootstrap_container AS copr_use_bootstrap_container, copr.follow_fedora_branching AS copr_follow_fedora_branching \nFROM copr JOIN "user" ON "user".id = copr.user_id \nWHERE copr.deleted = false AND copr.id = %(id_1)s ORDER BY copr.created_on DESC'] [parameters: {'id_1': 'webhook_secret'}]
2018-02-19 19:56:46,754 [ERROR][/usr/lib/python3.6/site-packages/flask/app.py:1587|app:log_exception] Exception on /webhooks/custom/webhook_secret/quick-package/ [POST]
Traceback (most recent call last):
  File "/usr/lib64/python3.6/site-packages/sqlalchemy/engine/base.py", line 1182, in _execute_context
    context)
  File "/usr/lib64/python3.6/site-packages/sqlalchemy/engine/default.py", line 470, in do_execute
    cursor.execute(statement, parameters)
psycopg2.DataError: invalid input syntax for integer: "webhook_secret"
LINE 3: WHERE copr.deleted = false AND copr.id = 'webhook_secret' OR...

Is it possible that we are missing some migration? copr-fe-dev db seems to be on head, however. But this is only an error related to custom webhook.

Seems like "webhook_secret" is not set to some default value, right? It somewhat
got removed from tests when moved from Regression to Sanity.

From the build log:

...
...
INFO:__main__:running command: mock -r /var/lib/copr-rpmbuild/results/tmpsfhmp7fx/mock-config.cfg --shell 'cat - > /script'
... later in the log ...
INFO:__main__:running command: mock -r /var/lib/copr-rpmbuild/results/tmpsfhmp7fx/mock-config.cfg --chroot 'set -ex; chmod a+x /script; rm -rf /workdir; mkdir -p /workdir; chown mockbuild /workdir;'
... later in the log ...
+ chmod a+x /script
chmod: cannot access '/script': No such file or directory

Is mock cleaning the buildroot?

Metadata Update from @praiskup:
- Issue status updated to: Closed (was: Open)

6 years ago

Login to comment on this ticket.

Metadata