builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-008 starttime: 1506938664.85 results: success (0) revision: 97efdde466f18cf580fda9673cf4c38ee21fc7b7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 03:04:24.855153) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 03:04:24.855576) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 03:04:24.855856) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 03:04:24.897266) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 03:04:24.897519) ========= 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=32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-02 03:04:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.4M=0s 2017-10-02 03:04:24 (50.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.077663 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 03:04:24.992545) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 03:04:24.995874) ========= 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=32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020058 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 03:04:25.045629) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-02 03:04:25.048978) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 97efdde466f18cf580fda9673cf4c38ee21fc7b7 --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 97efdde466f18cf580fda9673cf4c38ee21fc7b7 --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=32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-02 03:04:25,094 truncating revision to first 12 chars 2017-10-02 03:04:25,094 Setting DEBUG logging. 2017-10-02 03:04:25,094 attempt 1/10 2017-10-02 03:04:25,095 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/97efdde466f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-02 03:04:26,356 unpacking tar archive at: mozilla-central-97efdde466f1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.533823 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-02 03:04:26.599422) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 03:04:26.602747) ========= script_repo_revision: 97efdde466f18cf580fda9673cf4c38ee21fc7b7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 03:04:26.603218) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 03:04:26.603484) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 03:04:26.619560) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-10-02 03:04:26.619969) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:04:26 INFO - MultiFileLogger online at 20171002 03:04:26 in /builds/slave/test 03:04:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:04:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:04:26 INFO - {'append_to_log': False, 03:04:26 INFO - 'base_work_dir': '/builds/slave/test', 03:04:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:04:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:04:26 INFO - 'branch': 'Firefox-Non-PGO', 03:04:26 INFO - 'buildbot_json_path': 'buildprops.json', 03:04:26 INFO - 'code_coverage': False, 03:04:26 INFO - 'config_files': ('talos/linux_config.py',), 03:04:26 INFO - 'default_actions': ('clobber', 03:04:26 INFO - 'read-buildbot-config', 03:04:26 INFO - 'download-and-extract', 03:04:26 INFO - 'populate-webroot', 03:04:26 INFO - 'create-virtualenv', 03:04:26 INFO - 'install', 03:04:26 INFO - 'setup-mitmproxy', 03:04:26 INFO - 'run-tests'), 03:04:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:04:26 INFO - 'disable_ccov_upload': False, 03:04:26 INFO - 'disable_stylo': False, 03:04:26 INFO - 'download_minidump_stackwalk': True, 03:04:26 INFO - 'download_symbols': 'ondemand', 03:04:26 INFO - 'enable_stylo': False, 03:04:26 INFO - 'enable_webrender': False, 03:04:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:04:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:04:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:04:26 INFO - 'gecko_profile': False, 03:04:26 INFO - 'gecko_profile_interval': 0, 03:04:26 INFO - 'installer_path': 'installer.exe', 03:04:26 INFO - 'log_level': 'info', 03:04:26 INFO - 'log_name': 'talos', 03:04:26 INFO - 'log_to_console': True, 03:04:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:04:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:04:26 INFO - 'opt_config_files': (), 03:04:26 INFO - 'pip_index': False, 03:04:26 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 03:04:26 INFO - 'system_bits': '32', 03:04:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:04:26 INFO - 'title': 'talos-linux64-ix-008', 03:04:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:04:26 INFO - 'use_talos_json': True, 03:04:26 INFO - 'verify': 'False', 03:04:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:04:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:04:26 INFO - 'work_dir': 'build'} 03:04:26 INFO - [mozharness: 2017-10-02 10:04:26.810201Z] Running clobber step. 03:04:26 INFO - Running pre-action listener: _resource_record_pre_action 03:04:26 INFO - Running main action method: clobber 03:04:26 INFO - rmtree: /builds/slave/test/build 03:04:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:04:27 INFO - Running post-action listener: _resource_record_post_action 03:04:27 INFO - [mozharness: 2017-10-02 10:04:27.810342Z] Finished clobber step (success) 03:04:27 INFO - [mozharness: 2017-10-02 10:04:27.810440Z] Running read-buildbot-config step. 03:04:27 INFO - Running pre-action listener: _resource_record_pre_action 03:04:27 INFO - Running main action method: read_buildbot_config 03:04:27 INFO - Using buildbot properties: 03:04:27 INFO - { 03:04:27 INFO - "project": "", 03:04:27 INFO - "product": "firefox", 03:04:27 INFO - "who": "archaeopteryx@coole-files.de", 03:04:27 INFO - "installer_path": "public/build/target.tar.bz2", 03:04:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 03:04:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:04:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 03:04:27 INFO - "stage_platform": "linux64", 03:04:27 INFO - "basedir": "/builds/slave/test", 03:04:27 INFO - "buildnumber": 89, 03:04:27 INFO - "platform": "ubuntu64_hw", 03:04:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:04:27 INFO - "slavebuilddir": "test", 03:04:27 INFO - "taskId": "Hty74AN9TQSBZmqDImdiPg", 03:04:27 INFO - "branch": "mozilla-central", 03:04:27 INFO - "script_repo_revision": "production", 03:04:27 INFO - "revision": "97efdde466f18cf580fda9673cf4c38ee21fc7b7", 03:04:27 INFO - "slavename": "talos-linux64-ix-008", 03:04:27 INFO - "repo_path": "mozilla-central" 03:04:27 INFO - } 03:04:27 INFO - Finding installer, test and symbols from parent task. 03:04:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hty74AN9TQSBZmqDImdiPg'}, attempt #1 03:04:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hty74AN9TQSBZmqDImdiPg'}, attempt #1 03:04:28 INFO - Task dependencies: SpgnkNMfTjmvykF5w7h-dQ 03:04:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SpgnkNMfTjmvykF5w7h-dQ'}, attempt #1 03:04:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SpgnkNMfTjmvykF5w7h-dQ/artifacts/public/build/target.tar.bz2 03:04:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/SpgnkNMfTjmvykF5w7h-dQ/artifacts/public/build/target.test_packages.json 03:04:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SpgnkNMfTjmvykF5w7h-dQ/artifacts/public/build/target.crashreporter-symbols.zip 03:04:29 INFO - Running post-action listener: _resource_record_post_action 03:04:29 INFO - [mozharness: 2017-10-02 10:04:29.212740Z] Finished read-buildbot-config step (success) 03:04:29 INFO - [mozharness: 2017-10-02 10:04:29.212958Z] Running download-and-extract step. 03:04:29 INFO - Running pre-action listener: _resource_record_pre_action 03:04:29 INFO - Running main action method: download_and_extract 03:04:29 INFO - mkdir: /builds/slave/test/build/tests 03:04: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')]} 03:04:29 INFO - trying https://queue.taskcluster.net/v1/task/SpgnkNMfTjmvykF5w7h-dQ/artifacts/public/build/target.test_packages.json 03:04:29 INFO - Downloading https://queue.taskcluster.net/v1/task/SpgnkNMfTjmvykF5w7h-dQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:04:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SpgnkNMfTjmvykF5w7h-dQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:04:29 INFO - Downloaded 989 bytes. 03:04:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:04:29 INFO - Using the following test package requirements: 03:04:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:04:29 INFO - u'common': [u'target.common.tests.zip'], 03:04:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:04:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:04:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:04:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:04:29 INFO - u'mozbase': [u'target.common.tests.zip'], 03:04:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:04:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:04:29 INFO - u'web-platform': [u'target.common.tests.zip', 03:04:29 INFO - u'target.web-platform.tests.tar.gz'], 03:04:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:04:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:04:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SpgnkNMfTjmvykF5w7h-dQ/artifacts/public/build/target.common.tests.zip 03:04:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SpgnkNMfTjmvykF5w7h-dQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:04:29 INFO - Fetch https://queue.taskcluster.net/v1/task/SpgnkNMfTjmvykF5w7h-dQ/artifacts/public/build/target.common.tests.zip into memory 03:04:30 INFO - Content-Length response header: 55366763 03:04:30 INFO - Bytes received: 55366763 03:04:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SpgnkNMfTjmvykF5w7h-dQ/artifacts/public/build/target.talos.tests.zip 03:04:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SpgnkNMfTjmvykF5w7h-dQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:04:41 INFO - Fetch https://queue.taskcluster.net/v1/task/SpgnkNMfTjmvykF5w7h-dQ/artifacts/public/build/target.talos.tests.zip into memory 03:04:42 INFO - Content-Length response header: 14522385 03:04:42 INFO - Bytes received: 14522385 03:04:42 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')]} 03:04:42 INFO - trying https://queue.taskcluster.net/v1/task/SpgnkNMfTjmvykF5w7h-dQ/artifacts/public/build/target.tar.bz2 03:04:42 INFO - Downloading https://queue.taskcluster.net/v1/task/SpgnkNMfTjmvykF5w7h-dQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:04:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SpgnkNMfTjmvykF5w7h-dQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:04:43 INFO - Downloaded 61569382 bytes. 03:04:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SpgnkNMfTjmvykF5w7h-dQ/artifacts/public/build/target.tar.bz2 03:04:43 INFO - mkdir: /builds/slave/test/properties 03:04:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:04:43 INFO - Writing to file /builds/slave/test/properties/build_url 03:04:43 INFO - Contents: 03:04:43 INFO - build_url:https://queue.taskcluster.net/v1/task/SpgnkNMfTjmvykF5w7h-dQ/artifacts/public/build/target.tar.bz2 03:04:43 INFO - Running post-action listener: _resource_record_post_action 03:04:43 INFO - Running post-action listener: find_tests_for_verification 03:04:43 INFO - Running post-action listener: set_extra_try_arguments 03:04:43 INFO - [mozharness: 2017-10-02 10:04:43.885481Z] Finished download-and-extract step (success) 03:04:43 INFO - [mozharness: 2017-10-02 10:04:43.885591Z] Running populate-webroot step. 03:04:43 INFO - Running pre-action listener: _resource_record_pre_action 03:04:43 INFO - Running main action method: populate_webroot 03:04:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:04:43 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:04:43 INFO - 'tests': ['tresize', 03:04:43 INFO - 'tcanvasmark']}, 03:04:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:04:43 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:04:43 INFO - 'tests': ['dromaeo_css', 03:04:43 INFO - 'kraken']}, 03:04:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:04:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:04:43 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:04:43 INFO - 'talos_options': ['--disable-stylo'], 03:04:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:04:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:04:43 INFO - 'tests': ['damp', 'tps']}, 03:04:43 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:04:43 INFO - 'talos_options': ['--disable-stylo'], 03:04:43 INFO - 'tests': ['damp', 'tps']}, 03:04:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:04:43 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:04:43 INFO - 'tests': ['dromaeo_dom']}, 03:04:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:04:43 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:04:43 INFO - 'tests': ['basic_compositor_video', 03:04:43 INFO - 'glvideo']}, 03:04:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:04:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:04:43 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:04:43 INFO - 'talos_options': ['--disable-stylo'], 03:04:43 INFO - 'tests': ['ts_paint_webext', 03:04:43 INFO - 'tp5o_webext']}, 03:04:43 INFO - 'other-e10s': {'tests': ['a11yr', 03:04:43 INFO - 'ts_paint', 03:04:43 INFO - 'tpaint', 03:04:43 INFO - 'sessionrestore', 03:04:43 INFO - 'sessionrestore_many_windows', 03:04:43 INFO - 'sessionrestore_no_auto_restore', 03:04:43 INFO - 'tabpaint', 03:04:43 INFO - 'cpstartup']}, 03:04:43 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:04:43 INFO - 'tests': ['a11yr', 03:04:43 INFO - 'ts_paint', 03:04:43 INFO - 'tpaint', 03:04:43 INFO - 'sessionrestore', 03:04:43 INFO - 'sessionrestore_many_windows', 03:04:43 INFO - 'sessionrestore_no_auto_restore', 03:04:43 INFO - 'tabpaint', 03:04:43 INFO - 'cpstartup']}, 03:04:43 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 03:04:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:04:43 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:04:43 INFO - 'tests': ['perf_reftest_singletons']}, 03:04:43 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:04:43 INFO - 'tests': ['perf_reftest']}, 03:04:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:04:43 INFO - 'tsvgr_opacity', 03:04:43 INFO - 'tart', 03:04:43 INFO - 'tscrollx', 03:04:43 INFO - 'tsvg_static']}, 03:04:43 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:04:43 INFO - 'tests': ['tsvgx', 03:04:43 INFO - 'tsvgr_opacity', 03:04:43 INFO - 'tart', 03:04:43 INFO - 'tscrollx', 03:04:43 INFO - 'tsvg_static']}, 03:04:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:04:43 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:04:43 INFO - 'talos_options': ['--disable-stylo'], 03:04:43 INFO - 'tests': ['tp5o']}, 03:04:43 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:04:43 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:04:43 INFO - 'talos_options': ['--mitmproxy', 03:04:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:04:43 INFO - '--firstNonBlankPaint'], 03:04:43 INFO - 'tests': ['tp6_google', 03:04:43 INFO - 'tp6_youtube', 03:04:43 INFO - 'tp6_amazon', 03:04:43 INFO - 'tp6_facebook']}, 03:04:43 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:04:43 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:04:43 INFO - 'talos_options': ['--disable-stylo', 03:04:43 INFO - '--mitmproxy', 03:04:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:04:43 INFO - '--firstNonBlankPaint'], 03:04:43 INFO - 'tests': ['tp6_google', 03:04:43 INFO - 'tp6_youtube', 03:04:43 INFO - 'tp6_amazon', 03:04:43 INFO - 'tp6_facebook']}, 03:04:43 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:04:43 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:04:43 INFO - 'talos_options': ['--stylo-threads=1', 03:04:43 INFO - '--mitmproxy', 03:04:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:04:43 INFO - '--firstNonBlankPaint'], 03:04:43 INFO - 'tests': ['tp6_google', 03:04:43 INFO - 'tp6_youtube', 03:04:43 INFO - 'tp6_amazon', 03:04:43 INFO - 'tp6_facebook']}, 03:04:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:04:43 INFO - 'talos_options': ['--xperf_path', 03:04:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:04:43 INFO - 'tests': ['tp5n']}, 03:04:43 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:04:43 INFO - 'talos_options': ['--disable-stylo', 03:04:43 INFO - '--xperf_path', 03:04:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:04:43 INFO - 'tests': ['tp5n']}}} 03:04:43 INFO - Running post-action listener: _resource_record_post_action 03:04:43 INFO - [mozharness: 2017-10-02 10:04:43.916712Z] Finished populate-webroot step (success) 03:04:43 INFO - [mozharness: 2017-10-02 10:04:43.916819Z] Running create-virtualenv step. 03:04:43 INFO - Running pre-action listener: _resource_record_pre_action 03:04:43 INFO - Running main action method: create_virtualenv 03:04:43 INFO - Creating virtualenv /builds/slave/test/build/venv 03:04:43 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:04:43 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:04:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:04:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:04:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:04:44 INFO - Installing distribute.............................................................................................................................................................................................done. 03:04:44 INFO - Installing pip...............done. 03:04:44 INFO - Return code: 0 03:04:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:04:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:04:44 INFO - Reading from file tmpfile_stdout 03:04:44 INFO - Output received: 03:04:44 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:04:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:04:44 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')]} 03:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:44 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')]} 03:04:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:44 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 0x1bee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58d60>, '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 0x1f59a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f59ef0>, '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': '32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828', '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 03:04:44 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 03:04:44 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 03:04:44 INFO - Using env: {'DISPLAY': ':0', 03:04:44 INFO - 'HOME': '/home/cltbld', 03:04:44 INFO - 'LANG': 'en_US.UTF-8', 03:04:44 INFO - 'LANGUAGE': 'en_US:en', 03:04:44 INFO - 'LOGNAME': 'cltbld', 03:04:44 INFO - 'MAIL': '/var/mail/cltbld', 03:04:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:44 INFO - 'MOZ_NO_REMOTE': '1', 03:04:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:44 INFO - 'NO_EM_RESTART': '1', 03:04:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:44 INFO - 'PWD': '/builds/slave/test', 03:04:44 INFO - 'SHELL': '/bin/bash', 03:04:44 INFO - 'SHLVL': '1', 03:04:44 INFO - 'TERM': 'linux', 03:04:44 INFO - 'TMOUT': '86400', 03:04:44 INFO - 'USER': 'cltbld', 03:04:44 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828', 03:04:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:44 INFO - '_': '/tools/buildbot/bin/python'} 03:04:46 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:04:46 INFO - Downloading/unpacking pip>=1.5 03:04:46 INFO - Running setup.py egg_info for package pip 03:04:46 INFO - warning: no files found matching 'pip/cacert.pem' 03:04:46 INFO - warning: no files found matching '*.html' under directory 'docs' 03:04:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:04:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:04:46 INFO - Installing collected packages: pip 03:04:46 INFO - Found existing installation: pip 1.1 03:04:46 INFO - Uninstalling pip: 03:04:46 INFO - Successfully uninstalled pip 03:04:46 INFO - Running setup.py install for pip 03:04:46 INFO - warning: no files found matching 'pip/cacert.pem' 03:04:46 INFO - warning: no files found matching '*.html' under directory 'docs' 03:04:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:04:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:04:46 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:04:46 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:04:46 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:04:46 INFO - Successfully installed pip 03:04:46 INFO - Cleaning up... 03:04:46 INFO - Return code: 0 03:04:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:04:46 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')]} 03:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:46 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')]} 03:04:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:46 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 0x1bee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58d60>, '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 0x1f59a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f59ef0>, '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': '32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828', '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 03:04:46 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 03:04:46 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 03:04:46 INFO - Using env: {'DISPLAY': ':0', 03:04:46 INFO - 'HOME': '/home/cltbld', 03:04:46 INFO - 'LANG': 'en_US.UTF-8', 03:04:46 INFO - 'LANGUAGE': 'en_US:en', 03:04:46 INFO - 'LOGNAME': 'cltbld', 03:04:46 INFO - 'MAIL': '/var/mail/cltbld', 03:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:46 INFO - 'MOZ_NO_REMOTE': '1', 03:04:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:46 INFO - 'NO_EM_RESTART': '1', 03:04:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:46 INFO - 'PWD': '/builds/slave/test', 03:04:46 INFO - 'SHELL': '/bin/bash', 03:04:46 INFO - 'SHLVL': '1', 03:04:46 INFO - 'TERM': 'linux', 03:04:46 INFO - 'TMOUT': '86400', 03:04:46 INFO - 'USER': 'cltbld', 03:04:46 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828', 03:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:46 INFO - '_': '/tools/buildbot/bin/python'} 03:04:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:46 INFO - Downloading/unpacking psutil>=3.1.1 03:04:46 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 03:04:46 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 03:04:46 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 03:04:46 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 03:04:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:04:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:04:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:04:47 INFO - Installing collected packages: psutil 03:04:47 INFO - Running setup.py install for psutil 03:04:47 INFO - building 'psutil._psutil_linux' extension 03:04:47 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 03:04:47 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 03:04:47 INFO - building 'psutil._psutil_posix' extension 03:04:47 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 03:04:47 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 03:04:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:04:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:04:48 INFO - Successfully installed psutil 03:04:48 INFO - Cleaning up... 03:04:48 INFO - Return code: 0 03:04:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:04:48 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')]} 03:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:48 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')]} 03:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:48 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 0x1bee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58d60>, '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 0x1f59a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f59ef0>, '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': '32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828', '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 03:04:48 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 03:04:48 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 03:04:48 INFO - Using env: {'DISPLAY': ':0', 03:04:48 INFO - 'HOME': '/home/cltbld', 03:04:48 INFO - 'LANG': 'en_US.UTF-8', 03:04:48 INFO - 'LANGUAGE': 'en_US:en', 03:04:48 INFO - 'LOGNAME': 'cltbld', 03:04:48 INFO - 'MAIL': '/var/mail/cltbld', 03:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:48 INFO - 'MOZ_NO_REMOTE': '1', 03:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:48 INFO - 'NO_EM_RESTART': '1', 03:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:48 INFO - 'PWD': '/builds/slave/test', 03:04:48 INFO - 'SHELL': '/bin/bash', 03:04:48 INFO - 'SHLVL': '1', 03:04:48 INFO - 'TERM': 'linux', 03:04:48 INFO - 'TMOUT': '86400', 03:04:48 INFO - 'USER': 'cltbld', 03:04:48 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828', 03:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:48 INFO - '_': '/tools/buildbot/bin/python'} 03:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:04:48 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 03:04:48 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 03:04:48 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 03:04:48 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 03:04:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:04:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:04:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:04:49 INFO - Installing collected packages: mozsystemmonitor 03:04:49 INFO - Running setup.py install for mozsystemmonitor 03:04:49 INFO - Successfully installed mozsystemmonitor 03:04:49 INFO - Cleaning up... 03:04:50 INFO - Return code: 0 03:04:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:04:50 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')]} 03:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:50 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')]} 03:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:50 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 0x1bee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58d60>, '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 0x1f59a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f59ef0>, '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': '32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828', '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 03:04:50 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 03:04:50 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 03:04:50 INFO - Using env: {'DISPLAY': ':0', 03:04:50 INFO - 'HOME': '/home/cltbld', 03:04:50 INFO - 'LANG': 'en_US.UTF-8', 03:04:50 INFO - 'LANGUAGE': 'en_US:en', 03:04:50 INFO - 'LOGNAME': 'cltbld', 03:04:50 INFO - 'MAIL': '/var/mail/cltbld', 03:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:50 INFO - 'MOZ_NO_REMOTE': '1', 03:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:50 INFO - 'NO_EM_RESTART': '1', 03:04:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:50 INFO - 'PWD': '/builds/slave/test', 03:04:50 INFO - 'SHELL': '/bin/bash', 03:04:50 INFO - 'SHLVL': '1', 03:04:50 INFO - 'TERM': 'linux', 03:04:50 INFO - 'TMOUT': '86400', 03:04:50 INFO - 'USER': 'cltbld', 03:04:50 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828', 03:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:50 INFO - '_': '/tools/buildbot/bin/python'} 03:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:50 INFO - Downloading/unpacking jsonschema==2.5.1 03:04:50 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 03:04:50 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 03:04:50 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 03:04:50 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 03:04:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:04:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:04:52 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 03:04:52 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 03:04:52 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 03:04:52 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 03:04:52 INFO - Downloading functools32-3.2.3-2.tar.gz 03:04:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:04:52 INFO - warning: no files found matching '*.txt' 03:04:52 INFO - no previously-included directories found matching 'build' 03:04:52 INFO - no previously-included directories found matching 'dist' 03:04:52 INFO - no previously-included directories found matching '.git*' 03:04:52 INFO - Installing collected packages: jsonschema, functools32 03:04:53 INFO - Running setup.py install for functools32 03:04:53 INFO - warning: no files found matching '*.txt' 03:04:53 INFO - no previously-included directories found matching 'build' 03:04:53 INFO - no previously-included directories found matching 'dist' 03:04:53 INFO - no previously-included directories found matching '.git*' 03:04:53 INFO - Successfully installed jsonschema functools32 03:04:53 INFO - Cleaning up... 03:04:53 INFO - Return code: 0 03:04:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:04:53 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')]} 03:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:53 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')]} 03:04:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:53 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 0x1bee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58d60>, '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 0x1f59a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f59ef0>, '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': '32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828', '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 03:04:53 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 03:04:53 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 03:04:53 INFO - Using env: {'DISPLAY': ':0', 03:04:53 INFO - 'HOME': '/home/cltbld', 03:04:53 INFO - 'LANG': 'en_US.UTF-8', 03:04:53 INFO - 'LANGUAGE': 'en_US:en', 03:04:53 INFO - 'LOGNAME': 'cltbld', 03:04:53 INFO - 'MAIL': '/var/mail/cltbld', 03:04:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:53 INFO - 'MOZ_NO_REMOTE': '1', 03:04:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:53 INFO - 'NO_EM_RESTART': '1', 03:04:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:53 INFO - 'PWD': '/builds/slave/test', 03:04:53 INFO - 'SHELL': '/bin/bash', 03:04:53 INFO - 'SHLVL': '1', 03:04:53 INFO - 'TERM': 'linux', 03:04:53 INFO - 'TMOUT': '86400', 03:04:53 INFO - 'USER': 'cltbld', 03:04:53 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828', 03:04:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:53 INFO - '_': '/tools/buildbot/bin/python'} 03:04:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:04:53 INFO - Cleaning up... 03:04:53 INFO - Return code: 0 03:04:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:04:53 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')]} 03:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:53 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')]} 03:04:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:53 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 0x1bee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58d60>, '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 0x1f59a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f59ef0>, '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': '32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828', '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 03:04:53 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 03:04:53 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 03:04:53 INFO - Using env: {'DISPLAY': ':0', 03:04:53 INFO - 'HOME': '/home/cltbld', 03:04:53 INFO - 'LANG': 'en_US.UTF-8', 03:04:53 INFO - 'LANGUAGE': 'en_US:en', 03:04:53 INFO - 'LOGNAME': 'cltbld', 03:04:53 INFO - 'MAIL': '/var/mail/cltbld', 03:04:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:53 INFO - 'MOZ_NO_REMOTE': '1', 03:04:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:53 INFO - 'NO_EM_RESTART': '1', 03:04:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:53 INFO - 'PWD': '/builds/slave/test', 03:04:53 INFO - 'SHELL': '/bin/bash', 03:04:53 INFO - 'SHLVL': '1', 03:04:53 INFO - 'TERM': 'linux', 03:04:53 INFO - 'TMOUT': '86400', 03:04:53 INFO - 'USER': 'cltbld', 03:04:53 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828', 03:04:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:53 INFO - '_': '/tools/buildbot/bin/python'} 03:04:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:53 INFO - Downloading/unpacking blobuploader==1.2.4 03:04:53 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 03:04:53 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 03:04:53 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 03:04:53 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 03:04:54 INFO - Downloading blobuploader-1.2.4.tar.gz 03:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:04:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:04:54 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 03:04:54 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 03:04:54 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 03:04:54 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 03:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:04:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:04:55 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 03:04:55 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 03:04:55 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 03:04:55 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 03:04:55 INFO - Downloading docopt-0.6.1.tar.gz 03:04:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:04:55 INFO - Installing collected packages: blobuploader, requests, docopt 03:04:55 INFO - Running setup.py install for blobuploader 03:04:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:04:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:04:55 INFO - Running setup.py install for requests 03:04:55 INFO - Running setup.py install for docopt 03:04:55 INFO - Successfully installed blobuploader requests docopt 03:04:55 INFO - Cleaning up... 03:04:55 INFO - Return code: 0 03:04:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:04:55 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')]} 03:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:55 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')]} 03:04:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:55 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 0x1bee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58d60>, '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 0x1f59a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f59ef0>, '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': '32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828', '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 03:04:55 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 03:04:55 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 03:04:55 INFO - Using env: {'DISPLAY': ':0', 03:04:55 INFO - 'HOME': '/home/cltbld', 03:04:55 INFO - 'LANG': 'en_US.UTF-8', 03:04:55 INFO - 'LANGUAGE': 'en_US:en', 03:04:55 INFO - 'LOGNAME': 'cltbld', 03:04:55 INFO - 'MAIL': '/var/mail/cltbld', 03:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:55 INFO - 'MOZ_NO_REMOTE': '1', 03:04:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:55 INFO - 'NO_EM_RESTART': '1', 03:04:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:55 INFO - 'PWD': '/builds/slave/test', 03:04:55 INFO - 'SHELL': '/bin/bash', 03:04:55 INFO - 'SHLVL': '1', 03:04:55 INFO - 'TERM': 'linux', 03:04:55 INFO - 'TMOUT': '86400', 03:04:55 INFO - 'USER': 'cltbld', 03:04:55 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828', 03:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:55 INFO - '_': '/tools/buildbot/bin/python'} 03:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:04:56 INFO - Running setup.py (path:/tmp/pip-pT0f8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:04:56 INFO - Running setup.py (path:/tmp/pip-KEYGxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:04:56 INFO - Running setup.py (path:/tmp/pip-KhB_9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:04:56 INFO - Running setup.py (path:/tmp/pip-JUfZ5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:04:56 INFO - Running setup.py (path:/tmp/pip-PoQf61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:04:56 INFO - Running setup.py (path:/tmp/pip-wCV4EK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:04:56 INFO - Running setup.py (path:/tmp/pip-OktO5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:04:56 INFO - Running setup.py (path:/tmp/pip-J_5Wbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:04:56 INFO - Running setup.py (path:/tmp/pip-GDhRzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:04:56 INFO - Running setup.py (path:/tmp/pip-uDvXlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:04:56 INFO - Running setup.py (path:/tmp/pip-yiKZhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:04:56 INFO - Running setup.py (path:/tmp/pip-ODaARy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:04:56 INFO - Running setup.py (path:/tmp/pip-AyokRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:04:57 INFO - Running setup.py (path:/tmp/pip-RTw4Wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:57 INFO - Running setup.py (path:/tmp/pip-i_cvnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:04:57 INFO - Running setup.py (path:/tmp/pip-klbA4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:04:57 INFO - Running setup.py (path:/tmp/pip-97Qo55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:04:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:04:57 INFO - Running setup.py install for manifestparser 03:04:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:04:57 INFO - Running setup.py install for mozcrash 03:04:57 INFO - Running setup.py install for mozdebug 03:04:57 INFO - Running setup.py install for mozdevice 03:04:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:04:57 INFO - Running setup.py install for mozfile 03:04:57 INFO - Running setup.py install for mozhttpd 03:04:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:04:57 INFO - Running setup.py install for mozinfo 03:04:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:04:57 INFO - Running setup.py install for mozInstall 03:04:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:04:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:04:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:04:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:04:58 INFO - Running setup.py install for mozleak 03:04:58 INFO - Running setup.py install for mozlog 03:04:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:04:58 INFO - Running setup.py install for moznetwork 03:04:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:04:58 INFO - Running setup.py install for mozprocess 03:04:58 INFO - Running setup.py install for mozprofile 03:04:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:04:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:04:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:04:58 INFO - Running setup.py install for mozrunner 03:04:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:04:58 INFO - Running setup.py install for mozscreenshot 03:04:58 INFO - Running setup.py install for moztest 03:04:58 INFO - Running setup.py install for mozversion 03:04:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:04:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:04:59 INFO - Cleaning up... 03:04:59 INFO - Return code: 0 03:04:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:04:59 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')]} 03:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:59 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')]} 03:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:59 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 0x1bee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58d60>, '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 0x1f59a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f59ef0>, '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': '32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828', '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 03:04:59 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 03:04:59 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 03:04:59 INFO - Using env: {'DISPLAY': ':0', 03:04:59 INFO - 'HOME': '/home/cltbld', 03:04:59 INFO - 'LANG': 'en_US.UTF-8', 03:04:59 INFO - 'LANGUAGE': 'en_US:en', 03:04:59 INFO - 'LOGNAME': 'cltbld', 03:04:59 INFO - 'MAIL': '/var/mail/cltbld', 03:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:59 INFO - 'MOZ_NO_REMOTE': '1', 03:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:59 INFO - 'NO_EM_RESTART': '1', 03:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:59 INFO - 'PWD': '/builds/slave/test', 03:04:59 INFO - 'SHELL': '/bin/bash', 03:04:59 INFO - 'SHLVL': '1', 03:04:59 INFO - 'TERM': 'linux', 03:04:59 INFO - 'TMOUT': '86400', 03:04:59 INFO - 'USER': 'cltbld', 03:04:59 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828', 03:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:59 INFO - '_': '/tools/buildbot/bin/python'} 03:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:04:59 INFO - Running setup.py (path:/tmp/pip-a5ofUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:04:59 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)) 03:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:04:59 INFO - Running setup.py (path:/tmp/pip-DGVLXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:04:59 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)) 03:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:04:59 INFO - Running setup.py (path:/tmp/pip-iZLmfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:04:59 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)) 03:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:04:59 INFO - Running setup.py (path:/tmp/pip-bL2X8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:04:59 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)) 03:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:04:59 INFO - Running setup.py (path:/tmp/pip-R6954Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:04:59 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)) 03:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:04:59 INFO - Running setup.py (path:/tmp/pip-UBNRfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:04:59 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)) 03:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:04:59 INFO - Running setup.py (path:/tmp/pip-R54q9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:04:59 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)) 03:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:04:59 INFO - Running setup.py (path:/tmp/pip-0SnH37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:04:59 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)) 03:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:04:59 INFO - Running setup.py (path:/tmp/pip-bplHLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:04:59 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)) 03:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:04:59 INFO - Running setup.py (path:/tmp/pip-2SFHz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:04:59 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)) 03:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:04:59 INFO - Running setup.py (path:/tmp/pip-Gzi2_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:05:00 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)) 03:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:05:00 INFO - Running setup.py (path:/tmp/pip-32dPuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:05:00 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)) 03:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:05:00 INFO - Running setup.py (path:/tmp/pip-epJuE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:05:00 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)) 03:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:05:00 INFO - Running setup.py (path:/tmp/pip-H6hG7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:05:00 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)) 03:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:05:00 INFO - Running setup.py (path:/tmp/pip-tPVtyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:05:00 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)) 03:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:05:00 INFO - Running setup.py (path:/tmp/pip-ECpLad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:05:00 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)) 03:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:05:00 INFO - Running setup.py (path:/tmp/pip-X9F9KS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:05:00 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)) 03:05:00 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)) 03:05:00 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)) 03:05:00 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)) 03:05:00 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)) 03:05:00 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)) 03:05:00 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)) 03:05:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:05: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 03:05: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 03:05: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 03:05: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 03:05:01 INFO - Downloading blessings-1.6.tar.gz 03:05:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:05:01 INFO - Installing collected packages: blessings 03:05:01 INFO - Running setup.py install for blessings 03:05:01 INFO - Successfully installed blessings 03:05:01 INFO - Cleaning up... 03:05:01 INFO - Return code: 0 03:05:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:05:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:05:02 INFO - Reading from file tmpfile_stdout 03:05:02 INFO - Current package versions: 03:05:02 INFO - argparse == 1.2.1 03:05:02 INFO - blessings == 1.6 03:05:02 INFO - blobuploader == 1.2.4 03:05:02 INFO - docopt == 0.6.1 03:05:02 INFO - functools32 == 3.2.3-2 03:05:02 INFO - jsonschema == 2.5.1 03:05:02 INFO - manifestparser == 1.1 03:05:02 INFO - mozInstall == 1.13 03:05:02 INFO - mozcrash == 1.0 03:05:02 INFO - mozdebug == 0.1 03:05:02 INFO - mozdevice == 0.51 03:05:02 INFO - mozfile == 1.2 03:05:02 INFO - mozhttpd == 0.7 03:05:02 INFO - mozinfo == 0.10 03:05:02 INFO - mozleak == 0.1 03:05:02 INFO - mozlog == 3.5 03:05:02 INFO - moznetwork == 0.27 03:05:02 INFO - mozprocess == 0.25 03:05:02 INFO - mozprofile == 0.28 03:05:02 INFO - mozrunner == 6.13 03:05:02 INFO - mozscreenshot == 0.1 03:05:02 INFO - mozsystemmonitor == 0.3 03:05:02 INFO - moztest == 0.8 03:05:02 INFO - mozversion == 1.4 03:05:02 INFO - psutil == 3.1.1 03:05:02 INFO - requests == 1.2.3 03:05:02 INFO - wsgiref == 0.1.2 03:05:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:05: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')]} 03:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05: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')]} 03:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:02 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 0x1bee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58d60>, '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 0x1f59a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f59ef0>, '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': '32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828', '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 03:05:02 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 03:05:02 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 03:05:02 INFO - Using env: {'DISPLAY': ':0', 03:05:02 INFO - 'HOME': '/home/cltbld', 03:05:02 INFO - 'LANG': 'en_US.UTF-8', 03:05:02 INFO - 'LANGUAGE': 'en_US:en', 03:05:02 INFO - 'LOGNAME': 'cltbld', 03:05:02 INFO - 'MAIL': '/var/mail/cltbld', 03:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:02 INFO - 'MOZ_NO_REMOTE': '1', 03:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:02 INFO - 'NO_EM_RESTART': '1', 03:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:02 INFO - 'PWD': '/builds/slave/test', 03:05:02 INFO - 'SHELL': '/bin/bash', 03:05:02 INFO - 'SHLVL': '1', 03:05:02 INFO - 'TERM': 'linux', 03:05:02 INFO - 'TMOUT': '86400', 03:05:02 INFO - 'USER': 'cltbld', 03:05:02 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828', 03:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:02 INFO - '_': '/tools/buildbot/bin/python'} 03:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:02 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)) 03:05:02 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)) 03:05:02 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)) 03:05:02 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)) 03:05:02 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)) 03:05:02 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)) 03:05:02 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)) 03:05:02 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)) 03:05:02 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)) 03:05:02 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:05: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 03:05: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 03:05: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 03:05: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 03:05:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:05:03 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)) 03:05:03 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)) 03:05:03 INFO - Installing collected packages: simplejson 03:05:03 INFO - Running setup.py install for simplejson 03:05:03 INFO - building 'simplejson._speedups' extension 03:05:03 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 03:05:04 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 03:05:04 INFO - Successfully installed simplejson 03:05:04 INFO - Cleaning up... 03:05:04 INFO - Return code: 0 03:05:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:05:04 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')]} 03:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:04 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')]} 03:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:04 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 0x1bee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58d60>, '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 0x1f59a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f59ef0>, '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': '32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828', '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 03:05:04 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 03:05:04 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 03:05:04 INFO - Using env: {'DISPLAY': ':0', 03:05:04 INFO - 'HOME': '/home/cltbld', 03:05:04 INFO - 'LANG': 'en_US.UTF-8', 03:05:04 INFO - 'LANGUAGE': 'en_US:en', 03:05:04 INFO - 'LOGNAME': 'cltbld', 03:05:04 INFO - 'MAIL': '/var/mail/cltbld', 03:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:04 INFO - 'MOZ_NO_REMOTE': '1', 03:05:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:04 INFO - 'NO_EM_RESTART': '1', 03:05:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:04 INFO - 'PWD': '/builds/slave/test', 03:05:04 INFO - 'SHELL': '/bin/bash', 03:05:04 INFO - 'SHLVL': '1', 03:05:04 INFO - 'TERM': 'linux', 03:05:04 INFO - 'TMOUT': '86400', 03:05:04 INFO - 'USER': 'cltbld', 03:05:04 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828', 03:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:04 INFO - '_': '/tools/buildbot/bin/python'} 03:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:05:04 INFO - Cleaning up... 03:05:04 INFO - Return code: 0 03:05:04 INFO - Running post-action listener: _resource_record_post_action 03:05:04 INFO - Running post-action listener: _start_resource_monitoring 03:05:04 INFO - Starting resource monitoring. 03:05:04 INFO - [mozharness: 2017-10-02 10:05:04.776304Z] Finished create-virtualenv step (success) 03:05:04 INFO - [mozharness: 2017-10-02 10:05:04.776775Z] Running install step. 03:05:04 INFO - Running pre-action listener: _resource_record_pre_action 03:05:04 INFO - Running main action method: install 03:05:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:05:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:05:05 INFO - Reading from file tmpfile_stdout 03:05:05 INFO - Detecting whether we're running mozinstall >=1.0... 03:05:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:05:05 INFO - Reading from file tmpfile_stdout 03:05:05 INFO - Output received: 03:05:05 INFO - Usage: mozinstall [options] installer 03:05:05 INFO - Options: 03:05:05 INFO - -h, --help show this help message and exit 03:05:05 INFO - -d DEST, --destination=DEST 03:05:05 INFO - Directory to install application into. [default: 03:05:05 INFO - "/builds/slave/test"] 03:05:05 INFO - --app=APP Application being installed. [default: firefox] 03:05:05 INFO - mkdir: /builds/slave/test/build/application 03:05:05 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'] 03:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:05:22 INFO - Reading from file tmpfile_stdout 03:05:22 INFO - Output received: 03:05:22 INFO - /builds/slave/test/build/application/firefox/firefox 03:05:22 INFO - Running post-action listener: _resource_record_post_action 03:05:22 INFO - [mozharness: 2017-10-02 10:05:22.957458Z] Finished install step (success) 03:05:22 INFO - [mozharness: 2017-10-02 10:05:22.957710Z] Running setup-mitmproxy step. 03:05:22 INFO - Running pre-action listener: _resource_record_pre_action 03:05:22 INFO - Running main action method: setup_mitmproxy 03:05:22 INFO - Skipping: mitmproxy is not required 03:05:22 INFO - Running post-action listener: _resource_record_post_action 03:05:22 INFO - [mozharness: 2017-10-02 10:05:22.958925Z] Finished setup-mitmproxy step (success) 03:05:22 INFO - [mozharness: 2017-10-02 10:05:22.959145Z] Running run-tests step. 03:05:22 INFO - Running pre-action listener: _resource_record_pre_action 03:05:22 INFO - Running pre-action listener: _set_gcov_prefix 03:05:22 INFO - Running main action method: run_tests 03:05:22 WARNING - Try message not found. 03:05:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:05:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:05:22 INFO - Python 2.7.3 03:05:22 INFO - Return code: 0 03:05:22 INFO - grabbing minidump binary from tooltool 03:05:22 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')]} 03:05:22 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 0x1f58d60>, '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 0x1f59a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f59ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:05:22 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 03:05:22 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 03:05:22 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 03:05:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:05:23 INFO - Return code: 0 03:05:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:05:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:05:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:05:23 INFO - ENV: RUST_BACKTRACE is now full 03:05:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:05:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:05:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SpgnkNMfTjmvykF5w7h-dQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 03:05:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SpgnkNMfTjmvykF5w7h-dQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 03:05:23 INFO - Using env: {'DISPLAY': ':0', 03:05:23 INFO - 'HOME': '/home/cltbld', 03:05:23 INFO - 'LANG': 'en_US.UTF-8', 03:05:23 INFO - 'LANGUAGE': 'en_US:en', 03:05:23 INFO - 'LOGNAME': 'cltbld', 03:05:23 INFO - 'MAIL': '/var/mail/cltbld', 03:05:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:05:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:23 INFO - 'MOZ_NO_REMOTE': '1', 03:05:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:05:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:23 INFO - 'NO_EM_RESTART': '1', 03:05:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:23 INFO - 'PWD': '/builds/slave/test', 03:05:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:05:23 INFO - 'RUST_BACKTRACE': 'full', 03:05:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:05:23 INFO - 'SHELL': '/bin/bash', 03:05:23 INFO - 'SHLVL': '1', 03:05:23 INFO - 'TERM': 'linux', 03:05:23 INFO - 'TMOUT': '86400', 03:05:23 INFO - 'USER': 'cltbld', 03:05:23 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828', 03:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:23 INFO - '_': '/tools/buildbot/bin/python'} 03:05:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SpgnkNMfTjmvykF5w7h-dQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 03:05:23 INFO - mozversion application_buildid: 20171002090431 03:05:23 INFO - mozversion application_changeset: 97efdde466f18cf580fda9673cf4c38ee21fc7b7 03:05:23 INFO - mozversion application_display_name: FirefoxNightly 03:05:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:05:23 INFO - mozversion application_name: Firefox 03:05:23 INFO - mozversion application_remotingname: firefox 03:05:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:05:23 INFO - mozversion application_vendor: Mozilla 03:05:23 INFO - mozversion application_version: 58.0a1 03:05:23 INFO - mozversion platform_buildid: 20171002090431 03:05:23 INFO - mozversion platform_changeset: 97efdde466f18cf580fda9673cf4c38ee21fc7b7 03:05:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:05:23 INFO - mozversion platform_version: 58.0a1 03:05:23 INFO - using testdate: 1506938723 03:05:23 INFO - actual date: 1506938723 03:05:23 INFO - starting webserver on 'localhost:38867' 03:05:23 INFO - SUITE-START | Running 2 tests 03:05:23 INFO - TEST-START | dromaeo_css 03:05:23 INFO - Initialising browser for dromaeo_css test... 03:05:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38867/getInfo.html -profile /tmp/tmpq7DbP_/profile 03:05:23 INFO - TEST-INFO | started process 6082 (/builds/slave/test/build/application/firefox/firefox http://localhost:38867/getInfo.html) 03:05:28 INFO - TEST-INFO | 6082: exit 0 03:05:29 INFO - Browser initialized. 03:05:29 INFO - Running cycle 1/1 for dromaeo_css test... 03:05:29 INFO - Using env: {'DISPLAY': ':0', 03:05:29 INFO - 'HOME': '/home/cltbld', 03:05:29 INFO - 'JSGC_DISABLE_POISONING': '1', 03:05:29 INFO - 'LANG': 'en_US.UTF-8', 03:05:29 INFO - 'LANGUAGE': 'en_US:en', 03:05:29 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:05:29 INFO - 'LOGNAME': 'cltbld', 03:05:29 INFO - 'MAIL': '/var/mail/cltbld', 03:05:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:05:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:05:29 INFO - 'MOZ_CRASHREPORTER': '1', 03:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:29 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:05:29 INFO - 'MOZ_NO_REMOTE': '1', 03:05:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:05:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:29 INFO - 'NO_EM_RESTART': '1', 03:05:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:29 INFO - 'PWD': '/builds/slave/test', 03:05:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:05:29 INFO - 'RUST_BACKTRACE': 'full', 03:05:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:05:29 INFO - 'SHELL': '/bin/bash', 03:05:29 INFO - 'SHLVL': '1', 03:05:29 INFO - 'STYLO_FORCE_DISABLED': '1', 03:05:29 INFO - 'TERM': 'linux', 03:05:29 INFO - 'TMOUT': '86400', 03:05:29 INFO - 'USER': 'cltbld', 03:05:29 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828', 03:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:29 INFO - '_': '/tools/buildbot/bin/python'} 03:05:29 INFO - TEST-INFO | started process 6318 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq7DbP_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:05:29 INFO - PID 6318 | 03:05:29 INFO - PID 6318 | (/builds/slave/test/build/application/firefox/firefox:6368): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:05:29 INFO - PID 6318 | 03:05:40 INFO - PID 6318 | RSS: Main: 148377600 03:05:40 INFO - PID 6318 | 03:08:37 INFO - PID 6318 | Cycle 1(1): loaded http://localhost:38867/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38867/tests/dromaeo/cssquery-ext.html) 03:08:38 INFO - PID 6318 | RSS: Main: 149520384 03:08:38 INFO - PID 6318 | 03:11:40 INFO - PID 6318 | Cycle 1(1): loaded http://localhost:38867/tests/dromaeo/cssquery-ext.html (next: http://localhost:38867/tests/dromaeo/cssquery-jquery.html) 03:11:41 INFO - PID 6318 | RSS: Main: 150654976 03:11:41 INFO - PID 6318 | 03:14:42 INFO - PID 6318 | Cycle 1(1): loaded http://localhost:38867/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38867/tests/dromaeo/cssquery-mootools.html) 03:14:43 INFO - PID 6318 | RSS: Main: 151887872 03:14:43 INFO - PID 6318 | 03:17:45 INFO - PID 6318 | Cycle 1(1): loaded http://localhost:38867/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38867/tests/dromaeo/cssquery-prototype.html) 03:17:45 INFO - PID 6318 | RSS: Main: 149684224 03:17:45 INFO - PID 6318 | 03:20:48 INFO - PID 6318 | Cycle 1(1): loaded http://localhost:38867/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38867/tests/dromaeo/cssquery-yui.html) 03:20:49 INFO - PID 6318 | RSS: Main: 154529792 03:20:49 INFO - PID 6318 | 03:23:51 INFO - PID 6318 | Cycle 1(1): loaded http://localhost:38867/tests/dromaeo/cssquery-yui.html (next: http://localhost:38867/tests/dromaeo/cssquery-dojo.html) 03:23:51 INFO - PID 6318 | RSS: Main: 155054080 03:23:51 INFO - PID 6318 | 03:23:51 INFO - PID 6318 | __start_tp_report 03:23:51 INFO - PID 6318 | _x_x_mozilla_page_load 03:23:51 INFO - PID 6318 | _x_x_mozilla_page_load_details 03:23:51 INFO - PID 6318 | |i|pagename|runs| 03:23:51 INFO - PID 6318 | |0;dojo.html;3196.6164060312767;3212.8554215060303;3221.484562470005;3230.676932306771;3241.5137729340604;6209.9068513972215;6250.124982502453;6277.968610156949;6351.745930162794;6400.5519613627;6231.189945307115;6235.189425374695;6266.749330026805;6280.309165991737;6343.302236753953;5829.562782791308;5878.382769809173;5899;5944.167816505693;5952.375000624937;5628;5895.528357731371;5896.734646940898;5994.700264986734;6006.369331220203;5354.196870469422;5715.228444160027;5797.971010144965;5859.238299021121;5873.471387575096;5785.132230165466;5794.362620111784;5874.060150375962;5878.823635290948;5880.441358070976;5566.304211973504;5618.91571626426;5629.8592535186535;5648.124540696199;5786.855328616776;6165.2601687797305;6220.595661282002;6225.657588832612;6264.9686751566405;6304.842378940563;6773.8983915241315;6840.247572766992;6861.588304701734;6876.793696189123;6878.965605171942;6815.965920170417;6825.215100263484;6835.487338449587;6919;6943.062686537303;6133.969330153365;6257.342978987232;6259.561830671855;6261.624302541862;6276.027215781515;6790.626515541594;6924.688389022506;6931.653417329214;6938.271481494471;7034.753783617549;6693.196816382066;6736.360045795642;6760.3239676032;6766.458683305324;6768.69540870662;6773.288804675537;6774.593524388552;6793.082933803972;6883.862322753617;6902.827429314207;6556.082148499214;6718.0930574372815;6749.898751518731;6808.285130061371;6829.795106146824;6680;6710.463162946952;6713.328667133248;6719.328067193242;6727.495437842182;5287.4448182941005;5340.813071542555;5352.892942141136;5373.382061063028;5378.19327100938;4618.49196588375;4675.883102922386;4698.271767875985;4713.481517033124;4732.100900828831;5865.35481097079;5871.853203669857;5918.704064796743;5924.644521328734;5927.288725352985;6573.408393244536;6707.128073350434;6748.83127921796;6869.450443964471;6872.278410766798;5882;5890.293164820163;5913.497352725067;5933.199018132583;5937.317208520989;5718.428157184248;5843.970780146072;5864.589478736448;5899.76400943966;5924.377940316204;6624.436922861514;6652.7671531497135;6689.49828762835;6748.898766518506;6751.864962700718;6632.1709786276715;6657.500687448364;6779.966100169468;6791.558548694319;6797.762078327235;6567.540272180901;6665.266820649822;6693.397594216349;6696.363845434676;6710.261871194262;6677.265500795006;6681.76613818514;6799.864002720017;6824.897626535507;6842.965785171043;6831.726730930707;6837.042814005944;6907.896381554381;6909.205441374105;6916.51584389108;6401.391867772554;6510;6523.608583485006;6555.967220163869;6672.933270667231;6437.452816510649;6440.29156792743;6444.709988050643;6531.934680653323;6560.179977502812;6594.340565943367;6608.669566521751;6615.4046135848;6624.105745724266;6637.668116594247;6688.83277918056;6694.430973367318;6738.797836064926;6754.966225168842;6758.5269031167345;6155.47678447337;6395.456386207225;6397.328280530477;6447.935520644921;6485.448736857231 03:23:51 INFO - PID 6318 | |1;ext.html;885.4818674387243;886.6622737315399;900.4912224593104;926.8146370725852;927.7309580221736;41727;42343.78828105855;42383.36424953628;42493.15013699724;42559.936001599934;39188.412173817414;43604.56395436045;43991;44076.3388549172;44178.33732494015;8127.512349259034;8236.258736713695;8268.297194738454;8271.669133234664;8272.17278272174;8066.354691624685;8102.5543595102245;8106.716264930728;8185.427020108595;8187;8083.797905052391;8116.107228204893;8167.754967350989;8188.099309075997;8219.424640275183;8035.477693949903;8065.637046332899;8091.231333023354;8149.307308878752;8156.6737330507;7894.842103157962;7994.920050799476;8006.439549231556;8007.039155301343;8014.879776803353;39042.609573904185;39077.21845563101;39163.216735665126;39279;39386.80306598449;3475.409180439306;3507.333606614735;3513.0339156732102;3528.964710352915;3533.2933413317182;32004.839975800205;32038.679613204036;32047.83976080128;32194.678053219635;32233;5080.466551012128;5153.690778553261;5249.238860365225;5257.106291930381;5283.841484755425;194572;195723;196230.99999999857;196510;197346;49758;49840.252396214084;49846.75076624594;50135.49864501381;50222.24666630004;51682.74158629183;51823.222651659504;51881.2217816733;51902.22146667803;52136.73931630394;16057.197140142945;16209.837901620833;16284.592885177964;16292;16300.42948496797;13279.601611951657;13297.734045319039;13310.201387916755;13381.53164639233;13399;13585.52450664222;13725;13800.93099534516;13814.447422103003;13972.231527265894;4976.427710813303;5114.232865070269;5120.283160357553;5148.3564554430695;5162.664426812245;1010.9797804043878;1018.6536577563664;1023.7389465686202;1024.52871679027;1031.2111234905303;23002.424939376648;23113.653295200584;23150.42123946915;23273.650895236584;23279.418014549432;1115.5928086248623;1118.4799068433056;1119.0935342372704;1127.503898284752;1141.543382646948;12170.939145304217;12250.81623775644;12353.567625133077;12461.563845265373;12465.439055242536;241235;241411;241785;241931;242964;52690.47309526932;56205.156922646194;56320;56592;56889;1403.7122389910044;1447.4644381578673;1455.5997100797365;1458.1761304862719;1461.744194765933;26046.218613441626;26368.3407914796;26459.206223813315;26657.866710666323;27383.589246161722;38493;38530.6146938527;38540.22919541538;38553.421698675105;38559.61440385672;197644;198210;198509;198791;199163;33888;33998.66001339955;34063.14842128967;34155.14612134716;34511.30977380489;40570.391444127774;41511.58488415198;41635.37546936859;41949.161016780105;42109.36835947402;31583.526247106773;31635.84182079075;31914;31990.84004579962;32171.51742723908;31758.52362214615;31953.840230798698;32246;32434.67565324411;32618.51072233966;34188.658113419544;35647.465288021216;35655.82172089123;35706.821465892506;35710.4643430354;31251.218719532193;31313.8434307827;31520.52719209168;31543.211419713774;31641;22891.77108228963;23097.88451057734;23109.84308131257;23325.183618573268;23582 03:23:51 INFO - PID 6318 | |2;jquery.html;573.498189084551;577.9624324418916;588.4644973074503;594.408563479338;625.3465128940259;22782.88608556957;23216.88391558044;23292.41768955777;23566.76433235667;23612.88193559034;24186.637200442008;24839.254822355357;25784.613230801508;25869.48261034783;26003.21990340293;6482.837929051764;6623.933760662404;6627.867442651144;6628.43658289046;6656.267810540837;6480.546361754679;6510.283868774431;6594.670266486681;6604.768833090843;6738.427233685143;6708.83227919301;6709.630970296632;6714.462842972575;6715.12703348564;6717;6573.802785916382;6686;6694.263631000586;6712.865742685168;6726.697298621574;6331.841703957438;6334.651594162319;6352.1742173517605;6371.044343348535;6381.170447841797;29626.70373296261;29891.5516267254;30286.394272114434;30323.848380758176;30431.543526847116;2001.7497812773404;2028.817406433428;2029.989850050755;2031.1469182943051;2034.4303594993426;20374.471914606464;20401.591968160552;20514.794852051436;20624.896875515675;20827.68758468609;2210.4805370737863;2290.5647926893835;2314.953700925989;2319.153508969231;2319.953600927972;124660.37669811683;130514;132016.33991830074;138699.99999999898;147179;15108.63264775824;15201.467948621745;15475.529824666639;15718.764218536731;16037.358505659642;24238.030478781006;24239.757602424103;24306.75693243045;24328.756712433;24354.512909741705;10318.245898197325;10348.637797677196;10412.427316497666;10472.371657700562;10614.787704245871;9352.812943741086;9420.90579094214;9440.008799076135;9497.097775711296;9541.904580954102;9323.347365684473;9330.393524420891;9403.14471066873;9418.62325506972;9482.525873706287;2722.6460560127057;2737.151483040264;2837.3757773289844;2886.6536015677834;3003.894863679761;943.2406912435418;961.5336561767538;979.118793086228;979.7060881735594;981.2052237687496;19559.902200489192;20020.69968950467;20066.89966550158;20136;20387.796122038886;1035.223582313265;1046.2414749306693;1047.8899715529913;1051.8790339111101;1060.522764755863;10771.946140269249;10898.182636302308;11253.324800511995;11292.71768205785;11308.038816700508;478290;484419;493780;495203;498837.50581247587;115583;116143.41928290305;116628;117200;119981;1162.122597438928;1209.9455524501418;1258.150748244931;1262.2489618676873;1287.3241548187088;21370.465738356666;21396.572068558853;21493;21551;21997.67003494981;60424;61883.38116618776;61899.69050154721;62643;63540.682296588224;80192.59903700445;80291;80526;80569.19430805852;80837.59581202056;14805.407783688532;15137.697246055237;15138.772918406012;15174.544763657108;15247.695046099238;23424.06303747831;23491.295261142193;23657.763422366246;23840.04639814388;23887.163949261692;18401.263949441873;18904.716429253847;19099;19110.7133393002;19263;16817.159142042605;16837.91581042087;17132.743008854628;17458.73811892848;17664.381746638806;18309;18539.44381668552;18797.966111863978;19089.236430543177;19101.331453399063;15013.174275414956;15030.549083527512;15072.849271507144;15107.54677359681;15126.39494420211;17918.372856949944;18005.729914051037;18151.183196755912;18178.72731909049;18198.363057292932 03:23:51 INFO - PID 6318 | |3;mootools.html;1361.6936189357393;1413.2015411292618;1417.404690030187;1423.5515812519063;1424.8788852947498;14863.331150098244;16145.515634530953;16149.75775363369;16150.192490375493;16163.515094547152;15660.921695391507;15884.205789710526;15936.84063159371;15944.840551594481;15978.121203333812;2808.90168844091;2821.2241633550734;2844.3742376677096;2852.7147285271512;2853.4863724529578;2586.9094581689646;2690.4215593647364;2742.80800343976;2748.2854457840904;2757.1590664847213;2726.209399274208;2757.5725762506845;2795.6365672462553;2827.6889542150348;2841.3748975225417;2696.7168447313043;2732.4261904999976;2732.4535092981287;2733.808633395653;2735.6990731019573;2702.9189124326303;2721.482918245527;2730.1127133681434;2763.8065335426527;2764.2951047482966;15183.316750746133;15307.846921530754;15317.617059573487;15320.080795152326;15390.846091539053;8146.592670366517;8376;8473.110323416076;8509.361797865124;8525.701600444017;5272.947270527322;5458.918116228259;5546.889062218774;5659.5755318351285;5764.452377024176;1983.6528607493776;2008.2970960163973;2025.3215172917091;2039.6838490034067;2045.764737055243;27758.3060423489;27940.8602956988;27947.720522794716;27969.160925172277;28026.299342516395;6647.66761661915;6748.4938629602975;7048.259932707095;7063.117110361205;7231.168415632164;17885.46343609694;17979.640407191782;17983.820161798216;17994.10029498546;18025.09874506296;7942.324902383362;8191.672333106609;8211.876821847676;8225.424220304521;8230.300424463987;7355.264473552602;7371.078615173104;7497.9250207497225;7564.9243507565325;7578.280063393969;5434.728263586805;5451.345838499326;5471.2887324647545;5490.725463726878;5534.889302213933;1519.346680927212;1547.1722628393754;1569.8901076924733;1584.7464405695034;1597.456864666019;876.8158686675743;888.3248730964514;891.2424439226605;901.3915606965272;910.8451563234266;7330.303621155982;7381.188069312371;7409.37020353276;7437.107547094383;7460.962695186489;704.4012589299157;742.5173637135905;744.1591002167625;744.6983971491554;752.4018405367746;4719.2685133803625;4946.8763280918265;5017.648764586444;5145.92281115776;5287.391949925731;20873.79126208749;22915.08339666428;22919.88540057289;22934.42663933415;22943.655845162335;21708.78291217099;21844;21928.561428771336;22006.779932200472;22227;10715.142788576895;11066.723331916766;11144.442777861075;11156.442177891073;11167.888321116847;8396.832063358577;8461.534615595954;8501.489910605384;8556.57217139153;8654.350923680624;18121;18860;19103;19231.711524326867;19305;18947.621047579247;19517.316893908646;19704.605907882047;19824.306149284705;19915.800841991393;11171.441427928734;11297.096232301561;11394.316341019565;11397.658070257905;11443.942780286045;13969.161850289016;14055.859441405455;14101.224432656303;14162.575122746333;14203.076800008379;11347.319160850046;11696.35670038156;11708.765824683289;11788.823167652321;11811.763764724828;11134.33194008362;11226.438678066228;11362.659120226406;11432.657020289405;11605.361705106301;9579.808403831745;9762.755931101496;9762.80474390494;9763.267754918268;9766.07222313879;6919.481038922;6943.826404339932;6948.6178260196175;6949.583025018515;7003.159620845531;7277.563346199245;7314.634268286671;7326.523775954759;7470.738524151846;7516.699332026657 03:23:51 INFO - PID 6318 | |4;prototype.html;500.51222010829804;530.1200007986743;530.5861428086095;534.5940177333613;536.203737449887;6287.622742635445;6307.684615769211;6313.337099604544;6318.399752023556;6356.555041147116;6228.657423841687;6260.2487701475775;6289.088082228086;6302.928502154633;6303.873922521547;5226.712530810794;5244.265802787613;5262.000219958215;5262.973685131588;5285.154375299952;5176.007237213681;5227;5243.632945693784;5268.104422248227;5284.709340986245;5021.548060674539;5127.897442051157;5193.272941788153;5197.376314842224;5208.609354298424;5162.432132465426;5175.635836706134;5183.326167598207;5238.1618940969265;5251.579873610102;4780.856574302777;4822.397200349957;4880.560749532559;4887.608991280689;4915.5821755150855;6070.544709146788;6103.267607887037;6115.908261376083;6134.662593557353;6138.1074168798;5944.167816505693;6019.608725432833;6021.729022193968;6038.3659715729655;6047.699744554898;6530.346965303432;6627.867442651168;6653.60078395293;6682.391508585358;6715.634837355758;5308.124159513675;5348.8127915523155;5357.249985002103;5361.303030605996;5362.034833729927;6726.3609957054005;6915.481338899603;6917;6928.72285108595;6929.861402771916;5377.166539186433;5455.290812194389;5478.972605137029;5487.6981766002455;5530.474604912527;5499.285092937893;5515.145152501369;5560.497776000816;5574.414686457944;5615.550755939515;5917.467427931507;5924.911126333109;5928.4960778334325;5975.701214939236;6011.5190784737115;6608.636524991076;6657.567258128206;6659;6680.198376194888;6696.497762667722;1914.8372388347148;1931.3336898770183;1938.8545859060628;1944;1953.7007889753438;1377.9862201378057;1417.9361928713233;1419.5528408551274;1432.5057855039995;1437.3531910640254;5676.602637815396;5686;5688.54491640676;5697.971510142423;5702.857428564319;6627.536072474977;6694;6721.361470660279;6750.662466876636;6780.864382712318;5608.495235428831;5649.293838270216;5707.600467967202;5718.656880587178;5760.769569217268;3556.395412779834;3569.268299998494;3593.2813437312643;3605.152789094561;3606.441001644749;6468.320826313169;6487.6756162191705;6540.084388185658;6558.80323590293;6577.80266592003;6712.731490740413;6744.291849355845;6746.898796518056;6813.829654258683;6813.863722725617;6341.207349081365;6407.1808404301955;6412.691431084899;6448.807405482158;6454.903176452451;6579.243387010555;6635.402813746786;6638.601683898982;6661.16735408074;6736.191657001191;6480.70836812354;6559.442447392025;6590.648916972105;6625.668716564249;6714;6324.494040476843;6350.809475715736;6418.0693799397895;6442.291347951628;6603.316154380602;5437.510624043855;5481.725913704378;5542.2795036644975;5546.694931778791;5553.278073850373;6283.685815709287;6498.707558159988;6641.701123449359;6744.032625644701;6780.711664783676;6263.8702841034265;6373.553851230369;6413.2945376007665;6416.615003099829;6547.181602299713;6285.779997700059;6401.263854656774;6414.069959855888;6479.287278399466;6500.479961603155;6298.370162983848;6324.778632747832;6409.935900640934;6415.1981002374705;6433.228012638513;6448.645324507197;6499.252585952676;6559.245686746085;6577.934220657732;6600.722750651018;6180.505559555315;6236.282827474898;6303.905441418474;6314.4632706218645;6363.96818015907 03:23:51 INFO - PID 6318 | |5;yui.html;901.3960646366937;905.8867641544807;912.8448163812151;916.0701887584099;933;19449.41651750448;20193.394198174043;20252;20353;20368.98155092245;17584.296628134893;17980;17987.460376188734;17989;18074.72887906679;961.8893827209873;970.1801977329145;971.2472833553982;977.9804403911953;979;961.2646325560952;965.4979410706428;966.7583104223944;967.1247520993477;969;995.1143482300758;1017.6692574913146;1033.1579762493543;1039.132324509036;1039.3763741754963;1026.5637104230748;1027.2552399510332;1027.866377370937;1028.028513055163;1028.1260928210997;728.4900569601248;752.1613401057836;753.4951582439778;756.0247281007494;756.7124492692742;19123.52191195217;19190.424287271406;19263;19293.421197364103;19396;21584.352469425943;21647.025883835264;22104.115835366567;22152.778472215232;22306.442338941495;17116.400925967533;17411.912940435344;17423.912880435517;17697.469075927744;17859.196336164903;3678.1172518595613;3682.263547290526;3695.722820788452;3696.5564132304025;3699.963000370016;102536;137527;139227.30386348104;142254;144755.99999999895;17354.219060142324;17726;17789;17823.554411139565;17831.821681783014;30060.54909176364;32799.344013119604;32859.50710739341;32881.67118328786;32993.67006329954;9190.31072669539;9444.8583271251;9484.288678349152;9503.04969503058;9535.094166054352;4350.934735978963;4457.531959144308;4465.240909045405;4466.240739074366;4468.039371535136;5356.116240820299;5428.67427954324;5481.205225242317;5522.199281104217;5539.695316757537;1044;1048.7063622185801;1070.925035247525;1071.1591400750374;1072.265498133781;652.2955208375039;673.5419914458215;675.5507587454387;675.5541342713785;689.1867596236389;11724;11925.88074119265;12148.87851121495;12295.69260768488;12341.444634991447;651.9511036672269;652.7715299645181;666.7299743603849;668.9464842812563;669.2103318084706;5526.696031718294;5533.391326954032;5587.329520457572;5661.830145095653;5663.1505274208375;126338;127976.36011819882;128027;128642.35678821546;129602;114585.4270728641;115010;115573;118038;118102;92807.53596231976;93875;94613;97952.02047979571;98446.5077674607;10118.797624047626;10492.580296788348;10557.102646274845;10685.626003089854;10781.407022613517;42547.787261063495;43520.34719479274;44100;44127.558724412345;44490.555094449934;55540.44459555353;55599.722001391354;56011.719941400035;56556.71721641366;57148;14000.929995349958;14222.075565088237;14227;14420.711585768435;14454.421823126957;17931.910340448216;18453.07734613237;18494.81505184931;18563.90718046401;18796.624067518846;15255.92372038177;15373.923130384277;15385.923070385024;15420;15518.689626207186;16340.59148521249;16700.331986720394;16721.498355049367;16738.246778894736;16834;15677.137757423452;15721.68556628884;15722;15753.606159846095;15977.760333595237;11620.477078531318;11788.174827762317;11873.287602743863;11955.880441195477;12276.079294052803;12324.568640097912;12345.259284442962;12546.1844980076;12623.558175463815;12842.422091006114 03:23:51 INFO - PID 6318 | __end_tp_report 03:23:51 INFO - PID 6318 | __start_cc_report 03:23:51 INFO - PID 6318 | _x_x_mozilla_cycle_collect,273 03:23:51 INFO - PID 6318 | __end_cc_report 03:23:51 INFO - PID 6318 | __startTimestamp1506939831325__endTimestamp 03:23:51 INFO - PID 6318 | 03:23:51 INFO - PID 6318 | ------- Summary: start ------- 03:23:51 INFO - PID 6318 | Number of tests: 6 03:23:51 INFO - PID 6318 | 03:23:51 INFO - PID 6318 | [#0] dojo.html Cycles:165 Average:6237.49 Median:6447.94 stddev:746.89 (11.6%) stddev-sans-first:710.07 03:23:51 INFO - PID 6318 | Values: 3196.6 3212.9 3221.5 3230.7 3241.5 6209.9 6250.1 6278.0 6351.7 6400.6 6231.2 6235.2 6266.7 6280.3 6343.3 5829.6 5878.4 5899.0 5944.2 5952.4 5628.0 5895.5 5896.7 5994.7 6006.4 5354.2 5715.2 5798.0 5859.2 5873.5 5785.1 5794.4 5874.1 5878.8 5880.4 5566.3 5618.9 5629.9 5648.1 5786.9 6165.3 6220.6 6225.7 6265.0 6304.8 6773.9 6840.2 6861.6 6876.8 6879.0 6816.0 6825.2 6835.5 6919.0 6943.1 6134.0 6257.3 6259.6 6261.6 6276.0 6790.6 6924.7 6931.7 6938.3 7034.8 6693.2 6736.4 6760.3 6766.5 6768.7 6773.3 6774.6 6793.1 6883.9 6902.8 6556.1 6718.1 6749.9 6808.3 6829.8 6680.0 6710.5 6713.3 6719.3 6727.5 5287.4 5340.8 5352.9 5373.4 5378.2 4618.5 4675.9 4698.3 4713.5 4732.1 5865.4 5871.9 5918.7 5924.6 5927.3 6573.4 6707.1 6748.8 6869.5 6872.3 5882.0 5890.3 5913.5 5933.2 5937.3 5718.4 5844.0 5864.6 5899.8 5924.4 6624.4 6652.8 6689.5 6748.9 6751.9 6632.2 6657.5 6780.0 6791.6 6797.8 6567.5 6665.3 6693.4 6696.4 6710.3 6677.3 6681.8 6799.9 6824.9 6843.0 6831.7 6837.0 6907.9 6909.2 6916.5 6401.4 6510.0 6523.6 6556.0 6672.9 6437.5 6440.3 6444.7 6531.9 6560.2 6594.3 6608.7 6615.4 6624.1 6637.7 6688.8 6694.4 6738.8 6755.0 6758.5 6155.5 6395.5 6397.3 6447.9 6485.4 03:23:51 INFO - PID 6318 | 03:23:51 INFO - PID 6318 | [#1] ext.html Cycles:180 Average:38423.77 Median:18993.36 stddev:55261.38 (291.0%) stddev-sans-first:55344.51 03:23:51 INFO - PID 6318 | Values: 885.5 886.7 900.5 926.8 927.7 41727.0 42343.8 42383.4 42493.2 42559.9 39188.4 43604.6 43991.0 44076.3 44178.3 8127.5 8236.3 8268.3 8271.7 8272.2 8066.4 8102.6 8106.7 8185.4 8187.0 8083.8 8116.1 8167.8 8188.1 8219.4 8035.5 8065.6 8091.2 8149.3 8156.7 7894.8 7994.9 8006.4 8007.0 8014.9 39042.6 39077.2 39163.2 39279.0 39386.8 3475.4 3507.3 3513.0 3529.0 3533.3 32004.8 32038.7 32047.8 32194.7 32233.0 5080.5 5153.7 5249.2 5257.1 5283.8 194572.0 195723.0 196231.0 196510.0 197346.0 49758.0 49840.3 49846.8 50135.5 50222.2 51682.7 51823.2 51881.2 51902.2 52136.7 16057.2 16209.8 16284.6 16292.0 16300.4 13279.6 13297.7 13310.2 13381.5 13399.0 13585.5 13725.0 13800.9 13814.4 13972.2 4976.4 5114.2 5120.3 5148.4 5162.7 1011.0 1018.7 1023.7 1024.5 1031.2 23002.4 23113.7 23150.4 23273.7 23279.4 1115.6 1118.5 1119.1 1127.5 1141.5 12170.9 12250.8 12353.6 12461.6 12465.4 241235.0 241411.0 241785.0 241931.0 242964.0 52690.5 56205.2 56320.0 56592.0 56889.0 1403.7 1447.5 1455.6 1458.2 1461.7 26046.2 26368.3 26459.2 26657.9 27383.6 38493.0 38530.6 38540.2 38553.4 38559.6 197644.0 198210.0 198509.0 198791.0 199163.0 33888.0 33998.7 34063.1 34155.1 34511.3 40570.4 41511.6 41635.4 41949.2 42109.4 31583.5 31635.8 31914.0 31990.8 32171.5 31758.5 31953.8 32246.0 32434.7 32618.5 34188.7 35647.5 35655.8 35706.8 35710.5 31251.2 31313.8 31520.5 31543.2 31641.0 22891.8 23097.9 23109.8 23325.2 23582.0 03:23:51 INFO - PID 6318 | 03:23:51 INFO - PID 6318 | [#2] jquery.html Cycles:180 Average:35450.54 Median:12768.42 stddev:82634.13 (647.2%) stddev-sans-first:82824.45 03:23:51 INFO - PID 6318 | Values: 573.5 578.0 588.5 594.4 625.3 22782.9 23216.9 23292.4 23566.8 23612.9 24186.6 24839.3 25784.6 25869.5 26003.2 6482.8 6623.9 6627.9 6628.4 6656.3 6480.5 6510.3 6594.7 6604.8 6738.4 6708.8 6709.6 6714.5 6715.1 6717.0 6573.8 6686.0 6694.3 6712.9 6726.7 6331.8 6334.7 6352.2 6371.0 6381.2 29626.7 29891.6 30286.4 30323.8 30431.5 2001.7 2028.8 2030.0 2031.1 2034.4 20374.5 20401.6 20514.8 20624.9 20827.7 2210.5 2290.6 2315.0 2319.2 2320.0 124660.4 130514.0 132016.3 138700.0 147179.0 15108.6 15201.5 15475.5 15718.8 16037.4 24238.0 24239.8 24306.8 24328.8 24354.5 10318.2 10348.6 10412.4 10472.4 10614.8 9352.8 9420.9 9440.0 9497.1 9541.9 9323.3 9330.4 9403.1 9418.6 9482.5 2722.6 2737.2 2837.4 2886.7 3003.9 943.2 961.5 979.1 979.7 981.2 19559.9 20020.7 20066.9 20136.0 20387.8 1035.2 1046.2 1047.9 1051.9 1060.5 10771.9 10898.2 11253.3 11292.7 11308.0 478290.0 484419.0 493780.0 495203.0 498837.5 115583.0 116143.4 116628.0 117200.0 119981.0 1162.1 1209.9 1258.2 1262.2 1287.3 21370.5 21396.6 21493.0 21551.0 21997.7 60424.0 61883.4 61899.7 62643.0 63540.7 80192.6 80291.0 80526.0 80569.2 80837.6 14805.4 15137.7 15138.8 15174.5 15247.7 23424.1 23491.3 23657.8 23840.0 23887.2 18401.3 18904.7 19099.0 19110.7 19263.0 16817.2 16837.9 17132.7 17458.7 17664.4 18309.0 18539.4 18798.0 19089.2 19101.3 15013.2 15030.5 15072.8 15107.5 15126.4 17918.4 18005.7 18151.2 18178.7 18198.4 03:23:51 INFO - PID 6318 | 03:23:51 INFO - PID 6318 | [#3] mootools.html Cycles:180 Average:9524.58 Median:2739.25 stddev:6936.44 (253.2%) stddev-sans-first:6928.78 03:23:51 INFO - PID 6318 | Values: 1361.7 1413.2 1417.4 1423.6 1424.9 14863.3 16145.5 16149.8 16150.2 16163.5 15660.9 15884.2 15936.8 15944.8 15978.1 2808.9 2821.2 2844.4 2852.7 2853.5 2586.9 2690.4 2742.8 2748.3 2757.2 2726.2 2757.6 2795.6 2827.7 2841.4 2696.7 2732.4 2732.5 2733.8 2735.7 2702.9 2721.5 2730.1 2763.8 2764.3 15183.3 15307.8 15317.6 15320.1 15390.8 8146.6 8376.0 8473.1 8509.4 8525.7 5272.9 5458.9 5546.9 5659.6 5764.5 1983.7 2008.3 2025.3 2039.7 2045.8 27758.3 27940.9 27947.7 27969.2 28026.3 6647.7 6748.5 7048.3 7063.1 7231.2 17885.5 17979.6 17983.8 17994.1 18025.1 7942.3 8191.7 8211.9 8225.4 8230.3 7355.3 7371.1 7497.9 7564.9 7578.3 5434.7 5451.3 5471.3 5490.7 5534.9 1519.3 1547.2 1569.9 1584.7 1597.5 876.8 888.3 891.2 901.4 910.8 7330.3 7381.2 7409.4 7437.1 7461.0 704.4 742.5 744.2 744.7 752.4 4719.3 4946.9 5017.6 5145.9 5287.4 20873.8 22915.1 22919.9 22934.4 22943.7 21708.8 21844.0 21928.6 22006.8 22227.0 10715.1 11066.7 11144.4 11156.4 11167.9 8396.8 8461.5 8501.5 8556.6 8654.4 18121.0 18860.0 19103.0 19231.7 19305.0 18947.6 19517.3 19704.6 19824.3 19915.8 11171.4 11297.1 11394.3 11397.7 11443.9 13969.2 14055.9 14101.2 14162.6 14203.1 11347.3 11696.4 11708.8 11788.8 11811.8 11134.3 11226.4 11362.7 11432.7 11605.4 9579.8 9762.8 9762.8 9763.3 9766.1 6919.5 6943.8 6948.6 6949.6 7003.2 7277.6 7314.6 7326.5 7470.7 7516.7 03:23:51 INFO - PID 6318 | 03:23:51 INFO - PID 6318 | [#4] prototype.html Cycles:180 Average:5610.62 Median:6204.58 stddev:1481.91 (23.9%) stddev-sans-first:1435.57 03:23:51 INFO - PID 6318 | Values: 500.5 530.1 530.6 534.6 536.2 6287.6 6307.7 6313.3 6318.4 6356.6 6228.7 6260.2 6289.1 6302.9 6303.9 5226.7 5244.3 5262.0 5263.0 5285.2 5176.0 5227.0 5243.6 5268.1 5284.7 5021.5 5127.9 5193.3 5197.4 5208.6 5162.4 5175.6 5183.3 5238.2 5251.6 4780.9 4822.4 4880.6 4887.6 4915.6 6070.5 6103.3 6115.9 6134.7 6138.1 5944.2 6019.6 6021.7 6038.4 6047.7 6530.3 6627.9 6653.6 6682.4 6715.6 5308.1 5348.8 5357.2 5361.3 5362.0 6726.4 6915.5 6917.0 6928.7 6929.9 5377.2 5455.3 5479.0 5487.7 5530.5 5499.3 5515.1 5560.5 5574.4 5615.6 5917.5 5924.9 5928.5 5975.7 6011.5 6608.6 6657.6 6659.0 6680.2 6696.5 1914.8 1931.3 1938.9 1944.0 1953.7 1378.0 1417.9 1419.6 1432.5 1437.4 5676.6 5686.0 5688.5 5698.0 5702.9 6627.5 6694.0 6721.4 6750.7 6780.9 5608.5 5649.3 5707.6 5718.7 5760.8 3556.4 3569.3 3593.3 3605.2 3606.4 6468.3 6487.7 6540.1 6558.8 6577.8 6712.7 6744.3 6746.9 6813.8 6813.9 6341.2 6407.2 6412.7 6448.8 6454.9 6579.2 6635.4 6638.6 6661.2 6736.2 6480.7 6559.4 6590.6 6625.7 6714.0 6324.5 6350.8 6418.1 6442.3 6603.3 5437.5 5481.7 5542.3 5546.7 5553.3 6283.7 6498.7 6641.7 6744.0 6780.7 6263.9 6373.6 6413.3 6416.6 6547.2 6285.8 6401.3 6414.1 6479.3 6500.5 6298.4 6324.8 6409.9 6415.2 6433.2 6448.6 6499.3 6559.2 6577.9 6600.7 6180.5 6236.3 6303.9 6314.5 6364.0 03:23:51 INFO - PID 6318 | 03:23:51 INFO - PID 6318 | [#5] yui.html Cycles:180 Average:24559.98 Median:19226.71 stddev:35737.37 (185.9%) stddev-sans-first:35793.47 03:23:51 INFO - PID 6318 | Values: 901.4 905.9 912.8 916.1 933.0 19449.4 20193.4 20252.0 20353.0 20369.0 17584.3 17980.0 17987.5 17989.0 18074.7 961.9 970.2 971.2 978.0 979.0 961.3 965.5 966.8 967.1 969.0 995.1 1017.7 1033.2 1039.1 1039.4 1026.6 1027.3 1027.9 1028.0 1028.1 728.5 752.2 753.5 756.0 756.7 19123.5 19190.4 19263.0 19293.4 19396.0 21584.4 21647.0 22104.1 22152.8 22306.4 17116.4 17411.9 17423.9 17697.5 17859.2 3678.1 3682.3 3695.7 3696.6 3700.0 102536.0 137527.0 139227.3 142254.0 144756.0 17354.2 17726.0 17789.0 17823.6 17831.8 30060.5 32799.3 32859.5 32881.7 32993.7 9190.3 9444.9 9484.3 9503.0 9535.1 4350.9 4457.5 4465.2 4466.2 4468.0 5356.1 5428.7 5481.2 5522.2 5539.7 1044.0 1048.7 1070.9 1071.2 1072.3 652.3 673.5 675.6 675.6 689.2 11724.0 11925.9 12148.9 12295.7 12341.4 652.0 652.8 666.7 668.9 669.2 5526.7 5533.4 5587.3 5661.8 5663.2 126338.0 127976.4 128027.0 128642.4 129602.0 114585.4 115010.0 115573.0 118038.0 118102.0 92807.5 93875.0 94613.0 97952.0 98446.5 10118.8 10492.6 10557.1 10685.6 10781.4 42547.8 43520.3 44100.0 44127.6 44490.6 55540.4 55599.7 56011.7 56556.7 57148.0 14000.9 14222.1 14227.0 14420.7 14454.4 17931.9 18453.1 18494.8 18563.9 18796.6 15255.9 15373.9 15385.9 15420.0 15518.7 16340.6 16700.3 16721.5 16738.2 16834.0 15677.1 15721.7 15722.0 15753.6 15977.8 11620.5 11788.2 11873.3 11955.9 12276.1 12324.6 12345.3 12546.2 12623.6 12842.4 03:23:51 INFO - PID 6318 | -------- Summary: end -------- 03:23:51 INFO - PID 6318 | 03:23:51 INFO - TEST-INFO | 6318: exit 0 03:23:51 INFO - TEST-OK | dromaeo_css | took 1108510ms 03:23:51 INFO - TEST-START | kraken 03:23:51 INFO - Initialising browser for kraken test... 03:23:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38867/getInfo.html -profile /tmp/tmpiRJmJq/profile 03:23:51 INFO - TEST-INFO | started process 6678 (/builds/slave/test/build/application/firefox/firefox http://localhost:38867/getInfo.html) 03:23:56 INFO - TEST-INFO | 6678: exit 0 03:23:56 INFO - Browser initialized. 03:23:56 INFO - Running cycle 1/1 for kraken test... 03:23:56 INFO - Using env: {'DISPLAY': ':0', 03:23:56 INFO - 'HOME': '/home/cltbld', 03:23:56 INFO - 'JSGC_DISABLE_POISONING': '1', 03:23:56 INFO - 'LANG': 'en_US.UTF-8', 03:23:56 INFO - 'LANGUAGE': 'en_US:en', 03:23:56 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:23:56 INFO - 'LOGNAME': 'cltbld', 03:23:56 INFO - 'MAIL': '/var/mail/cltbld', 03:23:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:23:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:23:56 INFO - 'MOZ_CRASHREPORTER': '1', 03:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:56 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:23:56 INFO - 'MOZ_NO_REMOTE': '1', 03:23:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:56 INFO - 'NO_EM_RESTART': '1', 03:23:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:56 INFO - 'PWD': '/builds/slave/test', 03:23:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:23:56 INFO - 'RUST_BACKTRACE': 'full', 03:23:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:23:56 INFO - 'SHELL': '/bin/bash', 03:23:56 INFO - 'SHLVL': '1', 03:23:56 INFO - 'STYLO_FORCE_DISABLED': '1', 03:23:56 INFO - 'TERM': 'linux', 03:23:56 INFO - 'TMOUT': '86400', 03:23:56 INFO - 'USER': 'cltbld', 03:23:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828', 03:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:56 INFO - '_': '/tools/buildbot/bin/python'} 03:23:56 INFO - TEST-INFO | started process 6912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiRJmJq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:23:57 INFO - PID 6912 | 03:23:57 INFO - PID 6912 | (/builds/slave/test/build/application/firefox/firefox:6960): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:23:57 INFO - PID 6912 | 03:24:07 INFO - PID 6912 | RSS: Main: 154140672 03:24:07 INFO - PID 6912 | 03:24:10 INFO - PID 6912 | Cycle 1(1): loaded http://localhost:38867/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38867/tests/kraken/driver.html?testName=audio-beat-detection) 03:24:11 INFO - PID 6912 | RSS: Main: 159543296 03:24:11 INFO - PID 6912 | 03:24:14 INFO - PID 6912 | Cycle 1(1): loaded http://localhost:38867/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38867/tests/kraken/driver.html?testName=audio-dft) 03:24:14 INFO - PID 6912 | RSS: Main: 159727616 03:24:14 INFO - PID 6912 | 03:24:17 INFO - PID 6912 | Cycle 1(1): loaded http://localhost:38867/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38867/tests/kraken/driver.html?testName=audio-fft) 03:24:18 INFO - PID 6912 | RSS: Main: 156839936 03:24:18 INFO - PID 6912 | 03:24:20 INFO - PID 6912 | Cycle 1(1): loaded http://localhost:38867/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38867/tests/kraken/driver.html?testName=audio-oscillator) 03:24:20 INFO - PID 6912 | RSS: Main: 157327360 03:24:20 INFO - PID 6912 | 03:24:23 INFO - PID 6912 | Cycle 1(1): loaded http://localhost:38867/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38867/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:24:23 INFO - PID 6912 | RSS: Main: 157327360 03:24:23 INFO - PID 6912 | 03:24:26 INFO - PID 6912 | Cycle 1(1): loaded http://localhost:38867/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38867/tests/kraken/driver.html?testName=imaging-darkroom) 03:24:27 INFO - PID 6912 | RSS: Main: 159408128 03:24:27 INFO - PID 6912 | 03:24:31 INFO - PID 6912 | Cycle 1(1): loaded http://localhost:38867/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38867/tests/kraken/driver.html?testName=imaging-desaturate) 03:24:31 INFO - PID 6912 | RSS: Main: 159793152 03:24:31 INFO - PID 6912 | 03:24:34 INFO - PID 6912 | Cycle 1(1): loaded http://localhost:38867/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38867/tests/kraken/driver.html?testName=json-parse-financial) 03:24:35 INFO - PID 6912 | RSS: Main: 160124928 03:24:35 INFO - PID 6912 | 03:24:37 INFO - PID 6912 | Cycle 1(1): loaded http://localhost:38867/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38867/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:24:37 INFO - PID 6912 | RSS: Main: 159641600 03:24:37 INFO - PID 6912 | 03:24:39 INFO - PID 6912 | Cycle 1(1): loaded http://localhost:38867/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38867/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:24:39 INFO - PID 6912 | RSS: Main: 159846400 03:24:39 INFO - PID 6912 | 03:24:41 INFO - PID 6912 | Cycle 1(1): loaded http://localhost:38867/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38867/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:24:42 INFO - PID 6912 | RSS: Main: 156823552 03:24:42 INFO - PID 6912 | 03:24:45 INFO - PID 6912 | Cycle 1(1): loaded http://localhost:38867/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38867/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:24:45 INFO - PID 6912 | RSS: Main: 157327360 03:24:45 INFO - PID 6912 | 03:24:48 INFO - PID 6912 | Cycle 1(1): loaded http://localhost:38867/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38867/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:24:49 INFO - PID 6912 | RSS: Main: 157089792 03:24:49 INFO - PID 6912 | 03:24:51 INFO - PID 6912 | Cycle 1(1): loaded http://localhost:38867/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38867/tests/kraken/driver.html?testName=ai-astar) 03:24:51 INFO - PID 6912 | RSS: Main: 158359552 03:24:51 INFO - PID 6912 | 03:24:51 INFO - PID 6912 | __start_tp_report 03:24:51 INFO - PID 6912 | _x_x_mozilla_page_load 03:24:51 INFO - PID 6912 | _x_x_mozilla_page_load_details 03:24:51 INFO - PID 6912 | |i|pagename|runs| 03:24:51 INFO - PID 6912 | |0;ai-astar;107;107;107;107;108;107;109;106;107;107 03:24:51 INFO - PID 6912 | |1;audio-beat-detection;118;114;115;148;115;116;115;145;116;140 03:24:51 INFO - PID 6912 | |2;audio-dft;163;162;162;163;163;163;164;164;165;164 03:24:51 INFO - PID 6912 | |3;audio-fft;78;75;75;73;75;75;76;73;74;73 03:24:51 INFO - PID 6912 | |4;audio-oscillator;80;80;78;85;78;79;79;134;78;79 03:24:51 INFO - PID 6912 | |5;imaging-gaussian-blur;114;117;113;115;114;113;114;114;115;114 03:24:51 INFO - PID 6912 | |6;imaging-darkroom;149;151;148;148;150;147;195;149;149;149 03:24:51 INFO - PID 6912 | |7;imaging-desaturate;98;94;94;95;95;95;94;98;99;94 03:24:51 INFO - PID 6912 | |8;json-parse-financial;53;51;51;52;53;52;54;51;52;51 03:24:51 INFO - PID 6912 | |9;json-stringify-tinderbox;38;38;38;38;38;38;37;38;37;37 03:24:51 INFO - PID 6912 | |10;stanford-crypto-aes;72;74;71;72;71;72;72;74;72;78 03:24:51 INFO - PID 6912 | |11;stanford-crypto-ccm;107;111;116;106;110;108;110;116;113;107 03:24:51 INFO - PID 6912 | |12;stanford-crypto-pbkdf2;161;163;158;158;163;163;172;163;178;166 03:24:51 INFO - PID 6912 | |13;stanford-crypto-sha256-iterative;70;63;65;62;62;66;64;64;64;64 03:24:51 INFO - PID 6912 | __end_tp_report 03:24:51 INFO - PID 6912 | __start_cc_report 03:24:51 INFO - PID 6912 | _x_x_mozilla_cycle_collect,759 03:24:51 INFO - PID 6912 | __end_cc_report 03:24:51 INFO - PID 6912 | __startTimestamp1506939891254__endTimestamp 03:24:51 INFO - PID 6912 | 03:24:51 INFO - PID 6912 | ------- Summary: start ------- 03:24:51 INFO - PID 6912 | Number of tests: 14 03:24:51 INFO - PID 6912 | 03:24:51 INFO - PID 6912 | [#0] ai-astar Cycles:10 Average:107.20 Median:107.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 03:24:51 INFO - PID 6912 | Values: 107.0 107.0 107.0 107.0 108.0 107.0 109.0 106.0 107.0 107.0 03:24:51 INFO - PID 6912 | 03:24:51 INFO - PID 6912 | [#1] audio-beat-detection Cycles:10 Average:124.20 Median:117.00 stddev:14.06 (12.0%) stddev-sans-first:14.73 03:24:51 INFO - PID 6912 | Values: 118.0 114.0 115.0 148.0 115.0 116.0 115.0 145.0 116.0 140.0 03:24:51 INFO - PID 6912 | 03:24:51 INFO - PID 6912 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 03:24:51 INFO - PID 6912 | Values: 163.0 162.0 162.0 163.0 163.0 163.0 164.0 164.0 165.0 164.0 03:24:51 INFO - PID 6912 | 03:24:51 INFO - PID 6912 | [#3] audio-fft Cycles:10 Average:74.70 Median:75.00 stddev:1.57 (2.1%) stddev-sans-first:1.12 03:24:51 INFO - PID 6912 | Values: 78.0 75.0 75.0 73.0 75.0 75.0 76.0 73.0 74.0 73.0 03:24:51 INFO - PID 6912 | 03:24:51 INFO - PID 6912 | [#4] audio-oscillator Cycles:10 Average:85.00 Median:79.00 stddev:17.34 (21.9%) stddev-sans-first:18.30 03:24:51 INFO - PID 6912 | Values: 80.0 80.0 78.0 85.0 78.0 79.0 79.0 134.0 78.0 79.0 03:24:51 INFO - PID 6912 | 03:24:51 INFO - PID 6912 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:1.16 (1.0%) stddev-sans-first:1.22 03:24:51 INFO - PID 6912 | Values: 114.0 117.0 113.0 115.0 114.0 113.0 114.0 114.0 115.0 114.0 03:24:51 INFO - PID 6912 | 03:24:51 INFO - PID 6912 | [#6] imaging-darkroom Cycles:10 Average:153.50 Median:149.00 stddev:14.62 (9.8%) stddev-sans-first:15.42 03:24:51 INFO - PID 6912 | Values: 149.0 151.0 148.0 148.0 150.0 147.0 195.0 149.0 149.0 149.0 03:24:51 INFO - PID 6912 | 03:24:51 INFO - PID 6912 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.00 stddev:1.96 (2.1%) stddev-sans-first:1.87 03:24:51 INFO - PID 6912 | Values: 98.0 94.0 94.0 95.0 95.0 95.0 94.0 98.0 99.0 94.0 03:24:51 INFO - PID 6912 | 03:24:51 INFO - PID 6912 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:1.05 (2.0%) stddev-sans-first:1.05 03:24:51 INFO - PID 6912 | Values: 53.0 51.0 51.0 52.0 53.0 52.0 54.0 51.0 52.0 51.0 03:24:51 INFO - PID 6912 | 03:24:51 INFO - PID 6912 | [#9] json-stringify-tinderbox Cycles:10 Average:37.70 Median:38.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 03:24:51 INFO - PID 6912 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 37.0 38.0 37.0 37.0 03:24:51 INFO - PID 6912 | 03:24:51 INFO - PID 6912 | [#10] stanford-crypto-aes Cycles:10 Average:72.80 Median:72.00 stddev:2.10 (2.9%) stddev-sans-first:2.20 03:24:51 INFO - PID 6912 | Values: 72.0 74.0 71.0 72.0 71.0 72.0 72.0 74.0 72.0 78.0 03:24:51 INFO - PID 6912 | 03:24:51 INFO - PID 6912 | [#11] stanford-crypto-ccm Cycles:10 Average:110.40 Median:110.50 stddev:3.63 (3.3%) stddev-sans-first:3.63 03:24:51 INFO - PID 6912 | Values: 107.0 111.0 116.0 106.0 110.0 108.0 110.0 116.0 113.0 107.0 03:24:51 INFO - PID 6912 | 03:24:51 INFO - PID 6912 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.50 Median:163.00 stddev:6.20 (3.8%) stddev-sans-first:6.45 03:24:51 INFO - PID 6912 | Values: 161.0 163.0 158.0 158.0 163.0 163.0 172.0 163.0 178.0 166.0 03:24:51 INFO - PID 6912 | 03:24:51 INFO - PID 6912 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.00 stddev:2.32 (3.6%) stddev-sans-first:1.30 03:24:51 INFO - PID 6912 | Values: 70.0 63.0 65.0 62.0 62.0 66.0 64.0 64.0 64.0 64.0 03:24:51 INFO - PID 6912 | -------- Summary: end -------- 03:24:51 INFO - PID 6912 | 03:24:51 INFO - PID 6912 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:24:51 INFO - TEST-INFO | 6912: exit 0 03:24:51 INFO - TEST-OK | kraken | took 60072ms 03:24:51 INFO - SUITE-END | took 1168s 03:24:52 INFO - Completed test suite (00:19:29) 03:24:52 INFO - javascript benchmark 03:24:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8642.808432594478, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3196.6164060312767, 3212.8554215060303, 3221.484562470005, 3230.676932306771, 3241.5137729340604, 6209.9068513972215, 6250.124982502453, 6277.968610156949, 6351.745930162794, 6400.5519613627, 6231.189945307115, 6235.189425374695, 6266.749330026805, 6280.309165991737, 6343.302236753953, 5829.562782791308, 5878.382769809173, 5899.0, 5944.167816505693, 5952.375000624937, 5628.0, 5895.528357731371, 5896.734646940898, 5994.700264986734, 6006.369331220203, 5354.196870469422, 5715.228444160027, 5797.971010144965, 5859.238299021121, 5873.471387575096, 5785.132230165466, 5794.362620111784, 5874.060150375962, 5878.823635290948, 5880.441358070976, 5566.304211973504, 5618.91571626426, 5629.8592535186535, 5648.124540696199, 5786.855328616776, 6165.2601687797305, 6220.595661282002, 6225.657588832612, 6264.9686751566405, 6304.842378940563, 6773.8983915241315, 6840.247572766992, 6861.588304701734, 6876.793696189123, 6878.965605171942, 6815.965920170417, 6825.215100263484, 6835.487338449587, 6919.0, 6943.062686537303, 6133.969330153365, 6257.342978987232, 6259.561830671855, 6261.624302541862, 6276.027215781515, 6790.626515541594, 6924.688389022506, 6931.653417329214, 6938.271481494471, 7034.753783617549, 6693.196816382066, 6736.360045795642, 6760.3239676032, 6766.458683305324, 6768.69540870662, 6773.288804675537, 6774.593524388552, 6793.082933803972, 6883.862322753617, 6902.827429314207, 6556.082148499214, 6718.0930574372815, 6749.898751518731, 6808.285130061371, 6829.795106146824, 6680.0, 6710.463162946952, 6713.328667133248, 6719.328067193242, 6727.495437842182, 5287.4448182941005, 5340.813071542555, 5352.892942141136, 5373.382061063028, 5378.19327100938, 4618.49196588375, 4675.883102922386, 4698.271767875985, 4713.481517033124, 4732.100900828831, 5865.35481097079, 5871.853203669857, 5918.704064796743, 5924.644521328734, 5927.288725352985, 6573.408393244536, 6707.128073350434, 6748.83127921796, 6869.450443964471, 6872.278410766798, 5882.0, 5890.293164820163, 5913.497352725067, 5933.199018132583, 5937.317208520989, 5718.428157184248, 5843.970780146072, 5864.589478736448, 5899.76400943966, 5924.377940316204, 6624.436922861514, 6652.7671531497135, 6689.49828762835, 6748.898766518506, 6751.864962700718, 6632.1709786276715, 6657.500687448364, 6779.966100169468, 6791.558548694319, 6797.762078327235, 6567.540272180901, 6665.266820649822, 6693.397594216349, 6696.363845434676, 6710.261871194262, 6677.265500795006, 6681.76613818514, 6799.864002720017, 6824.897626535507, 6842.965785171043, 6831.726730930707, 6837.042814005944, 6907.896381554381, 6909.205441374105, 6916.51584389108, 6401.391867772554, 6510.0, 6523.608583485006, 6555.967220163869, 6672.933270667231, 6437.452816510649, 6440.29156792743, 6444.709988050643, 6531.934680653323, 6560.179977502812, 6594.340565943367, 6608.669566521751, 6615.4046135848, 6624.105745724266, 6637.668116594247, 6688.83277918056, 6694.430973367318, 6738.797836064926, 6754.966225168842, 6758.5269031167345, 6155.47678447337, 6395.456386207225, 6397.328280530477, 6447.935520644921, 6485.448736857231], "value": 6181.312907446011, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [885.4818674387243, 886.6622737315399, 900.4912224593104, 926.8146370725852, 927.7309580221736, 41727.0, 42343.78828105855, 42383.36424953628, 42493.15013699724, 42559.936001599934, 39188.412173817414, 43604.56395436045, 43991.0, 44076.3388549172, 44178.33732494015, 8127.512349259034, 8236.258736713695, 8268.297194738454, 8271.669133234664, 8272.17278272174, 8066.354691624685, 8102.5543595102245, 8106.716264930728, 8185.427020108595, 8187.0, 8083.797905052391, 8116.107228204893, 8167.754967350989, 8188.099309075997, 8219.424640275183, 8035.477693949903, 8065.637046332899, 8091.231333023354, 8149.307308878752, 8156.6737330507, 7894.842103157962, 7994.920050799476, 8006.439549231556, 8007.039155301343, 8014.879776803353, 39042.609573904185, 39077.21845563101, 39163.216735665126, 39279.0, 39386.80306598449, 3475.409180439306, 3507.333606614735, 3513.0339156732102, 3528.964710352915, 3533.2933413317182, 32004.839975800205, 32038.679613204036, 32047.83976080128, 32194.678053219635, 32233.0, 5080.466551012128, 5153.690778553261, 5249.238860365225, 5257.106291930381, 5283.841484755425, 194572.0, 195723.0, 196230.99999999857, 196510.0, 197346.0, 49758.0, 49840.252396214084, 49846.75076624594, 50135.49864501381, 50222.24666630004, 51682.74158629183, 51823.222651659504, 51881.2217816733, 51902.22146667803, 52136.73931630394, 16057.197140142945, 16209.837901620833, 16284.592885177964, 16292.0, 16300.42948496797, 13279.601611951657, 13297.734045319039, 13310.201387916755, 13381.53164639233, 13399.0, 13585.52450664222, 13725.0, 13800.93099534516, 13814.447422103003, 13972.231527265894, 4976.427710813303, 5114.232865070269, 5120.283160357553, 5148.3564554430695, 5162.664426812245, 1010.9797804043878, 1018.6536577563664, 1023.7389465686202, 1024.52871679027, 1031.2111234905303, 23002.424939376648, 23113.653295200584, 23150.42123946915, 23273.650895236584, 23279.418014549432, 1115.5928086248623, 1118.4799068433056, 1119.0935342372704, 1127.503898284752, 1141.543382646948, 12170.939145304217, 12250.81623775644, 12353.567625133077, 12461.563845265373, 12465.439055242536, 241235.0, 241411.0, 241785.0, 241931.0, 242964.0, 52690.47309526932, 56205.156922646194, 56320.0, 56592.0, 56889.0, 1403.7122389910044, 1447.4644381578673, 1455.5997100797365, 1458.1761304862719, 1461.744194765933, 26046.218613441626, 26368.3407914796, 26459.206223813315, 26657.866710666323, 27383.589246161722, 38493.0, 38530.6146938527, 38540.22919541538, 38553.421698675105, 38559.61440385672, 197644.0, 198210.0, 198509.0, 198791.0, 199163.0, 33888.0, 33998.66001339955, 34063.14842128967, 34155.14612134716, 34511.30977380489, 40570.391444127774, 41511.58488415198, 41635.37546936859, 41949.161016780105, 42109.36835947402, 31583.526247106773, 31635.84182079075, 31914.0, 31990.84004579962, 32171.51742723908, 31758.52362214615, 31953.840230798698, 32246.0, 32434.67565324411, 32618.51072233966, 34188.658113419544, 35647.465288021216, 35655.82172089123, 35706.821465892506, 35710.4643430354, 31251.218719532193, 31313.8434307827, 31520.52719209168, 31543.211419713774, 31641.0, 22891.77108228963, 23097.88451057734, 23109.84308131257, 23325.183618573268, 23582.0], "value": 17450.87808878761, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.498189084551, 577.9624324418916, 588.4644973074503, 594.408563479338, 625.3465128940259, 22782.88608556957, 23216.88391558044, 23292.41768955777, 23566.76433235667, 23612.88193559034, 24186.637200442008, 24839.254822355357, 25784.613230801508, 25869.48261034783, 26003.21990340293, 6482.837929051764, 6623.933760662404, 6627.867442651144, 6628.43658289046, 6656.267810540837, 6480.546361754679, 6510.283868774431, 6594.670266486681, 6604.768833090843, 6738.427233685143, 6708.83227919301, 6709.630970296632, 6714.462842972575, 6715.12703348564, 6717.0, 6573.802785916382, 6686.0, 6694.263631000586, 6712.865742685168, 6726.697298621574, 6331.841703957438, 6334.651594162319, 6352.1742173517605, 6371.044343348535, 6381.170447841797, 29626.70373296261, 29891.5516267254, 30286.394272114434, 30323.848380758176, 30431.543526847116, 2001.7497812773404, 2028.817406433428, 2029.989850050755, 2031.1469182943051, 2034.4303594993426, 20374.471914606464, 20401.591968160552, 20514.794852051436, 20624.896875515675, 20827.68758468609, 2210.4805370737863, 2290.5647926893835, 2314.953700925989, 2319.153508969231, 2319.953600927972, 124660.37669811683, 130514.0, 132016.33991830074, 138699.99999999898, 147179.0, 15108.63264775824, 15201.467948621745, 15475.529824666639, 15718.764218536731, 16037.358505659642, 24238.030478781006, 24239.757602424103, 24306.75693243045, 24328.756712433, 24354.512909741705, 10318.245898197325, 10348.637797677196, 10412.427316497666, 10472.371657700562, 10614.787704245871, 9352.812943741086, 9420.90579094214, 9440.008799076135, 9497.097775711296, 9541.904580954102, 9323.347365684473, 9330.393524420891, 9403.14471066873, 9418.62325506972, 9482.525873706287, 2722.6460560127057, 2737.151483040264, 2837.3757773289844, 2886.6536015677834, 3003.894863679761, 943.2406912435418, 961.5336561767538, 979.118793086228, 979.7060881735594, 981.2052237687496, 19559.902200489192, 20020.69968950467, 20066.89966550158, 20136.0, 20387.796122038886, 1035.223582313265, 1046.2414749306693, 1047.8899715529913, 1051.8790339111101, 1060.522764755863, 10771.946140269249, 10898.182636302308, 11253.324800511995, 11292.71768205785, 11308.038816700508, 478290.0, 484419.0, 493780.0, 495203.0, 498837.50581247587, 115583.0, 116143.41928290305, 116628.0, 117200.0, 119981.0, 1162.122597438928, 1209.9455524501418, 1258.150748244931, 1262.2489618676873, 1287.3241548187088, 21370.465738356666, 21396.572068558853, 21493.0, 21551.0, 21997.67003494981, 60424.0, 61883.38116618776, 61899.69050154721, 62643.0, 63540.682296588224, 80192.59903700445, 80291.0, 80526.0, 80569.19430805852, 80837.59581202056, 14805.407783688532, 15137.697246055237, 15138.772918406012, 15174.544763657108, 15247.695046099238, 23424.06303747831, 23491.295261142193, 23657.763422366246, 23840.04639814388, 23887.163949261692, 18401.263949441873, 18904.716429253847, 19099.0, 19110.7133393002, 19263.0, 16817.159142042605, 16837.91581042087, 17132.743008854628, 17458.73811892848, 17664.381746638806, 18309.0, 18539.44381668552, 18797.966111863978, 19089.236430543177, 19101.331453399063, 15013.174275414956, 15030.549083527512, 15072.849271507144, 15107.54677359681, 15126.39494420211, 17918.372856949944, 18005.729914051037, 18151.183196755912, 18178.72731909049, 18198.363057292932], "value": 12297.398963814265, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.6936189357393, 1413.2015411292618, 1417.404690030187, 1423.5515812519063, 1424.8788852947498, 14863.331150098244, 16145.515634530953, 16149.75775363369, 16150.192490375493, 16163.515094547152, 15660.921695391507, 15884.205789710526, 15936.84063159371, 15944.840551594481, 15978.121203333812, 2808.90168844091, 2821.2241633550734, 2844.3742376677096, 2852.7147285271512, 2853.4863724529578, 2586.9094581689646, 2690.4215593647364, 2742.80800343976, 2748.2854457840904, 2757.1590664847213, 2726.209399274208, 2757.5725762506845, 2795.6365672462553, 2827.6889542150348, 2841.3748975225417, 2696.7168447313043, 2732.4261904999976, 2732.4535092981287, 2733.808633395653, 2735.6990731019573, 2702.9189124326303, 2721.482918245527, 2730.1127133681434, 2763.8065335426527, 2764.2951047482966, 15183.316750746133, 15307.846921530754, 15317.617059573487, 15320.080795152326, 15390.846091539053, 8146.592670366517, 8376.0, 8473.110323416076, 8509.361797865124, 8525.701600444017, 5272.947270527322, 5458.918116228259, 5546.889062218774, 5659.5755318351285, 5764.452377024176, 1983.6528607493776, 2008.2970960163973, 2025.3215172917091, 2039.6838490034067, 2045.764737055243, 27758.3060423489, 27940.8602956988, 27947.720522794716, 27969.160925172277, 28026.299342516395, 6647.66761661915, 6748.4938629602975, 7048.259932707095, 7063.117110361205, 7231.168415632164, 17885.46343609694, 17979.640407191782, 17983.820161798216, 17994.10029498546, 18025.09874506296, 7942.324902383362, 8191.672333106609, 8211.876821847676, 8225.424220304521, 8230.300424463987, 7355.264473552602, 7371.078615173104, 7497.9250207497225, 7564.9243507565325, 7578.280063393969, 5434.728263586805, 5451.345838499326, 5471.2887324647545, 5490.725463726878, 5534.889302213933, 1519.346680927212, 1547.1722628393754, 1569.8901076924733, 1584.7464405695034, 1597.456864666019, 876.8158686675743, 888.3248730964514, 891.2424439226605, 901.3915606965272, 910.8451563234266, 7330.303621155982, 7381.188069312371, 7409.37020353276, 7437.107547094383, 7460.962695186489, 704.4012589299157, 742.5173637135905, 744.1591002167625, 744.6983971491554, 752.4018405367746, 4719.2685133803625, 4946.8763280918265, 5017.648764586444, 5145.92281115776, 5287.391949925731, 20873.79126208749, 22915.08339666428, 22919.88540057289, 22934.42663933415, 22943.655845162335, 21708.78291217099, 21844.0, 21928.561428771336, 22006.779932200472, 22227.0, 10715.142788576895, 11066.723331916766, 11144.442777861075, 11156.442177891073, 11167.888321116847, 8396.832063358577, 8461.534615595954, 8501.489910605384, 8556.57217139153, 8654.350923680624, 18121.0, 18860.0, 19103.0, 19231.711524326867, 19305.0, 18947.621047579247, 19517.316893908646, 19704.605907882047, 19824.306149284705, 19915.800841991393, 11171.441427928734, 11297.096232301561, 11394.316341019565, 11397.658070257905, 11443.942780286045, 13969.161850289016, 14055.859441405455, 14101.224432656303, 14162.575122746333, 14203.076800008379, 11347.319160850046, 11696.35670038156, 11708.765824683289, 11788.823167652321, 11811.763764724828, 11134.33194008362, 11226.438678066228, 11362.659120226406, 11432.657020289405, 11605.361705106301, 9579.808403831745, 9762.755931101496, 9762.80474390494, 9763.267754918268, 9766.07222313879, 6919.481038922, 6943.826404339932, 6948.6178260196175, 6949.583025018515, 7003.159620845531, 7277.563346199245, 7314.634268286671, 7326.523775954759, 7470.738524151846, 7516.699332026657], "value": 6736.781813703648, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.51222010829804, 530.1200007986743, 530.5861428086095, 534.5940177333613, 536.203737449887, 6287.622742635445, 6307.684615769211, 6313.337099604544, 6318.399752023556, 6356.555041147116, 6228.657423841687, 6260.2487701475775, 6289.088082228086, 6302.928502154633, 6303.873922521547, 5226.712530810794, 5244.265802787613, 5262.000219958215, 5262.973685131588, 5285.154375299952, 5176.007237213681, 5227.0, 5243.632945693784, 5268.104422248227, 5284.709340986245, 5021.548060674539, 5127.897442051157, 5193.272941788153, 5197.376314842224, 5208.609354298424, 5162.432132465426, 5175.635836706134, 5183.326167598207, 5238.1618940969265, 5251.579873610102, 4780.856574302777, 4822.397200349957, 4880.560749532559, 4887.608991280689, 4915.5821755150855, 6070.544709146788, 6103.267607887037, 6115.908261376083, 6134.662593557353, 6138.1074168798, 5944.167816505693, 6019.608725432833, 6021.729022193968, 6038.3659715729655, 6047.699744554898, 6530.346965303432, 6627.867442651168, 6653.60078395293, 6682.391508585358, 6715.634837355758, 5308.124159513675, 5348.8127915523155, 5357.249985002103, 5361.303030605996, 5362.034833729927, 6726.3609957054005, 6915.481338899603, 6917.0, 6928.72285108595, 6929.861402771916, 5377.166539186433, 5455.290812194389, 5478.972605137029, 5487.6981766002455, 5530.474604912527, 5499.285092937893, 5515.145152501369, 5560.497776000816, 5574.414686457944, 5615.550755939515, 5917.467427931507, 5924.911126333109, 5928.4960778334325, 5975.701214939236, 6011.5190784737115, 6608.636524991076, 6657.567258128206, 6659.0, 6680.198376194888, 6696.497762667722, 1914.8372388347148, 1931.3336898770183, 1938.8545859060628, 1944.0, 1953.7007889753438, 1377.9862201378057, 1417.9361928713233, 1419.5528408551274, 1432.5057855039995, 1437.3531910640254, 5676.602637815396, 5686.0, 5688.54491640676, 5697.971510142423, 5702.857428564319, 6627.536072474977, 6694.0, 6721.361470660279, 6750.662466876636, 6780.864382712318, 5608.495235428831, 5649.293838270216, 5707.600467967202, 5718.656880587178, 5760.769569217268, 3556.395412779834, 3569.268299998494, 3593.2813437312643, 3605.152789094561, 3606.441001644749, 6468.320826313169, 6487.6756162191705, 6540.084388185658, 6558.80323590293, 6577.80266592003, 6712.731490740413, 6744.291849355845, 6746.898796518056, 6813.829654258683, 6813.863722725617, 6341.207349081365, 6407.1808404301955, 6412.691431084899, 6448.807405482158, 6454.903176452451, 6579.243387010555, 6635.402813746786, 6638.601683898982, 6661.16735408074, 6736.191657001191, 6480.70836812354, 6559.442447392025, 6590.648916972105, 6625.668716564249, 6714.0, 6324.494040476843, 6350.809475715736, 6418.0693799397895, 6442.291347951628, 6603.316154380602, 5437.510624043855, 5481.725913704378, 5542.2795036644975, 5546.694931778791, 5553.278073850373, 6283.685815709287, 6498.707558159988, 6641.701123449359, 6744.032625644701, 6780.711664783676, 6263.8702841034265, 6373.553851230369, 6413.2945376007665, 6416.615003099829, 6547.181602299713, 6285.779997700059, 6401.263854656774, 6414.069959855888, 6479.287278399466, 6500.479961603155, 6298.370162983848, 6324.778632747832, 6409.935900640934, 6415.1981002374705, 6433.228012638513, 6448.645324507197, 6499.252585952676, 6559.245686746085, 6577.934220657732, 6600.722750651018, 6180.505559555315, 6236.282827474898, 6303.905441418474, 6314.4632706218645, 6363.96818015907], "value": 5185.626815011655, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [901.3960646366937, 905.8867641544807, 912.8448163812151, 916.0701887584099, 933.0, 19449.41651750448, 20193.394198174043, 20252.0, 20353.0, 20368.98155092245, 17584.296628134893, 17980.0, 17987.460376188734, 17989.0, 18074.72887906679, 961.8893827209873, 970.1801977329145, 971.2472833553982, 977.9804403911953, 979.0, 961.2646325560952, 965.4979410706428, 966.7583104223944, 967.1247520993477, 969.0, 995.1143482300758, 1017.6692574913146, 1033.1579762493543, 1039.132324509036, 1039.3763741754963, 1026.5637104230748, 1027.2552399510332, 1027.866377370937, 1028.028513055163, 1028.1260928210997, 728.4900569601248, 752.1613401057836, 753.4951582439778, 756.0247281007494, 756.7124492692742, 19123.52191195217, 19190.424287271406, 19263.0, 19293.421197364103, 19396.0, 21584.352469425943, 21647.025883835264, 22104.115835366567, 22152.778472215232, 22306.442338941495, 17116.400925967533, 17411.912940435344, 17423.912880435517, 17697.469075927744, 17859.196336164903, 3678.1172518595613, 3682.263547290526, 3695.722820788452, 3696.5564132304025, 3699.963000370016, 102536.0, 137527.0, 139227.30386348104, 142254.0, 144755.99999999895, 17354.219060142324, 17726.0, 17789.0, 17823.554411139565, 17831.821681783014, 30060.54909176364, 32799.344013119604, 32859.50710739341, 32881.67118328786, 32993.67006329954, 9190.31072669539, 9444.8583271251, 9484.288678349152, 9503.04969503058, 9535.094166054352, 4350.934735978963, 4457.531959144308, 4465.240909045405, 4466.240739074366, 4468.039371535136, 5356.116240820299, 5428.67427954324, 5481.205225242317, 5522.199281104217, 5539.695316757537, 1044.0, 1048.7063622185801, 1070.925035247525, 1071.1591400750374, 1072.265498133781, 652.2955208375039, 673.5419914458215, 675.5507587454387, 675.5541342713785, 689.1867596236389, 11724.0, 11925.88074119265, 12148.87851121495, 12295.69260768488, 12341.444634991447, 651.9511036672269, 652.7715299645181, 666.7299743603849, 668.9464842812563, 669.2103318084706, 5526.696031718294, 5533.391326954032, 5587.329520457572, 5661.830145095653, 5663.1505274208375, 126338.0, 127976.36011819882, 128027.0, 128642.35678821546, 129602.0, 114585.4270728641, 115010.0, 115573.0, 118038.0, 118102.0, 92807.53596231976, 93875.0, 94613.0, 97952.02047979571, 98446.5077674607, 10118.797624047626, 10492.580296788348, 10557.102646274845, 10685.626003089854, 10781.407022613517, 42547.787261063495, 43520.34719479274, 44100.0, 44127.558724412345, 44490.555094449934, 55540.44459555353, 55599.722001391354, 56011.719941400035, 56556.71721641366, 57148.0, 14000.929995349958, 14222.075565088237, 14227.0, 14420.711585768435, 14454.421823126957, 17931.910340448216, 18453.07734613237, 18494.81505184931, 18563.90718046401, 18796.624067518846, 15255.92372038177, 15373.923130384277, 15385.923070385024, 15420.0, 15518.689626207186, 16340.59148521249, 16700.331986720394, 16721.498355049367, 16738.246778894736, 16834.0, 15677.137757423452, 15721.68556628884, 15722.0, 15753.606159846095, 15977.760333595237, 11620.477078531318, 11788.174827762317, 11873.287602743863, 11955.880441195477, 12276.079294052803, 12324.568640097912, 12345.259284442962, 12546.1844980076, 12623.558175463815, 12842.422091006114], "value": 8993.709157294435, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1419.6000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 107.0, 107.0, 108.0, 107.0, 109.0, 106.0, 107.0, 107.0], "value": 107.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 114.0, 115.0, 148.0, 115.0, 116.0, 115.0, 145.0, 116.0, 140.0], "value": 124.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 163.0, 163.0, 163.0, 164.0, 164.0, 165.0, 164.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 75.0, 73.0, 75.0, 75.0, 76.0, 73.0, 74.0, 73.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 78.0, 85.0, 78.0, 79.0, 79.0, 134.0, 78.0, 79.0], "value": 85.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 113.0, 115.0, 114.0, 113.0, 114.0, 114.0, 115.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 148.0, 148.0, 150.0, 147.0, 195.0, 149.0, 149.0, 149.0], "value": 153.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 98.0, 99.0, 94.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 51.0, 52.0, 53.0, 52.0, 54.0, 51.0, 52.0, 51.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 37.0, 38.0, 37.0, 37.0], "value": 37.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 71.0, 72.0, 71.0, 72.0, 72.0, 74.0, 72.0, 78.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 116.0, 106.0, 110.0, 108.0, 110.0, 116.0, 113.0, 107.0], "value": 110.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 158.0, 158.0, 163.0, 163.0, 172.0, 163.0, 178.0, 166.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 63.0, 65.0, 62.0, 62.0, 66.0, 64.0, 64.0, 64.0, 64.0], "value": 64.4, "unit": "score"}]}]} 03:24:52 INFO - Return code: 0 03:24:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:24:52 INFO - # TBPL SUCCESS # 03:24:52 INFO - Running post-action listener: _package_coverage_data 03:24:52 INFO - Running post-action listener: _resource_record_post_action 03:24:52 INFO - [mozharness: 2017-10-02 10:24:52.530767Z] Finished run-tests step (success) 03:24:52 INFO - Running post-run listener: _resource_record_post_run 03:24:52 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 345247744; Read time: 12; Write time: 233248 03:24:52 INFO - TinderboxPrint: CPU usage
13.1% 03:24:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 03:24:52 INFO - TinderboxPrint: I/O write bytes / time
345,247,744 / 233,248 03:24:52 INFO - TinderboxPrint: CPU idle
8,221.2 (86.9%) 03:24:52 INFO - TinderboxPrint: CPU user
1,194.2 (12.6%) 03:24:52 INFO - TinderboxPrint: Swap in / out
0 / 0 03:24:52 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13340672; Read time: 0; Write time: 1488 03:24:52 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:24:52 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 331907072; Read time: 0; Write time: 231760 03:24:53 INFO - Running post-run listener: _upload_blobber_files 03:24:53 INFO - Blob upload gear active. 03:24:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:24:53 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 03:24:53 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:24:53 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:24:53 INFO - (blobuploader) - INFO - Open directory for files ... 03:24:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 03:24:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:24:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:24:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 03:24:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:24:54 INFO - (blobuploader) - INFO - Done attempting. 03:24:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:24:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:24:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:25:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:25:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:25:01 INFO - (blobuploader) - INFO - Done attempting. 03:25:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 03:25:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:25:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:25:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 03:25:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:25:02 INFO - (blobuploader) - INFO - Done attempting. 03:25:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:25:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:25:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:25:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:25:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:25:03 INFO - (blobuploader) - INFO - Done attempting. 03:25:03 INFO - (blobuploader) - INFO - Iteration through files over. 03:25:03 INFO - Return code: 0 03:25:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:25:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:25:03 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c6bde74b51245a3a87c623d692b873b845cfea2d22ea4c72f0ae18f7a65d4a597ae6008382a58e2ce9a0c8b6511850920bc8171c4949aca877de555b78b066c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e52fe15ec2228187e277f55666347677e35ad96910207e3b89ccdb60ab182c42b4526413cd99357977d7c00cfdd6c3bb64dd41385f8f7832bfe21abe54a05c5b", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c49261db5a329ad58b718d8e266c593c7cf1eb0b043f4da5b5a66db1b9f8a9bb89aede907920a0ec39911875797af8e2c79b5c7d8a47df600080eace2901521e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51e1f74ebeeb036da18a7021c6ec5343c5906697bded64fb7669290beb2b423aeeb8b2b3de27e66fafad11ef2eb634bda8976eb1905cd6c036318d7532f2ab7b"} 03:25:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:25:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:25:03 INFO - Contents: 03:25:03 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c6bde74b51245a3a87c623d692b873b845cfea2d22ea4c72f0ae18f7a65d4a597ae6008382a58e2ce9a0c8b6511850920bc8171c4949aca877de555b78b066c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e52fe15ec2228187e277f55666347677e35ad96910207e3b89ccdb60ab182c42b4526413cd99357977d7c00cfdd6c3bb64dd41385f8f7832bfe21abe54a05c5b", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c49261db5a329ad58b718d8e266c593c7cf1eb0b043f4da5b5a66db1b9f8a9bb89aede907920a0ec39911875797af8e2c79b5c7d8a47df600080eace2901521e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51e1f74ebeeb036da18a7021c6ec5343c5906697bded64fb7669290beb2b423aeeb8b2b3de27e66fafad11ef2eb634bda8976eb1905cd6c036318d7532f2ab7b"} 03:25:03 INFO - Running post-run listener: copy_logs_to_upload_dir 03:25:03 INFO - Copying logs to upload dir... 03:25:03 INFO - mkdir: /builds/slave/test/build/upload/logs 03:25:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.343267 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-10-02 03:25:04.028076) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 03:25:04.035260) ========= 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=32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c6bde74b51245a3a87c623d692b873b845cfea2d22ea4c72f0ae18f7a65d4a597ae6008382a58e2ce9a0c8b6511850920bc8171c4949aca877de555b78b066c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e52fe15ec2228187e277f55666347677e35ad96910207e3b89ccdb60ab182c42b4526413cd99357977d7c00cfdd6c3bb64dd41385f8f7832bfe21abe54a05c5b", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c49261db5a329ad58b718d8e266c593c7cf1eb0b043f4da5b5a66db1b9f8a9bb89aede907920a0ec39911875797af8e2c79b5c7d8a47df600080eace2901521e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51e1f74ebeeb036da18a7021c6ec5343c5906697bded64fb7669290beb2b423aeeb8b2b3de27e66fafad11ef2eb634bda8976eb1905cd6c036318d7532f2ab7b"} build_url:https://queue.taskcluster.net/v1/task/SpgnkNMfTjmvykF5w7h-dQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011377 build_url: 'https://queue.taskcluster.net/v1/task/SpgnkNMfTjmvykF5w7h-dQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c6bde74b51245a3a87c623d692b873b845cfea2d22ea4c72f0ae18f7a65d4a597ae6008382a58e2ce9a0c8b6511850920bc8171c4949aca877de555b78b066c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e52fe15ec2228187e277f55666347677e35ad96910207e3b89ccdb60ab182c42b4526413cd99357977d7c00cfdd6c3bb64dd41385f8f7832bfe21abe54a05c5b", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c49261db5a329ad58b718d8e266c593c7cf1eb0b043f4da5b5a66db1b9f8a9bb89aede907920a0ec39911875797af8e2c79b5c7d8a47df600080eace2901521e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51e1f74ebeeb036da18a7021c6ec5343c5906697bded64fb7669290beb2b423aeeb8b2b3de27e66fafad11ef2eb634bda8976eb1905cd6c036318d7532f2ab7b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 03:25:04.064054) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 03:25:04.064419) ========= 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=32c5991c409366f7fec8a718000001d2-1506938518.263299-1546301828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 03:25:04.148795) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 03:25:04.149115) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 03:25:04.149420) ========= ========= Total master_lag: 0.23 =========