builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0020 starttime: 1455285616.0 results: success (0) buildid: 20160212034113 builduid: f1166ad52c5a4a4f9e122961e6a013b3 revision: 3eca89d56c0252b12f8c5dadade8e8e76d852258 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-12 06:00:15.998723) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-12 06:00:16.001798) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-12 06:00:16.002091) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Zf3lad0fuz/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.3cPxT4QTAL/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005643 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-12 06:00:16.055222) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-12 06:00:16.055541) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-12 06:00:16.090388) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 06:00:16.090730) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Zf3lad0fuz/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.3cPxT4QTAL/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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.005473 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 06:00:16.145968) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-12 06:00:16.146278) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-12 06:00:16.146698) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 06:00:16.147019) ========= 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.Zf3lad0fuz/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.3cPxT4QTAL/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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-02-12 06:00:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 39.1M=0s 2016-02-12 06:00:16 (39.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155362 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 06:00:16.319318) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 06:00:16.319654) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Zf3lad0fuz/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.3cPxT4QTAL/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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.025554 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 06:00:16.369128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-12 06:00:16.369498) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3eca89d56c0252b12f8c5dadade8e8e76d852258 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3eca89d56c0252b12f8c5dadade8e8e76d852258 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Zf3lad0fuz/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.3cPxT4QTAL/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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-02-12 06:00:16,437 truncating revision to first 12 chars 2016-02-12 06:00:16,437 Setting DEBUG logging. 2016-02-12 06:00:16,437 attempt 1/10 2016-02-12 06:00:16,437 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3eca89d56c02?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-12 06:00:17,456 unpacking tar archive at: mozilla-central-3eca89d56c02/testing/mozharness/ program finished with exit code 0 elapsedTime=1.257117 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-12 06:00:17.642620) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-12 06:00:17.643097) ========= echo 3eca89d56c0252b12f8c5dadade8e8e76d852258 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3eca89d56c0252b12f8c5dadade8e8e76d852258'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Zf3lad0fuz/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.3cPxT4QTAL/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 3eca89d56c0252b12f8c5dadade8e8e76d852258 program finished with exit code 0 elapsedTime=0.005614 script_repo_revision: '3eca89d56c0252b12f8c5dadade8e8e76d852258' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-12 06:00:17.694839) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-12 06:00:17.695133) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-12 06:00:17.735768) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-02-12 06:00:17.736059) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Zf3lad0fuz/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.3cPxT4QTAL/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 06:00:17 INFO - MultiFileLogger online at 20160212 06:00:17 in /builds/slave/test 06:00:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:00:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:00:17 INFO - {'append_to_log': False, 06:00:17 INFO - 'base_work_dir': '/builds/slave/test', 06:00:17 INFO - 'blob_upload_branch': 'Firefox', 06:00:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:00:17 INFO - 'branch': 'Firefox', 06:00:17 INFO - 'buildbot_json_path': 'buildprops.json', 06:00:17 INFO - 'config_files': ('talos/mac_config.py',), 06:00:17 INFO - 'default_actions': ('clobber', 06:00:17 INFO - 'read-buildbot-config', 06:00:17 INFO - 'download-and-extract', 06:00:17 INFO - 'populate-webroot', 06:00:17 INFO - 'create-virtualenv', 06:00:17 INFO - 'install', 06:00:17 INFO - 'run-tests'), 06:00:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:00:17 INFO - 'download_minidump_stackwalk': True, 06:00:17 INFO - 'download_symbols': 'ondemand', 06:00:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:00:17 INFO - 'tooltool.py': '/tools/tooltool.py', 06:00:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:00:17 INFO - '/tools/misc-python/virtualenv.py')}, 06:00:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:00:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:00:17 INFO - 'installer_path': 'installer.exe', 06:00:17 INFO - 'log_level': 'info', 06:00:17 INFO - 'log_name': 'talos', 06:00:17 INFO - 'log_to_console': True, 06:00:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:00:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:00:17 INFO - 'opt_config_files': (), 06:00:17 INFO - 'pip_index': False, 06:00:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:00:17 INFO - 'cmd': ('bash', 06:00:17 INFO - '-c', 06:00:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:00:17 INFO - 'enabled': True, 06:00:17 INFO - 'halt_on_failure': False, 06:00:17 INFO - 'name': 'check_screen_resolution'},), 06:00:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:00:17 INFO - 'cmd': ('bash', 06:00:17 INFO - '-c', 06:00:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:00:17 INFO - 'enabled': True, 06:00:17 INFO - 'halt_on_failure': False, 06:00:17 INFO - 'name': 'check_screen_resolution'},), 06:00:17 INFO - 'run_cmd_checks_enabled': True, 06:00:17 INFO - 'sps_profile': False, 06:00:17 INFO - 'sps_profile_interval': 0, 06:00:17 INFO - 'suite': 'dromaeojs-e10s', 06:00:17 INFO - 'system_bits': '32', 06:00:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:00:17 INFO - 'title': 't-yosemite-r7-0020', 06:00:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:00:17 INFO - 'use_talos_json': True, 06:00:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:00:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:00:17 INFO - 'work_dir': 'build'} 06:00:17 INFO - ##### 06:00:17 INFO - ##### Running clobber step. 06:00:17 INFO - ##### 06:00:17 INFO - Running pre-action listener: _resource_record_pre_action 06:00:17 INFO - Running main action method: clobber 06:00:17 INFO - rmtree: /builds/slave/test/build 06:00:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:00:19 INFO - Running post-action listener: _resource_record_post_action 06:00:19 INFO - ##### 06:00:19 INFO - ##### Running read-buildbot-config step. 06:00:19 INFO - ##### 06:00:19 INFO - Running pre-action listener: _resource_record_pre_action 06:00:19 INFO - Running main action method: read_buildbot_config 06:00:19 INFO - Using buildbot properties: 06:00:19 INFO - { 06:00:19 INFO - "project": "", 06:00:19 INFO - "product": "firefox", 06:00:19 INFO - "script_repo_revision": "production", 06:00:19 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 06:00:19 INFO - "repository": "", 06:00:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 06:00:19 INFO - "buildid": "20160212034113", 06:00:19 INFO - "pgo_build": "False", 06:00:19 INFO - "basedir": "/builds/slave/test", 06:00:19 INFO - "buildnumber": 128, 06:00:19 INFO - "slavename": "t-yosemite-r7-0020", 06:00:19 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 06:00:19 INFO - "platform": "yosemite_r7", 06:00:19 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:00:19 INFO - "branch": "mozilla-central", 06:00:19 INFO - "repo_path": "mozilla-central", 06:00:19 INFO - "revision": "3eca89d56c0252b12f8c5dadade8e8e76d852258", 06:00:19 INFO - "stage_platform": "macosx64", 06:00:19 INFO - "builduid": "f1166ad52c5a4a4f9e122961e6a013b3", 06:00:19 INFO - "slavebuilddir": "test" 06:00:19 INFO - } 06:00:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 06:00:19 INFO - Running post-action listener: _resource_record_post_action 06:00:19 INFO - ##### 06:00:19 INFO - ##### Running download-and-extract step. 06:00:19 INFO - ##### 06:00:19 INFO - Running pre-action listener: _resource_record_pre_action 06:00:19 INFO - Running main action method: download_and_extract 06:00:19 INFO - mkdir: /builds/slave/test/build/tests 06:00:19 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')]} 06:00:19 INFO - https://queue.taskcluster.net/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:00:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/test_packages.json 06:00:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/test_packages.json 06:00:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:00:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:00:24 INFO - Downloaded 1277 bytes. 06:00:24 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:00:24 INFO - Using the following test package requirements: 06:00:24 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:00:24 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:00:24 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 06:00:24 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:00:24 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 06:00:24 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:00:24 INFO - u'jsshell-mac.zip'], 06:00:24 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:00:24 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 06:00:24 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:00:24 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:00:24 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 06:00:24 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:00:24 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 06:00:24 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:00:24 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 06:00:24 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:00:24 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:00:24 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 06:00:24 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:00:24 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')]} 06:00:24 INFO - https://queue.taskcluster.net/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:00:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:00:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:00:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:00:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:00:26 INFO - Downloaded 17755023 bytes. 06:00:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:00:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:00:29 INFO - Return code: 0 06:00:29 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:00:29 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')]} 06:00:29 INFO - https://queue.taskcluster.net/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:00:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:00:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:00:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:00:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:00:35 INFO - Downloaded 17755023 bytes. 06:00:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:00:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:00:39 INFO - Return code: 0 06:00: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')]} 06:00:39 INFO - https://queue.taskcluster.net/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:00:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 06:00:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 06:00:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 06:00:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:00:40 INFO - Downloaded 10706547 bytes. 06:00:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:00:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:00:40 INFO - Return code: 0 06:00:40 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')]} 06:00:40 INFO - https://queue.taskcluster.net/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:00:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:00:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:00:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 06:00:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 06:00:45 INFO - Downloaded 111154659 bytes. 06:00:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:00:45 INFO - mkdir: /builds/slave/test/properties 06:00:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:00:45 INFO - Writing to file /builds/slave/test/properties/build_url 06:00:45 INFO - Contents: 06:00:45 INFO - build_url:https://queue.taskcluster.net/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:00:46 INFO - Running post-action listener: _resource_record_post_action 06:00:46 INFO - Running post-action listener: set_extra_try_arguments 06:00:46 INFO - ##### 06:00:46 INFO - ##### Running populate-webroot step. 06:00:46 INFO - ##### 06:00:46 INFO - Running pre-action listener: _resource_record_pre_action 06:00:46 INFO - Running main action method: populate_webroot 06:00:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:00:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:00:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:00:46 INFO - '--tppagecycles', 06:00:46 INFO - '7'], 06:00:46 INFO - 'tests': ['tsvgm']}}, 06:00:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:00:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:00:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:00:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:00:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:00:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:00:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:00:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:46 INFO - 'talos_options': ['--e10s'], 06:00:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:00:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:46 INFO - 'tests': ['damp', 'tps']}, 06:00:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:46 INFO - 'talos_options': ['--e10s'], 06:00:46 INFO - 'tests': ['damp', 'tps']}, 06:00:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:00:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:00:46 INFO - 'other': {'tests': ['a11yr', 06:00:46 INFO - 'ts_paint', 06:00:46 INFO - 'tpaint', 06:00:46 INFO - 'sessionrestore', 06:00:46 INFO - 'sessionrestore_no_auto_restore']}, 06:00:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:00:46 INFO - 'tests': ['a11yr', 06:00:46 INFO - 'ts_paint', 06:00:46 INFO - 'tpaint', 06:00:46 INFO - 'sessionrestore', 06:00:46 INFO - 'sessionrestore_no_auto_restore']}, 06:00:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:00:46 INFO - 'tests': ['a11yr', 06:00:46 INFO - 'ts_paint', 06:00:46 INFO - 'tpaint', 06:00:46 INFO - 'sessionrestore', 06:00:46 INFO - 'sessionrestore_no_auto_restore']}, 06:00:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:00:46 INFO - 'tests': ['a11yr', 06:00:46 INFO - 'ts_paint', 06:00:46 INFO - 'tpaint', 06:00:46 INFO - 'sessionrestore', 06:00:46 INFO - 'sessionrestore_no_auto_restore']}, 06:00:46 INFO - 'other_l64': {'tests': ['a11yr', 06:00:46 INFO - 'ts_paint', 06:00:46 INFO - 'tpaint', 06:00:46 INFO - 'sessionrestore', 06:00:46 INFO - 'sessionrestore_no_auto_restore']}, 06:00:46 INFO - 'other_nol64': {'tests': ['a11yr', 06:00:46 INFO - 'ts_paint', 06:00:46 INFO - 'tpaint', 06:00:46 INFO - 'sessionrestore', 06:00:46 INFO - 'sessionrestore_no_auto_restore']}, 06:00:46 INFO - 'svgr': {'tests': ['tsvgx', 06:00:46 INFO - 'tsvgr_opacity', 06:00:46 INFO - 'tart', 06:00:46 INFO - 'tscrollx', 06:00:46 INFO - 'cart']}, 06:00:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:00:46 INFO - 'tests': ['tsvgx', 06:00:46 INFO - 'tsvgr_opacity', 06:00:46 INFO - 'tart', 06:00:46 INFO - 'tscrollx', 06:00:46 INFO - 'cart']}, 06:00:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:46 INFO - 'tests': ['tp5o']}, 06:00:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:46 INFO - 'talos_options': ['--e10s'], 06:00:46 INFO - 'tests': ['tp5o']}, 06:00:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:46 INFO - 'talos_options': ['--xperf_path', 06:00:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:00:46 INFO - 'tests': ['tp5n']}, 06:00:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:46 INFO - 'talos_options': ['--e10s', 06:00:46 INFO - '--xperf_path', 06:00:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:00:46 INFO - 'tests': ['tp5n']}}, 06:00:46 INFO - 'talos.zip': {'path': '', 06:00:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:00:46 INFO - Running post-action listener: _resource_record_post_action 06:00:46 INFO - ##### 06:00:46 INFO - ##### Running create-virtualenv step. 06:00:46 INFO - ##### 06:00:46 INFO - Running pre-action listener: _resource_record_pre_action 06:00:46 INFO - Running main action method: create_virtualenv 06:00:46 INFO - Creating virtualenv /builds/slave/test/build/venv 06:00: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 06:00:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:00:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:00:46 INFO - Using real prefix '/tools/python27' 06:00:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:00:47 INFO - Installing distribute.............................................................................................................................................................................................done. 06:00:50 INFO - Installing pip.................done. 06:00:50 INFO - Return code: 0 06:00:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:00: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')]} 06:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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')]} 06:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1b9cf13b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8a5d30>, '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 0x10b6c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b89cb20>, '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.Zf3lad0fuz/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.3cPxT4QTAL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 06:00: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', 'pip>=1.5'] in /builds/slave/test/build 06:00: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 pip>=1.5 06:00:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zf3lad0fuz/Render', 06:00:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:50 INFO - 'HOME': '/Users/cltbld', 06:00:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:50 INFO - 'LOGNAME': 'cltbld', 06:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:50 INFO - 'MOZ_NO_REMOTE': '1', 06:00:50 INFO - 'NO_EM_RESTART': '1', 06:00:50 INFO - 'PAGER': '/bin/cat', 06:00:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:50 INFO - 'PWD': '/builds/slave/test', 06:00:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:50 INFO - 'SHELL': '/bin/bash', 06:00:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3cPxT4QTAL/Listeners', 06:00:50 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 06:00:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:50 INFO - 'USER': 'cltbld', 06:00:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:50 INFO - 'XPC_FLAGS': '0x0', 06:00:50 INFO - 'XPC_SERVICE_NAME': '0', 06:00:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00: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 06:00:50 INFO - Cleaning up... 06:00:50 INFO - Return code: 0 06:00:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:00: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')]} 06:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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')]} 06:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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 0x10ba01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1b9cf13b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8a5d30>, '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 0x10b6c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b89cb20>, '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.Zf3lad0fuz/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.3cPxT4QTAL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 06:00: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 06:00: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 06:00:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zf3lad0fuz/Render', 06:00:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:50 INFO - 'HOME': '/Users/cltbld', 06:00:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:50 INFO - 'LOGNAME': 'cltbld', 06:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:50 INFO - 'MOZ_NO_REMOTE': '1', 06:00:50 INFO - 'NO_EM_RESTART': '1', 06:00:50 INFO - 'PAGER': '/bin/cat', 06:00:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:50 INFO - 'PWD': '/builds/slave/test', 06:00:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:50 INFO - 'SHELL': '/bin/bash', 06:00:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3cPxT4QTAL/Listeners', 06:00:50 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 06:00:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:50 INFO - 'USER': 'cltbld', 06:00:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:50 INFO - 'XPC_FLAGS': '0x0', 06:00:50 INFO - 'XPC_SERVICE_NAME': '0', 06:00:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:50 INFO - Downloading/unpacking psutil>=0.7.1 06:00: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 06:00: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 06:00: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 06:00: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 06:00: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 06:00: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 06:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:00:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:00:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:00:53 INFO - Installing collected packages: psutil 06:00:53 INFO - Running setup.py install for psutil 06:00:54 INFO - building 'psutil._psutil_osx' extension 06:00: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:00: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 06:00: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 06:00: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 06:00:54 INFO - building 'psutil._psutil_posix' extension 06:00: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 06:00:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:00:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:00:54 INFO - ^ 06:00:54 INFO - 1 warning generated. 06:00: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 06:00:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:00:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:00:55 INFO - Successfully installed psutil 06:00:55 INFO - Cleaning up... 06:00:55 INFO - Return code: 0 06:00:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:00: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')]} 06:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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')]} 06:00:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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 0x10ba01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1b9cf13b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8a5d30>, '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 0x10b6c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b89cb20>, '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.Zf3lad0fuz/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.3cPxT4QTAL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 06:00: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 06:00: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 06:00:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zf3lad0fuz/Render', 06:00:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:55 INFO - 'HOME': '/Users/cltbld', 06:00:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:55 INFO - 'LOGNAME': 'cltbld', 06:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:55 INFO - 'MOZ_NO_REMOTE': '1', 06:00:55 INFO - 'NO_EM_RESTART': '1', 06:00:55 INFO - 'PAGER': '/bin/cat', 06:00:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:55 INFO - 'PWD': '/builds/slave/test', 06:00:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:55 INFO - 'SHELL': '/bin/bash', 06:00:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3cPxT4QTAL/Listeners', 06:00:55 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 06:00:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:55 INFO - 'USER': 'cltbld', 06:00:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:55 INFO - 'XPC_FLAGS': '0x0', 06:00:55 INFO - 'XPC_SERVICE_NAME': '0', 06:00:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:00: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 06:00: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 06:00: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 06:00: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 06:00: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 06:00: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 06:00:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:00:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:00: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) 06:00:57 INFO - Installing collected packages: mozsystemmonitor 06:00:57 INFO - Running setup.py install for mozsystemmonitor 06:00:57 INFO - Successfully installed mozsystemmonitor 06:00:57 INFO - Cleaning up... 06:00:57 INFO - Return code: 0 06:00:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:00:57 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')]} 06:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:57 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')]} 06:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:57 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 0x10ba01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1b9cf13b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8a5d30>, '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 0x10b6c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b89cb20>, '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.Zf3lad0fuz/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.3cPxT4QTAL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 06:00:57 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 06:00:57 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 06:00:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zf3lad0fuz/Render', 06:00:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:57 INFO - 'HOME': '/Users/cltbld', 06:00:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:57 INFO - 'LOGNAME': 'cltbld', 06:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:57 INFO - 'MOZ_NO_REMOTE': '1', 06:00:57 INFO - 'NO_EM_RESTART': '1', 06:00:57 INFO - 'PAGER': '/bin/cat', 06:00:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:57 INFO - 'PWD': '/builds/slave/test', 06:00:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:57 INFO - 'SHELL': '/bin/bash', 06:00:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3cPxT4QTAL/Listeners', 06:00:57 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 06:00:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:57 INFO - 'USER': 'cltbld', 06:00:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:57 INFO - 'XPC_FLAGS': '0x0', 06:00:57 INFO - 'XPC_SERVICE_NAME': '0', 06:00:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:58 INFO - Downloading/unpacking blobuploader==1.2.4 06:00: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 06:00: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 06:00: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 06:00: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 06:00: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 06:00: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 06:01:00 INFO - Downloading blobuploader-1.2.4.tar.gz 06:01:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:01:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:01: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 06:01: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 06:01: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 06:01: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 06:01: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 06:01: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 06:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:01:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:01: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 06:01: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 06:01: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 06:01: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 06:01: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 06:01: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 06:01:01 INFO - Downloading docopt-0.6.1.tar.gz 06:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:01:01 INFO - Installing collected packages: blobuploader, requests, docopt 06:01:01 INFO - Running setup.py install for blobuploader 06:01:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:01:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:01:01 INFO - Running setup.py install for requests 06:01:02 INFO - Running setup.py install for docopt 06:01:02 INFO - Successfully installed blobuploader requests docopt 06:01:02 INFO - Cleaning up... 06:01:02 INFO - Return code: 0 06:01:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:01: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')]} 06:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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')]} 06:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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 0x10ba01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1b9cf13b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8a5d30>, '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 0x10b6c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b89cb20>, '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.Zf3lad0fuz/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.3cPxT4QTAL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 06:01: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 06:01: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 06:01:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zf3lad0fuz/Render', 06:01:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:01:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:01:02 INFO - 'HOME': '/Users/cltbld', 06:01:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:01:02 INFO - 'LOGNAME': 'cltbld', 06:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:02 INFO - 'MOZ_NO_REMOTE': '1', 06:01:02 INFO - 'NO_EM_RESTART': '1', 06:01:02 INFO - 'PAGER': '/bin/cat', 06:01:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:02 INFO - 'PWD': '/builds/slave/test', 06:01:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:01:02 INFO - 'SHELL': '/bin/bash', 06:01:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3cPxT4QTAL/Listeners', 06:01:02 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 06:01:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:01:02 INFO - 'USER': 'cltbld', 06:01:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:01:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:02 INFO - 'XPC_FLAGS': '0x0', 06:01:02 INFO - 'XPC_SERVICE_NAME': '0', 06:01:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:01:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:01:02 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-R43auA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:01:02 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-jnzoP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:01:03 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-1FsAjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:01:03 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-sgxU4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:01:03 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-GvwoBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:01:03 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-VOZUN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:01:03 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-JRGQY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:01:03 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-YIz430-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:01:03 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-z6rh8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:01:03 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-2c1TLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:01:03 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-SQyzlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:01:04 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-LDwhCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:01:04 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Gv3MF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:01:04 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-yK4Dyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:04 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-ukNXkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:01:04 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-0mwN62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:01:04 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-PJkUqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:01:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:01:04 INFO - Running setup.py install for manifestparser 06:01:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:01:04 INFO - Running setup.py install for mozcrash 06:01:04 INFO - Running setup.py install for mozdebug 06:01:05 INFO - Running setup.py install for mozdevice 06:01:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:01:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:01:05 INFO - Running setup.py install for mozfile 06:01:05 INFO - Running setup.py install for mozhttpd 06:01:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:01:05 INFO - Running setup.py install for mozinfo 06:01:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:01:05 INFO - Running setup.py install for mozInstall 06:01:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:01:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:01:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:01:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:01:05 INFO - Running setup.py install for mozleak 06:01:05 INFO - Running setup.py install for mozlog 06:01:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:01:06 INFO - Running setup.py install for moznetwork 06:01:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:01:06 INFO - Running setup.py install for mozprocess 06:01:06 INFO - Running setup.py install for mozprofile 06:01:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:01:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:01:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:01:06 INFO - Running setup.py install for mozrunner 06:01:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:01:06 INFO - Running setup.py install for mozscreenshot 06:01:06 INFO - Running setup.py install for moztest 06:01:07 INFO - Running setup.py install for mozversion 06:01:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:01:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:01:07 INFO - Cleaning up... 06:01:07 INFO - Return code: 0 06:01:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:01: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')]} 06:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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')]} 06:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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 0x10ba01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1b9cf13b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8a5d30>, '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 0x10b6c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b89cb20>, '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.Zf3lad0fuz/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.3cPxT4QTAL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 06:01: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 06:01: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 06:01:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zf3lad0fuz/Render', 06:01:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:01:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:01:07 INFO - 'HOME': '/Users/cltbld', 06:01:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:01:07 INFO - 'LOGNAME': 'cltbld', 06:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:07 INFO - 'MOZ_NO_REMOTE': '1', 06:01:07 INFO - 'NO_EM_RESTART': '1', 06:01:07 INFO - 'PAGER': '/bin/cat', 06:01:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:07 INFO - 'PWD': '/builds/slave/test', 06:01:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:01:07 INFO - 'SHELL': '/bin/bash', 06:01:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3cPxT4QTAL/Listeners', 06:01:07 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 06:01:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:01:07 INFO - 'USER': 'cltbld', 06:01:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:01:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:07 INFO - 'XPC_FLAGS': '0x0', 06:01:07 INFO - 'XPC_SERVICE_NAME': '0', 06:01:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:01:07 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-zDnJUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:01: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)) 06:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:01:07 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-ocu55F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 06:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:01:07 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-gN6onX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:01: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)) 06:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:01:07 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-HKkDuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:01:07 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)) 06:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:01:07 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-jzUmB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:01: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)) 06:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:01:08 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-7lZGzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:01: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)) 06:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:01:08 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Wq0GUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:01: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)) 06:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:01:08 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-c0gD1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:01: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)) 06:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:01:08 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-q1_S9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:01: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)) 06:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:01:08 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-lw64ex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:01: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)) 06:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:01:08 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-xcqtF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:01: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)) 06:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:01:08 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Luc4Bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:01: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)) 06:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:01:08 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-u5sMa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:01:08 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)) 06:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:01:08 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-4hd2nO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:01: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)) 06:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:09 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-X5_OAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:01: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)) 06:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:01:09 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Q86e3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:01: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)) 06:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:01:09 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-BuMieK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:01: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)) 06:01: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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:01: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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:01: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)) 06:01: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)) 06:01: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)) 06:01:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:01: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 06:01: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 06:01: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 06:01: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 06:01: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 06:01: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 06:01:11 INFO - Downloading blessings-1.6.tar.gz 06:01:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:01:11 INFO - Installing collected packages: blessings 06:01:11 INFO - Running setup.py install for blessings 06:01:11 INFO - Successfully installed blessings 06:01:11 INFO - Cleaning up... 06:01:11 INFO - Return code: 0 06:01:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:01:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:01:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:01:12 INFO - Reading from file tmpfile_stdout 06:01:12 INFO - Current package versions: 06:01:12 INFO - blessings == 1.6 06:01:12 INFO - blobuploader == 1.2.4 06:01:12 INFO - docopt == 0.6.1 06:01:12 INFO - manifestparser == 1.1 06:01:12 INFO - mozInstall == 1.12 06:01:12 INFO - mozcrash == 0.16 06:01:12 INFO - mozdebug == 0.1 06:01:12 INFO - mozdevice == 0.48 06:01:12 INFO - mozfile == 1.2 06:01:12 INFO - mozhttpd == 0.7 06:01:12 INFO - mozinfo == 0.9 06:01:12 INFO - mozleak == 0.1 06:01:12 INFO - mozlog == 3.1 06:01:12 INFO - moznetwork == 0.27 06:01:12 INFO - mozprocess == 0.22 06:01:12 INFO - mozprofile == 0.28 06:01:12 INFO - mozrunner == 6.11 06:01:12 INFO - mozscreenshot == 0.1 06:01:12 INFO - mozsystemmonitor == 0.0 06:01:12 INFO - moztest == 0.7 06:01:12 INFO - mozversion == 1.4 06:01:12 INFO - psutil == 3.1.1 06:01:12 INFO - requests == 1.2.3 06:01:12 INFO - wsgiref == 0.1.2 06:01:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:01: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')]} 06:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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')]} 06:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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 0x10ba01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1b9cf13b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8a5d30>, '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 0x10b6c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b89cb20>, '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.Zf3lad0fuz/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.3cPxT4QTAL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 06:01: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 06:01: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 06:01:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zf3lad0fuz/Render', 06:01:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:01:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:01:12 INFO - 'HOME': '/Users/cltbld', 06:01:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:01:12 INFO - 'LOGNAME': 'cltbld', 06:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:12 INFO - 'MOZ_NO_REMOTE': '1', 06:01:12 INFO - 'NO_EM_RESTART': '1', 06:01:12 INFO - 'PAGER': '/bin/cat', 06:01:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:12 INFO - 'PWD': '/builds/slave/test', 06:01:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:01:12 INFO - 'SHELL': '/bin/bash', 06:01:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3cPxT4QTAL/Listeners', 06:01:12 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 06:01:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:01:12 INFO - 'USER': 'cltbld', 06:01:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:01:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:12 INFO - 'XPC_FLAGS': '0x0', 06:01:12 INFO - 'XPC_SERVICE_NAME': '0', 06:01:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01: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)) 06:01: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)) 06:01: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)) 06:01: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)) 06:01: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)) 06:01: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)) 06:01: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)) 06:01: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)) 06:01: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)) 06:01: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)) 06:01: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)) 06:01:12 INFO - Cleaning up... 06:01:12 INFO - Return code: 0 06:01:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:01: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')]} 06:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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')]} 06:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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 0x10ba01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1b9cf13b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8a5d30>, '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 0x10b6c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b89cb20>, '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.Zf3lad0fuz/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.3cPxT4QTAL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 06:01: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 06:01: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 06:01:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zf3lad0fuz/Render', 06:01:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:01:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:01:12 INFO - 'HOME': '/Users/cltbld', 06:01:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:01:12 INFO - 'LOGNAME': 'cltbld', 06:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:12 INFO - 'MOZ_NO_REMOTE': '1', 06:01:12 INFO - 'NO_EM_RESTART': '1', 06:01:12 INFO - 'PAGER': '/bin/cat', 06:01:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:12 INFO - 'PWD': '/builds/slave/test', 06:01:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:01:12 INFO - 'SHELL': '/bin/bash', 06:01:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3cPxT4QTAL/Listeners', 06:01:12 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 06:01:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:01:12 INFO - 'USER': 'cltbld', 06:01:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:01:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:12 INFO - 'XPC_FLAGS': '0x0', 06:01:12 INFO - 'XPC_SERVICE_NAME': '0', 06:01:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:12 INFO - Downloading/unpacking jsonschema 06:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:12 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 06:01:12 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 06:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:01:15 INFO - Downloading/unpacking functools32 (from jsonschema) 06:01: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 06:01: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 06:01: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 06:01: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 06:01: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 06:01: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 06:01:15 INFO - Downloading functools32-3.2.3-2.tar.gz 06:01:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:01:15 INFO - warning: no files found matching '*.txt' 06:01:15 INFO - no previously-included directories found matching 'build' 06:01:15 INFO - no previously-included directories found matching 'dist' 06:01:15 INFO - no previously-included directories found matching '.git*' 06:01:15 INFO - Installing collected packages: jsonschema, functools32 06:01:15 INFO - Running setup.py install for functools32 06:01:15 INFO - warning: no files found matching '*.txt' 06:01:15 INFO - no previously-included directories found matching 'build' 06:01:15 INFO - no previously-included directories found matching 'dist' 06:01:15 INFO - no previously-included directories found matching '.git*' 06:01:15 INFO - Successfully installed jsonschema functools32 06:01:15 INFO - Cleaning up... 06:01:15 INFO - Return code: 0 06:01:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:01:15 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')]} 06:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:15 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')]} 06:01:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:15 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 0x10ba01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1b9cf13b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8a5d30>, '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 0x10b6c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b89cb20>, '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.Zf3lad0fuz/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.3cPxT4QTAL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 06:01:15 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 06:01:15 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 06:01:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zf3lad0fuz/Render', 06:01:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:01:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:01:15 INFO - 'HOME': '/Users/cltbld', 06:01:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:01:15 INFO - 'LOGNAME': 'cltbld', 06:01:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:15 INFO - 'MOZ_NO_REMOTE': '1', 06:01:15 INFO - 'NO_EM_RESTART': '1', 06:01:15 INFO - 'PAGER': '/bin/cat', 06:01:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:01:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:15 INFO - 'PWD': '/builds/slave/test', 06:01:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:01:15 INFO - 'SHELL': '/bin/bash', 06:01:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3cPxT4QTAL/Listeners', 06:01:15 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 06:01:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:01:15 INFO - 'USER': 'cltbld', 06:01:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:01:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:01:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:15 INFO - 'XPC_FLAGS': '0x0', 06:01:15 INFO - 'XPC_SERVICE_NAME': '0', 06:01:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:01:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:16 INFO - Downloading/unpacking flake8 06:01: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 06:01: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 06:01: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 06:01: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 06:01: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 06:01: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 06:01:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:01:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:01:18 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 06:01:18 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 06:01:18 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 06:01:18 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 06:01:18 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 06:01:18 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 06:01:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:01:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:01:18 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 06:01:18 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 06:01:18 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 06:01:18 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 06:01:18 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 06:01:18 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 06:01:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:01: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 06:01: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 06:01: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 06:01: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 06:01: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 06:01: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 06:01:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:01:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:01:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:01:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:01:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:01:19 INFO - no previously-included directories found matching 'docs/_build' 06:01:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:01:19 INFO - Running setup.py install for pep8 06:01:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:01:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:01:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:01:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:01:19 INFO - no previously-included directories found matching 'docs/_build' 06:01:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:01:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:01:19 INFO - Cleaning up... 06:01:19 INFO - Return code: 0 06:01:19 INFO - Running post-action listener: _resource_record_post_action 06:01:19 INFO - Running post-action listener: _start_resource_monitoring 06:01:19 INFO - Starting resource monitoring. 06:01:19 INFO - ##### 06:01:19 INFO - ##### Running install step. 06:01:19 INFO - ##### 06:01:19 INFO - Running pre-action listener: _resource_record_pre_action 06:01:19 INFO - Running main action method: install 06:01:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:01:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:01:20 INFO - Reading from file tmpfile_stdout 06:01:20 INFO - Detecting whether we're running mozinstall >=1.0... 06:01:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:01:20 INFO - Reading from file tmpfile_stdout 06:01:20 INFO - Output received: 06:01:20 INFO - Usage: mozinstall [options] installer 06:01:20 INFO - Options: 06:01:20 INFO - -h, --help show this help message and exit 06:01:20 INFO - -d DEST, --destination=DEST 06:01:20 INFO - Directory to install application into. [default: 06:01:20 INFO - "/builds/slave/test"] 06:01:20 INFO - --app=APP Application being installed. [default: firefox] 06:01:20 INFO - mkdir: /builds/slave/test/build/application 06:01:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:01:54 INFO - Reading from file tmpfile_stdout 06:01:54 INFO - Output received: 06:01:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:01:54 INFO - Running post-action listener: _resource_record_post_action 06:01:54 INFO - ##### 06:01:54 INFO - ##### Running run-tests step. 06:01:54 INFO - ##### 06:01:54 INFO - Running pre-action listener: _resource_record_pre_action 06:01:54 INFO - Running main action method: run_tests 06:01:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:01:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:01:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:01:54 INFO - 2016-02-12 06:01:54.173 screenresolution[1661:8705] starting screenresolution argv=screenresolution get 06:01:54 INFO - 2016-02-12 06:01:54.176 screenresolution[1661:8705] Display 0: 1600x1200x32@60 06:01:54 INFO - 2016-02-12 06:01:54.182 screenresolution[1662:8707] starting screenresolution argv=screenresolution list 06:01:54 INFO - Available Modes on Display 0 06:01:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:01:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:01:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:01:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:01:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:01:54 INFO - Intel Iris: 06:01:54 INFO - Chipset Model: Intel Iris 06:01:54 INFO - Type: GPU 06:01:54 INFO - Bus: Built-In 06:01:54 INFO - VRAM (Dynamic, Max): 1536 MB 06:01:54 INFO - Vendor: Intel (0x8086) 06:01:54 INFO - Device ID: 0x0a2e 06:01:54 INFO - Revision ID: 0x0009 06:01:54 INFO - Displays: 06:01:54 INFO - Display: 06:01:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:01:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:01:54 INFO - Display Serial Number: 1600x1200 60 06:01:54 INFO - Main Display: Yes 06:01:54 INFO - Mirror: Off 06:01:54 INFO - Online: Yes 06:01:54 INFO - Rotation: Supported 06:01:54 INFO - Return code: 0 06:01:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:01:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:01:54 INFO - Python 2.7.3 06:01:54 INFO - Return code: 0 06:01:54 INFO - grabbing minidump binary from tooltool 06:01:54 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')]} 06:01:54 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 0x10b8a5d30>, '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 0x10b6c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b89cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:01:54 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 06:01:54 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 06:01:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:01:54 INFO - Return code: 0 06:01:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:01:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:01:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:01:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:01:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:01:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:01:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:01:55 INFO - Return code: 0 06:01:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:01:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zf3lad0fuz/Render', 06:01:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:01:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:01:55 INFO - 'HOME': '/Users/cltbld', 06:01:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:01:55 INFO - 'LOGNAME': 'cltbld', 06:01:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:01:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:55 INFO - 'MOZ_NO_REMOTE': '1', 06:01:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:01:55 INFO - 'NO_EM_RESTART': '1', 06:01:55 INFO - 'PAGER': '/bin/cat', 06:01:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:55 INFO - 'PWD': '/builds/slave/test', 06:01:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:01:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:01:55 INFO - 'SHELL': '/bin/bash', 06:01:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3cPxT4QTAL/Listeners', 06:01:55 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 06:01:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:01:55 INFO - 'USER': 'cltbld', 06:01:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:01:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:55 INFO - 'XPC_FLAGS': '0x0', 06:01:55 INFO - 'XPC_SERVICE_NAME': '0', 06:01:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:01:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:01:55 INFO - mozversion application_buildid: 20160212034113 06:01:55 INFO - mozversion application_changeset: 3eca89d56c0252b12f8c5dadade8e8e76d852258 06:01:55 INFO - mozversion application_display_name: Nightly 06:01:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:01:55 INFO - mozversion application_name: Firefox 06:01:55 INFO - mozversion application_remotingname: firefox 06:01:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:01:55 INFO - mozversion application_vendor: Mozilla 06:01:55 INFO - mozversion application_version: 47.0a1 06:01:55 INFO - mozversion platform_buildid: 20160212034113 06:01:55 INFO - mozversion platform_changeset: 3eca89d56c0252b12f8c5dadade8e8e76d852258 06:01:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:01:55 INFO - mozversion platform_version: 47.0a1 06:01:55 INFO - using testdate: 1455285715 06:01:55 INFO - actual date: 1455285715 06:01:56 INFO - starting webserver on 'localhost:49288' 06:01:56 INFO - SUITE-START | Running 2 tests 06:01:56 INFO - TEST-START | dromaeo_css 06:01:56 INFO - operating with platform_type : mac_ 06:01:56 INFO - Initialising browser for dromaeo_css test... 06:01:56 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpcLlUle/profile http://localhost:49288/getInfo.html) 06:01:59 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 06:01:59 INFO - PROCESS | 1680 | colorDepth:24 06:01:59 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 06:01:59 INFO - PROCESS | 1680 | __metrics 06:02:00 INFO - TEST-INFO | 1680: exit 0 06:02:00 INFO - Browser initialized. 06:02:00 INFO - Running cycle 1/1 for dromaeo_css test... 06:02:00 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpcLlUle/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:02:12 INFO - PROCESS | 1685 | RSS: Main: 257490944 06:02:12 INFO - PROCESS | 1685 | 06:03:01 INFO - PROCESS | 1685 | 1455285781899 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] 06:05:11 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49288/tests/dromaeo/cssquery-ext.html) 06:05:12 INFO - PROCESS | 1685 | RSS: Main: 271310848 06:05:12 INFO - PROCESS | 1685 | 06:08:14 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-ext.html (next: http://localhost:49288/tests/dromaeo/cssquery-jquery.html) 06:08:15 INFO - PROCESS | 1685 | RSS: Main: 283504640 06:08:15 INFO - PROCESS | 1685 | 06:11:17 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49288/tests/dromaeo/cssquery-mootools.html) 06:11:17 INFO - PROCESS | 1685 | RSS: Main: 284917760 06:11:17 INFO - PROCESS | 1685 | 06:14:19 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49288/tests/dromaeo/cssquery-prototype.html) 06:14:20 INFO - PROCESS | 1685 | RSS: Main: 286461952 06:14:20 INFO - PROCESS | 1685 | 06:17:22 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49288/tests/dromaeo/cssquery-yui.html) 06:17:23 INFO - PROCESS | 1685 | RSS: Main: 287981568 06:17:23 INFO - PROCESS | 1685 | 06:20:25 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-yui.html (next: http://localhost:49288/tests/dromaeo/cssquery-dojo.html) 06:20:26 INFO - PROCESS | 1685 | RSS: Main: 291827712 06:20:26 INFO - PROCESS | 1685 | 06:20:26 INFO - PROCESS | 1685 | __start_tp_report 06:20:26 INFO - PROCESS | 1685 | _x_x_mozilla_page_load 06:20:26 INFO - PROCESS | 1685 | _x_x_mozilla_page_load_details 06:20:26 INFO - PROCESS | 1685 | |i|pagename|runs| 06:20:26 INFO - PROCESS | 1685 | |0;dojo.html;3506.736994725396;3527.911802204946;3530.947035794463;3577.463380492926;3578.964210357897;5725.62783419078;5771.711414429283;5786.942130578693;5788.884222315556;5809.477147056764;4553.68124231304;5680.119581464869;5719.399463056381;5773.9422605773925;5884.558658100649;5176.870578235536;5210.192420174879;5214.087534681435;5250.7112108834;5301.602379821509;527.5881987976293;5059.494050594948;5151.072806894757;5208.921866172011;5239.13554263546;5185.351831021104;5223.164293713006;5228.5555727763185;5231.973840130813;5236.973815130938;5212.983468223698;5222.268882356473;5222.477752224785;5231.319928409321;5309;5119.59043276537;5122.33409656746;5161.922571161435;5229.895402091975;5246.7901283948595;5026.843825920059;5119.616028797818;5681.829545113653;5718.342390625048;5795.594308398414;4673.878269215398;6150.7390984848;6231.719572619198;6276.717547710364;6300.180976473075;6236.719347629322;6242.531810114259;6257.468115210213;6269.62382257066;6270.46701030413;5870.97064514679;5871.943050250953;5887.793927212527;5902.055671092648;5941.19793827832;6153.84615384619;6185.381461853779;6274.874502509924;6283.277423096402;6290.025046117859;6193.81418557444;6193.969030154821;6200.782972595937;6200.937990620036;6221.782237621662;6247.531435142382;6281.8743625127245;6292.244930608356;6293.968530157412;6321.747130114744;6071.939280607226;6150.600210986271;6253.5622506425025;6263.96868015657;6293.527985401113;6242.812715618538;6250.656213908188;6290.119383286344;6309.495240380758;6337.366263373626;4833.564979151823;4882.658213924991;4924.9507504925205;4932.284818701268;4968.130577148984;4407.669424793154;4409.581089796464;4421.159979603865;4422.778861056934;4445.066536027406;5667.914981275284;5706.771729130788;5739.311282646026;5745.569082318759;5748.7125643717645;4876.975835074603;5596.188552659842;6139.29398119222;6169.96915015431;6172.9074063889075;5298.708571028554;5325.641961299843;5734.369219385864;5749.281339832521;5754.309482862;5289.3917199521775;5391.649542779707;5406.756695948692;5413.864653383697;5448.318960129984;6290.968545157245;6335.68321583919;6344.206974128234;6349.079383489368;6356.713947872357;6164.137020816999;6192.59748116371;6198.256209254738;6211.81364559064;6296.212973378328;6145.494353883327;6250.3749625037135;6320.494360451061;6327.272363678052;6543.476521878143;4674.485806561343;5134.922976155286;6236.220472440945;6246.469050130608;6254.655993920378;6243.562950593597;6271.372862713874;6285.308616052322;6295.276043254901;6298.08677741734;5999.340072592098;6101.974255744823;6131.693415329305;6198.256209254918;6222.62664240147;6069.423404776539;6112.938870611415;6126.264848218242;6147.354527774698;6167.229096362955;5904.3800400959;5934.020886553671;6090.390960903874;6099.320418295802;6126.754929802758;5695.515881150149;6177.073438984188;6185.041318595625;6189.752409903554;6212.192414986023;6026.969865150646;6050.364711705383;6069.848253793691;6070.908936366046;6093.268807743099 06:20:26 INFO - PROCESS | 1685 | |1;ext.html;423.7245790236344;489.9779509922053;499.89752100819334;569.018443185505;603.4960807725549;36924.07689807756;37000.814995924986;37009.814950925276;37133.25733485329;37206.62793372066;31679.524807127913;38086.857394278144;38434.8078259609;38638.613613863854;38711.22577548454;9378.906210937888;9599.712008639752;9630.374025688308;9656.662016829412;9675.806483870318;9464.905350946507;9686;9711.271654625896;9721.513924303792;9772.413655180677;9560.569774360136;9683.612655493807;9738.02619738024;9757.853632195523;9760.804783904317;9630.47032413217;9677.612895484137;9699.272554558402;9699.90300096997;9714.659986900424;9482.905170948272;9548.331616786827;9581.137697607248;9613.471259080748;9619.94180640136;36947.4457883132;37176.81411592925;37201.06997325089;37276.81361593202;37408.064798379986;2763.7098104698916;2803.8457884816326;3290.4077266092095;3344.615369232545;3436.621971583124;26459.735402645918;27634.170974870583;28091.71908280932;28174.154775356772;28538.71461285381;2756.9724302756917;2812.086072026579;2844.6586409630977;2853.2296280004284;2937.206954122375;490979;493259;493540;493548;495288.5235573835;56306.43693563012;64500;64632.76836158173;64882.026769598495;65833;62153.68923155355;62187;62315.6884215576;62508.687456562424;62973.370266297665;13204.801927971088;15770;15970.441034563966;15974.36102555908;15998.9200053999;10732.302400343953;10762.623308184176;12126.454309556091;12167.634970950885;12335.259884406785;16849;20050.699239511418;20184.798152018586;20208.66557018105;20388.79611203869;7242.311980361857;8279.58602069894;8772.517511536927;8942.46345219289;9032.277417806692;944.8771659684197;952.2477242978108;995;1004.4977511244377;1069.7218723132041;27839.30401739973;28789.568156477668;28893;29185.708142918724;29389.706102939126;963.1764841060932;1036.6164519127972;1088.77135801481;1129.0685184722636;1154.6016624264614;14572.489962851248;14711.55865324042;14793.260336983109;14965.850341496664;15058.32237549313;462834;534086;538721;539048;540352.0876769294;55846;55940;56188.43811561832;56466;56478.152827707614;1260.861305256421;1404.56458497866;1448.8696017358277;1453.6729235921832;1457.5700168450333;25273;27554.862225688743;28550;28932.855335723187;29092.854535727187;46773.53226467828;46876.29685554651;46964.7651761739;46995;47273;501599;506782;507253;510722;511275;32416.513752293264;42127.789361053;43214.78392608017;43387.04758285821;43454;44408.77795611001;44994.77502612466;45470.54529454663;45668.77165614284;46294.305585415575;34082.65917340795;34976.65023349734;35252;35396.82301588476;35570.822145889106;33279.33441331112;34829.78095766636;35083.64916350804;35391.11522211965;36665.81667091647;35886.64113358833;36172;36227.45658815067;36718.26563468769;37471.250574988895;30273.24316892095;31572.947758395632;32130.518042229854;32186.35627287394;32714.836425817717;24326.39184020343;24838.751612484368;25010.74989250084;25129.74870251274;25256.747432526176 06:20:26 INFO - PROCESS | 1685 | |2;jquery.html;360.4935066231945;361.6166863125087;364.0389372057768;365.6708961934259;371.127849553549;15640.530784076496;19073.04634768261;19613;19682.507937301576;20375.28686495973;18776.71834922474;18974.241030358804;19098.904505477487;19305.903470482626;19403.4178974631;4575.542445755431;4916.770807298176;5015.573676237515;5284.365876094874;5289.2859463972445;5085.898282034357;5852.912206316909;5892.204552385438;5894.086416605433;5928.970355148218;3855.151866589346;5593.629560757599;5600.411956744524;5841.766329346821;5846.824595262149;5749.540036797067;5773.787504623992;5801.187833703285;5810.970945145247;5812.099124635688;5403.83788486346;5463.836084917459;5538.335399752015;5571.387147413781;5571.804986825442;12887;14091.78862317066;23548.411289717722;23725.762742372528;24158.79206039691;2089.6447603907372;2190.9921436139393;2210.9226177083888;2388.703608900728;2625.2386807825706;9646.180074693659;10695.572177112907;12357.949574286196;14760;14965.625859353495;1807.168702396899;1849.7965223825368;1853.3420635674277;1856.916438760259;1911.340587497325;99545;102538;102894.48552757189;104126.99999999924;105381;9394.483303418378;11055.281406708538;11328.376939268419;11397.487113079931;11422.828657570142;13544.864551354558;13569.660758481117;13621.182729036289;13626.250556219504;13675.042747007614;7778.027746531684;7813.257740514642;8449.281811046007;8584.39909206362;8594.914050859536;8577.614007369682;8625.180607842245;8669.696560620348;8680.392372533863;8684.696035638723;3831.7126215533945;4354.8258069677495;4357.041450880801;4448.888777780581;4457.732536047847;1875.6717574424422;1910.455520176743;1911.4838993471963;1916.3484415298865;1920.6350793349218;394.9624785645359;830.667732906842;844.55660778092;855.683397143061;897.1028971028971;10493;11344.376059316652;11704;11851.585194518151;11876.940615296868;444.53324009789594;447.2597850557333;465.8812002939297;890.6817909493985;997.5211898288862;7824.6870125194355;7947.9205207948335;10347.586096556204;10523.579056837794;10643.52104155315;610841;623965;633232;761791;768244;112735;114819;117602.41198793951;122463.3876830628;124455;1136.755597546515;1202.0623913347604;1207.4083698987433;1229.065909908476;1272.9490820367082;17905.820941790935;18150.636987260445;18203.908980455013;18328.72506912424;18378.908105459923;44457.443404526915;48141.518584813704;50664.74667626638;50707.74646126746;51489.45531634057;57408.71295643662;70911;72148.63925680338;72222;74115.51768964698;7265.164506081657;7710.691572337044;7712.92287077122;7736.651850666846;7772;10721.909227700524;11523.711907202052;12005.339706316236;12237.816432753338;12412.689682758004;10035;10148.137408320375;10370.533326000197;10379.792404152025;10684.732881678021;10191.235657325582;10207;10273.589056437957;10775.461226938465;10840.199986084392;10549.9472502637;10781.622643207764;10968.177386696188;10989.120870330195;11221.775564488828;7458.440616953859;7728.149903510497;7807.375409967302;7809.258120478546;7817.843643127219;8975.865362019706;10194.541245644112;10628.468576571295;10721.731956701145;11029.83455248156 06:20:26 INFO - PROCESS | 1685 | |3;mootools.html;1533.9769903451447;1536.279367108838;1751.8773685841995;1856.0534127594922;1875.5967466994593;7846.136924938252;8424.115467875878;8614.612342444589;8763.693270735517;8771.91228087719;8511.191436813508;8577.31381489481;8621.612027458763;8692.869606955901;8717.651293948235;2457.8156638252112;2481.131603938625;2499.0878329409816;2499.6375525548783;2500.9749902500926;2283.1438210671;2370.589499247945;2443.6701045358827;2498.4378514834107;2504.887280072401;2182.8908554572286;2406.0736616402637;2462.384403899025;2470.493548822487;2491.5888878335054;2435.403326185078;2452.987735061331;2470.3824043989002;2470.6788117544693;2472.5920223163157;2124.851260411772;2465.4822487277693;2470.5800013997664;2479.690038745157;2480.1319538161497;8690.522021288827;8717.956410217972;8737.563121843883;8745;8758.474491530465;5340.118880384732;5388.245645609618;5399.541039011649;5449.618526703132;5466.34403871534;3524.594671612772;3646.4165733482514;3704.9811301891928;3716.349638813197;3722.9813850930573;893.8858209844628;917.8256131335091;1056.5456853552969;1092.82514797632;1093.278436232091;11429.199956003;11448.71378215543;11540.134489913291;11550.826737598944;11585.6524304271;4654.557817007379;4657.43338706148;4698.694584851974;4783.282507623884;4796.208625576811;9235;9241.537923103953;9249.537523123818;9257.537123143817;9285.675001374919;5216.37403511581;5234.450382709761;5326;5335.33308336458;5362.973185134049;4930.2358134488495;4956.256561515802;4959.479254678279;4975;4979.676321039121;3675.4303083022173;3706.8517259309865;3711.0907827581877;3734.0478178064964;3740.4389341598976;1137.766757814646;1186.4423720851187;1190.678516800459;1194.552042983881;1198.7413216123036;1101.5869049106584;1106.1040557148735;1127.430647523012;1246.7132559511363;1342.9865701343058;7907.2488113629115;7981.481203721855;8013.959930200428;8124.796880077927;8315.542645154454;1125.7692173104494;1179.55177032727;1182.9112816538623;1183.331417748969;1214.684182112657;6214.285357183891;6309.08518264849;6310;6393.296737358887;6408.935910640927;10186.898131018743;10428.904964978568;10437.112845408225;10571.418571978462;10585.364878107339;10151.796964060824;10278.588856445807;10456.268061235793;10456.738581535523;10511.789764204826;8056.194380562014;8098.919010809935;8108.878366824502;8113.918860811316;8254.339652827759;7931.484453510503;7974.242446967529;8001.919980800118;8062.838743224986;8203.384746144182;9426.434413935185;9468.195203407788;9587.233021358135;9591.184749296388;9749.853752193581;9372.578233979351;9640.084192001748;9729.978352272909;9915.752106197115;10054;6436.806895793134;7387.556746595222;7426.665800039119;7495.325420712162;7521.796512557965;7437.144728356092;7709.653065612173;8061.193880612126;8085.9595702021115;8128.83742325162;6854.9657251713425;6956.478264130312;7504.887426688713;7563.773086807405;7739.380849532136;7403.333699967029;7508.812279693051;7536.0956685198125;7598.886016709865;7605.695772169051;7627.54234745917;7701.383889288732;7715.768526944201;7774.067111946377;7778.88331675014;6957.826054348682;6986.6855991481525;7005.2644472329675;7011.088558487364;7025.121859767529;6889.242183359726;6936.34104760047;7023.33278338557;7034.155901291878;7052.224255332012 06:20:26 INFO - PROCESS | 1685 | |4;prototype.html;327.2179491016471;330.7387164140329;333.85310463396087;336.67006333792875;339.9439092549731;6627.701753421095;6752.797416077519;6773.762918297867;6774.695138718757;6778.356056174668;6773.153355830521;6777.457803375731;6800.251972283045;6805.761798337059;6874.79375618731;5011.574016208627;5021.27191557224;5027.648064635477;5035.068512325213;5044.646874718771;4740.146773580754;5007.774650140735;5028.84913452597;5032.4212715537815;5039.143345631252;4874.756262186894;4876.366072410582;4887.071456423286;4890.926636100461;4897.681650692693;4859.975700121495;4860.7326597037145;4860.9756951215195;4863.610911127119;4883.14544954635;4134.896627584304;4142.565030671796;4146.336586146233;4154.1068670236045;4160.980559762847;5204.34945631796;6212.782552610682;6453.096566480696;6462.353764623547;6467.32093130224;5694.77220911163;5702.629329093637;5750.568707346965;5763.3948435414095;5783.739731712083;6888.380045795852;7020.40326572242;7127.322904324133;7160.892586611205;7186.353228209487;4597.54024597541;4600.079984003212;4633.119707255611;4633.86098417048;4640.187967105777;7577;7641.541507509567;7651.655675494616;7675.462717609769;7681.57751323677;4579.771011449414;4666.836660716858;4691.812327506861;4720.622350211975;4721.693089949143;4287.735118140156;4525.52481989393;4795.688280261772;4802.951970480321;4813.542713442217;5013.323201367769;5726.856828579319;5727.541796656257;5750.051241545182;5755.3381361143165;5556.305461817273;7135.03578272264;7281.235470275651;7286.8178295541975;7293.124825021031;1496.7876020423491;1563.2262030294849;1613.1369717201242;1653.231247469908;1660.4603503861294;1044;1054.1250761867632;1065.9500392113762;1066.861308029951;1068.3750006246278;6723.058771771955;6725.092112564839;6726.327367263235;6761.391474767294;6761.492888033319;7527.096748390119;7542.2834830691;7542.773716788505;7556.093268807778;7565.735199268;6582.539222254396;6735.057092007123;6742.696578653972;6751.291114432914;6843.520953533304;3836.9256608149763;3997.6601988830694;4036.8990775230855;4038.8788336349958;4063.167050754588;6408.61548307103;7181.569105853666;7965.761027169194;7988.600569971478;8012.0786109596975;7678.270564296383;7840.33357164636;7856.371490280764;7876.527408355517;7913.089994650573;7543.509671871311;7648.1204661463535;7932.286094251545;7936.484128531627;7941.324987376138;6046.881326954527;6057.454829065406;7445.478816482794;7457;7515.549067055994;5632.5775566831835;7006.824829379307;7343.8898416522725;7345.522541034816;7346.33882950537;6867.759628413181;7237.203907570058;7624.656890440055;7789.727359542616;7796.493227940393;4646.7444290564345;4713.9057218856115;4732.384789977281;4737.502562231054;4738;7539.0576177977755;7551.773446796605;7557.470977031555;7559.508631938907;7573.6213189341415;7083.893741593984;7218.639068046682;7286.744963926237;7311.451641127043;7312.890306645299;7266.6729997151315;7280.563166210044;7282.708691652275;7299.963500182465;7345.816354590964;6921.2732663071665;7103.360697537247;7115.466340024415;7122.501424900207;7153.928460715326;7267.491275610657;7291.453141014339;7299;7311.159216690149;7332.9266707332245;7121.465890058163;7122.394596459359;7123.786286411416;7143.1428228612895;7151.642417878981 06:20:26 INFO - PROCESS | 1685 | |5;yui.html;620.7423919073585;658.611419262635;684.3635419060278;720.8233982674245;723.8190452386904;12156.27062376257;15135.772963405543;15153.772693409608;17601;17665.293388264487;15957.042577445362;16010.279537420814;16040;16056.83943160568;16087.034777913334;697.7209116353448;845.4842546046906;847.7711018025129;853.0957185383497;874.4359887872318;857.3955361470148;864.2999170671776;870.7997160653053;872.7032808844991;876.198278575103;895.9417637853551;906.9410488318238;910.6220918318922;910.7313342563959;912.3020889019905;873.4191762477944;893.6872094766844;903.8960519540271;904.7964208053169;908.0102688070035;619.5105866365566;669.7957123077459;671.9596824190564;673.4376795375867;673.723773252964;15251.61870953224;15464.5360639181;15487.457938972195;15578.844211557853;15605.297761600756;12565.93717031418;12687.175333603378;12715.809262860972;12901.806472902914;13257.933710331483;10083.042110999444;10892.019718225318;11276.718082047932;11404.315741055563;12091.576794812227;3563.8773786257507;3567.4827150063356;3569.928601427957;3587.1749497615697;3696.0205545530457;80382.19617803863;80853.59573202155;81673.18326816715;81884;83664;8592.699255526026;9265.768355791159;9683.467409292556;9829.361091529028;9872.308938374388;19813.405597832087;20263.79736202619;20500.282490112775;20539.28112516055;20556.588868222552;7528.360089392353;7540.962295188599;7642.159362470124;7692.384609231248;7693.384529237647;4166.354215096665;4211.410402543646;4226.4716910386205;4229.809658565372;4235.78821058952;3547.290541891632;3592.4072528033103;3605.8197090145386;3614.7348428049972;3628.129248980226;651.4723074309824;654.2835595023537;656.5437021270171;677.0757915445381;679.741698154698;536.3135186960697;541.5860735009702;569.4789267819898;599.0863932502967;629.4303655192059;8063.1130575636635;8303.875441868377;8409.831803363899;8466.74599762008;8530.914690853137;493.96048316134625;504.89649621827436;549.5603517186235;599.1701493431542;622.9065640153923;4002.2595819773437;4111.691623128278;4263.552327005682;4323.502797178365;4341.370501277297;90865;92040;92279;92417;93715.062849372;78971;79212.4157516858;79377.80933286005;79726;80367;69997.30002700009;70063.64968175127;70348.64825675839;70803.64598176976;71034;8744.387892847439;8802.207801297915;8888.77778055528;8960.327975402;8968.148025937526;41812.95467613334;45577.54422455865;47076.05701401304;47449;48736.29422970179;63160.68419658056;65326;66498.66750666215;67512;68781.65609171923;10889.945550272198;10981.121510279318;11247.044001259985;11251.381174035507;11405.973462388425;11771.411429428323;11814.119216107687;12232.327222002876;12622.179558328678;12622.621321360373;9588.856167157637;11145.164112691742;11312.490937907649;11439.570053743282;11659.417029148339;11599.304041757521;11603.593874214363;11645.708857278636;12194.939025304817;12547.184433011826;10824.24230303871;11072.833907491233;11532.25040372373;11679.240849344766;12140.079369026273;8260.29787468072;9335.299852510952;9584.520773961414;9587.472689002172;9747.220222382051;9234.307426942873;9880.950595246977;9884.703458896245;9884.950575247365;9966.40201587907 06:20:26 INFO - PROCESS | 1685 | __end_tp_report 06:20:26 INFO - PROCESS | 1685 | __start_cc_report 06:20:26 INFO - PROCESS | 1685 | _x_x_mozilla_cycle_collect,375 06:20:26 INFO - PROCESS | 1685 | __end_cc_report 06:20:26 INFO - PROCESS | 1685 | __startTimestamp1455286826177__endTimestamp 06:20:26 INFO - PROCESS | 1685 | 06:20:26 INFO - PROCESS | 1685 | ------- Summary: start ------- 06:20:26 INFO - PROCESS | 1685 | Number of tests: 6 06:20:26 INFO - PROCESS | 1685 | 06:20:26 INFO - PROCESS | 1685 | [#0] dojo.html Cycles:165 Average:5691.28 Median:5941.20 stddev:766.35 (12.9%) stddev-sans-first:749.29 06:20:26 INFO - PROCESS | 1685 | Values: 3506.7 3527.9 3530.9 3577.5 3579.0 5725.6 5771.7 5786.9 5788.9 5809.5 4553.7 5680.1 5719.4 5773.9 5884.6 5176.9 5210.2 5214.1 5250.7 5301.6 527.6 5059.5 5151.1 5208.9 5239.1 5185.4 5223.2 5228.6 5232.0 5237.0 5213.0 5222.3 5222.5 5231.3 5309.0 5119.6 5122.3 5161.9 5229.9 5246.8 5026.8 5119.6 5681.8 5718.3 5795.6 4673.9 6150.7 6231.7 6276.7 6300.2 6236.7 6242.5 6257.5 6269.6 6270.5 5871.0 5871.9 5887.8 5902.1 5941.2 6153.8 6185.4 6274.9 6283.3 6290.0 6193.8 6194.0 6200.8 6200.9 6221.8 6247.5 6281.9 6292.2 6294.0 6321.7 6071.9 6150.6 6253.6 6264.0 6293.5 6242.8 6250.7 6290.1 6309.5 6337.4 4833.6 4882.7 4925.0 4932.3 4968.1 4407.7 4409.6 4421.2 4422.8 4445.1 5667.9 5706.8 5739.3 5745.6 5748.7 4877.0 5596.2 6139.3 6170.0 6172.9 5298.7 5325.6 5734.4 5749.3 5754.3 5289.4 5391.6 5406.8 5413.9 5448.3 6291.0 6335.7 6344.2 6349.1 6356.7 6164.1 6192.6 6198.3 6211.8 6296.2 6145.5 6250.4 6320.5 6327.3 6543.5 4674.5 5134.9 6236.2 6246.5 6254.7 6243.6 6271.4 6285.3 6295.3 6298.1 5999.3 6102.0 6131.7 6198.3 6222.6 6069.4 6112.9 6126.3 6147.4 6167.2 5904.4 5934.0 6090.4 6099.3 6126.8 5695.5 6177.1 6185.0 6189.8 6212.2 6027.0 6050.4 6069.8 6070.9 6093.3 06:20:26 INFO - PROCESS | 1685 | 06:20:26 INFO - PROCESS | 1685 | [#1] ext.html Cycles:180 Average:64613.63 Median:37342.44 stddev:135326.94 (362.4%) stddev-sans-first:135620.75 06:20:26 INFO - PROCESS | 1685 | Values: 423.7 490.0 499.9 569.0 603.5 36924.1 37000.8 37009.8 37133.3 37206.6 31679.5 38086.9 38434.8 38638.6 38711.2 9378.9 9599.7 9630.4 9656.7 9675.8 9464.9 9686.0 9711.3 9721.5 9772.4 9560.6 9683.6 9738.0 9757.9 9760.8 9630.5 9677.6 9699.3 9699.9 9714.7 9482.9 9548.3 9581.1 9613.5 9619.9 36947.4 37176.8 37201.1 37276.8 37408.1 2763.7 2803.8 3290.4 3344.6 3436.6 26459.7 27634.2 28091.7 28174.2 28538.7 2757.0 2812.1 2844.7 2853.2 2937.2 490979.0 493259.0 493540.0 493548.0 495288.5 56306.4 64500.0 64632.8 64882.0 65833.0 62153.7 62187.0 62315.7 62508.7 62973.4 13204.8 15770.0 15970.4 15974.4 15998.9 10732.3 10762.6 12126.5 12167.6 12335.3 16849.0 20050.7 20184.8 20208.7 20388.8 7242.3 8279.6 8772.5 8942.5 9032.3 944.9 952.2 995.0 1004.5 1069.7 27839.3 28789.6 28893.0 29185.7 29389.7 963.2 1036.6 1088.8 1129.1 1154.6 14572.5 14711.6 14793.3 14965.9 15058.3 462834.0 534086.0 538721.0 539048.0 540352.1 55846.0 55940.0 56188.4 56466.0 56478.2 1260.9 1404.6 1448.9 1453.7 1457.6 25273.0 27554.9 28550.0 28932.9 29092.9 46773.5 46876.3 46964.8 46995.0 47273.0 501599.0 506782.0 507253.0 510722.0 511275.0 32416.5 42127.8 43214.8 43387.0 43454.0 44408.8 44994.8 45470.5 45668.8 46294.3 34082.7 34976.7 35252.0 35396.8 35570.8 33279.3 34829.8 35083.6 35391.1 36665.8 35886.6 36172.0 36227.5 36718.3 37471.3 30273.2 31572.9 32130.5 32186.4 32714.8 24326.4 24838.8 25010.7 25129.7 25256.7 06:20:26 INFO - PROCESS | 1685 | 06:20:26 INFO - PROCESS | 1685 | [#2] jquery.html Cycles:180 Average:35553.69 Median:13057.23 stddev:112905.76 (864.7%) stddev-sans-first:113191.57 06:20:26 INFO - PROCESS | 1685 | Values: 360.5 361.6 364.0 365.7 371.1 15640.5 19073.0 19613.0 19682.5 20375.3 18776.7 18974.2 19098.9 19305.9 19403.4 4575.5 4916.8 5015.6 5284.4 5289.3 5085.9 5852.9 5892.2 5894.1 5929.0 3855.2 5593.6 5600.4 5841.8 5846.8 5749.5 5773.8 5801.2 5811.0 5812.1 5403.8 5463.8 5538.3 5571.4 5571.8 12887.0 14091.8 23548.4 23725.8 24158.8 2089.6 2191.0 2210.9 2388.7 2625.2 9646.2 10695.6 12357.9 14760.0 14965.6 1807.2 1849.8 1853.3 1856.9 1911.3 99545.0 102538.0 102894.5 104127.0 105381.0 9394.5 11055.3 11328.4 11397.5 11422.8 13544.9 13569.7 13621.2 13626.3 13675.0 7778.0 7813.3 8449.3 8584.4 8594.9 8577.6 8625.2 8669.7 8680.4 8684.7 3831.7 4354.8 4357.0 4448.9 4457.7 1875.7 1910.5 1911.5 1916.3 1920.6 395.0 830.7 844.6 855.7 897.1 10493.0 11344.4 11704.0 11851.6 11876.9 444.5 447.3 465.9 890.7 997.5 7824.7 7947.9 10347.6 10523.6 10643.5 610841.0 623965.0 633232.0 761791.0 768244.0 112735.0 114819.0 117602.4 122463.4 124455.0 1136.8 1202.1 1207.4 1229.1 1272.9 17905.8 18150.6 18203.9 18328.7 18378.9 44457.4 48141.5 50664.7 50707.7 51489.5 57408.7 70911.0 72148.6 72222.0 74115.5 7265.2 7710.7 7712.9 7736.7 7772.0 10721.9 11523.7 12005.3 12237.8 12412.7 10035.0 10148.1 10370.5 10379.8 10684.7 10191.2 10207.0 10273.6 10775.5 10840.2 10549.9 10781.6 10968.2 10989.1 11221.8 7458.4 7728.1 7807.4 7809.3 7817.8 8975.9 10194.5 10628.5 10721.7 11029.8 06:20:26 INFO - PROCESS | 1685 | 06:20:26 INFO - PROCESS | 1685 | [#3] mootools.html Cycles:180 Average:5977.10 Median:5393.89 stddev:3107.46 (57.6%) stddev-sans-first:3098.23 06:20:26 INFO - PROCESS | 1685 | Values: 1534.0 1536.3 1751.9 1856.1 1875.6 7846.1 8424.1 8614.6 8763.7 8771.9 8511.2 8577.3 8621.6 8692.9 8717.7 2457.8 2481.1 2499.1 2499.6 2501.0 2283.1 2370.6 2443.7 2498.4 2504.9 2182.9 2406.1 2462.4 2470.5 2491.6 2435.4 2453.0 2470.4 2470.7 2472.6 2124.9 2465.5 2470.6 2479.7 2480.1 8690.5 8718.0 8737.6 8745.0 8758.5 5340.1 5388.2 5399.5 5449.6 5466.3 3524.6 3646.4 3705.0 3716.3 3723.0 893.9 917.8 1056.5 1092.8 1093.3 11429.2 11448.7 11540.1 11550.8 11585.7 4654.6 4657.4 4698.7 4783.3 4796.2 9235.0 9241.5 9249.5 9257.5 9285.7 5216.4 5234.5 5326.0 5335.3 5363.0 4930.2 4956.3 4959.5 4975.0 4979.7 3675.4 3706.9 3711.1 3734.0 3740.4 1137.8 1186.4 1190.7 1194.6 1198.7 1101.6 1106.1 1127.4 1246.7 1343.0 7907.2 7981.5 8014.0 8124.8 8315.5 1125.8 1179.6 1182.9 1183.3 1214.7 6214.3 6309.1 6310.0 6393.3 6408.9 10186.9 10428.9 10437.1 10571.4 10585.4 10151.8 10278.6 10456.3 10456.7 10511.8 8056.2 8098.9 8108.9 8113.9 8254.3 7931.5 7974.2 8001.9 8062.8 8203.4 9426.4 9468.2 9587.2 9591.2 9749.9 9372.6 9640.1 9730.0 9915.8 10054.0 6436.8 7387.6 7426.7 7495.3 7521.8 7437.1 7709.7 8061.2 8086.0 8128.8 6855.0 6956.5 7504.9 7563.8 7739.4 7403.3 7508.8 7536.1 7598.9 7605.7 7627.5 7701.4 7715.8 7774.1 7778.9 6957.8 6986.7 7005.3 7011.1 7025.1 6889.2 6936.3 7023.3 7034.2 7052.2 06:20:26 INFO - PROCESS | 1685 | 06:20:26 INFO - PROCESS | 1685 | [#4] prototype.html Cycles:180 Average:5869.08 Median:6738.88 stddev:1897.80 (28.2%) stddev-sans-first:1856.98 06:20:26 INFO - PROCESS | 1685 | Values: 327.2 330.7 333.9 336.7 339.9 6627.7 6752.8 6773.8 6774.7 6778.4 6773.2 6777.5 6800.3 6805.8 6874.8 5011.6 5021.3 5027.6 5035.1 5044.6 4740.1 5007.8 5028.8 5032.4 5039.1 4874.8 4876.4 4887.1 4890.9 4897.7 4860.0 4860.7 4861.0 4863.6 4883.1 4134.9 4142.6 4146.3 4154.1 4161.0 5204.3 6212.8 6453.1 6462.4 6467.3 5694.8 5702.6 5750.6 5763.4 5783.7 6888.4 7020.4 7127.3 7160.9 7186.4 4597.5 4600.1 4633.1 4633.9 4640.2 7577.0 7641.5 7651.7 7675.5 7681.6 4579.8 4666.8 4691.8 4720.6 4721.7 4287.7 4525.5 4795.7 4803.0 4813.5 5013.3 5726.9 5727.5 5750.1 5755.3 5556.3 7135.0 7281.2 7286.8 7293.1 1496.8 1563.2 1613.1 1653.2 1660.5 1044.0 1054.1 1066.0 1066.9 1068.4 6723.1 6725.1 6726.3 6761.4 6761.5 7527.1 7542.3 7542.8 7556.1 7565.7 6582.5 6735.1 6742.7 6751.3 6843.5 3836.9 3997.7 4036.9 4038.9 4063.2 6408.6 7181.6 7965.8 7988.6 8012.1 7678.3 7840.3 7856.4 7876.5 7913.1 7543.5 7648.1 7932.3 7936.5 7941.3 6046.9 6057.5 7445.5 7457.0 7515.5 5632.6 7006.8 7343.9 7345.5 7346.3 6867.8 7237.2 7624.7 7789.7 7796.5 4646.7 4713.9 4732.4 4737.5 4738.0 7539.1 7551.8 7557.5 7559.5 7573.6 7083.9 7218.6 7286.7 7311.5 7312.9 7266.7 7280.6 7282.7 7300.0 7345.8 6921.3 7103.4 7115.5 7122.5 7153.9 7267.5 7291.5 7299.0 7311.2 7332.9 7121.5 7122.4 7123.8 7143.1 7151.6 06:20:26 INFO - PROCESS | 1685 | 06:20:26 INFO - PROCESS | 1685 | [#5] yui.html Cycles:180 Average:18362.90 Median:31895.06 stddev:25634.07 (80.4%) stddev-sans-first:25671.36 06:20:26 INFO - PROCESS | 1685 | Values: 620.7 658.6 684.4 720.8 723.8 12156.3 15135.8 15153.8 17601.0 17665.3 15957.0 16010.3 16040.0 16056.8 16087.0 697.7 845.5 847.8 853.1 874.4 857.4 864.3 870.8 872.7 876.2 895.9 906.9 910.6 910.7 912.3 873.4 893.7 903.9 904.8 908.0 619.5 669.8 672.0 673.4 673.7 15251.6 15464.5 15487.5 15578.8 15605.3 12565.9 12687.2 12715.8 12901.8 13257.9 10083.0 10892.0 11276.7 11404.3 12091.6 3563.9 3567.5 3569.9 3587.2 3696.0 80382.2 80853.6 81673.2 81884.0 83664.0 8592.7 9265.8 9683.5 9829.4 9872.3 19813.4 20263.8 20500.3 20539.3 20556.6 7528.4 7541.0 7642.2 7692.4 7693.4 4166.4 4211.4 4226.5 4229.8 4235.8 3547.3 3592.4 3605.8 3614.7 3628.1 651.5 654.3 656.5 677.1 679.7 536.3 541.6 569.5 599.1 629.4 8063.1 8303.9 8409.8 8466.7 8530.9 494.0 504.9 549.6 599.2 622.9 4002.3 4111.7 4263.6 4323.5 4341.4 90865.0 92040.0 92279.0 92417.0 93715.1 78971.0 79212.4 79377.8 79726.0 80367.0 69997.3 70063.6 70348.6 70803.6 71034.0 8744.4 8802.2 8888.8 8960.3 8968.1 41813.0 45577.5 47076.1 47449.0 48736.3 63160.7 65326.0 66498.7 67512.0 68781.7 10889.9 10981.1 11247.0 11251.4 11406.0 11771.4 11814.1 12232.3 12622.2 12622.6 9588.9 11145.2 11312.5 11439.6 11659.4 11599.3 11603.6 11645.7 12194.9 12547.2 10824.2 11072.8 11532.3 11679.2 12140.1 8260.3 9335.3 9584.5 9587.5 9747.2 9234.3 9881.0 9884.7 9885.0 9966.4 06:20:26 INFO - PROCESS | 1685 | -------- Summary: end -------- 06:20:26 INFO - PROCESS | 1685 | 06:20:26 INFO - TEST-INFO | 1685: exit 0 06:20:26 INFO - TEST-OK | dromaeo_css | took 1110257ms 06:20:26 INFO - TEST-START | kraken 06:20:26 INFO - operating with platform_type : mac_ 06:20:26 INFO - Initialising browser for kraken test... 06:20:26 INFO - TEST-INFO | started process 1694 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpep3PFu/profile http://localhost:49288/getInfo.html) 06:20:29 INFO - PROCESS | 1694 | __metrics Screen width/height:1600/1200 06:20:29 INFO - PROCESS | 1694 | colorDepth:24 06:20:29 INFO - PROCESS | 1694 | Browser inner width/height: 1024/689 06:20:29 INFO - PROCESS | 1694 | __metrics 06:20:29 INFO - PROCESS | 1694 | 06:20:29 INFO - PROCESS | 1694 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 06:20:29 INFO - PROCESS | 1694 | 06:20:30 INFO - TEST-INFO | 1694: exit 0 06:20:30 INFO - Browser initialized. 06:20:30 INFO - Running cycle 1/1 for kraken test... 06:20:30 INFO - TEST-INFO | started process 1697 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpep3PFu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:20:42 INFO - PROCESS | 1697 | RSS: Main: 258076672 06:20:42 INFO - PROCESS | 1697 | 06:20:44 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-beat-detection) 06:20:45 INFO - PROCESS | 1697 | RSS: Main: 270585856 06:20:45 INFO - PROCESS | 1697 | 06:20:48 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-dft) 06:20:48 INFO - PROCESS | 1697 | RSS: Main: 278069248 06:20:48 INFO - PROCESS | 1697 | 06:20:52 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-fft) 06:20:52 INFO - PROCESS | 1697 | RSS: Main: 282697728 06:20:52 INFO - PROCESS | 1697 | 06:20:54 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-oscillator) 06:20:55 INFO - PROCESS | 1697 | RSS: Main: 284733440 06:20:55 INFO - PROCESS | 1697 | 06:20:57 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49288/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:20:57 INFO - PROCESS | 1697 | RSS: Main: 285888512 06:20:57 INFO - PROCESS | 1697 | 06:21:00 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49288/tests/kraken/driver.html?testName=imaging-darkroom) 06:21:01 INFO - PROCESS | 1697 | RSS: Main: 285528064 06:21:01 INFO - PROCESS | 1697 | 06:21:04 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49288/tests/kraken/driver.html?testName=imaging-desaturate) 06:21:04 INFO - PROCESS | 1697 | RSS: Main: 285126656 06:21:04 INFO - PROCESS | 1697 | 06:21:07 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49288/tests/kraken/driver.html?testName=json-parse-financial) 06:21:08 INFO - PROCESS | 1697 | RSS: Main: 285331456 06:21:08 INFO - PROCESS | 1697 | 06:21:09 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49288/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:21:10 INFO - PROCESS | 1697 | RSS: Main: 285532160 06:21:10 INFO - PROCESS | 1697 | 06:21:12 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:21:12 INFO - PROCESS | 1697 | RSS: Main: 284139520 06:21:12 INFO - PROCESS | 1697 | 06:21:14 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:21:15 INFO - PROCESS | 1697 | RSS: Main: 286314496 06:21:15 INFO - PROCESS | 1697 | 06:21:18 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:21:18 INFO - PROCESS | 1697 | RSS: Main: 285728768 06:21:18 INFO - PROCESS | 1697 | 06:21:21 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:21:22 INFO - PROCESS | 1697 | RSS: Main: 285306880 06:21:22 INFO - PROCESS | 1697 | 06:21:23 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49288/tests/kraken/driver.html?testName=ai-astar) 06:21:24 INFO - PROCESS | 1697 | RSS: Main: 286048256 06:21:24 INFO - PROCESS | 1697 | 06:21:24 INFO - PROCESS | 1697 | __start_tp_report 06:21:24 INFO - PROCESS | 1697 | _x_x_mozilla_page_load 06:21:24 INFO - PROCESS | 1697 | _x_x_mozilla_page_load_details 06:21:24 INFO - PROCESS | 1697 | |i|pagename|runs| 06:21:24 INFO - PROCESS | 1697 | |0;ai-astar;116;109;110;114;118;138;99;118;165;165 06:21:24 INFO - PROCESS | 1697 | |1;audio-beat-detection;151;123;150;149;145;149;150;147;183;115 06:21:24 INFO - PROCESS | 1697 | |2;audio-dft;192;193;219;201;262;268;200;195;201;197 06:21:24 INFO - PROCESS | 1697 | |3;audio-fft;70;72;75;109;59;56;59;59;108;60 06:21:24 INFO - PROCESS | 1697 | |4;audio-oscillator;73;85;125;80;80;82;115;83;82;115 06:21:24 INFO - PROCESS | 1697 | |5;imaging-gaussian-blur;87;93;88;95;88;93;87;95;87;106 06:21:24 INFO - PROCESS | 1697 | |6;imaging-darkroom;97;97;96;97;98;150;132;97;150;152 06:21:24 INFO - PROCESS | 1697 | |7;imaging-desaturate;91;92;91;95;92;113;149;94;91;91 06:21:24 INFO - PROCESS | 1697 | |8;json-parse-financial;54;52;53;53;56;55;54;53;46;81 06:21:24 INFO - PROCESS | 1697 | |9;json-stringify-tinderbox;62;67;72;78;72;72;67;65;65;66 06:21:24 INFO - PROCESS | 1697 | |10;stanford-crypto-aes;85;83;86;85;87;83;86;84;87;98 06:21:24 INFO - PROCESS | 1697 | |11;stanford-crypto-ccm;120;133;130;122;146;143;114;129;152;117 06:21:24 INFO - PROCESS | 1697 | |12;stanford-crypto-pbkdf2;171;171;150;141;150;171;179;173;141;125 06:21:24 INFO - PROCESS | 1697 | |13;stanford-crypto-sha256-iterative;61;100;95;68;69;65;80;92;95;98 06:21:24 INFO - PROCESS | 1697 | __end_tp_report 06:21:24 INFO - PROCESS | 1697 | __start_cc_report 06:21:24 INFO - PROCESS | 1697 | _x_x_mozilla_cycle_collect,945 06:21:24 INFO - PROCESS | 1697 | __end_cc_report 06:21:24 INFO - PROCESS | 1697 | __startTimestamp1455286884080__endTimestamp 06:21:24 INFO - PROCESS | 1697 | 06:21:24 INFO - PROCESS | 1697 | ------- Summary: start ------- 06:21:24 INFO - PROCESS | 1697 | Number of tests: 14 06:21:24 INFO - PROCESS | 1697 | 06:21:24 INFO - PROCESS | 1697 | [#0] ai-astar Cycles:10 Average:125.20 Median:128.00 stddev:23.16 (18.1%) stddev-sans-first:24.32 06:21:24 INFO - PROCESS | 1697 | Values: 116.0 109.0 110.0 114.0 118.0 138.0 99.0 118.0 165.0 165.0 06:21:24 INFO - PROCESS | 1697 | 06:21:24 INFO - PROCESS | 1697 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:149.50 stddev:18.06 (12.1%) stddev-sans-first:19.07 06:21:24 INFO - PROCESS | 1697 | Values: 151.0 123.0 150.0 149.0 145.0 149.0 150.0 147.0 183.0 115.0 06:21:24 INFO - PROCESS | 1697 | 06:21:24 INFO - PROCESS | 1697 | [#2] audio-dft Cycles:10 Average:212.80 Median:201.00 stddev:28.56 (14.2%) stddev-sans-first:29.28 06:21:24 INFO - PROCESS | 1697 | Values: 192.0 193.0 219.0 201.0 262.0 268.0 200.0 195.0 201.0 197.0 06:21:24 INFO - PROCESS | 1697 | 06:21:24 INFO - PROCESS | 1697 | [#3] audio-fft Cycles:10 Average:72.70 Median:59.50 stddev:19.94 (33.5%) stddev-sans-first:21.13 06:21:24 INFO - PROCESS | 1697 | Values: 70.0 72.0 75.0 109.0 59.0 56.0 59.0 59.0 108.0 60.0 06:21:24 INFO - PROCESS | 1697 | 06:21:24 INFO - PROCESS | 1697 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:81.00 stddev:18.64 (23.0%) stddev-sans-first:18.46 06:21:24 INFO - PROCESS | 1697 | Values: 73.0 85.0 125.0 80.0 80.0 82.0 115.0 83.0 82.0 115.0 06:21:24 INFO - PROCESS | 1697 | 06:21:24 INFO - PROCESS | 1697 | [#5] imaging-gaussian-blur Cycles:10 Average:91.90 Median:90.50 stddev:5.99 (6.6%) stddev-sans-first:6.09 06:21:24 INFO - PROCESS | 1697 | Values: 87.0 93.0 88.0 95.0 88.0 93.0 87.0 95.0 87.0 106.0 06:21:24 INFO - PROCESS | 1697 | 06:21:24 INFO - PROCESS | 1697 | [#6] imaging-darkroom Cycles:10 Average:116.60 Median:97.00 stddev:25.88 (26.7%) stddev-sans-first:26.46 06:21:24 INFO - PROCESS | 1697 | Values: 97.0 97.0 96.0 97.0 98.0 150.0 132.0 97.0 150.0 152.0 06:21:24 INFO - PROCESS | 1697 | 06:21:24 INFO - PROCESS | 1697 | [#7] imaging-desaturate Cycles:10 Average:99.90 Median:91.50 stddev:18.51 (20.2%) stddev-sans-first:19.35 06:21:24 INFO - PROCESS | 1697 | Values: 91.0 92.0 91.0 95.0 92.0 113.0 149.0 94.0 91.0 91.0 06:21:24 INFO - PROCESS | 1697 | 06:21:24 INFO - PROCESS | 1697 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:54.00 stddev:9.29 (17.2%) stddev-sans-first:9.83 06:21:24 INFO - PROCESS | 1697 | Values: 54.0 52.0 53.0 53.0 56.0 55.0 54.0 53.0 46.0 81.0 06:21:24 INFO - PROCESS | 1697 | 06:21:24 INFO - PROCESS | 1697 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.50 stddev:4.77 (6.9%) stddev-sans-first:4.42 06:21:24 INFO - PROCESS | 1697 | Values: 62.0 67.0 72.0 78.0 72.0 72.0 67.0 65.0 65.0 66.0 06:21:24 INFO - PROCESS | 1697 | 06:21:24 INFO - PROCESS | 1697 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:86.00 stddev:4.33 (5.0%) stddev-sans-first:4.56 06:21:24 INFO - PROCESS | 1697 | Values: 85.0 83.0 86.0 85.0 87.0 83.0 86.0 84.0 87.0 98.0 06:21:24 INFO - PROCESS | 1697 | 06:21:24 INFO - PROCESS | 1697 | [#11] stanford-crypto-ccm Cycles:10 Average:130.60 Median:131.50 stddev:12.93 (9.8%) stddev-sans-first:13.13 06:21:24 INFO - PROCESS | 1697 | Values: 120.0 133.0 130.0 122.0 146.0 143.0 114.0 129.0 152.0 117.0 06:21:24 INFO - PROCESS | 1697 | 06:21:24 INFO - PROCESS | 1697 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.20 Median:171.00 stddev:18.14 (10.6%) stddev-sans-first:18.54 06:21:24 INFO - PROCESS | 1697 | Values: 171.0 171.0 150.0 141.0 150.0 171.0 179.0 173.0 141.0 125.0 06:21:24 INFO - PROCESS | 1697 | 06:21:24 INFO - PROCESS | 1697 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.30 Median:86.00 stddev:15.33 (17.8%) stddev-sans-first:14.20 06:21:24 INFO - PROCESS | 1697 | Values: 61.0 100.0 95.0 68.0 69.0 65.0 80.0 92.0 95.0 98.0 06:21:24 INFO - PROCESS | 1697 | -------- Summary: end -------- 06:21:24 INFO - PROCESS | 1697 | 06:21:24 INFO - TEST-INFO | 1697: exit 0 06:21:24 INFO - TEST-OK | kraken | took 58129ms 06:21:24 INFO - SUITE-END | took 1168s 06:21:25 INFO - Completed test suite (00:19:28) 06:21:25 INFO - Working with test: dromaeo_css 06:21:25 INFO - Generating results file: dromaeo_css 06:21:25 INFO - Working with test: kraken 06:21:25 INFO - Generating results file: kraken 06:21:25 INFO - javascript benchmark 06:21:25 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:21:25 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 06:21:25 INFO - process_Request line: dromaeo_css 7468.92 graph.html#tests=[[72,1,61]] 06:21:25 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:21:25 INFO - process_Request line: kraken 1538.10 graph.html#tests=[[232,1,61]] 06:21:25 INFO - RETURN: dromaeo_css: 7468.92 06:21:25 INFO - RETURN: kraken: 1538.10 06:21:25 INFO - javascript benchmark 06:21:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3506.736994725396, 3527.911802204946, 3530.947035794463, 3577.463380492926, 3578.964210357897, 5725.62783419078, 5771.711414429283, 5786.942130578693, 5788.884222315556, 5809.477147056764, 4553.68124231304, 5680.119581464869, 5719.399463056381, 5773.9422605773925, 5884.558658100649, 5176.870578235536, 5210.192420174879, 5214.087534681435, 5250.7112108834, 5301.602379821509, 527.5881987976293, 5059.494050594948, 5151.072806894757, 5208.921866172011, 5239.13554263546, 5185.351831021104, 5223.164293713006, 5228.5555727763185, 5231.973840130813, 5236.973815130938, 5212.983468223698, 5222.268882356473, 5222.477752224785, 5231.319928409321, 5309.0, 5119.59043276537, 5122.33409656746, 5161.922571161435, 5229.895402091975, 5246.7901283948595, 5026.843825920059, 5119.616028797818, 5681.829545113653, 5718.342390625048, 5795.594308398414, 4673.878269215398, 6150.7390984848, 6231.719572619198, 6276.717547710364, 6300.180976473075, 6236.719347629322, 6242.531810114259, 6257.468115210213, 6269.62382257066, 6270.46701030413, 5870.97064514679, 5871.943050250953, 5887.793927212527, 5902.055671092648, 5941.19793827832, 6153.84615384619, 6185.381461853779, 6274.874502509924, 6283.277423096402, 6290.025046117859, 6193.81418557444, 6193.969030154821, 6200.782972595937, 6200.937990620036, 6221.782237621662, 6247.531435142382, 6281.8743625127245, 6292.244930608356, 6293.968530157412, 6321.747130114744, 6071.939280607226, 6150.600210986271, 6253.5622506425025, 6263.96868015657, 6293.527985401113, 6242.812715618538, 6250.656213908188, 6290.119383286344, 6309.495240380758, 6337.366263373626, 4833.564979151823, 4882.658213924991, 4924.9507504925205, 4932.284818701268, 4968.130577148984, 4407.669424793154, 4409.581089796464, 4421.159979603865, 4422.778861056934, 4445.066536027406, 5667.914981275284, 5706.771729130788, 5739.311282646026, 5745.569082318759, 5748.7125643717645, 4876.975835074603, 5596.188552659842, 6139.29398119222, 6169.96915015431, 6172.9074063889075, 5298.708571028554, 5325.641961299843, 5734.369219385864, 5749.281339832521, 5754.309482862, 5289.3917199521775, 5391.649542779707, 5406.756695948692, 5413.864653383697, 5448.318960129984, 6290.968545157245, 6335.68321583919, 6344.206974128234, 6349.079383489368, 6356.713947872357, 6164.137020816999, 6192.59748116371, 6198.256209254738, 6211.81364559064, 6296.212973378328, 6145.494353883327, 6250.3749625037135, 6320.494360451061, 6327.272363678052, 6543.476521878143, 4674.485806561343, 5134.922976155286, 6236.220472440945, 6246.469050130608, 6254.655993920378, 6243.562950593597, 6271.372862713874, 6285.308616052322, 6295.276043254901, 6298.08677741734, 5999.340072592098, 6101.974255744823, 6131.693415329305, 6198.256209254918, 6222.62664240147, 6069.423404776539, 6112.938870611415, 6126.264848218242, 6147.354527774698, 6167.229096362955, 5904.3800400959, 5934.020886553671, 6090.390960903874, 6099.320418295802, 6126.754929802758, 5695.515881150149, 6177.073438984188, 6185.041318595625, 6189.752409903554, 6212.192414986023, 6026.969865150646, 6050.364711705383, 6069.848253793691, 6070.908936366046, 6093.268807743099], "unit": "score", "name": "dojo.html", "value": 5647.616317654924}, {"lowerIsBetter": false, "replicates": [423.7245790236344, 489.9779509922053, 499.89752100819334, 569.018443185505, 603.4960807725549, 36924.07689807756, 37000.814995924986, 37009.814950925276, 37133.25733485329, 37206.62793372066, 31679.524807127913, 38086.857394278144, 38434.8078259609, 38638.613613863854, 38711.22577548454, 9378.906210937888, 9599.712008639752, 9630.374025688308, 9656.662016829412, 9675.806483870318, 9464.905350946507, 9686.0, 9711.271654625896, 9721.513924303792, 9772.413655180677, 9560.569774360136, 9683.612655493807, 9738.02619738024, 9757.853632195523, 9760.804783904317, 9630.47032413217, 9677.612895484137, 9699.272554558402, 9699.90300096997, 9714.659986900424, 9482.905170948272, 9548.331616786827, 9581.137697607248, 9613.471259080748, 9619.94180640136, 36947.4457883132, 37176.81411592925, 37201.06997325089, 37276.81361593202, 37408.064798379986, 2763.7098104698916, 2803.8457884816326, 3290.4077266092095, 3344.615369232545, 3436.621971583124, 26459.735402645918, 27634.170974870583, 28091.71908280932, 28174.154775356772, 28538.71461285381, 2756.9724302756917, 2812.086072026579, 2844.6586409630977, 2853.2296280004284, 2937.206954122375, 490979.0, 493259.0, 493540.0, 493548.0, 495288.5235573835, 56306.43693563012, 64500.0, 64632.76836158173, 64882.026769598495, 65833.0, 62153.68923155355, 62187.0, 62315.6884215576, 62508.687456562424, 62973.370266297665, 13204.801927971088, 15770.0, 15970.441034563966, 15974.36102555908, 15998.9200053999, 10732.302400343953, 10762.623308184176, 12126.454309556091, 12167.634970950885, 12335.259884406785, 16849.0, 20050.699239511418, 20184.798152018586, 20208.66557018105, 20388.79611203869, 7242.311980361857, 8279.58602069894, 8772.517511536927, 8942.46345219289, 9032.277417806692, 944.8771659684197, 952.2477242978108, 995.0, 1004.4977511244377, 1069.7218723132041, 27839.30401739973, 28789.568156477668, 28893.0, 29185.708142918724, 29389.706102939126, 963.1764841060932, 1036.6164519127972, 1088.77135801481, 1129.0685184722636, 1154.6016624264614, 14572.489962851248, 14711.55865324042, 14793.260336983109, 14965.850341496664, 15058.32237549313, 462834.0, 534086.0, 538721.0, 539048.0, 540352.0876769294, 55846.0, 55940.0, 56188.43811561832, 56466.0, 56478.152827707614, 1260.861305256421, 1404.56458497866, 1448.8696017358277, 1453.6729235921832, 1457.5700168450333, 25273.0, 27554.862225688743, 28550.0, 28932.855335723187, 29092.854535727187, 46773.53226467828, 46876.29685554651, 46964.7651761739, 46995.0, 47273.0, 501599.0, 506782.0, 507253.0, 510722.0, 511275.0, 32416.513752293264, 42127.789361053, 43214.78392608017, 43387.04758285821, 43454.0, 44408.77795611001, 44994.77502612466, 45470.54529454663, 45668.77165614284, 46294.305585415575, 34082.65917340795, 34976.65023349734, 35252.0, 35396.82301588476, 35570.822145889106, 33279.33441331112, 34829.78095766636, 35083.64916350804, 35391.11522211965, 36665.81667091647, 35886.64113358833, 36172.0, 36227.45658815067, 36718.26563468769, 37471.250574988895, 30273.24316892095, 31572.947758395632, 32130.518042229854, 32186.35627287394, 32714.836425817717, 24326.39184020343, 24838.751612484368, 25010.74989250084, 25129.74870251274, 25256.747432526176], "unit": "score", "name": "ext.html", "value": 19465.979414877303}, {"lowerIsBetter": false, "replicates": [360.4935066231945, 361.6166863125087, 364.0389372057768, 365.6708961934259, 371.127849553549, 15640.530784076496, 19073.04634768261, 19613.0, 19682.507937301576, 20375.28686495973, 18776.71834922474, 18974.241030358804, 19098.904505477487, 19305.903470482626, 19403.4178974631, 4575.542445755431, 4916.770807298176, 5015.573676237515, 5284.365876094874, 5289.2859463972445, 5085.898282034357, 5852.912206316909, 5892.204552385438, 5894.086416605433, 5928.970355148218, 3855.151866589346, 5593.629560757599, 5600.411956744524, 5841.766329346821, 5846.824595262149, 5749.540036797067, 5773.787504623992, 5801.187833703285, 5810.970945145247, 5812.099124635688, 5403.83788486346, 5463.836084917459, 5538.335399752015, 5571.387147413781, 5571.804986825442, 12887.0, 14091.78862317066, 23548.411289717722, 23725.762742372528, 24158.79206039691, 2089.6447603907372, 2190.9921436139393, 2210.9226177083888, 2388.703608900728, 2625.2386807825706, 9646.180074693659, 10695.572177112907, 12357.949574286196, 14760.0, 14965.625859353495, 1807.168702396899, 1849.7965223825368, 1853.3420635674277, 1856.916438760259, 1911.340587497325, 99545.0, 102538.0, 102894.48552757189, 104126.99999999924, 105381.0, 9394.483303418378, 11055.281406708538, 11328.376939268419, 11397.487113079931, 11422.828657570142, 13544.864551354558, 13569.660758481117, 13621.182729036289, 13626.250556219504, 13675.042747007614, 7778.027746531684, 7813.257740514642, 8449.281811046007, 8584.39909206362, 8594.914050859536, 8577.614007369682, 8625.180607842245, 8669.696560620348, 8680.392372533863, 8684.696035638723, 3831.7126215533945, 4354.8258069677495, 4357.041450880801, 4448.888777780581, 4457.732536047847, 1875.6717574424422, 1910.455520176743, 1911.4838993471963, 1916.3484415298865, 1920.6350793349218, 394.9624785645359, 830.667732906842, 844.55660778092, 855.683397143061, 897.1028971028971, 10493.0, 11344.376059316652, 11704.0, 11851.585194518151, 11876.940615296868, 444.53324009789594, 447.2597850557333, 465.8812002939297, 890.6817909493985, 997.5211898288862, 7824.6870125194355, 7947.9205207948335, 10347.586096556204, 10523.579056837794, 10643.52104155315, 610841.0, 623965.0, 633232.0, 761791.0, 768244.0, 112735.0, 114819.0, 117602.41198793951, 122463.3876830628, 124455.0, 1136.755597546515, 1202.0623913347604, 1207.4083698987433, 1229.065909908476, 1272.9490820367082, 17905.820941790935, 18150.636987260445, 18203.908980455013, 18328.72506912424, 18378.908105459923, 44457.443404526915, 48141.518584813704, 50664.74667626638, 50707.74646126746, 51489.45531634057, 57408.71295643662, 70911.0, 72148.63925680338, 72222.0, 74115.51768964698, 7265.164506081657, 7710.691572337044, 7712.92287077122, 7736.651850666846, 7772.0, 10721.909227700524, 11523.711907202052, 12005.339706316236, 12237.816432753338, 12412.689682758004, 10035.0, 10148.137408320375, 10370.533326000197, 10379.792404152025, 10684.732881678021, 10191.235657325582, 10207.0, 10273.589056437957, 10775.461226938465, 10840.199986084392, 10549.9472502637, 10781.622643207764, 10968.177386696188, 10989.120870330195, 11221.775564488828, 7458.440616953859, 7728.149903510497, 7807.375409967302, 7809.258120478546, 7817.843643127219, 8975.865362019706, 10194.541245644112, 10628.468576571295, 10721.731956701145, 11029.83455248156], "unit": "score", "name": "jquery.html", "value": 8924.267557924042}, {"lowerIsBetter": false, "replicates": [1533.9769903451447, 1536.279367108838, 1751.8773685841995, 1856.0534127594922, 1875.5967466994593, 7846.136924938252, 8424.115467875878, 8614.612342444589, 8763.693270735517, 8771.91228087719, 8511.191436813508, 8577.31381489481, 8621.612027458763, 8692.869606955901, 8717.651293948235, 2457.8156638252112, 2481.131603938625, 2499.0878329409816, 2499.6375525548783, 2500.9749902500926, 2283.1438210671, 2370.589499247945, 2443.6701045358827, 2498.4378514834107, 2504.887280072401, 2182.8908554572286, 2406.0736616402637, 2462.384403899025, 2470.493548822487, 2491.5888878335054, 2435.403326185078, 2452.987735061331, 2470.3824043989002, 2470.6788117544693, 2472.5920223163157, 2124.851260411772, 2465.4822487277693, 2470.5800013997664, 2479.690038745157, 2480.1319538161497, 8690.522021288827, 8717.956410217972, 8737.563121843883, 8745.0, 8758.474491530465, 5340.118880384732, 5388.245645609618, 5399.541039011649, 5449.618526703132, 5466.34403871534, 3524.594671612772, 3646.4165733482514, 3704.9811301891928, 3716.349638813197, 3722.9813850930573, 893.8858209844628, 917.8256131335091, 1056.5456853552969, 1092.82514797632, 1093.278436232091, 11429.199956003, 11448.71378215543, 11540.134489913291, 11550.826737598944, 11585.6524304271, 4654.557817007379, 4657.43338706148, 4698.694584851974, 4783.282507623884, 4796.208625576811, 9235.0, 9241.537923103953, 9249.537523123818, 9257.537123143817, 9285.675001374919, 5216.37403511581, 5234.450382709761, 5326.0, 5335.33308336458, 5362.973185134049, 4930.2358134488495, 4956.256561515802, 4959.479254678279, 4975.0, 4979.676321039121, 3675.4303083022173, 3706.8517259309865, 3711.0907827581877, 3734.0478178064964, 3740.4389341598976, 1137.766757814646, 1186.4423720851187, 1190.678516800459, 1194.552042983881, 1198.7413216123036, 1101.5869049106584, 1106.1040557148735, 1127.430647523012, 1246.7132559511363, 1342.9865701343058, 7907.2488113629115, 7981.481203721855, 8013.959930200428, 8124.796880077927, 8315.542645154454, 1125.7692173104494, 1179.55177032727, 1182.9112816538623, 1183.331417748969, 1214.684182112657, 6214.285357183891, 6309.08518264849, 6310.0, 6393.296737358887, 6408.935910640927, 10186.898131018743, 10428.904964978568, 10437.112845408225, 10571.418571978462, 10585.364878107339, 10151.796964060824, 10278.588856445807, 10456.268061235793, 10456.738581535523, 10511.789764204826, 8056.194380562014, 8098.919010809935, 8108.878366824502, 8113.918860811316, 8254.339652827759, 7931.484453510503, 7974.242446967529, 8001.919980800118, 8062.838743224986, 8203.384746144182, 9426.434413935185, 9468.195203407788, 9587.233021358135, 9591.184749296388, 9749.853752193581, 9372.578233979351, 9640.084192001748, 9729.978352272909, 9915.752106197115, 10054.0, 6436.806895793134, 7387.556746595222, 7426.665800039119, 7495.325420712162, 7521.796512557965, 7437.144728356092, 7709.653065612173, 8061.193880612126, 8085.9595702021115, 8128.83742325162, 6854.9657251713425, 6956.478264130312, 7504.887426688713, 7563.773086807405, 7739.380849532136, 7403.333699967029, 7508.812279693051, 7536.0956685198125, 7598.886016709865, 7605.695772169051, 7627.54234745917, 7701.383889288732, 7715.768526944201, 7774.067111946377, 7778.88331675014, 6957.826054348682, 6986.6855991481525, 7005.2644472329675, 7011.088558487364, 7025.121859767529, 6889.242183359726, 6936.34104760047, 7023.33278338557, 7034.155901291878, 7052.224255332012], "unit": "score", "name": "mootools.html", "value": 4880.122151755144}, {"lowerIsBetter": false, "replicates": [327.2179491016471, 330.7387164140329, 333.85310463396087, 336.67006333792875, 339.9439092549731, 6627.701753421095, 6752.797416077519, 6773.762918297867, 6774.695138718757, 6778.356056174668, 6773.153355830521, 6777.457803375731, 6800.251972283045, 6805.761798337059, 6874.79375618731, 5011.574016208627, 5021.27191557224, 5027.648064635477, 5035.068512325213, 5044.646874718771, 4740.146773580754, 5007.774650140735, 5028.84913452597, 5032.4212715537815, 5039.143345631252, 4874.756262186894, 4876.366072410582, 4887.071456423286, 4890.926636100461, 4897.681650692693, 4859.975700121495, 4860.7326597037145, 4860.9756951215195, 4863.610911127119, 4883.14544954635, 4134.896627584304, 4142.565030671796, 4146.336586146233, 4154.1068670236045, 4160.980559762847, 5204.34945631796, 6212.782552610682, 6453.096566480696, 6462.353764623547, 6467.32093130224, 5694.77220911163, 5702.629329093637, 5750.568707346965, 5763.3948435414095, 5783.739731712083, 6888.380045795852, 7020.40326572242, 7127.322904324133, 7160.892586611205, 7186.353228209487, 4597.54024597541, 4600.079984003212, 4633.119707255611, 4633.86098417048, 4640.187967105777, 7577.0, 7641.541507509567, 7651.655675494616, 7675.462717609769, 7681.57751323677, 4579.771011449414, 4666.836660716858, 4691.812327506861, 4720.622350211975, 4721.693089949143, 4287.735118140156, 4525.52481989393, 4795.688280261772, 4802.951970480321, 4813.542713442217, 5013.323201367769, 5726.856828579319, 5727.541796656257, 5750.051241545182, 5755.3381361143165, 5556.305461817273, 7135.03578272264, 7281.235470275651, 7286.8178295541975, 7293.124825021031, 1496.7876020423491, 1563.2262030294849, 1613.1369717201242, 1653.231247469908, 1660.4603503861294, 1044.0, 1054.1250761867632, 1065.9500392113762, 1066.861308029951, 1068.3750006246278, 6723.058771771955, 6725.092112564839, 6726.327367263235, 6761.391474767294, 6761.492888033319, 7527.096748390119, 7542.2834830691, 7542.773716788505, 7556.093268807778, 7565.735199268, 6582.539222254396, 6735.057092007123, 6742.696578653972, 6751.291114432914, 6843.520953533304, 3836.9256608149763, 3997.6601988830694, 4036.8990775230855, 4038.8788336349958, 4063.167050754588, 6408.61548307103, 7181.569105853666, 7965.761027169194, 7988.600569971478, 8012.0786109596975, 7678.270564296383, 7840.33357164636, 7856.371490280764, 7876.527408355517, 7913.089994650573, 7543.509671871311, 7648.1204661463535, 7932.286094251545, 7936.484128531627, 7941.324987376138, 6046.881326954527, 6057.454829065406, 7445.478816482794, 7457.0, 7515.549067055994, 5632.5775566831835, 7006.824829379307, 7343.8898416522725, 7345.522541034816, 7346.33882950537, 6867.759628413181, 7237.203907570058, 7624.656890440055, 7789.727359542616, 7796.493227940393, 4646.7444290564345, 4713.9057218856115, 4732.384789977281, 4737.502562231054, 4738.0, 7539.0576177977755, 7551.773446796605, 7557.470977031555, 7559.508631938907, 7573.6213189341415, 7083.893741593984, 7218.639068046682, 7286.744963926237, 7311.451641127043, 7312.890306645299, 7266.6729997151315, 7280.563166210044, 7282.708691652275, 7299.963500182465, 7345.816354590964, 6921.2732663071665, 7103.360697537247, 7115.466340024415, 7122.501424900207, 7153.928460715326, 7267.491275610657, 7291.453141014339, 7299.0, 7311.159216690149, 7332.9266707332245, 7121.465890058163, 7122.394596459359, 7123.786286411416, 7143.1428228612895, 7151.642417878981], "unit": "score", "name": "prototype.html", "value": 5231.111612445194}, {"lowerIsBetter": false, "replicates": [620.7423919073585, 658.611419262635, 684.3635419060278, 720.8233982674245, 723.8190452386904, 12156.27062376257, 15135.772963405543, 15153.772693409608, 17601.0, 17665.293388264487, 15957.042577445362, 16010.279537420814, 16040.0, 16056.83943160568, 16087.034777913334, 697.7209116353448, 845.4842546046906, 847.7711018025129, 853.0957185383497, 874.4359887872318, 857.3955361470148, 864.2999170671776, 870.7997160653053, 872.7032808844991, 876.198278575103, 895.9417637853551, 906.9410488318238, 910.6220918318922, 910.7313342563959, 912.3020889019905, 873.4191762477944, 893.6872094766844, 903.8960519540271, 904.7964208053169, 908.0102688070035, 619.5105866365566, 669.7957123077459, 671.9596824190564, 673.4376795375867, 673.723773252964, 15251.61870953224, 15464.5360639181, 15487.457938972195, 15578.844211557853, 15605.297761600756, 12565.93717031418, 12687.175333603378, 12715.809262860972, 12901.806472902914, 13257.933710331483, 10083.042110999444, 10892.019718225318, 11276.718082047932, 11404.315741055563, 12091.576794812227, 3563.8773786257507, 3567.4827150063356, 3569.928601427957, 3587.1749497615697, 3696.0205545530457, 80382.19617803863, 80853.59573202155, 81673.18326816715, 81884.0, 83664.0, 8592.699255526026, 9265.768355791159, 9683.467409292556, 9829.361091529028, 9872.308938374388, 19813.405597832087, 20263.79736202619, 20500.282490112775, 20539.28112516055, 20556.588868222552, 7528.360089392353, 7540.962295188599, 7642.159362470124, 7692.384609231248, 7693.384529237647, 4166.354215096665, 4211.410402543646, 4226.4716910386205, 4229.809658565372, 4235.78821058952, 3547.290541891632, 3592.4072528033103, 3605.8197090145386, 3614.7348428049972, 3628.129248980226, 651.4723074309824, 654.2835595023537, 656.5437021270171, 677.0757915445381, 679.741698154698, 536.3135186960697, 541.5860735009702, 569.4789267819898, 599.0863932502967, 629.4303655192059, 8063.1130575636635, 8303.875441868377, 8409.831803363899, 8466.74599762008, 8530.914690853137, 493.96048316134625, 504.89649621827436, 549.5603517186235, 599.1701493431542, 622.9065640153923, 4002.2595819773437, 4111.691623128278, 4263.552327005682, 4323.502797178365, 4341.370501277297, 90865.0, 92040.0, 92279.0, 92417.0, 93715.062849372, 78971.0, 79212.4157516858, 79377.80933286005, 79726.0, 80367.0, 69997.30002700009, 70063.64968175127, 70348.64825675839, 70803.64598176976, 71034.0, 8744.387892847439, 8802.207801297915, 8888.77778055528, 8960.327975402, 8968.148025937526, 41812.95467613334, 45577.54422455865, 47076.05701401304, 47449.0, 48736.29422970179, 63160.68419658056, 65326.0, 66498.66750666215, 67512.0, 68781.65609171923, 10889.945550272198, 10981.121510279318, 11247.044001259985, 11251.381174035507, 11405.973462388425, 11771.411429428323, 11814.119216107687, 12232.327222002876, 12622.179558328678, 12622.621321360373, 9588.856167157637, 11145.164112691742, 11312.490937907649, 11439.570053743282, 11659.417029148339, 11599.304041757521, 11603.593874214363, 11645.708857278636, 12194.939025304817, 12547.184433011826, 10824.24230303871, 11072.833907491233, 11532.25040372373, 11679.240849344766, 12140.079369026273, 8260.29787468072, 9335.299852510952, 9584.520773961414, 9587.472689002172, 9747.220222382051, 9234.307426942873, 9880.950595246977, 9884.703458896245, 9884.950575247365, 9966.40201587907], "unit": "score", "name": "yui.html", "value": 6930.654604949258}], "name": "dromaeo_css", "value": 7468.919357938855}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 109.0, 110.0, 114.0, 118.0, 138.0, 99.0, 118.0, 165.0, 165.0], "unit": "score", "name": "ai-astar", "value": 125.2}, {"lowerIsBetter": true, "replicates": [151.0, 123.0, 150.0, 149.0, 145.0, 149.0, 150.0, 147.0, 183.0, 115.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [192.0, 193.0, 219.0, 201.0, 262.0, 268.0, 200.0, 195.0, 201.0, 197.0], "unit": "score", "name": "audio-dft", "value": 212.8}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 75.0, 109.0, 59.0, 56.0, 59.0, 59.0, 108.0, 60.0], "unit": "score", "name": "audio-fft", "value": 72.7}, {"lowerIsBetter": true, "replicates": [73.0, 85.0, 125.0, 80.0, 80.0, 82.0, 115.0, 83.0, 82.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 92.0}, {"lowerIsBetter": true, "replicates": [87.0, 93.0, 88.0, 95.0, 88.0, 93.0, 87.0, 95.0, 87.0, 106.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.9}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 97.0, 98.0, 150.0, 132.0, 97.0, 150.0, 152.0], "unit": "score", "name": "imaging-darkroom", "value": 116.6}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 91.0, 95.0, 92.0, 113.0, 149.0, 94.0, 91.0, 91.0], "unit": "score", "name": "imaging-desaturate", "value": 99.9}, {"lowerIsBetter": true, "replicates": [54.0, 52.0, 53.0, 53.0, 56.0, 55.0, 54.0, 53.0, 46.0, 81.0], "unit": "score", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [62.0, 67.0, 72.0, 78.0, 72.0, 72.0, 67.0, 65.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [85.0, 83.0, 86.0, 85.0, 87.0, 83.0, 86.0, 84.0, 87.0, 98.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.4}, {"lowerIsBetter": true, "replicates": [120.0, 133.0, 130.0, 122.0, 146.0, 143.0, 114.0, 129.0, 152.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.6}, {"lowerIsBetter": true, "replicates": [171.0, 171.0, 150.0, 141.0, 150.0, 171.0, 179.0, 173.0, 141.0, 125.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 157.2}, {"lowerIsBetter": true, "replicates": [61.0, 100.0, 95.0, 68.0, 69.0, 65.0, 80.0, 92.0, 95.0, 98.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 82.3}], "name": "kraken", "value": 1538.1}]} 06:21:25 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1538.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7468.92"}}} 06:21:25 INFO - Return code: 0 06:21:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:21:25 INFO - # TBPL SUCCESS # 06:21:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:21:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:21:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:21:25 INFO - 2016-02-12 06:21:25.801 screenresolution[1702:11421] starting screenresolution argv=screenresolution get 06:21:25 INFO - 2016-02-12 06:21:25.803 screenresolution[1702:11421] Display 0: 1600x1200x32@60 06:21:25 INFO - 2016-02-12 06:21:25.809 screenresolution[1703:11424] starting screenresolution argv=screenresolution list 06:21:25 INFO - Available Modes on Display 0 06:21:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:21:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:21:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:21:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:21:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:21:26 INFO - Intel Iris: 06:21:26 INFO - Chipset Model: Intel Iris 06:21:26 INFO - Type: GPU 06:21:26 INFO - Bus: Built-In 06:21:26 INFO - VRAM (Dynamic, Max): 1536 MB 06:21:26 INFO - Vendor: Intel (0x8086) 06:21:26 INFO - Device ID: 0x0a2e 06:21:26 INFO - Revision ID: 0x0009 06:21:26 INFO - Displays: 06:21:26 INFO - Display: 06:21:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:21:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:21:26 INFO - Display Serial Number: 1600x1200 60 06:21:26 INFO - Main Display: Yes 06:21:26 INFO - Mirror: Off 06:21:26 INFO - Online: Yes 06:21:26 INFO - Rotation: Supported 06:21:26 INFO - Return code: 0 06:21:26 INFO - Running post-action listener: _resource_record_post_action 06:21:26 INFO - Running post-run listener: _resource_record_post_run 06:21:27 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 34037248; Write bytes: 711777792; Read time: 357; Write time: 1944 06:21:27 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 403794432; Write bytes: 402839040; Read time: 30234; Write time: 707 06:21:27 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 32247296; Write bytes: 304752640; Read time: 339; Write time: 1221 06:21:27 INFO - Running post-run listener: _upload_blobber_files 06:21:27 INFO - Blob upload gear active. 06:21:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:21:27 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 06:21:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:21:27 INFO - (blobuploader) - INFO - Open directory for files ... 06:21:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:21:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:21:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:21:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:21:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:21:28 INFO - (blobuploader) - INFO - Done attempting. 06:21:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:21:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:21:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:21:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:21:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:21:29 INFO - (blobuploader) - INFO - Done attempting. 06:21:29 INFO - (blobuploader) - INFO - Iteration through files over. 06:21:29 INFO - Return code: 0 06:21:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:21:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:21:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11e02a4224273090806d048e70eb965480f6b22cedd523375a3a14edea406d25077cb6f4996b9b0a40b35865bc6381a58d4ac129d18be7c065a3c4f38b71e96c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bbd9fc719046c07de633ea9b04c607bb642de38184637bd1c37763752982575d23e011eeb2b3fadabea5c641ff6c1ea496beef9ad7a9851c5303d9a090b2545"} 06:21:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:21:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:21:29 INFO - Contents: 06:21:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11e02a4224273090806d048e70eb965480f6b22cedd523375a3a14edea406d25077cb6f4996b9b0a40b35865bc6381a58d4ac129d18be7c065a3c4f38b71e96c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bbd9fc719046c07de633ea9b04c607bb642de38184637bd1c37763752982575d23e011eeb2b3fadabea5c641ff6c1ea496beef9ad7a9851c5303d9a090b2545"} 06:21:29 INFO - Running post-run listener: copy_logs_to_upload_dir 06:21:29 INFO - Copying logs to upload dir... 06:21:29 INFO - mkdir: /builds/slave/test/build/upload/logs 06:21:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.088157 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-02-12 06:21:29.858497) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-12 06:21:29.861780) ========= 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.Zf3lad0fuz/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.3cPxT4QTAL/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11e02a4224273090806d048e70eb965480f6b22cedd523375a3a14edea406d25077cb6f4996b9b0a40b35865bc6381a58d4ac129d18be7c065a3c4f38b71e96c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bbd9fc719046c07de633ea9b04c607bb642de38184637bd1c37763752982575d23e011eeb2b3fadabea5c641ff6c1ea496beef9ad7a9851c5303d9a090b2545"} build_url:https://queue.taskcluster.net/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011541 build_url: 'https://queue.taskcluster.net/v1/task/IyW3VspHRNimgHYf9Hi1-A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11e02a4224273090806d048e70eb965480f6b22cedd523375a3a14edea406d25077cb6f4996b9b0a40b35865bc6381a58d4ac129d18be7c065a3c4f38b71e96c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bbd9fc719046c07de633ea9b04c607bb642de38184637bd1c37763752982575d23e011eeb2b3fadabea5c641ff6c1ea496beef9ad7a9851c5303d9a090b2545"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-12 06:21:29.888812) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 06:21:29.889128) ========= 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.Zf3lad0fuz/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.3cPxT4QTAL/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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.005128 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 06:21:29.937471) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-12 06:21:29.937799) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-12 06:21:29.938193) ========= ========= Total master_lag: 0.29 =========