builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0166 starttime: 1466249658.41 results: success (0) buildid: 20160618031522 builduid: 162c044dae014cdb9ee9341d299a9c63 revision: cec857b11eaf51d6c04368f65fef17e017a0f96c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 04:34:18.409614) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 04:34:18.410118) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 04:34:18.410405) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 04:34:18.892546) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 04:34:18.892823) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NS793G2zXI/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.n6y7JiL8b4/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-06-18 04:34:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 163M=0s 2016-06-18 04:34:19 (163 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136837 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 04:34:19.100404) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 04:34:19.103749) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NS793G2zXI/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.n6y7JiL8b4/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.027483 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 04:34:19.156923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-18 04:34:19.157403) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cec857b11eaf51d6c04368f65fef17e017a0f96c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cec857b11eaf51d6c04368f65fef17e017a0f96c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NS793G2zXI/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.n6y7JiL8b4/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-06-18 04:34:19,232 truncating revision to first 12 chars 2016-06-18 04:34:19,232 Setting DEBUG logging. 2016-06-18 04:34:19,232 attempt 1/10 2016-06-18 04:34:19,232 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/cec857b11eaf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-18 04:34:19,947 unpacking tar archive at: mozilla-beta-cec857b11eaf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.970452 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-18 04:34:20.166330) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 04:34:20.166631) ========= script_repo_revision: cec857b11eaf51d6c04368f65fef17e017a0f96c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 04:34:20.167159) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 04:34:20.167503) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 04:34:20.289409) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-06-18 04:34:20.289778) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NS793G2zXI/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.n6y7JiL8b4/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:34:20 INFO - MultiFileLogger online at 20160618 04:34:20 in /builds/slave/test 04:34:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:34:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:34:20 INFO - {'append_to_log': False, 04:34:20 INFO - 'base_work_dir': '/builds/slave/test', 04:34:20 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:34:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:34:20 INFO - 'branch': 'Mozilla-Beta', 04:34:20 INFO - 'buildbot_json_path': 'buildprops.json', 04:34:20 INFO - 'config_files': ('talos/mac_config.py',), 04:34:20 INFO - 'default_actions': ('clobber', 04:34:20 INFO - 'read-buildbot-config', 04:34:20 INFO - 'download-and-extract', 04:34:20 INFO - 'populate-webroot', 04:34:20 INFO - 'create-virtualenv', 04:34:20 INFO - 'install', 04:34:20 INFO - 'run-tests'), 04:34:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:34:20 INFO - 'download_minidump_stackwalk': True, 04:34:20 INFO - 'download_symbols': 'ondemand', 04:34:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:34:20 INFO - 'tooltool.py': '/tools/tooltool.py', 04:34:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:34:20 INFO - '/tools/misc-python/virtualenv.py')}, 04:34:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:34:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:34:20 INFO - 'installer_path': 'installer.exe', 04:34:20 INFO - 'log_level': 'info', 04:34:20 INFO - 'log_name': 'talos', 04:34:20 INFO - 'log_to_console': True, 04:34:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:34:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:34:20 INFO - 'opt_config_files': (), 04:34:20 INFO - 'pip_index': False, 04:34:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:34:20 INFO - 'cmd': ('bash', 04:34:20 INFO - '-c', 04:34:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:34:20 INFO - 'enabled': True, 04:34:20 INFO - 'halt_on_failure': False, 04:34:20 INFO - 'name': 'check_screen_resolution'},), 04:34:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:34:20 INFO - 'cmd': ('bash', 04:34:20 INFO - '-c', 04:34:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:34:20 INFO - 'enabled': True, 04:34:20 INFO - 'halt_on_failure': False, 04:34:20 INFO - 'name': 'check_screen_resolution'},), 04:34:20 INFO - 'run_cmd_checks_enabled': True, 04:34:20 INFO - 'sps_profile': False, 04:34:20 INFO - 'sps_profile_interval': 0, 04:34:20 INFO - 'suite': 'dromaeojs', 04:34:20 INFO - 'system_bits': '32', 04:34:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:34:20 INFO - 'title': 't-yosemite-r7-0166', 04:34:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:34:20 INFO - 'use_talos_json': True, 04:34:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:34:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:34:20 INFO - 'work_dir': 'build'} 04:34:20 INFO - ##### 04:34:20 INFO - ##### Running clobber step. 04:34:20 INFO - ##### 04:34:20 INFO - Running pre-action listener: _resource_record_pre_action 04:34:20 INFO - Running main action method: clobber 04:34:20 INFO - rmtree: /builds/slave/test/build 04:34:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:34:22 INFO - Running post-action listener: _resource_record_post_action 04:34:22 INFO - ##### 04:34:22 INFO - ##### Running read-buildbot-config step. 04:34:22 INFO - ##### 04:34:22 INFO - Running pre-action listener: _resource_record_pre_action 04:34:22 INFO - Running main action method: read_buildbot_config 04:34:22 INFO - Using buildbot properties: 04:34:22 INFO - { 04:34:22 INFO - "project": "", 04:34:22 INFO - "product": "firefox", 04:34:22 INFO - "script_repo_revision": "production", 04:34:22 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 04:34:22 INFO - "repository": "", 04:34:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 04:34:22 INFO - "buildid": "20160618031522", 04:34:22 INFO - "pgo_build": "False", 04:34:22 INFO - "basedir": "/builds/slave/test", 04:34:22 INFO - "buildnumber": 2, 04:34:22 INFO - "slavename": "t-yosemite-r7-0166", 04:34:22 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 04:34:22 INFO - "platform": "yosemite_r7", 04:34:22 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:34:22 INFO - "branch": "mozilla-beta", 04:34:22 INFO - "repo_path": "releases/mozilla-beta", 04:34:22 INFO - "revision": "cec857b11eaf51d6c04368f65fef17e017a0f96c", 04:34:22 INFO - "stage_platform": "macosx64", 04:34:22 INFO - "builduid": "162c044dae014cdb9ee9341d299a9c63", 04:34:22 INFO - "slavebuilddir": "test" 04:34:22 INFO - } 04:34:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 04:34:22 INFO - Running post-action listener: _resource_record_post_action 04:34:22 INFO - ##### 04:34:22 INFO - ##### Running download-and-extract step. 04:34:22 INFO - ##### 04:34:22 INFO - Running pre-action listener: _resource_record_pre_action 04:34:22 INFO - Running main action method: download_and_extract 04:34:22 INFO - mkdir: /builds/slave/test/build/tests 04:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:22 INFO - https://queue.taskcluster.net/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:34:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 04:34:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 04:34:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 04:34:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 04:34:30 INFO - Downloaded 1165 bytes. 04:34:30 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 04:34:30 INFO - Using the following test package requirements: 04:34:30 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 04:34:30 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:34:30 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 04:34:30 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:34:30 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 04:34:30 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:34:30 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:34:30 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 04:34:30 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 04:34:30 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:34:30 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 04:34:30 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:34:30 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 04:34:30 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:34:30 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 04:34:30 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:34:30 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 04:34:30 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 04:34:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:30 INFO - https://queue.taskcluster.net/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:34:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:34:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:34:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 04:34:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 04:34:31 INFO - Downloaded 18300353 bytes. 04:34:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:34:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:34:34 INFO - Return code: 0 04:34:34 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 04:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:34 INFO - https://queue.taskcluster.net/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:34:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:34:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:34:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 04:34:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 04:34:36 INFO - Downloaded 18300353 bytes. 04:34:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:34:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:34:39 INFO - Return code: 0 04:34:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:39 INFO - https://queue.taskcluster.net/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:34:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 04:34:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 04:34:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 04:34:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 04:34:40 INFO - Downloaded 10840145 bytes. 04:34:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:34:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:34:41 INFO - Return code: 0 04:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:41 INFO - https://queue.taskcluster.net/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 04:34:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:34:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:34:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 04:34:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 04:34:45 INFO - Downloaded 86249143 bytes. 04:34:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:34:45 INFO - mkdir: /builds/slave/test/properties 04:34:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:34:45 INFO - Writing to file /builds/slave/test/properties/build_url 04:34:45 INFO - Contents: 04:34:45 INFO - build_url:https://queue.taskcluster.net/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:34:46 INFO - Running post-action listener: _resource_record_post_action 04:34:46 INFO - Running post-action listener: set_extra_try_arguments 04:34:46 INFO - ##### 04:34:46 INFO - ##### Running populate-webroot step. 04:34:46 INFO - ##### 04:34:46 INFO - Running pre-action listener: _resource_record_pre_action 04:34:46 INFO - Running main action method: populate_webroot 04:34:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:34:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:34:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:34:46 INFO - '--tppagecycles', 04:34:46 INFO - '7'], 04:34:46 INFO - 'tests': ['tsvgm']}}, 04:34:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:34:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:34:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:34:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:34:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:34:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:34:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:46 INFO - 'talos_options': ['--disable-e10s'], 04:34:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:34:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:34:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:46 INFO - 'talos_options': ['--disable-e10s'], 04:34:46 INFO - 'tests': ['damp', 'tps']}, 04:34:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:46 INFO - 'tests': ['damp', 'tps']}, 04:34:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:34:46 INFO - 'tests': ['dromaeo_dom']}, 04:34:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:34:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:34:46 INFO - 'tests': ['a11yr', 04:34:46 INFO - 'ts_paint', 04:34:46 INFO - 'tpaint', 04:34:46 INFO - 'sessionrestore', 04:34:46 INFO - 'sessionrestore_no_auto_restore', 04:34:46 INFO - 'tabpaint']}, 04:34:46 INFO - 'other-e10s': {'tests': ['a11yr', 04:34:46 INFO - 'ts_paint', 04:34:46 INFO - 'tpaint', 04:34:46 INFO - 'sessionrestore', 04:34:46 INFO - 'sessionrestore_no_auto_restore', 04:34:46 INFO - 'tabpaint']}, 04:34:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:34:46 INFO - 'ts_paint', 04:34:46 INFO - 'tpaint', 04:34:46 INFO - 'sessionrestore', 04:34:46 INFO - 'sessionrestore_no_auto_restore', 04:34:46 INFO - 'tabpaint']}, 04:34:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:34:46 INFO - 'ts_paint', 04:34:46 INFO - 'tpaint', 04:34:46 INFO - 'sessionrestore', 04:34:46 INFO - 'sessionrestore_no_auto_restore', 04:34:46 INFO - 'tabpaint']}, 04:34:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:34:46 INFO - 'tests': ['a11yr', 04:34:46 INFO - 'ts_paint', 04:34:46 INFO - 'tpaint', 04:34:46 INFO - 'sessionrestore', 04:34:46 INFO - 'sessionrestore_no_auto_restore', 04:34:46 INFO - 'tabpaint']}, 04:34:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:34:46 INFO - 'tests': ['a11yr', 04:34:46 INFO - 'ts_paint', 04:34:46 INFO - 'tpaint', 04:34:46 INFO - 'sessionrestore', 04:34:46 INFO - 'sessionrestore_no_auto_restore', 04:34:46 INFO - 'tabpaint']}, 04:34:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:34:46 INFO - 'tests': ['tsvgx', 04:34:46 INFO - 'tsvgr_opacity', 04:34:46 INFO - 'tart', 04:34:46 INFO - 'tscrollx', 04:34:46 INFO - 'cart']}, 04:34:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:34:46 INFO - 'tsvgr_opacity', 04:34:46 INFO - 'tart', 04:34:46 INFO - 'tscrollx', 04:34:46 INFO - 'cart']}, 04:34:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:46 INFO - 'talos_options': ['--disable-e10s'], 04:34:46 INFO - 'tests': ['tp5o']}, 04:34:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:46 INFO - 'tests': ['tp5o']}, 04:34:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:46 INFO - 'talos_options': ['--disable-e10s', 04:34:46 INFO - '--xperf_path', 04:34:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:34:46 INFO - 'tests': ['tp5n']}, 04:34:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:46 INFO - 'talos_options': ['--xperf_path', 04:34:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:34:46 INFO - 'tests': ['tp5n']}}, 04:34:46 INFO - 'talos.zip': {'path': '', 04:34:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:34:46 INFO - Running post-action listener: _resource_record_post_action 04:34:46 INFO - ##### 04:34:46 INFO - ##### Running create-virtualenv step. 04:34:46 INFO - ##### 04:34:46 INFO - Running pre-action listener: _resource_record_pre_action 04:34:46 INFO - Running main action method: create_virtualenv 04:34:46 INFO - Creating virtualenv /builds/slave/test/build/venv 04:34:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:34:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:34:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:34:46 INFO - Using real prefix '/tools/python27' 04:34:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:34:47 INFO - Installing distribute.............................................................................................................................................................................................done. 04:34:49 INFO - Installing pip.................done. 04:34:49 INFO - Return code: 0 04:34:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:49 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x101619a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101629420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9952ca0150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014b8e00>, '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 0x101321db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014b3b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NS793G2zXI/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6y7JiL8b4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:34:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:34:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NS793G2zXI/Render', 04:34:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:49 INFO - 'HOME': '/Users/cltbld', 04:34:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:49 INFO - 'LOGNAME': 'cltbld', 04:34:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:49 INFO - 'MOZ_NO_REMOTE': '1', 04:34:49 INFO - 'NO_EM_RESTART': '1', 04:34:49 INFO - 'PAGER': '/bin/cat', 04:34:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:49 INFO - 'PWD': '/builds/slave/test', 04:34:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:49 INFO - 'SHELL': '/bin/bash', 04:34:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6y7JiL8b4/Listeners', 04:34:49 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 04:34:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:49 INFO - 'USER': 'cltbld', 04:34:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:49 INFO - 'XPC_FLAGS': '0x0', 04:34:49 INFO - 'XPC_SERVICE_NAME': '0', 04:34:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:34:50 INFO - Cleaning up... 04:34:50 INFO - Return code: 0 04:34:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101619a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101629420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9952ca0150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014b8e00>, '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 0x101321db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014b3b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NS793G2zXI/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6y7JiL8b4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:34:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:34:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:34:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NS793G2zXI/Render', 04:34:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:50 INFO - 'HOME': '/Users/cltbld', 04:34:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:50 INFO - 'LOGNAME': 'cltbld', 04:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:50 INFO - 'MOZ_NO_REMOTE': '1', 04:34:50 INFO - 'NO_EM_RESTART': '1', 04:34:50 INFO - 'PAGER': '/bin/cat', 04:34:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:50 INFO - 'PWD': '/builds/slave/test', 04:34:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:50 INFO - 'SHELL': '/bin/bash', 04:34:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6y7JiL8b4/Listeners', 04:34:50 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 04:34:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:50 INFO - 'USER': 'cltbld', 04:34:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:50 INFO - 'XPC_FLAGS': '0x0', 04:34:50 INFO - 'XPC_SERVICE_NAME': '0', 04:34:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:50 INFO - Downloading/unpacking psutil>=0.7.1 04:34: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 04:34: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 04:34:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34: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 04:34: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 04:34:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:34:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:34:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:34:53 INFO - Installing collected packages: psutil 04:34:53 INFO - Running setup.py install for psutil 04:34:53 INFO - building 'psutil._psutil_osx' extension 04:34:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:34:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:34:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:34:54 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:34:54 INFO - building 'psutil._psutil_posix' extension 04:34:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:34:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:34:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:34:54 INFO - ^ 04:34:54 INFO - 1 warning generated. 04:34:54 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:34:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:34:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:34:54 INFO - Successfully installed psutil 04:34:54 INFO - Cleaning up... 04:34:55 INFO - Return code: 0 04:34:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:55 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101619a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101629420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9952ca0150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014b8e00>, '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 0x101321db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014b3b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NS793G2zXI/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6y7JiL8b4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:34:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:34:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:34:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NS793G2zXI/Render', 04:34:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:55 INFO - 'HOME': '/Users/cltbld', 04:34:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:55 INFO - 'LOGNAME': 'cltbld', 04:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:55 INFO - 'MOZ_NO_REMOTE': '1', 04:34:55 INFO - 'NO_EM_RESTART': '1', 04:34:55 INFO - 'PAGER': '/bin/cat', 04:34:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:55 INFO - 'PWD': '/builds/slave/test', 04:34:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:55 INFO - 'SHELL': '/bin/bash', 04:34:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6y7JiL8b4/Listeners', 04:34:55 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 04:34:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:55 INFO - 'USER': 'cltbld', 04:34:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:55 INFO - 'XPC_FLAGS': '0x0', 04:34:55 INFO - 'XPC_SERVICE_NAME': '0', 04:34:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:34: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 04:34: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 04:34:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34: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 04:34: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 04:34:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:34:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:34:57 INFO - Installing collected packages: mozsystemmonitor 04:34:57 INFO - Running setup.py install for mozsystemmonitor 04:34:57 INFO - Successfully installed mozsystemmonitor 04:34:57 INFO - Cleaning up... 04:34:58 INFO - Return code: 0 04:34:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x101619a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101629420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9952ca0150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014b8e00>, '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 0x101321db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014b3b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NS793G2zXI/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6y7JiL8b4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:34:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:34:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NS793G2zXI/Render', 04:34:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:58 INFO - 'HOME': '/Users/cltbld', 04:34:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:58 INFO - 'LOGNAME': 'cltbld', 04:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:58 INFO - 'MOZ_NO_REMOTE': '1', 04:34:58 INFO - 'NO_EM_RESTART': '1', 04:34:58 INFO - 'PAGER': '/bin/cat', 04:34:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:58 INFO - 'PWD': '/builds/slave/test', 04:34:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:58 INFO - 'SHELL': '/bin/bash', 04:34:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6y7JiL8b4/Listeners', 04:34:58 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 04:34:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:58 INFO - 'USER': 'cltbld', 04:34:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:58 INFO - 'XPC_FLAGS': '0x0', 04:34:58 INFO - 'XPC_SERVICE_NAME': '0', 04:34:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:58 INFO - Downloading/unpacking blobuploader==1.2.4 04:34:58 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 04:34:58 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 04:34:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:58 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 04:34:58 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 04:35:00 INFO - Downloading blobuploader-1.2.4.tar.gz 04:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:35:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:35: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 04:35: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 04:35:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35: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 04:35: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 04:35:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:35:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:35:01 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 04:35:01 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 04:35:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:01 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 04:35:01 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 04:35:01 INFO - Downloading docopt-0.6.1.tar.gz 04:35:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:35:01 INFO - Installing collected packages: blobuploader, requests, docopt 04:35:01 INFO - Running setup.py install for blobuploader 04:35:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:35:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:35:02 INFO - Running setup.py install for requests 04:35:02 INFO - Running setup.py install for docopt 04:35:02 INFO - Successfully installed blobuploader requests docopt 04:35:02 INFO - Cleaning up... 04:35:02 INFO - Return code: 0 04:35:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:02 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x101619a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101629420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9952ca0150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014b8e00>, '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 0x101321db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014b3b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NS793G2zXI/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6y7JiL8b4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:35:02 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:35:02 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:35:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NS793G2zXI/Render', 04:35:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:02 INFO - 'HOME': '/Users/cltbld', 04:35:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:02 INFO - 'LOGNAME': 'cltbld', 04:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:02 INFO - 'MOZ_NO_REMOTE': '1', 04:35:02 INFO - 'NO_EM_RESTART': '1', 04:35:02 INFO - 'PAGER': '/bin/cat', 04:35:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:02 INFO - 'PWD': '/builds/slave/test', 04:35:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:02 INFO - 'SHELL': '/bin/bash', 04:35:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6y7JiL8b4/Listeners', 04:35:02 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 04:35:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:02 INFO - 'USER': 'cltbld', 04:35:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:02 INFO - 'XPC_FLAGS': '0x0', 04:35:02 INFO - 'XPC_SERVICE_NAME': '0', 04:35:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:35:03 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-MFOFqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:35:03 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-ezDbVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:35:03 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-9YK5a8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:35:03 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-J_mdPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:35:03 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-NPzJIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:35:03 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-0BPsLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:35:03 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-JJWn7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:35:03 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-0NwqG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:35:03 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-VFu0xt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:35:04 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-ggMRqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:35:04 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-m3hIem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:35:04 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-6YltqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:35:04 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-o76NLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:35:04 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-Dt8L3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:04 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-aX9CBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:35:04 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-qMb5Lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:35:04 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-Sp4cxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:35:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:35:04 INFO - Running setup.py install for manifestparser 04:35:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:35:04 INFO - Running setup.py install for mozcrash 04:35:05 INFO - Running setup.py install for mozdebug 04:35:05 INFO - Running setup.py install for mozdevice 04:35:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:35:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:35:05 INFO - Running setup.py install for mozfile 04:35:05 INFO - Running setup.py install for mozhttpd 04:35:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:35:05 INFO - Running setup.py install for mozinfo 04:35:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:35:05 INFO - Running setup.py install for mozInstall 04:35:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:35:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:35:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:35:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:35:05 INFO - Running setup.py install for mozleak 04:35:06 INFO - Running setup.py install for mozlog 04:35:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:35:06 INFO - Running setup.py install for moznetwork 04:35:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:35:06 INFO - Running setup.py install for mozprocess 04:35:06 INFO - Running setup.py install for mozprofile 04:35:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:35:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:35:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:35:06 INFO - Running setup.py install for mozrunner 04:35:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:35:06 INFO - Running setup.py install for mozscreenshot 04:35:07 INFO - Running setup.py install for moztest 04:35:07 INFO - Running setup.py install for mozversion 04:35:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:35:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:35:07 INFO - Cleaning up... 04:35:07 INFO - Return code: 0 04:35:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:07 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x101619a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101629420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9952ca0150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014b8e00>, '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 0x101321db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014b3b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NS793G2zXI/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6y7JiL8b4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:35:07 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:35:07 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:35:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NS793G2zXI/Render', 04:35:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:07 INFO - 'HOME': '/Users/cltbld', 04:35:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:07 INFO - 'LOGNAME': 'cltbld', 04:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:07 INFO - 'MOZ_NO_REMOTE': '1', 04:35:07 INFO - 'NO_EM_RESTART': '1', 04:35:07 INFO - 'PAGER': '/bin/cat', 04:35:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:07 INFO - 'PWD': '/builds/slave/test', 04:35:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:07 INFO - 'SHELL': '/bin/bash', 04:35:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6y7JiL8b4/Listeners', 04:35:07 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 04:35:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:07 INFO - 'USER': 'cltbld', 04:35:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:07 INFO - 'XPC_FLAGS': '0x0', 04:35:07 INFO - 'XPC_SERVICE_NAME': '0', 04:35:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:35:07 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-Rl4pOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:35:07 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)) 04:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:35:07 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-9fw58z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:35:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 04:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:35:07 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-RhdDKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:35:07 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)) 04:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:35:07 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-TGgtOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 04:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:35:08 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-pN4ct7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:35:08 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)) 04:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:35:08 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-mbtl69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:35:08 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)) 04:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:35:08 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-SVt3y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 04:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:35:08 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-fwpWw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 04:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:35:08 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-_MES1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:35:08 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)) 04:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:35:08 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-oryLVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 04:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:35:08 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-w39p4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:35:08 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)) 04:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:35:08 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-k48xtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 04:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:35:08 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-Xp9bfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:35:09 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)) 04:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:35:09 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-BjsBC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 04:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:09 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-__t2Jz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:09 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)) 04:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:35:09 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-hhh7QR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 04:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:35:09 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-343nGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:35:09 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)) 04:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:35:09 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)) 04:35:09 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:35:09 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:35:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:35:09 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 04:35:09 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 04:35:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:09 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 04:35:09 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 04:35:11 INFO - Downloading blessings-1.6.tar.gz 04:35:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:35:11 INFO - Installing collected packages: blessings 04:35:11 INFO - Running setup.py install for blessings 04:35:12 INFO - Successfully installed blessings 04:35:12 INFO - Cleaning up... 04:35:12 INFO - Return code: 0 04:35:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:35:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:35:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:35:12 INFO - Reading from file tmpfile_stdout 04:35:12 INFO - Current package versions: 04:35:12 INFO - blessings == 1.6 04:35:12 INFO - blobuploader == 1.2.4 04:35:12 INFO - docopt == 0.6.1 04:35:12 INFO - manifestparser == 1.1 04:35:12 INFO - mozInstall == 1.12 04:35:12 INFO - mozcrash == 0.17 04:35:12 INFO - mozdebug == 0.1 04:35:12 INFO - mozdevice == 0.48 04:35:12 INFO - mozfile == 1.2 04:35:12 INFO - mozhttpd == 0.7 04:35:12 INFO - mozinfo == 0.9 04:35:12 INFO - mozleak == 0.1 04:35:12 INFO - mozlog == 3.1 04:35:12 INFO - moznetwork == 0.27 04:35:12 INFO - mozprocess == 0.22 04:35:12 INFO - mozprofile == 0.28 04:35:12 INFO - mozrunner == 6.11 04:35:12 INFO - mozscreenshot == 0.1 04:35:12 INFO - mozsystemmonitor == 0.0 04:35:12 INFO - moztest == 0.7 04:35:12 INFO - mozversion == 1.4 04:35:12 INFO - psutil == 3.1.1 04:35:12 INFO - requests == 1.2.3 04:35:12 INFO - wsgiref == 0.1.2 04:35:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:35:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:12 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x101619a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101629420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9952ca0150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014b8e00>, '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 0x101321db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014b3b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NS793G2zXI/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6y7JiL8b4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:35:12 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:35:12 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:35:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NS793G2zXI/Render', 04:35:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:12 INFO - 'HOME': '/Users/cltbld', 04:35:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:12 INFO - 'LOGNAME': 'cltbld', 04:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:12 INFO - 'MOZ_NO_REMOTE': '1', 04:35:12 INFO - 'NO_EM_RESTART': '1', 04:35:12 INFO - 'PAGER': '/bin/cat', 04:35:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:12 INFO - 'PWD': '/builds/slave/test', 04:35:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:12 INFO - 'SHELL': '/bin/bash', 04:35:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6y7JiL8b4/Listeners', 04:35:12 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 04:35:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:12 INFO - 'USER': 'cltbld', 04:35:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:12 INFO - 'XPC_FLAGS': '0x0', 04:35:12 INFO - 'XPC_SERVICE_NAME': '0', 04:35:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:12 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)) 04:35:12 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)) 04:35:12 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)) 04:35:12 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)) 04:35:12 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)) 04:35:12 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)) 04:35:12 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)) 04:35:12 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)) 04:35:12 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)) 04:35:12 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)) 04:35:12 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)) 04:35:12 INFO - Cleaning up... 04:35:12 INFO - Return code: 0 04:35:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:35:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:12 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x101619a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101629420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9952ca0150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014b8e00>, '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 0x101321db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014b3b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NS793G2zXI/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6y7JiL8b4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:35:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:35:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:35:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NS793G2zXI/Render', 04:35:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:12 INFO - 'HOME': '/Users/cltbld', 04:35:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:12 INFO - 'LOGNAME': 'cltbld', 04:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:12 INFO - 'MOZ_NO_REMOTE': '1', 04:35:12 INFO - 'NO_EM_RESTART': '1', 04:35:12 INFO - 'PAGER': '/bin/cat', 04:35:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:12 INFO - 'PWD': '/builds/slave/test', 04:35:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:12 INFO - 'SHELL': '/bin/bash', 04:35:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6y7JiL8b4/Listeners', 04:35:12 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 04:35:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:12 INFO - 'USER': 'cltbld', 04:35:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:12 INFO - 'XPC_FLAGS': '0x0', 04:35:12 INFO - 'XPC_SERVICE_NAME': '0', 04:35:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:13 INFO - Downloading/unpacking jsonschema 04:35:13 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 04:35:13 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 04:35:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:13 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 04:35:13 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 04:35:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:35:15 INFO - Downloading/unpacking functools32 (from jsonschema) 04:35:15 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 04:35:15 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 04:35:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:15 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 04:35:15 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 04:35:15 INFO - Downloading functools32-3.2.3-2.tar.gz 04:35:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:35:16 INFO - warning: no files found matching '*.txt' 04:35:16 INFO - no previously-included directories found matching 'build' 04:35:16 INFO - no previously-included directories found matching 'dist' 04:35:16 INFO - no previously-included directories found matching '.git*' 04:35:16 INFO - Installing collected packages: jsonschema, functools32 04:35:16 INFO - Running setup.py install for functools32 04:35:16 INFO - warning: no files found matching '*.txt' 04:35:16 INFO - no previously-included directories found matching 'build' 04:35:16 INFO - no previously-included directories found matching 'dist' 04:35:16 INFO - no previously-included directories found matching '.git*' 04:35:16 INFO - Successfully installed jsonschema functools32 04:35:16 INFO - Cleaning up... 04:35:16 INFO - Return code: 0 04:35:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101619a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101629420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9952ca0150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014b8e00>, '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 0x101321db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014b3b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NS793G2zXI/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6y7JiL8b4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:35:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:35:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NS793G2zXI/Render', 04:35:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:16 INFO - 'HOME': '/Users/cltbld', 04:35:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:16 INFO - 'LOGNAME': 'cltbld', 04:35:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:16 INFO - 'MOZ_NO_REMOTE': '1', 04:35:16 INFO - 'NO_EM_RESTART': '1', 04:35:16 INFO - 'PAGER': '/bin/cat', 04:35:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:16 INFO - 'PWD': '/builds/slave/test', 04:35:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:16 INFO - 'SHELL': '/bin/bash', 04:35:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6y7JiL8b4/Listeners', 04:35:16 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 04:35:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:16 INFO - 'USER': 'cltbld', 04:35:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:16 INFO - 'XPC_FLAGS': '0x0', 04:35:16 INFO - 'XPC_SERVICE_NAME': '0', 04:35:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:16 INFO - Downloading/unpacking flake8 04:35:16 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 04:35:16 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 04:35:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:16 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 04:35:16 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 04:35:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:35:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:35:19 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 04:35:19 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 04:35:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:19 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 04:35:19 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 04:35:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:35:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:35:19 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 04:35:19 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 04:35:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:19 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 04:35:19 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 04:35:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:35:19 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 04:35:19 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 04:35:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:19 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 04:35:19 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 04:35:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:35:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:35:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:35:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:35:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:35:20 INFO - no previously-included directories found matching 'docs/_build' 04:35:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:35:20 INFO - Running setup.py install for pep8 04:35:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:35:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:35:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:35:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:35:20 INFO - no previously-included directories found matching 'docs/_build' 04:35:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:35:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:35:20 INFO - Cleaning up... 04:35:20 INFO - Return code: 0 04:35:20 INFO - Running post-action listener: _resource_record_post_action 04:35:20 INFO - Running post-action listener: _start_resource_monitoring 04:35:20 INFO - Starting resource monitoring. 04:35:20 INFO - ##### 04:35:20 INFO - ##### Running install step. 04:35:20 INFO - ##### 04:35:20 INFO - Running pre-action listener: _resource_record_pre_action 04:35:20 INFO - Running main action method: install 04:35:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:35:20 INFO - Reading from file tmpfile_stdout 04:35:20 INFO - Detecting whether we're running mozinstall >=1.0... 04:35:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:35:21 INFO - Reading from file tmpfile_stdout 04:35:21 INFO - Output received: 04:35:21 INFO - Usage: mozinstall [options] installer 04:35:21 INFO - Options: 04:35:21 INFO - -h, --help show this help message and exit 04:35:21 INFO - -d DEST, --destination=DEST 04:35:21 INFO - Directory to install application into. [default: 04:35:21 INFO - "/builds/slave/test"] 04:35:21 INFO - --app=APP Application being installed. [default: firefox] 04:35:21 INFO - mkdir: /builds/slave/test/build/application 04:35:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:35:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 04:35:42 INFO - Reading from file tmpfile_stdout 04:35:42 INFO - Output received: 04:35:42 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:35:42 INFO - Running post-action listener: _resource_record_post_action 04:35:42 INFO - ##### 04:35:42 INFO - ##### Running run-tests step. 04:35:42 INFO - ##### 04:35:42 INFO - Running pre-action listener: _resource_record_pre_action 04:35:42 INFO - Running main action method: run_tests 04:35:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:35:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:35:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:35:42 INFO - 2016-06-18 04:35:42.658 screenresolution[1685:12155] starting screenresolution argv=screenresolution get 04:35:42 INFO - 2016-06-18 04:35:42.661 screenresolution[1685:12155] Display 0: 1600x1200x32@60 04:35:42 INFO - 2016-06-18 04:35:42.667 screenresolution[1686:12158] starting screenresolution argv=screenresolution list 04:35:42 INFO - Available Modes on Display 0 04:35:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:35:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:35:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:35:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:35:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:35:42 INFO - Intel Iris: 04:35:42 INFO - Chipset Model: Intel Iris 04:35:42 INFO - Type: GPU 04:35:42 INFO - Bus: Built-In 04:35:42 INFO - VRAM (Dynamic, Max): 1536 MB 04:35:42 INFO - Vendor: Intel (0x8086) 04:35:42 INFO - Device ID: 0x0a2e 04:35:42 INFO - Revision ID: 0x0009 04:35:42 INFO - Displays: 04:35:42 INFO - Display: 04:35:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:35:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:35:42 INFO - Display Serial Number: 1600x1200 60 04:35:42 INFO - Main Display: Yes 04:35:42 INFO - Mirror: Off 04:35:42 INFO - Online: Yes 04:35:42 INFO - Rotation: Supported 04:35:42 INFO - Return code: 0 04:35:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:35:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:35:42 INFO - Python 2.7.3 04:35:42 INFO - Return code: 0 04:35:42 INFO - grabbing minidump binary from tooltool 04:35:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:42 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014b8e00>, '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 0x101321db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014b3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:35:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:35:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:35:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:35:42 INFO - Return code: 0 04:35:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:35:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:35:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:35:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:35:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:35:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:35:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:35:44 INFO - Return code: 0 04:35:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0166', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:35:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0166 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:35:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NS793G2zXI/Render', 04:35:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:44 INFO - 'HOME': '/Users/cltbld', 04:35:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:44 INFO - 'LOGNAME': 'cltbld', 04:35:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:35:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:44 INFO - 'MOZ_NO_REMOTE': '1', 04:35:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:35:44 INFO - 'NO_EM_RESTART': '1', 04:35:44 INFO - 'PAGER': '/bin/cat', 04:35:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:44 INFO - 'PWD': '/builds/slave/test', 04:35:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:35:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:44 INFO - 'SHELL': '/bin/bash', 04:35:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6y7JiL8b4/Listeners', 04:35:44 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 04:35:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:44 INFO - 'USER': 'cltbld', 04:35:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:44 INFO - 'XPC_FLAGS': '0x0', 04:35:44 INFO - 'XPC_SERVICE_NAME': '0', 04:35:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0166', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:35:44 INFO - mozversion application_buildid: 20160618031522 04:35:44 INFO - mozversion application_changeset: cec857b11eaf51d6c04368f65fef17e017a0f96c 04:35:44 INFO - mozversion application_display_name: Firefox 04:35:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:35:44 INFO - mozversion application_name: Firefox 04:35:44 INFO - mozversion application_remotingname: firefox 04:35:44 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:35:44 INFO - mozversion application_vendor: Mozilla 04:35:44 INFO - mozversion application_version: 48.0 04:35:44 INFO - mozversion platform_buildid: 20160618031522 04:35:44 INFO - mozversion platform_changeset: cec857b11eaf51d6c04368f65fef17e017a0f96c 04:35:44 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:35:44 INFO - mozversion platform_version: 48.0 04:35:44 INFO - using testdate: 1466249744 04:35:44 INFO - actual date: 1466249744 04:35:44 INFO - starting webserver on 'localhost:49278' 04:35:44 INFO - SUITE-START | Running 2 tests 04:35:44 INFO - TEST-START | dromaeo_css 04:35:44 INFO - operating with platform_type : mac_ 04:35:44 INFO - Initialising browser for dromaeo_css test... 04:35:44 INFO - TEST-INFO | started process 1704 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmpelBKfK/profile http://localhost:49278/getInfo.html) 04:35:46 INFO - PROCESS | 1704 | __metrics Screen width/height:1600/1200 04:35:46 INFO - PROCESS | 1704 | colorDepth:24 04:35:46 INFO - PROCESS | 1704 | Browser inner width/height: 1024/689 04:35:46 INFO - PROCESS | 1704 | __metrics 04:35:46 INFO - PROCESS | 1704 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:35:46 ERROR - PROCESS | 1704 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:35:47 INFO - TEST-INFO | 1704: exit 0 04:35:47 INFO - Browser initialized. 04:35:47 INFO - Running cycle 1/1 for dromaeo_css test... 04:35:47 INFO - TEST-INFO | started process 1708 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmpelBKfK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:35:59 INFO - PROCESS | 1708 | RSS: Main: 161492992 04:35:59 INFO - PROCESS | 1708 | 04:36:50 INFO - PROCESS | 1708 | 1466249810324 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:39:00 INFO - PROCESS | 1708 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 04:39:01 INFO - PROCESS | 1708 | RSS: Main: 292773888 04:39:01 INFO - PROCESS | 1708 | 04:42:04 INFO - PROCESS | 1708 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 04:42:04 INFO - PROCESS | 1708 | RSS: Main: 302358528 04:42:04 INFO - PROCESS | 1708 | 04:45:06 INFO - PROCESS | 1708 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 04:45:07 INFO - PROCESS | 1708 | RSS: Main: 303763456 04:45:07 INFO - PROCESS | 1708 | 04:48:09 INFO - PROCESS | 1708 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 04:48:10 INFO - PROCESS | 1708 | RSS: Main: 303411200 04:48:10 INFO - PROCESS | 1708 | 04:51:13 INFO - PROCESS | 1708 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 04:51:13 INFO - PROCESS | 1708 | RSS: Main: 267329536 04:51:13 INFO - PROCESS | 1708 | 04:54:16 INFO - PROCESS | 1708 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 04:54:16 INFO - PROCESS | 1708 | RSS: Main: 314634240 04:54:16 INFO - PROCESS | 1708 | 04:54:16 INFO - PROCESS | 1708 | __start_tp_report 04:54:16 INFO - PROCESS | 1708 | _x_x_mozilla_page_load 04:54:16 INFO - PROCESS | 1708 | _x_x_mozilla_page_load_details 04:54:16 INFO - PROCESS | 1708 | |i|pagename|runs| 04:54:16 INFO - PROCESS | 1708 | |0;dojo.html;2914.9562756558653;3624.8550057997672;3640.1263696712795;3647.854085836567;3693.7045036397076;5693.316801983758;5705.657660540371;5710.229119068925;5722.2274992876;5723.9713801431035;5662;5728.713564321788;5755.223044888939;5765.827025189241;5768.221290125832;5176.0683077046115;5202.245674377213;5224.346956630421;5266.972940276648;5295.973520132394;5232.319798426218;5283.682979021271;5291.28567643369;5295.0468915595175;5297.125974214269;5190.662606930557;5252.395974462928;5273.525382715555;5275.419703832576;5286.762095705702;5254.894902101936;5285.392179899322;5290.206469029637;5302.072137375943;5327.38735045467;5117.513836185556;5147.948520514784;5180.507851754077;5185.637005409623;5218;5571.969185700618;5578.888422231533;5608.383077861432;5624.831255062355;5635.8591035224035;6256.499480041632;6263.091851681481;6267.185265915447;6274.027525733519;6278.37216278373;6166.630002199838;6181.258249010102;6297.33877942814;6311.93688063118;6339.11252424661;5835.562332825013;5851.034579294412;5852.063669812895;5883.794067207627;5900.970495147497;6319.988801791691;6338.714757835908;6339.207599050119;6339.714712837934;6341.682915854281;6053.667048312297;6127.922628246602;6144.56988010835;6178.104174894705;6191.876162476815;5088.109580823341;6196.256449226122;6237.968810156011;6285.371462853678;6292.024736165901;6216.689165541705;6246.3441338659695;6249;6251.874962500816;6258.655773932477;5840.941590584125;6215.564910456315;6225.564210505312;6274.937250627435;6288.371162883766;4827.25177597473;4897.363342765418;4912.140375434285;4993.950060499421;5012.548870601663;4508.797104130256;4515.774211289422;4525.208088584484;4527.977360113178;4556.726596404226;5937.2578427696535;5949;5960.165576819249;5963.19496867926;5978.641281523122;6107.61364822091;6200.162977997912;6285.057241413733;6301.432871041537;6302.621842689453;5869.413058694182;5869.442402971711;5870.73581688825;5891.204687367236;5895.528357731371;5066.06277838601;5417.945820541823;5422.5119739223655;5429.484199001088;5433.212184233264;5789.739461724233;6357.618542887534;6363.109164716943;6411.903821442776;6419.940709782833;6264.248290205022;6266.937330626635;6288.968555157195;6301.558890877594;6303.275123360872;6389.9361006389345;6460.160179176865;6464.644444555594;6465.709043092978;6473.417392434703;5584.6038490377405;5876.559258055749;6104.725287361991;6144.723487442986;6207.6275423474735;6296.716647750954;6306.085617585516;6331.588446750947;6334.334894835976;6336.334684858208;6148.1085242640465;6168.25980882297;6174.197354343906;6181.443670069715;6188.4739797117745;5901.822945311647;6062.787802426894;6135.325114237341;6138.817583427312;6140.017597184429;5956.218905472637;5989.610675306091;6005.939940600538;6006.429389208019;6011.27864656244;6135.662538560422;6146.692665366803;6148.139260503623;6152.230971128609;6154.3845615438095;5837.29952405714;5919.792807251725;5964.433378829004;5979.402059793986;5990.520758339235 04:54:16 INFO - PROCESS | 1708 | |1;ext.html;555.3557872867475;580.6254965547222;580.7444724321298;590.861147630307;601.6239850093691;32190.517142242858;39620;40160.59839401605;40189;40200.59799402005;42415;43267;43270;43335.13329733411;43378.783106084506;8894.199522043014;9645.42127472354;9830.950845245763;9859.211263098934;9860.35907666003;11701.648950531498;11964.70088247792;11984.820227696591;11986.2208956418;11993.220440671328;11464.31214127155;11476.4835582399;11482.311061336346;11485.885141148565;11616.82574761375;11540.769184616345;11554.248973816675;11679.532818687243;11772.823407648892;11784.057275417988;11585.18903676743;11678.24091434054;11679.532818687243;11680.299182049104;11690.006349460306;37784.05539861498;39476.60523394787;42185.36721949173;42423.57576424227;42445.151096978196;3408;3409.7954122752467;3468.6357932417236;3491.3017396520545;4036.8183431745642;29503.262418439495;29727.851360743272;29983.400331993456;30031;30315.242118946982;2750.0787236275673;2803.7336453037133;2810.339570201001;2821;2828.61813655156;518061;519816;520573.3971330157;520708;520940;37715.62284377176;66711.66644166748;67929;67964;67982;36997.890063298146;37014.07464813347;37052.073698157765;37184;37220.44169337462;16221.513354599381;16431;16460.83539164593;16484.587885302964;16494.2577584009;13097.934510327577;13103.2138071716;13123.737525249442;13158.407871645799;13999.440022399194;8555.20340728454;8657.610407531676;8709.433886797464;8721.171488708562;8755.868661970075;3493.7729047611824;3577.874774382884;3585.354636165463;3585.713142948558;3623.767918907584;1036.1710631494775;1052.2634156090767;1053.0995998421392;1078.3044936016227;1120.0031971545332;30475.847620762197;30902.53646195309;31013.68986310108;31358.37283254322;31920.680793191772;1123.5449642894641;1141.7545227776068;1225.3015781004742;1236.5795629486017;1255.0963306419364;15185.544433667008;16612.916935415487;17009.319627214772;17027.574310642332;17036.977781332913;482434;514613;516929;518176;518305;60560.09159862606;61835;61968.380316196264;61969.38030619636;62128.689356552924;1480.9333579989143;1529.2048134969975;1567.6707891342946;1587.8888477806443;1604.7753314535973;24370.512589747752;29257.82968681314;30237.697623023487;30693.359423500482;31814.681853182097;55201.447985521234;55913.72043139758;56392.718036409555;56447.71776141093;56451;512197;514256;515421;515446;515974;24906.750932490442;28044.439111217253;28403.715962840935;28713.856430718548;28738.85630571834;43752.12495750003;44587.77706111449;44833.775831120634;44915.775421122686;45218.869528262054;36389.81517125564;36703.449448258834;37567.81216093902;38373.23253534969;39668;32553.837230813693;37133.81433092817;37783.433248501846;38410;38603.034924127125;36475.63524364722;38988;39818.40272395974;40285.194296113325;41314;31920.680793191772;32741.04978069339;33099.83450082734;33198.33603327871;33215.667843322226;22033.33899983003;25647.487050259264;25798.09706660258;25815;26288.211353659422 04:54:16 INFO - PROCESS | 1708 | |2;jquery.html;357.3745944596955;417.2551994689479;418.72991920211444;421.31956889623257;429.81088321138697;15397.384104635828;18731.4380568583;21472.46318842028;21608.459788505275;21876.671849922262;20913.37259882206;21254.14983400662;22119.889400553016;22130.557388852252;22140.446488837788;5998.520118390518;6062.757489700407;6241.157443745082;6256.781012664557;6277.811665650038;6148.538859585527;6260.937390626081;6265.874682506347;6269.843253918643;6276.68616569172;4458.308962110862;6638.435732962704;6982.406495447893;6989.126359205099;6990.370866622003;6864.759733409307;6921.411680007205;6926.168859736838;6942.930570694279;6945.652717364137;5888.852778680524;6052.939470605282;6073.301570319381;6085.726142323606;6085.756569737206;26661.733382666313;27028.783704733334;28089.578656320173;28152.43695126086;28156;2364.1607229433475;2673.4786716590274;2701.351675597862;2844.5733140028956;3085.537169424604;15696.776804584777;15857.36570537177;16093;16214.918925405298;16233;1478.5786050975528;1609.3723447855346;1873.7751469823572;1912.6270377276437;1914.0621095663025;116702;116935.4153229237;118364;118597.81402186041;119217;11211.887881121247;11424.942875285571;11803.527858885549;11849.526018959144;12044.81932771009;12994.935025324812;13458;14045.71908561823;14898.25508724581;14933.029353092013;9172.8624070639;9182.586783594754;9248.537573121317;9265.305102117369;9331.766705832273;9418.29362797793;9420.95289523548;9424.575894084783;9532.428054316762;9541.47521886289;6967.82580435483;7072.328128827753;7102.893456598155;7106;7111.182214045451;1816.246257802997;1840.9966568220084;1954.6579348613936;1981.1184023109865;1983.395064505311;978.2760757039739;992.1120597065586;1025.0364657222337;1035.3048923133554;1164.061103275652;22036.33890983273;22836;22963.311100667008;23036.53926921452;23056.731879746774;953.9856902146473;1016.3190662256306;1035.3684252605904;1077.256692881909;1085.5820509103894;9328.347015708836;11410.315381076996;11463.312201267783;11464.36945967963;11475.8278625819;537027;606722.6974786145;610216;679317;679745;133528.66471335356;135894.3205283987;137375.31312343373;138793;139966;1043.582566973217;1063.5798859450474;1075.8440026196158;1079.1852151625471;1083.8970297821695;18424.772837397075;18787.624247515247;19142.7128593074;19154;19506.02469876529;39639.80180099081;51999;52693;55673.44326556683;56197.43802561922;70696;73901;75971.62014189894;78140;81512;8019.358451323997;8359.582020899052;8445.308933568833;8548.187922147386;8668.869966950628;9401.905980940377;12599.874001260237;13008.089433739548;13277.468901243841;13440.663983400493;10550;10649.307794993301;11126;11802.937735603837;11839.467223975114;11174.161937854531;11311.434428278388;11316.886831131584;11328.773424531628;11568.537258509565;11665.650030499099;11691.532338706356;11860.822087668519;12000.75998480043;12104.031677465957;8068.59657017135;8368.12134725845;8397.664093436439;8516.190961858862;8887.200151986352;8541;10599.947000264949;11177.944110279723;11435.485403156712;11443.14176436754 04:54:16 INFO - PROCESS | 1708 | |3;mootools.html;1260.8045752908301;1615.3780794394158;1622.4808061420342;1877.14589861613;1998;8327.375446841488;8993;9170.12883776042;9194.724158275245;9196.586153623086;8926;9184.173424391804;9190.816183676323;9192.12674795895;9207.493587852665;2516.396064944414;2528.898844046236;2531.73416791237;2531.999860055277;2545.4400031993023;2484.6769919910384;2571.112966026718;2571.7042540107846;2573.4724381501746;2575.549278876189;2507.623856421533;2526.9747302527016;2572.781313588347;2575.6780402449695;2579.3809485723386;2513.28371414147;2551.323899166722;2551.5279673260507;2558.296468471167;2558.8848501817465;2139.8181154601875;2495.563276426618;2534.911278105276;2543.2370288913253;2548.885300161497;8853.24747396472;9061.365704400694;9099.272058235325;9145.771355716093;9182.17360437564;5630.634008789416;5835.941640583582;5867.266591676041;5885.146653735184;5887.146363777271;3600.0819790953137;3704.0924973381425;3713.1830997180577;3725.4784330193793;3760.623937606245;1052.8683914510686;1058.841173823925;1071.539238127605;1074.785042991397;1118.3737107219983;12420.937895310466;12511.3744312784;12516.936060434873;12523.311217883012;12529.310887901162;4766.4280286365165;4783.329857076231;4788.066327066189;4886.731229782325;4890.682105663121;9698.224142068617;9708.271879609058;9711.46586937711;9723.416595004323;9776.706698798906;4770.189067858403;5557.610967232255;5596.804111856066;5615.101583746581;5619.662820230799;4630.444346678353;4717.787699553528;4914.238293064509;5010.799568017312;5230.581553475713;3952.7825969571372;3974.4038394241097;4026.214888096793;4048.473698419187;4108.034611866209;1236.5981056156604;1243.3223892978167;1246.2647038247478;1256.4974010395915;1262.110212300326;902.8894459814334;919.94940278284;962.5283611030544;979.3878825733916;984.9854649710809;4990.451050384455;6053.152558641794;6132.8773424532155;6152.3540028297275;6244.843878903063;464.97907594158346;466.4822047527242;470.621149974274;473.2924278204107;481.90843739690047;3315.8891771256417;3805.733598648068;3927.273454410943;3952.5256969163884;4249.68127390447;10956.835647465294;11097.722556936142;11189.328640281608;11283.66149015531;11300.717482063013;11104.666859994213;11126.721831954266;11130.666080017612;11141.2201145919;11155.163362747826;7198.964005180045;8208.753737387888;8472.110428405053;8498.617562209716;8776.078511756301;5978.581499295182;6017.608855424383;6110.480609148272;6125.1424800527075;6148.78479253224;9790.657326993522;9810.117089461983;9825.950870245602;10010.549525271526;10017.298789084694;9347.859782103138;9642.891067527324;10042.035968512646;10238.641647542301;10312.02035806597;7186.065811444688;7305.3425191732995;7625.733099341496;7846.0976987647155;8003.4797738146835;8553.700620478254;8574.871376929475;8626.223639872442;8633.438826476258;8657;7535.660895259617;7788.688452461838;7790.844183116193;7848.686052557834;7885.960570197112;7504.774856754306;7506.474546781673;7531.133919599316;7639.503432276884;7657;7247.710091596277;7264.837625979818;7266.091738532684;7283.308085731847;7324.560526368435;4973.801047958041;4989.775460104376;5130.153524668537;5146.614003949644;5189.896202076013;5105.881420732577;5132.486751324987;5162.148245539594;5268.841934741964;5398.2442458056685 04:54:16 INFO - PROCESS | 1708 | |4;prototype.html;332.2507745034946;335.89134982695776;344.2753004924634;345.3490171027613;347.5586005772667;6419.229692436902;6485.189351331083;6539.803805885825;6550.868982620351;6580.341965803417;5752.165935939297;6407.711652975616;6687.297833727462;6713.227978782442;6747.39273465388;4952.727599981999;4969.602431805447;4977.850664480072;5000.174971129768;5011.899762004758;4982.651214414992;4987;4991.425986011619;4996.050750357439;5005.57452616528;3992;4925.950740492585;4930.334404855353;4951.8514444566545;4953.6037117030555;4207.495100587918;4610.976945115253;4781.450133234688;4901.852944411673;4922.064807686528;4168.6665066794585;4212.85255016073;4217.114405974749;4229.133027729308;4236.301010333292;6196.907046394308;6211.285702144266;6211.565190436671;6233.1273621693;6240.282367527747;5826.825195244107;5831.154482600042;5833.79581714638;5835.44563266489;5840.240768700084;6967.930320696779;6968.303169683042;6978.685959131801;6983.650817459106;7001.509894307401;4460.241758900995;4631.282151266559;4685.109829132488;4704.247320428715;4708.317293992386;7161.749338773118;7295.270472952715;7334.596597187206;7375.336219740249;7481.214472480366;4578.816847326069;4590.311453281967;4662.7668616569035;4669.322948172564;4676.953230467651;4526.705764125321;4699;4789.682837219722;4793.161196790617;4808.422989241243;5598.636088654306;5626.746796394172;5640.520555752725;5765.4522820332;5766.192733017297;6801.0138529913875;7119.89320160198;7129.073220481304;7131.750388736369;7160.283971602798;1419.978700319496;1656.8011838579448;1659.2284587666793;1660.2611837732334;1660.4603503861051;1026.8973102689672;1045.5571311589956;1055.9894401056044;1058.6771034834449;1071.6088627651006;5762.394948530427;6669.4330981866115;6766.729330826712;6807.761728339485;6837.658117094125;7363.668634911442;7371.967924490576;7378.114626244885;7381.224971378036;7385.556866588022;5853.970730146322;6099.298580663191;6789.864202715918;6799.660016999229;6812.4550035997;3121.5941927549275;3846.288436639175;3883.66988805949;3885.834249725071;3892.630200130983;7780.1052878919645;8077.838443231102;8114.229148230908;8115.959420202979;8116.391270654606;7633.503822251536;7719.343855772322;7726.7681969541;7730.690772369155;7733.806654833674;8066.919330806734;8068.757937261891;8082.515049097073;8082.676692932217;8088.716894908767;7130.825098344847;7330.780076597711;7485.850282994418;7492.063492063492;7497.62511874415;7175.8564828704175;7200.567965922061;7220;7221.53060051095;7240;5808.448197421239;6590.637514936533;7626.351760100453;7776.105747839071;8072.192780721881;4691.695039822537;4740.407449068866;4745.454272758677;4752.215884379177;4754.477007529238;7422.96288518554;7427.851442971219;7430.331270185709;7438.73964411243;7448.1807001228735;6344.206974128234;7172.892406614009;7176.246494118042;7178.497505174588;7191.748288809867;6453.967365221542;6563.638999855054;6581.5392922496885;7214.386777123793;7227.710891564278;5691.886162276648;6982.860342793014;7039.014537964791;7056.024313192314;7075.363217310467;5872.618279811799;7145.820939544917;7193.662059830681;7203.063601731741;7206.89189662145;6802.863942721019;7071.646417679199;7074.398676112588;7077.186123595852;7077.752278670222 04:54:16 INFO - PROCESS | 1708 | |5;yui.html;711.6370650968006;762.5577165244159;772.6329993253208;773.8258891749354;800.6797281087564;15625;15801.84198158018;15851.128187949658;15871.920640396782;15901.602459938507;12123.878761212385;12186.573469928555;12202.572909948154;12211.267323960546;12256.203346782475;791.7070683846985;805.046020465747;957.1577012229228;959.6833045095102;983.7786498037956;945.8959514453404;957.4111921168466;960.9711708648751;961.5865177973469;962.562034274407;1041.86455760751;1046.5918291866178;1046.9057784799365;1047.842823576462;1049.3441599000626;766.7661363284196;841.7306461932214;842.7808769719855;843.6456688190974;1019.9698304712219;769.5305863423307;779.6179871862803;779.6530543907963;780.7111368793583;782.1083964280724;15261.61845953849;15337.539873803804;15348.386064557404;15351.769723454045;15365.923170384076;13082.934585327108;13186.208827470382;13413.262270575115;13476.191428514321;13486.595402137951;10365.740856478573;10481.528331225114;10529.157667386668;10613.310134841287;10815.67552973412;3569.7291724493366;3614.475900994341;3638.472421498894;3686.4838922550866;3868.535775706905;80142.79785803218;80981;81023.59488202521;81069.9999999994;81140.18859811385;9710.417374957526;9831.070350960877;10134.594616215416;10160.491975401348;10221.284510084222;22290.331290061324;22337.32988010362;22361;23725;24089.03643854226;7774.416918731118;7815.921840781633;7901.723439679584;8015.559144247006;8022.358211343078;4154.439150714676;4265.0830071534765;4284.378765079046;4298.24430183448;4389.714668546534;3745.7939813309986;3795.772253664789;3798.506194194737;3807.048237940515;3825.215830754689;655.4592461219513;657.940785329313;660.8744338575656;670.493777198222;676.9627670478171;588.2088590845307;615.2801222569605;618.944295013442;619.5136817598163;634.5589815078569;8063.395245356622;8465.57672116404;8472.152784721602;8486.74539763808;8612.827743445221;541.8347404041805;589.178096555303;611.6452457574596;621;623.4221494121839;3525.801227582634;3812.5234345706785;3822.369309064029;3884.864029758945;4065.7611726280356;95743;96504.0349596509;97299;98087.50956245315;98141;81341.18658813337;81934.59032704799;82429.58785206036;82503;82916.3416731662;71777.6411117941;72219.63890180516;72329;72417.91373129407;72428.63785681038;7680.884786728316;7776.688932442639;7898.131205567498;8087.029556453028;8233.958830205811;48645;50554.74722626364;51110;52103.218451722496;52437.21344179917;50117.24824127714;61795.07307390482;65931;66333.66833165997;70853.64573177102;10425.012891198263;10449.895501044892;10520.631777888044;10632.30889992148;11405.087592992706;11875.287482751062;12101.69745756363;12161.270323780602;12778.297193654438;13177.868221318047;9919.900800992187;11494.655160345203;11582.420878956187;11694.532218711156;11840.82238766402;11615.883841161818;11627.941860290644;11634.301941883514;11637.010854077498;11994.520219191134;11260.887391125983;11274.830877537008;11525.366104864313;11736.70658233551;12428.067894907737;9720.173785228335;9765.9023409765;9999.200063994718;10295.07344339013;10351.534180962026;9702.59062736883;9851.16265117473;9867.901320986699;9879.357841740264;9893 04:54:16 INFO - PROCESS | 1708 | __end_tp_report 04:54:16 INFO - PROCESS | 1708 | __start_cc_report 04:54:16 INFO - PROCESS | 1708 | _x_x_mozilla_cycle_collect,1224 04:54:16 INFO - PROCESS | 1708 | __end_cc_report 04:54:16 INFO - PROCESS | 1708 | __startTimestamp1466250856725__endTimestamp 04:54:16 INFO - PROCESS | 1708 | 04:54:16 INFO - PROCESS | 1708 | ------- Summary: start ------- 04:54:16 INFO - PROCESS | 1708 | Number of tests: 6 04:54:16 INFO - PROCESS | 1708 | 04:54:16 INFO - PROCESS | 1708 | [#0] dojo.html Cycles:165 Average:5776.01 Median:5963.19 stddev:628.26 (10.5%) stddev-sans-first:588.74 04:54:16 INFO - PROCESS | 1708 | Values: 2915.0 3624.9 3640.1 3647.9 3693.7 5693.3 5705.7 5710.2 5722.2 5724.0 5662.0 5728.7 5755.2 5765.8 5768.2 5176.1 5202.2 5224.3 5267.0 5296.0 5232.3 5283.7 5291.3 5295.0 5297.1 5190.7 5252.4 5273.5 5275.4 5286.8 5254.9 5285.4 5290.2 5302.1 5327.4 5117.5 5147.9 5180.5 5185.6 5218.0 5572.0 5578.9 5608.4 5624.8 5635.9 6256.5 6263.1 6267.2 6274.0 6278.4 6166.6 6181.3 6297.3 6311.9 6339.1 5835.6 5851.0 5852.1 5883.8 5901.0 6320.0 6338.7 6339.2 6339.7 6341.7 6053.7 6127.9 6144.6 6178.1 6191.9 5088.1 6196.3 6238.0 6285.4 6292.0 6216.7 6246.3 6249.0 6251.9 6258.7 5840.9 6215.6 6225.6 6274.9 6288.4 4827.3 4897.4 4912.1 4994.0 5012.5 4508.8 4515.8 4525.2 4528.0 4556.7 5937.3 5949.0 5960.2 5963.2 5978.6 6107.6 6200.2 6285.1 6301.4 6302.6 5869.4 5869.4 5870.7 5891.2 5895.5 5066.1 5417.9 5422.5 5429.5 5433.2 5789.7 6357.6 6363.1 6411.9 6419.9 6264.2 6266.9 6289.0 6301.6 6303.3 6389.9 6460.2 6464.6 6465.7 6473.4 5584.6 5876.6 6104.7 6144.7 6207.6 6296.7 6306.1 6331.6 6334.3 6336.3 6148.1 6168.3 6174.2 6181.4 6188.5 5901.8 6062.8 6135.3 6138.8 6140.0 5956.2 5989.6 6005.9 6006.4 6011.3 6135.7 6146.7 6148.1 6152.2 6154.4 5837.3 5919.8 5964.4 5979.4 5990.5 04:54:16 INFO - PROCESS | 1708 | 04:54:16 INFO - PROCESS | 1708 | [#1] ext.html Cycles:180 Average:65115.62 Median:3492.54 stddev:137146.37 (3926.8%) stddev-sans-first:137445.45 04:54:16 INFO - PROCESS | 1708 | Values: 555.4 580.6 580.7 590.9 601.6 32190.5 39620.0 40160.6 40189.0 40200.6 42415.0 43267.0 43270.0 43335.1 43378.8 8894.2 9645.4 9831.0 9859.2 9860.4 11701.6 11964.7 11984.8 11986.2 11993.2 11464.3 11476.5 11482.3 11485.9 11616.8 11540.8 11554.2 11679.5 11772.8 11784.1 11585.2 11678.2 11679.5 11680.3 11690.0 37784.1 39476.6 42185.4 42423.6 42445.2 3408.0 3409.8 3468.6 3491.3 4036.8 29503.3 29727.9 29983.4 30031.0 30315.2 2750.1 2803.7 2810.3 2821.0 2828.6 518061.0 519816.0 520573.4 520708.0 520940.0 37715.6 66711.7 67929.0 67964.0 67982.0 36997.9 37014.1 37052.1 37184.0 37220.4 16221.5 16431.0 16460.8 16484.6 16494.3 13097.9 13103.2 13123.7 13158.4 13999.4 8555.2 8657.6 8709.4 8721.2 8755.9 3493.8 3577.9 3585.4 3585.7 3623.8 1036.2 1052.3 1053.1 1078.3 1120.0 30475.8 30902.5 31013.7 31358.4 31920.7 1123.5 1141.8 1225.3 1236.6 1255.1 15185.5 16612.9 17009.3 17027.6 17037.0 482434.0 514613.0 516929.0 518176.0 518305.0 60560.1 61835.0 61968.4 61969.4 62128.7 1480.9 1529.2 1567.7 1587.9 1604.8 24370.5 29257.8 30237.7 30693.4 31814.7 55201.4 55913.7 56392.7 56447.7 56451.0 512197.0 514256.0 515421.0 515446.0 515974.0 24906.8 28044.4 28403.7 28713.9 28738.9 43752.1 44587.8 44833.8 44915.8 45218.9 36389.8 36703.4 37567.8 38373.2 39668.0 32553.8 37133.8 37783.4 38410.0 38603.0 36475.6 38988.0 39818.4 40285.2 41314.0 31920.7 32741.0 33099.8 33198.3 33215.7 22033.3 25647.5 25798.1 25815.0 26288.2 04:54:16 INFO - PROCESS | 1708 | 04:54:16 INFO - PROCESS | 1708 | [#2] jquery.html Cycles:180 Average:36401.06 Median:22899.66 stddev:104164.40 (454.9%) stddev-sans-first:104421.45 04:54:16 INFO - PROCESS | 1708 | Values: 357.4 417.3 418.7 421.3 429.8 15397.4 18731.4 21472.5 21608.5 21876.7 20913.4 21254.1 22119.9 22130.6 22140.4 5998.5 6062.8 6241.2 6256.8 6277.8 6148.5 6260.9 6265.9 6269.8 6276.7 4458.3 6638.4 6982.4 6989.1 6990.4 6864.8 6921.4 6926.2 6942.9 6945.7 5888.9 6052.9 6073.3 6085.7 6085.8 26661.7 27028.8 28089.6 28152.4 28156.0 2364.2 2673.5 2701.4 2844.6 3085.5 15696.8 15857.4 16093.0 16214.9 16233.0 1478.6 1609.4 1873.8 1912.6 1914.1 116702.0 116935.4 118364.0 118597.8 119217.0 11211.9 11424.9 11803.5 11849.5 12044.8 12994.9 13458.0 14045.7 14898.3 14933.0 9172.9 9182.6 9248.5 9265.3 9331.8 9418.3 9421.0 9424.6 9532.4 9541.5 6967.8 7072.3 7102.9 7106.0 7111.2 1816.2 1841.0 1954.7 1981.1 1983.4 978.3 992.1 1025.0 1035.3 1164.1 22036.3 22836.0 22963.3 23036.5 23056.7 954.0 1016.3 1035.4 1077.3 1085.6 9328.3 11410.3 11463.3 11464.4 11475.8 537027.0 606722.7 610216.0 679317.0 679745.0 133528.7 135894.3 137375.3 138793.0 139966.0 1043.6 1063.6 1075.8 1079.2 1083.9 18424.8 18787.6 19142.7 19154.0 19506.0 39639.8 51999.0 52693.0 55673.4 56197.4 70696.0 73901.0 75971.6 78140.0 81512.0 8019.4 8359.6 8445.3 8548.2 8668.9 9401.9 12599.9 13008.1 13277.5 13440.7 10550.0 10649.3 11126.0 11802.9 11839.5 11174.2 11311.4 11316.9 11328.8 11568.5 11665.7 11691.5 11860.8 12000.8 12104.0 8068.6 8368.1 8397.7 8516.2 8887.2 8541.0 10599.9 11177.9 11435.5 11443.1 04:54:16 INFO - PROCESS | 1708 | 04:54:16 INFO - PROCESS | 1708 | [#3] mootools.html Cycles:180 Average:5873.91 Median:4990.11 stddev:3301.32 (66.2%) stddev-sans-first:3292.38 04:54:16 INFO - PROCESS | 1708 | Values: 1260.8 1615.4 1622.5 1877.1 1998.0 8327.4 8993.0 9170.1 9194.7 9196.6 8926.0 9184.2 9190.8 9192.1 9207.5 2516.4 2528.9 2531.7 2532.0 2545.4 2484.7 2571.1 2571.7 2573.5 2575.5 2507.6 2527.0 2572.8 2575.7 2579.4 2513.3 2551.3 2551.5 2558.3 2558.9 2139.8 2495.6 2534.9 2543.2 2548.9 8853.2 9061.4 9099.3 9145.8 9182.2 5630.6 5835.9 5867.3 5885.1 5887.1 3600.1 3704.1 3713.2 3725.5 3760.6 1052.9 1058.8 1071.5 1074.8 1118.4 12420.9 12511.4 12516.9 12523.3 12529.3 4766.4 4783.3 4788.1 4886.7 4890.7 9698.2 9708.3 9711.5 9723.4 9776.7 4770.2 5557.6 5596.8 5615.1 5619.7 4630.4 4717.8 4914.2 5010.8 5230.6 3952.8 3974.4 4026.2 4048.5 4108.0 1236.6 1243.3 1246.3 1256.5 1262.1 902.9 919.9 962.5 979.4 985.0 4990.5 6053.2 6132.9 6152.4 6244.8 465.0 466.5 470.6 473.3 481.9 3315.9 3805.7 3927.3 3952.5 4249.7 10956.8 11097.7 11189.3 11283.7 11300.7 11104.7 11126.7 11130.7 11141.2 11155.2 7199.0 8208.8 8472.1 8498.6 8776.1 5978.6 6017.6 6110.5 6125.1 6148.8 9790.7 9810.1 9826.0 10010.5 10017.3 9347.9 9642.9 10042.0 10238.6 10312.0 7186.1 7305.3 7625.7 7846.1 8003.5 8553.7 8574.9 8626.2 8633.4 8657.0 7535.7 7788.7 7790.8 7848.7 7886.0 7504.8 7506.5 7531.1 7639.5 7657.0 7247.7 7264.8 7266.1 7283.3 7324.6 4973.8 4989.8 5130.2 5146.6 5189.9 5105.9 5132.5 5162.1 5268.8 5398.2 04:54:16 INFO - PROCESS | 1708 | 04:54:16 INFO - PROCESS | 1708 | [#4] prototype.html Cycles:180 Average:5809.99 Median:6469.58 stddev:1882.69 (29.1%) stddev-sans-first:1842.53 04:54:16 INFO - PROCESS | 1708 | Values: 332.3 335.9 344.3 345.3 347.6 6419.2 6485.2 6539.8 6550.9 6580.3 5752.2 6407.7 6687.3 6713.2 6747.4 4952.7 4969.6 4977.9 5000.2 5011.9 4982.7 4987.0 4991.4 4996.1 5005.6 3992.0 4926.0 4930.3 4951.9 4953.6 4207.5 4611.0 4781.5 4901.9 4922.1 4168.7 4212.9 4217.1 4229.1 4236.3 6196.9 6211.3 6211.6 6233.1 6240.3 5826.8 5831.2 5833.8 5835.4 5840.2 6967.9 6968.3 6978.7 6983.7 7001.5 4460.2 4631.3 4685.1 4704.2 4708.3 7161.7 7295.3 7334.6 7375.3 7481.2 4578.8 4590.3 4662.8 4669.3 4677.0 4526.7 4699.0 4789.7 4793.2 4808.4 5598.6 5626.7 5640.5 5765.5 5766.2 6801.0 7119.9 7129.1 7131.8 7160.3 1420.0 1656.8 1659.2 1660.3 1660.5 1026.9 1045.6 1056.0 1058.7 1071.6 5762.4 6669.4 6766.7 6807.8 6837.7 7363.7 7372.0 7378.1 7381.2 7385.6 5854.0 6099.3 6789.9 6799.7 6812.5 3121.6 3846.3 3883.7 3885.8 3892.6 7780.1 8077.8 8114.2 8116.0 8116.4 7633.5 7719.3 7726.8 7730.7 7733.8 8066.9 8068.8 8082.5 8082.7 8088.7 7130.8 7330.8 7485.9 7492.1 7497.6 7175.9 7200.6 7220.0 7221.5 7240.0 5808.4 6590.6 7626.4 7776.1 8072.2 4691.7 4740.4 4745.5 4752.2 4754.5 7423.0 7427.9 7430.3 7438.7 7448.2 6344.2 7172.9 7176.2 7178.5 7191.7 6454.0 6563.6 6581.5 7214.4 7227.7 5691.9 6982.9 7039.0 7056.0 7075.4 5872.6 7145.8 7193.7 7203.1 7206.9 6802.9 7071.6 7074.4 7077.2 7077.8 04:54:16 INFO - PROCESS | 1708 | 04:54:16 INFO - PROCESS | 1708 | [#5] yui.html Cycles:180 Average:18647.40 Median:26489.52 stddev:26289.25 (99.2%) stddev-sans-first:26328.50 04:54:16 INFO - PROCESS | 1708 | Values: 711.6 762.6 772.6 773.8 800.7 15625.0 15801.8 15851.1 15871.9 15901.6 12123.9 12186.6 12202.6 12211.3 12256.2 791.7 805.0 957.2 959.7 983.8 945.9 957.4 961.0 961.6 962.6 1041.9 1046.6 1046.9 1047.8 1049.3 766.8 841.7 842.8 843.6 1020.0 769.5 779.6 779.7 780.7 782.1 15261.6 15337.5 15348.4 15351.8 15365.9 13082.9 13186.2 13413.3 13476.2 13486.6 10365.7 10481.5 10529.2 10613.3 10815.7 3569.7 3614.5 3638.5 3686.5 3868.5 80142.8 80981.0 81023.6 81070.0 81140.2 9710.4 9831.1 10134.6 10160.5 10221.3 22290.3 22337.3 22361.0 23725.0 24089.0 7774.4 7815.9 7901.7 8015.6 8022.4 4154.4 4265.1 4284.4 4298.2 4389.7 3745.8 3795.8 3798.5 3807.0 3825.2 655.5 657.9 660.9 670.5 677.0 588.2 615.3 618.9 619.5 634.6 8063.4 8465.6 8472.2 8486.7 8612.8 541.8 589.2 611.6 621.0 623.4 3525.8 3812.5 3822.4 3884.9 4065.8 95743.0 96504.0 97299.0 98087.5 98141.0 81341.2 81934.6 82429.6 82503.0 82916.3 71777.6 72219.6 72329.0 72417.9 72428.6 7680.9 7776.7 7898.1 8087.0 8234.0 48645.0 50554.7 51110.0 52103.2 52437.2 50117.2 61795.1 65931.0 66333.7 70853.6 10425.0 10449.9 10520.6 10632.3 11405.1 11875.3 12101.7 12161.3 12778.3 13177.9 9919.9 11494.7 11582.4 11694.5 11840.8 11615.9 11627.9 11634.3 11637.0 11994.5 11260.9 11274.8 11525.4 11736.7 12428.1 9720.2 9765.9 9999.2 10295.1 10351.5 9702.6 9851.2 9867.9 9879.4 9893.0 04:54:16 INFO - PROCESS | 1708 | -------- Summary: end -------- 04:54:16 INFO - PROCESS | 1708 | 04:54:17 INFO - TEST-INFO | 1708: exit 0 04:54:17 INFO - TEST-OK | dromaeo_css | took 1112953ms 04:54:17 INFO - TEST-START | kraken 04:54:17 INFO - operating with platform_type : mac_ 04:54:17 INFO - Initialising browser for kraken test... 04:54:17 INFO - TEST-INFO | started process 1714 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmpWOBcuE/profile http://localhost:49278/getInfo.html) 04:54:19 INFO - PROCESS | 1714 | __metrics Screen width/height:1600/1200 04:54:19 INFO - PROCESS | 1714 | colorDepth:24 04:54:19 INFO - PROCESS | 1714 | Browser inner width/height: 1024/689 04:54:19 INFO - PROCESS | 1714 | __metrics 04:54:19 INFO - PROCESS | 1714 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:54:19 ERROR - PROCESS | 1714 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:54:20 INFO - TEST-INFO | 1714: exit 0 04:54:20 INFO - Browser initialized. 04:54:20 INFO - Running cycle 1/1 for kraken test... 04:54:20 INFO - TEST-INFO | started process 1717 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmpWOBcuE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:54:32 INFO - PROCESS | 1717 | RSS: Main: 161226752 04:54:32 INFO - PROCESS | 1717 | 04:54:34 INFO - PROCESS | 1717 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 04:54:35 INFO - PROCESS | 1717 | RSS: Main: 223756288 04:54:35 INFO - PROCESS | 1717 | 04:54:38 INFO - PROCESS | 1717 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 04:54:38 INFO - PROCESS | 1717 | RSS: Main: 238882816 04:54:38 INFO - PROCESS | 1717 | 04:54:41 INFO - PROCESS | 1717 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 04:54:42 INFO - PROCESS | 1717 | RSS: Main: 325054464 04:54:42 INFO - PROCESS | 1717 | 04:54:44 INFO - PROCESS | 1717 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 04:54:45 INFO - PROCESS | 1717 | RSS: Main: 229842944 04:54:45 INFO - PROCESS | 1717 | 04:54:47 INFO - PROCESS | 1717 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:54:48 INFO - PROCESS | 1717 | RSS: Main: 231874560 04:54:48 INFO - PROCESS | 1717 | 04:54:50 INFO - PROCESS | 1717 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 04:54:51 INFO - PROCESS | 1717 | RSS: Main: 268468224 04:54:51 INFO - PROCESS | 1717 | 04:54:54 INFO - PROCESS | 1717 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 04:54:54 INFO - PROCESS | 1717 | RSS: Main: 269516800 04:54:54 INFO - PROCESS | 1717 | 04:54:57 INFO - PROCESS | 1717 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 04:54:58 INFO - PROCESS | 1717 | RSS: Main: 268390400 04:54:58 INFO - PROCESS | 1717 | 04:54:59 INFO - PROCESS | 1717 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:55:00 INFO - PROCESS | 1717 | RSS: Main: 260177920 04:55:00 INFO - PROCESS | 1717 | 04:55:02 INFO - PROCESS | 1717 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:55:02 INFO - PROCESS | 1717 | RSS: Main: 266661888 04:55:02 INFO - PROCESS | 1717 | 04:55:05 INFO - PROCESS | 1717 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:55:05 INFO - PROCESS | 1717 | RSS: Main: 270557184 04:55:05 INFO - PROCESS | 1717 | 04:55:08 INFO - PROCESS | 1717 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:55:09 INFO - PROCESS | 1717 | RSS: Main: 277618688 04:55:09 INFO - PROCESS | 1717 | 04:55:11 INFO - PROCESS | 1717 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:55:12 INFO - PROCESS | 1717 | RSS: Main: 274726912 04:55:12 INFO - PROCESS | 1717 | 04:55:14 INFO - PROCESS | 1717 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 04:55:14 INFO - PROCESS | 1717 | RSS: Main: 335769600 04:55:14 INFO - PROCESS | 1717 | 04:55:14 INFO - PROCESS | 1717 | __start_tp_report 04:55:14 INFO - PROCESS | 1717 | _x_x_mozilla_page_load 04:55:14 INFO - PROCESS | 1717 | _x_x_mozilla_page_load_details 04:55:14 INFO - PROCESS | 1717 | |i|pagename|runs| 04:55:14 INFO - PROCESS | 1717 | |0;ai-astar;114;113;119;112;112;111;112;112;113;134 04:55:14 INFO - PROCESS | 1717 | |1;audio-beat-detection;154;117;143;149;126;173;166;123;175;116 04:55:14 INFO - PROCESS | 1717 | |2;audio-dft;185;184;184;186;189;186;184;185;184;185 04:55:14 INFO - PROCESS | 1717 | |3;audio-fft;69;82;98;193;80;56;56;60;126;61 04:55:14 INFO - PROCESS | 1717 | |4;audio-oscillator;93;91;145;77;78;77;124;79;77;126 04:55:14 INFO - PROCESS | 1717 | |5;imaging-gaussian-blur;88;84;133;91;73;125;135;85;88;85 04:55:14 INFO - PROCESS | 1717 | |6;imaging-darkroom;92;129;93;93;93;93;94;93;93;92 04:55:14 INFO - PROCESS | 1717 | |7;imaging-desaturate;83;85;84;87;84;83;87;85;86;83 04:55:14 INFO - PROCESS | 1717 | |8;json-parse-financial;58;61;60;62;61;60;61;75;57;54 04:55:14 INFO - PROCESS | 1717 | |9;json-stringify-tinderbox;61;64;60;67;68;74;68;66;66;66 04:55:14 INFO - PROCESS | 1717 | |10;stanford-crypto-aes;83;78;79;80;81;94;102;85;78;81 04:55:14 INFO - PROCESS | 1717 | |11;stanford-crypto-ccm;137;142;144;131;124;126;127;126;143;129 04:55:14 INFO - PROCESS | 1717 | |12;stanford-crypto-pbkdf2;168;161;164;164;164;162;161;176;207;170 04:55:14 INFO - PROCESS | 1717 | |13;stanford-crypto-sha256-iterative;65;68;68;67;68;66;68;68;69;65 04:55:14 INFO - PROCESS | 1717 | __end_tp_report 04:55:14 INFO - PROCESS | 1717 | __start_cc_report 04:55:14 INFO - PROCESS | 1717 | _x_x_mozilla_cycle_collect,1920 04:55:14 INFO - PROCESS | 1717 | __end_cc_report 04:55:14 INFO - PROCESS | 1717 | __startTimestamp1466250914446__endTimestamp 04:55:14 INFO - PROCESS | 1717 | 04:55:14 INFO - PROCESS | 1717 | ------- Summary: start ------- 04:55:14 INFO - PROCESS | 1717 | Number of tests: 14 04:55:14 INFO - PROCESS | 1717 | 04:55:14 INFO - PROCESS | 1717 | [#0] ai-astar Cycles:10 Average:115.20 Median:113.00 stddev:6.97 (6.2%) stddev-sans-first:7.38 04:55:14 INFO - PROCESS | 1717 | Values: 114.0 113.0 119.0 112.0 112.0 111.0 112.0 112.0 113.0 134.0 04:55:14 INFO - PROCESS | 1717 | 04:55:14 INFO - PROCESS | 1717 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:151.50 stddev:22.83 (15.1%) stddev-sans-first:23.93 04:55:14 INFO - PROCESS | 1717 | Values: 154.0 117.0 143.0 149.0 126.0 173.0 166.0 123.0 175.0 116.0 04:55:14 INFO - PROCESS | 1717 | 04:55:14 INFO - PROCESS | 1717 | [#2] audio-dft Cycles:10 Average:185.20 Median:185.00 stddev:1.55 (0.8%) stddev-sans-first:1.64 04:55:14 INFO - PROCESS | 1717 | Values: 185.0 184.0 184.0 186.0 189.0 186.0 184.0 185.0 184.0 185.0 04:55:14 INFO - PROCESS | 1717 | 04:55:14 INFO - PROCESS | 1717 | [#3] audio-fft Cycles:10 Average:88.10 Median:65.00 stddev:42.94 (66.1%) stddev-sans-first:44.98 04:55:14 INFO - PROCESS | 1717 | Values: 69.0 82.0 98.0 193.0 80.0 56.0 56.0 60.0 126.0 61.0 04:55:14 INFO - PROCESS | 1717 | 04:55:14 INFO - PROCESS | 1717 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:77.50 stddev:25.41 (32.8%) stddev-sans-first:26.91 04:55:14 INFO - PROCESS | 1717 | Values: 93.0 91.0 145.0 77.0 78.0 77.0 124.0 79.0 77.0 126.0 04:55:14 INFO - PROCESS | 1717 | 04:55:14 INFO - PROCESS | 1717 | [#5] imaging-gaussian-blur Cycles:10 Average:98.70 Median:85.00 stddev:22.92 (27.0%) stddev-sans-first:23.98 04:55:14 INFO - PROCESS | 1717 | Values: 88.0 84.0 133.0 91.0 73.0 125.0 135.0 85.0 88.0 85.0 04:55:14 INFO - PROCESS | 1717 | 04:55:14 INFO - PROCESS | 1717 | [#6] imaging-darkroom Cycles:10 Average:96.50 Median:93.00 stddev:11.43 (12.3%) stddev-sans-first:12.01 04:55:14 INFO - PROCESS | 1717 | Values: 92.0 129.0 93.0 93.0 93.0 93.0 94.0 93.0 93.0 92.0 04:55:14 INFO - PROCESS | 1717 | 04:55:14 INFO - PROCESS | 1717 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:1.57 (1.8%) stddev-sans-first:1.54 04:55:14 INFO - PROCESS | 1717 | Values: 83.0 85.0 84.0 87.0 84.0 83.0 87.0 85.0 86.0 83.0 04:55:14 INFO - PROCESS | 1717 | 04:55:14 INFO - PROCESS | 1717 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:61.00 stddev:5.51 (9.0%) stddev-sans-first:5.74 04:55:14 INFO - PROCESS | 1717 | Values: 58.0 61.0 60.0 62.0 61.0 60.0 61.0 75.0 57.0 54.0 04:55:14 INFO - PROCESS | 1717 | 04:55:14 INFO - PROCESS | 1717 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.50 stddev:3.92 (5.9%) stddev-sans-first:3.71 04:55:14 INFO - PROCESS | 1717 | Values: 61.0 64.0 60.0 67.0 68.0 74.0 68.0 66.0 66.0 66.0 04:55:14 INFO - PROCESS | 1717 | 04:55:14 INFO - PROCESS | 1717 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:81.00 stddev:7.87 (9.7%) stddev-sans-first:8.33 04:55:14 INFO - PROCESS | 1717 | Values: 83.0 78.0 79.0 80.0 81.0 94.0 102.0 85.0 78.0 81.0 04:55:14 INFO - PROCESS | 1717 | 04:55:14 INFO - PROCESS | 1717 | [#11] stanford-crypto-ccm Cycles:10 Average:132.90 Median:134.00 stddev:7.84 (5.8%) stddev-sans-first:8.17 04:55:14 INFO - PROCESS | 1717 | Values: 137.0 142.0 144.0 131.0 124.0 126.0 127.0 126.0 143.0 129.0 04:55:14 INFO - PROCESS | 1717 | 04:55:14 INFO - PROCESS | 1717 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.70 Median:166.00 stddev:13.91 (8.4%) stddev-sans-first:14.74 04:55:14 INFO - PROCESS | 1717 | Values: 168.0 161.0 164.0 164.0 164.0 162.0 161.0 176.0 207.0 170.0 04:55:14 INFO - PROCESS | 1717 | 04:55:14 INFO - PROCESS | 1717 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:68.00 stddev:1.40 (2.1%) stddev-sans-first:1.24 04:55:14 INFO - PROCESS | 1717 | Values: 65.0 68.0 68.0 67.0 68.0 66.0 68.0 68.0 69.0 65.0 04:55:14 INFO - PROCESS | 1717 | -------- Summary: end -------- 04:55:14 INFO - PROCESS | 1717 | 04:55:15 INFO - TEST-INFO | 1717: exit 0 04:55:15 INFO - TEST-OK | kraken | took 57941ms 04:55:15 INFO - SUITE-END | took 1170s 04:55:15 INFO - Completed test suite (00:19:31) 04:55:15 INFO - javascript benchmark 04:55:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2914.9562756558653, 3624.8550057997672, 3640.1263696712795, 3647.854085836567, 3693.7045036397076, 5693.316801983758, 5705.657660540371, 5710.229119068925, 5722.2274992876, 5723.9713801431035, 5662.0, 5728.713564321788, 5755.223044888939, 5765.827025189241, 5768.221290125832, 5176.0683077046115, 5202.245674377213, 5224.346956630421, 5266.972940276648, 5295.973520132394, 5232.319798426218, 5283.682979021271, 5291.28567643369, 5295.0468915595175, 5297.125974214269, 5190.662606930557, 5252.395974462928, 5273.525382715555, 5275.419703832576, 5286.762095705702, 5254.894902101936, 5285.392179899322, 5290.206469029637, 5302.072137375943, 5327.38735045467, 5117.513836185556, 5147.948520514784, 5180.507851754077, 5185.637005409623, 5218.0, 5571.969185700618, 5578.888422231533, 5608.383077861432, 5624.831255062355, 5635.8591035224035, 6256.499480041632, 6263.091851681481, 6267.185265915447, 6274.027525733519, 6278.37216278373, 6166.630002199838, 6181.258249010102, 6297.33877942814, 6311.93688063118, 6339.11252424661, 5835.562332825013, 5851.034579294412, 5852.063669812895, 5883.794067207627, 5900.970495147497, 6319.988801791691, 6338.714757835908, 6339.207599050119, 6339.714712837934, 6341.682915854281, 6053.667048312297, 6127.922628246602, 6144.56988010835, 6178.104174894705, 6191.876162476815, 5088.109580823341, 6196.256449226122, 6237.968810156011, 6285.371462853678, 6292.024736165901, 6216.689165541705, 6246.3441338659695, 6249.0, 6251.874962500816, 6258.655773932477, 5840.941590584125, 6215.564910456315, 6225.564210505312, 6274.937250627435, 6288.371162883766, 4827.25177597473, 4897.363342765418, 4912.140375434285, 4993.950060499421, 5012.548870601663, 4508.797104130256, 4515.774211289422, 4525.208088584484, 4527.977360113178, 4556.726596404226, 5937.2578427696535, 5949.0, 5960.165576819249, 5963.19496867926, 5978.641281523122, 6107.61364822091, 6200.162977997912, 6285.057241413733, 6301.432871041537, 6302.621842689453, 5869.413058694182, 5869.442402971711, 5870.73581688825, 5891.204687367236, 5895.528357731371, 5066.06277838601, 5417.945820541823, 5422.5119739223655, 5429.484199001088, 5433.212184233264, 5789.739461724233, 6357.618542887534, 6363.109164716943, 6411.903821442776, 6419.940709782833, 6264.248290205022, 6266.937330626635, 6288.968555157195, 6301.558890877594, 6303.275123360872, 6389.9361006389345, 6460.160179176865, 6464.644444555594, 6465.709043092978, 6473.417392434703, 5584.6038490377405, 5876.559258055749, 6104.725287361991, 6144.723487442986, 6207.6275423474735, 6296.716647750954, 6306.085617585516, 6331.588446750947, 6334.334894835976, 6336.334684858208, 6148.1085242640465, 6168.25980882297, 6174.197354343906, 6181.443670069715, 6188.4739797117745, 5901.822945311647, 6062.787802426894, 6135.325114237341, 6138.817583427312, 6140.017597184429, 5956.218905472637, 5989.610675306091, 6005.939940600538, 6006.429389208019, 6011.27864656244, 6135.662538560422, 6146.692665366803, 6148.139260503623, 6152.230971128609, 6154.3845615438095, 5837.29952405714, 5919.792807251725, 5964.433378829004, 5979.402059793986, 5990.520758339235], "value": 5737.698860330604, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.3557872867475, 580.6254965547222, 580.7444724321298, 590.861147630307, 601.6239850093691, 32190.517142242858, 39620.0, 40160.59839401605, 40189.0, 40200.59799402005, 42415.0, 43267.0, 43270.0, 43335.13329733411, 43378.783106084506, 8894.199522043014, 9645.42127472354, 9830.950845245763, 9859.211263098934, 9860.35907666003, 11701.648950531498, 11964.70088247792, 11984.820227696591, 11986.2208956418, 11993.220440671328, 11464.31214127155, 11476.4835582399, 11482.311061336346, 11485.885141148565, 11616.82574761375, 11540.769184616345, 11554.248973816675, 11679.532818687243, 11772.823407648892, 11784.057275417988, 11585.18903676743, 11678.24091434054, 11679.532818687243, 11680.299182049104, 11690.006349460306, 37784.05539861498, 39476.60523394787, 42185.36721949173, 42423.57576424227, 42445.151096978196, 3408.0, 3409.7954122752467, 3468.6357932417236, 3491.3017396520545, 4036.8183431745642, 29503.262418439495, 29727.851360743272, 29983.400331993456, 30031.0, 30315.242118946982, 2750.0787236275673, 2803.7336453037133, 2810.339570201001, 2821.0, 2828.61813655156, 518061.0, 519816.0, 520573.3971330157, 520708.0, 520940.0, 37715.62284377176, 66711.66644166748, 67929.0, 67964.0, 67982.0, 36997.890063298146, 37014.07464813347, 37052.073698157765, 37184.0, 37220.44169337462, 16221.513354599381, 16431.0, 16460.83539164593, 16484.587885302964, 16494.2577584009, 13097.934510327577, 13103.2138071716, 13123.737525249442, 13158.407871645799, 13999.440022399194, 8555.20340728454, 8657.610407531676, 8709.433886797464, 8721.171488708562, 8755.868661970075, 3493.7729047611824, 3577.874774382884, 3585.354636165463, 3585.713142948558, 3623.767918907584, 1036.1710631494775, 1052.2634156090767, 1053.0995998421392, 1078.3044936016227, 1120.0031971545332, 30475.847620762197, 30902.53646195309, 31013.68986310108, 31358.37283254322, 31920.680793191772, 1123.5449642894641, 1141.7545227776068, 1225.3015781004742, 1236.5795629486017, 1255.0963306419364, 15185.544433667008, 16612.916935415487, 17009.319627214772, 17027.574310642332, 17036.977781332913, 482434.0, 514613.0, 516929.0, 518176.0, 518305.0, 60560.09159862606, 61835.0, 61968.380316196264, 61969.38030619636, 62128.689356552924, 1480.9333579989143, 1529.2048134969975, 1567.6707891342946, 1587.8888477806443, 1604.7753314535973, 24370.512589747752, 29257.82968681314, 30237.697623023487, 30693.359423500482, 31814.681853182097, 55201.447985521234, 55913.72043139758, 56392.718036409555, 56447.71776141093, 56451.0, 512197.0, 514256.0, 515421.0, 515446.0, 515974.0, 24906.750932490442, 28044.439111217253, 28403.715962840935, 28713.856430718548, 28738.85630571834, 43752.12495750003, 44587.77706111449, 44833.775831120634, 44915.775421122686, 45218.869528262054, 36389.81517125564, 36703.449448258834, 37567.81216093902, 38373.23253534969, 39668.0, 32553.837230813693, 37133.81433092817, 37783.433248501846, 38410.0, 38603.034924127125, 36475.63524364722, 38988.0, 39818.40272395974, 40285.194296113325, 41314.0, 31920.680793191772, 32741.04978069339, 33099.83450082734, 33198.33603327871, 33215.667843322226, 22033.33899983003, 25647.487050259264, 25798.09706660258, 25815.0, 26288.211353659422], "value": 19470.36062289223, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.3745944596955, 417.2551994689479, 418.72991920211444, 421.31956889623257, 429.81088321138697, 15397.384104635828, 18731.4380568583, 21472.46318842028, 21608.459788505275, 21876.671849922262, 20913.37259882206, 21254.14983400662, 22119.889400553016, 22130.557388852252, 22140.446488837788, 5998.520118390518, 6062.757489700407, 6241.157443745082, 6256.781012664557, 6277.811665650038, 6148.538859585527, 6260.937390626081, 6265.874682506347, 6269.843253918643, 6276.68616569172, 4458.308962110862, 6638.435732962704, 6982.406495447893, 6989.126359205099, 6990.370866622003, 6864.759733409307, 6921.411680007205, 6926.168859736838, 6942.930570694279, 6945.652717364137, 5888.852778680524, 6052.939470605282, 6073.301570319381, 6085.726142323606, 6085.756569737206, 26661.733382666313, 27028.783704733334, 28089.578656320173, 28152.43695126086, 28156.0, 2364.1607229433475, 2673.4786716590274, 2701.351675597862, 2844.5733140028956, 3085.537169424604, 15696.776804584777, 15857.36570537177, 16093.0, 16214.918925405298, 16233.0, 1478.5786050975528, 1609.3723447855346, 1873.7751469823572, 1912.6270377276437, 1914.0621095663025, 116702.0, 116935.4153229237, 118364.0, 118597.81402186041, 119217.0, 11211.887881121247, 11424.942875285571, 11803.527858885549, 11849.526018959144, 12044.81932771009, 12994.935025324812, 13458.0, 14045.71908561823, 14898.25508724581, 14933.029353092013, 9172.8624070639, 9182.586783594754, 9248.537573121317, 9265.305102117369, 9331.766705832273, 9418.29362797793, 9420.95289523548, 9424.575894084783, 9532.428054316762, 9541.47521886289, 6967.82580435483, 7072.328128827753, 7102.893456598155, 7106.0, 7111.182214045451, 1816.246257802997, 1840.9966568220084, 1954.6579348613936, 1981.1184023109865, 1983.395064505311, 978.2760757039739, 992.1120597065586, 1025.0364657222337, 1035.3048923133554, 1164.061103275652, 22036.33890983273, 22836.0, 22963.311100667008, 23036.53926921452, 23056.731879746774, 953.9856902146473, 1016.3190662256306, 1035.3684252605904, 1077.256692881909, 1085.5820509103894, 9328.347015708836, 11410.315381076996, 11463.312201267783, 11464.36945967963, 11475.8278625819, 537027.0, 606722.6974786145, 610216.0, 679317.0, 679745.0, 133528.66471335356, 135894.3205283987, 137375.31312343373, 138793.0, 139966.0, 1043.582566973217, 1063.5798859450474, 1075.8440026196158, 1079.1852151625471, 1083.8970297821695, 18424.772837397075, 18787.624247515247, 19142.7128593074, 19154.0, 19506.02469876529, 39639.80180099081, 51999.0, 52693.0, 55673.44326556683, 56197.43802561922, 70696.0, 73901.0, 75971.62014189894, 78140.0, 81512.0, 8019.358451323997, 8359.582020899052, 8445.308933568833, 8548.187922147386, 8668.869966950628, 9401.905980940377, 12599.874001260237, 13008.089433739548, 13277.468901243841, 13440.663983400493, 10550.0, 10649.307794993301, 11126.0, 11802.937735603837, 11839.467223975114, 11174.161937854531, 11311.434428278388, 11316.886831131584, 11328.773424531628, 11568.537258509565, 11665.650030499099, 11691.532338706356, 11860.822087668519, 12000.75998480043, 12104.031677465957, 8068.59657017135, 8368.12134725845, 8397.664093436439, 8516.190961858862, 8887.200151986352, 8541.0, 10599.947000264949, 11177.944110279723, 11435.485403156712, 11443.14176436754], "value": 10231.731117217021, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1260.8045752908301, 1615.3780794394158, 1622.4808061420342, 1877.14589861613, 1998.0, 8327.375446841488, 8993.0, 9170.12883776042, 9194.724158275245, 9196.586153623086, 8926.0, 9184.173424391804, 9190.816183676323, 9192.12674795895, 9207.493587852665, 2516.396064944414, 2528.898844046236, 2531.73416791237, 2531.999860055277, 2545.4400031993023, 2484.6769919910384, 2571.112966026718, 2571.7042540107846, 2573.4724381501746, 2575.549278876189, 2507.623856421533, 2526.9747302527016, 2572.781313588347, 2575.6780402449695, 2579.3809485723386, 2513.28371414147, 2551.323899166722, 2551.5279673260507, 2558.296468471167, 2558.8848501817465, 2139.8181154601875, 2495.563276426618, 2534.911278105276, 2543.2370288913253, 2548.885300161497, 8853.24747396472, 9061.365704400694, 9099.272058235325, 9145.771355716093, 9182.17360437564, 5630.634008789416, 5835.941640583582, 5867.266591676041, 5885.146653735184, 5887.146363777271, 3600.0819790953137, 3704.0924973381425, 3713.1830997180577, 3725.4784330193793, 3760.623937606245, 1052.8683914510686, 1058.841173823925, 1071.539238127605, 1074.785042991397, 1118.3737107219983, 12420.937895310466, 12511.3744312784, 12516.936060434873, 12523.311217883012, 12529.310887901162, 4766.4280286365165, 4783.329857076231, 4788.066327066189, 4886.731229782325, 4890.682105663121, 9698.224142068617, 9708.271879609058, 9711.46586937711, 9723.416595004323, 9776.706698798906, 4770.189067858403, 5557.610967232255, 5596.804111856066, 5615.101583746581, 5619.662820230799, 4630.444346678353, 4717.787699553528, 4914.238293064509, 5010.799568017312, 5230.581553475713, 3952.7825969571372, 3974.4038394241097, 4026.214888096793, 4048.473698419187, 4108.034611866209, 1236.5981056156604, 1243.3223892978167, 1246.2647038247478, 1256.4974010395915, 1262.110212300326, 902.8894459814334, 919.94940278284, 962.5283611030544, 979.3878825733916, 984.9854649710809, 4990.451050384455, 6053.152558641794, 6132.8773424532155, 6152.3540028297275, 6244.843878903063, 464.97907594158346, 466.4822047527242, 470.621149974274, 473.2924278204107, 481.90843739690047, 3315.8891771256417, 3805.733598648068, 3927.273454410943, 3952.5256969163884, 4249.68127390447, 10956.835647465294, 11097.722556936142, 11189.328640281608, 11283.66149015531, 11300.717482063013, 11104.666859994213, 11126.721831954266, 11130.666080017612, 11141.2201145919, 11155.163362747826, 7198.964005180045, 8208.753737387888, 8472.110428405053, 8498.617562209716, 8776.078511756301, 5978.581499295182, 6017.608855424383, 6110.480609148272, 6125.1424800527075, 6148.78479253224, 9790.657326993522, 9810.117089461983, 9825.950870245602, 10010.549525271526, 10017.298789084694, 9347.859782103138, 9642.891067527324, 10042.035968512646, 10238.641647542301, 10312.02035806597, 7186.065811444688, 7305.3425191732995, 7625.733099341496, 7846.0976987647155, 8003.4797738146835, 8553.700620478254, 8574.871376929475, 8626.223639872442, 8633.438826476258, 8657.0, 7535.660895259617, 7788.688452461838, 7790.844183116193, 7848.686052557834, 7885.960570197112, 7504.774856754306, 7506.474546781673, 7531.133919599316, 7639.503432276884, 7657.0, 7247.710091596277, 7264.837625979818, 7266.091738532684, 7283.308085731847, 7324.560526368435, 4973.801047958041, 4989.775460104376, 5130.153524668537, 5146.614003949644, 5189.896202076013, 5105.881420732577, 5132.486751324987, 5162.148245539594, 5268.841934741964, 5398.2442458056685], "value": 4651.521667910991, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.2507745034946, 335.89134982695776, 344.2753004924634, 345.3490171027613, 347.5586005772667, 6419.229692436902, 6485.189351331083, 6539.803805885825, 6550.868982620351, 6580.341965803417, 5752.165935939297, 6407.711652975616, 6687.297833727462, 6713.227978782442, 6747.39273465388, 4952.727599981999, 4969.602431805447, 4977.850664480072, 5000.174971129768, 5011.899762004758, 4982.651214414992, 4987.0, 4991.425986011619, 4996.050750357439, 5005.57452616528, 3992.0, 4925.950740492585, 4930.334404855353, 4951.8514444566545, 4953.6037117030555, 4207.495100587918, 4610.976945115253, 4781.450133234688, 4901.852944411673, 4922.064807686528, 4168.6665066794585, 4212.85255016073, 4217.114405974749, 4229.133027729308, 4236.301010333292, 6196.907046394308, 6211.285702144266, 6211.565190436671, 6233.1273621693, 6240.282367527747, 5826.825195244107, 5831.154482600042, 5833.79581714638, 5835.44563266489, 5840.240768700084, 6967.930320696779, 6968.303169683042, 6978.685959131801, 6983.650817459106, 7001.509894307401, 4460.241758900995, 4631.282151266559, 4685.109829132488, 4704.247320428715, 4708.317293992386, 7161.749338773118, 7295.270472952715, 7334.596597187206, 7375.336219740249, 7481.214472480366, 4578.816847326069, 4590.311453281967, 4662.7668616569035, 4669.322948172564, 4676.953230467651, 4526.705764125321, 4699.0, 4789.682837219722, 4793.161196790617, 4808.422989241243, 5598.636088654306, 5626.746796394172, 5640.520555752725, 5765.4522820332, 5766.192733017297, 6801.0138529913875, 7119.89320160198, 7129.073220481304, 7131.750388736369, 7160.283971602798, 1419.978700319496, 1656.8011838579448, 1659.2284587666793, 1660.2611837732334, 1660.4603503861051, 1026.8973102689672, 1045.5571311589956, 1055.9894401056044, 1058.6771034834449, 1071.6088627651006, 5762.394948530427, 6669.4330981866115, 6766.729330826712, 6807.761728339485, 6837.658117094125, 7363.668634911442, 7371.967924490576, 7378.114626244885, 7381.224971378036, 7385.556866588022, 5853.970730146322, 6099.298580663191, 6789.864202715918, 6799.660016999229, 6812.4550035997, 3121.5941927549275, 3846.288436639175, 3883.66988805949, 3885.834249725071, 3892.630200130983, 7780.1052878919645, 8077.838443231102, 8114.229148230908, 8115.959420202979, 8116.391270654606, 7633.503822251536, 7719.343855772322, 7726.7681969541, 7730.690772369155, 7733.806654833674, 8066.919330806734, 8068.757937261891, 8082.515049097073, 8082.676692932217, 8088.716894908767, 7130.825098344847, 7330.780076597711, 7485.850282994418, 7492.063492063492, 7497.62511874415, 7175.8564828704175, 7200.567965922061, 7220.0, 7221.53060051095, 7240.0, 5808.448197421239, 6590.637514936533, 7626.351760100453, 7776.105747839071, 8072.192780721881, 4691.695039822537, 4740.407449068866, 4745.454272758677, 4752.215884379177, 4754.477007529238, 7422.96288518554, 7427.851442971219, 7430.331270185709, 7438.73964411243, 7448.1807001228735, 6344.206974128234, 7172.892406614009, 7176.246494118042, 7178.497505174588, 7191.748288809867, 6453.967365221542, 6563.638999855054, 6581.5392922496885, 7214.386777123793, 7227.710891564278, 5691.886162276648, 6982.860342793014, 7039.014537964791, 7056.024313192314, 7075.363217310467, 5872.618279811799, 7145.820939544917, 7193.662059830681, 7203.063601731741, 7206.89189662145, 6802.863942721019, 7071.646417679199, 7074.398676112588, 7077.186123595852, 7077.752278670222], "value": 5183.538257215051, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.6370650968006, 762.5577165244159, 772.6329993253208, 773.8258891749354, 800.6797281087564, 15625.0, 15801.84198158018, 15851.128187949658, 15871.920640396782, 15901.602459938507, 12123.878761212385, 12186.573469928555, 12202.572909948154, 12211.267323960546, 12256.203346782475, 791.7070683846985, 805.046020465747, 957.1577012229228, 959.6833045095102, 983.7786498037956, 945.8959514453404, 957.4111921168466, 960.9711708648751, 961.5865177973469, 962.562034274407, 1041.86455760751, 1046.5918291866178, 1046.9057784799365, 1047.842823576462, 1049.3441599000626, 766.7661363284196, 841.7306461932214, 842.7808769719855, 843.6456688190974, 1019.9698304712219, 769.5305863423307, 779.6179871862803, 779.6530543907963, 780.7111368793583, 782.1083964280724, 15261.61845953849, 15337.539873803804, 15348.386064557404, 15351.769723454045, 15365.923170384076, 13082.934585327108, 13186.208827470382, 13413.262270575115, 13476.191428514321, 13486.595402137951, 10365.740856478573, 10481.528331225114, 10529.157667386668, 10613.310134841287, 10815.67552973412, 3569.7291724493366, 3614.475900994341, 3638.472421498894, 3686.4838922550866, 3868.535775706905, 80142.79785803218, 80981.0, 81023.59488202521, 81069.9999999994, 81140.18859811385, 9710.417374957526, 9831.070350960877, 10134.594616215416, 10160.491975401348, 10221.284510084222, 22290.331290061324, 22337.32988010362, 22361.0, 23725.0, 24089.03643854226, 7774.416918731118, 7815.921840781633, 7901.723439679584, 8015.559144247006, 8022.358211343078, 4154.439150714676, 4265.0830071534765, 4284.378765079046, 4298.24430183448, 4389.714668546534, 3745.7939813309986, 3795.772253664789, 3798.506194194737, 3807.048237940515, 3825.215830754689, 655.4592461219513, 657.940785329313, 660.8744338575656, 670.493777198222, 676.9627670478171, 588.2088590845307, 615.2801222569605, 618.944295013442, 619.5136817598163, 634.5589815078569, 8063.395245356622, 8465.57672116404, 8472.152784721602, 8486.74539763808, 8612.827743445221, 541.8347404041805, 589.178096555303, 611.6452457574596, 621.0, 623.4221494121839, 3525.801227582634, 3812.5234345706785, 3822.369309064029, 3884.864029758945, 4065.7611726280356, 95743.0, 96504.0349596509, 97299.0, 98087.50956245315, 98141.0, 81341.18658813337, 81934.59032704799, 82429.58785206036, 82503.0, 82916.3416731662, 71777.6411117941, 72219.63890180516, 72329.0, 72417.91373129407, 72428.63785681038, 7680.884786728316, 7776.688932442639, 7898.131205567498, 8087.029556453028, 8233.958830205811, 48645.0, 50554.74722626364, 51110.0, 52103.218451722496, 52437.21344179917, 50117.24824127714, 61795.07307390482, 65931.0, 66333.66833165997, 70853.64573177102, 10425.012891198263, 10449.895501044892, 10520.631777888044, 10632.30889992148, 11405.087592992706, 11875.287482751062, 12101.69745756363, 12161.270323780602, 12778.297193654438, 13177.868221318047, 9919.900800992187, 11494.655160345203, 11582.420878956187, 11694.532218711156, 11840.82238766402, 11615.883841161818, 11627.941860290644, 11634.301941883514, 11637.010854077498, 11994.520219191134, 11260.887391125983, 11274.830877537008, 11525.366104864313, 11736.70658233551, 12428.067894907737, 9720.173785228335, 9765.9023409765, 9999.200063994718, 10295.07344339013, 10351.534180962026, 9702.59062736883, 9851.16265117473, 9867.901320986699, 9879.357841740264, 9893.0], "value": 7079.12384924292, "unit": "score"}], "name": "dromaeo_css", "value": 7615.815574246427, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 119.0, 112.0, 112.0, 111.0, 112.0, 112.0, 113.0, 134.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 117.0, 143.0, 149.0, 126.0, 173.0, 166.0, 123.0, 175.0, 116.0], "value": 144.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 184.0, 186.0, 189.0, 186.0, 184.0, 185.0, 184.0, 185.0], "value": 185.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 82.0, 98.0, 193.0, 80.0, 56.0, 56.0, 60.0, 126.0, 61.0], "value": 88.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 145.0, 77.0, 78.0, 77.0, 124.0, 79.0, 77.0, 126.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 133.0, 91.0, 73.0, 125.0, 135.0, 85.0, 88.0, 85.0], "value": 98.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 129.0, 93.0, 93.0, 93.0, 93.0, 94.0, 93.0, 93.0, 92.0], "value": 96.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 84.0, 87.0, 84.0, 83.0, 87.0, 85.0, 86.0, 83.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 61.0, 60.0, 62.0, 61.0, 60.0, 61.0, 75.0, 57.0, 54.0], "value": 60.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 60.0, 67.0, 68.0, 74.0, 68.0, 66.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 78.0, 79.0, 80.0, 81.0, 94.0, 102.0, 85.0, 78.0, 81.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 142.0, 144.0, 131.0, 124.0, 126.0, 127.0, 126.0, 143.0, 129.0], "value": 132.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 161.0, 164.0, 164.0, 164.0, 162.0, 161.0, 176.0, 207.0, 170.0], "value": 169.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 68.0, 67.0, 68.0, 66.0, 68.0, 68.0, 69.0, 65.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1490.1000000000001, "alertThreshold": 2.0}]} 04:55:15 INFO - Return code: 0 04:55:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:55:15 ERROR - # TBPL SUCCESS # 04:55:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:55:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:55:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:55:15 INFO - 2016-06-18 04:55:15.741 screenresolution[1721:14314] starting screenresolution argv=screenresolution get 04:55:15 INFO - 2016-06-18 04:55:15.743 screenresolution[1721:14314] Display 0: 1600x1200x32@60 04:55:15 INFO - 2016-06-18 04:55:15.749 screenresolution[1722:14317] starting screenresolution argv=screenresolution list 04:55:15 INFO - Available Modes on Display 0 04:55:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:55:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:55:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:55:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:55:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:55:15 INFO - Intel Iris: 04:55:15 INFO - Chipset Model: Intel Iris 04:55:15 INFO - Type: GPU 04:55:15 INFO - Bus: Built-In 04:55:15 INFO - VRAM (Dynamic, Max): 1536 MB 04:55:15 INFO - Vendor: Intel (0x8086) 04:55:15 INFO - Device ID: 0x0a2e 04:55:15 INFO - Revision ID: 0x0009 04:55:15 INFO - Displays: 04:55:15 INFO - Display: 04:55:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:55:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:55:15 INFO - Display Serial Number: 1600x1200 60 04:55:15 INFO - Main Display: Yes 04:55:15 INFO - Mirror: Off 04:55:15 INFO - Online: Yes 04:55:15 INFO - Rotation: Supported 04:55:15 INFO - Return code: 0 04:55:15 INFO - Running post-action listener: _resource_record_post_action 04:55:15 INFO - Running post-run listener: _resource_record_post_run 04:55:17 INFO - Total resource usage - Wall time: 1194s; CPU: 53.0%; Read bytes: 31095296; Write bytes: 494083072; Read time: 308; Write time: 1615 04:55:17 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 180859392; Write bytes: 174301184; Read time: 16380; Write time: 328 04:55:17 INFO - run-tests - Wall time: 1173s; CPU: 52.0%; Read bytes: 30173696; Write bytes: 297042944; Read time: 294; Write time: 1211 04:55:17 INFO - Running post-run listener: _upload_blobber_files 04:55:17 INFO - Blob upload gear active. 04:55:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:55:17 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 04:55:17 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:55:17 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:55:17 INFO - (blobuploader) - INFO - Open directory for files ... 04:55:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:55:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:55:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:55:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:55:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:55:18 INFO - (blobuploader) - INFO - Done attempting. 04:55:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:55:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:55:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:55:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:55:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:55:19 INFO - (blobuploader) - INFO - Done attempting. 04:55:19 INFO - (blobuploader) - INFO - Iteration through files over. 04:55:19 INFO - Return code: 0 04:55:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:55:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:55:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe294301801ccecd5580688fc09a80233d4cfd3375b8f1b43fe6dee3e77143fe449bd9132f01d648e55cd6ed00ba1cda90e7ccba4f20b843cd178b331f1c8a51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a72fccf2f6b5edbfa08c3581e97fb5a8934dd8a1bd54ba7746d00884996bad9668aa9a6bea98124fbe84869a6414c72e956684850ce73e89f38021bf22a4a250"} 04:55:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:55:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:55:19 INFO - Contents: 04:55:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe294301801ccecd5580688fc09a80233d4cfd3375b8f1b43fe6dee3e77143fe449bd9132f01d648e55cd6ed00ba1cda90e7ccba4f20b843cd178b331f1c8a51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a72fccf2f6b5edbfa08c3581e97fb5a8934dd8a1bd54ba7746d00884996bad9668aa9a6bea98124fbe84869a6414c72e956684850ce73e89f38021bf22a4a250"} 04:55:19 INFO - Running post-run listener: copy_logs_to_upload_dir 04:55:19 INFO - Copying logs to upload dir... 04:55:19 INFO - mkdir: /builds/slave/test/build/upload/logs 04:55:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.875514 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-06-18 04:55:19.217203) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 04:55:19.221262) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NS793G2zXI/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.n6y7JiL8b4/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe294301801ccecd5580688fc09a80233d4cfd3375b8f1b43fe6dee3e77143fe449bd9132f01d648e55cd6ed00ba1cda90e7ccba4f20b843cd178b331f1c8a51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a72fccf2f6b5edbfa08c3581e97fb5a8934dd8a1bd54ba7746d00884996bad9668aa9a6bea98124fbe84869a6414c72e956684850ce73e89f38021bf22a4a250"} build_url:https://queue.taskcluster.net/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011154 build_url: 'https://queue.taskcluster.net/v1/task/HFr0QQczS8KDjDuuCzy9zQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe294301801ccecd5580688fc09a80233d4cfd3375b8f1b43fe6dee3e77143fe449bd9132f01d648e55cd6ed00ba1cda90e7ccba4f20b843cd178b331f1c8a51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a72fccf2f6b5edbfa08c3581e97fb5a8934dd8a1bd54ba7746d00884996bad9668aa9a6bea98124fbe84869a6414c72e956684850ce73e89f38021bf22a4a250"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 04:55:19.254104) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 04:55:19.254491) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NS793G2zXI/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.n6y7JiL8b4/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.004969 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 04:55:19.304290) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 04:55:19.304639) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 04:55:19.305076) ========= ========= Total master_lag: 0.25 =========