builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0086 starttime: 1454601540.97 results: success (0) buildid: 20160204060028 builduid: d949b2e4713f4cac85c9a352a1e2098d revision: d2522fbd0f6328c7c2b54975636d951924ec7372 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-04 07:59:00.973255) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-04 07:59:00.973692) ========= ========= Started set props: basedir (results: 0, elapsed: 4 secs) (at 2016-02-04 07:59:00.973987) ========= 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.Kk4TkAcuIl/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.qb0SM6yvgU/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.005664 basedir: '/builds/slave/test' ========= master_lag: 4.56 ========= ========= Finished set props: basedir (results: 0, elapsed: 4 secs) (at 2016-02-04 07:59:05.539282) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-04 07:59:05.539631) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-04 07:59:05.558755) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 07:59:05.559105) ========= 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.Kk4TkAcuIl/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.qb0SM6yvgU/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.005096 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 07:59:05.607366) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-04 07:59:05.607680) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-04 07:59:05.608049) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 07:59:05.608317) ========= 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.Kk4TkAcuIl/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.qb0SM6yvgU/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 07:59:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 165M=0s 2016-02-04 07:59:05 (165 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126083 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 07:59:05.749033) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 07:59:05.749336) ========= 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.Kk4TkAcuIl/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.qb0SM6yvgU/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.019388 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 07:59:05.798520) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 07:59:05.798872) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d2522fbd0f6328c7c2b54975636d951924ec7372 --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 d2522fbd0f6328c7c2b54975636d951924ec7372 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Kk4TkAcuIl/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.qb0SM6yvgU/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 07:59:05,863 truncating revision to first 12 chars 2016-02-04 07:59:05,863 Setting DEBUG logging. 2016-02-04 07:59:05,863 attempt 1/10 2016-02-04 07:59:05,863 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d2522fbd0f63?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-04 07:59:06,552 unpacking tar archive at: fx-team-d2522fbd0f63/testing/mozharness/ program finished with exit code 0 elapsedTime=0.931962 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 07:59:06.746567) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-04 07:59:06.746920) ========= echo d2522fbd0f6328c7c2b54975636d951924ec7372 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd2522fbd0f6328c7c2b54975636d951924ec7372'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Kk4TkAcuIl/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.qb0SM6yvgU/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 d2522fbd0f6328c7c2b54975636d951924ec7372 program finished with exit code 0 elapsedTime=0.004992 script_repo_revision: 'd2522fbd0f6328c7c2b54975636d951924ec7372' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-04 07:59:06.796416) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-04 07:59:06.796730) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-04 07:59:06.809329) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-04 07:59:06.809645) ========= /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.Kk4TkAcuIl/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.qb0SM6yvgU/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 07:59:06 INFO - MultiFileLogger online at 20160204 07:59:06 in /builds/slave/test 07:59:06 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 07:59:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:59:06 INFO - {'append_to_log': False, 07:59:06 INFO - 'base_work_dir': '/builds/slave/test', 07:59:06 INFO - 'blob_upload_branch': 'Fx-Team', 07:59:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:59:06 INFO - 'branch': 'Fx-Team', 07:59:06 INFO - 'buildbot_json_path': 'buildprops.json', 07:59:06 INFO - 'config_files': ('talos/mac_config.py',), 07:59:06 INFO - 'default_actions': ('clobber', 07:59:06 INFO - 'read-buildbot-config', 07:59:06 INFO - 'download-and-extract', 07:59:06 INFO - 'populate-webroot', 07:59:06 INFO - 'create-virtualenv', 07:59:06 INFO - 'install', 07:59:06 INFO - 'run-tests'), 07:59:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:59:06 INFO - 'download_minidump_stackwalk': True, 07:59:06 INFO - 'download_symbols': 'ondemand', 07:59:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:59:06 INFO - 'tooltool.py': '/tools/tooltool.py', 07:59:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:59:06 INFO - '/tools/misc-python/virtualenv.py')}, 07:59:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:59:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:59:06 INFO - 'installer_path': 'installer.exe', 07:59:06 INFO - 'log_level': 'info', 07:59:06 INFO - 'log_name': 'talos', 07:59:06 INFO - 'log_to_console': True, 07:59:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:59:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:59:06 INFO - 'opt_config_files': (), 07:59:06 INFO - 'pip_index': False, 07:59:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:59:06 INFO - 'cmd': ('bash', 07:59:06 INFO - '-c', 07:59:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:59:06 INFO - 'enabled': True, 07:59:06 INFO - 'halt_on_failure': False, 07:59:06 INFO - 'name': 'check_screen_resolution'},), 07:59:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:59:06 INFO - 'cmd': ('bash', 07:59:06 INFO - '-c', 07:59:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:59:06 INFO - 'enabled': True, 07:59:06 INFO - 'halt_on_failure': False, 07:59:06 INFO - 'name': 'check_screen_resolution'},), 07:59:06 INFO - 'run_cmd_checks_enabled': True, 07:59:06 INFO - 'sps_profile': False, 07:59:06 INFO - 'sps_profile_interval': 0, 07:59:06 INFO - 'suite': 'dromaeojs-e10s', 07:59:06 INFO - 'system_bits': '32', 07:59:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:59:06 INFO - 'title': 't-yosemite-r7-0086', 07:59:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:59:06 INFO - 'use_talos_json': True, 07:59:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:59:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:59:06 INFO - 'work_dir': 'build'} 07:59:06 INFO - ##### 07:59:06 INFO - ##### Running clobber step. 07:59:06 INFO - ##### 07:59:06 INFO - Running pre-action listener: _resource_record_pre_action 07:59:06 INFO - Running main action method: clobber 07:59:06 INFO - rmtree: /builds/slave/test/build 07:59:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:59:07 INFO - Running post-action listener: _resource_record_post_action 07:59:07 INFO - ##### 07:59:07 INFO - ##### Running read-buildbot-config step. 07:59:07 INFO - ##### 07:59:07 INFO - Running pre-action listener: _resource_record_pre_action 07:59:07 INFO - Running main action method: read_buildbot_config 07:59:07 INFO - Using buildbot properties: 07:59:07 INFO - { 07:59:07 INFO - "project": "", 07:59:07 INFO - "product": "firefox", 07:59:07 INFO - "script_repo_revision": "production", 07:59:07 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 07:59:07 INFO - "repository": "", 07:59:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 07:59:07 INFO - "buildid": "20160204060028", 07:59:07 INFO - "pgo_build": "False", 07:59:07 INFO - "basedir": "/builds/slave/test", 07:59:07 INFO - "buildnumber": 319, 07:59:07 INFO - "slavename": "t-yosemite-r7-0086", 07:59:07 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 07:59:07 INFO - "platform": "yosemite_r7", 07:59:07 INFO - "scheduler": "tests-fx-team-macosx64-talos", 07:59:07 INFO - "branch": "fx-team", 07:59:07 INFO - "repo_path": "integration/fx-team", 07:59:07 INFO - "revision": "d2522fbd0f6328c7c2b54975636d951924ec7372", 07:59:07 INFO - "stage_platform": "macosx64", 07:59:07 INFO - "builduid": "d949b2e4713f4cac85c9a352a1e2098d", 07:59:07 INFO - "slavebuilddir": "test" 07:59:07 INFO - } 07:59:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 07:59:07 INFO - Running post-action listener: _resource_record_post_action 07:59:07 INFO - ##### 07:59:07 INFO - ##### Running download-and-extract step. 07:59:07 INFO - ##### 07:59:07 INFO - Running pre-action listener: _resource_record_pre_action 07:59:07 INFO - Running main action method: download_and_extract 07:59:07 INFO - mkdir: /builds/slave/test/build/tests 07:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:07 INFO - https://queue.taskcluster.net/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:59:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/artifacts/public/build/test_packages.json 07:59:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/artifacts/public/build/test_packages.json 07:59:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:59:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:59:08 INFO - Downloaded 1277 bytes. 07:59:08 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:59:08 INFO - Using the following test package requirements: 07:59:08 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 07:59:08 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:59:08 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 07:59:08 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:59:08 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 07:59:08 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:59:08 INFO - u'jsshell-mac.zip'], 07:59:08 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:59:08 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 07:59:08 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 07:59:08 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:59:08 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 07:59:08 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:59:08 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 07:59:08 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:59:08 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 07:59:08 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 07:59:08 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:59:08 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 07:59:08 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:59: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')]} 07:59:08 INFO - https://queue.taskcluster.net/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:59:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:59:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:59:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/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 07:59:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/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 07:59:09 INFO - Downloaded 17747637 bytes. 07:59: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'] 07:59: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 07:59:12 INFO - Return code: 0 07:59:12 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 07:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:12 INFO - https://queue.taskcluster.net/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:59:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:59:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:59:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/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 07:59:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/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 07:59:13 INFO - Downloaded 17747637 bytes. 07:59:13 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'] 07:59:13 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 07:59:17 INFO - Return code: 0 07:59:17 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')]} 07:59:17 INFO - https://queue.taskcluster.net/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:59:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 07:59:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 07:59:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/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 07:59:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/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 07:59:18 INFO - Downloaded 10706582 bytes. 07:59:18 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'] 07:59:18 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 07:59:18 INFO - Return code: 0 07:59:18 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')]} 07:59:18 INFO - https://queue.taskcluster.net/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:59:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:59:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:59:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 07:59:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/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 07:59:21 INFO - Downloaded 111287872 bytes. 07:59:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:59:21 INFO - mkdir: /builds/slave/test/properties 07:59:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:59:21 INFO - Writing to file /builds/slave/test/properties/build_url 07:59:21 INFO - Contents: 07:59:21 INFO - build_url:https://queue.taskcluster.net/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:59:22 INFO - Running post-action listener: _resource_record_post_action 07:59:22 INFO - Running post-action listener: set_extra_try_arguments 07:59:22 INFO - ##### 07:59:22 INFO - ##### Running populate-webroot step. 07:59:22 INFO - ##### 07:59:22 INFO - Running pre-action listener: _resource_record_pre_action 07:59:22 INFO - Running main action method: populate_webroot 07:59:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:59:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:59:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:59:22 INFO - '--tppagecycles', 07:59:22 INFO - '7'], 07:59:22 INFO - 'tests': ['tsvgm']}}, 07:59:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:59:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:59:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:59:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:59:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:59:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:59:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:59:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:22 INFO - 'talos_options': ['--e10s'], 07:59:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:59:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:22 INFO - 'tests': ['damp', 'tps']}, 07:59:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:22 INFO - 'talos_options': ['--e10s'], 07:59:22 INFO - 'tests': ['damp', 'tps']}, 07:59:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:59:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:59:22 INFO - 'other': {'tests': ['a11yr', 07:59:22 INFO - 'ts_paint', 07:59:22 INFO - 'tpaint', 07:59:22 INFO - 'sessionrestore', 07:59:22 INFO - 'sessionrestore_no_auto_restore']}, 07:59:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:59:22 INFO - 'tests': ['a11yr', 07:59:22 INFO - 'ts_paint', 07:59:22 INFO - 'tpaint', 07:59:22 INFO - 'sessionrestore', 07:59:22 INFO - 'sessionrestore_no_auto_restore']}, 07:59:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:59:22 INFO - 'tests': ['a11yr', 07:59:22 INFO - 'ts_paint', 07:59:22 INFO - 'tpaint', 07:59:22 INFO - 'sessionrestore', 07:59:22 INFO - 'sessionrestore_no_auto_restore']}, 07:59:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:59:22 INFO - 'tests': ['a11yr', 07:59:22 INFO - 'ts_paint', 07:59:22 INFO - 'tpaint', 07:59:22 INFO - 'sessionrestore', 07:59:22 INFO - 'sessionrestore_no_auto_restore']}, 07:59:22 INFO - 'other_l64': {'tests': ['a11yr', 07:59:22 INFO - 'ts_paint', 07:59:22 INFO - 'tpaint', 07:59:22 INFO - 'sessionrestore', 07:59:22 INFO - 'sessionrestore_no_auto_restore']}, 07:59:22 INFO - 'other_nol64': {'tests': ['a11yr', 07:59:22 INFO - 'ts_paint', 07:59:22 INFO - 'tpaint', 07:59:22 INFO - 'sessionrestore', 07:59:22 INFO - 'sessionrestore_no_auto_restore']}, 07:59:22 INFO - 'svgr': {'tests': ['tsvgx', 07:59:22 INFO - 'tsvgr_opacity', 07:59:22 INFO - 'tart', 07:59:22 INFO - 'tscrollx', 07:59:22 INFO - 'cart']}, 07:59:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:59:22 INFO - 'tests': ['tsvgx', 07:59:22 INFO - 'tsvgr_opacity', 07:59:22 INFO - 'tart', 07:59:22 INFO - 'tscrollx', 07:59:22 INFO - 'cart']}, 07:59:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:22 INFO - 'tests': ['tp5o']}, 07:59:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:22 INFO - 'talos_options': ['--e10s'], 07:59:22 INFO - 'tests': ['tp5o']}, 07:59:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:22 INFO - 'talos_options': ['--xperf_path', 07:59:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:59:22 INFO - 'tests': ['tp5n']}, 07:59:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:22 INFO - 'talos_options': ['--e10s', 07:59:22 INFO - '--xperf_path', 07:59:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:59:22 INFO - 'tests': ['tp5n']}}, 07:59:22 INFO - 'talos.zip': {'path': '', 07:59:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:59:22 INFO - Running post-action listener: _resource_record_post_action 07:59:22 INFO - ##### 07:59:22 INFO - ##### Running create-virtualenv step. 07:59:22 INFO - ##### 07:59:22 INFO - Running pre-action listener: _resource_record_pre_action 07:59:22 INFO - Running main action method: create_virtualenv 07:59:22 INFO - Creating virtualenv /builds/slave/test/build/venv 07:59:22 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 07:59:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:59:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:59:22 INFO - Using real prefix '/tools/python27' 07:59:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:59:23 INFO - Installing distribute.............................................................................................................................................................................................done. 07:59:26 INFO - Installing pip.................done. 07:59:26 INFO - Return code: 0 07:59:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:59: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')]} 07:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59: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')]} 07:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:26 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 0x101b60a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe842caead0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a05d30>, '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 0x101868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019fbb20>, '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.Kk4TkAcuIl/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.qb0SM6yvgU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 07:59:26 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 07:59:26 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 07:59:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kk4TkAcuIl/Render', 07:59:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:26 INFO - 'HOME': '/Users/cltbld', 07:59:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:26 INFO - 'LOGNAME': 'cltbld', 07:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:26 INFO - 'MOZ_NO_REMOTE': '1', 07:59:26 INFO - 'NO_EM_RESTART': '1', 07:59:26 INFO - 'PAGER': '/bin/cat', 07:59:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:26 INFO - 'PWD': '/builds/slave/test', 07:59:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:26 INFO - 'SHELL': '/bin/bash', 07:59:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qb0SM6yvgU/Listeners', 07:59:26 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 07:59:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:26 INFO - 'USER': 'cltbld', 07:59:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:26 INFO - 'XPC_FLAGS': '0x0', 07:59:26 INFO - 'XPC_SERVICE_NAME': '0', 07:59:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:26 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 07:59:26 INFO - Cleaning up... 07:59:26 INFO - Return code: 0 07:59:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:59: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')]} 07:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59: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')]} 07:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:26 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 0x101b60a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe842caead0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a05d30>, '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 0x101868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019fbb20>, '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.Kk4TkAcuIl/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.qb0SM6yvgU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 07:59:26 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 07:59:26 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 07:59:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kk4TkAcuIl/Render', 07:59:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:26 INFO - 'HOME': '/Users/cltbld', 07:59:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:26 INFO - 'LOGNAME': 'cltbld', 07:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:26 INFO - 'MOZ_NO_REMOTE': '1', 07:59:26 INFO - 'NO_EM_RESTART': '1', 07:59:26 INFO - 'PAGER': '/bin/cat', 07:59:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:26 INFO - 'PWD': '/builds/slave/test', 07:59:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:26 INFO - 'SHELL': '/bin/bash', 07:59:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qb0SM6yvgU/Listeners', 07:59:26 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 07:59:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:26 INFO - 'USER': 'cltbld', 07:59:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:26 INFO - 'XPC_FLAGS': '0x0', 07:59:26 INFO - 'XPC_SERVICE_NAME': '0', 07:59:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:26 INFO - Downloading/unpacking psutil>=0.7.1 07:59:26 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 07:59:26 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 07:59:26 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 07:59:26 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 07:59:26 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 07:59:26 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 07:59:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:59:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:59:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:59:29 INFO - Installing collected packages: psutil 07:59:29 INFO - Running setup.py install for psutil 07:59:29 INFO - building 'psutil._psutil_osx' extension 07:59:29 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 07:59:30 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 07:59:30 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 07:59:30 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 07:59:30 INFO - building 'psutil._psutil_posix' extension 07:59:30 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 07:59:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:59:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:59:30 INFO - ^ 07:59:30 INFO - 1 warning generated. 07:59:30 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 07:59:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:59:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:59:30 INFO - Successfully installed psutil 07:59:30 INFO - Cleaning up... 07:59:30 INFO - Return code: 0 07:59:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:59: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')]} 07:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59: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')]} 07:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59: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', '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 0x101b60a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe842caead0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a05d30>, '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 0x101868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019fbb20>, '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.Kk4TkAcuIl/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.qb0SM6yvgU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 07:59: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:59: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 mozsystemmonitor==0.0.0 07:59:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kk4TkAcuIl/Render', 07:59:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:30 INFO - 'HOME': '/Users/cltbld', 07:59:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:30 INFO - 'LOGNAME': 'cltbld', 07:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:30 INFO - 'MOZ_NO_REMOTE': '1', 07:59:30 INFO - 'NO_EM_RESTART': '1', 07:59:30 INFO - 'PAGER': '/bin/cat', 07:59:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:30 INFO - 'PWD': '/builds/slave/test', 07:59:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:30 INFO - 'SHELL': '/bin/bash', 07:59:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qb0SM6yvgU/Listeners', 07:59:30 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 07:59:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:30 INFO - 'USER': 'cltbld', 07:59:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:30 INFO - 'XPC_FLAGS': '0x0', 07:59:30 INFO - 'XPC_SERVICE_NAME': '0', 07:59:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:59:31 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 07:59:31 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 07:59:31 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 07:59:31 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 07:59:31 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 07:59:31 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 07:59:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:59:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:59:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:59:33 INFO - Installing collected packages: mozsystemmonitor 07:59:33 INFO - Running setup.py install for mozsystemmonitor 07:59:33 INFO - Successfully installed mozsystemmonitor 07:59:33 INFO - Cleaning up... 07:59:33 INFO - Return code: 0 07:59:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:59:33 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')]} 07:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:33 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')]} 07:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:33 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 0x101b60a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe842caead0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a05d30>, '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 0x101868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019fbb20>, '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.Kk4TkAcuIl/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.qb0SM6yvgU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 07:59:33 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 07:59:33 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 07:59:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kk4TkAcuIl/Render', 07:59:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:33 INFO - 'HOME': '/Users/cltbld', 07:59:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:33 INFO - 'LOGNAME': 'cltbld', 07:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:33 INFO - 'MOZ_NO_REMOTE': '1', 07:59:33 INFO - 'NO_EM_RESTART': '1', 07:59:33 INFO - 'PAGER': '/bin/cat', 07:59:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:33 INFO - 'PWD': '/builds/slave/test', 07:59:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:33 INFO - 'SHELL': '/bin/bash', 07:59:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qb0SM6yvgU/Listeners', 07:59:33 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 07:59:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:33 INFO - 'USER': 'cltbld', 07:59:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:33 INFO - 'XPC_FLAGS': '0x0', 07:59:33 INFO - 'XPC_SERVICE_NAME': '0', 07:59:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:33 INFO - Downloading/unpacking blobuploader==1.2.4 07:59: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 07:59: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 07:59: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 07:59: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 07:59: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 07:59: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 07:59:36 INFO - Downloading blobuploader-1.2.4.tar.gz 07:59:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:59:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:59:36 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 07:59:36 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 07:59:36 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 07:59:36 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 07:59:36 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 07:59:36 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 07:59:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:59:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:59:36 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 07:59:36 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 07:59:36 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 07:59:36 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 07:59:36 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 07:59:36 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 07:59:37 INFO - Downloading docopt-0.6.1.tar.gz 07:59:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:59:37 INFO - Installing collected packages: blobuploader, requests, docopt 07:59:37 INFO - Running setup.py install for blobuploader 07:59:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:59:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:59:37 INFO - Running setup.py install for requests 07:59:37 INFO - Running setup.py install for docopt 07:59:38 INFO - Successfully installed blobuploader requests docopt 07:59:38 INFO - Cleaning up... 07:59:38 INFO - Return code: 0 07:59:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:59:38 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')]} 07:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:38 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')]} 07:59:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:38 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 0x101b60a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe842caead0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a05d30>, '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 0x101868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019fbb20>, '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.Kk4TkAcuIl/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.qb0SM6yvgU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 07:59:38 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 07:59:38 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 07:59:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kk4TkAcuIl/Render', 07:59:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:38 INFO - 'HOME': '/Users/cltbld', 07:59:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:38 INFO - 'LOGNAME': 'cltbld', 07:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:38 INFO - 'MOZ_NO_REMOTE': '1', 07:59:38 INFO - 'NO_EM_RESTART': '1', 07:59:38 INFO - 'PAGER': '/bin/cat', 07:59:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:38 INFO - 'PWD': '/builds/slave/test', 07:59:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:38 INFO - 'SHELL': '/bin/bash', 07:59:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qb0SM6yvgU/Listeners', 07:59:38 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 07:59:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:38 INFO - 'USER': 'cltbld', 07:59:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:38 INFO - 'XPC_FLAGS': '0x0', 07:59:38 INFO - 'XPC_SERVICE_NAME': '0', 07:59:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:59:38 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-rcr8QW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:59:38 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-f5rLvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:59:38 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-wHZgeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:59:38 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-TA7FB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:59:38 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-2g2IQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:59:38 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-DkGf0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:59:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-y9lMZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:59:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-C_BN_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:59:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-FxfqIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:59:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-e2K20k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:59:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-9W9eBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:59:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-XPLj_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:59:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-kMJIGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:59:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Y8AaH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-tCzYPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:59:40 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-NN4isA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:59:40 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-HYJun3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:59:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:59:40 INFO - Running setup.py install for manifestparser 07:59:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:59:40 INFO - Running setup.py install for mozcrash 07:59:40 INFO - Running setup.py install for mozdebug 07:59:40 INFO - Running setup.py install for mozdevice 07:59:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:59:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:59:40 INFO - Running setup.py install for mozfile 07:59:40 INFO - Running setup.py install for mozhttpd 07:59:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:59:41 INFO - Running setup.py install for mozinfo 07:59:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:59:41 INFO - Running setup.py install for mozInstall 07:59:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:59:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:59:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:59:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:59:41 INFO - Running setup.py install for mozleak 07:59:41 INFO - Running setup.py install for mozlog 07:59:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:59:41 INFO - Running setup.py install for moznetwork 07:59:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:59:41 INFO - Running setup.py install for mozprocess 07:59:42 INFO - Running setup.py install for mozprofile 07:59:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:59:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:59:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:59:42 INFO - Running setup.py install for mozrunner 07:59:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:59:42 INFO - Running setup.py install for mozscreenshot 07:59:42 INFO - Running setup.py install for moztest 07:59:42 INFO - Running setup.py install for mozversion 07:59:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:59:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:59:42 INFO - Cleaning up... 07:59:42 INFO - Return code: 0 07:59:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:42 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 0x101b60a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe842caead0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a05d30>, '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 0x101868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019fbb20>, '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.Kk4TkAcuIl/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.qb0SM6yvgU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 07:59:42 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 07:59:42 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 07:59:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kk4TkAcuIl/Render', 07:59:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:42 INFO - 'HOME': '/Users/cltbld', 07:59:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:42 INFO - 'LOGNAME': 'cltbld', 07:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:42 INFO - 'MOZ_NO_REMOTE': '1', 07:59:42 INFO - 'NO_EM_RESTART': '1', 07:59:42 INFO - 'PAGER': '/bin/cat', 07:59:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:42 INFO - 'PWD': '/builds/slave/test', 07:59:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:42 INFO - 'SHELL': '/bin/bash', 07:59:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qb0SM6yvgU/Listeners', 07:59:42 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 07:59:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:42 INFO - 'USER': 'cltbld', 07:59:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:42 INFO - 'XPC_FLAGS': '0x0', 07:59:42 INFO - 'XPC_SERVICE_NAME': '0', 07:59:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:59:43 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-0Gq9BT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:59:43 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)) 07:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:59:43 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-RMsges-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:59:43 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)) 07:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:59:43 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-ajB3Zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:59:43 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)) 07:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:59:43 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-d0Kkwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:59:43 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)) 07:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:59:43 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Z8qcxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:59:43 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)) 07:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:59:43 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-oU4Xyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:59:43 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)) 07:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:59:43 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-nipO20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:59:43 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)) 07:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:59:43 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-uEfJ9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:59:43 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)) 07:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:59:43 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-INPBd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:59:43 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)) 07:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:59:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-u2cMj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:59:44 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)) 07:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:59:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-zZh_cR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:59:44 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)) 07:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:59:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-A6IJcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:59:44 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)) 07:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:59:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-9P8hIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:59:44 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)) 07:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:59:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-9iZUCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:59:44 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)) 07:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-S72H8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:44 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)) 07:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:59:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-XmMSBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:59:44 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)) 07:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:59:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-ITXUf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:59:44 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)) 07:59:44 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)) 07:59:44 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)) 07:59:44 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)) 07:59:44 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)) 07:59:44 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)) 07:59:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:59: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 07:59: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 07:59: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 07:59: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 07:59: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 07:59: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 07:59:47 INFO - Downloading blessings-1.6.tar.gz 07:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:59:47 INFO - Installing collected packages: blessings 07:59:47 INFO - Running setup.py install for blessings 07:59:47 INFO - Successfully installed blessings 07:59:47 INFO - Cleaning up... 07:59:47 INFO - Return code: 0 07:59:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:59:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:59:47 INFO - Reading from file tmpfile_stdout 07:59:47 INFO - Current package versions: 07:59:47 INFO - blessings == 1.6 07:59:47 INFO - blobuploader == 1.2.4 07:59:47 INFO - docopt == 0.6.1 07:59:47 INFO - manifestparser == 1.1 07:59:47 INFO - mozInstall == 1.12 07:59:47 INFO - mozcrash == 0.16 07:59:47 INFO - mozdebug == 0.1 07:59:47 INFO - mozdevice == 0.48 07:59:47 INFO - mozfile == 1.2 07:59:47 INFO - mozhttpd == 0.7 07:59:47 INFO - mozinfo == 0.9 07:59:47 INFO - mozleak == 0.1 07:59:47 INFO - mozlog == 3.1 07:59:47 INFO - moznetwork == 0.27 07:59:47 INFO - mozprocess == 0.22 07:59:47 INFO - mozprofile == 0.28 07:59:47 INFO - mozrunner == 6.11 07:59:47 INFO - mozscreenshot == 0.1 07:59:47 INFO - mozsystemmonitor == 0.0 07:59:47 INFO - moztest == 0.7 07:59:47 INFO - mozversion == 1.4 07:59:47 INFO - psutil == 3.1.1 07:59:47 INFO - requests == 1.2.3 07:59:47 INFO - wsgiref == 0.1.2 07:59:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:59: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')]} 07:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59: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')]} 07:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:47 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 0x101b60a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe842caead0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a05d30>, '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 0x101868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019fbb20>, '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.Kk4TkAcuIl/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.qb0SM6yvgU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 07:59:47 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 07:59:47 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 07:59:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kk4TkAcuIl/Render', 07:59:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:47 INFO - 'HOME': '/Users/cltbld', 07:59:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:47 INFO - 'LOGNAME': 'cltbld', 07:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:47 INFO - 'MOZ_NO_REMOTE': '1', 07:59:47 INFO - 'NO_EM_RESTART': '1', 07:59:47 INFO - 'PAGER': '/bin/cat', 07:59:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:47 INFO - 'PWD': '/builds/slave/test', 07:59:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:47 INFO - 'SHELL': '/bin/bash', 07:59:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qb0SM6yvgU/Listeners', 07:59:47 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 07:59:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:47 INFO - 'USER': 'cltbld', 07:59:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:47 INFO - 'XPC_FLAGS': '0x0', 07:59:47 INFO - 'XPC_SERVICE_NAME': '0', 07:59:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:48 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)) 07:59:48 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)) 07:59:48 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)) 07:59:48 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)) 07:59:48 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)) 07:59:48 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)) 07:59:48 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)) 07:59:48 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)) 07:59:48 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)) 07:59:48 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)) 07:59:48 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)) 07:59:48 INFO - Cleaning up... 07:59:48 INFO - Return code: 0 07:59:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:59:48 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')]} 07:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:48 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')]} 07:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x101b60a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe842caead0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a05d30>, '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 0x101868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019fbb20>, '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.Kk4TkAcuIl/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.qb0SM6yvgU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 07:59:48 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 07:59:48 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 07:59:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kk4TkAcuIl/Render', 07:59:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:48 INFO - 'HOME': '/Users/cltbld', 07:59:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:48 INFO - 'LOGNAME': 'cltbld', 07:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:48 INFO - 'MOZ_NO_REMOTE': '1', 07:59:48 INFO - 'NO_EM_RESTART': '1', 07:59:48 INFO - 'PAGER': '/bin/cat', 07:59:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:48 INFO - 'PWD': '/builds/slave/test', 07:59:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:48 INFO - 'SHELL': '/bin/bash', 07:59:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qb0SM6yvgU/Listeners', 07:59:48 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 07:59:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:48 INFO - 'USER': 'cltbld', 07:59:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:48 INFO - 'XPC_FLAGS': '0x0', 07:59:48 INFO - 'XPC_SERVICE_NAME': '0', 07:59:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:48 INFO - Downloading/unpacking jsonschema 07:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:48 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 07:59:48 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 07:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:59:50 INFO - Downloading/unpacking functools32 (from jsonschema) 07:59: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 07:59: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 07:59: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 07:59: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 07:59: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 07:59: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 07:59:50 INFO - Downloading functools32-3.2.3-2.tar.gz 07:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:59:51 INFO - warning: no files found matching '*.txt' 07:59:51 INFO - no previously-included directories found matching 'build' 07:59:51 INFO - no previously-included directories found matching 'dist' 07:59:51 INFO - no previously-included directories found matching '.git*' 07:59:51 INFO - Installing collected packages: jsonschema, functools32 07:59:51 INFO - Running setup.py install for functools32 07:59:51 INFO - warning: no files found matching '*.txt' 07:59:51 INFO - no previously-included directories found matching 'build' 07:59:51 INFO - no previously-included directories found matching 'dist' 07:59:51 INFO - no previously-included directories found matching '.git*' 07:59:51 INFO - Successfully installed jsonschema functools32 07:59:51 INFO - Cleaning up... 07:59:51 INFO - Return code: 0 07:59:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:59:51 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')]} 07:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:51 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')]} 07:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:51 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 0x101b60a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe842caead0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a05d30>, '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 0x101868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019fbb20>, '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.Kk4TkAcuIl/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.qb0SM6yvgU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 07:59:51 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 07:59:51 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 07:59:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kk4TkAcuIl/Render', 07:59:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:51 INFO - 'HOME': '/Users/cltbld', 07:59:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:51 INFO - 'LOGNAME': 'cltbld', 07:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:51 INFO - 'MOZ_NO_REMOTE': '1', 07:59:51 INFO - 'NO_EM_RESTART': '1', 07:59:51 INFO - 'PAGER': '/bin/cat', 07:59:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:51 INFO - 'PWD': '/builds/slave/test', 07:59:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:51 INFO - 'SHELL': '/bin/bash', 07:59:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qb0SM6yvgU/Listeners', 07:59:51 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 07:59:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:51 INFO - 'USER': 'cltbld', 07:59:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:51 INFO - 'XPC_FLAGS': '0x0', 07:59:51 INFO - 'XPC_SERVICE_NAME': '0', 07:59:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:51 INFO - Downloading/unpacking flake8 07:59:51 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 07:59:51 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 07:59:51 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 07:59:51 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 07:59:51 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 07:59:51 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 07:59:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:59:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:53 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 07:59:53 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 07:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:59:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:54 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 07:59:54 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 07:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:54 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 07:59:54 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 07:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:59:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:59:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:59:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:59:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:59:55 INFO - no previously-included directories found matching 'docs/_build' 07:59:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:59:55 INFO - Running setup.py install for pep8 07:59:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:59:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:59:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:59:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:59:55 INFO - no previously-included directories found matching 'docs/_build' 07:59:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:59:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:59:55 INFO - Cleaning up... 07:59:55 INFO - Return code: 0 07:59:55 INFO - Running post-action listener: _resource_record_post_action 07:59:55 INFO - Running post-action listener: _start_resource_monitoring 07:59:55 INFO - Starting resource monitoring. 07:59:55 INFO - ##### 07:59:55 INFO - ##### Running install step. 07:59:55 INFO - ##### 07:59:55 INFO - Running pre-action listener: _resource_record_pre_action 07:59:55 INFO - Running main action method: install 07:59:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:59:55 INFO - Reading from file tmpfile_stdout 07:59:55 INFO - Detecting whether we're running mozinstall >=1.0... 07:59:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:59:55 INFO - Reading from file tmpfile_stdout 07:59:55 INFO - Output received: 07:59:55 INFO - Usage: mozinstall [options] installer 07:59:55 INFO - Options: 07:59:55 INFO - -h, --help show this help message and exit 07:59:55 INFO - -d DEST, --destination=DEST 07:59:55 INFO - Directory to install application into. [default: 07:59:55 INFO - "/builds/slave/test"] 07:59:55 INFO - --app=APP Application being installed. [default: firefox] 07:59:55 INFO - mkdir: /builds/slave/test/build/application 07:59:55 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'] 07:59:55 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 08:00:29 INFO - Reading from file tmpfile_stdout 08:00:29 INFO - Output received: 08:00:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:00:29 INFO - Running post-action listener: _resource_record_post_action 08:00:29 INFO - ##### 08:00:29 INFO - ##### Running run-tests step. 08:00:29 INFO - ##### 08:00:29 INFO - Running pre-action listener: _resource_record_pre_action 08:00:29 INFO - Running main action method: run_tests 08:00:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:00:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:00:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:00:29 INFO - 2016-02-04 08:00:29.830 screenresolution[2090:13256] starting screenresolution argv=screenresolution get 08:00:29 INFO - 2016-02-04 08:00:29.832 screenresolution[2090:13256] Display 0: 1600x1200x32@60 08:00:29 INFO - 2016-02-04 08:00:29.838 screenresolution[2091:13258] starting screenresolution argv=screenresolution list 08:00:29 INFO - Available Modes on Display 0 08:00:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:00:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:00:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:00:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:00:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:00:30 INFO - Intel Iris: 08:00:30 INFO - Chipset Model: Intel Iris 08:00:30 INFO - Type: GPU 08:00:30 INFO - Bus: Built-In 08:00:30 INFO - VRAM (Dynamic, Max): 1536 MB 08:00:30 INFO - Vendor: Intel (0x8086) 08:00:30 INFO - Device ID: 0x0a2e 08:00:30 INFO - Revision ID: 0x0009 08:00:30 INFO - Displays: 08:00:30 INFO - Display: 08:00:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:00:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:00:30 INFO - Display Serial Number: 1600x1200 60 08:00:30 INFO - Main Display: Yes 08:00:30 INFO - Mirror: Off 08:00:30 INFO - Online: Yes 08:00:30 INFO - Rotation: Supported 08:00:30 INFO - Return code: 0 08:00:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:00:30 INFO - Python 2.7.3 08:00:30 INFO - Return code: 0 08:00:30 INFO - grabbing minidump binary from tooltool 08:00: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')]} 08:00:30 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 0x101a05d30>, '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 0x101868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019fbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:00:30 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 08:00:30 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 08:00:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:00:30 INFO - Return code: 0 08:00:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:00:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:00:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:00:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:00:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:00:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:00:31 INFO - Return code: 0 08:00:31 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/U3oGXjkHSXeIXQjgZ_2trQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--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 08:00:31 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/U3oGXjkHSXeIXQjgZ_2trQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0086 --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 08:00:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kk4TkAcuIl/Render', 08:00:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:00:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:00:31 INFO - 'HOME': '/Users/cltbld', 08:00:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:00:31 INFO - 'LOGNAME': 'cltbld', 08:00:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:00:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:31 INFO - 'MOZ_NO_REMOTE': '1', 08:00:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:00:31 INFO - 'NO_EM_RESTART': '1', 08:00:31 INFO - 'PAGER': '/bin/cat', 08:00:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:31 INFO - 'PWD': '/builds/slave/test', 08:00:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:00:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:00:31 INFO - 'SHELL': '/bin/bash', 08:00:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qb0SM6yvgU/Listeners', 08:00:31 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 08:00:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:00:31 INFO - 'USER': 'cltbld', 08:00:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:00:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:31 INFO - 'XPC_FLAGS': '0x0', 08:00:31 INFO - 'XPC_SERVICE_NAME': '0', 08:00:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:00:31 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/U3oGXjkHSXeIXQjgZ_2trQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--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 08:00:31 INFO - mozversion application_buildid: 20160204060028 08:00:31 INFO - mozversion application_changeset: d2522fbd0f6328c7c2b54975636d951924ec7372 08:00:31 INFO - mozversion application_display_name: Nightly 08:00:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:00:31 INFO - mozversion application_name: Firefox 08:00:31 INFO - mozversion application_remotingname: firefox 08:00:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:00:31 INFO - mozversion application_vendor: Mozilla 08:00:31 INFO - mozversion application_version: 47.0a1 08:00:31 INFO - mozversion platform_buildid: 20160204060028 08:00:31 INFO - mozversion platform_changeset: d2522fbd0f6328c7c2b54975636d951924ec7372 08:00:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:00:31 INFO - mozversion platform_version: 47.0a1 08:00:31 INFO - using testdate: 1454601631 08:00:31 INFO - actual date: 1454601631 08:00:32 INFO - starting webserver on 'localhost:49382' 08:00:32 INFO - SUITE-START | Running 2 tests 08:00:32 INFO - TEST-START | dromaeo_css 08:00:32 INFO - operating with platform_type : mac_ 08:00:32 INFO - Initialising browser for dromaeo_css test... 08:00:32 INFO - TEST-INFO | started process 2109 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpRn7LpC/profile http://localhost:49382/getInfo.html) 08:00:32 INFO - PROCESS | 2109 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 08:00:35 INFO - PROCESS | 2109 | __metrics Screen width/height:1600/1200 08:00:35 INFO - PROCESS | 2109 | colorDepth:24 08:00:35 INFO - PROCESS | 2109 | Browser inner width/height: 1024/689 08:00:35 INFO - PROCESS | 2109 | __metrics 08:00:35 INFO - PROCESS | 2109 | 08:00:35 INFO - PROCESS | 2109 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 08:00:35 INFO - PROCESS | 2109 | 08:00:35 INFO - TEST-INFO | 2109: exit 0 08:00:35 INFO - Browser initialized. 08:00:35 INFO - Running cycle 1/1 for dromaeo_css test... 08:00:35 INFO - TEST-INFO | started process 2114 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpRn7LpC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:00:47 INFO - PROCESS | 2114 | RSS: Main: 257204224 08:00:47 INFO - PROCESS | 2114 | 08:01:37 INFO - PROCESS | 2114 | 1454601697599 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] 08:03:48 INFO - PROCESS | 2114 | Cycle 1(1): loaded http://localhost:49382/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49382/tests/dromaeo/cssquery-ext.html) 08:03:49 INFO - PROCESS | 2114 | RSS: Main: 272781312 08:03:49 INFO - PROCESS | 2114 | 08:06:51 INFO - PROCESS | 2114 | Cycle 1(1): loaded http://localhost:49382/tests/dromaeo/cssquery-ext.html (next: http://localhost:49382/tests/dromaeo/cssquery-jquery.html) 08:06:52 INFO - PROCESS | 2114 | RSS: Main: 283779072 08:06:52 INFO - PROCESS | 2114 | 08:09:54 INFO - PROCESS | 2114 | Cycle 1(1): loaded http://localhost:49382/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49382/tests/dromaeo/cssquery-mootools.html) 08:09:54 INFO - PROCESS | 2114 | RSS: Main: 285061120 08:09:54 INFO - PROCESS | 2114 | 08:12:56 INFO - PROCESS | 2114 | Cycle 1(1): loaded http://localhost:49382/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49382/tests/dromaeo/cssquery-prototype.html) 08:12:57 INFO - PROCESS | 2114 | RSS: Main: 285544448 08:12:57 INFO - PROCESS | 2114 | 08:15:59 INFO - PROCESS | 2114 | Cycle 1(1): loaded http://localhost:49382/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49382/tests/dromaeo/cssquery-yui.html) 08:16:00 INFO - PROCESS | 2114 | RSS: Main: 288010240 08:16:00 INFO - PROCESS | 2114 | 08:19:02 INFO - PROCESS | 2114 | Cycle 1(1): loaded http://localhost:49382/tests/dromaeo/cssquery-yui.html (next: http://localhost:49382/tests/dromaeo/cssquery-dojo.html) 08:19:03 INFO - PROCESS | 2114 | RSS: Main: 291819520 08:19:03 INFO - PROCESS | 2114 | 08:19:03 INFO - PROCESS | 2114 | __start_tp_report 08:19:03 INFO - PROCESS | 2114 | _x_x_mozilla_page_load 08:19:03 INFO - PROCESS | 2114 | _x_x_mozilla_page_load_details 08:19:03 INFO - PROCESS | 2114 | |i|pagename|runs| 08:19:03 INFO - PROCESS | 2114 | |0;dojo.html;3551.3962626353527;3576.409892367758;3605.296967091418;3640.490331353611;3649.2883887641906;4721.409823772028;4970.179920313144;5919.585629005961;5933.673647949367;5949.345571987078;5717.056685646874;5858.238429004234;5909.054551271797;5910.3203131639875;5910.586258961875;5235.607329450297;5288.788448462076;5296.443873393296;5340.732963351817;5356.089464790975;4666.859994200179;5323.866903327409;5325.946740532584;5331.760070796804;5408.702521361323;5363.249145119687;5398.568114550846;5403.972980135094;5408.567314614821;5413.160960051198;4661.3241080043545;5178.741062946875;5273.551748101416;5333.280007199017;5370.973145134269;5243.737813109329;5355.705436201008;5366.838994830161;5371.033214021474;5391.218273350342;4292.80682369291;4759.738214398207;5797.130430435426;5855.941440585582;5943.881122377528;6156.292026416974;6198.4731297839735;6294.716737746812;6319.178506794134;6327.14583531222;6282.277538083134;6346.619202847798;6354.3963323484195;6364.299927008025;6366.968165159191;6021.879562408727;6036.728347224385;6049.73314410218;6054.061620448793;6058.848528786772;6230.127782110508;6301.243850737941;6310.337414571496;6410.519211059189;6464.159659244268;6197.380261973766;6211.068339749074;6224.128621992924;6231.158793562901;6247.344028876993;5279.208118782213;6305.558610897285;6323.43089121972;6331.271903731038;6350.460210882126;6113;6202.72087756052;6231.594946328474;6265.530085243625;6292.307846136921;6229.3770622937345;6235.906461403082;6239;6252.874942501216;6258.217722784652;4886.560209581155;5005.3242812220615;5013.974930125326;5017.774200161001;5032.597392208614;4507.459104907367;4508.07584445188;4540.477845047862;4549.135664223787;4550.180967425895;5442.809501667422;5448.754806033738;5501;5505.119180931032;5510.421405752419;6187.226596675416;6259.780907668301;6271.749130034747;6282.811515654537;6294;5478.616496845182;5490.0941344677685;5503.752331145108;5517.69652669099;5530.5022547970075;5210.869728256748;5331.733413329318;5332.733363331818;5337.250703383726;5339.599530035185;6318.589291696025;6328.778492752732;6470.4823614110755;6471.0940468334475;6477.6437295948235;4794.952050479451;6011;6028.457438830351;6222.284437289589;6296;5730.828075157752;6277.874442511033;6363.172787537591;6483.481321494175;6487.578307410004;6232.532560057924;6305.211848518935;6317.336679648571;6333.145025421693;6360.840978975562;5285.392179899207;6250.718717657625;6267.717952692231;6284.811455656155;6286.119943207863;5084.237364395371;6166.352532983972;6174.166487524307;6223.471004964447;6284;6105.581053426346;6238.875222495434;6273.215848018997;6278.0269058296035;6288.496920246278;6075.848103797263;6120.877582448237;6123.4488895999575;6134.723937422916;6182.041783523561;4930;6139.124180917401;6222.657753823583;6223.844403889939;6251.4061164189325;6139.693015349126;6181.350958149509;6181.9690901547;6182;6202.596831205957 08:19:03 INFO - PROCESS | 2114 | |1;ext.html;448.70161342707104;456.05823973494734;475.00486480822684;508.76596765487875;525.69772380881;27772;37477.437838432445;37488.62511374885;37662.43506347403;37713.43429848555;39357.80321098398;39827.80516584507;39900;39984.60015399845;40151;9399.624015039408;9540.618375264981;9545.61817527298;9603.855942160873;9615.615375384976;9451.905480945206;9513;9574.52127393631;9710.465924374157;9751.609935602568;9664.95167524165;9685.176759975411;9788.559514821814;9790.706278811647;9796.755081122994;8332.458390204618;9615.278854085936;9616.90383096167;9684.61261549537;9704.078112579293;8245.381596380295;9515.714528564155;9647.662331818423;9657.22742180624;9672.322937394385;38611;38794.80602596969;38893.41659875104;39022.60977390246;39069.609303907164;3210.646828848825;3249.8700051997894;3250.2686895448574;3260.625028121749;3265.151060724205;27578.44843103147;27978.440431191262;28581;29010;29390.85304573485;2749.230215539652;2771.4457108578363;2830.278279038832;2854.2578929478277;2945.779066570016;359281.4071859274;360733;363587;364051;364734;53127;54118.7294063535;61165.38834611686;61355;61458.38541614527;64717.67641161764;64839;65553.01670474946;65704;65743.67128164328;15310.157941313111;15496.457623983331;15573.454929077428;15719.607009824846;15895.920520397556;11999.64001079969;12137.514499419924;12188.451519681636;12201.69495762613;12217.93891030539;15177.696446071017;18149.909250453664;18153.092345382676;18222.544436388933;18388.540286492676;6189.442950134509;7963.8407231855035;8173.060098088796;8202.343812494986;8210.178982101861;728.9635518224068;901.3195037746459;901.9503927283931;926.2775035472342;941.6092321686424;28510.42979140447;29007.129786106452;29415.558766618517;29629.555556666666;29664.2583935399;1057.577558184241;1060.3266925502362;1079.3308148947547;1087.6791346552786;1128.4696192789377;13624;14359.707626313682;14971;15079;15167.469138580096;510489;525678;534442;537804;542786;55703.721481392335;55877.88244235093;56074.158887616715;56406.717966410724;56584;1394.5258612071943;1413.837408698013;1421.2964582531506;1422.6514503946598;1537.531053028837;27902.441951160457;28088.71911280861;29010.213314802822;29061.273468163465;29226.707732922398;48153.7961550964;48439.27341089816;48772.75613621909;48868.5113148864;48954;495255.52372237906;496593;502599.4870025627;502726;503197;31662;32536.186595335304;32719.836400817843;32742.181445463102;32763.017109486755;41338.58661413468;41867.581324186365;43125.13749725051;43167.35248971205;43912.780436097615;33516.16209594682;34284.971450856516;34306.31387372289;34747.65252347444;34920.82539587286;27366.452670946866;33291.16772080717;34056.14859628529;34173;34403;33513.16217094495;34158.82920585381;34272.82863585666;34299.314013719086;34553.30893382169;31563.84218078895;31770.52344214885;31956.840215798773;32109.518357225126;32313.35373292568;24378.75621243765;24597.87701061555;24675.506489870462;24820.751792481846;24910.12814551482 08:19:03 INFO - PROCESS | 2114 | |2;jquery.html;357.1749259211222;359.52183595817564;360.94766258892463;366.1468777747848;367.8583745258075;15245.466408675698;15287.464938727147;17917.014564198962;19586.90206548967;20838.74967501951;18472.44582662519;18615;18694;18720.438386848382;18968.051597420144;5494;5812.680302583356;5812.970935145339;5816.534677225812;5834.095715164156;4125.566815484376;4310.568943105695;5405.4324295948945;6100.908486372708;6317.273513545955;6105.358937311585;6312.400321969429;6333.398327158936;6375.075614035962;6380.979043353064;6289.465395441393;6322.968385158091;6338.778142764981;6343.936560634427;6376.39424254695;5230.450802665741;5388.946110538884;5535.197396377543;5536.141898005815;5542.307211598551;15519.3016314265;23635.88182059096;23956.520869582684;24027.759722402727;24049.639255411184;1866.9066546672748;1887.7635148977442;2012.11466954541;2107.926222582202;2170.34889533141;8285.62714677841;8884.20042196199;9734.805303893952;9790.706278811647;9852.802943941153;1685.9085561603888;1700.2348942975711;1723.862091032727;1741.7561541384216;1829.698099813529;97620.51189744077;101665.4916725419;101959.4902025485;102395.48802256015;102422;9020.954895225483;10946.233763636628;11099.667009989713;11178.664640060812;11251.943740281245;13441.663958401119;13561.796573051412;13565.59303220905;13576.049676522549;13590.660233494043;8447.281981031558;8485.236328730443;8523.105073967268;8565.614547345385;8587.055423903366;8575.3997220194;8588;8592.742217733477;8681.479111253346;8688.565571721389;3541.256336169382;3790.711158206223;4417.624501917308;4446.377507149002;4548.385967894292;1549.2486144220045;1809.9185536650882;1824.8357647811495;1858.7583614130347;1860.8139186081555;382.7971175277108;778.5328802718324;978.2027647467291;1019.2050200843354;1027.6916924922493;10975.890241097646;11373.033292170257;11392.145589080852;11545.307281563133;11753.706157346134;435.9367891655692;442.03415537051643;442.4005472584666;444.5820928327362;445.3031006474921;5954.255718035246;6136.23297087864;6194.907076393858;6225.28409232935;6286.5599408041;724471;729527;735676;741027;741468;87073.5646321777;118500;119318;120628;120857;503.2074482689778;508.69732509156995;509.1598861877931;509.22089203518675;509.9949000509947;8843.46939183651;10992.955669211413;11075.224734268846;11112.333260004425;11131.554737810397;46254;46434.767826160656;47425.52574474211;48213.758931206525;48744.53766387014;65230.347696522425;66143;66420.6678966602;66537;67807.98288025783;7441.255874412515;7748.612569371621;7754.728584499516;7798.883016754639;7805.687772489036;9516.95241523788;10485.842712359474;11485.712857178638;11819.881801181878;12111.212771169845;8126.228008339198;9177.54112294396;9642.228621710106;10231.437270949871;10448.843267351147;8337.082920878578;9139.177474027369;9589.904100958902;9640;10063.295569310078;7054.506184567031;7399.223081576572;9479.526023698925;10482.004209600076;10714;7872.803179920548;10004.149647279772;10208.846867297145;10573.418461984356;11108.777824443627;7959.442839001446;10983.61557345489;10987.340759554452;11218.551257949917;11589.710257243636 08:19:03 INFO - PROCESS | 2114 | |3;mootools.html;1518.8708959738422;1532.348751780493;1756.2448147296666;1857.2570971611362;1870.5697689531416;7946.960265198681;8014.799630009253;8751.212390884819;8876.467411955287;8974.685885993991;7378.778636640896;8100.311473524743;8529.914700852989;8530;8664.306855451565;2427.8057755379527;2468.333549941515;2473.6660550825677;2483.428811373385;2484.1802205272215;2454.840435371704;2482.019602257107;2489.029278581355;2489.3029951613485;2492.6385674077246;2410.5660981023407;2438.426969662137;2477.4549599088264;2481.677381940345;2491.028498885436;2152.956940861174;2163.8268938484885;2175.6845257437585;2179.6512557990723;2181.301983365324;2486.3908342456034;2489.8879550420274;2496.2636022373263;2497.512984967932;2506.0602274147195;8610.311175105977;8775.78060548485;8848.424852384638;8850.20348168668;8870.55647217643;4164.604362585549;5446.428125046892;5454.427285135083;5513.476219759116;5537.058700021006;3714.9442758358646;3749.343864823645;3772.6981841452616;3804.144067584799;3804.8478060877533;1045.8431235314688;1074.7957888001254;1077.095239998405;1082.4749996251812;1097.4238524774478;12000.97991670709;12041.518339266506;12138.696532586757;12187.634370968797;12195.756084878341;4944.53026962438;4955.157623204064;4970.3290055842;5023.899522009539;5034.0686972910125;10129.949350253202;10275.383476991256;10429.426381549089;10462.110720588684;10474.73813154662;4959.132151873408;5284.180951952453;5430.864228394322;5434.83695489136;5486.149646804752;3750.6249375062275;4396.846110386121;4462.665300102505;4855.223164293696;4936.975315123402;3447.637998010223;3998.3402738547816;4016.7389119707127;4019.477467929209;4057.5333836609166;1320.6368248731676;1328.2628141381433;1329.415057374752;1334.786434170528;1343.3619030960215;1090.1006669497697;1090.9399983000853;1263.368315842079;1316.4602512969636;1335.1721932401972;7977.880331795028;8025.759227223192;8052.798680033046;8108.1891810819625;8259.917400826034;511.1086898382518;518.266652686452;521.3092652235803;524.7586110389187;525.6451894970879;6133.202683651186;6153.4154255345675;6249.281332646804;6253.218347706536;6284.685765711788;9120.361574689841;9455.432674039579;9500.904990950141;10280.86910439851;10932.890671093346;10236.385816851012;10473.633422830164;10682.51928663212;10729.83905241422;10755.300905441121;8183.918160818434;8263.95868020668;8295;8358.540280284642;8414.831703365899;7892.250236227549;8091.271785539329;8151;8178.914376833869;8180.713675021346;9468.763280917756;9562.187214086602;9636.42181469086;9689;9733.172680321968;9866.802663946824;10081.546330415296;10131.341462804894;10212.591496340063;10232.23258255619;6173.228346456693;6732.528722989344;7110.933359996042;7505.587192704454;7516.774496765106;8037.437379383387;8181.877271840808;8205.917940820515;8217.424780265563;8255.587220639065;7042.823929401601;7750.457467977188;7793.337566306927;7793.922060779547;7894.684212631661;7567.886481702669;7592.734254301073;7620.123685776207;7740.961295193488;7784;7772.68909243624;7807.687692492236;7837.37301015906;7936.087349954829;7972.242636949481;7035;7082.433405327459;7091.184513780981;7127.394171495481;7145.46409019336;7189.496735228484;7204.495685302189;7249.166345870292;7252.202257751748;7261.854762904818 08:19:03 INFO - PROCESS | 2114 | |4;prototype.html;321.20822173342714;327.7705606075746;328.16482053174695;335.99496007559884;337.3506000948176;6732.899006514906;6950.339717726814;6961.895571566424;6998.510104292702;7060.152781666207;6837.350451707092;6912.9654351728295;6936.341047600483;6937.098177236952;7005.194402643685;5058.11482990477;5069.315642388286;5071.137906555876;5082.16144336185;5091.1090559152;4811.254255590372;5085.66943148696;5087.135187018216;5088.949110508903;5121.436641969381;4928.581070609002;4943.23379876118;4943.431505376891;4961.5286547777905;4973.378327709036;4939.678920870132;4941.283513890484;4951;4963.751812409365;4977.278294647292;3980.243753686819;4081.3265811141127;4087.8364865405347;4192.916141677149;4193.308104162809;5351;6613.173353330833;6622.701978410983;6636.270010298863;6640.136782218329;5914.37899020601;5915.970420147914;5925.4370834770625;5935.55483338747;5946.167536544887;5860.501857342131;7049.4712896532965;7319.963400182965;7418.517796343221;7432.070991126109;4713.505081966413;4714.740689262089;4717.198076327033;4723.354921244114;4724.149653062447;7777.455578109534;7798.298153166243;7816.257455541714;7841.882371764371;7847.646855891441;3748.4189950557707;4195.223883581547;4773.809047638125;4773.9761301193275;4788.712677239377;4875.219964805685;4880;4883;4895.7062576245535;4904.141775189328;4829.27560865873;5871.532116970758;5904.9704751475965;5906.143609176645;5911.615744976562;7267.091613548307;7458.738944137038;7471.626418679044;7488.176300606929;7511.32398084175;1652.6281586642908;1698.4395149600603;1699.4137022727139;1706.6330738891197;1707.282941164689;1056.8044911691209;1066.1630619963291;1070.2347821307646;1070.8500809886623;1085.8588383510094;6485.383888530677;6490.383413575702;6515.120458738104;6528.543001989815;6543.509236807258;7573.6213189340315;7581.3934885209055;7588.62056897153;7608.391328693802;7628.923710762932;6249.468795152463;6485.092087107809;6491.123698300763;6492.415682588496;6539.411452969255;3914.080191155076;3956.723029387973;4005.499312585927;4023.255697695877;4049.9392509112386;6981.3367730065565;7706.730264440717;8112.22933821286;8118.309943654737;8131.105578386373;7832.216778322236;7986.960065199637;8032.277095061472;8038.115807261197;8039.15588863161;8045.919540804634;8059.959700201696;8089.02931648206;8112.675492980333;8182.263596276363;7650.896003598832;7653;7654.502457340255;7663.616819159131;7694.115176754521;7302.379297759538;7615.276548727862;7632.3512501438;7653.961730191313;7669.5398276103615;8084.87872681922;8090.919090809017;8091.94804675412;8092.959535202286;8104.554249516334;4013.698972577127;4806.639502037291;4809.567138957371;4817.397825271841;4821.831235906727;7437.48877491967;7713.344365728752;7714.691412343668;7725.884111738441;7774.883376749466;7451.143118541437;7455.6644950978425;7455.92544074574;7460.403167746459;7476.626168691652;7208.747693830691;7337.156227033959;7435.405167586689;7441.776746697607;7487.625618718933;5906.438888305604;7220.38626716735;7227.602481863548;7282.563046217244;7319.59742214162;6773.679132569102;6928.237893831775;7447.92552074494;7450.739224127129;7458.962705186656;7116.893246601202;7278.96360518194;7282.963585182252;7291.52605080668;7342 08:19:03 INFO - PROCESS | 2114 | |5;yui.html;609.625080575446;657.8519833037567;670.4368330602293;709.1277728394075;718.9604571748558;14776.704465910689;15175.392984280643;15251.161186134772;17452.476425707217;17661.91169044156;16070.357185712557;16121.99999999997;16164.353425862952;16223.756643650355;16240.593985150377;684.2609981220295;696.2619623199399;844.476424616737;850.2602735620019;852.288339236738;848.3128665780706;857.9613917373701;858.9312854971587;859.3511898516612;861.1259571534897;883.8762573239752;891.9509426981514;892.8839250897374;895.4358753985013;898.7213963671282;882.9867551986725;883.3639779358883;886.6852267445094;890.9821803563925;892.7143314139478;655.446148004935;658.5324419662046;662.8276648071488;663.0650782396798;667.2793383146239;15307.617309567238;15425.537233883002;15470;15493;15572;10425.79148417035;12593.685157871036;12697;12879.549215777402;12916.87083129166;10094.646687365981;10117.595296188143;10257.583747052555;10365.01532354425;10376.94811525945;3459.394605943975;3505.964940350589;3508.5438892944007;3510.385682505577;3523.9780463665506;83914.321713566;84669.57665211635;86548;86565.26869462576;86630.56684716599;9337.159655631025;9364.157225849705;9391.859122113174;9480.431174129575;9510.524473776284;20222.393328200178;20474.488137796674;20577;20628.896855515926;20649;7437.776866694008;7438.776836694908;7636.618169091523;7659.731909383145;7677.424193185533;4001.099752555652;4111.342185250345;4113.650339721157;4116.897077573085;4123.587641235852;3001.504751715986;3561.4123669594746;3567.571891373052;3582.265635544707;3598.838052287653;636.5353292096795;644.2333622988722;645.4481418387305;669.6417416682149;670.765232168737;535.8981793459308;549.9587530935116;555.1727925391139;565.3357305166413;621.7388696747377;6769.086173366631;8600.268977136888;8680;8754.69358572447;8891.066438023914;491.7836152093068;536.6431323170126;546.9781208751606;600.2047287344286;606.0273261415452;3712.350338690718;3830.4637350770913;3928.705347098979;3984.8007599620482;4000.57993910641;74412.88380674295;76870.46259074788;94152.17543473707;97562;98348;80267.19732802713;80840;81151.3769724614;81761.77357339645;81930;62377;63460;64043;68401.31598684049;68454.28864278333;8583.227509524173;8705.129487051245;8807.691730789391;8830.602622882114;8831.116888311117;47632;47814.760926195144;48092;50368.74815625898;50433;65170;66458;66886;67441.65116697736;70615.64692176506;10728.517216725422;10808.405537695502;10821.296615719953;11115;11455.541778328774;10186.490675466346;11902.226355286879;11988.700282493008;12292.201006934522;12629.052821038274;11011.229213954946;11166.776664466828;11476.87409869131;11542.422878855856;12164.452599633214;11170.664880053611;11324.547018119183;11359.943200284277;11735.41322933867;12330.568430105262;10853.565857365616;11424;11443.713907152387;11445.141614379121;12031.27812331263;9176.816463670822;9287.907120928705;9344.252459803336;9514.345056495871;9598.95200523993;8256.587170641324;9137.269018478373;9161.450312981242;9523.619055237712;9951.850722239316 08:19:03 INFO - PROCESS | 2114 | __end_tp_report 08:19:03 INFO - PROCESS | 2114 | __start_cc_report 08:19:03 INFO - PROCESS | 2114 | _x_x_mozilla_cycle_collect,392 08:19:03 INFO - PROCESS | 2114 | __end_cc_report 08:19:03 INFO - PROCESS | 2114 | __startTimestamp1454602743031__endTimestamp 08:19:03 INFO - PROCESS | 2114 | 08:19:03 INFO - PROCESS | 2114 | ------- Summary: start ------- 08:19:03 INFO - PROCESS | 2114 | Number of tests: 6 08:19:03 INFO - PROCESS | 2114 | 08:19:03 INFO - PROCESS | 2114 | [#0] dojo.html Cycles:165 Average:5757.77 Median:6058.85 stddev:662.90 (10.9%) stddev-sans-first:641.93 08:19:03 INFO - PROCESS | 2114 | Values: 3551.4 3576.4 3605.3 3640.5 3649.3 4721.4 4970.2 5919.6 5933.7 5949.3 5717.1 5858.2 5909.1 5910.3 5910.6 5235.6 5288.8 5296.4 5340.7 5356.1 4666.9 5323.9 5325.9 5331.8 5408.7 5363.2 5398.6 5404.0 5408.6 5413.2 4661.3 5178.7 5273.6 5333.3 5371.0 5243.7 5355.7 5366.8 5371.0 5391.2 4292.8 4759.7 5797.1 5855.9 5943.9 6156.3 6198.5 6294.7 6319.2 6327.1 6282.3 6346.6 6354.4 6364.3 6367.0 6021.9 6036.7 6049.7 6054.1 6058.8 6230.1 6301.2 6310.3 6410.5 6464.2 6197.4 6211.1 6224.1 6231.2 6247.3 5279.2 6305.6 6323.4 6331.3 6350.5 6113.0 6202.7 6231.6 6265.5 6292.3 6229.4 6235.9 6239.0 6252.9 6258.2 4886.6 5005.3 5014.0 5017.8 5032.6 4507.5 4508.1 4540.5 4549.1 4550.2 5442.8 5448.8 5501.0 5505.1 5510.4 6187.2 6259.8 6271.7 6282.8 6294.0 5478.6 5490.1 5503.8 5517.7 5530.5 5210.9 5331.7 5332.7 5337.3 5339.6 6318.6 6328.8 6470.5 6471.1 6477.6 4795.0 6011.0 6028.5 6222.3 6296.0 5730.8 6277.9 6363.2 6483.5 6487.6 6232.5 6305.2 6317.3 6333.1 6360.8 5285.4 6250.7 6267.7 6284.8 6286.1 5084.2 6166.4 6174.2 6223.5 6284.0 6105.6 6238.9 6273.2 6278.0 6288.5 6075.8 6120.9 6123.4 6134.7 6182.0 4930.0 6139.1 6222.7 6223.8 6251.4 6139.7 6181.4 6182.0 6182.0 6202.6 08:19:03 INFO - PROCESS | 2114 | 08:19:03 INFO - PROCESS | 2114 | [#1] ext.html Cycles:180 Average:60560.29 Median:201105.72 stddev:125089.68 (62.2%) stddev-sans-first:125359.17 08:19:03 INFO - PROCESS | 2114 | Values: 448.7 456.1 475.0 508.8 525.7 27772.0 37477.4 37488.6 37662.4 37713.4 39357.8 39827.8 39900.0 39984.6 40151.0 9399.6 9540.6 9545.6 9603.9 9615.6 9451.9 9513.0 9574.5 9710.5 9751.6 9665.0 9685.2 9788.6 9790.7 9796.8 8332.5 9615.3 9616.9 9684.6 9704.1 8245.4 9515.7 9647.7 9657.2 9672.3 38611.0 38794.8 38893.4 39022.6 39069.6 3210.6 3249.9 3250.3 3260.6 3265.2 27578.4 27978.4 28581.0 29010.0 29390.9 2749.2 2771.4 2830.3 2854.3 2945.8 359281.4 360733.0 363587.0 364051.0 364734.0 53127.0 54118.7 61165.4 61355.0 61458.4 64717.7 64839.0 65553.0 65704.0 65743.7 15310.2 15496.5 15573.5 15719.6 15895.9 11999.6 12137.5 12188.5 12201.7 12217.9 15177.7 18149.9 18153.1 18222.5 18388.5 6189.4 7963.8 8173.1 8202.3 8210.2 729.0 901.3 902.0 926.3 941.6 28510.4 29007.1 29415.6 29629.6 29664.3 1057.6 1060.3 1079.3 1087.7 1128.5 13624.0 14359.7 14971.0 15079.0 15167.5 510489.0 525678.0 534442.0 537804.0 542786.0 55703.7 55877.9 56074.2 56406.7 56584.0 1394.5 1413.8 1421.3 1422.7 1537.5 27902.4 28088.7 29010.2 29061.3 29226.7 48153.8 48439.3 48772.8 48868.5 48954.0 495255.5 496593.0 502599.5 502726.0 503197.0 31662.0 32536.2 32719.8 32742.2 32763.0 41338.6 41867.6 43125.1 43167.4 43912.8 33516.2 34285.0 34306.3 34747.7 34920.8 27366.5 33291.2 34056.1 34173.0 34403.0 33513.2 34158.8 34272.8 34299.3 34553.3 31563.8 31770.5 31956.8 32109.5 32313.4 24378.8 24597.9 24675.5 24820.8 24910.1 08:19:03 INFO - PROCESS | 2114 | 08:19:03 INFO - PROCESS | 2114 | [#2] jquery.html Cycles:180 Average:36346.83 Median:2445.84 stddev:121056.95 (4949.5%) stddev-sans-first:121366.38 08:19:03 INFO - PROCESS | 2114 | Values: 357.2 359.5 360.9 366.1 367.9 15245.5 15287.5 17917.0 19586.9 20838.7 18472.4 18615.0 18694.0 18720.4 18968.1 5494.0 5812.7 5813.0 5816.5 5834.1 4125.6 4310.6 5405.4 6100.9 6317.3 6105.4 6312.4 6333.4 6375.1 6381.0 6289.5 6323.0 6338.8 6343.9 6376.4 5230.5 5388.9 5535.2 5536.1 5542.3 15519.3 23635.9 23956.5 24027.8 24049.6 1866.9 1887.8 2012.1 2107.9 2170.3 8285.6 8884.2 9734.8 9790.7 9852.8 1685.9 1700.2 1723.9 1741.8 1829.7 97620.5 101665.5 101959.5 102395.5 102422.0 9021.0 10946.2 11099.7 11178.7 11251.9 13441.7 13561.8 13565.6 13576.0 13590.7 8447.3 8485.2 8523.1 8565.6 8587.1 8575.4 8588.0 8592.7 8681.5 8688.6 3541.3 3790.7 4417.6 4446.4 4548.4 1549.2 1809.9 1824.8 1858.8 1860.8 382.8 778.5 978.2 1019.2 1027.7 10975.9 11373.0 11392.1 11545.3 11753.7 435.9 442.0 442.4 444.6 445.3 5954.3 6136.2 6194.9 6225.3 6286.6 724471.0 729527.0 735676.0 741027.0 741468.0 87073.6 118500.0 119318.0 120628.0 120857.0 503.2 508.7 509.2 509.2 510.0 8843.5 10993.0 11075.2 11112.3 11131.6 46254.0 46434.8 47425.5 48213.8 48744.5 65230.3 66143.0 66420.7 66537.0 67808.0 7441.3 7748.6 7754.7 7798.9 7805.7 9517.0 10485.8 11485.7 11819.9 12111.2 8126.2 9177.5 9642.2 10231.4 10448.8 8337.1 9139.2 9589.9 9640.0 10063.3 7054.5 7399.2 9479.5 10482.0 10714.0 7872.8 10004.1 10208.8 10573.4 11108.8 7959.4 10983.6 10987.3 11218.6 11589.7 08:19:03 INFO - PROCESS | 2114 | 08:19:03 INFO - PROCESS | 2114 | [#3] mootools.html Cycles:180 Average:6032.78 Median:523.03 stddev:3215.44 (614.8%) stddev-sans-first:3206.56 08:19:03 INFO - PROCESS | 2114 | Values: 1518.9 1532.3 1756.2 1857.3 1870.6 7947.0 8014.8 8751.2 8876.5 8974.7 7378.8 8100.3 8529.9 8530.0 8664.3 2427.8 2468.3 2473.7 2483.4 2484.2 2454.8 2482.0 2489.0 2489.3 2492.6 2410.6 2438.4 2477.5 2481.7 2491.0 2153.0 2163.8 2175.7 2179.7 2181.3 2486.4 2489.9 2496.3 2497.5 2506.1 8610.3 8775.8 8848.4 8850.2 8870.6 4164.6 5446.4 5454.4 5513.5 5537.1 3714.9 3749.3 3772.7 3804.1 3804.8 1045.8 1074.8 1077.1 1082.5 1097.4 12001.0 12041.5 12138.7 12187.6 12195.8 4944.5 4955.2 4970.3 5023.9 5034.1 10129.9 10275.4 10429.4 10462.1 10474.7 4959.1 5284.2 5430.9 5434.8 5486.1 3750.6 4396.8 4462.7 4855.2 4937.0 3447.6 3998.3 4016.7 4019.5 4057.5 1320.6 1328.3 1329.4 1334.8 1343.4 1090.1 1090.9 1263.4 1316.5 1335.2 7977.9 8025.8 8052.8 8108.2 8259.9 511.1 518.3 521.3 524.8 525.6 6133.2 6153.4 6249.3 6253.2 6284.7 9120.4 9455.4 9500.9 10280.9 10932.9 10236.4 10473.6 10682.5 10729.8 10755.3 8183.9 8264.0 8295.0 8358.5 8414.8 7892.3 8091.3 8151.0 8178.9 8180.7 9468.8 9562.2 9636.4 9689.0 9733.2 9866.8 10081.5 10131.3 10212.6 10232.2 6173.2 6732.5 7110.9 7505.6 7516.8 8037.4 8181.9 8205.9 8217.4 8255.6 7042.8 7750.5 7793.3 7793.9 7894.7 7567.9 7592.7 7620.1 7741.0 7784.0 7772.7 7807.7 7837.4 7936.1 7972.2 7035.0 7082.4 7091.2 7127.4 7145.5 7189.5 7204.5 7249.2 7252.2 7261.9 08:19:03 INFO - PROCESS | 2114 | 08:19:03 INFO - PROCESS | 2114 | [#4] prototype.html Cycles:180 Average:5994.81 Median:6638.20 stddev:1970.38 (29.7%) stddev-sans-first:1929.34 08:19:03 INFO - PROCESS | 2114 | Values: 321.2 327.8 328.2 336.0 337.4 6732.9 6950.3 6961.9 6998.5 7060.2 6837.4 6913.0 6936.3 6937.1 7005.2 5058.1 5069.3 5071.1 5082.2 5091.1 4811.3 5085.7 5087.1 5088.9 5121.4 4928.6 4943.2 4943.4 4961.5 4973.4 4939.7 4941.3 4951.0 4963.8 4977.3 3980.2 4081.3 4087.8 4192.9 4193.3 5351.0 6613.2 6622.7 6636.3 6640.1 5914.4 5916.0 5925.4 5935.6 5946.2 5860.5 7049.5 7320.0 7418.5 7432.1 4713.5 4714.7 4717.2 4723.4 4724.1 7777.5 7798.3 7816.3 7841.9 7847.6 3748.4 4195.2 4773.8 4774.0 4788.7 4875.2 4880.0 4883.0 4895.7 4904.1 4829.3 5871.5 5905.0 5906.1 5911.6 7267.1 7458.7 7471.6 7488.2 7511.3 1652.6 1698.4 1699.4 1706.6 1707.3 1056.8 1066.2 1070.2 1070.9 1085.9 6485.4 6490.4 6515.1 6528.5 6543.5 7573.6 7581.4 7588.6 7608.4 7628.9 6249.5 6485.1 6491.1 6492.4 6539.4 3914.1 3956.7 4005.5 4023.3 4049.9 6981.3 7706.7 8112.2 8118.3 8131.1 7832.2 7987.0 8032.3 8038.1 8039.2 8045.9 8060.0 8089.0 8112.7 8182.3 7650.9 7653.0 7654.5 7663.6 7694.1 7302.4 7615.3 7632.4 7654.0 7669.5 8084.9 8090.9 8091.9 8093.0 8104.6 4013.7 4806.6 4809.6 4817.4 4821.8 7437.5 7713.3 7714.7 7725.9 7774.9 7451.1 7455.7 7455.9 7460.4 7476.6 7208.7 7337.2 7435.4 7441.8 7487.6 5906.4 7220.4 7227.6 7282.6 7319.6 6773.7 6928.2 7447.9 7450.7 7459.0 7116.9 7279.0 7283.0 7291.5 7342.0 08:19:03 INFO - PROCESS | 2114 | 08:19:03 INFO - PROCESS | 2114 | [#5] yui.html Cycles:180 Average:18300.60 Median:31499.37 stddev:25674.72 (81.5%) stddev-sans-first:25712.38 08:19:03 INFO - PROCESS | 2114 | Values: 609.6 657.9 670.4 709.1 719.0 14776.7 15175.4 15251.2 17452.5 17661.9 16070.4 16122.0 16164.4 16223.8 16240.6 684.3 696.3 844.5 850.3 852.3 848.3 858.0 858.9 859.4 861.1 883.9 892.0 892.9 895.4 898.7 883.0 883.4 886.7 891.0 892.7 655.4 658.5 662.8 663.1 667.3 15307.6 15425.5 15470.0 15493.0 15572.0 10425.8 12593.7 12697.0 12879.5 12916.9 10094.6 10117.6 10257.6 10365.0 10376.9 3459.4 3506.0 3508.5 3510.4 3524.0 83914.3 84669.6 86548.0 86565.3 86630.6 9337.2 9364.2 9391.9 9480.4 9510.5 20222.4 20474.5 20577.0 20628.9 20649.0 7437.8 7438.8 7636.6 7659.7 7677.4 4001.1 4111.3 4113.7 4116.9 4123.6 3001.5 3561.4 3567.6 3582.3 3598.8 636.5 644.2 645.4 669.6 670.8 535.9 550.0 555.2 565.3 621.7 6769.1 8600.3 8680.0 8754.7 8891.1 491.8 536.6 547.0 600.2 606.0 3712.4 3830.5 3928.7 3984.8 4000.6 74412.9 76870.5 94152.2 97562.0 98348.0 80267.2 80840.0 81151.4 81761.8 81930.0 62377.0 63460.0 64043.0 68401.3 68454.3 8583.2 8705.1 8807.7 8830.6 8831.1 47632.0 47814.8 48092.0 50368.7 50433.0 65170.0 66458.0 66886.0 67441.7 70615.6 10728.5 10808.4 10821.3 11115.0 11455.5 10186.5 11902.2 11988.7 12292.2 12629.1 11011.2 11166.8 11476.9 11542.4 12164.5 11170.7 11324.5 11359.9 11735.4 12330.6 10853.6 11424.0 11443.7 11445.1 12031.3 9176.8 9287.9 9344.3 9514.3 9599.0 8256.6 9137.3 9161.5 9523.6 9951.9 08:19:03 INFO - PROCESS | 2114 | -------- Summary: end -------- 08:19:03 INFO - PROCESS | 2114 | 08:19:03 INFO - TEST-INFO | 2114: exit 0 08:19:03 INFO - TEST-OK | dromaeo_css | took 1111415ms 08:19:03 INFO - TEST-START | kraken 08:19:03 INFO - operating with platform_type : mac_ 08:19:03 INFO - Initialising browser for kraken test... 08:19:03 INFO - TEST-INFO | started process 2121 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpqCsAdS/profile http://localhost:49382/getInfo.html) 08:19:03 INFO - PROCESS | 2121 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 08:19:06 INFO - PROCESS | 2121 | __metrics Screen width/height:1600/1200 08:19:06 INFO - PROCESS | 2121 | colorDepth:24 08:19:06 INFO - PROCESS | 2121 | Browser inner width/height: 1024/689 08:19:06 INFO - PROCESS | 2121 | __metrics 08:19:06 INFO - PROCESS | 2121 | 08:19:06 INFO - PROCESS | 2121 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 08:19:06 INFO - PROCESS | 2121 | 08:19:07 INFO - TEST-INFO | 2121: exit 0 08:19:07 INFO - Browser initialized. 08:19:07 INFO - Running cycle 1/1 for kraken test... 08:19:07 INFO - TEST-INFO | started process 2124 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpqCsAdS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:19:19 INFO - PROCESS | 2124 | RSS: Main: 258179072 08:19:19 INFO - PROCESS | 2124 | 08:19:22 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49382/tests/kraken/driver.html?testName=audio-beat-detection) 08:19:22 INFO - PROCESS | 2124 | RSS: Main: 270450688 08:19:22 INFO - PROCESS | 2124 | 08:19:25 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49382/tests/kraken/driver.html?testName=audio-dft) 08:19:25 INFO - PROCESS | 2124 | RSS: Main: 279273472 08:19:25 INFO - PROCESS | 2124 | 08:19:29 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49382/tests/kraken/driver.html?testName=audio-fft) 08:19:29 INFO - PROCESS | 2124 | RSS: Main: 281538560 08:19:29 INFO - PROCESS | 2124 | 08:19:31 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49382/tests/kraken/driver.html?testName=audio-oscillator) 08:19:32 INFO - PROCESS | 2124 | RSS: Main: 283463680 08:19:32 INFO - PROCESS | 2124 | 08:19:34 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49382/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:19:35 INFO - PROCESS | 2124 | RSS: Main: 284160000 08:19:35 INFO - PROCESS | 2124 | 08:19:37 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49382/tests/kraken/driver.html?testName=imaging-darkroom) 08:19:38 INFO - PROCESS | 2124 | RSS: Main: 285814784 08:19:38 INFO - PROCESS | 2124 | 08:19:41 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49382/tests/kraken/driver.html?testName=imaging-desaturate) 08:19:42 INFO - PROCESS | 2124 | RSS: Main: 285581312 08:19:42 INFO - PROCESS | 2124 | 08:19:45 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49382/tests/kraken/driver.html?testName=json-parse-financial) 08:19:45 INFO - PROCESS | 2124 | RSS: Main: 286003200 08:19:45 INFO - PROCESS | 2124 | 08:19:47 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49382/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:19:47 INFO - PROCESS | 2124 | RSS: Main: 285163520 08:19:47 INFO - PROCESS | 2124 | 08:19:49 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49382/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:19:50 INFO - PROCESS | 2124 | RSS: Main: 284135424 08:19:50 INFO - PROCESS | 2124 | 08:19:52 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49382/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:19:52 INFO - PROCESS | 2124 | RSS: Main: 285032448 08:19:52 INFO - PROCESS | 2124 | 08:19:55 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49382/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:19:56 INFO - PROCESS | 2124 | RSS: Main: 284712960 08:19:56 INFO - PROCESS | 2124 | 08:19:58 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49382/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:19:59 INFO - PROCESS | 2124 | RSS: Main: 286810112 08:19:59 INFO - PROCESS | 2124 | 08:20:00 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49382/tests/kraken/driver.html?testName=ai-astar) 08:20:01 INFO - PROCESS | 2124 | RSS: Main: 287031296 08:20:01 INFO - PROCESS | 2124 | 08:20:01 INFO - PROCESS | 2124 | __start_tp_report 08:20:01 INFO - PROCESS | 2124 | _x_x_mozilla_page_load 08:20:01 INFO - PROCESS | 2124 | _x_x_mozilla_page_load_details 08:20:01 INFO - PROCESS | 2124 | |i|pagename|runs| 08:20:01 INFO - PROCESS | 2124 | |0;ai-astar;116;112;115;135;168;170;113;113;134;157 08:20:01 INFO - PROCESS | 2124 | |1;audio-beat-detection;153;124;160;185;123;139;146;122;156;125 08:20:01 INFO - PROCESS | 2124 | |2;audio-dft;192;195;198;212;247;269;269;226;202;202 08:20:01 INFO - PROCESS | 2124 | |3;audio-fft;76;74;66;112;48;56;64;89;131;61 08:20:01 INFO - PROCESS | 2124 | |4;audio-oscillator;80;82;122;81;82;84;132;85;87;121 08:20:01 INFO - PROCESS | 2124 | |5;imaging-gaussian-blur;87;93;86;93;88;111;110;94;87;92 08:20:01 INFO - PROCESS | 2124 | |6;imaging-darkroom;116;96;95;96;127;101;106;149;151;105 08:20:01 INFO - PROCESS | 2124 | |7;imaging-desaturate;91;96;90;92;96;92;92;91;93;91 08:20:01 INFO - PROCESS | 2124 | |8;json-parse-financial;56;57;54;55;55;57;56;64;52;62 08:20:01 INFO - PROCESS | 2124 | |9;json-stringify-tinderbox;62;74;89;107;64;67;66;67;66;66 08:20:01 INFO - PROCESS | 2124 | |10;stanford-crypto-aes;85;85;83;86;85;87;86;87;122;73 08:20:01 INFO - PROCESS | 2124 | |11;stanford-crypto-ccm;141;128;128;132;135;125;124;128;123;130 08:20:01 INFO - PROCESS | 2124 | |12;stanford-crypto-pbkdf2;182;168;140;143;141;147;142;142;142;141 08:20:01 INFO - PROCESS | 2124 | |13;stanford-crypto-sha256-iterative;67;70;67;67;69;67;67;69;69;68 08:20:01 INFO - PROCESS | 2124 | __end_tp_report 08:20:01 INFO - PROCESS | 2124 | __start_cc_report 08:20:01 INFO - PROCESS | 2124 | _x_x_mozilla_cycle_collect,937 08:20:01 INFO - PROCESS | 2124 | __end_cc_report 08:20:01 INFO - PROCESS | 2124 | __startTimestamp1454602801243__endTimestamp 08:20:01 INFO - PROCESS | 2124 | 08:20:01 INFO - PROCESS | 2124 | ------- Summary: start ------- 08:20:01 INFO - PROCESS | 2124 | Number of tests: 14 08:20:01 INFO - PROCESS | 2124 | 08:20:01 INFO - PROCESS | 2124 | [#0] ai-astar Cycles:10 Average:133.30 Median:134.50 stddev:23.64 (17.6%) stddev-sans-first:24.23 08:20:01 INFO - PROCESS | 2124 | Values: 116.0 112.0 115.0 135.0 168.0 170.0 113.0 113.0 134.0 157.0 08:20:01 INFO - PROCESS | 2124 | 08:20:01 INFO - PROCESS | 2124 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:149.50 stddev:20.74 (13.9%) stddev-sans-first:21.70 08:20:01 INFO - PROCESS | 2124 | Values: 153.0 124.0 160.0 185.0 123.0 139.0 146.0 122.0 156.0 125.0 08:20:01 INFO - PROCESS | 2124 | 08:20:01 INFO - PROCESS | 2124 | [#2] audio-dft Cycles:10 Average:221.20 Median:219.00 stddev:30.11 (13.7%) stddev-sans-first:30.02 08:20:01 INFO - PROCESS | 2124 | Values: 192.0 195.0 198.0 212.0 247.0 269.0 269.0 226.0 202.0 202.0 08:20:01 INFO - PROCESS | 2124 | 08:20:01 INFO - PROCESS | 2124 | [#3] audio-fft Cycles:10 Average:77.70 Median:65.00 stddev:26.07 (40.1%) stddev-sans-first:27.65 08:20:01 INFO - PROCESS | 2124 | Values: 76.0 74.0 66.0 112.0 48.0 56.0 64.0 89.0 131.0 61.0 08:20:01 INFO - PROCESS | 2124 | 08:20:01 INFO - PROCESS | 2124 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:82.00 stddev:20.59 (25.1%) stddev-sans-first:21.05 08:20:01 INFO - PROCESS | 2124 | Values: 80.0 82.0 122.0 81.0 82.0 84.0 132.0 85.0 87.0 121.0 08:20:01 INFO - PROCESS | 2124 | 08:20:01 INFO - PROCESS | 2124 | [#5] imaging-gaussian-blur Cycles:10 Average:94.10 Median:90.00 stddev:9.12 (10.1%) stddev-sans-first:9.31 08:20:01 INFO - PROCESS | 2124 | Values: 87.0 93.0 86.0 93.0 88.0 111.0 110.0 94.0 87.0 92.0 08:20:01 INFO - PROCESS | 2124 | 08:20:01 INFO - PROCESS | 2124 | [#6] imaging-darkroom Cycles:10 Average:114.20 Median:150.00 stddev:21.32 (14.2%) stddev-sans-first:22.60 08:20:01 INFO - PROCESS | 2124 | Values: 116.0 96.0 95.0 96.0 127.0 101.0 106.0 149.0 151.0 105.0 08:20:01 INFO - PROCESS | 2124 | 08:20:01 INFO - PROCESS | 2124 | [#7] imaging-desaturate Cycles:10 Average:92.40 Median:92.00 stddev:2.07 (2.2%) stddev-sans-first:2.13 08:20:01 INFO - PROCESS | 2124 | Values: 91.0 96.0 90.0 92.0 96.0 92.0 92.0 91.0 93.0 91.0 08:20:01 INFO - PROCESS | 2124 | 08:20:01 INFO - PROCESS | 2124 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.50 stddev:3.61 (6.4%) stddev-sans-first:3.82 08:20:01 INFO - PROCESS | 2124 | Values: 56.0 57.0 54.0 55.0 55.0 57.0 56.0 64.0 52.0 62.0 08:20:01 INFO - PROCESS | 2124 | 08:20:01 INFO - PROCESS | 2124 | [#9] json-stringify-tinderbox Cycles:10 Average:72.80 Median:66.50 stddev:14.27 (21.5%) stddev-sans-first:14.59 08:20:01 INFO - PROCESS | 2124 | Values: 62.0 74.0 89.0 107.0 64.0 67.0 66.0 67.0 66.0 66.0 08:20:01 INFO - PROCESS | 2124 | 08:20:01 INFO - PROCESS | 2124 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:85.50 stddev:12.66 (14.8%) stddev-sans-first:13.39 08:20:01 INFO - PROCESS | 2124 | Values: 85.0 85.0 83.0 86.0 85.0 87.0 86.0 87.0 122.0 73.0 08:20:01 INFO - PROCESS | 2124 | 08:20:01 INFO - PROCESS | 2124 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:129.00 stddev:5.46 (4.2%) stddev-sans-first:3.86 08:20:01 INFO - PROCESS | 2124 | Values: 141.0 128.0 128.0 132.0 135.0 125.0 124.0 128.0 123.0 130.0 08:20:01 INFO - PROCESS | 2124 | 08:20:01 INFO - PROCESS | 2124 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.80 Median:142.50 stddev:14.32 (10.0%) stddev-sans-first:8.81 08:20:01 INFO - PROCESS | 2124 | Values: 182.0 168.0 140.0 143.0 141.0 147.0 142.0 142.0 142.0 141.0 08:20:01 INFO - PROCESS | 2124 | 08:20:01 INFO - PROCESS | 2124 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:1.15 (1.7%) stddev-sans-first:1.17 08:20:01 INFO - PROCESS | 2124 | Values: 67.0 70.0 67.0 67.0 69.0 67.0 67.0 69.0 69.0 68.0 08:20:01 INFO - PROCESS | 2124 | -------- Summary: end -------- 08:20:01 INFO - PROCESS | 2124 | 08:20:02 INFO - TEST-INFO | 2124: exit 0 08:20:02 INFO - TEST-OK | kraken | took 58667ms 08:20:02 INFO - SUITE-END | took 1170s 08:20:02 INFO - Completed test suite (00:19:30) 08:20:02 INFO - Working with test: dromaeo_css 08:20:02 INFO - Generating results file: dromaeo_css 08:20:02 INFO - Working with test: kraken 08:20:02 INFO - Generating results file: kraken 08:20:02 INFO - javascript benchmark 08:20:02 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:20:06 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 08:20:06 INFO - process_Request line: dromaeo_css 7356.44 graph.html#tests=[[72,64,61]] 08:20:06 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:20:06 INFO - process_Request line: kraken 1535.50 graph.html#tests=[[232,64,61]] 08:20:06 INFO - RETURN: dromaeo_css: 7356.44 08:20:06 INFO - RETURN: kraken: 1535.50 08:20:06 INFO - javascript benchmark 08:20:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3551.3962626353527, 3576.409892367758, 3605.296967091418, 3640.490331353611, 3649.2883887641906, 4721.409823772028, 4970.179920313144, 5919.585629005961, 5933.673647949367, 5949.345571987078, 5717.056685646874, 5858.238429004234, 5909.054551271797, 5910.3203131639875, 5910.586258961875, 5235.607329450297, 5288.788448462076, 5296.443873393296, 5340.732963351817, 5356.089464790975, 4666.859994200179, 5323.866903327409, 5325.946740532584, 5331.760070796804, 5408.702521361323, 5363.249145119687, 5398.568114550846, 5403.972980135094, 5408.567314614821, 5413.160960051198, 4661.3241080043545, 5178.741062946875, 5273.551748101416, 5333.280007199017, 5370.973145134269, 5243.737813109329, 5355.705436201008, 5366.838994830161, 5371.033214021474, 5391.218273350342, 4292.80682369291, 4759.738214398207, 5797.130430435426, 5855.941440585582, 5943.881122377528, 6156.292026416974, 6198.4731297839735, 6294.716737746812, 6319.178506794134, 6327.14583531222, 6282.277538083134, 6346.619202847798, 6354.3963323484195, 6364.299927008025, 6366.968165159191, 6021.879562408727, 6036.728347224385, 6049.73314410218, 6054.061620448793, 6058.848528786772, 6230.127782110508, 6301.243850737941, 6310.337414571496, 6410.519211059189, 6464.159659244268, 6197.380261973766, 6211.068339749074, 6224.128621992924, 6231.158793562901, 6247.344028876993, 5279.208118782213, 6305.558610897285, 6323.43089121972, 6331.271903731038, 6350.460210882126, 6113.0, 6202.72087756052, 6231.594946328474, 6265.530085243625, 6292.307846136921, 6229.3770622937345, 6235.906461403082, 6239.0, 6252.874942501216, 6258.217722784652, 4886.560209581155, 5005.3242812220615, 5013.974930125326, 5017.774200161001, 5032.597392208614, 4507.459104907367, 4508.07584445188, 4540.477845047862, 4549.135664223787, 4550.180967425895, 5442.809501667422, 5448.754806033738, 5501.0, 5505.119180931032, 5510.421405752419, 6187.226596675416, 6259.780907668301, 6271.749130034747, 6282.811515654537, 6294.0, 5478.616496845182, 5490.0941344677685, 5503.752331145108, 5517.69652669099, 5530.5022547970075, 5210.869728256748, 5331.733413329318, 5332.733363331818, 5337.250703383726, 5339.599530035185, 6318.589291696025, 6328.778492752732, 6470.4823614110755, 6471.0940468334475, 6477.6437295948235, 4794.952050479451, 6011.0, 6028.457438830351, 6222.284437289589, 6296.0, 5730.828075157752, 6277.874442511033, 6363.172787537591, 6483.481321494175, 6487.578307410004, 6232.532560057924, 6305.211848518935, 6317.336679648571, 6333.145025421693, 6360.840978975562, 5285.392179899207, 6250.718717657625, 6267.717952692231, 6284.811455656155, 6286.119943207863, 5084.237364395371, 6166.352532983972, 6174.166487524307, 6223.471004964447, 6284.0, 6105.581053426346, 6238.875222495434, 6273.215848018997, 6278.0269058296035, 6288.496920246278, 6075.848103797263, 6120.877582448237, 6123.4488895999575, 6134.723937422916, 6182.041783523561, 4930.0, 6139.124180917401, 6222.657753823583, 6223.844403889939, 6251.4061164189325, 6139.693015349126, 6181.350958149509, 6181.9690901547, 6182.0, 6202.596831205957], "unit": "score", "name": "dojo.html", "value": 5720.736228426575}, {"lowerIsBetter": false, "replicates": [448.70161342707104, 456.05823973494734, 475.00486480822684, 508.76596765487875, 525.69772380881, 27772.0, 37477.437838432445, 37488.62511374885, 37662.43506347403, 37713.43429848555, 39357.80321098398, 39827.80516584507, 39900.0, 39984.60015399845, 40151.0, 9399.624015039408, 9540.618375264981, 9545.61817527298, 9603.855942160873, 9615.615375384976, 9451.905480945206, 9513.0, 9574.52127393631, 9710.465924374157, 9751.609935602568, 9664.95167524165, 9685.176759975411, 9788.559514821814, 9790.706278811647, 9796.755081122994, 8332.458390204618, 9615.278854085936, 9616.90383096167, 9684.61261549537, 9704.078112579293, 8245.381596380295, 9515.714528564155, 9647.662331818423, 9657.22742180624, 9672.322937394385, 38611.0, 38794.80602596969, 38893.41659875104, 39022.60977390246, 39069.609303907164, 3210.646828848825, 3249.8700051997894, 3250.2686895448574, 3260.625028121749, 3265.151060724205, 27578.44843103147, 27978.440431191262, 28581.0, 29010.0, 29390.85304573485, 2749.230215539652, 2771.4457108578363, 2830.278279038832, 2854.2578929478277, 2945.779066570016, 359281.4071859274, 360733.0, 363587.0, 364051.0, 364734.0, 53127.0, 54118.7294063535, 61165.38834611686, 61355.0, 61458.38541614527, 64717.67641161764, 64839.0, 65553.01670474946, 65704.0, 65743.67128164328, 15310.157941313111, 15496.457623983331, 15573.454929077428, 15719.607009824846, 15895.920520397556, 11999.64001079969, 12137.514499419924, 12188.451519681636, 12201.69495762613, 12217.93891030539, 15177.696446071017, 18149.909250453664, 18153.092345382676, 18222.544436388933, 18388.540286492676, 6189.442950134509, 7963.8407231855035, 8173.060098088796, 8202.343812494986, 8210.178982101861, 728.9635518224068, 901.3195037746459, 901.9503927283931, 926.2775035472342, 941.6092321686424, 28510.42979140447, 29007.129786106452, 29415.558766618517, 29629.555556666666, 29664.2583935399, 1057.577558184241, 1060.3266925502362, 1079.3308148947547, 1087.6791346552786, 1128.4696192789377, 13624.0, 14359.707626313682, 14971.0, 15079.0, 15167.469138580096, 510489.0, 525678.0, 534442.0, 537804.0, 542786.0, 55703.721481392335, 55877.88244235093, 56074.158887616715, 56406.717966410724, 56584.0, 1394.5258612071943, 1413.837408698013, 1421.2964582531506, 1422.6514503946598, 1537.531053028837, 27902.441951160457, 28088.71911280861, 29010.213314802822, 29061.273468163465, 29226.707732922398, 48153.7961550964, 48439.27341089816, 48772.75613621909, 48868.5113148864, 48954.0, 495255.52372237906, 496593.0, 502599.4870025627, 502726.0, 503197.0, 31662.0, 32536.186595335304, 32719.836400817843, 32742.181445463102, 32763.017109486755, 41338.58661413468, 41867.581324186365, 43125.13749725051, 43167.35248971205, 43912.780436097615, 33516.16209594682, 34284.971450856516, 34306.31387372289, 34747.65252347444, 34920.82539587286, 27366.452670946866, 33291.16772080717, 34056.14859628529, 34173.0, 34403.0, 33513.16217094495, 34158.82920585381, 34272.82863585666, 34299.314013719086, 34553.30893382169, 31563.84218078895, 31770.52344214885, 31956.840215798773, 32109.518357225126, 32313.35373292568, 24378.75621243765, 24597.87701061555, 24675.506489870462, 24820.751792481846, 24910.12814551482], "unit": "score", "name": "ext.html", "value": 18957.11710164165}, {"lowerIsBetter": false, "replicates": [357.1749259211222, 359.52183595817564, 360.94766258892463, 366.1468777747848, 367.8583745258075, 15245.466408675698, 15287.464938727147, 17917.014564198962, 19586.90206548967, 20838.74967501951, 18472.44582662519, 18615.0, 18694.0, 18720.438386848382, 18968.051597420144, 5494.0, 5812.680302583356, 5812.970935145339, 5816.534677225812, 5834.095715164156, 4125.566815484376, 4310.568943105695, 5405.4324295948945, 6100.908486372708, 6317.273513545955, 6105.358937311585, 6312.400321969429, 6333.398327158936, 6375.075614035962, 6380.979043353064, 6289.465395441393, 6322.968385158091, 6338.778142764981, 6343.936560634427, 6376.39424254695, 5230.450802665741, 5388.946110538884, 5535.197396377543, 5536.141898005815, 5542.307211598551, 15519.3016314265, 23635.88182059096, 23956.520869582684, 24027.759722402727, 24049.639255411184, 1866.9066546672748, 1887.7635148977442, 2012.11466954541, 2107.926222582202, 2170.34889533141, 8285.62714677841, 8884.20042196199, 9734.805303893952, 9790.706278811647, 9852.802943941153, 1685.9085561603888, 1700.2348942975711, 1723.862091032727, 1741.7561541384216, 1829.698099813529, 97620.51189744077, 101665.4916725419, 101959.4902025485, 102395.48802256015, 102422.0, 9020.954895225483, 10946.233763636628, 11099.667009989713, 11178.664640060812, 11251.943740281245, 13441.663958401119, 13561.796573051412, 13565.59303220905, 13576.049676522549, 13590.660233494043, 8447.281981031558, 8485.236328730443, 8523.105073967268, 8565.614547345385, 8587.055423903366, 8575.3997220194, 8588.0, 8592.742217733477, 8681.479111253346, 8688.565571721389, 3541.256336169382, 3790.711158206223, 4417.624501917308, 4446.377507149002, 4548.385967894292, 1549.2486144220045, 1809.9185536650882, 1824.8357647811495, 1858.7583614130347, 1860.8139186081555, 382.7971175277108, 778.5328802718324, 978.2027647467291, 1019.2050200843354, 1027.6916924922493, 10975.890241097646, 11373.033292170257, 11392.145589080852, 11545.307281563133, 11753.706157346134, 435.9367891655692, 442.03415537051643, 442.4005472584666, 444.5820928327362, 445.3031006474921, 5954.255718035246, 6136.23297087864, 6194.907076393858, 6225.28409232935, 6286.5599408041, 724471.0, 729527.0, 735676.0, 741027.0, 741468.0, 87073.5646321777, 118500.0, 119318.0, 120628.0, 120857.0, 503.2074482689778, 508.69732509156995, 509.1598861877931, 509.22089203518675, 509.9949000509947, 8843.46939183651, 10992.955669211413, 11075.224734268846, 11112.333260004425, 11131.554737810397, 46254.0, 46434.767826160656, 47425.52574474211, 48213.758931206525, 48744.53766387014, 65230.347696522425, 66143.0, 66420.6678966602, 66537.0, 67807.98288025783, 7441.255874412515, 7748.612569371621, 7754.728584499516, 7798.883016754639, 7805.687772489036, 9516.95241523788, 10485.842712359474, 11485.712857178638, 11819.881801181878, 12111.212771169845, 8126.228008339198, 9177.54112294396, 9642.228621710106, 10231.437270949871, 10448.843267351147, 8337.082920878578, 9139.177474027369, 9589.904100958902, 9640.0, 10063.295569310078, 7054.506184567031, 7399.223081576572, 9479.526023698925, 10482.004209600076, 10714.0, 7872.803179920548, 10004.149647279772, 10208.846867297145, 10573.418461984356, 11108.777824443627, 7959.442839001446, 10983.61557345489, 10987.340759554452, 11218.551257949917, 11589.710257243636], "unit": "score", "name": "jquery.html", "value": 8299.508554253314}, {"lowerIsBetter": false, "replicates": [1518.8708959738422, 1532.348751780493, 1756.2448147296666, 1857.2570971611362, 1870.5697689531416, 7946.960265198681, 8014.799630009253, 8751.212390884819, 8876.467411955287, 8974.685885993991, 7378.778636640896, 8100.311473524743, 8529.914700852989, 8530.0, 8664.306855451565, 2427.8057755379527, 2468.333549941515, 2473.6660550825677, 2483.428811373385, 2484.1802205272215, 2454.840435371704, 2482.019602257107, 2489.029278581355, 2489.3029951613485, 2492.6385674077246, 2410.5660981023407, 2438.426969662137, 2477.4549599088264, 2481.677381940345, 2491.028498885436, 2152.956940861174, 2163.8268938484885, 2175.6845257437585, 2179.6512557990723, 2181.301983365324, 2486.3908342456034, 2489.8879550420274, 2496.2636022373263, 2497.512984967932, 2506.0602274147195, 8610.311175105977, 8775.78060548485, 8848.424852384638, 8850.20348168668, 8870.55647217643, 4164.604362585549, 5446.428125046892, 5454.427285135083, 5513.476219759116, 5537.058700021006, 3714.9442758358646, 3749.343864823645, 3772.6981841452616, 3804.144067584799, 3804.8478060877533, 1045.8431235314688, 1074.7957888001254, 1077.095239998405, 1082.4749996251812, 1097.4238524774478, 12000.97991670709, 12041.518339266506, 12138.696532586757, 12187.634370968797, 12195.756084878341, 4944.53026962438, 4955.157623204064, 4970.3290055842, 5023.899522009539, 5034.0686972910125, 10129.949350253202, 10275.383476991256, 10429.426381549089, 10462.110720588684, 10474.73813154662, 4959.132151873408, 5284.180951952453, 5430.864228394322, 5434.83695489136, 5486.149646804752, 3750.6249375062275, 4396.846110386121, 4462.665300102505, 4855.223164293696, 4936.975315123402, 3447.637998010223, 3998.3402738547816, 4016.7389119707127, 4019.477467929209, 4057.5333836609166, 1320.6368248731676, 1328.2628141381433, 1329.415057374752, 1334.786434170528, 1343.3619030960215, 1090.1006669497697, 1090.9399983000853, 1263.368315842079, 1316.4602512969636, 1335.1721932401972, 7977.880331795028, 8025.759227223192, 8052.798680033046, 8108.1891810819625, 8259.917400826034, 511.1086898382518, 518.266652686452, 521.3092652235803, 524.7586110389187, 525.6451894970879, 6133.202683651186, 6153.4154255345675, 6249.281332646804, 6253.218347706536, 6284.685765711788, 9120.361574689841, 9455.432674039579, 9500.904990950141, 10280.86910439851, 10932.890671093346, 10236.385816851012, 10473.633422830164, 10682.51928663212, 10729.83905241422, 10755.300905441121, 8183.918160818434, 8263.95868020668, 8295.0, 8358.540280284642, 8414.831703365899, 7892.250236227549, 8091.271785539329, 8151.0, 8178.914376833869, 8180.713675021346, 9468.763280917756, 9562.187214086602, 9636.42181469086, 9689.0, 9733.172680321968, 9866.802663946824, 10081.546330415296, 10131.341462804894, 10212.591496340063, 10232.23258255619, 6173.228346456693, 6732.528722989344, 7110.933359996042, 7505.587192704454, 7516.774496765106, 8037.437379383387, 8181.877271840808, 8205.917940820515, 8217.424780265563, 8255.587220639065, 7042.823929401601, 7750.457467977188, 7793.337566306927, 7793.922060779547, 7894.684212631661, 7567.886481702669, 7592.734254301073, 7620.123685776207, 7740.961295193488, 7784.0, 7772.68909243624, 7807.687692492236, 7837.37301015906, 7936.087349954829, 7972.242636949481, 7035.0, 7082.433405327459, 7091.184513780981, 7127.394171495481, 7145.46409019336, 7189.496735228484, 7204.495685302189, 7249.166345870292, 7252.202257751748, 7261.854762904818], "unit": "score", "name": "mootools.html", "value": 4829.323647409454}, {"lowerIsBetter": false, "replicates": [321.20822173342714, 327.7705606075746, 328.16482053174695, 335.99496007559884, 337.3506000948176, 6732.899006514906, 6950.339717726814, 6961.895571566424, 6998.510104292702, 7060.152781666207, 6837.350451707092, 6912.9654351728295, 6936.341047600483, 6937.098177236952, 7005.194402643685, 5058.11482990477, 5069.315642388286, 5071.137906555876, 5082.16144336185, 5091.1090559152, 4811.254255590372, 5085.66943148696, 5087.135187018216, 5088.949110508903, 5121.436641969381, 4928.581070609002, 4943.23379876118, 4943.431505376891, 4961.5286547777905, 4973.378327709036, 4939.678920870132, 4941.283513890484, 4951.0, 4963.751812409365, 4977.278294647292, 3980.243753686819, 4081.3265811141127, 4087.8364865405347, 4192.916141677149, 4193.308104162809, 5351.0, 6613.173353330833, 6622.701978410983, 6636.270010298863, 6640.136782218329, 5914.37899020601, 5915.970420147914, 5925.4370834770625, 5935.55483338747, 5946.167536544887, 5860.501857342131, 7049.4712896532965, 7319.963400182965, 7418.517796343221, 7432.070991126109, 4713.505081966413, 4714.740689262089, 4717.198076327033, 4723.354921244114, 4724.149653062447, 7777.455578109534, 7798.298153166243, 7816.257455541714, 7841.882371764371, 7847.646855891441, 3748.4189950557707, 4195.223883581547, 4773.809047638125, 4773.9761301193275, 4788.712677239377, 4875.219964805685, 4880.0, 4883.0, 4895.7062576245535, 4904.141775189328, 4829.27560865873, 5871.532116970758, 5904.9704751475965, 5906.143609176645, 5911.615744976562, 7267.091613548307, 7458.738944137038, 7471.626418679044, 7488.176300606929, 7511.32398084175, 1652.6281586642908, 1698.4395149600603, 1699.4137022727139, 1706.6330738891197, 1707.282941164689, 1056.8044911691209, 1066.1630619963291, 1070.2347821307646, 1070.8500809886623, 1085.8588383510094, 6485.383888530677, 6490.383413575702, 6515.120458738104, 6528.543001989815, 6543.509236807258, 7573.6213189340315, 7581.3934885209055, 7588.62056897153, 7608.391328693802, 7628.923710762932, 6249.468795152463, 6485.092087107809, 6491.123698300763, 6492.415682588496, 6539.411452969255, 3914.080191155076, 3956.723029387973, 4005.499312585927, 4023.255697695877, 4049.9392509112386, 6981.3367730065565, 7706.730264440717, 8112.22933821286, 8118.309943654737, 8131.105578386373, 7832.216778322236, 7986.960065199637, 8032.277095061472, 8038.115807261197, 8039.15588863161, 8045.919540804634, 8059.959700201696, 8089.02931648206, 8112.675492980333, 8182.263596276363, 7650.896003598832, 7653.0, 7654.502457340255, 7663.616819159131, 7694.115176754521, 7302.379297759538, 7615.276548727862, 7632.3512501438, 7653.961730191313, 7669.5398276103615, 8084.87872681922, 8090.919090809017, 8091.94804675412, 8092.959535202286, 8104.554249516334, 4013.698972577127, 4806.639502037291, 4809.567138957371, 4817.397825271841, 4821.831235906727, 7437.48877491967, 7713.344365728752, 7714.691412343668, 7725.884111738441, 7774.883376749466, 7451.143118541437, 7455.6644950978425, 7455.92544074574, 7460.403167746459, 7476.626168691652, 7208.747693830691, 7337.156227033959, 7435.405167586689, 7441.776746697607, 7487.625618718933, 5906.438888305604, 7220.38626716735, 7227.602481863548, 7282.563046217244, 7319.59742214162, 6773.679132569102, 6928.237893831775, 7447.92552074494, 7450.739224127129, 7458.962705186656, 7116.893246601202, 7278.96360518194, 7282.963585182252, 7291.52605080668, 7342.0], "unit": "score", "name": "prototype.html", "value": 5330.198501558035}, {"lowerIsBetter": false, "replicates": [609.625080575446, 657.8519833037567, 670.4368330602293, 709.1277728394075, 718.9604571748558, 14776.704465910689, 15175.392984280643, 15251.161186134772, 17452.476425707217, 17661.91169044156, 16070.357185712557, 16121.99999999997, 16164.353425862952, 16223.756643650355, 16240.593985150377, 684.2609981220295, 696.2619623199399, 844.476424616737, 850.2602735620019, 852.288339236738, 848.3128665780706, 857.9613917373701, 858.9312854971587, 859.3511898516612, 861.1259571534897, 883.8762573239752, 891.9509426981514, 892.8839250897374, 895.4358753985013, 898.7213963671282, 882.9867551986725, 883.3639779358883, 886.6852267445094, 890.9821803563925, 892.7143314139478, 655.446148004935, 658.5324419662046, 662.8276648071488, 663.0650782396798, 667.2793383146239, 15307.617309567238, 15425.537233883002, 15470.0, 15493.0, 15572.0, 10425.79148417035, 12593.685157871036, 12697.0, 12879.549215777402, 12916.87083129166, 10094.646687365981, 10117.595296188143, 10257.583747052555, 10365.01532354425, 10376.94811525945, 3459.394605943975, 3505.964940350589, 3508.5438892944007, 3510.385682505577, 3523.9780463665506, 83914.321713566, 84669.57665211635, 86548.0, 86565.26869462576, 86630.56684716599, 9337.159655631025, 9364.157225849705, 9391.859122113174, 9480.431174129575, 9510.524473776284, 20222.393328200178, 20474.488137796674, 20577.0, 20628.896855515926, 20649.0, 7437.776866694008, 7438.776836694908, 7636.618169091523, 7659.731909383145, 7677.424193185533, 4001.099752555652, 4111.342185250345, 4113.650339721157, 4116.897077573085, 4123.587641235852, 3001.504751715986, 3561.4123669594746, 3567.571891373052, 3582.265635544707, 3598.838052287653, 636.5353292096795, 644.2333622988722, 645.4481418387305, 669.6417416682149, 670.765232168737, 535.8981793459308, 549.9587530935116, 555.1727925391139, 565.3357305166413, 621.7388696747377, 6769.086173366631, 8600.268977136888, 8680.0, 8754.69358572447, 8891.066438023914, 491.7836152093068, 536.6431323170126, 546.9781208751606, 600.2047287344286, 606.0273261415452, 3712.350338690718, 3830.4637350770913, 3928.705347098979, 3984.8007599620482, 4000.57993910641, 74412.88380674295, 76870.46259074788, 94152.17543473707, 97562.0, 98348.0, 80267.19732802713, 80840.0, 81151.3769724614, 81761.77357339645, 81930.0, 62377.0, 63460.0, 64043.0, 68401.31598684049, 68454.28864278333, 8583.227509524173, 8705.129487051245, 8807.691730789391, 8830.602622882114, 8831.116888311117, 47632.0, 47814.760926195144, 48092.0, 50368.74815625898, 50433.0, 65170.0, 66458.0, 66886.0, 67441.65116697736, 70615.64692176506, 10728.517216725422, 10808.405537695502, 10821.296615719953, 11115.0, 11455.541778328774, 10186.490675466346, 11902.226355286879, 11988.700282493008, 12292.201006934522, 12629.052821038274, 11011.229213954946, 11166.776664466828, 11476.87409869131, 11542.422878855856, 12164.452599633214, 11170.664880053611, 11324.547018119183, 11359.943200284277, 11735.41322933867, 12330.568430105262, 10853.565857365616, 11424.0, 11443.713907152387, 11445.141614379121, 12031.27812331263, 9176.816463670822, 9287.907120928705, 9344.252459803336, 9514.345056495871, 9598.95200523993, 8256.587170641324, 9137.269018478373, 9161.450312981242, 9523.619055237712, 9951.850722239316], "unit": "score", "name": "yui.html", "value": 6840.166307539174}], "name": "dromaeo_css", "value": 7356.436029260018}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 112.0, 115.0, 135.0, 168.0, 170.0, 113.0, 113.0, 134.0, 157.0], "unit": "score", "name": "ai-astar", "value": 133.3}, {"lowerIsBetter": true, "replicates": [153.0, 124.0, 160.0, 185.0, 123.0, 139.0, 146.0, 122.0, 156.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 143.3}, {"lowerIsBetter": true, "replicates": [192.0, 195.0, 198.0, 212.0, 247.0, 269.0, 269.0, 226.0, 202.0, 202.0], "unit": "score", "name": "audio-dft", "value": 221.2}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 66.0, 112.0, 48.0, 56.0, 64.0, 89.0, 131.0, 61.0], "unit": "score", "name": "audio-fft", "value": 77.7}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 122.0, 81.0, 82.0, 84.0, 132.0, 85.0, 87.0, 121.0], "unit": "score", "name": "audio-oscillator", "value": 95.6}, {"lowerIsBetter": true, "replicates": [87.0, 93.0, 86.0, 93.0, 88.0, 111.0, 110.0, 94.0, 87.0, 92.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 94.1}, {"lowerIsBetter": true, "replicates": [116.0, 96.0, 95.0, 96.0, 127.0, 101.0, 106.0, 149.0, 151.0, 105.0], "unit": "score", "name": "imaging-darkroom", "value": 114.2}, {"lowerIsBetter": true, "replicates": [91.0, 96.0, 90.0, 92.0, 96.0, 92.0, 92.0, 91.0, 93.0, 91.0], "unit": "score", "name": "imaging-desaturate", "value": 92.4}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 54.0, 55.0, 55.0, 57.0, 56.0, 64.0, 52.0, 62.0], "unit": "score", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [62.0, 74.0, 89.0, 107.0, 64.0, 67.0, 66.0, 67.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 72.8}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 83.0, 86.0, 85.0, 87.0, 86.0, 87.0, 122.0, 73.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.9}, {"lowerIsBetter": true, "replicates": [141.0, 128.0, 128.0, 132.0, 135.0, 125.0, 124.0, 128.0, 123.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.4}, {"lowerIsBetter": true, "replicates": [182.0, 168.0, 140.0, 143.0, 141.0, 147.0, 142.0, 142.0, 142.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.8}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 67.0, 67.0, 69.0, 67.0, 67.0, 69.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1535.5000000000002}]} 08:20:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1535.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7356.44"}}} 08:20:06 INFO - Return code: 0 08:20:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:20:06 INFO - # TBPL SUCCESS # 08:20:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:20:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:20:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:20:06 INFO - 2016-02-04 08:20:06.551 screenresolution[2129:16013] starting screenresolution argv=screenresolution get 08:20:06 INFO - 2016-02-04 08:20:06.553 screenresolution[2129:16013] Display 0: 1600x1200x32@60 08:20:06 INFO - 2016-02-04 08:20:06.559 screenresolution[2130:16016] starting screenresolution argv=screenresolution list 08:20:06 INFO - Available Modes on Display 0 08:20:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:20:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:20:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:20:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:20:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:20:06 INFO - Intel Iris: 08:20:06 INFO - Chipset Model: Intel Iris 08:20:06 INFO - Type: GPU 08:20:06 INFO - Bus: Built-In 08:20:06 INFO - VRAM (Dynamic, Max): 1536 MB 08:20:06 INFO - Vendor: Intel (0x8086) 08:20:06 INFO - Device ID: 0x0a2e 08:20:06 INFO - Revision ID: 0x0009 08:20:06 INFO - Displays: 08:20:06 INFO - Display: 08:20:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:20:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:20:06 INFO - Display Serial Number: 1600x1200 60 08:20:06 INFO - Main Display: Yes 08:20:06 INFO - Mirror: Off 08:20:06 INFO - Online: Yes 08:20:06 INFO - Rotation: Supported 08:20:06 INFO - Return code: 0 08:20:06 INFO - Running post-action listener: _resource_record_post_action 08:20:06 INFO - Running post-run listener: _resource_record_post_run 08:20:07 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 31878656; Write bytes: 713184256; Read time: 334; Write time: 2234 08:20:07 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404756992; Write bytes: 401934336; Read time: 30338; Write time: 733 08:20:07 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 31854080; Write bytes: 303844352; Read time: 333; Write time: 1476 08:20:07 INFO - Running post-run listener: _upload_blobber_files 08:20:07 INFO - Blob upload gear active. 08:20:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:20:07 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 08:20:07 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'] 08:20:07 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 08:20:08 INFO - (blobuploader) - INFO - Open directory for files ... 08:20:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:20:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:20:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:10 INFO - (blobuploader) - INFO - Done attempting. 08:20:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:20:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:20:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:11 INFO - (blobuploader) - INFO - Done attempting. 08:20:11 INFO - (blobuploader) - INFO - Iteration through files over. 08:20:11 INFO - Return code: 0 08:20:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:20:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:20:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c06998883564133a2e61e7599925307b0ce2b2f4c1b5819f48ef3f0fb23d07cbbfdafccfe4de67fbc9464e9c16b1f798d3845db219027fd60b260a4a18b305e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9052e005bc7466fe64a209c2a0e401d289060a498652a3c86fe48ae62f552bda1b0c5e8d8dda7a5f51743b280c0e343e6a2eeec3628ac38ba9f78ecc7292d96c"} 08:20:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:20:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:20:11 INFO - Contents: 08:20:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c06998883564133a2e61e7599925307b0ce2b2f4c1b5819f48ef3f0fb23d07cbbfdafccfe4de67fbc9464e9c16b1f798d3845db219027fd60b260a4a18b305e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9052e005bc7466fe64a209c2a0e401d289060a498652a3c86fe48ae62f552bda1b0c5e8d8dda7a5f51743b280c0e343e6a2eeec3628ac38ba9f78ecc7292d96c"} 08:20:11 INFO - Running post-run listener: copy_logs_to_upload_dir 08:20:11 INFO - Copying logs to upload dir... 08:20:11 INFO - mkdir: /builds/slave/test/build/upload/logs 08:20:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.825219 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-04 08:20:11.654378) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-04 08:20:11.658047) ========= 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.Kk4TkAcuIl/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.qb0SM6yvgU/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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/c06998883564133a2e61e7599925307b0ce2b2f4c1b5819f48ef3f0fb23d07cbbfdafccfe4de67fbc9464e9c16b1f798d3845db219027fd60b260a4a18b305e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9052e005bc7466fe64a209c2a0e401d289060a498652a3c86fe48ae62f552bda1b0c5e8d8dda7a5f51743b280c0e343e6a2eeec3628ac38ba9f78ecc7292d96c"} build_url:https://queue.taskcluster.net/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011153 build_url: 'https://queue.taskcluster.net/v1/task/U3oGXjkHSXeIXQjgZ_2trQ/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/c06998883564133a2e61e7599925307b0ce2b2f4c1b5819f48ef3f0fb23d07cbbfdafccfe4de67fbc9464e9c16b1f798d3845db219027fd60b260a4a18b305e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9052e005bc7466fe64a209c2a0e401d289060a498652a3c86fe48ae62f552bda1b0c5e8d8dda7a5f51743b280c0e343e6a2eeec3628ac38ba9f78ecc7292d96c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-04 08:20:11.687486) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 08:20:11.687834) ========= 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.Kk4TkAcuIl/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.qb0SM6yvgU/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.005330 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 08:20:11.736260) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-04 08:20:11.736572) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-04 08:20:11.736955) ========= ========= Total master_lag: 4.79 =========