builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0072 starttime: 1454592178.83 results: success (0) buildid: 20160204024424 builduid: 6a1c575e585c4d67b0e83ec7fe01ea5e revision: d577f0c34dee0bf5d0054bea3d8535af03f2b85d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-04 05:22:58.825633) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-04 05:22:58.826065) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-04 05:22:58.826355) ========= 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.EDyEhqUqAL/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.i8Zozrur6I/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.005589 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-04 05:22:58.848790) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-04 05:22:58.849096) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-04 05:22:58.864787) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:22:58.865130) ========= 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.EDyEhqUqAL/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.i8Zozrur6I/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.005528 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:22:58.914313) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-04 05:22:58.914627) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-04 05:22:58.914974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:22:58.915247) ========= 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.EDyEhqUqAL/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.i8Zozrur6I/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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-04 05:22:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 37.8M=0s 2016-02-04 05:22:59 (37.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.478855 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:22:59.409095) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:22:59.409414) ========= 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.EDyEhqUqAL/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.i8Zozrur6I/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.019540 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:22:59.458180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-04 05:22:59.458594) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d577f0c34dee0bf5d0054bea3d8535af03f2b85d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d577f0c34dee0bf5d0054bea3d8535af03f2b85d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EDyEhqUqAL/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.i8Zozrur6I/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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-04 05:22:59,530 truncating revision to first 12 chars 2016-02-04 05:22:59,530 Setting DEBUG logging. 2016-02-04 05:22:59,530 attempt 1/10 2016-02-04 05:22:59,530 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d577f0c34dee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-04 05:23:01,070 unpacking tar archive at: fx-team-d577f0c34dee/testing/mozharness/ program finished with exit code 0 elapsedTime=1.788957 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-04 05:23:01.263055) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-04 05:23:01.263393) ========= echo d577f0c34dee0bf5d0054bea3d8535af03f2b85d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd577f0c34dee0bf5d0054bea3d8535af03f2b85d'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EDyEhqUqAL/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.i8Zozrur6I/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 d577f0c34dee0bf5d0054bea3d8535af03f2b85d program finished with exit code 0 elapsedTime=0.005036 script_repo_revision: 'd577f0c34dee0bf5d0054bea3d8535af03f2b85d' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-04 05:23:01.312899) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-04 05:23:01.313194) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-04 05:23:01.325670) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-04 05:23:01.325951) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EDyEhqUqAL/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.i8Zozrur6I/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:23:01 INFO - MultiFileLogger online at 20160204 05:23:01 in /builds/slave/test 05:23:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:23:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:23:01 INFO - {'append_to_log': False, 05:23:01 INFO - 'base_work_dir': '/builds/slave/test', 05:23:01 INFO - 'blob_upload_branch': 'Fx-Team', 05:23:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:23:01 INFO - 'branch': 'Fx-Team', 05:23:01 INFO - 'buildbot_json_path': 'buildprops.json', 05:23:01 INFO - 'config_files': ('talos/mac_config.py',), 05:23:01 INFO - 'default_actions': ('clobber', 05:23:01 INFO - 'read-buildbot-config', 05:23:01 INFO - 'download-and-extract', 05:23:01 INFO - 'populate-webroot', 05:23:01 INFO - 'create-virtualenv', 05:23:01 INFO - 'install', 05:23:01 INFO - 'run-tests'), 05:23:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:23:01 INFO - 'download_minidump_stackwalk': True, 05:23:01 INFO - 'download_symbols': 'ondemand', 05:23:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:23:01 INFO - 'tooltool.py': '/tools/tooltool.py', 05:23:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:23:01 INFO - '/tools/misc-python/virtualenv.py')}, 05:23:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:23:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:23:01 INFO - 'installer_path': 'installer.exe', 05:23:01 INFO - 'log_level': 'info', 05:23:01 INFO - 'log_name': 'talos', 05:23:01 INFO - 'log_to_console': True, 05:23:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:23:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:23:01 INFO - 'opt_config_files': (), 05:23:01 INFO - 'pip_index': False, 05:23:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:23:01 INFO - 'cmd': ('bash', 05:23:01 INFO - '-c', 05:23:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:23:01 INFO - 'enabled': True, 05:23:01 INFO - 'halt_on_failure': False, 05:23:01 INFO - 'name': 'check_screen_resolution'},), 05:23:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:23:01 INFO - 'cmd': ('bash', 05:23:01 INFO - '-c', 05:23:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:23:01 INFO - 'enabled': True, 05:23:01 INFO - 'halt_on_failure': False, 05:23:01 INFO - 'name': 'check_screen_resolution'},), 05:23:01 INFO - 'run_cmd_checks_enabled': True, 05:23:01 INFO - 'sps_profile': False, 05:23:01 INFO - 'sps_profile_interval': 0, 05:23:01 INFO - 'suite': 'dromaeojs-e10s', 05:23:01 INFO - 'system_bits': '32', 05:23:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:23:01 INFO - 'title': 't-yosemite-r7-0072', 05:23:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:23:01 INFO - 'use_talos_json': True, 05:23:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:23:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:23:01 INFO - 'work_dir': 'build'} 05:23:01 INFO - ##### 05:23:01 INFO - ##### Running clobber step. 05:23:01 INFO - ##### 05:23:01 INFO - Running pre-action listener: _resource_record_pre_action 05:23:01 INFO - Running main action method: clobber 05:23:01 INFO - rmtree: /builds/slave/test/build 05:23:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:23:02 INFO - Running post-action listener: _resource_record_post_action 05:23:02 INFO - ##### 05:23:02 INFO - ##### Running read-buildbot-config step. 05:23:02 INFO - ##### 05:23:02 INFO - Running pre-action listener: _resource_record_pre_action 05:23:02 INFO - Running main action method: read_buildbot_config 05:23:02 INFO - Using buildbot properties: 05:23:02 INFO - { 05:23:02 INFO - "project": "", 05:23:02 INFO - "product": "firefox", 05:23:02 INFO - "script_repo_revision": "production", 05:23:02 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 05:23:02 INFO - "repository": "", 05:23:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 05:23:02 INFO - "buildid": "20160204024424", 05:23:02 INFO - "pgo_build": "False", 05:23:02 INFO - "basedir": "/builds/slave/test", 05:23:02 INFO - "buildnumber": 291, 05:23:02 INFO - "slavename": "t-yosemite-r7-0072", 05:23:02 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:23:02 INFO - "platform": "yosemite_r7", 05:23:02 INFO - "scheduler": "tests-fx-team-macosx64-talos", 05:23:02 INFO - "branch": "fx-team", 05:23:02 INFO - "repo_path": "integration/fx-team", 05:23:02 INFO - "revision": "d577f0c34dee0bf5d0054bea3d8535af03f2b85d", 05:23:02 INFO - "stage_platform": "macosx64", 05:23:02 INFO - "builduid": "6a1c575e585c4d67b0e83ec7fe01ea5e", 05:23:02 INFO - "slavebuilddir": "test" 05:23:02 INFO - } 05:23:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 05:23:02 INFO - Running post-action listener: _resource_record_post_action 05:23:02 INFO - ##### 05:23:02 INFO - ##### Running download-and-extract step. 05:23:02 INFO - ##### 05:23:02 INFO - Running pre-action listener: _resource_record_pre_action 05:23:02 INFO - Running main action method: download_and_extract 05:23:02 INFO - mkdir: /builds/slave/test/build/tests 05:23: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')]} 05:23:02 INFO - https://queue.taskcluster.net/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:23:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/test_packages.json 05:23:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/test_packages.json 05:23:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:23:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:23:04 INFO - Downloaded 1277 bytes. 05:23:04 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:23:04 INFO - Using the following test package requirements: 05:23:04 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:23:04 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:23:04 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 05:23:04 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:23:04 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 05:23:04 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:23:04 INFO - u'jsshell-mac.zip'], 05:23:04 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:23:04 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 05:23:04 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:23:04 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:23:04 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 05:23:04 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:23:04 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 05:23:04 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:23:04 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 05:23:04 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:23:04 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:23:04 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 05:23:04 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:23:04 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')]} 05:23:04 INFO - https://queue.taskcluster.net/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:23:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:23:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:23:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/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 05:23:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/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 05:23:05 INFO - Downloaded 17746617 bytes. 05:23:05 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'] 05:23:05 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 05:23:08 INFO - Return code: 0 05:23:08 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 05:23:08 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')]} 05:23:08 INFO - https://queue.taskcluster.net/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:23:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:23:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:23:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/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 05:23:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/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 05:23:09 INFO - Downloaded 17746617 bytes. 05:23:09 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'] 05:23:09 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 05:23:13 INFO - Return code: 0 05:23:13 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')]} 05:23:13 INFO - https://queue.taskcluster.net/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:23:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:23:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:23:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/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 05:23:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/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 05:23:14 INFO - Downloaded 10706582 bytes. 05:23:14 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'] 05:23:14 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 05:23:15 INFO - Return code: 0 05:23: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')]} 05:23:15 INFO - https://queue.taskcluster.net/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:23:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:23:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:23:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 05:23:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/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 05:23:17 INFO - Downloaded 111279285 bytes. 05:23:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:23:17 INFO - mkdir: /builds/slave/test/properties 05:23:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:23:17 INFO - Writing to file /builds/slave/test/properties/build_url 05:23:17 INFO - Contents: 05:23:17 INFO - build_url:https://queue.taskcluster.net/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:23:19 INFO - Running post-action listener: _resource_record_post_action 05:23:19 INFO - Running post-action listener: set_extra_try_arguments 05:23:19 INFO - ##### 05:23:19 INFO - ##### Running populate-webroot step. 05:23:19 INFO - ##### 05:23:19 INFO - Running pre-action listener: _resource_record_pre_action 05:23:19 INFO - Running main action method: populate_webroot 05:23:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:23:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:23:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:23:19 INFO - '--tppagecycles', 05:23:19 INFO - '7'], 05:23:19 INFO - 'tests': ['tsvgm']}}, 05:23:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:23:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:23:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:23:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:23:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:23:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:23:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:23:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:19 INFO - 'talos_options': ['--e10s'], 05:23:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:23:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:19 INFO - 'tests': ['damp', 'tps']}, 05:23:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:19 INFO - 'talos_options': ['--e10s'], 05:23:19 INFO - 'tests': ['damp', 'tps']}, 05:23:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:23:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:23:19 INFO - 'other': {'tests': ['a11yr', 05:23:19 INFO - 'ts_paint', 05:23:19 INFO - 'tpaint', 05:23:19 INFO - 'sessionrestore', 05:23:19 INFO - 'sessionrestore_no_auto_restore']}, 05:23:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:23:19 INFO - 'tests': ['a11yr', 05:23:19 INFO - 'ts_paint', 05:23:19 INFO - 'tpaint', 05:23:19 INFO - 'sessionrestore', 05:23:19 INFO - 'sessionrestore_no_auto_restore']}, 05:23:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:23:19 INFO - 'tests': ['a11yr', 05:23:19 INFO - 'ts_paint', 05:23:19 INFO - 'tpaint', 05:23:19 INFO - 'sessionrestore', 05:23:19 INFO - 'sessionrestore_no_auto_restore']}, 05:23:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:23:19 INFO - 'tests': ['a11yr', 05:23:19 INFO - 'ts_paint', 05:23:19 INFO - 'tpaint', 05:23:19 INFO - 'sessionrestore', 05:23:19 INFO - 'sessionrestore_no_auto_restore']}, 05:23:19 INFO - 'other_l64': {'tests': ['a11yr', 05:23:19 INFO - 'ts_paint', 05:23:19 INFO - 'tpaint', 05:23:19 INFO - 'sessionrestore', 05:23:19 INFO - 'sessionrestore_no_auto_restore']}, 05:23:19 INFO - 'other_nol64': {'tests': ['a11yr', 05:23:19 INFO - 'ts_paint', 05:23:19 INFO - 'tpaint', 05:23:19 INFO - 'sessionrestore', 05:23:19 INFO - 'sessionrestore_no_auto_restore']}, 05:23:19 INFO - 'svgr': {'tests': ['tsvgx', 05:23:19 INFO - 'tsvgr_opacity', 05:23:19 INFO - 'tart', 05:23:19 INFO - 'tscrollx', 05:23:19 INFO - 'cart']}, 05:23:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:23:19 INFO - 'tests': ['tsvgx', 05:23:19 INFO - 'tsvgr_opacity', 05:23:19 INFO - 'tart', 05:23:19 INFO - 'tscrollx', 05:23:19 INFO - 'cart']}, 05:23:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:19 INFO - 'tests': ['tp5o']}, 05:23:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:19 INFO - 'talos_options': ['--e10s'], 05:23:19 INFO - 'tests': ['tp5o']}, 05:23:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:19 INFO - 'talos_options': ['--xperf_path', 05:23:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:23:19 INFO - 'tests': ['tp5n']}, 05:23:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:19 INFO - 'talos_options': ['--e10s', 05:23:19 INFO - '--xperf_path', 05:23:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:23:19 INFO - 'tests': ['tp5n']}}, 05:23:19 INFO - 'talos.zip': {'path': '', 05:23:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:23:19 INFO - Running post-action listener: _resource_record_post_action 05:23:19 INFO - ##### 05:23:19 INFO - ##### Running create-virtualenv step. 05:23:19 INFO - ##### 05:23:19 INFO - Running pre-action listener: _resource_record_pre_action 05:23:19 INFO - Running main action method: create_virtualenv 05:23:19 INFO - Creating virtualenv /builds/slave/test/build/venv 05:23:19 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 05:23:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:23:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:23:19 INFO - Using real prefix '/tools/python27' 05:23:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:23:20 INFO - Installing distribute.............................................................................................................................................................................................done. 05:23:22 INFO - Installing pip.................done. 05:23:22 INFO - Return code: 0 05:23:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:22 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 0x104aa8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aaf4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6a3d903e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10494dd30>, '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 0x1047b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104943b20>, '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.EDyEhqUqAL/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.i8Zozrur6I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:23:22 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 05:23:22 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 05:23:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EDyEhqUqAL/Render', 05:23:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:23:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:23:22 INFO - 'HOME': '/Users/cltbld', 05:23:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:23:22 INFO - 'LOGNAME': 'cltbld', 05:23:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:22 INFO - 'MOZ_NO_REMOTE': '1', 05:23:22 INFO - 'NO_EM_RESTART': '1', 05:23:22 INFO - 'PAGER': '/bin/cat', 05:23:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:23:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:22 INFO - 'PWD': '/builds/slave/test', 05:23:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:23:22 INFO - 'SHELL': '/bin/bash', 05:23:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i8Zozrur6I/Listeners', 05:23:22 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:23:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:23:22 INFO - 'USER': 'cltbld', 05:23:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:23:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:23:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:22 INFO - 'XPC_FLAGS': '0x0', 05:23:22 INFO - 'XPC_SERVICE_NAME': '0', 05:23:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:23 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 05:23:23 INFO - Cleaning up... 05:23:23 INFO - Return code: 0 05:23:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:23:23 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')]} 05:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:23 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')]} 05:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:23 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 0x104aa8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aaf4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6a3d903e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10494dd30>, '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 0x1047b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104943b20>, '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.EDyEhqUqAL/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.i8Zozrur6I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:23:23 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 05:23:23 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 05:23:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EDyEhqUqAL/Render', 05:23:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:23:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:23:23 INFO - 'HOME': '/Users/cltbld', 05:23:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:23:23 INFO - 'LOGNAME': 'cltbld', 05:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:23 INFO - 'MOZ_NO_REMOTE': '1', 05:23:23 INFO - 'NO_EM_RESTART': '1', 05:23:23 INFO - 'PAGER': '/bin/cat', 05:23:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:23 INFO - 'PWD': '/builds/slave/test', 05:23:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:23:23 INFO - 'SHELL': '/bin/bash', 05:23:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i8Zozrur6I/Listeners', 05:23:23 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:23:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:23:23 INFO - 'USER': 'cltbld', 05:23:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:23:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:23 INFO - 'XPC_FLAGS': '0x0', 05:23:23 INFO - 'XPC_SERVICE_NAME': '0', 05:23:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:23 INFO - Downloading/unpacking psutil>=0.7.1 05:23:23 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 05:23:23 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 05:23:23 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 05:23:23 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 05:23:23 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 05:23:23 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 05:23:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:23:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:23:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:23:26 INFO - Installing collected packages: psutil 05:23:26 INFO - Running setup.py install for psutil 05:23:26 INFO - building 'psutil._psutil_osx' extension 05:23:26 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 05:23:26 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 05:23:26 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 05:23:26 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 05:23:26 INFO - building 'psutil._psutil_posix' extension 05:23:26 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 05:23:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:23:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:23:26 INFO - ^ 05:23:26 INFO - 1 warning generated. 05:23:26 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 05:23:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:23:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:23:27 INFO - Successfully installed psutil 05:23:27 INFO - Cleaning up... 05:23:27 INFO - Return code: 0 05:23:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:23:27 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')]} 05:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:27 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')]} 05:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:27 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 0x104aa8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aaf4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6a3d903e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10494dd30>, '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 0x1047b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104943b20>, '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.EDyEhqUqAL/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.i8Zozrur6I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:23:27 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 05:23:27 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 05:23:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EDyEhqUqAL/Render', 05:23:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:23:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:23:27 INFO - 'HOME': '/Users/cltbld', 05:23:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:23:27 INFO - 'LOGNAME': 'cltbld', 05:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:27 INFO - 'MOZ_NO_REMOTE': '1', 05:23:27 INFO - 'NO_EM_RESTART': '1', 05:23:27 INFO - 'PAGER': '/bin/cat', 05:23:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:27 INFO - 'PWD': '/builds/slave/test', 05:23:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:23:27 INFO - 'SHELL': '/bin/bash', 05:23:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i8Zozrur6I/Listeners', 05:23:27 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:23:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:23:27 INFO - 'USER': 'cltbld', 05:23:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:23:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:27 INFO - 'XPC_FLAGS': '0x0', 05:23:27 INFO - 'XPC_SERVICE_NAME': '0', 05:23:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:23:27 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 05:23:27 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 05:23:27 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 05:23:27 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 05:23:27 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 05:23:27 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 05:23:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:23:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:23:29 INFO - Installing collected packages: mozsystemmonitor 05:23:29 INFO - Running setup.py install for mozsystemmonitor 05:23:29 INFO - Successfully installed mozsystemmonitor 05:23:29 INFO - Cleaning up... 05:23:30 INFO - Return code: 0 05:23:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:30 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 0x104aa8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aaf4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6a3d903e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10494dd30>, '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 0x1047b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104943b20>, '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.EDyEhqUqAL/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.i8Zozrur6I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:23:30 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 05:23:30 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 05:23:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EDyEhqUqAL/Render', 05:23:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:23:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:23:30 INFO - 'HOME': '/Users/cltbld', 05:23:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:23:30 INFO - 'LOGNAME': 'cltbld', 05:23:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:30 INFO - 'MOZ_NO_REMOTE': '1', 05:23:30 INFO - 'NO_EM_RESTART': '1', 05:23:30 INFO - 'PAGER': '/bin/cat', 05:23:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:23:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:30 INFO - 'PWD': '/builds/slave/test', 05:23:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:23:30 INFO - 'SHELL': '/bin/bash', 05:23:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i8Zozrur6I/Listeners', 05:23:30 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:23:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:23:30 INFO - 'USER': 'cltbld', 05:23:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:23:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:23:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:30 INFO - 'XPC_FLAGS': '0x0', 05:23:30 INFO - 'XPC_SERVICE_NAME': '0', 05:23:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:23:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:30 INFO - Downloading/unpacking blobuploader==1.2.4 05:23:30 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 05:23:30 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 05:23:30 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 05:23:30 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 05:23:30 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 05:23:30 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 05:23:32 INFO - Downloading blobuploader-1.2.4.tar.gz 05:23:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:23:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:23:32 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 05:23:32 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 05:23:32 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 05:23:32 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 05:23:32 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 05:23:32 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 05:23:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:23:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:23:33 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 05:23:33 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 05:23:33 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 05:23:33 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 05:23:33 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 05:23:33 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 05:23:33 INFO - Downloading docopt-0.6.1.tar.gz 05:23:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:23:33 INFO - Installing collected packages: blobuploader, requests, docopt 05:23:33 INFO - Running setup.py install for blobuploader 05:23:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:23:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:23:33 INFO - Running setup.py install for requests 05:23:34 INFO - Running setup.py install for docopt 05:23:34 INFO - Successfully installed blobuploader requests docopt 05:23:34 INFO - Cleaning up... 05:23:34 INFO - Return code: 0 05:23:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:34 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 0x104aa8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aaf4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6a3d903e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10494dd30>, '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 0x1047b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104943b20>, '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.EDyEhqUqAL/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.i8Zozrur6I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:23:34 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 05:23:34 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 05:23:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EDyEhqUqAL/Render', 05:23:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:23:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:23:34 INFO - 'HOME': '/Users/cltbld', 05:23:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:23:34 INFO - 'LOGNAME': 'cltbld', 05:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:34 INFO - 'MOZ_NO_REMOTE': '1', 05:23:34 INFO - 'NO_EM_RESTART': '1', 05:23:34 INFO - 'PAGER': '/bin/cat', 05:23:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:34 INFO - 'PWD': '/builds/slave/test', 05:23:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:23:34 INFO - 'SHELL': '/bin/bash', 05:23:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i8Zozrur6I/Listeners', 05:23:34 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:23:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:23:34 INFO - 'USER': 'cltbld', 05:23:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:23:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:34 INFO - 'XPC_FLAGS': '0x0', 05:23:34 INFO - 'XPC_SERVICE_NAME': '0', 05:23:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:23:34 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-LrVTFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:23:35 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-3hi3ez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:23:35 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-_YGWSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:23:35 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-WLyd1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:23:35 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Mx1NoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:23:35 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-X4GuQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:23:35 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Fy7TqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:23:35 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Y1usRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:23:35 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-6M0YME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:23:35 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-P2pOjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:23:35 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-sT_QOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:23:36 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-VMOEA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:23:36 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-WVQtSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:23:36 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-E3s7E5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:36 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-ZXFfjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:23:36 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-vDjC1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:23:36 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-ZeGKIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:23:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:23:36 INFO - Running setup.py install for manifestparser 05:23:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:23:36 INFO - Running setup.py install for mozcrash 05:23:36 INFO - Running setup.py install for mozdebug 05:23:37 INFO - Running setup.py install for mozdevice 05:23:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:23:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:23:37 INFO - Running setup.py install for mozfile 05:23:37 INFO - Running setup.py install for mozhttpd 05:23:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:23:37 INFO - Running setup.py install for mozinfo 05:23:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:23:37 INFO - Running setup.py install for mozInstall 05:23:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:23:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:23:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:23:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:23:37 INFO - Running setup.py install for mozleak 05:23:37 INFO - Running setup.py install for mozlog 05:23:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:23:38 INFO - Running setup.py install for moznetwork 05:23:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:23:38 INFO - Running setup.py install for mozprocess 05:23:38 INFO - Running setup.py install for mozprofile 05:23:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:23:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:23:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:23:38 INFO - Running setup.py install for mozrunner 05:23:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:23:38 INFO - Running setup.py install for mozscreenshot 05:23:38 INFO - Running setup.py install for moztest 05:23:39 INFO - Running setup.py install for mozversion 05:23:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:23:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:23:39 INFO - Cleaning up... 05:23:39 INFO - Return code: 0 05:23:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:23: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')]} 05:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23: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')]} 05:23:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:39 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 0x104aa8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aaf4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6a3d903e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10494dd30>, '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 0x1047b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104943b20>, '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.EDyEhqUqAL/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.i8Zozrur6I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:23:39 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 05:23:39 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 05:23:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EDyEhqUqAL/Render', 05:23:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:23:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:23:39 INFO - 'HOME': '/Users/cltbld', 05:23:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:23:39 INFO - 'LOGNAME': 'cltbld', 05:23:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:39 INFO - 'MOZ_NO_REMOTE': '1', 05:23:39 INFO - 'NO_EM_RESTART': '1', 05:23:39 INFO - 'PAGER': '/bin/cat', 05:23:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:23:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:39 INFO - 'PWD': '/builds/slave/test', 05:23:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:23:39 INFO - 'SHELL': '/bin/bash', 05:23:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i8Zozrur6I/Listeners', 05:23:39 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:23:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:23:39 INFO - 'USER': 'cltbld', 05:23:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:23:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:23:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:39 INFO - 'XPC_FLAGS': '0x0', 05:23:39 INFO - 'XPC_SERVICE_NAME': '0', 05:23:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:23:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:23:39 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-yoXKP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:23:39 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)) 05:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:23:39 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-zEKDwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:23:39 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)) 05:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:23:39 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Ugz6cE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:23:39 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)) 05:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:23:39 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-OpxJJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:23:39 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)) 05:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:23:39 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-hAyBJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:23:39 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)) 05:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:23:39 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-L4MX_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:23:40 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)) 05:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:23:40 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-7WwARc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:23:40 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)) 05:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:23:40 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-NGmglo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:23:40 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)) 05:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:23:40 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-71jNgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:23:40 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)) 05:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:23:40 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-nUOVxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:23:40 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)) 05:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:23:40 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-wbp35c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:23:40 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)) 05:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:23:40 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-mfgCJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:23:40 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)) 05:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:23:40 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-E9GPm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:23:40 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)) 05:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:23:40 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-4RgR9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:23:40 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)) 05:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:40 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-c56bYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:41 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)) 05:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:23:41 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-V7f6CI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:23:41 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)) 05:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:23:41 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-5I1O7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:23:41 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)) 05:23:41 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)) 05:23:41 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)) 05:23:41 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)) 05:23:41 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)) 05:23:41 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)) 05:23:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:23:41 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 05:23:41 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 05:23:41 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 05:23:41 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 05:23:41 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 05:23:41 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 05:23:43 INFO - Downloading blessings-1.6.tar.gz 05:23:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:23:43 INFO - Installing collected packages: blessings 05:23:43 INFO - Running setup.py install for blessings 05:23:43 INFO - Successfully installed blessings 05:23:43 INFO - Cleaning up... 05:23:43 INFO - Return code: 0 05:23:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:23:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:23:44 INFO - Reading from file tmpfile_stdout 05:23:44 INFO - Current package versions: 05:23:44 INFO - blessings == 1.6 05:23:44 INFO - blobuploader == 1.2.4 05:23:44 INFO - docopt == 0.6.1 05:23:44 INFO - manifestparser == 1.1 05:23:44 INFO - mozInstall == 1.12 05:23:44 INFO - mozcrash == 0.16 05:23:44 INFO - mozdebug == 0.1 05:23:44 INFO - mozdevice == 0.48 05:23:44 INFO - mozfile == 1.2 05:23:44 INFO - mozhttpd == 0.7 05:23:44 INFO - mozinfo == 0.9 05:23:44 INFO - mozleak == 0.1 05:23:44 INFO - mozlog == 3.1 05:23:44 INFO - moznetwork == 0.27 05:23:44 INFO - mozprocess == 0.22 05:23:44 INFO - mozprofile == 0.28 05:23:44 INFO - mozrunner == 6.11 05:23:44 INFO - mozscreenshot == 0.1 05:23:44 INFO - mozsystemmonitor == 0.0 05:23:44 INFO - moztest == 0.7 05:23:44 INFO - mozversion == 1.4 05:23:44 INFO - psutil == 3.1.1 05:23:44 INFO - requests == 1.2.3 05:23:44 INFO - wsgiref == 0.1.2 05:23:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:23:44 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')]} 05:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:44 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')]} 05:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:44 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 0x104aa8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aaf4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6a3d903e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10494dd30>, '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 0x1047b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104943b20>, '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.EDyEhqUqAL/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.i8Zozrur6I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:23:44 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 05:23:44 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 05:23:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EDyEhqUqAL/Render', 05:23:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:23:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:23:44 INFO - 'HOME': '/Users/cltbld', 05:23:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:23:44 INFO - 'LOGNAME': 'cltbld', 05:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:44 INFO - 'MOZ_NO_REMOTE': '1', 05:23:44 INFO - 'NO_EM_RESTART': '1', 05:23:44 INFO - 'PAGER': '/bin/cat', 05:23:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:44 INFO - 'PWD': '/builds/slave/test', 05:23:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:23:44 INFO - 'SHELL': '/bin/bash', 05:23:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i8Zozrur6I/Listeners', 05:23:44 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:23:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:23:44 INFO - 'USER': 'cltbld', 05:23:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:23:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:44 INFO - 'XPC_FLAGS': '0x0', 05:23:44 INFO - 'XPC_SERVICE_NAME': '0', 05:23:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:44 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)) 05:23:44 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)) 05:23:44 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)) 05:23:44 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)) 05:23:44 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)) 05:23:44 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)) 05:23:44 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)) 05:23:44 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)) 05:23:44 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)) 05:23:44 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)) 05:23:44 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)) 05:23:44 INFO - Cleaning up... 05:23:44 INFO - Return code: 0 05:23:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:23:44 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')]} 05:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:44 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')]} 05:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x104aa8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aaf4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6a3d903e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10494dd30>, '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 0x1047b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104943b20>, '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.EDyEhqUqAL/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.i8Zozrur6I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:23:44 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 05:23:44 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 05:23:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EDyEhqUqAL/Render', 05:23:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:23:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:23:44 INFO - 'HOME': '/Users/cltbld', 05:23:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:23:44 INFO - 'LOGNAME': 'cltbld', 05:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:44 INFO - 'MOZ_NO_REMOTE': '1', 05:23:44 INFO - 'NO_EM_RESTART': '1', 05:23:44 INFO - 'PAGER': '/bin/cat', 05:23:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:44 INFO - 'PWD': '/builds/slave/test', 05:23:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:23:44 INFO - 'SHELL': '/bin/bash', 05:23:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i8Zozrur6I/Listeners', 05:23:44 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:23:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:23:44 INFO - 'USER': 'cltbld', 05:23:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:23:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:44 INFO - 'XPC_FLAGS': '0x0', 05:23:44 INFO - 'XPC_SERVICE_NAME': '0', 05:23:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:44 INFO - Downloading/unpacking jsonschema 05:23:44 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 05:23:44 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 05:23:44 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 05:23:44 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 05:23:44 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 05:23:44 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 05:23:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:23:46 INFO - Downloading/unpacking functools32 (from jsonschema) 05:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:46 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 05:23:46 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 05:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:47 INFO - Downloading functools32-3.2.3-2.tar.gz 05:23:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:23:47 INFO - warning: no files found matching '*.txt' 05:23:47 INFO - no previously-included directories found matching 'build' 05:23:47 INFO - no previously-included directories found matching 'dist' 05:23:47 INFO - no previously-included directories found matching '.git*' 05:23:47 INFO - Installing collected packages: jsonschema, functools32 05:23:47 INFO - Running setup.py install for functools32 05:23:47 INFO - warning: no files found matching '*.txt' 05:23:47 INFO - no previously-included directories found matching 'build' 05:23:47 INFO - no previously-included directories found matching 'dist' 05:23:47 INFO - no previously-included directories found matching '.git*' 05:23:47 INFO - Successfully installed jsonschema functools32 05:23:47 INFO - Cleaning up... 05:23:47 INFO - Return code: 0 05:23:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:23:47 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')]} 05:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:47 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')]} 05:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:47 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 0x104aa8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aaf4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6a3d903e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10494dd30>, '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 0x1047b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104943b20>, '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.EDyEhqUqAL/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.i8Zozrur6I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:23:47 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 05:23:47 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 05:23:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EDyEhqUqAL/Render', 05:23:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:23:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:23:47 INFO - 'HOME': '/Users/cltbld', 05:23:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:23:47 INFO - 'LOGNAME': 'cltbld', 05:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:47 INFO - 'MOZ_NO_REMOTE': '1', 05:23:47 INFO - 'NO_EM_RESTART': '1', 05:23:47 INFO - 'PAGER': '/bin/cat', 05:23:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:47 INFO - 'PWD': '/builds/slave/test', 05:23:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:23:47 INFO - 'SHELL': '/bin/bash', 05:23:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i8Zozrur6I/Listeners', 05:23:47 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:23:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:23:47 INFO - 'USER': 'cltbld', 05:23:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:23:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:47 INFO - 'XPC_FLAGS': '0x0', 05:23:47 INFO - 'XPC_SERVICE_NAME': '0', 05:23:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:47 INFO - Downloading/unpacking flake8 05:23:47 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 05:23:47 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 05:23:47 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 05:23:47 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 05:23:47 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 05:23:47 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 05:23:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:23:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:23: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 05:23: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 05:23: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 05:23: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 05:23: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 05:23: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 05:23:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:23:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:23: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 05:23: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 05:23: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 05:23: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 05:23: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 05:23: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 05:23:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:23: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 05:23: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 05:23: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 05:23: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 05:23: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 05:23: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 05:23:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:23:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:23:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:23:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:23:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:23:51 INFO - no previously-included directories found matching 'docs/_build' 05:23:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:23:51 INFO - Running setup.py install for pep8 05:23:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:23:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:23:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:23:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:23:51 INFO - no previously-included directories found matching 'docs/_build' 05:23:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:23:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:23:51 INFO - Cleaning up... 05:23:51 INFO - Return code: 0 05:23:51 INFO - Running post-action listener: _resource_record_post_action 05:23:51 INFO - Running post-action listener: _start_resource_monitoring 05:23:51 INFO - Starting resource monitoring. 05:23:51 INFO - ##### 05:23:51 INFO - ##### Running install step. 05:23:51 INFO - ##### 05:23:51 INFO - Running pre-action listener: _resource_record_pre_action 05:23:51 INFO - Running main action method: install 05:23:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:23:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:23:52 INFO - Reading from file tmpfile_stdout 05:23:52 INFO - Detecting whether we're running mozinstall >=1.0... 05:23:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:23:52 INFO - Reading from file tmpfile_stdout 05:23:52 INFO - Output received: 05:23:52 INFO - Usage: mozinstall [options] installer 05:23:52 INFO - Options: 05:23:52 INFO - -h, --help show this help message and exit 05:23:52 INFO - -d DEST, --destination=DEST 05:23:52 INFO - Directory to install application into. [default: 05:23:52 INFO - "/builds/slave/test"] 05:23:52 INFO - --app=APP Application being installed. [default: firefox] 05:23:52 INFO - mkdir: /builds/slave/test/build/application 05:23:52 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'] 05:23:52 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 05:24:26 INFO - Reading from file tmpfile_stdout 05:24:26 INFO - Output received: 05:24:26 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:24:26 INFO - Running post-action listener: _resource_record_post_action 05:24:26 INFO - ##### 05:24:26 INFO - ##### Running run-tests step. 05:24:26 INFO - ##### 05:24:26 INFO - Running pre-action listener: _resource_record_pre_action 05:24:26 INFO - Running main action method: run_tests 05:24:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:24:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:24:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:24:26 INFO - 2016-02-04 05:24:26.571 screenresolution[2277:29199] starting screenresolution argv=screenresolution get 05:24:26 INFO - 2016-02-04 05:24:26.574 screenresolution[2277:29199] Display 0: 1600x1200x32@60 05:24:26 INFO - 2016-02-04 05:24:26.581 screenresolution[2278:29202] starting screenresolution argv=screenresolution list 05:24:26 INFO - Available Modes on Display 0 05:24:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:24:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:24:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:24:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:24:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:24:26 INFO - Intel Iris: 05:24:26 INFO - Chipset Model: Intel Iris 05:24:26 INFO - Type: GPU 05:24:26 INFO - Bus: Built-In 05:24:26 INFO - VRAM (Dynamic, Max): 1536 MB 05:24:26 INFO - Vendor: Intel (0x8086) 05:24:26 INFO - Device ID: 0x0a2e 05:24:26 INFO - Revision ID: 0x0009 05:24:26 INFO - Displays: 05:24:26 INFO - Display: 05:24:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:24:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:24:26 INFO - Display Serial Number: 1600x1200 60 05:24:26 INFO - Main Display: Yes 05:24:26 INFO - Mirror: Off 05:24:26 INFO - Online: Yes 05:24:26 INFO - Rotation: Supported 05:24:26 INFO - Return code: 0 05:24:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:24:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:24:26 INFO - Python 2.7.3 05:24:26 INFO - Return code: 0 05:24:26 INFO - grabbing minidump binary from tooltool 05:24:26 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')]} 05:24:26 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 0x10494dd30>, '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 0x1047b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104943b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:24:26 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 05:24:26 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 05:24:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:24:26 INFO - Return code: 0 05:24:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:24:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:24:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:24:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:24:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:24:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:24:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:24:28 INFO - Return code: 0 05:24:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0072', '--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 05:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0072 --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 05:24:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EDyEhqUqAL/Render', 05:24:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:28 INFO - 'HOME': '/Users/cltbld', 05:24:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:28 INFO - 'LOGNAME': 'cltbld', 05:24:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:24:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:28 INFO - 'MOZ_NO_REMOTE': '1', 05:24:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:24:28 INFO - 'NO_EM_RESTART': '1', 05:24:28 INFO - 'PAGER': '/bin/cat', 05:24:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:28 INFO - 'PWD': '/builds/slave/test', 05:24:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:24:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:28 INFO - 'SHELL': '/bin/bash', 05:24:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i8Zozrur6I/Listeners', 05:24:28 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:24:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:28 INFO - 'USER': 'cltbld', 05:24:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:28 INFO - 'XPC_FLAGS': '0x0', 05:24:28 INFO - 'XPC_SERVICE_NAME': '0', 05:24:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0072', '--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 05:24:28 INFO - mozversion application_buildid: 20160204024424 05:24:28 INFO - mozversion application_changeset: d577f0c34dee0bf5d0054bea3d8535af03f2b85d 05:24:28 INFO - mozversion application_display_name: Nightly 05:24:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:24:28 INFO - mozversion application_name: Firefox 05:24:28 INFO - mozversion application_remotingname: firefox 05:24:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:24:28 INFO - mozversion application_vendor: Mozilla 05:24:28 INFO - mozversion application_version: 47.0a1 05:24:28 INFO - mozversion platform_buildid: 20160204024424 05:24:28 INFO - mozversion platform_changeset: d577f0c34dee0bf5d0054bea3d8535af03f2b85d 05:24:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:24:28 INFO - mozversion platform_version: 47.0a1 05:24:28 INFO - using testdate: 1454592268 05:24:28 INFO - actual date: 1454592268 05:24:28 INFO - starting webserver on 'localhost:50474' 05:24:28 INFO - SUITE-START | Running 2 tests 05:24:28 INFO - TEST-START | dromaeo_css 05:24:28 INFO - operating with platform_type : mac_ 05:24:28 INFO - Initialising browser for dromaeo_css test... 05:24:28 INFO - TEST-INFO | started process 2296 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpM1Ob7c/profile http://localhost:50474/getInfo.html) 05:24:28 INFO - PROCESS | 2296 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 05:24:31 INFO - PROCESS | 2296 | __metrics Screen width/height:1600/1200 05:24:31 INFO - PROCESS | 2296 | colorDepth:24 05:24:31 INFO - PROCESS | 2296 | Browser inner width/height: 1024/689 05:24:31 INFO - PROCESS | 2296 | __metrics 05:24:31 INFO - TEST-INFO | 2296: exit 0 05:24:31 INFO - Browser initialized. 05:24:31 INFO - Running cycle 1/1 for dromaeo_css test... 05:24:31 INFO - TEST-INFO | started process 2300 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpM1Ob7c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:44 INFO - PROCESS | 2300 | RSS: Main: 256487424 05:24:44 INFO - PROCESS | 2300 | 05:25:33 INFO - PROCESS | 2300 | 1454592333714 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] 05:27:43 INFO - PROCESS | 2300 | Cycle 1(1): loaded http://localhost:50474/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50474/tests/dromaeo/cssquery-ext.html) 05:27:45 INFO - PROCESS | 2300 | RSS: Main: 269066240 05:27:45 INFO - PROCESS | 2300 | 05:30:47 INFO - PROCESS | 2300 | Cycle 1(1): loaded http://localhost:50474/tests/dromaeo/cssquery-ext.html (next: http://localhost:50474/tests/dromaeo/cssquery-jquery.html) 05:30:48 INFO - PROCESS | 2300 | RSS: Main: 282091520 05:30:48 INFO - PROCESS | 2300 | 05:33:50 INFO - PROCESS | 2300 | Cycle 1(1): loaded http://localhost:50474/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50474/tests/dromaeo/cssquery-mootools.html) 05:33:50 INFO - PROCESS | 2300 | RSS: Main: 283623424 05:33:50 INFO - PROCESS | 2300 | 05:36:52 INFO - PROCESS | 2300 | Cycle 1(1): loaded http://localhost:50474/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50474/tests/dromaeo/cssquery-prototype.html) 05:36:53 INFO - PROCESS | 2300 | RSS: Main: 285728768 05:36:53 INFO - PROCESS | 2300 | 05:39:55 INFO - PROCESS | 2300 | Cycle 1(1): loaded http://localhost:50474/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50474/tests/dromaeo/cssquery-yui.html) 05:39:56 INFO - PROCESS | 2300 | RSS: Main: 287227904 05:39:56 INFO - PROCESS | 2300 | 05:42:58 INFO - PROCESS | 2300 | Cycle 1(1): loaded http://localhost:50474/tests/dromaeo/cssquery-yui.html (next: http://localhost:50474/tests/dromaeo/cssquery-dojo.html) 05:42:58 INFO - PROCESS | 2300 | RSS: Main: 290594816 05:42:58 INFO - PROCESS | 2300 | 05:42:58 INFO - PROCESS | 2300 | __start_tp_report 05:42:58 INFO - PROCESS | 2300 | _x_x_mozilla_page_load 05:42:58 INFO - PROCESS | 2300 | _x_x_mozilla_page_load_details 05:42:58 INFO - PROCESS | 2300 | |i|pagename|runs| 05:42:58 INFO - PROCESS | 2300 | |0;dojo.html;2876.942461150777;3446.1040129566304;3489.8080605566715;3505.7195424366037;3512.034190597586;5502.092154794459;5546.112621980479;5548.9167662485;5561.443855614437;5614.971925140374;5494.120940649497;5552.4169962154;5610.438956104387;5619.4099619539975;5651.5761317901115;5062.974685126569;5103.693778373291;5125.436202017784;5194.506521880416;5228.346456692913;4331.956680433187;5127.513021223841;5182.248573956774;5241.3710354757295;5276.657017293883;3648.5621725392857;5063.215201643714;5120.923186152192;5141.665791723563;5193.350831146106;5149;5149.021685879671;5160.071187186305;5189.688618682853;5218.034663587248;5083.872903177413;5114.718690472023;5126.128558145087;5127.589792816566;5137.922931156036;5297.417284098746;5475.6440831345835;5541.5289700375515;5575.442455754433;5696.1740547620775;6068.514518838527;6069.939300606981;6081.391860813883;6088.421599948042;6106.297775755756;6110.816675499742;6128.816135515942;6134.447899689005;6135.110408990716;6151.077338399231;5571.526420254283;5735.1684005818925;5743.483086522233;5747.453991870766;5797.797077102366;6173.444390004921;6181.412765787243;6184.628922264678;6221.875562488724;6227.564070515021;5895.557833162444;6016.368281330485;6018.398160183947;6030.366811484819;6051.788187413419;6081.239845019372;6138.6623735694075;6143.846403839851;6186.041163619646;6207.6275423474735;6061.931507530213;6090.390960903874;6091.63450192981;6102.314311391842;6109.2974307955155;4815.253635686474;5583.832485025456;5837.737301821428;6099.024156134997;6154.138420621117;4156;4767.4517430495935;4861.732604706775;4863.513648635108;4899.804007839718;4346.369776382407;4352.782360882006;4360.890977725582;4365.973996110912;4369.9126017479475;5588.524975377057;5696.8860622787315;5734.426557344315;5753.33836608787;5829.417058294137;6059.969700151559;6094.939050609526;6117.736059405574;6119.204503414617;6142.293636231891;4741.810327586858;5653.434656534314;5686.9715651421475;5694.886102277931;5711.485966263056;5296.390915044819;5308.389535203424;5311.362636483646;5312.362516497968;5395;6103.913516305051;6185;6194;6280.497560195174;6304.527160463075;6120.693965301806;6134.8159555213415;6148.385161483816;6162.291336496361;6165.383461653978;6117.755289788537;6138.204480310071;6282.2147231596055;6293.402126797947;6336.3030066693545;6044.214252147192;6075.605085669417;6105.558635639443;6150.138980542817;6172;6117.307309300865;6138.242861781976;6147.692615369124;6150.261968563801;6165.414285642857;5881.500072493886;5908.172855800278;5994.970025149846;6037.275526936795;6070.848228794139;5974.641521508724;5999;6032.155498230339;6083.726232319467;6122.816315510542;5377.327834020747;5797.884042319046;5797.942020579909;5852.385499522489;5866.208061911588;5818.534517238695;6000.339962604023;6019.879602408015;6038.698065096815;6067.575269731076;5854.531637469077;5855;5864.149698293809;5866.2373891393845;5886.911696324473 05:42:58 INFO - PROCESS | 2300 | |1;ext.html;436.0951026619763;438.3687490014379;493.7728644823382;544.3141641531669;568.8094488346404;38034.619653803486;38849;38956.026099347495;39005.41491877621;39042.60957390425;43008.139837203234;43031.56968430323;43481.782591087;43534.7823260884;43777.343339849926;8448.197421244971;8476.321894248445;9677.177439917597;9864.35881667693;9927.305088643798;9796.559154838049;9867.111959923606;9867.16129129025;9887.901120988807;9896.208303335752;9891.851622225673;9911.653092141776;9931.15585175261;9940.005999400075;9965.252606054539;9462.67522546844;9761.902380976206;9890.357126786736;9923.40459572428;9941.80116397668;8631.784205394915;9562.85655715158;9824.263180261438;9827.803443931152;9852.65515706954;40103.197936041404;40197.59802401968;40222;40471.19057618861;40561.79719101415;2770.3766652503227;3222.7744057915957;3296.027671836814;3360.327934413103;3486.6164721880573;27959.161225163276;27981.160565182872;28275.293117672223;28355;28676.426471470455;2739.8218067042335;2812.5640525718545;2819.7744180465515;2832.730890565393;2840.872160752771;461460;462810.9999999966;463337;464992;465364;57679.711601441726;58752;65109.3956241745;65684;66908;64558.67720661461;64706;65144.022839657446;65238;65301.020484692766;16441.424550140928;16443.342266309213;16490.257938392802;16637.83362166387;16755.2460139294;12667.873321266854;12703;12724.109312348231;12751.36243187837;12874.742505150032;21150.894245528983;21270;21455.78544214569;21497.892510537346;21617.891910540347;8747.868781968276;8989.280857531381;9000.459972401677;9036.695642611092;9050.230730387992;911.2527727263713;925.6621333213463;933.5892207428709;956.4882787708542;1195.9760804783855;27887.84561550637;29075.709242907724;29200;29714.257143571584;29758;1014.7970405918845;1042.4096121138964;1070.9303895246785;1116.4808364110565;1139.601139601133;13541.59375218745;14204.360803763855;14933.850661493247;14941.925290373696;15206.695866082837;511907;617433;619154;621898;629157.854210726;59617.40382596205;60353.69823150856;60437.09344359838;60494;60522;1378.0904602961998;1399.3143359753647;1412.7951447040123;1422.807920930661;1426.108682073704;27264.182074537795;28826.001569129334;29113.508675980036;29299.7070029297;29369.412611748074;48992.5100748988;49142.01715965732;49573.75213123911;49576.50423495863;49774.00451991012;480812;486662;487671;488818;489586;28377;28756.42487150287;32755;33584.82453114129;33842.49236261409;41038;41192.79403602963;42450;42749.57250427456;42922.35616465693;33679.494807577415;35345.65338868033;35405;35609.46585801267;35961;27378.041768538005;34767.13082172966;34874.12814679653;35296;35605.1098722534;33440;35292.47061294031;35547.28905421825;35965.640343597275;36919.26161476809;27736;29843.70156298496;32025.87909423159;32527;32918.51866665958;21574;22871.771282286965;24580.279380443197;24628.753712462647;25847.353816154748 05:42:58 INFO - PROCESS | 2300 | |2;jquery.html;314.95118256670213;352.5082509898693;357.2889949001487;357.3460567162094;363.1375483227335;15318.387264509434;17615.559611009732;18734.063296835157;19254.13356398962;20929.37211883644;15339.693206135871;19121.42635720927;19208.61582768344;19279.518012049706;19464.221431142738;4964.404271487427;5535.833924982237;5827.096799996008;5832.56255780816;5853.912191317112;4092.5088989321175;4310.353446982962;5451.236826844245;5790.7683692652245;6093.390660933916;6049.1228771828055;6302.613425046506;6305.653189074599;6307.653079080649;6328.303886572473;6347.206599175103;6361.745530178788;6377.808665740035;6394.808155755335;6418.743250269984;5488.53347465466;5533.418991005927;5539.446055394468;5589.161625756128;5597.888042239173;24159.758402416104;24372.268831934893;24422.26733198007;24588.262352129466;24596;2455.4229756007326;2604.4009877728226;2668.0795125681607;2878.266042159257;3018.622672165979;11046.834297485544;11341.829872551918;11997.520099196021;14311.642208944755;14323.928380358031;1696.4740930311643;1711.7432385142204;1730.2041061111904;1734.8612111031086;1807.6203997160612;80903.97740056487;84248;90367;92067.99999999933;95015.52492237494;10197.337173083726;10434.426106564211;10551.20865935058;10624.628138015132;10728.302660327054;12738.745225095447;12821.487140514275;12951.352432378344;12958.22250664963;12960.157589756636;8492.74521764348;8531.872021919677;8577.05652378238;8586.95706521476;8619.353548483889;7081.787546373617;8807.471551706918;8808.075152109064;8859.202671759573;8872.689455869013;6080.331163572004;6133.570650054543;6159.045347971071;6186.226721659793;6203.937960620427;1451.506487794155;1582.185174635064;1744.5202569293547;1788.4902802701429;1790.1765188013399;366.6616848502932;374.7371358521799;415.36863966770943;444.5732097186737;998.3610489286863;11035.39305338198;11551.76896462066;11570.537178512934;11679;11752.294862308288;391.37575566970634;431.3917376499121;443.1646346636549;453.94098767160716;473;5960.791372301948;6149.41580549847;8998.55007249648;10644.254902156774;10726.410047447309;600044;617163;623086;672990;697257;107931.38102928305;108272;108468.4576577112;109494;109581;909.1499448016126;1130.621241883978;1134.7843909657304;1151.5163631274884;1159.084323384517;16109.630681392213;16442.671146577242;16789.66420671555;17965.461036168937;18355.541111471786;30965.69034309628;49139.50860491349;49238.75380623074;49652.50347496479;49755.004899902524;64054.67972660107;69601.65199173972;70252.29747702662;70328.29671703218;71388.9291660636;6271.811845644638;6746.86506269862;7168.462365322726;7657.808554785952;7676.078870535572;9946.751331216778;10184.796304074025;11286.943565282449;11657.941710291734;11762.353070580857;9861.260405469475;10035.297529172887;10073.44596047195;10111.696649100539;10210.897891020995;9616.9038309616;9926.970912988269;10038.347507411994;10087.344322619007;10272.537735801758;9822.75443113928;10055.69832905014;10212.846807297748;10279.588816447558;10390.012948769854;7468.813279668052;7619.619019049136;7674.61626918663;7697.230276972482;7724.420668450001;8601.612927418157;9711.36876103051;10155.289129761142;10406.479676016017;10464.267501274837 05:42:58 INFO - PROCESS | 2300 | |3;mootools.html;1191.9463624136915;1507.7813717011034;1651.5128037229017;1849.879757815741;1867.2997625890291;7909.604519774017;8013.2387423194705;8591;8749.606267717953;8789.208971192584;8292.70975515857;8400.831983360344;8509;8541.871871921927;8553.486790792542;2466.161505088274;2490.302715239736;2492.090387008747;2496.5131799299143;2508.08454913956;2382.9046838126455;2430.4895971845935;2476.8761561921924;2480.3675062858947;2481.4540801023745;1859.8977056261967;1938.5444420561157;2053.4763635273057;2454.6563481112657;2484.6521486991837;2464.6549483072386;2473.5547601431736;2484.900603975848;2492.1277552856536;2492.9252122436264;2458.791002764767;2485.9005639774387;2493.7755601995727;2494.239257026606;2495.625656151574;8753.299736021167;8853.867191992125;8911.73264802057;8930.955345223298;8935.374523783337;5362.249285100089;5546.722663866791;5563.693996830173;5570.220169176318;5593.972030139864;3606.0804494853646;3662.505561749156;3693.279810436966;3710.9257814843822;3716.981415092934;1026.686860507545;1036.4921188617523;1039.2413538117216;1045.3414348960182;1051.164324362134;12013.279203247746;12100;12271.38643067843;12295.016398688083;12302.954248888855;4354.911272181955;4916.803327866845;4920.852374428773;5019.67372120811;5034.823781167642;8673;10063.647772327933;10236.53935572901;10373.740656483498;10391.53238104287;4387.42963414754;5501.862453438696;5556.083246264321;5560.165975103686;5569.777208911598;4405.29515277554;4488.842890498817;4861.513848615181;4948.8762780930765;5015.84952451427;3950.071733142709;3960.6237407446247;4004.1391100913443;4014.8394064237687;4089.3865920111625;1104.282216559243;1296.027979015738;1301.5965050834272;1301.9414126364336;1312.6915174933883;1292.9224246545236;1313.835770528684;1321.4648067532664;1328.4951718346965;1338.5315139701027;8074.111847696749;8183.6726530938095;8209.958950205211;8392.916070839336;8395.202455766692;1031.6286136990827;1176;1180.5100883133402;1183.384639987219;1191.6901605582611;6260.092286618506;6308.337624549448;6378.521610879203;6382.457491113308;6409.775657851953;10612.893871061346;10810.513526891309;10872.565097396173;10959.83560246597;10964.17768667353;10379.584816607252;10644.89355106439;10792.082672972885;10799;10814.972577605115;8386.580670966427;8387.203215694499;8421.410501264852;8478.576071196292;8512.531810750344;7747.535147891144;7898.368130549427;7912;7968.601569921597;8015.318697910743;9660.516974151124;9811.85282220753;9845.310828241954;9862.654807081717;9890.703278901357;9674.452087665939;10023.348482348623;10159.898401015895;10311.742206444898;10326.896731032593;6423.518236132215;6669.46644268467;6922.619255940972;7036.683349249193;7115.181754098345;7566.129895061918;7976.1226265109635;8194.877076843733;8210.137935516685;8215.876761848458;7545.207753185837;7781.688732450639;7803.180666030212;7808.882866757117;7924.326432253092;7538.924610754042;7594.164641889277;7632.771016869503;7702.768916932501;7752.5348479091435;7755.6509957053195;7770.14528401864;7788.221177882167;7813.4530582860925;7819.413543984338;6936.757213497705;7027.683754231174;7070.292970702889;7073.71705131789;7081.929180708333;7132.893006605009;7161.4986950912935;7194.856102878018;7196.748113815991;7230.891536626849 05:42:58 INFO - PROCESS | 2300 | |4;prototype.html;319.5701781104415;321.168174428231;326.8186156683043;330.1515106177126;330.7040199021876;6657.733690652381;6804.115464989551;6890.310968903107;6918.066061081759;6926.965365173167;6545.967270163655;6658.533902626818;6706.530542862001;6708.96645516773;6736.427403670682;4057.6753859691153;5034.647574669774;5060.443351231362;5072.873178170538;5074.264231686403;4918.188498897677;5044.394672639289;5056.165732654108;5056.367954005749;5070.1380765269805;4155.231282212801;4185.807044992178;4306.837153968427;5006.299118123466;5014.5737612303;5010.849674509771;5016.974915125419;5026.466927587085;5031.295618613397;5032.899342013176;4075.8981025474304;4152.259508724258;4156.334986402161;4296.978515107436;4298.290782020963;5341.626086173969;6389.329120442333;6426.967865160691;6428.903566446507;6479.060536222269;5878.382769809151;5889.1460738193155;5889.941100589025;5917.349091599921;5926.940730592682;7004.170933340004;7124.287571242886;7207.135143782727;7215.386692131176;7258.165310989251;4225.852095176685;4505.121501307246;4773.260144677581;4777.355057067321;4797.088553174921;6135.78524751636;7606.733764318223;7635.732749353801;7668.118166410878;7670.27132422419;4725;4812.470628230892;4850.442199147073;4874.902501949941;4886.99816537609;4109.869785808926;4968.254761785689;4995.325631039836;4997.425296090923;5007.349044624176;5908.0503433866725;5919.881602368015;5921.526277897758;5928.962431574457;5937.228160339128;5837.620554663933;7217.530860494051;7233.819154521179;7292.234315396913;7337.963310183522;1357.5995081450997;1584.4533635895598;1669.0986867091635;1715.5110793423814;1742.1202292842033;959.2374062620233;988.7393573194091;1055.4247934875357;1067.7490789664423;1072.0137473524376;5884.617499862496;6820.6930688119155;6829.975503674389;6859;6877.759278425331;6008.309044459856;7458.2541745826065;7462;7500.024996750388;7538.736144235035;6627.271000189975;6815.727370905108;6825.317468253135;6830.487713421513;6850.554713943578;3900.2199560088097;3963.8810835674976;3977.9801100994887;4013.959860401417;4021.5375231848125;6422.614643121427;7729.265719756614;7767.961160194276;7999.720009799629;8044.1955804419085;6631.966840165768;7859.449838511249;7871.527708337404;7888.802779930547;7906.486078404885;7737.497062690907;7934.206579342135;7973.362131029619;7981.40139489529;7988;7585.544867307979;7598.772036838904;7621.237876212556;7670.348020418104;7674;7254.673539690621;7481.476296659399;7488.101427828696;7492.325690687864;7510.887336690063;7976.282134607914;7978.481398709066;7985.640646171052;7993.920060799318;8026.59867006659;3911.6675082618294;3924.3328634131694;4754.857354279377;4756.16767065769;4775.832845850378;7358.300961408658;7505.549667019996;7581.50720203185;7621.618919054136;7624.847503049797;7284.817879553054;7306.817329566803;7313;7337.523061001018;7354.779356619096;7291.52605080668;7300.96349518249;7308.5614863108385;7314.670839812327;7325.157606875277;6888.242293347828;7133.536320139175;7137.464690148156;7143.392811611071;7146.213916469288;7320.780376588711;7321.816954576178;7324.121105467165;7333.230010848997;7352.77941661751;6937.098177236927;7160.176579693402;7174.461915356264;7184.030155929092;7214 05:42:58 INFO - PROCESS | 2300 | |5;yui.html;646.5668002438368;654.5254690349494;675.5946432140715;711.281605578366;725.300085417572;14362;14860.182689952047;14897.478588249414;14988.625284367883;15003.774943375858;15443.536693899201;15710.764338534931;15764.290606922686;15795;15816.683666326666;595.75574014654;686.4096876686046;687.6596084937963;804.6419343392192;849.1720572441882;827.5903427803246;858.6050416808245;860.7202659135775;866;867.3321542412339;900.045951291633;904.2314033071902;904.5206040798355;913.7669894176976;914.9862752058724;889.1775108025051;902.7923577577161;905.3707673167152;909.4588719711761;910.0990019880337;657.2015001772869;664.2626684380382;667.2393471442559;671.9092922455454;672.1228796420669;14787.40850365984;14901.031432956823;14957.626059348604;14967.95224334297;15005.774913376308;10441.738956526071;12008.699782505508;12346.135770496068;12740.681482962907;13016.479340826356;10914.345139291669;10981.780364392747;11068.557257709683;11383.772324553545;11959.521619135225;3471.75697701161;3502.4571191465366;3512.4213711282705;3544.326577950181;3577.5528058992627;80855.59572202161;81180;81992.77010844841;82245;82936;9320.487373194539;9339.673111441067;9448.622055117718;9457.38526995757;9669.226461883032;21472.355829325144;21658.566828663337;21752.89123554372;22096;22097.447563811034;7503.962480187564;7645.579493127821;7651.502652327581;7707.614619269127;7915.525068495908;3877.651011408987;3990.900227494336;3999.6200360965663;4077.1845630873945;4145.502539695196;3536.6109727929907;3568.7680300780885;3582.9283414331567;3586.246888153517;3608.963910360915;658.9538732288789;659.0378048049901;666.1406785246977;675.8040168351222;681.7613835157754;540.9323834520685;573.9770409183669;594.7710131599365;642.3768944124192;648.0894343447463;8353.54055526952;8639.78400539979;8649.654013839501;8709.956450217709;8719.38964272495;502.9622778291643;504.742581283548;600.8678090820013;609.5002098279368;620.5563022438978;3978.2839088964265;4011.719179657396;4040.595940405936;4108.075682971307;4113.115680128787;87102;88870;90384.54807726051;90437;91210;74902.5019499607;75034.87447688289;75594;75688.62155689186;76527;53271.73364133154;68888.65555672189;68904.6554767223;69629.95555066678;70331.59336813337;8723.694670686495;8866.86699699492;8936.776580585278;9000.054994225513;9073.410228335137;45489.31766023446;47289.05421891474;47477;49174.52476425713;50533.242001370745;45589.77205113953;49390.75304623454;72663.63668181625;73045.6347718258;73551.26448735659;9068.863967040632;11382.658520244406;11596;11621.186516943733;12359.25844449336;11820.645380638594;11968.16222864391;11979.700507487383;12183.695407614881;12432.440540175532;11142.387168705474;11353.829692554784;11440.199186056896;11894.524219031488;12076.973457256232;11220.607278745205;11959.402029898645;11973.221740587182;12066.638000859988;12482.063845211464;10592.841107383241;10941;11680.357580333164;11729;12320.691982700504;7833.855157570845;8888.466691998501;8948.926128864578;9288.396254243453;9289.62841486333;9109.77225569366;9381.671641492516;9849;9905.504724763588;9911.950440247752 05:42:58 INFO - PROCESS | 2300 | __end_tp_report 05:42:58 INFO - PROCESS | 2300 | __start_cc_report 05:42:58 INFO - PROCESS | 2300 | _x_x_mozilla_cycle_collect,379 05:42:58 INFO - PROCESS | 2300 | __end_cc_report 05:42:58 INFO - PROCESS | 2300 | __startTimestamp1454593378894__endTimestamp 05:42:58 INFO - PROCESS | 2300 | 05:42:58 INFO - PROCESS | 2300 | ------- Summary: start ------- 05:42:58 INFO - PROCESS | 2300 | Number of tests: 6 05:42:58 INFO - PROCESS | 2300 | 05:42:58 INFO - PROCESS | 2300 | [#0] dojo.html Cycles:165 Average:5623.56 Median:5852.39 stddev:656.32 (11.2%) stddev-sans-first:621.96 05:42:58 INFO - PROCESS | 2300 | Values: 2876.9 3446.1 3489.8 3505.7 3512.0 5502.1 5546.1 5548.9 5561.4 5615.0 5494.1 5552.4 5610.4 5619.4 5651.6 5063.0 5103.7 5125.4 5194.5 5228.3 4332.0 5127.5 5182.2 5241.4 5276.7 3648.6 5063.2 5120.9 5141.7 5193.4 5149.0 5149.0 5160.1 5189.7 5218.0 5083.9 5114.7 5126.1 5127.6 5137.9 5297.4 5475.6 5541.5 5575.4 5696.2 6068.5 6069.9 6081.4 6088.4 6106.3 6110.8 6128.8 6134.4 6135.1 6151.1 5571.5 5735.2 5743.5 5747.5 5797.8 6173.4 6181.4 6184.6 6221.9 6227.6 5895.6 6016.4 6018.4 6030.4 6051.8 6081.2 6138.7 6143.8 6186.0 6207.6 6061.9 6090.4 6091.6 6102.3 6109.3 4815.3 5583.8 5837.7 6099.0 6154.1 4156.0 4767.5 4861.7 4863.5 4899.8 4346.4 4352.8 4360.9 4366.0 4369.9 5588.5 5696.9 5734.4 5753.3 5829.4 6060.0 6094.9 6117.7 6119.2 6142.3 4741.8 5653.4 5687.0 5694.9 5711.5 5296.4 5308.4 5311.4 5312.4 5395.0 6103.9 6185.0 6194.0 6280.5 6304.5 6120.7 6134.8 6148.4 6162.3 6165.4 6117.8 6138.2 6282.2 6293.4 6336.3 6044.2 6075.6 6105.6 6150.1 6172.0 6117.3 6138.2 6147.7 6150.3 6165.4 5881.5 5908.2 5995.0 6037.3 6070.8 5974.6 5999.0 6032.2 6083.7 6122.8 5377.3 5797.9 5797.9 5852.4 5866.2 5818.5 6000.3 6019.9 6038.7 6067.6 5854.5 5855.0 5864.1 5866.2 5886.9 05:42:58 INFO - PROCESS | 2300 | 05:42:58 INFO - PROCESS | 2300 | [#1] ext.html Cycles:180 Average:65600.77 Median:39572.90 stddev:138840.12 (350.8%) stddev-sans-first:139143.40 05:42:58 INFO - PROCESS | 2300 | Values: 436.1 438.4 493.8 544.3 568.8 38034.6 38849.0 38956.0 39005.4 39042.6 43008.1 43031.6 43481.8 43534.8 43777.3 8448.2 8476.3 9677.2 9864.4 9927.3 9796.6 9867.1 9867.2 9887.9 9896.2 9891.9 9911.7 9931.2 9940.0 9965.3 9462.7 9761.9 9890.4 9923.4 9941.8 8631.8 9562.9 9824.3 9827.8 9852.7 40103.2 40197.6 40222.0 40471.2 40561.8 2770.4 3222.8 3296.0 3360.3 3486.6 27959.2 27981.2 28275.3 28355.0 28676.4 2739.8 2812.6 2819.8 2832.7 2840.9 461460.0 462811.0 463337.0 464992.0 465364.0 57679.7 58752.0 65109.4 65684.0 66908.0 64558.7 64706.0 65144.0 65238.0 65301.0 16441.4 16443.3 16490.3 16637.8 16755.2 12667.9 12703.0 12724.1 12751.4 12874.7 21150.9 21270.0 21455.8 21497.9 21617.9 8747.9 8989.3 9000.5 9036.7 9050.2 911.3 925.7 933.6 956.5 1196.0 27887.8 29075.7 29200.0 29714.3 29758.0 1014.8 1042.4 1070.9 1116.5 1139.6 13541.6 14204.4 14933.9 14941.9 15206.7 511907.0 617433.0 619154.0 621898.0 629157.9 59617.4 60353.7 60437.1 60494.0 60522.0 1378.1 1399.3 1412.8 1422.8 1426.1 27264.2 28826.0 29113.5 29299.7 29369.4 48992.5 49142.0 49573.8 49576.5 49774.0 480812.0 486662.0 487671.0 488818.0 489586.0 28377.0 28756.4 32755.0 33584.8 33842.5 41038.0 41192.8 42450.0 42749.6 42922.4 33679.5 35345.7 35405.0 35609.5 35961.0 27378.0 34767.1 34874.1 35296.0 35605.1 33440.0 35292.5 35547.3 35965.6 36919.3 27736.0 29843.7 32025.9 32527.0 32918.5 21574.0 22871.8 24580.3 24628.8 25847.4 05:42:58 INFO - PROCESS | 2300 | 05:42:58 INFO - PROCESS | 2300 | [#2] jquery.html Cycles:180 Average:33753.60 Median:370.70 stddev:106030.81 (28602.9%) stddev-sans-first:106298.52 05:42:58 INFO - PROCESS | 2300 | Values: 315.0 352.5 357.3 357.3 363.1 15318.4 17615.6 18734.1 19254.1 20929.4 15339.7 19121.4 19208.6 19279.5 19464.2 4964.4 5535.8 5827.1 5832.6 5853.9 4092.5 4310.4 5451.2 5790.8 6093.4 6049.1 6302.6 6305.7 6307.7 6328.3 6347.2 6361.7 6377.8 6394.8 6418.7 5488.5 5533.4 5539.4 5589.2 5597.9 24159.8 24372.3 24422.3 24588.3 24596.0 2455.4 2604.4 2668.1 2878.3 3018.6 11046.8 11341.8 11997.5 14311.6 14323.9 1696.5 1711.7 1730.2 1734.9 1807.6 80904.0 84248.0 90367.0 92068.0 95015.5 10197.3 10434.4 10551.2 10624.6 10728.3 12738.7 12821.5 12951.4 12958.2 12960.2 8492.7 8531.9 8577.1 8587.0 8619.4 7081.8 8807.5 8808.1 8859.2 8872.7 6080.3 6133.6 6159.0 6186.2 6203.9 1451.5 1582.2 1744.5 1788.5 1790.2 366.7 374.7 415.4 444.6 998.4 11035.4 11551.8 11570.5 11679.0 11752.3 391.4 431.4 443.2 453.9 473.0 5960.8 6149.4 8998.6 10644.3 10726.4 600044.0 617163.0 623086.0 672990.0 697257.0 107931.4 108272.0 108468.5 109494.0 109581.0 909.1 1130.6 1134.8 1151.5 1159.1 16109.6 16442.7 16789.7 17965.5 18355.5 30965.7 49139.5 49238.8 49652.5 49755.0 64054.7 69601.7 70252.3 70328.3 71388.9 6271.8 6746.9 7168.5 7657.8 7676.1 9946.8 10184.8 11286.9 11657.9 11762.4 9861.3 10035.3 10073.4 10111.7 10210.9 9616.9 9927.0 10038.3 10087.3 10272.5 9822.8 10055.7 10212.8 10279.6 10390.0 7468.8 7619.6 7674.6 7697.2 7724.4 8601.6 9711.4 10155.3 10406.5 10464.3 05:42:58 INFO - PROCESS | 2300 | 05:42:58 INFO - PROCESS | 2300 | [#3] mootools.html Cycles:180 Average:6087.39 Median:4982.36 stddev:3224.29 (64.7%) stddev-sans-first:3212.33 05:42:58 INFO - PROCESS | 2300 | Values: 1191.9 1507.8 1651.5 1849.9 1867.3 7909.6 8013.2 8591.0 8749.6 8789.2 8292.7 8400.8 8509.0 8541.9 8553.5 2466.2 2490.3 2492.1 2496.5 2508.1 2382.9 2430.5 2476.9 2480.4 2481.5 1859.9 1938.5 2053.5 2454.7 2484.7 2464.7 2473.6 2484.9 2492.1 2492.9 2458.8 2485.9 2493.8 2494.2 2495.6 8753.3 8853.9 8911.7 8931.0 8935.4 5362.2 5546.7 5563.7 5570.2 5594.0 3606.1 3662.5 3693.3 3710.9 3717.0 1026.7 1036.5 1039.2 1045.3 1051.2 12013.3 12100.0 12271.4 12295.0 12303.0 4354.9 4916.8 4920.9 5019.7 5034.8 8673.0 10063.6 10236.5 10373.7 10391.5 4387.4 5501.9 5556.1 5560.2 5569.8 4405.3 4488.8 4861.5 4948.9 5015.8 3950.1 3960.6 4004.1 4014.8 4089.4 1104.3 1296.0 1301.6 1301.9 1312.7 1292.9 1313.8 1321.5 1328.5 1338.5 8074.1 8183.7 8210.0 8392.9 8395.2 1031.6 1176.0 1180.5 1183.4 1191.7 6260.1 6308.3 6378.5 6382.5 6409.8 10612.9 10810.5 10872.6 10959.8 10964.2 10379.6 10644.9 10792.1 10799.0 10815.0 8386.6 8387.2 8421.4 8478.6 8512.5 7747.5 7898.4 7912.0 7968.6 8015.3 9660.5 9811.9 9845.3 9862.7 9890.7 9674.5 10023.3 10159.9 10311.7 10326.9 6423.5 6669.5 6922.6 7036.7 7115.2 7566.1 7976.1 8194.9 8210.1 8215.9 7545.2 7781.7 7803.2 7808.9 7924.3 7538.9 7594.2 7632.8 7702.8 7752.5 7755.7 7770.1 7788.2 7813.5 7819.4 6936.8 7027.7 7070.3 7073.7 7081.9 7132.9 7161.5 7194.9 7196.7 7230.9 05:42:58 INFO - PROCESS | 2300 | 05:42:58 INFO - PROCESS | 2300 | [#4] prototype.html Cycles:180 Average:5913.37 Median:6770.27 stddev:1934.78 (28.6%) stddev-sans-first:1894.10 05:42:58 INFO - PROCESS | 2300 | Values: 319.6 321.2 326.8 330.2 330.7 6657.7 6804.1 6890.3 6918.1 6927.0 6546.0 6658.5 6706.5 6709.0 6736.4 4057.7 5034.6 5060.4 5072.9 5074.3 4918.2 5044.4 5056.2 5056.4 5070.1 4155.2 4185.8 4306.8 5006.3 5014.6 5010.8 5017.0 5026.5 5031.3 5032.9 4075.9 4152.3 4156.3 4297.0 4298.3 5341.6 6389.3 6427.0 6428.9 6479.1 5878.4 5889.1 5889.9 5917.3 5926.9 7004.2 7124.3 7207.1 7215.4 7258.2 4225.9 4505.1 4773.3 4777.4 4797.1 6135.8 7606.7 7635.7 7668.1 7670.3 4725.0 4812.5 4850.4 4874.9 4887.0 4109.9 4968.3 4995.3 4997.4 5007.3 5908.1 5919.9 5921.5 5929.0 5937.2 5837.6 7217.5 7233.8 7292.2 7338.0 1357.6 1584.5 1669.1 1715.5 1742.1 959.2 988.7 1055.4 1067.7 1072.0 5884.6 6820.7 6830.0 6859.0 6877.8 6008.3 7458.3 7462.0 7500.0 7538.7 6627.3 6815.7 6825.3 6830.5 6850.6 3900.2 3963.9 3978.0 4014.0 4021.5 6422.6 7729.3 7768.0 7999.7 8044.2 6632.0 7859.4 7871.5 7888.8 7906.5 7737.5 7934.2 7973.4 7981.4 7988.0 7585.5 7598.8 7621.2 7670.3 7674.0 7254.7 7481.5 7488.1 7492.3 7510.9 7976.3 7978.5 7985.6 7993.9 8026.6 3911.7 3924.3 4754.9 4756.2 4775.8 7358.3 7505.5 7581.5 7621.6 7624.8 7284.8 7306.8 7313.0 7337.5 7354.8 7291.5 7301.0 7308.6 7314.7 7325.2 6888.2 7133.5 7137.5 7143.4 7146.2 7320.8 7321.8 7324.1 7333.2 7352.8 6937.1 7160.2 7174.5 7184.0 7214.0 05:42:58 INFO - PROCESS | 2300 | 05:42:58 INFO - PROCESS | 2300 | [#5] yui.html Cycles:180 Average:17995.21 Median:631.47 stddev:24945.03 (3950.3%) stddev-sans-first:24981.00 05:42:58 INFO - PROCESS | 2300 | Values: 646.6 654.5 675.6 711.3 725.3 14362.0 14860.2 14897.5 14988.6 15003.8 15443.5 15710.8 15764.3 15795.0 15816.7 595.8 686.4 687.7 804.6 849.2 827.6 858.6 860.7 866.0 867.3 900.0 904.2 904.5 913.8 915.0 889.2 902.8 905.4 909.5 910.1 657.2 664.3 667.2 671.9 672.1 14787.4 14901.0 14957.6 14968.0 15005.8 10441.7 12008.7 12346.1 12740.7 13016.5 10914.3 10981.8 11068.6 11383.8 11959.5 3471.8 3502.5 3512.4 3544.3 3577.6 80855.6 81180.0 81992.8 82245.0 82936.0 9320.5 9339.7 9448.6 9457.4 9669.2 21472.4 21658.6 21752.9 22096.0 22097.4 7504.0 7645.6 7651.5 7707.6 7915.5 3877.7 3990.9 3999.6 4077.2 4145.5 3536.6 3568.8 3582.9 3586.2 3609.0 659.0 659.0 666.1 675.8 681.8 540.9 574.0 594.8 642.4 648.1 8353.5 8639.8 8649.7 8710.0 8719.4 503.0 504.7 600.9 609.5 620.6 3978.3 4011.7 4040.6 4108.1 4113.1 87102.0 88870.0 90384.5 90437.0 91210.0 74902.5 75034.9 75594.0 75688.6 76527.0 53271.7 68888.7 68904.7 69630.0 70331.6 8723.7 8866.9 8936.8 9000.1 9073.4 45489.3 47289.1 47477.0 49174.5 50533.2 45589.8 49390.8 72663.6 73045.6 73551.3 9068.9 11382.7 11596.0 11621.2 12359.3 11820.6 11968.2 11979.7 12183.7 12432.4 11142.4 11353.8 11440.2 11894.5 12077.0 11220.6 11959.4 11973.2 12066.6 12482.1 10592.8 10941.0 11680.4 11729.0 12320.7 7833.9 8888.5 8948.9 9288.4 9289.6 9109.8 9381.7 9849.0 9905.5 9912.0 05:42:58 INFO - PROCESS | 2300 | -------- Summary: end -------- 05:42:58 INFO - PROCESS | 2300 | 05:42:59 INFO - TEST-INFO | 2300: exit 0 05:42:59 INFO - TEST-OK | dromaeo_css | took 1111026ms 05:42:59 INFO - TEST-START | kraken 05:42:59 INFO - operating with platform_type : mac_ 05:42:59 INFO - Initialising browser for kraken test... 05:42:59 INFO - TEST-INFO | started process 2308 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpbJUgad/profile http://localhost:50474/getInfo.html) 05:42:59 INFO - PROCESS | 2308 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 05:43:02 INFO - PROCESS | 2308 | __metrics Screen width/height:1600/1200 05:43:02 INFO - PROCESS | 2308 | colorDepth:24 05:43:02 INFO - PROCESS | 2308 | Browser inner width/height: 1024/689 05:43:02 INFO - PROCESS | 2308 | __metrics 05:43:02 INFO - PROCESS | 2308 | 05:43:02 INFO - PROCESS | 2308 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 05:43:02 INFO - PROCESS | 2308 | 05:43:03 INFO - TEST-INFO | 2308: exit 0 05:43:03 INFO - Browser initialized. 05:43:03 INFO - Running cycle 1/1 for kraken test... 05:43:03 INFO - TEST-INFO | started process 2311 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpbJUgad/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:43:15 INFO - PROCESS | 2311 | RSS: Main: 257204224 05:43:15 INFO - PROCESS | 2311 | 05:43:18 INFO - PROCESS | 2311 | Cycle 1(1): loaded http://localhost:50474/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50474/tests/kraken/driver.html?testName=audio-beat-detection) 05:43:18 INFO - PROCESS | 2311 | RSS: Main: 270286848 05:43:18 INFO - PROCESS | 2311 | 05:43:21 INFO - PROCESS | 2311 | Cycle 1(1): loaded http://localhost:50474/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50474/tests/kraken/driver.html?testName=audio-dft) 05:43:21 INFO - PROCESS | 2311 | RSS: Main: 279396352 05:43:21 INFO - PROCESS | 2311 | 05:43:25 INFO - PROCESS | 2311 | Cycle 1(1): loaded http://localhost:50474/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50474/tests/kraken/driver.html?testName=audio-fft) 05:43:25 INFO - PROCESS | 2311 | RSS: Main: 282808320 05:43:25 INFO - PROCESS | 2311 | 05:43:27 INFO - PROCESS | 2311 | Cycle 1(1): loaded http://localhost:50474/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50474/tests/kraken/driver.html?testName=audio-oscillator) 05:43:28 INFO - PROCESS | 2311 | RSS: Main: 282800128 05:43:28 INFO - PROCESS | 2311 | 05:43:30 INFO - PROCESS | 2311 | Cycle 1(1): loaded http://localhost:50474/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50474/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:43:30 INFO - PROCESS | 2311 | RSS: Main: 283799552 05:43:30 INFO - PROCESS | 2311 | 05:43:33 INFO - PROCESS | 2311 | Cycle 1(1): loaded http://localhost:50474/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50474/tests/kraken/driver.html?testName=imaging-darkroom) 05:43:34 INFO - PROCESS | 2311 | RSS: Main: 284995584 05:43:34 INFO - PROCESS | 2311 | 05:43:37 INFO - PROCESS | 2311 | Cycle 1(1): loaded http://localhost:50474/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50474/tests/kraken/driver.html?testName=imaging-desaturate) 05:43:38 INFO - PROCESS | 2311 | RSS: Main: 284569600 05:43:38 INFO - PROCESS | 2311 | 05:43:40 INFO - PROCESS | 2311 | Cycle 1(1): loaded http://localhost:50474/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50474/tests/kraken/driver.html?testName=json-parse-financial) 05:43:41 INFO - PROCESS | 2311 | RSS: Main: 284819456 05:43:41 INFO - PROCESS | 2311 | 05:43:42 INFO - PROCESS | 2311 | Cycle 1(1): loaded http://localhost:50474/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50474/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:43:43 INFO - PROCESS | 2311 | RSS: Main: 285155328 05:43:43 INFO - PROCESS | 2311 | 05:43:45 INFO - PROCESS | 2311 | Cycle 1(1): loaded http://localhost:50474/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50474/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:43:46 INFO - PROCESS | 2311 | RSS: Main: 283459584 05:43:46 INFO - PROCESS | 2311 | 05:43:48 INFO - PROCESS | 2311 | Cycle 1(1): loaded http://localhost:50474/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50474/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:43:48 INFO - PROCESS | 2311 | RSS: Main: 284192768 05:43:48 INFO - PROCESS | 2311 | 05:43:51 INFO - PROCESS | 2311 | Cycle 1(1): loaded http://localhost:50474/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50474/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:43:52 INFO - PROCESS | 2311 | RSS: Main: 285822976 05:43:52 INFO - PROCESS | 2311 | 05:43:54 INFO - PROCESS | 2311 | Cycle 1(1): loaded http://localhost:50474/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50474/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:43:55 INFO - PROCESS | 2311 | RSS: Main: 285614080 05:43:55 INFO - PROCESS | 2311 | 05:43:57 INFO - PROCESS | 2311 | Cycle 1(1): loaded http://localhost:50474/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50474/tests/kraken/driver.html?testName=ai-astar) 05:43:57 INFO - PROCESS | 2311 | RSS: Main: 285286400 05:43:57 INFO - PROCESS | 2311 | 05:43:57 INFO - PROCESS | 2311 | __start_tp_report 05:43:57 INFO - PROCESS | 2311 | _x_x_mozilla_page_load 05:43:57 INFO - PROCESS | 2311 | _x_x_mozilla_page_load_details 05:43:57 INFO - PROCESS | 2311 | |i|pagename|runs| 05:43:57 INFO - PROCESS | 2311 | |0;ai-astar;123;95;145;166;116;127;115;150;170;115 05:43:57 INFO - PROCESS | 2311 | |1;audio-beat-detection;154;124;154;182;158;146;141;127;174;122 05:43:57 INFO - PROCESS | 2311 | |2;audio-dft;194;196;201;210;210;204;196;200;201;195 05:43:57 INFO - PROCESS | 2311 | |3;audio-fft;84;70;74;109;57;57;61;60;113;62 05:43:57 INFO - PROCESS | 2311 | |4;audio-oscillator;83;89;119;78;82;82;119;82;83;117 05:43:57 INFO - PROCESS | 2311 | |5;imaging-gaussian-blur;87;93;86;93;86;91;87;91;126;95 05:43:57 INFO - PROCESS | 2311 | |6;imaging-darkroom;95;95;95;128;130;150;108;139;151;95 05:43:57 INFO - PROCESS | 2311 | |7;imaging-desaturate;90;93;92;92;93;98;91;95;91;121 05:43:57 INFO - PROCESS | 2311 | |8;json-parse-financial;58;57;57;55;58;57;55;65;57;56 05:43:57 INFO - PROCESS | 2311 | |9;json-stringify-tinderbox;63;65;75;72;82;109;62;84;100;101 05:43:57 INFO - PROCESS | 2311 | |10;stanford-crypto-aes;85;87;87;87;86;87;87;108;115;111 05:43:57 INFO - PROCESS | 2311 | |11;stanford-crypto-ccm;146;139;132;136;124;131;127;135;141;119 05:43:57 INFO - PROCESS | 2311 | |12;stanford-crypto-pbkdf2;147;144;143;142;146;147;139;132;199;139 05:43:57 INFO - PROCESS | 2311 | |13;stanford-crypto-sha256-iterative;70;69;67;70;68;68;66;69;70;66 05:43:57 INFO - PROCESS | 2311 | __end_tp_report 05:43:57 INFO - PROCESS | 2311 | __start_cc_report 05:43:57 INFO - PROCESS | 2311 | _x_x_mozilla_cycle_collect,909 05:43:57 INFO - PROCESS | 2311 | __end_cc_report 05:43:57 INFO - PROCESS | 2311 | __startTimestamp1454593437262__endTimestamp 05:43:57 INFO - PROCESS | 2311 | 05:43:57 INFO - PROCESS | 2311 | ------- Summary: start ------- 05:43:57 INFO - PROCESS | 2311 | Number of tests: 14 05:43:57 INFO - PROCESS | 2311 | 05:43:57 INFO - PROCESS | 2311 | [#0] ai-astar Cycles:10 Average:132.20 Median:147.50 stddev:24.50 (16.6%) stddev-sans-first:25.76 05:43:57 INFO - PROCESS | 2311 | Values: 123.0 95.0 145.0 166.0 116.0 127.0 115.0 150.0 170.0 115.0 05:43:57 INFO - PROCESS | 2311 | 05:43:57 INFO - PROCESS | 2311 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:154.00 stddev:20.41 (13.3%) stddev-sans-first:21.54 05:43:57 INFO - PROCESS | 2311 | Values: 154.0 124.0 154.0 182.0 158.0 146.0 141.0 127.0 174.0 122.0 05:43:57 INFO - PROCESS | 2311 | 05:43:57 INFO - PROCESS | 2311 | [#2] audio-dft Cycles:10 Average:200.70 Median:201.00 stddev:5.83 (2.9%) stddev-sans-first:5.66 05:43:57 INFO - PROCESS | 2311 | Values: 194.0 196.0 201.0 210.0 210.0 204.0 196.0 200.0 201.0 195.0 05:43:57 INFO - PROCESS | 2311 | 05:43:57 INFO - PROCESS | 2311 | [#3] audio-fft Cycles:10 Average:74.70 Median:61.50 stddev:20.93 (34.0%) stddev-sans-first:21.93 05:43:57 INFO - PROCESS | 2311 | Values: 84.0 70.0 74.0 109.0 57.0 57.0 61.0 60.0 113.0 62.0 05:43:57 INFO - PROCESS | 2311 | 05:43:57 INFO - PROCESS | 2311 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:82.00 stddev:17.42 (21.2%) stddev-sans-first:18.06 05:43:57 INFO - PROCESS | 2311 | Values: 83.0 89.0 119.0 78.0 82.0 82.0 119.0 82.0 83.0 117.0 05:43:57 INFO - PROCESS | 2311 | 05:43:57 INFO - PROCESS | 2311 | [#5] imaging-gaussian-blur Cycles:10 Average:93.50 Median:91.00 stddev:11.87 (13.0%) stddev-sans-first:12.36 05:43:57 INFO - PROCESS | 2311 | Values: 87.0 93.0 86.0 93.0 86.0 91.0 87.0 91.0 126.0 95.0 05:43:57 INFO - PROCESS | 2311 | 05:43:57 INFO - PROCESS | 2311 | [#6] imaging-darkroom Cycles:10 Average:118.60 Median:123.00 stddev:23.59 (19.2%) stddev-sans-first:23.43 05:43:57 INFO - PROCESS | 2311 | Values: 95.0 95.0 95.0 128.0 130.0 150.0 108.0 139.0 151.0 95.0 05:43:57 INFO - PROCESS | 2311 | 05:43:57 INFO - PROCESS | 2311 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:92.50 stddev:9.22 (10.0%) stddev-sans-first:9.55 05:43:57 INFO - PROCESS | 2311 | Values: 90.0 93.0 92.0 92.0 93.0 98.0 91.0 95.0 91.0 121.0 05:43:57 INFO - PROCESS | 2311 | 05:43:57 INFO - PROCESS | 2311 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.00 stddev:2.84 (5.0%) stddev-sans-first:3.00 05:43:57 INFO - PROCESS | 2311 | Values: 58.0 57.0 57.0 55.0 58.0 57.0 55.0 65.0 57.0 56.0 05:43:57 INFO - PROCESS | 2311 | 05:43:57 INFO - PROCESS | 2311 | [#9] json-stringify-tinderbox Cycles:10 Average:81.30 Median:68.50 stddev:17.04 (24.9%) stddev-sans-first:16.73 05:43:57 INFO - PROCESS | 2311 | Values: 63.0 65.0 75.0 72.0 82.0 109.0 62.0 84.0 100.0 101.0 05:43:57 INFO - PROCESS | 2311 | 05:43:57 INFO - PROCESS | 2311 | [#10] stanford-crypto-aes Cycles:10 Average:94.00 Median:87.00 stddev:12.09 (13.9%) stddev-sans-first:12.38 05:43:57 INFO - PROCESS | 2311 | Values: 85.0 87.0 87.0 87.0 86.0 87.0 87.0 108.0 115.0 111.0 05:43:57 INFO - PROCESS | 2311 | 05:43:57 INFO - PROCESS | 2311 | [#11] stanford-crypto-ccm Cycles:10 Average:133.00 Median:135.50 stddev:8.16 (6.0%) stddev-sans-first:7.18 05:43:57 INFO - PROCESS | 2311 | Values: 146.0 139.0 132.0 136.0 124.0 131.0 127.0 135.0 141.0 119.0 05:43:57 INFO - PROCESS | 2311 | 05:43:57 INFO - PROCESS | 2311 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.80 Median:145.00 stddev:18.56 (12.8%) stddev-sans-first:19.69 05:43:57 INFO - PROCESS | 2311 | Values: 147.0 144.0 143.0 142.0 146.0 147.0 139.0 132.0 199.0 139.0 05:43:57 INFO - PROCESS | 2311 | 05:43:57 INFO - PROCESS | 2311 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.00 stddev:1.57 (2.3%) stddev-sans-first:1.54 05:43:57 INFO - PROCESS | 2311 | Values: 70.0 69.0 67.0 70.0 68.0 68.0 66.0 69.0 70.0 66.0 05:43:57 INFO - PROCESS | 2311 | -------- Summary: end -------- 05:43:57 INFO - PROCESS | 2311 | 05:43:57 INFO - TEST-INFO | 2311: exit 0 05:43:58 INFO - TEST-OK | kraken | took 58618ms 05:43:58 INFO - SUITE-END | took 1169s 05:43:58 INFO - Completed test suite (00:19:30) 05:43:58 INFO - Working with test: dromaeo_css 05:43:58 INFO - Generating results file: dromaeo_css 05:43:58 INFO - Working with test: kraken 05:43:58 INFO - Generating results file: kraken 05:43:58 INFO - javascript benchmark 05:43:58 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:43:58 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 05:43:58 INFO - process_Request line: dromaeo_css 7439.79 graph.html#tests=[[72,64,61]] 05:43:58 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:43:58 INFO - process_Request line: kraken 1538.80 graph.html#tests=[[232,64,61]] 05:43:58 INFO - RETURN: dromaeo_css: 7439.79 05:43:58 INFO - RETURN: kraken: 1538.80 05:43:58 INFO - javascript benchmark 05:43:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2876.942461150777, 3446.1040129566304, 3489.8080605566715, 3505.7195424366037, 3512.034190597586, 5502.092154794459, 5546.112621980479, 5548.9167662485, 5561.443855614437, 5614.971925140374, 5494.120940649497, 5552.4169962154, 5610.438956104387, 5619.4099619539975, 5651.5761317901115, 5062.974685126569, 5103.693778373291, 5125.436202017784, 5194.506521880416, 5228.346456692913, 4331.956680433187, 5127.513021223841, 5182.248573956774, 5241.3710354757295, 5276.657017293883, 3648.5621725392857, 5063.215201643714, 5120.923186152192, 5141.665791723563, 5193.350831146106, 5149.0, 5149.021685879671, 5160.071187186305, 5189.688618682853, 5218.034663587248, 5083.872903177413, 5114.718690472023, 5126.128558145087, 5127.589792816566, 5137.922931156036, 5297.417284098746, 5475.6440831345835, 5541.5289700375515, 5575.442455754433, 5696.1740547620775, 6068.514518838527, 6069.939300606981, 6081.391860813883, 6088.421599948042, 6106.297775755756, 6110.816675499742, 6128.816135515942, 6134.447899689005, 6135.110408990716, 6151.077338399231, 5571.526420254283, 5735.1684005818925, 5743.483086522233, 5747.453991870766, 5797.797077102366, 6173.444390004921, 6181.412765787243, 6184.628922264678, 6221.875562488724, 6227.564070515021, 5895.557833162444, 6016.368281330485, 6018.398160183947, 6030.366811484819, 6051.788187413419, 6081.239845019372, 6138.6623735694075, 6143.846403839851, 6186.041163619646, 6207.6275423474735, 6061.931507530213, 6090.390960903874, 6091.63450192981, 6102.314311391842, 6109.2974307955155, 4815.253635686474, 5583.832485025456, 5837.737301821428, 6099.024156134997, 6154.138420621117, 4156.0, 4767.4517430495935, 4861.732604706775, 4863.513648635108, 4899.804007839718, 4346.369776382407, 4352.782360882006, 4360.890977725582, 4365.973996110912, 4369.9126017479475, 5588.524975377057, 5696.8860622787315, 5734.426557344315, 5753.33836608787, 5829.417058294137, 6059.969700151559, 6094.939050609526, 6117.736059405574, 6119.204503414617, 6142.293636231891, 4741.810327586858, 5653.434656534314, 5686.9715651421475, 5694.886102277931, 5711.485966263056, 5296.390915044819, 5308.389535203424, 5311.362636483646, 5312.362516497968, 5395.0, 6103.913516305051, 6185.0, 6194.0, 6280.497560195174, 6304.527160463075, 6120.693965301806, 6134.8159555213415, 6148.385161483816, 6162.291336496361, 6165.383461653978, 6117.755289788537, 6138.204480310071, 6282.2147231596055, 6293.402126797947, 6336.3030066693545, 6044.214252147192, 6075.605085669417, 6105.558635639443, 6150.138980542817, 6172.0, 6117.307309300865, 6138.242861781976, 6147.692615369124, 6150.261968563801, 6165.414285642857, 5881.500072493886, 5908.172855800278, 5994.970025149846, 6037.275526936795, 6070.848228794139, 5974.641521508724, 5999.0, 6032.155498230339, 6083.726232319467, 6122.816315510542, 5377.327834020747, 5797.884042319046, 5797.942020579909, 5852.385499522489, 5866.208061911588, 5818.534517238695, 6000.339962604023, 6019.879602408015, 6038.698065096815, 6067.575269731076, 5854.531637469077, 5855.0, 5864.149698293809, 5866.2373891393845, 5886.911696324473], "unit": "score", "name": "dojo.html", "value": 5582.444399319079}, {"lowerIsBetter": false, "replicates": [436.0951026619763, 438.3687490014379, 493.7728644823382, 544.3141641531669, 568.8094488346404, 38034.619653803486, 38849.0, 38956.026099347495, 39005.41491877621, 39042.60957390425, 43008.139837203234, 43031.56968430323, 43481.782591087, 43534.7823260884, 43777.343339849926, 8448.197421244971, 8476.321894248445, 9677.177439917597, 9864.35881667693, 9927.305088643798, 9796.559154838049, 9867.111959923606, 9867.16129129025, 9887.901120988807, 9896.208303335752, 9891.851622225673, 9911.653092141776, 9931.15585175261, 9940.005999400075, 9965.252606054539, 9462.67522546844, 9761.902380976206, 9890.357126786736, 9923.40459572428, 9941.80116397668, 8631.784205394915, 9562.85655715158, 9824.263180261438, 9827.803443931152, 9852.65515706954, 40103.197936041404, 40197.59802401968, 40222.0, 40471.19057618861, 40561.79719101415, 2770.3766652503227, 3222.7744057915957, 3296.027671836814, 3360.327934413103, 3486.6164721880573, 27959.161225163276, 27981.160565182872, 28275.293117672223, 28355.0, 28676.426471470455, 2739.8218067042335, 2812.5640525718545, 2819.7744180465515, 2832.730890565393, 2840.872160752771, 461460.0, 462810.9999999966, 463337.0, 464992.0, 465364.0, 57679.711601441726, 58752.0, 65109.3956241745, 65684.0, 66908.0, 64558.67720661461, 64706.0, 65144.022839657446, 65238.0, 65301.020484692766, 16441.424550140928, 16443.342266309213, 16490.257938392802, 16637.83362166387, 16755.2460139294, 12667.873321266854, 12703.0, 12724.109312348231, 12751.36243187837, 12874.742505150032, 21150.894245528983, 21270.0, 21455.78544214569, 21497.892510537346, 21617.891910540347, 8747.868781968276, 8989.280857531381, 9000.459972401677, 9036.695642611092, 9050.230730387992, 911.2527727263713, 925.6621333213463, 933.5892207428709, 956.4882787708542, 1195.9760804783855, 27887.84561550637, 29075.709242907724, 29200.0, 29714.257143571584, 29758.0, 1014.7970405918845, 1042.4096121138964, 1070.9303895246785, 1116.4808364110565, 1139.601139601133, 13541.59375218745, 14204.360803763855, 14933.850661493247, 14941.925290373696, 15206.695866082837, 511907.0, 617433.0, 619154.0, 621898.0, 629157.854210726, 59617.40382596205, 60353.69823150856, 60437.09344359838, 60494.0, 60522.0, 1378.0904602961998, 1399.3143359753647, 1412.7951447040123, 1422.807920930661, 1426.108682073704, 27264.182074537795, 28826.001569129334, 29113.508675980036, 29299.7070029297, 29369.412611748074, 48992.5100748988, 49142.01715965732, 49573.75213123911, 49576.50423495863, 49774.00451991012, 480812.0, 486662.0, 487671.0, 488818.0, 489586.0, 28377.0, 28756.42487150287, 32755.0, 33584.82453114129, 33842.49236261409, 41038.0, 41192.79403602963, 42450.0, 42749.57250427456, 42922.35616465693, 33679.494807577415, 35345.65338868033, 35405.0, 35609.46585801267, 35961.0, 27378.041768538005, 34767.13082172966, 34874.12814679653, 35296.0, 35605.1098722534, 33440.0, 35292.47061294031, 35547.28905421825, 35965.640343597275, 36919.26161476809, 27736.0, 29843.70156298496, 32025.87909423159, 32527.0, 32918.51866665958, 21574.0, 22871.771282286965, 24580.279380443197, 24628.753712462647, 25847.353816154748], "unit": "score", "name": "ext.html", "value": 19654.17778006889}, {"lowerIsBetter": false, "replicates": [314.95118256670213, 352.5082509898693, 357.2889949001487, 357.3460567162094, 363.1375483227335, 15318.387264509434, 17615.559611009732, 18734.063296835157, 19254.13356398962, 20929.37211883644, 15339.693206135871, 19121.42635720927, 19208.61582768344, 19279.518012049706, 19464.221431142738, 4964.404271487427, 5535.833924982237, 5827.096799996008, 5832.56255780816, 5853.912191317112, 4092.5088989321175, 4310.353446982962, 5451.236826844245, 5790.7683692652245, 6093.390660933916, 6049.1228771828055, 6302.613425046506, 6305.653189074599, 6307.653079080649, 6328.303886572473, 6347.206599175103, 6361.745530178788, 6377.808665740035, 6394.808155755335, 6418.743250269984, 5488.53347465466, 5533.418991005927, 5539.446055394468, 5589.161625756128, 5597.888042239173, 24159.758402416104, 24372.268831934893, 24422.26733198007, 24588.262352129466, 24596.0, 2455.4229756007326, 2604.4009877728226, 2668.0795125681607, 2878.266042159257, 3018.622672165979, 11046.834297485544, 11341.829872551918, 11997.520099196021, 14311.642208944755, 14323.928380358031, 1696.4740930311643, 1711.7432385142204, 1730.2041061111904, 1734.8612111031086, 1807.6203997160612, 80903.97740056487, 84248.0, 90367.0, 92067.99999999933, 95015.52492237494, 10197.337173083726, 10434.426106564211, 10551.20865935058, 10624.628138015132, 10728.302660327054, 12738.745225095447, 12821.487140514275, 12951.352432378344, 12958.22250664963, 12960.157589756636, 8492.74521764348, 8531.872021919677, 8577.05652378238, 8586.95706521476, 8619.353548483889, 7081.787546373617, 8807.471551706918, 8808.075152109064, 8859.202671759573, 8872.689455869013, 6080.331163572004, 6133.570650054543, 6159.045347971071, 6186.226721659793, 6203.937960620427, 1451.506487794155, 1582.185174635064, 1744.5202569293547, 1788.4902802701429, 1790.1765188013399, 366.6616848502932, 374.7371358521799, 415.36863966770943, 444.5732097186737, 998.3610489286863, 11035.39305338198, 11551.76896462066, 11570.537178512934, 11679.0, 11752.294862308288, 391.37575566970634, 431.3917376499121, 443.1646346636549, 453.94098767160716, 473.0, 5960.791372301948, 6149.41580549847, 8998.55007249648, 10644.254902156774, 10726.410047447309, 600044.0, 617163.0, 623086.0, 672990.0, 697257.0, 107931.38102928305, 108272.0, 108468.4576577112, 109494.0, 109581.0, 909.1499448016126, 1130.621241883978, 1134.7843909657304, 1151.5163631274884, 1159.084323384517, 16109.630681392213, 16442.671146577242, 16789.66420671555, 17965.461036168937, 18355.541111471786, 30965.69034309628, 49139.50860491349, 49238.75380623074, 49652.50347496479, 49755.004899902524, 64054.67972660107, 69601.65199173972, 70252.29747702662, 70328.29671703218, 71388.9291660636, 6271.811845644638, 6746.86506269862, 7168.462365322726, 7657.808554785952, 7676.078870535572, 9946.751331216778, 10184.796304074025, 11286.943565282449, 11657.941710291734, 11762.353070580857, 9861.260405469475, 10035.297529172887, 10073.44596047195, 10111.696649100539, 10210.897891020995, 9616.9038309616, 9926.970912988269, 10038.347507411994, 10087.344322619007, 10272.537735801758, 9822.75443113928, 10055.69832905014, 10212.846807297748, 10279.588816447558, 10390.012948769854, 7468.813279668052, 7619.619019049136, 7674.61626918663, 7697.230276972482, 7724.420668450001, 8601.612927418157, 9711.36876103051, 10155.289129761142, 10406.479676016017, 10464.267501274837], "unit": "score", "name": "jquery.html", "value": 8655.383424378502}, {"lowerIsBetter": false, "replicates": [1191.9463624136915, 1507.7813717011034, 1651.5128037229017, 1849.879757815741, 1867.2997625890291, 7909.604519774017, 8013.2387423194705, 8591.0, 8749.606267717953, 8789.208971192584, 8292.70975515857, 8400.831983360344, 8509.0, 8541.871871921927, 8553.486790792542, 2466.161505088274, 2490.302715239736, 2492.090387008747, 2496.5131799299143, 2508.08454913956, 2382.9046838126455, 2430.4895971845935, 2476.8761561921924, 2480.3675062858947, 2481.4540801023745, 1859.8977056261967, 1938.5444420561157, 2053.4763635273057, 2454.6563481112657, 2484.6521486991837, 2464.6549483072386, 2473.5547601431736, 2484.900603975848, 2492.1277552856536, 2492.9252122436264, 2458.791002764767, 2485.9005639774387, 2493.7755601995727, 2494.239257026606, 2495.625656151574, 8753.299736021167, 8853.867191992125, 8911.73264802057, 8930.955345223298, 8935.374523783337, 5362.249285100089, 5546.722663866791, 5563.693996830173, 5570.220169176318, 5593.972030139864, 3606.0804494853646, 3662.505561749156, 3693.279810436966, 3710.9257814843822, 3716.981415092934, 1026.686860507545, 1036.4921188617523, 1039.2413538117216, 1045.3414348960182, 1051.164324362134, 12013.279203247746, 12100.0, 12271.38643067843, 12295.016398688083, 12302.954248888855, 4354.911272181955, 4916.803327866845, 4920.852374428773, 5019.67372120811, 5034.823781167642, 8673.0, 10063.647772327933, 10236.53935572901, 10373.740656483498, 10391.53238104287, 4387.42963414754, 5501.862453438696, 5556.083246264321, 5560.165975103686, 5569.777208911598, 4405.29515277554, 4488.842890498817, 4861.513848615181, 4948.8762780930765, 5015.84952451427, 3950.071733142709, 3960.6237407446247, 4004.1391100913443, 4014.8394064237687, 4089.3865920111625, 1104.282216559243, 1296.027979015738, 1301.5965050834272, 1301.9414126364336, 1312.6915174933883, 1292.9224246545236, 1313.835770528684, 1321.4648067532664, 1328.4951718346965, 1338.5315139701027, 8074.111847696749, 8183.6726530938095, 8209.958950205211, 8392.916070839336, 8395.202455766692, 1031.6286136990827, 1176.0, 1180.5100883133402, 1183.384639987219, 1191.6901605582611, 6260.092286618506, 6308.337624549448, 6378.521610879203, 6382.457491113308, 6409.775657851953, 10612.893871061346, 10810.513526891309, 10872.565097396173, 10959.83560246597, 10964.17768667353, 10379.584816607252, 10644.89355106439, 10792.082672972885, 10799.0, 10814.972577605115, 8386.580670966427, 8387.203215694499, 8421.410501264852, 8478.576071196292, 8512.531810750344, 7747.535147891144, 7898.368130549427, 7912.0, 7968.601569921597, 8015.318697910743, 9660.516974151124, 9811.85282220753, 9845.310828241954, 9862.654807081717, 9890.703278901357, 9674.452087665939, 10023.348482348623, 10159.898401015895, 10311.742206444898, 10326.896731032593, 6423.518236132215, 6669.46644268467, 6922.619255940972, 7036.683349249193, 7115.181754098345, 7566.129895061918, 7976.1226265109635, 8194.877076843733, 8210.137935516685, 8215.876761848458, 7545.207753185837, 7781.688732450639, 7803.180666030212, 7808.882866757117, 7924.326432253092, 7538.924610754042, 7594.164641889277, 7632.771016869503, 7702.768916932501, 7752.5348479091435, 7755.6509957053195, 7770.14528401864, 7788.221177882167, 7813.4530582860925, 7819.413543984338, 6936.757213497705, 7027.683754231174, 7070.292970702889, 7073.71705131789, 7081.929180708333, 7132.893006605009, 7161.4986950912935, 7194.856102878018, 7196.748113815991, 7230.891536626849], "unit": "score", "name": "mootools.html", "value": 4952.525635920373}, {"lowerIsBetter": false, "replicates": [319.5701781104415, 321.168174428231, 326.8186156683043, 330.1515106177126, 330.7040199021876, 6657.733690652381, 6804.115464989551, 6890.310968903107, 6918.066061081759, 6926.965365173167, 6545.967270163655, 6658.533902626818, 6706.530542862001, 6708.96645516773, 6736.427403670682, 4057.6753859691153, 5034.647574669774, 5060.443351231362, 5072.873178170538, 5074.264231686403, 4918.188498897677, 5044.394672639289, 5056.165732654108, 5056.367954005749, 5070.1380765269805, 4155.231282212801, 4185.807044992178, 4306.837153968427, 5006.299118123466, 5014.5737612303, 5010.849674509771, 5016.974915125419, 5026.466927587085, 5031.295618613397, 5032.899342013176, 4075.8981025474304, 4152.259508724258, 4156.334986402161, 4296.978515107436, 4298.290782020963, 5341.626086173969, 6389.329120442333, 6426.967865160691, 6428.903566446507, 6479.060536222269, 5878.382769809151, 5889.1460738193155, 5889.941100589025, 5917.349091599921, 5926.940730592682, 7004.170933340004, 7124.287571242886, 7207.135143782727, 7215.386692131176, 7258.165310989251, 4225.852095176685, 4505.121501307246, 4773.260144677581, 4777.355057067321, 4797.088553174921, 6135.78524751636, 7606.733764318223, 7635.732749353801, 7668.118166410878, 7670.27132422419, 4725.0, 4812.470628230892, 4850.442199147073, 4874.902501949941, 4886.99816537609, 4109.869785808926, 4968.254761785689, 4995.325631039836, 4997.425296090923, 5007.349044624176, 5908.0503433866725, 5919.881602368015, 5921.526277897758, 5928.962431574457, 5937.228160339128, 5837.620554663933, 7217.530860494051, 7233.819154521179, 7292.234315396913, 7337.963310183522, 1357.5995081450997, 1584.4533635895598, 1669.0986867091635, 1715.5110793423814, 1742.1202292842033, 959.2374062620233, 988.7393573194091, 1055.4247934875357, 1067.7490789664423, 1072.0137473524376, 5884.617499862496, 6820.6930688119155, 6829.975503674389, 6859.0, 6877.759278425331, 6008.309044459856, 7458.2541745826065, 7462.0, 7500.024996750388, 7538.736144235035, 6627.271000189975, 6815.727370905108, 6825.317468253135, 6830.487713421513, 6850.554713943578, 3900.2199560088097, 3963.8810835674976, 3977.9801100994887, 4013.959860401417, 4021.5375231848125, 6422.614643121427, 7729.265719756614, 7767.961160194276, 7999.720009799629, 8044.1955804419085, 6631.966840165768, 7859.449838511249, 7871.527708337404, 7888.802779930547, 7906.486078404885, 7737.497062690907, 7934.206579342135, 7973.362131029619, 7981.40139489529, 7988.0, 7585.544867307979, 7598.772036838904, 7621.237876212556, 7670.348020418104, 7674.0, 7254.673539690621, 7481.476296659399, 7488.101427828696, 7492.325690687864, 7510.887336690063, 7976.282134607914, 7978.481398709066, 7985.640646171052, 7993.920060799318, 8026.59867006659, 3911.6675082618294, 3924.3328634131694, 4754.857354279377, 4756.16767065769, 4775.832845850378, 7358.300961408658, 7505.549667019996, 7581.50720203185, 7621.618919054136, 7624.847503049797, 7284.817879553054, 7306.817329566803, 7313.0, 7337.523061001018, 7354.779356619096, 7291.52605080668, 7300.96349518249, 7308.5614863108385, 7314.670839812327, 7325.157606875277, 6888.242293347828, 7133.536320139175, 7137.464690148156, 7143.392811611071, 7146.213916469288, 7320.780376588711, 7321.816954576178, 7324.121105467165, 7333.230010848997, 7352.77941661751, 6937.098177236927, 7160.176579693402, 7174.461915356264, 7184.030155929092, 7214.0], "unit": "score", "name": "prototype.html", "value": 5256.597302769281}, {"lowerIsBetter": false, "replicates": [646.5668002438368, 654.5254690349494, 675.5946432140715, 711.281605578366, 725.300085417572, 14362.0, 14860.182689952047, 14897.478588249414, 14988.625284367883, 15003.774943375858, 15443.536693899201, 15710.764338534931, 15764.290606922686, 15795.0, 15816.683666326666, 595.75574014654, 686.4096876686046, 687.6596084937963, 804.6419343392192, 849.1720572441882, 827.5903427803246, 858.6050416808245, 860.7202659135775, 866.0, 867.3321542412339, 900.045951291633, 904.2314033071902, 904.5206040798355, 913.7669894176976, 914.9862752058724, 889.1775108025051, 902.7923577577161, 905.3707673167152, 909.4588719711761, 910.0990019880337, 657.2015001772869, 664.2626684380382, 667.2393471442559, 671.9092922455454, 672.1228796420669, 14787.40850365984, 14901.031432956823, 14957.626059348604, 14967.95224334297, 15005.774913376308, 10441.738956526071, 12008.699782505508, 12346.135770496068, 12740.681482962907, 13016.479340826356, 10914.345139291669, 10981.780364392747, 11068.557257709683, 11383.772324553545, 11959.521619135225, 3471.75697701161, 3502.4571191465366, 3512.4213711282705, 3544.326577950181, 3577.5528058992627, 80855.59572202161, 81180.0, 81992.77010844841, 82245.0, 82936.0, 9320.487373194539, 9339.673111441067, 9448.622055117718, 9457.38526995757, 9669.226461883032, 21472.355829325144, 21658.566828663337, 21752.89123554372, 22096.0, 22097.447563811034, 7503.962480187564, 7645.579493127821, 7651.502652327581, 7707.614619269127, 7915.525068495908, 3877.651011408987, 3990.900227494336, 3999.6200360965663, 4077.1845630873945, 4145.502539695196, 3536.6109727929907, 3568.7680300780885, 3582.9283414331567, 3586.246888153517, 3608.963910360915, 658.9538732288789, 659.0378048049901, 666.1406785246977, 675.8040168351222, 681.7613835157754, 540.9323834520685, 573.9770409183669, 594.7710131599365, 642.3768944124192, 648.0894343447463, 8353.54055526952, 8639.78400539979, 8649.654013839501, 8709.956450217709, 8719.38964272495, 502.9622778291643, 504.742581283548, 600.8678090820013, 609.5002098279368, 620.5563022438978, 3978.2839088964265, 4011.719179657396, 4040.595940405936, 4108.075682971307, 4113.115680128787, 87102.0, 88870.0, 90384.54807726051, 90437.0, 91210.0, 74902.5019499607, 75034.87447688289, 75594.0, 75688.62155689186, 76527.0, 53271.73364133154, 68888.65555672189, 68904.6554767223, 69629.95555066678, 70331.59336813337, 8723.694670686495, 8866.86699699492, 8936.776580585278, 9000.054994225513, 9073.410228335137, 45489.31766023446, 47289.05421891474, 47477.0, 49174.52476425713, 50533.242001370745, 45589.77205113953, 49390.75304623454, 72663.63668181625, 73045.6347718258, 73551.26448735659, 9068.863967040632, 11382.658520244406, 11596.0, 11621.186516943733, 12359.25844449336, 11820.645380638594, 11968.16222864391, 11979.700507487383, 12183.695407614881, 12432.440540175532, 11142.387168705474, 11353.829692554784, 11440.199186056896, 11894.524219031488, 12076.973457256232, 11220.607278745205, 11959.402029898645, 11973.221740587182, 12066.638000859988, 12482.063845211464, 10592.841107383241, 10941.0, 11680.357580333164, 11729.0, 12320.691982700504, 7833.855157570845, 8888.466691998501, 8948.926128864578, 9288.396254243453, 9289.62841486333, 9109.77225569366, 9381.671641492516, 9849.0, 9905.504724763588, 9911.950440247752], "unit": "score", "name": "yui.html", "value": 6858.566886943995}], "name": "dromaeo_css", "value": 7439.7894281562185}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [123.0, 95.0, 145.0, 166.0, 116.0, 127.0, 115.0, 150.0, 170.0, 115.0], "unit": "score", "name": "ai-astar", "value": 132.2}, {"lowerIsBetter": true, "replicates": [154.0, 124.0, 154.0, 182.0, 158.0, 146.0, 141.0, 127.0, 174.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 148.2}, {"lowerIsBetter": true, "replicates": [194.0, 196.0, 201.0, 210.0, 210.0, 204.0, 196.0, 200.0, 201.0, 195.0], "unit": "score", "name": "audio-dft", "value": 200.7}, {"lowerIsBetter": true, "replicates": [84.0, 70.0, 74.0, 109.0, 57.0, 57.0, 61.0, 60.0, 113.0, 62.0], "unit": "score", "name": "audio-fft", "value": 74.7}, {"lowerIsBetter": true, "replicates": [83.0, 89.0, 119.0, 78.0, 82.0, 82.0, 119.0, 82.0, 83.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 93.4}, {"lowerIsBetter": true, "replicates": [87.0, 93.0, 86.0, 93.0, 86.0, 91.0, 87.0, 91.0, 126.0, 95.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 93.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 128.0, 130.0, 150.0, 108.0, 139.0, 151.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 118.6}, {"lowerIsBetter": true, "replicates": [90.0, 93.0, 92.0, 92.0, 93.0, 98.0, 91.0, 95.0, 91.0, 121.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 57.0, 55.0, 58.0, 57.0, 55.0, 65.0, 57.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 75.0, 72.0, 82.0, 109.0, 62.0, 84.0, 100.0, 101.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 81.3}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 87.0, 87.0, 86.0, 87.0, 87.0, 108.0, 115.0, 111.0], "unit": "score", "name": "stanford-crypto-aes", "value": 94.0}, {"lowerIsBetter": true, "replicates": [146.0, 139.0, 132.0, 136.0, 124.0, 131.0, 127.0, 135.0, 141.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 133.0}, {"lowerIsBetter": true, "replicates": [147.0, 144.0, 143.0, 142.0, 146.0, 147.0, 139.0, 132.0, 199.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.8}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 67.0, 70.0, 68.0, 68.0, 66.0, 69.0, 70.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1538.8}]} 05:43:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1538.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7439.79"}}} 05:43:59 INFO - Return code: 0 05:43:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:43:59 INFO - # TBPL SUCCESS # 05:43:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:43:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:43:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:43:59 INFO - 2016-02-04 05:43:59.087 screenresolution[2316:31800] starting screenresolution argv=screenresolution get 05:43:59 INFO - 2016-02-04 05:43:59.089 screenresolution[2316:31800] Display 0: 1600x1200x32@60 05:43:59 INFO - 2016-02-04 05:43:59.095 screenresolution[2317:31803] starting screenresolution argv=screenresolution list 05:43:59 INFO - Available Modes on Display 0 05:43:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:43:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:43:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:43:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:43:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:43:59 INFO - Intel Iris: 05:43:59 INFO - Chipset Model: Intel Iris 05:43:59 INFO - Type: GPU 05:43:59 INFO - Bus: Built-In 05:43:59 INFO - VRAM (Dynamic, Max): 1536 MB 05:43:59 INFO - Vendor: Intel (0x8086) 05:43:59 INFO - Device ID: 0x0a2e 05:43:59 INFO - Revision ID: 0x0009 05:43:59 INFO - Displays: 05:43:59 INFO - Display: 05:43:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:43:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:43:59 INFO - Display Serial Number: 1600x1200 60 05:43:59 INFO - Main Display: Yes 05:43:59 INFO - Mirror: Off 05:43:59 INFO - Online: Yes 05:43:59 INFO - Rotation: Supported 05:43:59 INFO - Return code: 0 05:43:59 INFO - Running post-action listener: _resource_record_post_action 05:43:59 INFO - Running post-run listener: _resource_record_post_run 05:44:00 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 2351104; Write bytes: 711538176; Read time: 35; Write time: 1988 05:44:00 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 391483904; Write bytes: 385881600; Read time: 30355; Write time: 768 05:44:00 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 2351104; Write bytes: 303340032; Read time: 35; Write time: 1166 05:44:00 INFO - Running post-run listener: _upload_blobber_files 05:44:00 INFO - Blob upload gear active. 05:44:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:44:00 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 05:44:00 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:44:00 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:44:00 INFO - (blobuploader) - INFO - Open directory for files ... 05:44:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:44:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:44:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:44:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:44:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:44:02 INFO - (blobuploader) - INFO - Done attempting. 05:44:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:44:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:44:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:44:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:44:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:44:03 INFO - (blobuploader) - INFO - Done attempting. 05:44:03 INFO - (blobuploader) - INFO - Iteration through files over. 05:44:03 INFO - Return code: 0 05:44:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:44:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:44:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/560a914057c09f858c63473312b99800ceec051d87b619d08ebe8786e9c8ab76c740f0091408670059a36cfb2c9694bc8675d89e61b110ea187fd377a6205194", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb152f761008e1fa951a9ba9ca7cc71c9691fa65530b0124b7ca2d9e261fc24deadb86fbb95324f2c258768b4d02c34a9606fc2e96e94bd051cab17920545de6"} 05:44:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:44:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:44:03 INFO - Contents: 05:44:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/560a914057c09f858c63473312b99800ceec051d87b619d08ebe8786e9c8ab76c740f0091408670059a36cfb2c9694bc8675d89e61b110ea187fd377a6205194", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb152f761008e1fa951a9ba9ca7cc71c9691fa65530b0124b7ca2d9e261fc24deadb86fbb95324f2c258768b4d02c34a9606fc2e96e94bd051cab17920545de6"} 05:44:03 INFO - Running post-run listener: copy_logs_to_upload_dir 05:44:03 INFO - Copying logs to upload dir... 05:44:03 INFO - mkdir: /builds/slave/test/build/upload/logs 05:44:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.944897 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-04 05:44:03.302108) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-04 05:44:03.305787) ========= 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.EDyEhqUqAL/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.i8Zozrur6I/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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/Fx-Team/sha512/560a914057c09f858c63473312b99800ceec051d87b619d08ebe8786e9c8ab76c740f0091408670059a36cfb2c9694bc8675d89e61b110ea187fd377a6205194", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb152f761008e1fa951a9ba9ca7cc71c9691fa65530b0124b7ca2d9e261fc24deadb86fbb95324f2c258768b4d02c34a9606fc2e96e94bd051cab17920545de6"} build_url:https://queue.taskcluster.net/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011461 build_url: 'https://queue.taskcluster.net/v1/task/Ns1hnHkrSMafU6NW_pc4Pg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/560a914057c09f858c63473312b99800ceec051d87b619d08ebe8786e9c8ab76c740f0091408670059a36cfb2c9694bc8675d89e61b110ea187fd377a6205194", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb152f761008e1fa951a9ba9ca7cc71c9691fa65530b0124b7ca2d9e261fc24deadb86fbb95324f2c258768b4d02c34a9606fc2e96e94bd051cab17920545de6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-04 05:44:03.337352) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:44:03.337669) ========= 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.EDyEhqUqAL/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.i8Zozrur6I/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.005416 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:44:03.386318) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-04 05:44:03.386631) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-04 05:44:03.387016) ========= ========= Total master_lag: 0.26 =========