builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-005 starttime: 1504030345.05 results: success (0) revision: e336d84fc1d2d1fde7387dd5f86fe06fa59abe10 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-29 11:12:25.052286) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-29 11:12:25.052752) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-29 11:12:25.053049) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-29 11:12:25.073472) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 11:12:25.073899) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-29 11:12:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 212M=0s 2017-08-29 11:12:25 (212 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126133 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 11:12:25.221298) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 11:12:25.221620) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023174 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 11:12:25.282544) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 11:12:25.282896) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e336d84fc1d2d1fde7387dd5f86fe06fa59abe10 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev e336d84fc1d2d1fde7387dd5f86fe06fa59abe10 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-29 11:12:25,369 truncating revision to first 12 chars 2017-08-29 11:12:25,369 Setting DEBUG logging. 2017-08-29 11:12:25,369 attempt 1/10 2017-08-29 11:12:25,369 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e336d84fc1d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-29 11:12:25,770 unpacking tar archive at: mozilla-central-e336d84fc1d2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.709462 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 11:12:26.010372) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-29 11:12:26.010678) ========= script_repo_revision: e336d84fc1d2d1fde7387dd5f86fe06fa59abe10 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-29 11:12:26.014221) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-29 11:12:26.014528) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-29 11:12:26.025991) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-29 11:12:26.026423) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:12:26 INFO - MultiFileLogger online at 20170829 11:12:26 in /builds/slave/test 11:12:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:12:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:12:26 INFO - {'append_to_log': False, 11:12:26 INFO - 'base_work_dir': '/builds/slave/test', 11:12:26 INFO - 'blob_upload_branch': 'Firefox', 11:12:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:12:26 INFO - 'branch': 'Firefox', 11:12:26 INFO - 'buildbot_json_path': 'buildprops.json', 11:12:26 INFO - 'code_coverage': False, 11:12:26 INFO - 'config_files': ('talos/linux_config.py',), 11:12:26 INFO - 'default_actions': ('clobber', 11:12:26 INFO - 'read-buildbot-config', 11:12:26 INFO - 'download-and-extract', 11:12:26 INFO - 'populate-webroot', 11:12:26 INFO - 'create-virtualenv', 11:12:26 INFO - 'install', 11:12:26 INFO - 'setup-mitmproxy', 11:12:26 INFO - 'run-tests'), 11:12:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:12:26 INFO - 'disable_ccov_upload': False, 11:12:26 INFO - 'download_minidump_stackwalk': True, 11:12:26 INFO - 'download_symbols': 'ondemand', 11:12:26 INFO - 'enable_stylo': False, 11:12:26 INFO - 'enable_webrender': False, 11:12:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:12:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:12:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:12:26 INFO - 'gecko_profile': False, 11:12:26 INFO - 'gecko_profile_interval': 0, 11:12:26 INFO - 'installer_path': 'installer.exe', 11:12:26 INFO - 'log_level': 'info', 11:12:26 INFO - 'log_name': 'talos', 11:12:26 INFO - 'log_to_console': True, 11:12:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:12:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:12:26 INFO - 'opt_config_files': (), 11:12:26 INFO - 'pip_index': False, 11:12:26 INFO - 'suite': 'dromaeojs-e10s', 11:12:26 INFO - 'system_bits': '32', 11:12:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:12:26 INFO - 'title': 'talos-linux64-ix-005', 11:12:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:12:26 INFO - 'use_talos_json': True, 11:12:26 INFO - 'verify': 'False', 11:12:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:12:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:12:26 INFO - 'work_dir': 'build'} 11:12:26 INFO - [mozharness: 2017-08-29 18:12:26.257210Z] Running clobber step. 11:12:26 INFO - Running pre-action listener: _resource_record_pre_action 11:12:26 INFO - Running main action method: clobber 11:12:26 INFO - rmtree: /builds/slave/test/build 11:12:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:12:27 INFO - Running post-action listener: _resource_record_post_action 11:12:27 INFO - [mozharness: 2017-08-29 18:12:27.796071Z] Finished clobber step (success) 11:12:27 INFO - [mozharness: 2017-08-29 18:12:27.796169Z] Running read-buildbot-config step. 11:12:27 INFO - Running pre-action listener: _resource_record_pre_action 11:12:27 INFO - Running main action method: read_buildbot_config 11:12:27 INFO - Using buildbot properties: 11:12:27 INFO - { 11:12:27 INFO - "project": "", 11:12:27 INFO - "product": "firefox", 11:12:27 INFO - "who": "ffxbld@noreply.mozilla.org", 11:12:27 INFO - "installer_path": "public/build/target.tar.bz2", 11:12:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 11:12:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:12:27 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 11:12:27 INFO - "stage_platform": "linux64-stylosequential", 11:12:27 INFO - "basedir": "/builds/slave/test", 11:12:27 INFO - "buildnumber": 216, 11:12:27 INFO - "platform": "ubuntu64_hw_styloseq", 11:12:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:12:27 INFO - "slavebuilddir": "test", 11:12:27 INFO - "taskId": "arvCRhNASYutRgOD9zsdAQ", 11:12:27 INFO - "branch": "mozilla-central", 11:12:27 INFO - "script_repo_revision": "production", 11:12:27 INFO - "revision": "e336d84fc1d2d1fde7387dd5f86fe06fa59abe10", 11:12:27 INFO - "slavename": "talos-linux64-ix-005", 11:12:27 INFO - "repo_path": "mozilla-central" 11:12:27 INFO - } 11:12:27 INFO - Finding installer, test and symbols from parent task. 11:12:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/arvCRhNASYutRgOD9zsdAQ'}, attempt #1 11:12:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/arvCRhNASYutRgOD9zsdAQ'}, attempt #1 11:12:28 INFO - Task dependencies: J1Wwa5wdSOSum0rQh28Tpg 11:12:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg'}, attempt #1 11:12:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.tar.bz2 11:12:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.test_packages.json 11:12:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.crashreporter-symbols.zip 11:12:29 INFO - Running post-action listener: _resource_record_post_action 11:12:29 INFO - [mozharness: 2017-08-29 18:12:29.338355Z] Finished read-buildbot-config step (success) 11:12:29 INFO - [mozharness: 2017-08-29 18:12:29.338573Z] Running download-and-extract step. 11:12:29 INFO - Running pre-action listener: _resource_record_pre_action 11:12:29 INFO - Running main action method: download_and_extract 11:12:29 INFO - mkdir: /builds/slave/test/build/tests 11:12:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:29 INFO - trying https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.test_packages.json 11:12:29 INFO - Downloading https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:12:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:12:29 INFO - Downloaded 989 bytes. 11:12:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:12:29 INFO - Using the following test package requirements: 11:12:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:12:29 INFO - u'common': [u'target.common.tests.zip'], 11:12:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:12:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:12:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:12:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:12:29 INFO - u'mozbase': [u'target.common.tests.zip'], 11:12:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:12:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:12:29 INFO - u'web-platform': [u'target.common.tests.zip', 11:12:29 INFO - u'target.web-platform.tests.tar.gz'], 11:12:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:12:29 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:12:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.common.tests.zip 11:12:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:12:29 INFO - Fetch https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.common.tests.zip into memory 11:12:31 INFO - Content-Length response header: 54977655 11:12:31 INFO - Bytes received: 54977655 11:12:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:12:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.common.tests.zip 11:12:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:12:42 INFO - Fetch https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.common.tests.zip into memory 11:12:43 INFO - Content-Length response header: 54977655 11:12:43 INFO - Bytes received: 54977655 11:12:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.talos.tests.zip 11:12:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:12:55 INFO - Fetch https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.talos.tests.zip into memory 11:12:56 INFO - Content-Length response header: 14496611 11:12:56 INFO - Bytes received: 14496611 11:12:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:56 INFO - trying https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.tar.bz2 11:12:56 INFO - Downloading https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:12:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:12:57 INFO - Downloaded 61283835 bytes. 11:12:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.tar.bz2 11:12:57 INFO - mkdir: /builds/slave/test/properties 11:12:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:12:57 INFO - Writing to file /builds/slave/test/properties/build_url 11:12:57 INFO - Contents: 11:12:57 INFO - build_url:https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.tar.bz2 11:12:57 INFO - Running post-action listener: _resource_record_post_action 11:12:57 INFO - Running post-action listener: find_tests_for_verification 11:12:57 INFO - Running post-action listener: set_extra_try_arguments 11:12:57 INFO - [mozharness: 2017-08-29 18:12:57.995246Z] Finished download-and-extract step (success) 11:12:57 INFO - [mozharness: 2017-08-29 18:12:57.995365Z] Running populate-webroot step. 11:12:57 INFO - Running pre-action listener: _resource_record_pre_action 11:12:57 INFO - Running main action method: populate_webroot 11:12:58 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:12:58 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 11:12:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:12:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:12:58 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 11:12:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:12:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:12:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:58 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:12:58 INFO - 'talos_options': ['--stylo'], 11:12:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:12:58 INFO - 'tests': ['damp', 'tps']}, 11:12:58 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:12:58 INFO - 'talos_options': ['--stylo'], 11:12:58 INFO - 'tests': ['damp', 'tps']}, 11:12:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:12:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:12:58 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 11:12:58 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:12:58 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:12:58 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:12:58 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:12:58 INFO - 'talos_options': ['--stylo'], 11:12:58 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:12:58 INFO - 'other-e10s': {'tests': ['a11yr', 11:12:58 INFO - 'ts_paint', 11:12:58 INFO - 'tpaint', 11:12:58 INFO - 'sessionrestore', 11:12:58 INFO - 'sessionrestore_many_windows', 11:12:58 INFO - 'sessionrestore_no_auto_restore', 11:12:58 INFO - 'tabpaint']}, 11:12:58 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 11:12:58 INFO - 'tests': ['a11yr', 11:12:58 INFO - 'ts_paint', 11:12:58 INFO - 'tpaint', 11:12:58 INFO - 'sessionrestore', 11:12:58 INFO - 'sessionrestore_many_windows', 11:12:58 INFO - 'sessionrestore_no_auto_restore', 11:12:58 INFO - 'tabpaint']}, 11:12:58 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:12:58 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:12:58 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 11:12:58 INFO - 'tests': ['bloom_basic_singleton']}, 11:12:58 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 11:12:58 INFO - 'tests': ['bloom_basic']}, 11:12:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:12:58 INFO - 'tsvgr_opacity', 11:12:58 INFO - 'tart', 11:12:58 INFO - 'tscrollx', 11:12:58 INFO - 'tsvg_static']}, 11:12:58 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 11:12:58 INFO - 'tests': ['tsvgx', 11:12:58 INFO - 'tsvgr_opacity', 11:12:58 INFO - 'tart', 11:12:58 INFO - 'tscrollx', 11:12:58 INFO - 'tsvg_static']}, 11:12:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:12:58 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:12:58 INFO - 'talos_options': ['--stylo'], 11:12:58 INFO - 'tests': ['tp5o']}, 11:12:58 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:12:58 INFO - 'talos_options': ['--mitmproxy', 11:12:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:12:58 INFO - '--firstNonBlankPaint'], 11:12:58 INFO - 'tests': ['tp6_google', 11:12:58 INFO - 'tp6_youtube', 11:12:58 INFO - 'tp6_amazon', 11:12:58 INFO - 'tp6_facebook']}, 11:12:58 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:12:58 INFO - 'talos_options': ['--stylo', 11:12:58 INFO - '--mitmproxy', 11:12:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:12:58 INFO - '--firstNonBlankPaint'], 11:12:58 INFO - 'tests': ['tp6_google', 11:12:58 INFO - 'tp6_youtube', 11:12:58 INFO - 'tp6_amazon', 11:12:58 INFO - 'tp6_facebook']}, 11:12:58 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:12:58 INFO - 'talos_options': ['--stylo', 11:12:58 INFO - '--stylo-threads=1', 11:12:58 INFO - '--mitmproxy', 11:12:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:12:58 INFO - '--firstNonBlankPaint'], 11:12:58 INFO - 'tests': ['tp6_google', 11:12:58 INFO - 'tp6_youtube', 11:12:58 INFO - 'tp6_amazon', 11:12:58 INFO - 'tp6_facebook']}, 11:12:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:12:58 INFO - 'talos_options': ['--xperf_path', 11:12:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:58 INFO - 'tests': ['tp5n']}, 11:12:58 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:12:58 INFO - 'talos_options': ['--stylo', 11:12:58 INFO - '--xperf_path', 11:12:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:58 INFO - 'tests': ['tp5n']}}} 11:12:58 INFO - Running post-action listener: _resource_record_post_action 11:12:58 INFO - [mozharness: 2017-08-29 18:12:58.009688Z] Finished populate-webroot step (success) 11:12:58 INFO - [mozharness: 2017-08-29 18:12:58.009778Z] Running create-virtualenv step. 11:12:58 INFO - Running pre-action listener: _resource_record_pre_action 11:12:58 INFO - Running main action method: create_virtualenv 11:12:58 INFO - Creating virtualenv /builds/slave/test/build/venv 11:12:58 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:12:58 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:12:58 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:12:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:12:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:12:58 INFO - Installing distribute.............................................................................................................................................................................................done. 11:12:58 INFO - Installing pip...............done. 11:12:58 INFO - Return code: 0 11:12:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:12:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:12:58 INFO - Reading from file tmpfile_stdout 11:12:58 INFO - Output received: 11:12:58 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:12:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2561f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255f130>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25604c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:12:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:12:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:12:58 INFO - Using env: {'DISPLAY': ':0', 11:12:58 INFO - 'HOME': '/home/cltbld', 11:12:58 INFO - 'LANG': 'en_US.UTF-8', 11:12:58 INFO - 'LANGUAGE': 'en_US:en', 11:12:58 INFO - 'LOGNAME': 'cltbld', 11:12:58 INFO - 'MAIL': '/var/mail/cltbld', 11:12:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:59 INFO - 'MOZ_NO_REMOTE': '1', 11:12:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:59 INFO - 'NO_EM_RESTART': '1', 11:12:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:59 INFO - 'PWD': '/builds/slave/test', 11:12:59 INFO - 'SHELL': '/bin/bash', 11:12:59 INFO - 'SHLVL': '1', 11:12:59 INFO - 'TERM': 'linux', 11:12:59 INFO - 'TMOUT': '86400', 11:12:59 INFO - 'USER': 'cltbld', 11:12:59 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491', 11:12:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:59 INFO - '_': '/tools/buildbot/bin/python'} 11:13:00 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:13:00 INFO - Downloading/unpacking pip>=1.5 11:13:00 INFO - Running setup.py egg_info for package pip 11:13:00 INFO - warning: no files found matching 'pip/cacert.pem' 11:13:00 INFO - warning: no files found matching '*.html' under directory 'docs' 11:13:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:13:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:13:00 INFO - Installing collected packages: pip 11:13:00 INFO - Found existing installation: pip 1.1 11:13:00 INFO - Uninstalling pip: 11:13:00 INFO - Successfully uninstalled pip 11:13:00 INFO - Running setup.py install for pip 11:13:00 INFO - warning: no files found matching 'pip/cacert.pem' 11:13:00 INFO - warning: no files found matching '*.html' under directory 'docs' 11:13:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:13:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:13:00 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:13:00 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:13:00 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:13:00 INFO - Successfully installed pip 11:13:00 INFO - Cleaning up... 11:13:00 INFO - Return code: 0 11:13:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2561f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255f130>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25604c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:13:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:13:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:13:00 INFO - Using env: {'DISPLAY': ':0', 11:13:00 INFO - 'HOME': '/home/cltbld', 11:13:00 INFO - 'LANG': 'en_US.UTF-8', 11:13:00 INFO - 'LANGUAGE': 'en_US:en', 11:13:00 INFO - 'LOGNAME': 'cltbld', 11:13:00 INFO - 'MAIL': '/var/mail/cltbld', 11:13:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:00 INFO - 'MOZ_NO_REMOTE': '1', 11:13:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:00 INFO - 'NO_EM_RESTART': '1', 11:13:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:00 INFO - 'PWD': '/builds/slave/test', 11:13:00 INFO - 'SHELL': '/bin/bash', 11:13:00 INFO - 'SHLVL': '1', 11:13:00 INFO - 'TERM': 'linux', 11:13:00 INFO - 'TMOUT': '86400', 11:13:00 INFO - 'USER': 'cltbld', 11:13:00 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491', 11:13:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:00 INFO - '_': '/tools/buildbot/bin/python'} 11:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:00 INFO - Downloading/unpacking psutil>=3.1.1 11:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:13:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:01 INFO - Installing collected packages: psutil 11:13:01 INFO - Running setup.py install for psutil 11:13:01 INFO - building 'psutil._psutil_linux' extension 11:13:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:13:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:13:01 INFO - building 'psutil._psutil_posix' extension 11:13:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:13:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:13:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:02 INFO - Successfully installed psutil 11:13:02 INFO - Cleaning up... 11:13:02 INFO - Return code: 0 11:13:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:13:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2561f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255f130>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25604c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:13:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:13:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:13:02 INFO - Using env: {'DISPLAY': ':0', 11:13:02 INFO - 'HOME': '/home/cltbld', 11:13:02 INFO - 'LANG': 'en_US.UTF-8', 11:13:02 INFO - 'LANGUAGE': 'en_US:en', 11:13:02 INFO - 'LOGNAME': 'cltbld', 11:13:02 INFO - 'MAIL': '/var/mail/cltbld', 11:13:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:02 INFO - 'MOZ_NO_REMOTE': '1', 11:13:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:02 INFO - 'NO_EM_RESTART': '1', 11:13:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:02 INFO - 'PWD': '/builds/slave/test', 11:13:02 INFO - 'SHELL': '/bin/bash', 11:13:02 INFO - 'SHLVL': '1', 11:13:02 INFO - 'TERM': 'linux', 11:13:02 INFO - 'TMOUT': '86400', 11:13:02 INFO - 'USER': 'cltbld', 11:13:02 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491', 11:13:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:02 INFO - '_': '/tools/buildbot/bin/python'} 11:13:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:13:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:13:03 INFO - Installing collected packages: mozsystemmonitor 11:13:03 INFO - Running setup.py install for mozsystemmonitor 11:13:03 INFO - Successfully installed mozsystemmonitor 11:13:03 INFO - Cleaning up... 11:13:03 INFO - Return code: 0 11:13:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2561f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255f130>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25604c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:13:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:13:03 INFO - Using env: {'DISPLAY': ':0', 11:13:03 INFO - 'HOME': '/home/cltbld', 11:13:03 INFO - 'LANG': 'en_US.UTF-8', 11:13:03 INFO - 'LANGUAGE': 'en_US:en', 11:13:03 INFO - 'LOGNAME': 'cltbld', 11:13:03 INFO - 'MAIL': '/var/mail/cltbld', 11:13:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:03 INFO - 'MOZ_NO_REMOTE': '1', 11:13:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:03 INFO - 'NO_EM_RESTART': '1', 11:13:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:03 INFO - 'PWD': '/builds/slave/test', 11:13:03 INFO - 'SHELL': '/bin/bash', 11:13:03 INFO - 'SHLVL': '1', 11:13:03 INFO - 'TERM': 'linux', 11:13:03 INFO - 'TMOUT': '86400', 11:13:03 INFO - 'USER': 'cltbld', 11:13:03 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491', 11:13:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:03 INFO - '_': '/tools/buildbot/bin/python'} 11:13:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:03 INFO - Downloading/unpacking jsonschema==2.5.1 11:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:13:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:05 INFO - Downloading functools32-3.2.3-2.tar.gz 11:13:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:13:05 INFO - warning: no files found matching '*.txt' 11:13:05 INFO - no previously-included directories found matching 'build' 11:13:05 INFO - no previously-included directories found matching 'dist' 11:13:05 INFO - no previously-included directories found matching '.git*' 11:13:05 INFO - Installing collected packages: jsonschema, functools32 11:13:05 INFO - Running setup.py install for functools32 11:13:05 INFO - warning: no files found matching '*.txt' 11:13:05 INFO - no previously-included directories found matching 'build' 11:13:05 INFO - no previously-included directories found matching 'dist' 11:13:05 INFO - no previously-included directories found matching '.git*' 11:13:05 INFO - Successfully installed jsonschema functools32 11:13:05 INFO - Cleaning up... 11:13:05 INFO - Return code: 0 11:13:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2561f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255f130>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25604c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:13:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:13:05 INFO - Using env: {'DISPLAY': ':0', 11:13:05 INFO - 'HOME': '/home/cltbld', 11:13:05 INFO - 'LANG': 'en_US.UTF-8', 11:13:05 INFO - 'LANGUAGE': 'en_US:en', 11:13:05 INFO - 'LOGNAME': 'cltbld', 11:13:05 INFO - 'MAIL': '/var/mail/cltbld', 11:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:05 INFO - 'MOZ_NO_REMOTE': '1', 11:13:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:05 INFO - 'NO_EM_RESTART': '1', 11:13:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:05 INFO - 'PWD': '/builds/slave/test', 11:13:05 INFO - 'SHELL': '/bin/bash', 11:13:05 INFO - 'SHLVL': '1', 11:13:05 INFO - 'TERM': 'linux', 11:13:05 INFO - 'TMOUT': '86400', 11:13:05 INFO - 'USER': 'cltbld', 11:13:05 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491', 11:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:05 INFO - '_': '/tools/buildbot/bin/python'} 11:13:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:13:05 INFO - Cleaning up... 11:13:05 INFO - Return code: 0 11:13:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2561f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255f130>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25604c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:13:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:13:05 INFO - Using env: {'DISPLAY': ':0', 11:13:05 INFO - 'HOME': '/home/cltbld', 11:13:05 INFO - 'LANG': 'en_US.UTF-8', 11:13:05 INFO - 'LANGUAGE': 'en_US:en', 11:13:05 INFO - 'LOGNAME': 'cltbld', 11:13:05 INFO - 'MAIL': '/var/mail/cltbld', 11:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:05 INFO - 'MOZ_NO_REMOTE': '1', 11:13:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:05 INFO - 'NO_EM_RESTART': '1', 11:13:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:05 INFO - 'PWD': '/builds/slave/test', 11:13:05 INFO - 'SHELL': '/bin/bash', 11:13:05 INFO - 'SHLVL': '1', 11:13:05 INFO - 'TERM': 'linux', 11:13:05 INFO - 'TMOUT': '86400', 11:13:05 INFO - 'USER': 'cltbld', 11:13:05 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491', 11:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:05 INFO - '_': '/tools/buildbot/bin/python'} 11:13:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:05 INFO - Downloading/unpacking blobuploader==1.2.4 11:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:06 INFO - Downloading blobuploader-1.2.4.tar.gz 11:13:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:13:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:13:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:07 INFO - Downloading docopt-0.6.1.tar.gz 11:13:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:13:07 INFO - Installing collected packages: blobuploader, requests, docopt 11:13:07 INFO - Running setup.py install for blobuploader 11:13:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:13:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:13:07 INFO - Running setup.py install for requests 11:13:07 INFO - Running setup.py install for docopt 11:13:08 INFO - Successfully installed blobuploader requests docopt 11:13:08 INFO - Cleaning up... 11:13:08 INFO - Return code: 0 11:13:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2561f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255f130>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25604c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:13:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:13:08 INFO - Using env: {'DISPLAY': ':0', 11:13:08 INFO - 'HOME': '/home/cltbld', 11:13:08 INFO - 'LANG': 'en_US.UTF-8', 11:13:08 INFO - 'LANGUAGE': 'en_US:en', 11:13:08 INFO - 'LOGNAME': 'cltbld', 11:13:08 INFO - 'MAIL': '/var/mail/cltbld', 11:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:08 INFO - 'MOZ_NO_REMOTE': '1', 11:13:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:08 INFO - 'NO_EM_RESTART': '1', 11:13:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:08 INFO - 'PWD': '/builds/slave/test', 11:13:08 INFO - 'SHELL': '/bin/bash', 11:13:08 INFO - 'SHLVL': '1', 11:13:08 INFO - 'TERM': 'linux', 11:13:08 INFO - 'TMOUT': '86400', 11:13:08 INFO - 'USER': 'cltbld', 11:13:08 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491', 11:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:08 INFO - '_': '/tools/buildbot/bin/python'} 11:13:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:13:08 INFO - Running setup.py (path:/tmp/pip-qtdJXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:13:08 INFO - Running setup.py (path:/tmp/pip-mBBObz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:13:08 INFO - Running setup.py (path:/tmp/pip-DR_rwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:13:08 INFO - Running setup.py (path:/tmp/pip-t34Hzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:13:08 INFO - Running setup.py (path:/tmp/pip-elMGt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:13:08 INFO - Running setup.py (path:/tmp/pip-nDZ9gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:13:08 INFO - Running setup.py (path:/tmp/pip-UHxh3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:13:08 INFO - Running setup.py (path:/tmp/pip-ohCi_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:13:08 INFO - Running setup.py (path:/tmp/pip-F7Ar3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:13:08 INFO - Running setup.py (path:/tmp/pip-vrVIZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:13:08 INFO - Running setup.py (path:/tmp/pip-3xd9RF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:13:09 INFO - Running setup.py (path:/tmp/pip-dS4Ue_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:13:09 INFO - Running setup.py (path:/tmp/pip-l5cA6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:13:09 INFO - Running setup.py (path:/tmp/pip-LOHXt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:09 INFO - Running setup.py (path:/tmp/pip-QB3bOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:13:09 INFO - Running setup.py (path:/tmp/pip-b6elUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:13:09 INFO - Running setup.py (path:/tmp/pip-G3fi0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:13:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:13:09 INFO - Running setup.py install for manifestparser 11:13:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:13:09 INFO - Running setup.py install for mozcrash 11:13:09 INFO - Running setup.py install for mozdebug 11:13:09 INFO - Running setup.py install for mozdevice 11:13:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:13:09 INFO - Running setup.py install for mozfile 11:13:09 INFO - Running setup.py install for mozhttpd 11:13:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:13:10 INFO - Running setup.py install for mozinfo 11:13:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:13:10 INFO - Running setup.py install for mozInstall 11:13:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:13:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:13:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:13:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:13:10 INFO - Running setup.py install for mozleak 11:13:10 INFO - Running setup.py install for mozlog 11:13:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:13:10 INFO - Running setup.py install for moznetwork 11:13:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:13:10 INFO - Running setup.py install for mozprocess 11:13:10 INFO - Running setup.py install for mozprofile 11:13:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:13:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:13:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:13:10 INFO - Running setup.py install for mozrunner 11:13:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:13:10 INFO - Running setup.py install for mozscreenshot 11:13:11 INFO - Running setup.py install for moztest 11:13:11 INFO - Running setup.py install for mozversion 11:13:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:13:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:13:11 INFO - Cleaning up... 11:13:11 INFO - Return code: 0 11:13:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2561f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255f130>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25604c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:13:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:13:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:13:11 INFO - Using env: {'DISPLAY': ':0', 11:13:11 INFO - 'HOME': '/home/cltbld', 11:13:11 INFO - 'LANG': 'en_US.UTF-8', 11:13:11 INFO - 'LANGUAGE': 'en_US:en', 11:13:11 INFO - 'LOGNAME': 'cltbld', 11:13:11 INFO - 'MAIL': '/var/mail/cltbld', 11:13:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:11 INFO - 'MOZ_NO_REMOTE': '1', 11:13:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:11 INFO - 'NO_EM_RESTART': '1', 11:13:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:11 INFO - 'PWD': '/builds/slave/test', 11:13:11 INFO - 'SHELL': '/bin/bash', 11:13:11 INFO - 'SHLVL': '1', 11:13:11 INFO - 'TERM': 'linux', 11:13:11 INFO - 'TMOUT': '86400', 11:13:11 INFO - 'USER': 'cltbld', 11:13:11 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491', 11:13:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:11 INFO - '_': '/tools/buildbot/bin/python'} 11:13:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:13:11 INFO - Running setup.py (path:/tmp/pip-awswae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:13:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:13:11 INFO - Running setup.py (path:/tmp/pip-ZkQwrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:13:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:13:11 INFO - Running setup.py (path:/tmp/pip-VuffsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:13:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:13:11 INFO - Running setup.py (path:/tmp/pip-uDEFEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:13:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:13:11 INFO - Running setup.py (path:/tmp/pip-vIeKTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:13:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:13:11 INFO - Running setup.py (path:/tmp/pip-ttJT8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:13:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:13:11 INFO - Running setup.py (path:/tmp/pip-kBfIJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:13:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:13:11 INFO - Running setup.py (path:/tmp/pip-IQ_wGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:13:12 INFO - Running setup.py (path:/tmp/pip-EqzzXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:13:12 INFO - Running setup.py (path:/tmp/pip-RBxYkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:13:12 INFO - Running setup.py (path:/tmp/pip-QWyH9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:13:12 INFO - Running setup.py (path:/tmp/pip-kWPJxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:13:12 INFO - Running setup.py (path:/tmp/pip-xJ7x3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:13:12 INFO - Running setup.py (path:/tmp/pip-sEAWKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:12 INFO - Running setup.py (path:/tmp/pip-IWjHEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:13:12 INFO - Running setup.py (path:/tmp/pip-_Lvfm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:13:12 INFO - Running setup.py (path:/tmp/pip-mwatd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:13:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:13 INFO - Downloading blessings-1.6.tar.gz 11:13:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:13:13 INFO - Installing collected packages: blessings 11:13:13 INFO - Running setup.py install for blessings 11:13:13 INFO - Successfully installed blessings 11:13:13 INFO - Cleaning up... 11:13:13 INFO - Return code: 0 11:13:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:13:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:13:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:13:14 INFO - Reading from file tmpfile_stdout 11:13:14 INFO - Current package versions: 11:13:14 INFO - argparse == 1.2.1 11:13:14 INFO - blessings == 1.6 11:13:14 INFO - blobuploader == 1.2.4 11:13:14 INFO - docopt == 0.6.1 11:13:14 INFO - functools32 == 3.2.3-2 11:13:14 INFO - jsonschema == 2.5.1 11:13:14 INFO - manifestparser == 1.1 11:13:14 INFO - mozInstall == 1.13 11:13:14 INFO - mozcrash == 1.0 11:13:14 INFO - mozdebug == 0.1 11:13:14 INFO - mozdevice == 0.51 11:13:14 INFO - mozfile == 1.2 11:13:14 INFO - mozhttpd == 0.7 11:13:14 INFO - mozinfo == 0.10 11:13:14 INFO - mozleak == 0.1 11:13:14 INFO - mozlog == 3.5 11:13:14 INFO - moznetwork == 0.27 11:13:14 INFO - mozprocess == 0.25 11:13:14 INFO - mozprofile == 0.28 11:13:14 INFO - mozrunner == 6.13 11:13:14 INFO - mozscreenshot == 0.1 11:13:14 INFO - mozsystemmonitor == 0.3 11:13:14 INFO - moztest == 0.8 11:13:14 INFO - mozversion == 1.4 11:13:14 INFO - psutil == 3.1.1 11:13:14 INFO - requests == 1.2.3 11:13:14 INFO - wsgiref == 0.1.2 11:13:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2561f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255f130>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25604c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:13:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:13:14 INFO - Using env: {'DISPLAY': ':0', 11:13:14 INFO - 'HOME': '/home/cltbld', 11:13:14 INFO - 'LANG': 'en_US.UTF-8', 11:13:14 INFO - 'LANGUAGE': 'en_US:en', 11:13:14 INFO - 'LOGNAME': 'cltbld', 11:13:14 INFO - 'MAIL': '/var/mail/cltbld', 11:13:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:14 INFO - 'MOZ_NO_REMOTE': '1', 11:13:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:14 INFO - 'NO_EM_RESTART': '1', 11:13:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:14 INFO - 'PWD': '/builds/slave/test', 11:13:14 INFO - 'SHELL': '/bin/bash', 11:13:14 INFO - 'SHLVL': '1', 11:13:14 INFO - 'TERM': 'linux', 11:13:14 INFO - 'TMOUT': '86400', 11:13:14 INFO - 'USER': 'cltbld', 11:13:14 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491', 11:13:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:14 INFO - '_': '/tools/buildbot/bin/python'} 11:13:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:13:14 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:13:15 INFO - Installing collected packages: simplejson 11:13:15 INFO - Running setup.py install for simplejson 11:13:15 INFO - building 'simplejson._speedups' extension 11:13:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:13:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:13:16 INFO - Successfully installed simplejson 11:13:16 INFO - Cleaning up... 11:13:16 INFO - Return code: 0 11:13:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2561f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255f130>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25604c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:13:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:13:16 INFO - Using env: {'DISPLAY': ':0', 11:13:16 INFO - 'HOME': '/home/cltbld', 11:13:16 INFO - 'LANG': 'en_US.UTF-8', 11:13:16 INFO - 'LANGUAGE': 'en_US:en', 11:13:16 INFO - 'LOGNAME': 'cltbld', 11:13:16 INFO - 'MAIL': '/var/mail/cltbld', 11:13:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:16 INFO - 'MOZ_NO_REMOTE': '1', 11:13:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:16 INFO - 'NO_EM_RESTART': '1', 11:13:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:16 INFO - 'PWD': '/builds/slave/test', 11:13:16 INFO - 'SHELL': '/bin/bash', 11:13:16 INFO - 'SHLVL': '1', 11:13:16 INFO - 'TERM': 'linux', 11:13:16 INFO - 'TMOUT': '86400', 11:13:16 INFO - 'USER': 'cltbld', 11:13:16 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491', 11:13:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:16 INFO - '_': '/tools/buildbot/bin/python'} 11:13:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:13:16 INFO - Cleaning up... 11:13:16 INFO - Return code: 0 11:13:16 INFO - Running post-action listener: _resource_record_post_action 11:13:16 INFO - Running post-action listener: _start_resource_monitoring 11:13:16 INFO - Starting resource monitoring. 11:13:16 INFO - [mozharness: 2017-08-29 18:13:16.861328Z] Finished create-virtualenv step (success) 11:13:16 INFO - [mozharness: 2017-08-29 18:13:16.861857Z] Running install step. 11:13:16 INFO - Running pre-action listener: _resource_record_pre_action 11:13:16 INFO - Running main action method: install 11:13:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:13:17 INFO - Reading from file tmpfile_stdout 11:13:17 INFO - Detecting whether we're running mozinstall >=1.0... 11:13:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:13:17 INFO - Reading from file tmpfile_stdout 11:13:17 INFO - Output received: 11:13:17 INFO - Usage: mozinstall [options] installer 11:13:17 INFO - Options: 11:13:17 INFO - -h, --help show this help message and exit 11:13:17 INFO - -d DEST, --destination=DEST 11:13:17 INFO - Directory to install application into. [default: 11:13:17 INFO - "/builds/slave/test"] 11:13:17 INFO - --app=APP Application being installed. [default: firefox] 11:13:17 INFO - mkdir: /builds/slave/test/build/application 11:13:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:13:34 INFO - Reading from file tmpfile_stdout 11:13:34 INFO - Output received: 11:13:34 INFO - /builds/slave/test/build/application/firefox/firefox 11:13:34 INFO - Running post-action listener: _resource_record_post_action 11:13:34 INFO - [mozharness: 2017-08-29 18:13:34.912106Z] Finished install step (success) 11:13:34 INFO - [mozharness: 2017-08-29 18:13:34.912357Z] Running setup-mitmproxy step. 11:13:34 INFO - Running pre-action listener: _resource_record_pre_action 11:13:34 INFO - Running main action method: setup_mitmproxy 11:13:34 INFO - Skipping: mitmproxy is not required 11:13:34 INFO - Running post-action listener: _resource_record_post_action 11:13:34 INFO - [mozharness: 2017-08-29 18:13:34.913481Z] Finished setup-mitmproxy step (success) 11:13:34 INFO - [mozharness: 2017-08-29 18:13:34.913701Z] Running run-tests step. 11:13:34 INFO - Running pre-action listener: _resource_record_pre_action 11:13:34 INFO - Running pre-action listener: _set_gcov_prefix 11:13:34 INFO - Running main action method: run_tests 11:13:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:13:34 INFO - Python 2.7.3 11:13:34 INFO - Return code: 0 11:13:34 INFO - grabbing minidump binary from tooltool 11:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255f130>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25604c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:13:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:13:34 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:13:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:13:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:13:35 INFO - Return code: 0 11:13:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:13:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:13:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:13:35 INFO - ENV: RUST_BACKTRACE is now full 11:13:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:13:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:13:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:13:35 INFO - Using env: {'DISPLAY': ':0', 11:13:35 INFO - 'HOME': '/home/cltbld', 11:13:35 INFO - 'LANG': 'en_US.UTF-8', 11:13:35 INFO - 'LANGUAGE': 'en_US:en', 11:13:35 INFO - 'LOGNAME': 'cltbld', 11:13:35 INFO - 'MAIL': '/var/mail/cltbld', 11:13:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:13:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:35 INFO - 'MOZ_NO_REMOTE': '1', 11:13:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:13:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:35 INFO - 'NO_EM_RESTART': '1', 11:13:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:35 INFO - 'PWD': '/builds/slave/test', 11:13:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:13:35 INFO - 'RUST_BACKTRACE': 'full', 11:13:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:13:35 INFO - 'SHELL': '/bin/bash', 11:13:35 INFO - 'SHLVL': '1', 11:13:35 INFO - 'STYLO_FORCE_ENABLED': '1', 11:13:35 INFO - 'TERM': 'linux', 11:13:35 INFO - 'TMOUT': '86400', 11:13:35 INFO - 'USER': 'cltbld', 11:13:35 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491', 11:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:35 INFO - '_': '/tools/buildbot/bin/python'} 11:13:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:13:35 INFO - mozversion application_buildid: 20170829172659 11:13:35 INFO - mozversion application_changeset: e336d84fc1d2d1fde7387dd5f86fe06fa59abe10 11:13:35 INFO - mozversion application_display_name: Nightly 11:13:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:13:35 INFO - mozversion application_name: Firefox 11:13:35 INFO - mozversion application_remotingname: firefox 11:13:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:13:35 INFO - mozversion application_vendor: Mozilla 11:13:35 INFO - mozversion application_version: 57.0a1 11:13:35 INFO - mozversion platform_buildid: 20170829172659 11:13:35 INFO - mozversion platform_changeset: e336d84fc1d2d1fde7387dd5f86fe06fa59abe10 11:13:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:13:35 INFO - mozversion platform_version: 57.0a1 11:13:35 INFO - using testdate: 1504030415 11:13:35 INFO - actual date: 1504030415 11:13:35 INFO - starting webserver on 'localhost:34031' 11:13:35 INFO - SUITE-START | Running 2 tests 11:13:35 INFO - TEST-START | dromaeo_css 11:13:35 INFO - Initialising browser for dromaeo_css test... 11:13:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34031/getInfo.html -profile /tmp/tmprpMXgs/profile 11:13:35 INFO - TEST-INFO | started process 751 (/builds/slave/test/build/application/firefox/firefox http://localhost:34031/getInfo.html) 11:13:40 INFO - TEST-INFO | 751: exit 0 11:13:40 INFO - Browser initialized. 11:13:40 INFO - Running cycle 1/1 for dromaeo_css test... 11:13:40 INFO - Using env: {'DISPLAY': ':0', 11:13:40 INFO - 'HOME': '/home/cltbld', 11:13:40 INFO - 'JSGC_DISABLE_POISONING': '1', 11:13:40 INFO - 'LANG': 'en_US.UTF-8', 11:13:40 INFO - 'LANGUAGE': 'en_US:en', 11:13:40 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:13:40 INFO - 'LOGNAME': 'cltbld', 11:13:40 INFO - 'MAIL': '/var/mail/cltbld', 11:13:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:13:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:13:40 INFO - 'MOZ_CRASHREPORTER': '1', 11:13:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:40 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:13:40 INFO - 'MOZ_NO_REMOTE': '1', 11:13:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:13:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:40 INFO - 'NO_EM_RESTART': '1', 11:13:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:40 INFO - 'PWD': '/builds/slave/test', 11:13:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:13:40 INFO - 'RUST_BACKTRACE': 'full', 11:13:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:13:40 INFO - 'SHELL': '/bin/bash', 11:13:40 INFO - 'SHLVL': '1', 11:13:40 INFO - 'STYLO_FORCE_ENABLED': '1', 11:13:40 INFO - 'TERM': 'linux', 11:13:40 INFO - 'TMOUT': '86400', 11:13:40 INFO - 'USER': 'cltbld', 11:13:40 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491', 11:13:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:40 INFO - '_': '/tools/buildbot/bin/python'} 11:13:40 INFO - TEST-INFO | started process 943 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprpMXgs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:41 INFO - PID 943 | 11:13:41 INFO - PID 943 | (/builds/slave/test/build/application/firefox/firefox:993): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:13:41 INFO - PID 943 | 11:13:51 INFO - PID 943 | RSS: Main: 175685632 11:13:51 INFO - PID 943 | 11:16:50 INFO - PID 943 | Cycle 1(1): loaded http://localhost:34031/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34031/tests/dromaeo/cssquery-ext.html) 11:16:51 INFO - PID 943 | RSS: Main: 178286592 11:16:51 INFO - PID 943 | 11:19:53 INFO - PID 943 | Cycle 1(1): loaded http://localhost:34031/tests/dromaeo/cssquery-ext.html (next: http://localhost:34031/tests/dromaeo/cssquery-jquery.html) 11:19:54 INFO - PID 943 | RSS: Main: 174006272 11:19:54 INFO - PID 943 | 11:22:55 INFO - PID 943 | Cycle 1(1): loaded http://localhost:34031/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34031/tests/dromaeo/cssquery-mootools.html) 11:22:56 INFO - PID 943 | RSS: Main: 176402432 11:22:56 INFO - PID 943 | 11:25:58 INFO - PID 943 | Cycle 1(1): loaded http://localhost:34031/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34031/tests/dromaeo/cssquery-prototype.html) 11:25:58 INFO - PID 943 | RSS: Main: 175169536 11:25:58 INFO - PID 943 | 11:29:02 INFO - PID 943 | Cycle 1(1): loaded http://localhost:34031/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34031/tests/dromaeo/cssquery-yui.html) 11:29:03 INFO - PID 943 | RSS: Main: 176168960 11:29:03 INFO - PID 943 | 11:32:04 INFO - PID 943 | Cycle 1(1): loaded http://localhost:34031/tests/dromaeo/cssquery-yui.html (next: http://localhost:34031/tests/dromaeo/cssquery-dojo.html) 11:32:05 INFO - PID 943 | RSS: Main: 178782208 11:32:05 INFO - PID 943 | 11:32:05 INFO - PID 943 | __start_tp_report 11:32:05 INFO - PID 943 | _x_x_mozilla_page_load 11:32:05 INFO - PID 943 | _x_x_mozilla_page_load_details 11:32:05 INFO - PID 943 | |i|pagename|runs| 11:32:05 INFO - PID 943 | |0;dojo.html;3299.05976796613;3338.3323335332934;3361.9495707564383;3366.2257680733446;3372.6795954384324;6224.564280500355;6292.685365731712;6319.5576309658345;6361.968190159054;6367.713452894619;6151.41561551653;6233.937660623393;6255.06174073888;6261.843453913654;6276.654783986879;5718.799842005531;5723.5135013523795;5745.540356771448;5756.510696590794;5853.50245229156;5822.214001109838;5841.591088623798;5856.795012174574;5890.057590785475;5916.615419997708;5498.065328894098;5621.0444224481935;5711.428857114297;5831.737571809279;5838.474537291643;5669.206311116406;5707.143928410772;5756.107803290497;5783.5951483396175;5796.449337312949;5675.460831221028;5713.200151978726;5739.598228124033;5744.770209191627;5760.222369980041;6081.422264884829;6146.416090471398;6216.471599914013;6271.905921411182;6299.968500157515;6706.83232919181;6740.696668649923;6742.258351581322;6747.089142965686;6758.189017317954;6754.864902701967;6813.3527314905;6822.658867056677;6837.760678376283;6866.931330686679;6255.499560035186;6261.9373806262265;6351.682415879188;6370.55406121567;6372.84067898297;6773.221079575814;6879.174499060145;6893.276205998298;6894.207166175854;6916.412104971033;6494.447971922439;6580.901286480706;6580.967095164494;6584.539082264291;6592.143021407186;6771;6785.796426107225;6798.286179951133;6806.591604503746;6816.4546836252985;6699.665016749241;6709.329067093349;6767.492438067165;6788.830279243059;6811.795646130624;6608.3391660834495;6725.05849181115;6734.1918969722965;6816.591004539743;6830.043793868862;4933.0380575788095;4959.404871415381;4966.801327946841;4970.2793095001025;4973;4375.6280716138845;4377.124575084932;4431.556844315543;4436.44544431946;4447.043885564619;5879.794207202727;5907.497862681635;5948.970255148696;5951.404859514014;5955.285365756137;6699.564528305645;6709.060731497594;6788.898166527506;6800.727970881109;6804.251532331439;5735.684537350402;5835.066389377679;5836.620619659709;5844.152597873284;5933.821985340447;5791.942080579224;5808.099744539603;5809.099589563624;5810.273715785527;5815.41845815415;6530.346965303432;6552.246491653425;6626.768063117768;6631.767888123893;6650.235222949423;6704.128463299739;6713.765018224339;6785.59286442815;6786.219584747719;6796.966015169893;6415.679216039272;6489.675516224264;6545;6628.105205797156;6644.4020038196795;6625;6693.631850248283;6704.195496540447;6710.698018589078;6722.05891175226;6752.088468056946;6786.049953006484;6833.043373927753;6877;6878.071460352989;6515.576487528296;6543.509236807164;6593.538452308292;6594.142761440982;6609.339066093352;6346.111544383698;6528.804135875931;6530.640814755234;6613.570117942319;6628.635425051669;6441.452476539546;6469.77355792545;6503.674816259263;6505.707243173973;6521.576097553644;6516.6415847128865;6551.967240163769;6567.343265673586;6644.368784965421;6674.532782705164;6349.301576826453;6357.745690172342;6357.841053973688;6441.162648855806;6449.6130232186215 11:32:05 INFO - PID 943 | |1;ext.html;768.7232596265344;848.9490630562166;862.331692937973;863.3136656358197;1120.787050460413;29214;30101;38721.99999999996;39420.40869386961;39421.80289098558;39331.21337573247;39753.80123099388;39776.40335394971;39777.80111099448;39811;7414.036175297218;7596.5062270952485;7596.544207347549;7597.734079307225;7598.354139898115;7466.813329666747;7559.773206803805;7566.810829729246;7567.091948966105;7572.886406703877;7534.962325188367;7537.321641052305;7567.394608431312;7582.090149182106;7596.202398748134;7508.962455187744;7541.358984486325;7543.886841697379;7561.659725312346;7566.546007239584;7426.368758655521;7480;7480.476366654337;7482;7489.475736698433;35416.82291588551;35672.10819729501;35734.82132589346;35744.64255357439;35797.284054319025;3478.1652403422995;3527.8236088195486;3533.134382076382;3534.045807631925;3534.32847758925;28895.277618059506;28912.42175156506;28942.13173604795;29011.12966610984;29063.564046539108;4938.555530002282;4948.1093403187415;4967.230079337708;5007.749612519396;5007.924881126786;180031;182165;182498;182661.0866945657;183585.08207458878;44255.55744442579;44339.55660443419;44378.11243775171;44411.55588444139;44448.55551444509;50921;51618.741906290226;51642;51723;51785.74107129515;12625;12761.106722529334;15628.531144065697;15798.68402631941;15898.76151857723;13043.086983911035;13062.150960187557;13063;13067.869321306665;13078.411471483807;13602.93198534001;13614.18314901109;13636.52272170489;13674.726505469835;13758.65603359924;5476.616636835383;5558.944410555923;5576.442355764391;5593.608447408642;5671.347795003545;969.7769513012047;980.475445636581;1008.6016023670609;1014.3102690170755;1016.8068067067381;21629.675554866688;21657.133714651238;21683.34949951504;22398;22519.324420267418;1091.3779145886767;1092.6612750047511;1104.1442881766534;1108.141190577309;1112.788570171681;11471.770564588662;11714.765704685859;11723.706907327385;11794.233374830781;11806.114541409428;221679;222028;222236;222925;223331;47541;48309.75845120752;48365.274520882216;48379.5162048375;48609;1411.1885665742034;1417.2205287092058;1427.9928600356932;1436.6911114110308;1443.0980637101811;21427.571448571252;21459.961303676126;21698.457538561663;21836.56326873422;21996.560068798855;34319.142021448664;34391.4841277376;34477.13807154841;34557.30885382228;34640.133996650286;185209;185326;185821;185872;185960;31253.531197031607;31803.20491987626;31824.681753183097;32021.519677204393;32203.194920126247;38532.80733596314;38696.226075478895;38964.220715586096;39208.215835683695;39341.6065839338;29241.543406431225;30170.24574385658;31769.20576985594;32018.679813202503;32126;30994.84502577563;31217.843910780302;31288;31300.530492043094;31560.842195788875;34735.30529389449;34813.65186348104;34846.303073937874;35100.824495878376;35388.46917296294;31159.376812464077;31160;31548;31638.525422119146;32073.35853282968;23418.76581234234;23663.29010129699;23831;24112;24276.271711848673 11:32:05 INFO - PID 943 | |2;jquery.html;534.1533669134421;542.9511343979041;544.5643485211831;552.7733629212024;556.6214973817803;21310.57378852422;21963.670544941837;22017.559648807015;22045.11819527217;22054.669179962275;23075.192368267115;24084.397890052758;25253.368665783364;25402;25459;6512.641804700751;6651.501137414713;6652.401283884449;6653.767118150866;6657.267700552935;6239.469645080151;6584.506162037842;6606.735730570796;6629.303923088079;6632.602043877383;6577.638229897354;6582.605043697394;6584.9012264816065;6585.93414065858;6589.637569933651;6545.116409284733;6552.410283074499;6564.048213009087;6564.442022428099;6567.901481477782;6044.516438684895;6046.516278697693;6059.363766804466;6069.423404776539;6084.117802918552;27788.58317125245;27923.301917452227;28332.858335708395;28480.430391392056;29248.268793280124;2033.745781777278;2078.1791192478886;2083.1250874632537;2084.739407574053;2088.644930361827;19198.904005480024;19388.515287117792;19402.22391104354;19542.51143721404;19709.80290197094;2489.751024897514;2503.4242124311327;2566.8588227647474;2571.6785401824773;2577.6262441946;136402.31798841042;138826;139187;139267.30366348205;139348;19244.652874298663;20371.490712732004;21037.78962210389;21357;21567.784322156578;41392.1721565567;41417;41491.585084149374;41565.1686966259;41589.58410415857;11375.374354410587;11498.42507874603;11523.654290371302;11555.364454955059;11701.941490292664;8556.914430855611;9546.284028697875;9696.418214907128;9708.563114659857;9797.265205109645;9456.810863782686;10996.28524145928;11129.332240065622;11343.376114313627;11409.48657310423;3533.7349698772696;3664.358737220976;4058.8782336529953;4160.521540022875;4186.937195942002;957.1768279279814;971.7327734872825;982.5578489679673;991.9454430006275;1001.929864909464;19126;19391.806081939;19427;19903.004849757453;22929.541409171725;1003.508280942333;1040.1366865501616;1042.8632790258655;1046.7330830638139;1063.7606538528769;10758.139348852073;12932.482700691868;13839.792403113961;13855.445782168601;14055.086419382911;514195;526390;528433;540846;541300;115917.4204128974;116570.41714791542;117369;117746;117814;1234.512367614787;1235.9382030898419;1258.9748205035849;1269.9238045717286;1272.7963525835821;20862.895685521475;21085.262015829372;21155.788442115383;21404.892975535022;21735.782642173377;57762;58119.4188058114;58541;58731.11903321368;59457.70271148616;70666;71228.64385678039;71388.64305678438;74007.62996184985;74737;11936.880631193577;12418.441170147184;13989;14193.645158871112;14604.415823367372;22424;22671.546569068196;22713.205037823598;22733.545329093657;22889.542209156058;18096.276148953893;18151.81848181501;18421.447356579323;18486.260549577866;18494.0752962354;16411.753823692892;16447.013179209287;16858.241379137722;17304.740428893827;17312.913435432743;18658.44024679262;18725;18766.906165469085;18830.152643131365;18979.71530427072;14155.64610884736;14168.220747858555;14291.42834286617;14309.785353219502;14311.355988980313;17887.73168402501;17938.91030544839;18127.546811329823;18177.727334089734;18318.450446486626 11:32:05 INFO - PID 943 | |3;mootools.html;1295.2940647347195;1326.098253187832;1326.1645163546964;1349.8447678516973;1357.945682172713;14241;14645.926770366146;14662.486812961548;14709.779353309708;14738.336774845131;14939.925300373483;15204.543863684079;15213.92393038036;15297.388104475835;15324.310406031727;2419.4072452249225;2649.3641526033807;2698.716634753352;2700.176446183913;2701.0951331304036;2577.1495406515805;2634.7496987786226;2635.196265139132;2635.696894857087;2636.5913283441096;2520.407704189523;2539.3397716593636;2554.514642217973;2558.6801649793774;2596.6624338835927;2505.023041014006;2521.684789401325;2528.8609126498036;2529.064246228889;2529.5067461844947;2466.7409921958297;2479.789217916479;2503.5368456835545;2504.3864253257884;2505.361132911114;13932.791008134885;14250.2162381069;14273.78589321161;14278.571642850731;14285.928570357186;7523.962380188064;7750.496217745828;7948.523088614702;7956.641951112214;7969.721059762938;5271.103912334912;5454.372747134051;5470.589705772083;5471.890562188773;5531.170324451325;1864.7296142059326;1886.1323791056132;1889.8488120950292;1946.9221231150736;1948.279136719423;24064.879675601685;24416.267511974493;24561.877190614112;24655.137070202458;24682.629760553784;6726.3946244837225;6728.596284222962;6767.864642707217;6834.419074378733;6847.774473296198;18781;18838.3406580769;18906.243750249836;18930.148143333583;18951.71572426387;7756.457048006585;7829.804254893559;8032.598370081472;8044.718434854752;8048.59757012147;5555.099339667722;6150.415710507495;6190.81427557174;7150.356467917913;7158;4709.646776491777;4820.469748327681;4848.393950756155;4877.073356062337;4887.36464259644;1369.2263870912902;1370.691594391254;1384.508499482669;1396.0576610787678;1397.5737400092867;860.3805260212762;884.8451520983803;898.0660113481906;903.5482258870564;904.7104926423482;7379.3358597726465;7450.366718828852;7451.925480745232;7510.023696919366;7529.774106776806;697.2678687378233;702.8664553734774;704.9048378468943;710.7974227345181;712.5582139073704;4471.128130014616;4920.704757714549;5108.055009823194;5169.663971841818;5303.893922121536;19502.8049719501;19889.502762431053;20072.598548028956;20139.295124670858;20141.697874531892;19658;19866.404007879788;19936.601267974558;19969.301074462324;19971.800281997286;9839.444402957239;10137.087662110445;10480.161587073017;10535.894641053645;10550.0504954556;7889.368850492062;7921.247481489249;7986.201379861967;8191.918080819116;8382;17014.31942722327;17197.74203386925;17247.65504689874;17502.47492575225;18216.726749099038;17724.202410891285;17992.91003544974;18067.819321806615;18149.727754083964;18331.633367332313;11716.70708232301;11846.466908988943;11943.462544185359;11954.58158964432;11968.222065565711;12914.547990820276;13200.33998300062;13268.402921868346;13333.666658333232;13403.731925361242;10991.175661825555;11043.779124417306;11070.114390848874;11182;11536.192466527598;9847.261455390731;10077.798444031225;10169.491525423848;10189.592416303265;10203.540840662337;8540.658373665232;9263.397879137834;9357.298202634965;9364.765880853032;9376.57805398745;6613.603183808987;6849.24658287578;6878.312168783082;6920.792376228721;6935.514513984174;6988.965055174692;7017.578945263301;7046.4010559101;7055.788326350218;7090.361867431956 11:32:05 INFO - PID 943 | |4;prototype.html;494.957928576071;498.29740066506224;513.4377856247409;517.9663321884075;529.625621512176;6208.968955155229;6223.346548612399;6239.282482514513;6277.968610156943;6327.240731112267;6128.540359473046;6201.410865967726;6201.658908760016;6237.261719218319;6261.749530018794;4845.152098382769;4925.138100832358;4974.776135073912;5066.518680725344;5098.9745051274695;4926.719053046216;4941.802327906879;4982.377202849644;5009.747563109223;5030.547250747432;4865.41615006198;4889.853304400874;4938.308636790852;4943.851684449454;4955;4947.183714687072;4949.307097006422;4955.132851750947;4959.330490383788;4982.103221420143;4427.800748966304;4448.310511870665;4467.642588592905;4471.39636149119;4478.8432404866;5925.355906117749;6004.699765011732;6021.969890150565;6080.422359875804;6089.634621922699;5629.211910332557;5646.237757902672;5662.348829884575;5676.858078548028;5689.487946084872;6559.508036897252;6569.934300657028;6572.342765723437;6591.274959754423;6612.404883560503;4819.9036019279765;4832.226843704991;4838.322634831126;4841.273808928654;4858.222684370484;6568.244651865001;6775.424088952445;6789.321067893171;6801.979703044533;6946.687399067054;4884.194107972145;4978.128827455181;4989.226669866177;5023.031804874182;5023.899522009539;5070.264811602297;5088.262201980692;5097.470758772353;5098.5411312982005;5111.821086262037;5673.432656734376;5695.658260504383;5704.515116215085;5712.6286791358425;5719.970405326998;6598.492572822297;6611.173603299588;6646.4350530205475;6646.933530664728;6648.301928297556;1757.2882982392152;1781.5368004318711;1782.7504149419092;1782.9108544572719;1789.4094948667168;1173.730042090324;1223.4922507159606;1224.7489264700714;1226.4174517104304;1237.616338934933;5878.823635290948;5887.646741195542;5888.146218798336;5902.881942361215;5917.349091599921;6719.656068786262;6721.4958878084335;6740.258571557125;6748.4938629602975;6758.357955994173;5811.3316968548315;5827.3007239131575;5828.591998560145;5838.9124163137585;5850.912236316459;3475.669811367916;3494.4932984717584;3531.1285018940002;3547.0777597824235;3549.982250088733;6485.254195767453;6497.155369801895;6538.215414150332;6538.738450461929;6539.346065393518;6441;6789.25318214996;6826.761063362758;6839.692213850389;6863.210730766026;6460.709268082947;6478.190226221723;6537.084808126866;6549.115869357671;6568.408843204134;6596.80209593713;6598.406143447113;6702.229243636849;6704.83237919056;6723.495737819585;6506.60960342381;6626.635535045619;6662.933370666231;6670.66646667655;6756.966215168893;6472.288048314776;6479.546431749733;6482.189726284215;6507.837304067436;6563.324538258399;4964.180910149785;4967.875803104951;4983.601311895112;5008.77460514285;5020.347354843847;6463.612183269019;6596.967015164893;6622.602643841192;6722.1261236039;6840.657967101724;6215.782447614311;6526.118973938457;6549.836254093686;6554.868902622016;6565.441937435371;6488.480921526361;6497.350264973654;6503.934960650522;6504.544681872224;6540.542162048611;6427.3251308611925;6460.289368169404;6474.093626892333;6480.643564603992;6519.869602608016;6563.195121341479;6576.901346479903;6591.802245932629;6616.603003819786;6653.401193892573;6315.273743519554;6321.652309123042;6382.6491092176975;6395.488360931207;6426.068220108152 11:32:05 INFO - PID 943 | |5;yui.html;827.9089300176979;836.3518273338159;848.1899785704651;874.8075423406852;895.1898531828697;18602;19410.51473713158;19422.126004329803;19449.513762155937;19963.800361996375;20159.59680806383;20418.591628167465;20575.588488230263;20811.959402029912;20843.791562084374;914.9130832570895;926.4117285523707;927.0081013315755;928.4522131942152;928.5264515097282;913.5112714697638;932.8181004704086;940.5156344482563;940.9341346105775;942.8020115775661;993.3443927008176;997.4065431068502;997.7655251016006;997.9151772099381;1000.8548760429734;991.9702408927708;993.6323560282669;993.9155171810405;995;995.0894931138037;735.2867718313228;736.4292673178276;736.4329466310965;736.4403053679189;736.7863319637353;18379.26482940681;18537.814621853744;18757;18777.718334225;19519.609607807906;20513.589728205352;20547.89726051375;20556.691649625267;20937;20960.895195524077;16776.245068971926;16838.158092095346;16933.830661693348;16953.237104330336;16996.235169417407;3482.320947415255;3484.930301393958;3498.073010652179;3500.2299494111253;3504.6495350465007;122910;125115.37442312822;125460.99999999908;126873.36563317124;128327;16193.433229836899;16257.91871040661;16463.34146634121;16501.174941253128;16523.091229982227;29087.41825163485;29281.414371712446;29634.259143521584;29685.81256749749;29747.85126074399;8181.181881811771;8320.542370169578;8323.292520135856;8334.791630209293;8352.12302708219;4311.784410779511;4437;4442.244818380883;4449.2658711312915;4449.3326001100095;4822.035592881438;4994.3507344045765;5007.12375334315;5014.34813474246;5015.774290156952;924.8289066522715;948.5352177433008;952.2001518724305;965.6958058211641;967.9612815487443;668.8327918020495;684.2746688510196;684.910961574992;687.5015613680042;697.9895301570481;12025.218360806695;12247.510099595916;12400;12567.434465449076;12634.052446066582;678.2302087131142;680.8161796314968;690.0856365315976;690.4614400767409;698.183125742882;5576.972115139399;5608.831735047955;5678.261825962599;5689.431056894277;5808.128780682931;111400.4429977845;114415;114540.42729786297;116154;119741;98844;99186.5040674792;102248.48875755574;105606;106186;87216;88898;90040.5497972506;91650;92172;10581.4709264538;10583.994520520539;10611.045005949502;10669.093127084285;10803;38221.80889095537;39504.60495395009;40576;40665.39001915033;40691.7965410171;72183.27816721976;73551.26448735445;73690;76380.23619763953;78422;17237.138143092543;17427.215775290395;17534.386296479563;18380.908095459436;18418.447446576625;20299.69550456774;20635.14283714473;20662.58674826465;21345.25291614786;21391.144354225657;19366.128524216725;19870.205191792167;19962.500937476678;19995.100220490403;20103.29638462647;16586.668266634842;18984.905075474533;19534;20034.799652003294;20112.09495572732;18913.810861891754;19346.903265484147;19348.4195474136;19564.90217548903;19704.31034913771;12227;12943.741125177632;13124.540641077516;13323.400446979715;13599.456021759019;13209.933950330187;14502;15134.470293539673;15145.772813407588;15194.316255768295 11:32:05 INFO - PID 943 | __end_tp_report 11:32:05 INFO - PID 943 | __start_cc_report 11:32:05 INFO - PID 943 | _x_x_mozilla_cycle_collect,355 11:32:05 INFO - PID 943 | __end_cc_report 11:32:05 INFO - PID 943 | __startTimestamp1504031525042__endTimestamp 11:32:05 INFO - PID 943 | 11:32:05 INFO - PID 943 | ------- Summary: start ------- 11:32:05 INFO - PID 943 | Number of tests: 6 11:32:05 INFO - PID 943 | 11:32:05 INFO - PID 943 | [#0] dojo.html Cycles:165 Average:6187.93 Median:6449.61 stddev:753.04 (11.7%) stddev-sans-first:720.44 11:32:05 INFO - PID 943 | Values: 3299.1 3338.3 3361.9 3366.2 3372.7 6224.6 6292.7 6319.6 6362.0 6367.7 6151.4 6233.9 6255.1 6261.8 6276.7 5718.8 5723.5 5745.5 5756.5 5853.5 5822.2 5841.6 5856.8 5890.1 5916.6 5498.1 5621.0 5711.4 5831.7 5838.5 5669.2 5707.1 5756.1 5783.6 5796.4 5675.5 5713.2 5739.6 5744.8 5760.2 6081.4 6146.4 6216.5 6271.9 6300.0 6706.8 6740.7 6742.3 6747.1 6758.2 6754.9 6813.4 6822.7 6837.8 6866.9 6255.5 6261.9 6351.7 6370.6 6372.8 6773.2 6879.2 6893.3 6894.2 6916.4 6494.4 6580.9 6581.0 6584.5 6592.1 6771.0 6785.8 6798.3 6806.6 6816.5 6699.7 6709.3 6767.5 6788.8 6811.8 6608.3 6725.1 6734.2 6816.6 6830.0 4933.0 4959.4 4966.8 4970.3 4973.0 4375.6 4377.1 4431.6 4436.4 4447.0 5879.8 5907.5 5949.0 5951.4 5955.3 6699.6 6709.1 6788.9 6800.7 6804.3 5735.7 5835.1 5836.6 5844.2 5933.8 5791.9 5808.1 5809.1 5810.3 5815.4 6530.3 6552.2 6626.8 6631.8 6650.2 6704.1 6713.8 6785.6 6786.2 6797.0 6415.7 6489.7 6545.0 6628.1 6644.4 6625.0 6693.6 6704.2 6710.7 6722.1 6752.1 6786.0 6833.0 6877.0 6878.1 6515.6 6543.5 6593.5 6594.1 6609.3 6346.1 6528.8 6530.6 6613.6 6628.6 6441.5 6469.8 6503.7 6505.7 6521.6 6516.6 6552.0 6567.3 6644.4 6674.5 6349.3 6357.7 6357.8 6441.2 6449.6 11:32:05 INFO - PID 943 | 11:32:05 INFO - PID 943 | [#1] ext.html Cycles:180 Average:35690.46 Median:33261.17 stddev:51148.26 (153.8%) stddev-sans-first:51224.53 11:32:05 INFO - PID 943 | Values: 768.7 848.9 862.3 863.3 1120.8 29214.0 30101.0 38722.0 39420.4 39421.8 39331.2 39753.8 39776.4 39777.8 39811.0 7414.0 7596.5 7596.5 7597.7 7598.4 7466.8 7559.8 7566.8 7567.1 7572.9 7535.0 7537.3 7567.4 7582.1 7596.2 7509.0 7541.4 7543.9 7561.7 7566.5 7426.4 7480.0 7480.5 7482.0 7489.5 35416.8 35672.1 35734.8 35744.6 35797.3 3478.2 3527.8 3533.1 3534.0 3534.3 28895.3 28912.4 28942.1 29011.1 29063.6 4938.6 4948.1 4967.2 5007.7 5007.9 180031.0 182165.0 182498.0 182661.1 183585.1 44255.6 44339.6 44378.1 44411.6 44448.6 50921.0 51618.7 51642.0 51723.0 51785.7 12625.0 12761.1 15628.5 15798.7 15898.8 13043.1 13062.2 13063.0 13067.9 13078.4 13602.9 13614.2 13636.5 13674.7 13758.7 5476.6 5558.9 5576.4 5593.6 5671.3 969.8 980.5 1008.6 1014.3 1016.8 21629.7 21657.1 21683.3 22398.0 22519.3 1091.4 1092.7 1104.1 1108.1 1112.8 11471.8 11714.8 11723.7 11794.2 11806.1 221679.0 222028.0 222236.0 222925.0 223331.0 47541.0 48309.8 48365.3 48379.5 48609.0 1411.2 1417.2 1428.0 1436.7 1443.1 21427.6 21460.0 21698.5 21836.6 21996.6 34319.1 34391.5 34477.1 34557.3 34640.1 185209.0 185326.0 185821.0 185872.0 185960.0 31253.5 31803.2 31824.7 32021.5 32203.2 38532.8 38696.2 38964.2 39208.2 39341.6 29241.5 30170.2 31769.2 32018.7 32126.0 30994.8 31217.8 31288.0 31300.5 31560.8 34735.3 34813.7 34846.3 35100.8 35388.5 31159.4 31160.0 31548.0 31638.5 32073.4 23418.8 23663.3 23831.0 24112.0 24276.3 11:32:05 INFO - PID 943 | 11:32:05 INFO - PID 943 | [#2] jquery.html Cycles:180 Average:36858.65 Median:21990.62 stddev:88779.52 (403.7%) stddev-sans-first:88986.68 11:32:05 INFO - PID 943 | Values: 534.2 543.0 544.6 552.8 556.6 21310.6 21963.7 22017.6 22045.1 22054.7 23075.2 24084.4 25253.4 25402.0 25459.0 6512.6 6651.5 6652.4 6653.8 6657.3 6239.5 6584.5 6606.7 6629.3 6632.6 6577.6 6582.6 6584.9 6585.9 6589.6 6545.1 6552.4 6564.0 6564.4 6567.9 6044.5 6046.5 6059.4 6069.4 6084.1 27788.6 27923.3 28332.9 28480.4 29248.3 2033.7 2078.2 2083.1 2084.7 2088.6 19198.9 19388.5 19402.2 19542.5 19709.8 2489.8 2503.4 2566.9 2571.7 2577.6 136402.3 138826.0 139187.0 139267.3 139348.0 19244.7 20371.5 21037.8 21357.0 21567.8 41392.2 41417.0 41491.6 41565.2 41589.6 11375.4 11498.4 11523.7 11555.4 11701.9 8556.9 9546.3 9696.4 9708.6 9797.3 9456.8 10996.3 11129.3 11343.4 11409.5 3533.7 3664.4 4058.9 4160.5 4186.9 957.2 971.7 982.6 991.9 1001.9 19126.0 19391.8 19427.0 19903.0 22929.5 1003.5 1040.1 1042.9 1046.7 1063.8 10758.1 12932.5 13839.8 13855.4 14055.1 514195.0 526390.0 528433.0 540846.0 541300.0 115917.4 116570.4 117369.0 117746.0 117814.0 1234.5 1235.9 1259.0 1269.9 1272.8 20862.9 21085.3 21155.8 21404.9 21735.8 57762.0 58119.4 58541.0 58731.1 59457.7 70666.0 71228.6 71388.6 74007.6 74737.0 11936.9 12418.4 13989.0 14193.6 14604.4 22424.0 22671.5 22713.2 22733.5 22889.5 18096.3 18151.8 18421.4 18486.3 18494.1 16411.8 16447.0 16858.2 17304.7 17312.9 18658.4 18725.0 18766.9 18830.2 18979.7 14155.6 14168.2 14291.4 14309.8 14311.4 17887.7 17938.9 18127.5 18177.7 18318.5 11:32:05 INFO - PID 943 | 11:32:05 INFO - PID 943 | [#3] mootools.html Cycles:180 Average:8923.80 Median:2521.05 stddev:6343.97 (251.6%) stddev-sans-first:6335.88 11:32:05 INFO - PID 943 | Values: 1295.3 1326.1 1326.2 1349.8 1357.9 14241.0 14645.9 14662.5 14709.8 14738.3 14939.9 15204.5 15213.9 15297.4 15324.3 2419.4 2649.4 2698.7 2700.2 2701.1 2577.1 2634.7 2635.2 2635.7 2636.6 2520.4 2539.3 2554.5 2558.7 2596.7 2505.0 2521.7 2528.9 2529.1 2529.5 2466.7 2479.8 2503.5 2504.4 2505.4 13932.8 14250.2 14273.8 14278.6 14285.9 7524.0 7750.5 7948.5 7956.6 7969.7 5271.1 5454.4 5470.6 5471.9 5531.2 1864.7 1886.1 1889.8 1946.9 1948.3 24064.9 24416.3 24561.9 24655.1 24682.6 6726.4 6728.6 6767.9 6834.4 6847.8 18781.0 18838.3 18906.2 18930.1 18951.7 7756.5 7829.8 8032.6 8044.7 8048.6 5555.1 6150.4 6190.8 7150.4 7158.0 4709.6 4820.5 4848.4 4877.1 4887.4 1369.2 1370.7 1384.5 1396.1 1397.6 860.4 884.8 898.1 903.5 904.7 7379.3 7450.4 7451.9 7510.0 7529.8 697.3 702.9 704.9 710.8 712.6 4471.1 4920.7 5108.1 5169.7 5303.9 19502.8 19889.5 20072.6 20139.3 20141.7 19658.0 19866.4 19936.6 19969.3 19971.8 9839.4 10137.1 10480.2 10535.9 10550.1 7889.4 7921.2 7986.2 8191.9 8382.0 17014.3 17197.7 17247.7 17502.5 18216.7 17724.2 17992.9 18067.8 18149.7 18331.6 11716.7 11846.5 11943.5 11954.6 11968.2 12914.5 13200.3 13268.4 13333.7 13403.7 10991.2 11043.8 11070.1 11182.0 11536.2 9847.3 10077.8 10169.5 10189.6 10203.5 8540.7 9263.4 9357.3 9364.8 9376.6 6613.6 6849.2 6878.3 6920.8 6935.5 6989.0 7017.6 7046.4 7055.8 7090.4 11:32:05 INFO - PID 943 | 11:32:05 INFO - PID 943 | [#4] prototype.html Cycles:180 Average:5505.65 Median:6164.98 stddev:1543.77 (25.0%) stddev-sans-first:1501.59 11:32:05 INFO - PID 943 | Values: 495.0 498.3 513.4 518.0 529.6 6209.0 6223.3 6239.3 6278.0 6327.2 6128.5 6201.4 6201.7 6237.3 6261.7 4845.2 4925.1 4974.8 5066.5 5099.0 4926.7 4941.8 4982.4 5009.7 5030.5 4865.4 4889.9 4938.3 4943.9 4955.0 4947.2 4949.3 4955.1 4959.3 4982.1 4427.8 4448.3 4467.6 4471.4 4478.8 5925.4 6004.7 6022.0 6080.4 6089.6 5629.2 5646.2 5662.3 5676.9 5689.5 6559.5 6569.9 6572.3 6591.3 6612.4 4819.9 4832.2 4838.3 4841.3 4858.2 6568.2 6775.4 6789.3 6802.0 6946.7 4884.2 4978.1 4989.2 5023.0 5023.9 5070.3 5088.3 5097.5 5098.5 5111.8 5673.4 5695.7 5704.5 5712.6 5720.0 6598.5 6611.2 6646.4 6646.9 6648.3 1757.3 1781.5 1782.8 1782.9 1789.4 1173.7 1223.5 1224.7 1226.4 1237.6 5878.8 5887.6 5888.1 5902.9 5917.3 6719.7 6721.5 6740.3 6748.5 6758.4 5811.3 5827.3 5828.6 5838.9 5850.9 3475.7 3494.5 3531.1 3547.1 3550.0 6485.3 6497.2 6538.2 6538.7 6539.3 6441.0 6789.3 6826.8 6839.7 6863.2 6460.7 6478.2 6537.1 6549.1 6568.4 6596.8 6598.4 6702.2 6704.8 6723.5 6506.6 6626.6 6662.9 6670.7 6757.0 6472.3 6479.5 6482.2 6507.8 6563.3 4964.2 4967.9 4983.6 5008.8 5020.3 6463.6 6597.0 6622.6 6722.1 6840.7 6215.8 6526.1 6549.8 6554.9 6565.4 6488.5 6497.4 6503.9 6504.5 6540.5 6427.3 6460.3 6474.1 6480.6 6519.9 6563.2 6576.9 6591.8 6616.6 6653.4 6315.3 6321.7 6382.6 6395.5 6426.1 11:32:05 INFO - PID 943 | 11:32:05 INFO - PID 943 | [#5] yui.html Cycles:180 Average:24240.56 Median:29457.84 stddev:33199.84 (112.7%) stddev-sans-first:33246.43 11:32:05 INFO - PID 943 | Values: 827.9 836.4 848.2 874.8 895.2 18602.0 19410.5 19422.1 19449.5 19963.8 20159.6 20418.6 20575.6 20812.0 20843.8 914.9 926.4 927.0 928.5 928.5 913.5 932.8 940.5 940.9 942.8 993.3 997.4 997.8 997.9 1000.9 992.0 993.6 993.9 995.0 995.1 735.3 736.4 736.4 736.4 736.8 18379.3 18537.8 18757.0 18777.7 19519.6 20513.6 20547.9 20556.7 20937.0 20960.9 16776.2 16838.2 16933.8 16953.2 16996.2 3482.3 3484.9 3498.1 3500.2 3504.6 122910.0 125115.4 125461.0 126873.4 128327.0 16193.4 16257.9 16463.3 16501.2 16523.1 29087.4 29281.4 29634.3 29685.8 29747.9 8181.2 8320.5 8323.3 8334.8 8352.1 4311.8 4437.0 4442.2 4449.3 4449.3 4822.0 4994.4 5007.1 5014.3 5015.8 924.8 948.5 952.2 965.7 968.0 668.8 684.3 684.9 687.5 698.0 12025.2 12247.5 12400.0 12567.4 12634.1 678.2 680.8 690.1 690.5 698.2 5577.0 5608.8 5678.3 5689.4 5808.1 111400.4 114415.0 114540.4 116154.0 119741.0 98844.0 99186.5 102248.5 105606.0 106186.0 87216.0 88898.0 90040.5 91650.0 92172.0 10581.5 10584.0 10611.0 10669.1 10803.0 38221.8 39504.6 40576.0 40665.4 40691.8 72183.3 73551.3 73690.0 76380.2 78422.0 17237.1 17427.2 17534.4 18380.9 18418.4 20299.7 20635.1 20662.6 21345.3 21391.1 19366.1 19870.2 19962.5 19995.1 20103.3 16586.7 18984.9 19534.0 20034.8 20112.1 18913.8 19346.9 19348.4 19564.9 19704.3 12227.0 12943.7 13124.5 13323.4 13599.5 13209.9 14502.0 15134.5 15145.8 15194.3 11:32:05 INFO - PID 943 | -------- Summary: end -------- 11:32:05 INFO - PID 943 | 11:32:05 INFO - TEST-INFO | 943: exit 0 11:32:05 INFO - TEST-OK | dromaeo_css | took 1110477ms 11:32:05 INFO - TEST-START | kraken 11:32:05 INFO - Initialising browser for kraken test... 11:32:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34031/getInfo.html -profile /tmp/tmp2TssFq/profile 11:32:05 INFO - TEST-INFO | started process 1392 (/builds/slave/test/build/application/firefox/firefox http://localhost:34031/getInfo.html) 11:32:11 INFO - TEST-INFO | 1392: exit 0 11:32:11 INFO - Browser initialized. 11:32:11 INFO - Running cycle 1/1 for kraken test... 11:32:11 INFO - Using env: {'DISPLAY': ':0', 11:32:11 INFO - 'HOME': '/home/cltbld', 11:32:11 INFO - 'JSGC_DISABLE_POISONING': '1', 11:32:11 INFO - 'LANG': 'en_US.UTF-8', 11:32:11 INFO - 'LANGUAGE': 'en_US:en', 11:32:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:32:11 INFO - 'LOGNAME': 'cltbld', 11:32:11 INFO - 'MAIL': '/var/mail/cltbld', 11:32:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:32:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:32:11 INFO - 'MOZ_CRASHREPORTER': '1', 11:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:32:11 INFO - 'MOZ_NO_REMOTE': '1', 11:32:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:11 INFO - 'NO_EM_RESTART': '1', 11:32:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:11 INFO - 'PWD': '/builds/slave/test', 11:32:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:32:11 INFO - 'RUST_BACKTRACE': 'full', 11:32:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:32:11 INFO - 'SHELL': '/bin/bash', 11:32:11 INFO - 'SHLVL': '1', 11:32:11 INFO - 'STYLO_FORCE_ENABLED': '1', 11:32:11 INFO - 'TERM': 'linux', 11:32:11 INFO - 'TMOUT': '86400', 11:32:11 INFO - 'USER': 'cltbld', 11:32:11 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491', 11:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:11 INFO - '_': '/tools/buildbot/bin/python'} 11:32:11 INFO - TEST-INFO | started process 1582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2TssFq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:32:12 INFO - PID 1582 | 11:32:12 INFO - PID 1582 | (/builds/slave/test/build/application/firefox/firefox:1632): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:32:12 INFO - PID 1582 | 11:32:22 INFO - PID 1582 | RSS: Main: 170106880 11:32:22 INFO - PID 1582 | 11:32:25 INFO - PID 1582 | Cycle 1(1): loaded http://localhost:34031/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34031/tests/kraken/driver.html?testName=audio-beat-detection) 11:32:26 INFO - PID 1582 | RSS: Main: 176005120 11:32:26 INFO - PID 1582 | 11:32:28 INFO - PID 1582 | Cycle 1(1): loaded http://localhost:34031/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34031/tests/kraken/driver.html?testName=audio-dft) 11:32:29 INFO - PID 1582 | RSS: Main: 176570368 11:32:29 INFO - PID 1582 | 11:32:32 INFO - PID 1582 | Cycle 1(1): loaded http://localhost:34031/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34031/tests/kraken/driver.html?testName=audio-fft) 11:32:32 INFO - PID 1582 | RSS: Main: 169697280 11:32:32 INFO - PID 1582 | 11:32:35 INFO - PID 1582 | Cycle 1(1): loaded http://localhost:34031/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34031/tests/kraken/driver.html?testName=audio-oscillator) 11:32:35 INFO - PID 1582 | RSS: Main: 170291200 11:32:35 INFO - PID 1582 | 11:32:37 INFO - PID 1582 | Cycle 1(1): loaded http://localhost:34031/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34031/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:32:38 INFO - PID 1582 | RSS: Main: 170573824 11:32:38 INFO - PID 1582 | 11:32:41 INFO - PID 1582 | Cycle 1(1): loaded http://localhost:34031/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34031/tests/kraken/driver.html?testName=imaging-darkroom) 11:32:42 INFO - PID 1582 | RSS: Main: 172953600 11:32:42 INFO - PID 1582 | 11:32:45 INFO - PID 1582 | Cycle 1(1): loaded http://localhost:34031/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34031/tests/kraken/driver.html?testName=imaging-desaturate) 11:32:46 INFO - PID 1582 | RSS: Main: 173117440 11:32:46 INFO - PID 1582 | 11:32:49 INFO - PID 1582 | Cycle 1(1): loaded http://localhost:34031/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34031/tests/kraken/driver.html?testName=json-parse-financial) 11:32:49 INFO - PID 1582 | RSS: Main: 173084672 11:32:49 INFO - PID 1582 | 11:32:51 INFO - PID 1582 | Cycle 1(1): loaded http://localhost:34031/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34031/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:32:52 INFO - PID 1582 | RSS: Main: 173424640 11:32:52 INFO - PID 1582 | 11:32:53 INFO - PID 1582 | Cycle 1(1): loaded http://localhost:34031/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34031/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:32:54 INFO - PID 1582 | RSS: Main: 173604864 11:32:54 INFO - PID 1582 | 11:32:56 INFO - PID 1582 | Cycle 1(1): loaded http://localhost:34031/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34031/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:32:57 INFO - PID 1582 | RSS: Main: 173461504 11:32:57 INFO - PID 1582 | 11:32:59 INFO - PID 1582 | Cycle 1(1): loaded http://localhost:34031/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34031/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:33:00 INFO - PID 1582 | RSS: Main: 174211072 11:33:00 INFO - PID 1582 | 11:33:03 INFO - PID 1582 | Cycle 1(1): loaded http://localhost:34031/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34031/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:33:04 INFO - PID 1582 | RSS: Main: 174219264 11:33:04 INFO - PID 1582 | 11:33:05 INFO - PID 1582 | Cycle 1(1): loaded http://localhost:34031/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34031/tests/kraken/driver.html?testName=ai-astar) 11:33:06 INFO - PID 1582 | RSS: Main: 175865856 11:33:06 INFO - PID 1582 | 11:33:06 INFO - PID 1582 | __start_tp_report 11:33:06 INFO - PID 1582 | _x_x_mozilla_page_load 11:33:06 INFO - PID 1582 | _x_x_mozilla_page_load_details 11:33:06 INFO - PID 1582 | |i|pagename|runs| 11:33:06 INFO - PID 1582 | |0;ai-astar;99;107;102;106;107;112;107;100;108;107 11:33:06 INFO - PID 1582 | |1;audio-beat-detection;143;115;143;170;122;150;141;119;168;117 11:33:06 INFO - PID 1582 | |2;audio-dft;163;163;163;161;161;160;162;161;167;169 11:33:06 INFO - PID 1582 | |3;audio-fft;73;81;74;183;85;74;73;74;154;76 11:33:06 INFO - PID 1582 | |4;audio-oscillator;79;82;135;80;79;79;133;79;78;130 11:33:06 INFO - PID 1582 | |5;imaging-gaussian-blur;114;115;115;114;114;114;114;114;114;114 11:33:06 INFO - PID 1582 | |6;imaging-darkroom;147;157;150;148;148;147;148;147;149;148 11:33:06 INFO - PID 1582 | |7;imaging-desaturate;95;93;93;94;94;93;93;93;94;94 11:33:06 INFO - PID 1582 | |8;json-parse-financial;52;52;51;51;57;52;52;52;52;52 11:33:06 INFO - PID 1582 | |9;json-stringify-tinderbox;38;38;39;38;38;38;38;38;38;38 11:33:06 INFO - PID 1582 | |10;stanford-crypto-aes;76;76;73;75;75;75;79;75;74;78 11:33:06 INFO - PID 1582 | |11;stanford-crypto-ccm;126;120;128;123;119;124;121;119;125;160 11:33:06 INFO - PID 1582 | |12;stanford-crypto-pbkdf2;172;175;171;170;177;170;176;168;173;169 11:33:06 INFO - PID 1582 | |13;stanford-crypto-sha256-iterative;65;65;65;64;64;63;63;64;62;62 11:33:06 INFO - PID 1582 | __end_tp_report 11:33:06 INFO - PID 1582 | __start_cc_report 11:33:06 INFO - PID 1582 | _x_x_mozilla_cycle_collect,934 11:33:06 INFO - PID 1582 | __end_cc_report 11:33:06 INFO - PID 1582 | __startTimestamp1504031586157__endTimestamp 11:33:06 INFO - PID 1582 | 11:33:06 INFO - PID 1582 | ------- Summary: start ------- 11:33:06 INFO - PID 1582 | Number of tests: 14 11:33:06 INFO - PID 1582 | 11:33:06 INFO - PID 1582 | [#0] ai-astar Cycles:10 Average:105.50 Median:107.00 stddev:3.98 (3.7%) stddev-sans-first:3.46 11:33:06 INFO - PID 1582 | Values: 99.0 107.0 102.0 106.0 107.0 112.0 107.0 100.0 108.0 107.0 11:33:06 INFO - PID 1582 | 11:33:06 INFO - PID 1582 | [#1] audio-beat-detection Cycles:10 Average:138.80 Median:143.00 stddev:20.30 (14.2%) stddev-sans-first:21.47 11:33:06 INFO - PID 1582 | Values: 143.0 115.0 143.0 170.0 122.0 150.0 141.0 119.0 168.0 117.0 11:33:06 INFO - PID 1582 | 11:33:06 INFO - PID 1582 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:2.87 (1.8%) stddev-sans-first:3.04 11:33:06 INFO - PID 1582 | Values: 163.0 163.0 163.0 161.0 161.0 160.0 162.0 161.0 167.0 169.0 11:33:06 INFO - PID 1582 | 11:33:06 INFO - PID 1582 | [#3] audio-fft Cycles:10 Average:94.70 Median:74.00 stddev:39.68 (53.6%) stddev-sans-first:41.31 11:33:06 INFO - PID 1582 | Values: 73.0 81.0 74.0 183.0 85.0 74.0 73.0 74.0 154.0 76.0 11:33:06 INFO - PID 1582 | 11:33:06 INFO - PID 1582 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:79.00 stddev:25.76 (32.6%) stddev-sans-first:26.64 11:33:06 INFO - PID 1582 | Values: 79.0 82.0 135.0 80.0 79.0 79.0 133.0 79.0 78.0 130.0 11:33:06 INFO - PID 1582 | 11:33:06 INFO - PID 1582 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:33:06 INFO - PID 1582 | Values: 114.0 115.0 115.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 11:33:06 INFO - PID 1582 | 11:33:06 INFO - PID 1582 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:148.00 stddev:3.00 (2.0%) stddev-sans-first:3.10 11:33:06 INFO - PID 1582 | Values: 147.0 157.0 150.0 148.0 148.0 147.0 148.0 147.0 149.0 148.0 11:33:06 INFO - PID 1582 | 11:33:06 INFO - PID 1582 | [#7] imaging-desaturate Cycles:10 Average:93.60 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.53 11:33:06 INFO - PID 1582 | Values: 95.0 93.0 93.0 94.0 94.0 93.0 93.0 93.0 94.0 94.0 11:33:06 INFO - PID 1582 | 11:33:06 INFO - PID 1582 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:1.70 (3.3%) stddev-sans-first:1.80 11:33:06 INFO - PID 1582 | Values: 52.0 52.0 51.0 51.0 57.0 52.0 52.0 52.0 52.0 52.0 11:33:06 INFO - PID 1582 | 11:33:06 INFO - PID 1582 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:0.32 (0.8%) stddev-sans-first:0.33 11:33:06 INFO - PID 1582 | Values: 38.0 38.0 39.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 11:33:06 INFO - PID 1582 | 11:33:06 INFO - PID 1582 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:75.50 stddev:1.78 (2.4%) stddev-sans-first:1.88 11:33:06 INFO - PID 1582 | Values: 76.0 76.0 73.0 75.0 75.0 75.0 79.0 75.0 74.0 78.0 11:33:06 INFO - PID 1582 | 11:33:06 INFO - PID 1582 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:124.50 stddev:12.16 (9.8%) stddev-sans-first:12.89 11:33:06 INFO - PID 1582 | Values: 126.0 120.0 128.0 123.0 119.0 124.0 121.0 119.0 125.0 160.0 11:33:06 INFO - PID 1582 | 11:33:06 INFO - PID 1582 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:172.50 stddev:3.07 (1.8%) stddev-sans-first:3.26 11:33:06 INFO - PID 1582 | Values: 172.0 175.0 171.0 170.0 177.0 170.0 176.0 168.0 173.0 169.0 11:33:06 INFO - PID 1582 | 11:33:06 INFO - PID 1582 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:1.16 (1.8%) stddev-sans-first:1.13 11:33:06 INFO - PID 1582 | Values: 65.0 65.0 65.0 64.0 64.0 63.0 63.0 64.0 62.0 62.0 11:33:06 INFO - PID 1582 | -------- Summary: end -------- 11:33:06 INFO - PID 1582 | 11:33:06 INFO - PID 1582 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:33:06 INFO - TEST-INFO | 1582: exit 0 11:33:06 INFO - TEST-OK | kraken | took 61101ms 11:33:06 INFO - SUITE-END | took 1171s 11:33:07 INFO - Completed test suite (00:19:32) 11:33:07 INFO - javascript benchmark 11:33:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8478.761427286938, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3299.05976796613, 3338.3323335332934, 3361.9495707564383, 3366.2257680733446, 3372.6795954384324, 6224.564280500355, 6292.685365731712, 6319.5576309658345, 6361.968190159054, 6367.713452894619, 6151.41561551653, 6233.937660623393, 6255.06174073888, 6261.843453913654, 6276.654783986879, 5718.799842005531, 5723.5135013523795, 5745.540356771448, 5756.510696590794, 5853.50245229156, 5822.214001109838, 5841.591088623798, 5856.795012174574, 5890.057590785475, 5916.615419997708, 5498.065328894098, 5621.0444224481935, 5711.428857114297, 5831.737571809279, 5838.474537291643, 5669.206311116406, 5707.143928410772, 5756.107803290497, 5783.5951483396175, 5796.449337312949, 5675.460831221028, 5713.200151978726, 5739.598228124033, 5744.770209191627, 5760.222369980041, 6081.422264884829, 6146.416090471398, 6216.471599914013, 6271.905921411182, 6299.968500157515, 6706.83232919181, 6740.696668649923, 6742.258351581322, 6747.089142965686, 6758.189017317954, 6754.864902701967, 6813.3527314905, 6822.658867056677, 6837.760678376283, 6866.931330686679, 6255.499560035186, 6261.9373806262265, 6351.682415879188, 6370.55406121567, 6372.84067898297, 6773.221079575814, 6879.174499060145, 6893.276205998298, 6894.207166175854, 6916.412104971033, 6494.447971922439, 6580.901286480706, 6580.967095164494, 6584.539082264291, 6592.143021407186, 6771.0, 6785.796426107225, 6798.286179951133, 6806.591604503746, 6816.4546836252985, 6699.665016749241, 6709.329067093349, 6767.492438067165, 6788.830279243059, 6811.795646130624, 6608.3391660834495, 6725.05849181115, 6734.1918969722965, 6816.591004539743, 6830.043793868862, 4933.0380575788095, 4959.404871415381, 4966.801327946841, 4970.2793095001025, 4973.0, 4375.6280716138845, 4377.124575084932, 4431.556844315543, 4436.44544431946, 4447.043885564619, 5879.794207202727, 5907.497862681635, 5948.970255148696, 5951.404859514014, 5955.285365756137, 6699.564528305645, 6709.060731497594, 6788.898166527506, 6800.727970881109, 6804.251532331439, 5735.684537350402, 5835.066389377679, 5836.620619659709, 5844.152597873284, 5933.821985340447, 5791.942080579224, 5808.099744539603, 5809.099589563624, 5810.273715785527, 5815.41845815415, 6530.346965303432, 6552.246491653425, 6626.768063117768, 6631.767888123893, 6650.235222949423, 6704.128463299739, 6713.765018224339, 6785.59286442815, 6786.219584747719, 6796.966015169893, 6415.679216039272, 6489.675516224264, 6545.0, 6628.105205797156, 6644.4020038196795, 6625.0, 6693.631850248283, 6704.195496540447, 6710.698018589078, 6722.05891175226, 6752.088468056946, 6786.049953006484, 6833.043373927753, 6877.0, 6878.071460352989, 6515.576487528296, 6543.509236807164, 6593.538452308292, 6594.142761440982, 6609.339066093352, 6346.111544383698, 6528.804135875931, 6530.640814755234, 6613.570117942319, 6628.635425051669, 6441.452476539546, 6469.77355792545, 6503.674816259263, 6505.707243173973, 6521.576097553644, 6516.6415847128865, 6551.967240163769, 6567.343265673586, 6644.368784965421, 6674.532782705164, 6349.301576826453, 6357.745690172342, 6357.841053973688, 6441.162648855806, 6449.6130232186215], "value": 6131.50711175086, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.7232596265344, 848.9490630562166, 862.331692937973, 863.3136656358197, 1120.787050460413, 29214.0, 30101.0, 38721.99999999996, 39420.40869386961, 39421.80289098558, 39331.21337573247, 39753.80123099388, 39776.40335394971, 39777.80111099448, 39811.0, 7414.036175297218, 7596.5062270952485, 7596.544207347549, 7597.734079307225, 7598.354139898115, 7466.813329666747, 7559.773206803805, 7566.810829729246, 7567.091948966105, 7572.886406703877, 7534.962325188367, 7537.321641052305, 7567.394608431312, 7582.090149182106, 7596.202398748134, 7508.962455187744, 7541.358984486325, 7543.886841697379, 7561.659725312346, 7566.546007239584, 7426.368758655521, 7480.0, 7480.476366654337, 7482.0, 7489.475736698433, 35416.82291588551, 35672.10819729501, 35734.82132589346, 35744.64255357439, 35797.284054319025, 3478.1652403422995, 3527.8236088195486, 3533.134382076382, 3534.045807631925, 3534.32847758925, 28895.277618059506, 28912.42175156506, 28942.13173604795, 29011.12966610984, 29063.564046539108, 4938.555530002282, 4948.1093403187415, 4967.230079337708, 5007.749612519396, 5007.924881126786, 180031.0, 182165.0, 182498.0, 182661.0866945657, 183585.08207458878, 44255.55744442579, 44339.55660443419, 44378.11243775171, 44411.55588444139, 44448.55551444509, 50921.0, 51618.741906290226, 51642.0, 51723.0, 51785.74107129515, 12625.0, 12761.106722529334, 15628.531144065697, 15798.68402631941, 15898.76151857723, 13043.086983911035, 13062.150960187557, 13063.0, 13067.869321306665, 13078.411471483807, 13602.93198534001, 13614.18314901109, 13636.52272170489, 13674.726505469835, 13758.65603359924, 5476.616636835383, 5558.944410555923, 5576.442355764391, 5593.608447408642, 5671.347795003545, 969.7769513012047, 980.475445636581, 1008.6016023670609, 1014.3102690170755, 1016.8068067067381, 21629.675554866688, 21657.133714651238, 21683.34949951504, 22398.0, 22519.324420267418, 1091.3779145886767, 1092.6612750047511, 1104.1442881766534, 1108.141190577309, 1112.788570171681, 11471.770564588662, 11714.765704685859, 11723.706907327385, 11794.233374830781, 11806.114541409428, 221679.0, 222028.0, 222236.0, 222925.0, 223331.0, 47541.0, 48309.75845120752, 48365.274520882216, 48379.5162048375, 48609.0, 1411.1885665742034, 1417.2205287092058, 1427.9928600356932, 1436.6911114110308, 1443.0980637101811, 21427.571448571252, 21459.961303676126, 21698.457538561663, 21836.56326873422, 21996.560068798855, 34319.142021448664, 34391.4841277376, 34477.13807154841, 34557.30885382228, 34640.133996650286, 185209.0, 185326.0, 185821.0, 185872.0, 185960.0, 31253.531197031607, 31803.20491987626, 31824.681753183097, 32021.519677204393, 32203.194920126247, 38532.80733596314, 38696.226075478895, 38964.220715586096, 39208.215835683695, 39341.6065839338, 29241.543406431225, 30170.24574385658, 31769.20576985594, 32018.679813202503, 32126.0, 30994.84502577563, 31217.843910780302, 31288.0, 31300.530492043094, 31560.842195788875, 34735.30529389449, 34813.65186348104, 34846.303073937874, 35100.824495878376, 35388.46917296294, 31159.376812464077, 31160.0, 31548.0, 31638.525422119146, 32073.35853282968, 23418.76581234234, 23663.29010129699, 23831.0, 24112.0, 24276.271711848673], "value": 16472.230064320618, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.1533669134421, 542.9511343979041, 544.5643485211831, 552.7733629212024, 556.6214973817803, 21310.57378852422, 21963.670544941837, 22017.559648807015, 22045.11819527217, 22054.669179962275, 23075.192368267115, 24084.397890052758, 25253.368665783364, 25402.0, 25459.0, 6512.641804700751, 6651.501137414713, 6652.401283884449, 6653.767118150866, 6657.267700552935, 6239.469645080151, 6584.506162037842, 6606.735730570796, 6629.303923088079, 6632.602043877383, 6577.638229897354, 6582.605043697394, 6584.9012264816065, 6585.93414065858, 6589.637569933651, 6545.116409284733, 6552.410283074499, 6564.048213009087, 6564.442022428099, 6567.901481477782, 6044.516438684895, 6046.516278697693, 6059.363766804466, 6069.423404776539, 6084.117802918552, 27788.58317125245, 27923.301917452227, 28332.858335708395, 28480.430391392056, 29248.268793280124, 2033.745781777278, 2078.1791192478886, 2083.1250874632537, 2084.739407574053, 2088.644930361827, 19198.904005480024, 19388.515287117792, 19402.22391104354, 19542.51143721404, 19709.80290197094, 2489.751024897514, 2503.4242124311327, 2566.8588227647474, 2571.6785401824773, 2577.6262441946, 136402.31798841042, 138826.0, 139187.0, 139267.30366348205, 139348.0, 19244.652874298663, 20371.490712732004, 21037.78962210389, 21357.0, 21567.784322156578, 41392.1721565567, 41417.0, 41491.585084149374, 41565.1686966259, 41589.58410415857, 11375.374354410587, 11498.42507874603, 11523.654290371302, 11555.364454955059, 11701.941490292664, 8556.914430855611, 9546.284028697875, 9696.418214907128, 9708.563114659857, 9797.265205109645, 9456.810863782686, 10996.28524145928, 11129.332240065622, 11343.376114313627, 11409.48657310423, 3533.7349698772696, 3664.358737220976, 4058.8782336529953, 4160.521540022875, 4186.937195942002, 957.1768279279814, 971.7327734872825, 982.5578489679673, 991.9454430006275, 1001.929864909464, 19126.0, 19391.806081939, 19427.0, 19903.004849757453, 22929.541409171725, 1003.508280942333, 1040.1366865501616, 1042.8632790258655, 1046.7330830638139, 1063.7606538528769, 10758.139348852073, 12932.482700691868, 13839.792403113961, 13855.445782168601, 14055.086419382911, 514195.0, 526390.0, 528433.0, 540846.0, 541300.0, 115917.4204128974, 116570.41714791542, 117369.0, 117746.0, 117814.0, 1234.512367614787, 1235.9382030898419, 1258.9748205035849, 1269.9238045717286, 1272.7963525835821, 20862.895685521475, 21085.262015829372, 21155.788442115383, 21404.892975535022, 21735.782642173377, 57762.0, 58119.4188058114, 58541.0, 58731.11903321368, 59457.70271148616, 70666.0, 71228.64385678039, 71388.64305678438, 74007.62996184985, 74737.0, 11936.880631193577, 12418.441170147184, 13989.0, 14193.645158871112, 14604.415823367372, 22424.0, 22671.546569068196, 22713.205037823598, 22733.545329093657, 22889.542209156058, 18096.276148953893, 18151.81848181501, 18421.447356579323, 18486.260549577866, 18494.0752962354, 16411.753823692892, 16447.013179209287, 16858.241379137722, 17304.740428893827, 17312.913435432743, 18658.44024679262, 18725.0, 18766.906165469085, 18830.152643131365, 18979.71530427072, 14155.64610884736, 14168.220747858555, 14291.42834286617, 14309.785353219502, 14311.355988980313, 17887.73168402501, 17938.91030544839, 18127.546811329823, 18177.727334089734, 18318.450446486626], "value": 12643.641074107896, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1295.2940647347195, 1326.098253187832, 1326.1645163546964, 1349.8447678516973, 1357.945682172713, 14241.0, 14645.926770366146, 14662.486812961548, 14709.779353309708, 14738.336774845131, 14939.925300373483, 15204.543863684079, 15213.92393038036, 15297.388104475835, 15324.310406031727, 2419.4072452249225, 2649.3641526033807, 2698.716634753352, 2700.176446183913, 2701.0951331304036, 2577.1495406515805, 2634.7496987786226, 2635.196265139132, 2635.696894857087, 2636.5913283441096, 2520.407704189523, 2539.3397716593636, 2554.514642217973, 2558.6801649793774, 2596.6624338835927, 2505.023041014006, 2521.684789401325, 2528.8609126498036, 2529.064246228889, 2529.5067461844947, 2466.7409921958297, 2479.789217916479, 2503.5368456835545, 2504.3864253257884, 2505.361132911114, 13932.791008134885, 14250.2162381069, 14273.78589321161, 14278.571642850731, 14285.928570357186, 7523.962380188064, 7750.496217745828, 7948.523088614702, 7956.641951112214, 7969.721059762938, 5271.103912334912, 5454.372747134051, 5470.589705772083, 5471.890562188773, 5531.170324451325, 1864.7296142059326, 1886.1323791056132, 1889.8488120950292, 1946.9221231150736, 1948.279136719423, 24064.879675601685, 24416.267511974493, 24561.877190614112, 24655.137070202458, 24682.629760553784, 6726.3946244837225, 6728.596284222962, 6767.864642707217, 6834.419074378733, 6847.774473296198, 18781.0, 18838.3406580769, 18906.243750249836, 18930.148143333583, 18951.71572426387, 7756.457048006585, 7829.804254893559, 8032.598370081472, 8044.718434854752, 8048.59757012147, 5555.099339667722, 6150.415710507495, 6190.81427557174, 7150.356467917913, 7158.0, 4709.646776491777, 4820.469748327681, 4848.393950756155, 4877.073356062337, 4887.36464259644, 1369.2263870912902, 1370.691594391254, 1384.508499482669, 1396.0576610787678, 1397.5737400092867, 860.3805260212762, 884.8451520983803, 898.0660113481906, 903.5482258870564, 904.7104926423482, 7379.3358597726465, 7450.366718828852, 7451.925480745232, 7510.023696919366, 7529.774106776806, 697.2678687378233, 702.8664553734774, 704.9048378468943, 710.7974227345181, 712.5582139073704, 4471.128130014616, 4920.704757714549, 5108.055009823194, 5169.663971841818, 5303.893922121536, 19502.8049719501, 19889.502762431053, 20072.598548028956, 20139.295124670858, 20141.697874531892, 19658.0, 19866.404007879788, 19936.601267974558, 19969.301074462324, 19971.800281997286, 9839.444402957239, 10137.087662110445, 10480.161587073017, 10535.894641053645, 10550.0504954556, 7889.368850492062, 7921.247481489249, 7986.201379861967, 8191.918080819116, 8382.0, 17014.31942722327, 17197.74203386925, 17247.65504689874, 17502.47492575225, 18216.726749099038, 17724.202410891285, 17992.91003544974, 18067.819321806615, 18149.727754083964, 18331.633367332313, 11716.70708232301, 11846.466908988943, 11943.462544185359, 11954.58158964432, 11968.222065565711, 12914.547990820276, 13200.33998300062, 13268.402921868346, 13333.666658333232, 13403.731925361242, 10991.175661825555, 11043.779124417306, 11070.114390848874, 11182.0, 11536.192466527598, 9847.261455390731, 10077.798444031225, 10169.491525423848, 10189.592416303265, 10203.540840662337, 8540.658373665232, 9263.397879137834, 9357.298202634965, 9364.765880853032, 9376.57805398745, 6613.603183808987, 6849.24658287578, 6878.312168783082, 6920.792376228721, 6935.514513984174, 6988.965055174692, 7017.578945263301, 7046.4010559101, 7055.788326350218, 7090.361867431956], "value": 6345.648352344998, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.957928576071, 498.29740066506224, 513.4377856247409, 517.9663321884075, 529.625621512176, 6208.968955155229, 6223.346548612399, 6239.282482514513, 6277.968610156943, 6327.240731112267, 6128.540359473046, 6201.410865967726, 6201.658908760016, 6237.261719218319, 6261.749530018794, 4845.152098382769, 4925.138100832358, 4974.776135073912, 5066.518680725344, 5098.9745051274695, 4926.719053046216, 4941.802327906879, 4982.377202849644, 5009.747563109223, 5030.547250747432, 4865.41615006198, 4889.853304400874, 4938.308636790852, 4943.851684449454, 4955.0, 4947.183714687072, 4949.307097006422, 4955.132851750947, 4959.330490383788, 4982.103221420143, 4427.800748966304, 4448.310511870665, 4467.642588592905, 4471.39636149119, 4478.8432404866, 5925.355906117749, 6004.699765011732, 6021.969890150565, 6080.422359875804, 6089.634621922699, 5629.211910332557, 5646.237757902672, 5662.348829884575, 5676.858078548028, 5689.487946084872, 6559.508036897252, 6569.934300657028, 6572.342765723437, 6591.274959754423, 6612.404883560503, 4819.9036019279765, 4832.226843704991, 4838.322634831126, 4841.273808928654, 4858.222684370484, 6568.244651865001, 6775.424088952445, 6789.321067893171, 6801.979703044533, 6946.687399067054, 4884.194107972145, 4978.128827455181, 4989.226669866177, 5023.031804874182, 5023.899522009539, 5070.264811602297, 5088.262201980692, 5097.470758772353, 5098.5411312982005, 5111.821086262037, 5673.432656734376, 5695.658260504383, 5704.515116215085, 5712.6286791358425, 5719.970405326998, 6598.492572822297, 6611.173603299588, 6646.4350530205475, 6646.933530664728, 6648.301928297556, 1757.2882982392152, 1781.5368004318711, 1782.7504149419092, 1782.9108544572719, 1789.4094948667168, 1173.730042090324, 1223.4922507159606, 1224.7489264700714, 1226.4174517104304, 1237.616338934933, 5878.823635290948, 5887.646741195542, 5888.146218798336, 5902.881942361215, 5917.349091599921, 6719.656068786262, 6721.4958878084335, 6740.258571557125, 6748.4938629602975, 6758.357955994173, 5811.3316968548315, 5827.3007239131575, 5828.591998560145, 5838.9124163137585, 5850.912236316459, 3475.669811367916, 3494.4932984717584, 3531.1285018940002, 3547.0777597824235, 3549.982250088733, 6485.254195767453, 6497.155369801895, 6538.215414150332, 6538.738450461929, 6539.346065393518, 6441.0, 6789.25318214996, 6826.761063362758, 6839.692213850389, 6863.210730766026, 6460.709268082947, 6478.190226221723, 6537.084808126866, 6549.115869357671, 6568.408843204134, 6596.80209593713, 6598.406143447113, 6702.229243636849, 6704.83237919056, 6723.495737819585, 6506.60960342381, 6626.635535045619, 6662.933370666231, 6670.66646667655, 6756.966215168893, 6472.288048314776, 6479.546431749733, 6482.189726284215, 6507.837304067436, 6563.324538258399, 4964.180910149785, 4967.875803104951, 4983.601311895112, 5008.77460514285, 5020.347354843847, 6463.612183269019, 6596.967015164893, 6622.602643841192, 6722.1261236039, 6840.657967101724, 6215.782447614311, 6526.118973938457, 6549.836254093686, 6554.868902622016, 6565.441937435371, 6488.480921526361, 6497.350264973654, 6503.934960650522, 6504.544681872224, 6540.542162048611, 6427.3251308611925, 6460.289368169404, 6474.093626892333, 6480.643564603992, 6519.869602608016, 6563.195121341479, 6576.901346479903, 6591.802245932629, 6616.603003819786, 6653.401193892573, 6315.273743519554, 6321.652309123042, 6382.6491092176975, 6395.488360931207, 6426.068220108152], "value": 5051.121501215472, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.9089300176979, 836.3518273338159, 848.1899785704651, 874.8075423406852, 895.1898531828697, 18602.0, 19410.51473713158, 19422.126004329803, 19449.513762155937, 19963.800361996375, 20159.59680806383, 20418.591628167465, 20575.588488230263, 20811.959402029912, 20843.791562084374, 914.9130832570895, 926.4117285523707, 927.0081013315755, 928.4522131942152, 928.5264515097282, 913.5112714697638, 932.8181004704086, 940.5156344482563, 940.9341346105775, 942.8020115775661, 993.3443927008176, 997.4065431068502, 997.7655251016006, 997.9151772099381, 1000.8548760429734, 991.9702408927708, 993.6323560282669, 993.9155171810405, 995.0, 995.0894931138037, 735.2867718313228, 736.4292673178276, 736.4329466310965, 736.4403053679189, 736.7863319637353, 18379.26482940681, 18537.814621853744, 18757.0, 18777.718334225, 19519.609607807906, 20513.589728205352, 20547.89726051375, 20556.691649625267, 20937.0, 20960.895195524077, 16776.245068971926, 16838.158092095346, 16933.830661693348, 16953.237104330336, 16996.235169417407, 3482.320947415255, 3484.930301393958, 3498.073010652179, 3500.2299494111253, 3504.6495350465007, 122910.0, 125115.37442312822, 125460.99999999908, 126873.36563317124, 128327.0, 16193.433229836899, 16257.91871040661, 16463.34146634121, 16501.174941253128, 16523.091229982227, 29087.41825163485, 29281.414371712446, 29634.259143521584, 29685.81256749749, 29747.85126074399, 8181.181881811771, 8320.542370169578, 8323.292520135856, 8334.791630209293, 8352.12302708219, 4311.784410779511, 4437.0, 4442.244818380883, 4449.2658711312915, 4449.3326001100095, 4822.035592881438, 4994.3507344045765, 5007.12375334315, 5014.34813474246, 5015.774290156952, 924.8289066522715, 948.5352177433008, 952.2001518724305, 965.6958058211641, 967.9612815487443, 668.8327918020495, 684.2746688510196, 684.910961574992, 687.5015613680042, 697.9895301570481, 12025.218360806695, 12247.510099595916, 12400.0, 12567.434465449076, 12634.052446066582, 678.2302087131142, 680.8161796314968, 690.0856365315976, 690.4614400767409, 698.183125742882, 5576.972115139399, 5608.831735047955, 5678.261825962599, 5689.431056894277, 5808.128780682931, 111400.4429977845, 114415.0, 114540.42729786297, 116154.0, 119741.0, 98844.0, 99186.5040674792, 102248.48875755574, 105606.0, 106186.0, 87216.0, 88898.0, 90040.5497972506, 91650.0, 92172.0, 10581.4709264538, 10583.994520520539, 10611.045005949502, 10669.093127084285, 10803.0, 38221.80889095537, 39504.60495395009, 40576.0, 40665.39001915033, 40691.7965410171, 72183.27816721976, 73551.26448735445, 73690.0, 76380.23619763953, 78422.0, 17237.138143092543, 17427.215775290395, 17534.386296479563, 18380.908095459436, 18418.447446576625, 20299.69550456774, 20635.14283714473, 20662.58674826465, 21345.25291614786, 21391.144354225657, 19366.128524216725, 19870.205191792167, 19962.500937476678, 19995.100220490403, 20103.29638462647, 16586.668266634842, 18984.905075474533, 19534.0, 20034.799652003294, 20112.09495572732, 18913.810861891754, 19346.903265484147, 19348.4195474136, 19564.90217548903, 19704.31034913771, 12227.0, 12943.741125177632, 13124.540641077516, 13323.400446979715, 13599.456021759019, 13209.933950330187, 14502.0, 15134.470293539673, 15145.772813407588, 15194.316255768295], "value": 9076.374428048626, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1482.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 107.0, 102.0, 106.0, 107.0, 112.0, 107.0, 100.0, 108.0, 107.0], "value": 105.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 115.0, 143.0, 170.0, 122.0, 150.0, 141.0, 119.0, 168.0, 117.0], "value": 138.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 161.0, 161.0, 160.0, 162.0, 161.0, 167.0, 169.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 81.0, 74.0, 183.0, 85.0, 74.0, 73.0, 74.0, 154.0, 76.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 135.0, 80.0, 79.0, 79.0, 133.0, 79.0, 78.0, 130.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 157.0, 150.0, 148.0, 148.0, 147.0, 148.0, 147.0, 149.0, 148.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 93.0, 94.0, 94.0, 93.0, 93.0, 93.0, 94.0, 94.0], "value": 93.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 51.0, 57.0, 52.0, 52.0, 52.0, 52.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 39.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 73.0, 75.0, 75.0, 75.0, 79.0, 75.0, 74.0, 78.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 120.0, 128.0, 123.0, 119.0, 124.0, 121.0, 119.0, 125.0, 160.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 175.0, 171.0, 170.0, 177.0, 170.0, 176.0, 168.0, 173.0, 169.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 64.0, 63.0, 63.0, 64.0, 62.0, 62.0], "value": 63.7, "unit": "score"}]}]} 11:33:07 INFO - Return code: 0 11:33:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:33:07 INFO - # TBPL SUCCESS # 11:33:07 INFO - Running post-action listener: _package_coverage_data 11:33:07 INFO - Running post-action listener: _resource_record_post_action 11:33:07 INFO - [mozharness: 2017-08-29 18:33:07.433204Z] Finished run-tests step (success) 11:33:07 INFO - Running post-run listener: _resource_record_post_run 11:33:07 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 434872320; Read time: 8; Write time: 307712 11:33:07 INFO - TinderboxPrint: CPU usage
13.1% 11:33:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 11:33:07 INFO - TinderboxPrint: I/O write bytes / time
434,872,320 / 307,712 11:33:07 INFO - TinderboxPrint: CPU idle
8,246.0 (86.9%) 11:33:07 INFO - TinderboxPrint: CPU user
1,193.7 (12.6%) 11:33:07 INFO - TinderboxPrint: Swap in / out
0 / 0 11:33:07 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105361408; Read time: 0; Write time: 80636 11:33:07 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:33:07 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 327987200; Read time: 0; Write time: 227004 11:33:08 INFO - Running post-run listener: _upload_blobber_files 11:33:08 INFO - Blob upload gear active. 11:33:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:33:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:33:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:33:08 INFO - (blobuploader) - INFO - Open directory for files ... 11:33:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:33:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:33:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:09 INFO - (blobuploader) - INFO - Done attempting. 11:33:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:33:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:33:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:10 INFO - (blobuploader) - INFO - Done attempting. 11:33:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:33:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:33:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:17 INFO - (blobuploader) - INFO - Done attempting. 11:33:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:33:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:33:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:18 INFO - (blobuploader) - INFO - Done attempting. 11:33:18 INFO - (blobuploader) - INFO - Iteration through files over. 11:33:18 INFO - Return code: 0 11:33:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:33:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:33:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/301e907ba3389613c7e8e88d90cc64121ace65da8c788209a5a04d41002d5dd737a61153015b55aadf8f0b3e746c4b672fd67c8e9dd2ae2f1783eb9e096632a0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a45b72e06ab47277d2a8bdd9f1f23d15c9185ab21babd663d3292441119fbdf04017696ec5f229fce1a301bba707e207c4f9675c7aed4bb4333a19858e9323f0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65828a80b869e25818e8b4dbd77faee4cefb2eacb2751f8b6e3d639d772e48e0104adb91c01efea68707aa7a9ef5874f54ee5f7f106e864c43e9fe51d90558e4", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3db0733da833c55382ec5879b6b62545c6614ef164df8eb8bad193860456f67a8551928c65d4c5ced95b40538e9d2a8a7e8a6b7ae327aaf43d3014e0bb8041f2"} 11:33:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:33:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:33:18 INFO - Contents: 11:33:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/301e907ba3389613c7e8e88d90cc64121ace65da8c788209a5a04d41002d5dd737a61153015b55aadf8f0b3e746c4b672fd67c8e9dd2ae2f1783eb9e096632a0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a45b72e06ab47277d2a8bdd9f1f23d15c9185ab21babd663d3292441119fbdf04017696ec5f229fce1a301bba707e207c4f9675c7aed4bb4333a19858e9323f0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65828a80b869e25818e8b4dbd77faee4cefb2eacb2751f8b6e3d639d772e48e0104adb91c01efea68707aa7a9ef5874f54ee5f7f106e864c43e9fe51d90558e4", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3db0733da833c55382ec5879b6b62545c6614ef164df8eb8bad193860456f67a8551928c65d4c5ced95b40538e9d2a8a7e8a6b7ae327aaf43d3014e0bb8041f2"} 11:33:18 INFO - Running post-run listener: copy_logs_to_upload_dir 11:33:18 INFO - Copying logs to upload dir... 11:33:18 INFO - mkdir: /builds/slave/test/build/upload/logs 11:33:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.748785 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-29 11:33:18.808031) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-29 11:33:18.811256) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/301e907ba3389613c7e8e88d90cc64121ace65da8c788209a5a04d41002d5dd737a61153015b55aadf8f0b3e746c4b672fd67c8e9dd2ae2f1783eb9e096632a0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a45b72e06ab47277d2a8bdd9f1f23d15c9185ab21babd663d3292441119fbdf04017696ec5f229fce1a301bba707e207c4f9675c7aed4bb4333a19858e9323f0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65828a80b869e25818e8b4dbd77faee4cefb2eacb2751f8b6e3d639d772e48e0104adb91c01efea68707aa7a9ef5874f54ee5f7f106e864c43e9fe51d90558e4", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3db0733da833c55382ec5879b6b62545c6614ef164df8eb8bad193860456f67a8551928c65d4c5ced95b40538e9d2a8a7e8a6b7ae327aaf43d3014e0bb8041f2"} build_url:https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011204 build_url: 'https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/301e907ba3389613c7e8e88d90cc64121ace65da8c788209a5a04d41002d5dd737a61153015b55aadf8f0b3e746c4b672fd67c8e9dd2ae2f1783eb9e096632a0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a45b72e06ab47277d2a8bdd9f1f23d15c9185ab21babd663d3292441119fbdf04017696ec5f229fce1a301bba707e207c4f9675c7aed4bb4333a19858e9323f0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65828a80b869e25818e8b4dbd77faee4cefb2eacb2751f8b6e3d639d772e48e0104adb91c01efea68707aa7a9ef5874f54ee5f7f106e864c43e9fe51d90558e4", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3db0733da833c55382ec5879b6b62545c6614ef164df8eb8bad193860456f67a8551928c65d4c5ced95b40538e9d2a8a7e8a6b7ae327aaf43d3014e0bb8041f2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-29 11:33:18.838039) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 11:33:18.838377) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1504026578.819019-978308491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 11:33:18.923921) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-29 11:33:18.924243) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-29 11:33:18.924551) ========= ========= Total master_lag: 0.21 =========