builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0115 starttime: 1455663646.54 results: success (0) buildid: 20160216140711 builduid: 62b854f6ab3d4e6e84ebbf1a34efa388 revision: 39742e742b69087a03366c396d365e03e5df997d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-16 15:00:46.544808) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-16 15:00:46.545343) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-16 15:00:46.545675) ========= 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.Y8cNim4GfL/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.Kbolnk1Vvl/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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.005596 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-16 15:00:46.575537) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-16 15:00:46.575898) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-16 15:00:46.595690) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-02-16 15:00:46.595995) ========= 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.Y8cNim4GfL/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.Kbolnk1Vvl/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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.005407 ========= master_lag: 3.56 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-02-16 15:00:50.161473) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-16 15:00:50.161844) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-16 15:00:50.165332) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 15:00:50.165659) ========= 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.Y8cNim4GfL/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.Kbolnk1Vvl/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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-16 15:00:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 181M=0s 2016-02-16 15:00:50 (181 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099018 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 15:00:50.280948) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 15:00:50.281346) ========= 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.Y8cNim4GfL/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.Kbolnk1Vvl/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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.025243 ========= master_lag: 0.51 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 15:00:50.817599) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-16 15:00:50.818040) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 39742e742b69087a03366c396d365e03e5df997d --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 39742e742b69087a03366c396d365e03e5df997d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Y8cNim4GfL/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.Kbolnk1Vvl/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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-16 15:00:50,896 truncating revision to first 12 chars 2016-02-16 15:00:50,896 Setting DEBUG logging. 2016-02-16 15:00:50,896 attempt 1/10 2016-02-16 15:00:50,896 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/39742e742b69?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-16 15:00:52,953 unpacking tar archive at: fx-team-39742e742b69/testing/mozharness/ program finished with exit code 0 elapsedTime=2.308504 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-16 15:00:53.159452) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-16 15:00:53.159848) ========= echo 39742e742b69087a03366c396d365e03e5df997d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'39742e742b69087a03366c396d365e03e5df997d'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Y8cNim4GfL/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.Kbolnk1Vvl/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 39742e742b69087a03366c396d365e03e5df997d program finished with exit code 0 elapsedTime=0.005750 script_repo_revision: '39742e742b69087a03366c396d365e03e5df997d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-16 15:00:53.210628) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-16 15:00:53.210994) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-16 15:00:53.225909) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-16 15:00:53.226455) ========= /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.Y8cNim4GfL/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.Kbolnk1Vvl/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 15:00:53 INFO - MultiFileLogger online at 20160216 15:00:53 in /builds/slave/test 15:00:53 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 15:00:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:00:53 INFO - {'append_to_log': False, 15:00:53 INFO - 'base_work_dir': '/builds/slave/test', 15:00:53 INFO - 'blob_upload_branch': 'Fx-Team', 15:00:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:00:53 INFO - 'branch': 'Fx-Team', 15:00:53 INFO - 'buildbot_json_path': 'buildprops.json', 15:00:53 INFO - 'config_files': ('talos/mac_config.py',), 15:00:53 INFO - 'default_actions': ('clobber', 15:00:53 INFO - 'read-buildbot-config', 15:00:53 INFO - 'download-and-extract', 15:00:53 INFO - 'populate-webroot', 15:00:53 INFO - 'create-virtualenv', 15:00:53 INFO - 'install', 15:00:53 INFO - 'run-tests'), 15:00:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:00:53 INFO - 'download_minidump_stackwalk': True, 15:00:53 INFO - 'download_symbols': 'ondemand', 15:00:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:00:53 INFO - 'tooltool.py': '/tools/tooltool.py', 15:00:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:00:53 INFO - '/tools/misc-python/virtualenv.py')}, 15:00:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:00:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:00:53 INFO - 'installer_path': 'installer.exe', 15:00:53 INFO - 'log_level': 'info', 15:00:53 INFO - 'log_name': 'talos', 15:00:53 INFO - 'log_to_console': True, 15:00:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:00:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:00:53 INFO - 'opt_config_files': (), 15:00:53 INFO - 'pip_index': False, 15:00:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:00:53 INFO - 'cmd': ('bash', 15:00:53 INFO - '-c', 15:00:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:00:53 INFO - 'enabled': True, 15:00:53 INFO - 'halt_on_failure': False, 15:00:53 INFO - 'name': 'check_screen_resolution'},), 15:00:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:00:53 INFO - 'cmd': ('bash', 15:00:53 INFO - '-c', 15:00:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:00:53 INFO - 'enabled': True, 15:00:53 INFO - 'halt_on_failure': False, 15:00:53 INFO - 'name': 'check_screen_resolution'},), 15:00:53 INFO - 'run_cmd_checks_enabled': True, 15:00:53 INFO - 'sps_profile': False, 15:00:53 INFO - 'sps_profile_interval': 0, 15:00:53 INFO - 'suite': 'dromaeojs-e10s', 15:00:53 INFO - 'system_bits': '32', 15:00:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:00:53 INFO - 'title': 't-yosemite-r7-0115', 15:00:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:00:53 INFO - 'use_talos_json': True, 15:00:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:00:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:00:53 INFO - 'work_dir': 'build'} 15:00:53 INFO - ##### 15:00:53 INFO - ##### Running clobber step. 15:00:53 INFO - ##### 15:00:53 INFO - Running pre-action listener: _resource_record_pre_action 15:00:53 INFO - Running main action method: clobber 15:00:53 INFO - rmtree: /builds/slave/test/build 15:00:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:00:55 INFO - Running post-action listener: _resource_record_post_action 15:00:55 INFO - ##### 15:00:55 INFO - ##### Running read-buildbot-config step. 15:00:55 INFO - ##### 15:00:55 INFO - Running pre-action listener: _resource_record_pre_action 15:00:55 INFO - Running main action method: read_buildbot_config 15:00:55 INFO - Using buildbot properties: 15:00:55 INFO - { 15:00:55 INFO - "project": "", 15:00:55 INFO - "product": "firefox", 15:00:55 INFO - "script_repo_revision": "production", 15:00:55 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 15:00:55 INFO - "repository": "", 15:00:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 15:00:55 INFO - "buildid": "20160216140711", 15:00:55 INFO - "pgo_build": "False", 15:00:55 INFO - "basedir": "/builds/slave/test", 15:00:55 INFO - "buildnumber": 401, 15:00:55 INFO - "slavename": "t-yosemite-r7-0115", 15:00:55 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:00:55 INFO - "platform": "yosemite_r7", 15:00:55 INFO - "scheduler": "tests-fx-team-macosx64-talos", 15:00:55 INFO - "branch": "fx-team", 15:00:55 INFO - "repo_path": "integration/fx-team", 15:00:55 INFO - "revision": "39742e742b69087a03366c396d365e03e5df997d", 15:00:55 INFO - "stage_platform": "macosx64", 15:00:55 INFO - "builduid": "62b854f6ab3d4e6e84ebbf1a34efa388", 15:00:55 INFO - "slavebuilddir": "test" 15:00:55 INFO - } 15:00:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/GhDMFqZZRPiL17ulMQ--VQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 15:00:55 INFO - Running post-action listener: _resource_record_post_action 15:00:55 INFO - ##### 15:00:55 INFO - ##### Running download-and-extract step. 15:00:55 INFO - ##### 15:00:55 INFO - Running pre-action listener: _resource_record_pre_action 15:00:55 INFO - Running main action method: download_and_extract 15:00:55 INFO - mkdir: /builds/slave/test/build/tests 15:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:55 INFO - https://queue.taskcluster.net/v1/task/GhDMFqZZRPiL17ulMQ--VQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:00:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GhDMFqZZRPiL17ulMQ--VQ/artifacts/public/build/test_packages.json 15:00:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GhDMFqZZRPiL17ulMQ--VQ/artifacts/public/build/test_packages.json 15:00:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GhDMFqZZRPiL17ulMQ--VQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:00:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GhDMFqZZRPiL17ulMQ--VQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:00:56 INFO - Downloaded 1277 bytes. 15:00:56 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:00:56 INFO - Using the following test package requirements: 15:00:56 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:00:56 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:00:56 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 15:00:56 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:00:56 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 15:00:56 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:00:56 INFO - u'jsshell-mac.zip'], 15:00:56 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:00:56 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 15:00:56 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:00:56 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:00:56 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 15:00:56 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:00:56 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 15:00:56 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:00:56 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 15:00:56 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:00:56 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:00:56 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 15:00:56 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:00:56 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')]} 15:00:56 INFO - https://queue.taskcluster.net/v1/task/GhDMFqZZRPiL17ulMQ--VQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:00:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GhDMFqZZRPiL17ulMQ--VQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:00:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GhDMFqZZRPiL17ulMQ--VQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:00:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GhDMFqZZRPiL17ulMQ--VQ/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 15:00:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GhDMFqZZRPiL17ulMQ--VQ/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 15:00:57 INFO - Downloaded 17803578 bytes. 15:00:57 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'] 15:00:57 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 15:01:00 INFO - Return code: 0 15:01:00 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 15:01:00 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')]} 15:01:00 INFO - https://queue.taskcluster.net/v1/task/GhDMFqZZRPiL17ulMQ--VQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:01:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GhDMFqZZRPiL17ulMQ--VQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:01:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GhDMFqZZRPiL17ulMQ--VQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:01:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GhDMFqZZRPiL17ulMQ--VQ/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 15:01:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GhDMFqZZRPiL17ulMQ--VQ/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 15:01:03 INFO - Downloaded 17803578 bytes. 15:01:03 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'] 15:01:03 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 15:01:06 INFO - Return code: 0 15:01:06 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')]} 15:01:06 INFO - https://queue.taskcluster.net/v1/task/GhDMFqZZRPiL17ulMQ--VQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:01:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GhDMFqZZRPiL17ulMQ--VQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 15:01:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GhDMFqZZRPiL17ulMQ--VQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 15:01:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GhDMFqZZRPiL17ulMQ--VQ/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 15:01:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GhDMFqZZRPiL17ulMQ--VQ/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 15:01:07 INFO - Downloaded 10707071 bytes. 15:01:07 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'] 15:01:07 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 15:01:07 INFO - Return code: 0 15:01:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:07 INFO - https://queue.taskcluster.net/v1/task/GhDMFqZZRPiL17ulMQ--VQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:01:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GhDMFqZZRPiL17ulMQ--VQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:01:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GhDMFqZZRPiL17ulMQ--VQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:01:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GhDMFqZZRPiL17ulMQ--VQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 15:01:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GhDMFqZZRPiL17ulMQ--VQ/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 15:01:10 INFO - Downloaded 111172709 bytes. 15:01:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GhDMFqZZRPiL17ulMQ--VQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:01:10 INFO - mkdir: /builds/slave/test/properties 15:01:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:01:10 INFO - Writing to file /builds/slave/test/properties/build_url 15:01:10 INFO - Contents: 15:01:10 INFO - build_url:https://queue.taskcluster.net/v1/task/GhDMFqZZRPiL17ulMQ--VQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:01:12 INFO - Running post-action listener: _resource_record_post_action 15:01:12 INFO - Running post-action listener: set_extra_try_arguments 15:01:12 INFO - ##### 15:01:12 INFO - ##### Running populate-webroot step. 15:01:12 INFO - ##### 15:01:12 INFO - Running pre-action listener: _resource_record_pre_action 15:01:12 INFO - Running main action method: populate_webroot 15:01:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:01:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:01:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:01:12 INFO - '--tppagecycles', 15:01:12 INFO - '7'], 15:01:12 INFO - 'tests': ['tsvgm']}}, 15:01:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:01:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:01:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:01:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:01:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:01:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:01:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:12 INFO - 'talos_options': ['--e10s'], 15:01:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:12 INFO - 'tests': ['damp', 'tps']}, 15:01:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:12 INFO - 'talos_options': ['--e10s'], 15:01:12 INFO - 'tests': ['damp', 'tps']}, 15:01:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:01:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:01:12 INFO - 'other': {'tests': ['a11yr', 15:01:12 INFO - 'ts_paint', 15:01:12 INFO - 'tpaint', 15:01:12 INFO - 'sessionrestore', 15:01:12 INFO - 'sessionrestore_no_auto_restore']}, 15:01:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:01:12 INFO - 'tests': ['a11yr', 15:01:12 INFO - 'ts_paint', 15:01:12 INFO - 'tpaint', 15:01:12 INFO - 'sessionrestore', 15:01:12 INFO - 'sessionrestore_no_auto_restore']}, 15:01:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:01:12 INFO - 'tests': ['a11yr', 15:01:12 INFO - 'ts_paint', 15:01:12 INFO - 'tpaint', 15:01:12 INFO - 'sessionrestore', 15:01:12 INFO - 'sessionrestore_no_auto_restore']}, 15:01:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:01:12 INFO - 'tests': ['a11yr', 15:01:12 INFO - 'ts_paint', 15:01:12 INFO - 'tpaint', 15:01:12 INFO - 'sessionrestore', 15:01:12 INFO - 'sessionrestore_no_auto_restore']}, 15:01:12 INFO - 'other_l64': {'tests': ['a11yr', 15:01:12 INFO - 'ts_paint', 15:01:12 INFO - 'tpaint', 15:01:12 INFO - 'sessionrestore', 15:01:12 INFO - 'sessionrestore_no_auto_restore']}, 15:01:12 INFO - 'other_nol64': {'tests': ['a11yr', 15:01:12 INFO - 'ts_paint', 15:01:12 INFO - 'tpaint', 15:01:12 INFO - 'sessionrestore', 15:01:12 INFO - 'sessionrestore_no_auto_restore']}, 15:01:12 INFO - 'svgr': {'tests': ['tsvgx', 15:01:12 INFO - 'tsvgr_opacity', 15:01:12 INFO - 'tart', 15:01:12 INFO - 'tscrollx', 15:01:12 INFO - 'cart']}, 15:01:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:01:12 INFO - 'tests': ['tsvgx', 15:01:12 INFO - 'tsvgr_opacity', 15:01:12 INFO - 'tart', 15:01:12 INFO - 'tscrollx', 15:01:12 INFO - 'cart']}, 15:01:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:12 INFO - 'tests': ['tp5o']}, 15:01:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:12 INFO - 'talos_options': ['--e10s'], 15:01:12 INFO - 'tests': ['tp5o']}, 15:01:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:12 INFO - 'talos_options': ['--xperf_path', 15:01:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:12 INFO - 'tests': ['tp5n']}, 15:01:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:12 INFO - 'talos_options': ['--e10s', 15:01:12 INFO - '--xperf_path', 15:01:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:12 INFO - 'tests': ['tp5n']}}, 15:01:12 INFO - 'talos.zip': {'path': '', 15:01:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:01:12 INFO - Running post-action listener: _resource_record_post_action 15:01:12 INFO - ##### 15:01:12 INFO - ##### Running create-virtualenv step. 15:01:12 INFO - ##### 15:01:12 INFO - Running pre-action listener: _resource_record_pre_action 15:01:12 INFO - Running main action method: create_virtualenv 15:01:12 INFO - Creating virtualenv /builds/slave/test/build/venv 15:01:12 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 15:01:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:01:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:01:12 INFO - Using real prefix '/tools/python27' 15:01:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:01:12 INFO - Installing distribute.............................................................................................................................................................................................done. 15:01:15 INFO - Installing pip.................done. 15:01:15 INFO - Return code: 0 15:01:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:01:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10444aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044514c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d9ad9a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042eed30>, '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 0x104112db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042e5b20>, '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.Y8cNim4GfL/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.Kbolnk1Vvl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 15:01:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:01:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:01:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y8cNim4GfL/Render', 15:01:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:15 INFO - 'HOME': '/Users/cltbld', 15:01:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:15 INFO - 'LOGNAME': 'cltbld', 15:01:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:15 INFO - 'MOZ_NO_REMOTE': '1', 15:01:15 INFO - 'NO_EM_RESTART': '1', 15:01:15 INFO - 'PAGER': '/bin/cat', 15:01:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:15 INFO - 'PWD': '/builds/slave/test', 15:01:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:15 INFO - 'SHELL': '/bin/bash', 15:01:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Kbolnk1Vvl/Listeners', 15:01:15 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 15:01:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:15 INFO - 'USER': 'cltbld', 15:01:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:15 INFO - 'XPC_FLAGS': '0x0', 15:01:15 INFO - 'XPC_SERVICE_NAME': '0', 15:01:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:16 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 15:01:16 INFO - Cleaning up... 15:01:16 INFO - Return code: 0 15:01:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10444aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044514c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d9ad9a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042eed30>, '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 0x104112db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042e5b20>, '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.Y8cNim4GfL/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.Kbolnk1Vvl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 15:01:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:01:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y8cNim4GfL/Render', 15:01:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:16 INFO - 'HOME': '/Users/cltbld', 15:01:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:16 INFO - 'LOGNAME': 'cltbld', 15:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:16 INFO - 'MOZ_NO_REMOTE': '1', 15:01:16 INFO - 'NO_EM_RESTART': '1', 15:01:16 INFO - 'PAGER': '/bin/cat', 15:01:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:16 INFO - 'PWD': '/builds/slave/test', 15:01:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:16 INFO - 'SHELL': '/bin/bash', 15:01:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Kbolnk1Vvl/Listeners', 15:01:16 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 15:01:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:16 INFO - 'USER': 'cltbld', 15:01:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:16 INFO - 'XPC_FLAGS': '0x0', 15:01:16 INFO - 'XPC_SERVICE_NAME': '0', 15:01:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:16 INFO - Downloading/unpacking psutil>=0.7.1 15:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:01:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:19 INFO - Installing collected packages: psutil 15:01:19 INFO - Running setup.py install for psutil 15:01:19 INFO - building 'psutil._psutil_osx' extension 15:01:19 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 15:01:19 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 15:01:19 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 15:01:20 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 15:01:20 INFO - building 'psutil._psutil_posix' extension 15:01:20 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 15:01:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:01:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:01:20 INFO - ^ 15:01:20 INFO - 1 warning generated. 15:01:20 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 15:01:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:20 INFO - Successfully installed psutil 15:01:20 INFO - Cleaning up... 15:01:20 INFO - Return code: 0 15:01:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:01:20 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')]} 15:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:20 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')]} 15:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:20 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 0x10444aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044514c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d9ad9a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042eed30>, '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 0x104112db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042e5b20>, '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.Y8cNim4GfL/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.Kbolnk1Vvl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 15:01:20 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 15:01:20 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 15:01:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y8cNim4GfL/Render', 15:01:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:20 INFO - 'HOME': '/Users/cltbld', 15:01:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:20 INFO - 'LOGNAME': 'cltbld', 15:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:20 INFO - 'MOZ_NO_REMOTE': '1', 15:01:20 INFO - 'NO_EM_RESTART': '1', 15:01:20 INFO - 'PAGER': '/bin/cat', 15:01:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:20 INFO - 'PWD': '/builds/slave/test', 15:01:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:20 INFO - 'SHELL': '/bin/bash', 15:01:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Kbolnk1Vvl/Listeners', 15:01:20 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 15:01:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:20 INFO - 'USER': 'cltbld', 15:01:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:20 INFO - 'XPC_FLAGS': '0x0', 15:01:20 INFO - 'XPC_SERVICE_NAME': '0', 15:01:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:01:20 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 15:01:20 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 15:01:20 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 15:01:20 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 15:01:20 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 15:01:20 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 15:01:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:01:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:01:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:01:23 INFO - Installing collected packages: mozsystemmonitor 15:01:23 INFO - Running setup.py install for mozsystemmonitor 15:01:23 INFO - Successfully installed mozsystemmonitor 15:01:23 INFO - Cleaning up... 15:01:23 INFO - Return code: 0 15:01:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10444aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044514c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d9ad9a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042eed30>, '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 0x104112db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042e5b20>, '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.Y8cNim4GfL/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.Kbolnk1Vvl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 15:01:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:01:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:01:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y8cNim4GfL/Render', 15:01:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:23 INFO - 'HOME': '/Users/cltbld', 15:01:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:23 INFO - 'LOGNAME': 'cltbld', 15:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:23 INFO - 'MOZ_NO_REMOTE': '1', 15:01:23 INFO - 'NO_EM_RESTART': '1', 15:01:23 INFO - 'PAGER': '/bin/cat', 15:01:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:23 INFO - 'PWD': '/builds/slave/test', 15:01:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:23 INFO - 'SHELL': '/bin/bash', 15:01:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Kbolnk1Vvl/Listeners', 15:01:23 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 15:01:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:23 INFO - 'USER': 'cltbld', 15:01:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:23 INFO - 'XPC_FLAGS': '0x0', 15:01:23 INFO - 'XPC_SERVICE_NAME': '0', 15:01:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:23 INFO - Downloading/unpacking blobuploader==1.2.4 15:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:25 INFO - Downloading blobuploader-1.2.4.tar.gz 15:01:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:01:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:01:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01:27 INFO - Downloading docopt-0.6.1.tar.gz 15:01:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:01:27 INFO - Installing collected packages: blobuploader, requests, docopt 15:01:27 INFO - Running setup.py install for blobuploader 15:01:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:01:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:01:27 INFO - Running setup.py install for requests 15:01:27 INFO - Running setup.py install for docopt 15:01:27 INFO - Successfully installed blobuploader requests docopt 15:01:27 INFO - Cleaning up... 15:01:28 INFO - Return code: 0 15:01:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:28 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')]} 15:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:28 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')]} 15:01:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:28 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 0x10444aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044514c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d9ad9a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042eed30>, '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 0x104112db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042e5b20>, '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.Y8cNim4GfL/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.Kbolnk1Vvl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 15:01:28 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 15:01:28 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 15:01:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y8cNim4GfL/Render', 15:01:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:28 INFO - 'HOME': '/Users/cltbld', 15:01:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:28 INFO - 'LOGNAME': 'cltbld', 15:01:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:28 INFO - 'MOZ_NO_REMOTE': '1', 15:01:28 INFO - 'NO_EM_RESTART': '1', 15:01:28 INFO - 'PAGER': '/bin/cat', 15:01:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:28 INFO - 'PWD': '/builds/slave/test', 15:01:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:28 INFO - 'SHELL': '/bin/bash', 15:01:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Kbolnk1Vvl/Listeners', 15:01:28 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 15:01:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:28 INFO - 'USER': 'cltbld', 15:01:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:28 INFO - 'XPC_FLAGS': '0x0', 15:01:28 INFO - 'XPC_SERVICE_NAME': '0', 15:01:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:01:28 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-g7YdmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:01:28 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-aQLbQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:01:28 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-RjD9lZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:01:28 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-sqJK2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:01:28 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-2mnmDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:01:28 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-7a_2MS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:01:28 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-MjRXmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:01:29 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-21JN7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:01:29 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-INHNcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:01:29 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-4jfXnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:01:29 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-tgiruu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:01:29 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-HtFxX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:01:29 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-UQZ_aO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:01:29 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-XFVzsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:29 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-yKO9ki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:01:29 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-GMEwWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:01:29 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-9lwDhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:01:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:01:30 INFO - Running setup.py install for manifestparser 15:01:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:01:30 INFO - Running setup.py install for mozcrash 15:01:30 INFO - Running setup.py install for mozdebug 15:01:30 INFO - Running setup.py install for mozdevice 15:01:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:01:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:01:30 INFO - Running setup.py install for mozfile 15:01:30 INFO - Running setup.py install for mozhttpd 15:01:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:01:30 INFO - Running setup.py install for mozinfo 15:01:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:01:31 INFO - Running setup.py install for mozInstall 15:01:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:01:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:01:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:01:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:01:31 INFO - Running setup.py install for mozleak 15:01:31 INFO - Running setup.py install for mozlog 15:01:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:01:31 INFO - Running setup.py install for moznetwork 15:01:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:01:31 INFO - Running setup.py install for mozprocess 15:01:31 INFO - Running setup.py install for mozprofile 15:01:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:01:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:01:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:01:32 INFO - Running setup.py install for mozrunner 15:01:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:01:32 INFO - Running setup.py install for mozscreenshot 15:01:32 INFO - Running setup.py install for moztest 15:01:32 INFO - Running setup.py install for mozversion 15:01:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:01:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:01:32 INFO - Cleaning up... 15:01:32 INFO - Return code: 0 15:01:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:32 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')]} 15:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:32 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')]} 15:01:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:32 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 0x10444aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044514c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d9ad9a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042eed30>, '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 0x104112db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042e5b20>, '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.Y8cNim4GfL/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.Kbolnk1Vvl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 15:01:32 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 15:01:32 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 15:01:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y8cNim4GfL/Render', 15:01:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:32 INFO - 'HOME': '/Users/cltbld', 15:01:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:32 INFO - 'LOGNAME': 'cltbld', 15:01:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:32 INFO - 'MOZ_NO_REMOTE': '1', 15:01:32 INFO - 'NO_EM_RESTART': '1', 15:01:32 INFO - 'PAGER': '/bin/cat', 15:01:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:32 INFO - 'PWD': '/builds/slave/test', 15:01:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:32 INFO - 'SHELL': '/bin/bash', 15:01:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Kbolnk1Vvl/Listeners', 15:01:32 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 15:01:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:32 INFO - 'USER': 'cltbld', 15:01:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:32 INFO - 'XPC_FLAGS': '0x0', 15:01:32 INFO - 'XPC_SERVICE_NAME': '0', 15:01:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:01:32 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-HWufXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:01:33 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)) 15:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:01:33 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-_rbpNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:01:33 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)) 15:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:01:33 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-88pnBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:01:33 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)) 15:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:01:33 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-2TPPeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:01:33 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)) 15:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:01:33 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-y44bzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:01:33 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)) 15:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:01:33 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-n22mnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:01:33 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)) 15:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:01:33 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-zySJSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:01:33 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)) 15:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:01:33 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-rpzrqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:01:33 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)) 15:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:01:33 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-0zxQLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:01:33 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)) 15:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:01:33 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-k7_JL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:01:33 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)) 15:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:01:33 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-vL6yCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:01:34 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)) 15:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:01:34 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-vQKbYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:01:34 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)) 15:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:01:34 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-izkz76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:01:34 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)) 15:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:01:34 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-PFRG3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:01:34 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)) 15:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:34 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-mSdmNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:34 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)) 15:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:01:34 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-XYHZe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:01:34 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)) 15:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:01:34 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-5ccc8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:01:34 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)) 15:01:34 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)) 15:01:34 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)) 15:01:34 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)) 15:01:34 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)) 15:01:34 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)) 15:01:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:01:34 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 15:01:34 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 15:01:34 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 15:01:34 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 15:01:34 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 15:01:34 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 15:01:37 INFO - Downloading blessings-1.6.tar.gz 15:01:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:01:37 INFO - Installing collected packages: blessings 15:01:37 INFO - Running setup.py install for blessings 15:01:37 INFO - Successfully installed blessings 15:01:37 INFO - Cleaning up... 15:01:37 INFO - Return code: 0 15:01:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:01:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:01:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:01:37 INFO - Reading from file tmpfile_stdout 15:01:37 INFO - Current package versions: 15:01:37 INFO - blessings == 1.6 15:01:37 INFO - blobuploader == 1.2.4 15:01:37 INFO - docopt == 0.6.1 15:01:37 INFO - manifestparser == 1.1 15:01:37 INFO - mozInstall == 1.12 15:01:37 INFO - mozcrash == 0.16 15:01:37 INFO - mozdebug == 0.1 15:01:37 INFO - mozdevice == 0.48 15:01:37 INFO - mozfile == 1.2 15:01:37 INFO - mozhttpd == 0.7 15:01:37 INFO - mozinfo == 0.9 15:01:37 INFO - mozleak == 0.1 15:01:37 INFO - mozlog == 3.1 15:01:37 INFO - moznetwork == 0.27 15:01:37 INFO - mozprocess == 0.22 15:01:37 INFO - mozprofile == 0.28 15:01:37 INFO - mozrunner == 6.11 15:01:37 INFO - mozscreenshot == 0.1 15:01:37 INFO - mozsystemmonitor == 0.0 15:01:37 INFO - moztest == 0.7 15:01:37 INFO - mozversion == 1.4 15:01:37 INFO - psutil == 3.1.1 15:01:37 INFO - requests == 1.2.3 15:01:37 INFO - wsgiref == 0.1.2 15:01:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:37 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')]} 15:01:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:37 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')]} 15:01:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:37 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 0x10444aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044514c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d9ad9a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042eed30>, '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 0x104112db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042e5b20>, '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.Y8cNim4GfL/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.Kbolnk1Vvl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 15:01:37 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 15:01:37 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 15:01:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y8cNim4GfL/Render', 15:01:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:37 INFO - 'HOME': '/Users/cltbld', 15:01:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:37 INFO - 'LOGNAME': 'cltbld', 15:01:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:37 INFO - 'MOZ_NO_REMOTE': '1', 15:01:37 INFO - 'NO_EM_RESTART': '1', 15:01:37 INFO - 'PAGER': '/bin/cat', 15:01:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:37 INFO - 'PWD': '/builds/slave/test', 15:01:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:37 INFO - 'SHELL': '/bin/bash', 15:01:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Kbolnk1Vvl/Listeners', 15:01:37 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 15:01:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:37 INFO - 'USER': 'cltbld', 15:01:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:37 INFO - 'XPC_FLAGS': '0x0', 15:01:37 INFO - 'XPC_SERVICE_NAME': '0', 15:01:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:37 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)) 15:01:37 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)) 15:01:37 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)) 15:01:37 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)) 15:01:37 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)) 15:01:37 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)) 15:01:37 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)) 15:01:37 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)) 15:01:37 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)) 15:01:37 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)) 15:01:37 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)) 15:01:37 INFO - Cleaning up... 15:01:37 INFO - Return code: 0 15:01:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:01:37 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')]} 15:01:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:37 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')]} 15:01:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:37 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 0x10444aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044514c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d9ad9a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042eed30>, '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 0x104112db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042e5b20>, '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.Y8cNim4GfL/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.Kbolnk1Vvl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 15:01:37 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 15:01:37 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 15:01:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y8cNim4GfL/Render', 15:01:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:37 INFO - 'HOME': '/Users/cltbld', 15:01:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:37 INFO - 'LOGNAME': 'cltbld', 15:01:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:37 INFO - 'MOZ_NO_REMOTE': '1', 15:01:37 INFO - 'NO_EM_RESTART': '1', 15:01:37 INFO - 'PAGER': '/bin/cat', 15:01:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:37 INFO - 'PWD': '/builds/slave/test', 15:01:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:37 INFO - 'SHELL': '/bin/bash', 15:01:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Kbolnk1Vvl/Listeners', 15:01:37 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 15:01:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:37 INFO - 'USER': 'cltbld', 15:01:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:37 INFO - 'XPC_FLAGS': '0x0', 15:01:37 INFO - 'XPC_SERVICE_NAME': '0', 15:01:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:38 INFO - Downloading/unpacking jsonschema 15:01:38 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 15:01:38 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 15:01:38 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 15:01:38 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 15:01:38 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 15:01:38 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 15:01:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:01:40 INFO - Downloading/unpacking functools32 (from jsonschema) 15:01:40 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 15:01:40 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 15:01:40 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 15:01:40 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 15:01:40 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 15:01:40 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 15:01:40 INFO - Downloading functools32-3.2.3-2.tar.gz 15:01:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:01:40 INFO - warning: no files found matching '*.txt' 15:01:40 INFO - no previously-included directories found matching 'build' 15:01:40 INFO - no previously-included directories found matching 'dist' 15:01:40 INFO - no previously-included directories found matching '.git*' 15:01:40 INFO - Installing collected packages: jsonschema, functools32 15:01:40 INFO - Running setup.py install for functools32 15:01:41 INFO - warning: no files found matching '*.txt' 15:01:41 INFO - no previously-included directories found matching 'build' 15:01:41 INFO - no previously-included directories found matching 'dist' 15:01:41 INFO - no previously-included directories found matching '.git*' 15:01:41 INFO - Successfully installed jsonschema functools32 15:01:41 INFO - Cleaning up... 15:01:41 INFO - Return code: 0 15:01:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:41 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 0x10444aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044514c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d9ad9a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042eed30>, '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 0x104112db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042e5b20>, '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.Y8cNim4GfL/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.Kbolnk1Vvl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 15:01:41 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 15:01:41 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 15:01:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y8cNim4GfL/Render', 15:01:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:41 INFO - 'HOME': '/Users/cltbld', 15:01:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:41 INFO - 'LOGNAME': 'cltbld', 15:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:41 INFO - 'MOZ_NO_REMOTE': '1', 15:01:41 INFO - 'NO_EM_RESTART': '1', 15:01:41 INFO - 'PAGER': '/bin/cat', 15:01:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:41 INFO - 'PWD': '/builds/slave/test', 15:01:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:41 INFO - 'SHELL': '/bin/bash', 15:01:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Kbolnk1Vvl/Listeners', 15:01:41 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 15:01:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:41 INFO - 'USER': 'cltbld', 15:01:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:41 INFO - 'XPC_FLAGS': '0x0', 15:01:41 INFO - 'XPC_SERVICE_NAME': '0', 15:01:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:41 INFO - Downloading/unpacking flake8 15:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:01:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:01:43 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 15:01:43 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 15:01:43 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 15:01:43 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 15:01:43 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 15:01:43 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 15:01:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:01:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:01:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:01:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:01:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:01:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:01:44 INFO - no previously-included directories found matching 'docs/_build' 15:01:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:01:45 INFO - Running setup.py install for pep8 15:01:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:01:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:01:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:01:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:01:45 INFO - no previously-included directories found matching 'docs/_build' 15:01:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:01:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:01:45 INFO - Cleaning up... 15:01:45 INFO - Return code: 0 15:01:45 INFO - Running post-action listener: _resource_record_post_action 15:01:45 INFO - Running post-action listener: _start_resource_monitoring 15:01:45 INFO - Starting resource monitoring. 15:01:45 INFO - ##### 15:01:45 INFO - ##### Running install step. 15:01:45 INFO - ##### 15:01:45 INFO - Running pre-action listener: _resource_record_pre_action 15:01:45 INFO - Running main action method: install 15:01:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:01:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:01:45 INFO - Reading from file tmpfile_stdout 15:01:45 INFO - Detecting whether we're running mozinstall >=1.0... 15:01:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:01:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:01:45 INFO - Reading from file tmpfile_stdout 15:01:45 INFO - Output received: 15:01:45 INFO - Usage: mozinstall [options] installer 15:01:45 INFO - Options: 15:01:45 INFO - -h, --help show this help message and exit 15:01:45 INFO - -d DEST, --destination=DEST 15:01:45 INFO - Directory to install application into. [default: 15:01:45 INFO - "/builds/slave/test"] 15:01:45 INFO - --app=APP Application being installed. [default: firefox] 15:01:45 INFO - mkdir: /builds/slave/test/build/application 15:01:45 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'] 15:01:45 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 15:02:19 INFO - Reading from file tmpfile_stdout 15:02:19 INFO - Output received: 15:02:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:02:19 INFO - Running post-action listener: _resource_record_post_action 15:02:19 INFO - ##### 15:02:19 INFO - ##### Running run-tests step. 15:02:19 INFO - ##### 15:02:19 INFO - Running pre-action listener: _resource_record_pre_action 15:02:19 INFO - Running main action method: run_tests 15:02:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:02:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:02:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:02:19 INFO - 2016-02-16 15:02:19.752 screenresolution[1649:7452] starting screenresolution argv=screenresolution get 15:02:19 INFO - 2016-02-16 15:02:19.755 screenresolution[1649:7452] Display 0: 1600x1200x32@60 15:02:19 INFO - 2016-02-16 15:02:19.760 screenresolution[1650:7455] starting screenresolution argv=screenresolution list 15:02:19 INFO - Available Modes on Display 0 15:02:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:02:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:02:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:02:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:02:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:02:20 INFO - Intel Iris: 15:02:20 INFO - Chipset Model: Intel Iris 15:02:20 INFO - Type: GPU 15:02:20 INFO - Bus: Built-In 15:02:20 INFO - VRAM (Dynamic, Max): 1536 MB 15:02:20 INFO - Vendor: Intel (0x8086) 15:02:20 INFO - Device ID: 0x0a2e 15:02:20 INFO - Revision ID: 0x0009 15:02:20 INFO - Displays: 15:02:20 INFO - Display: 15:02:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:02:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:02:20 INFO - Display Serial Number: 1600x1200 60 15:02:20 INFO - Main Display: Yes 15:02:20 INFO - Mirror: Off 15:02:20 INFO - Online: Yes 15:02:20 INFO - Rotation: Supported 15:02:20 INFO - Return code: 0 15:02:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:02:20 INFO - Python 2.7.3 15:02:20 INFO - Return code: 0 15:02:20 INFO - grabbing minidump binary from tooltool 15:02:20 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')]} 15:02:20 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 0x1042eed30>, '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 0x104112db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042e5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:02:20 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 15:02:20 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 15:02:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:02:20 INFO - Return code: 0 15:02:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:02:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:02:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:02:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:02:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:02:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:02:21 INFO - Return code: 0 15:02:21 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/GhDMFqZZRPiL17ulMQ--VQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0115', '--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 15:02:21 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/GhDMFqZZRPiL17ulMQ--VQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0115 --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 15:02:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y8cNim4GfL/Render', 15:02:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:02:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:02:21 INFO - 'HOME': '/Users/cltbld', 15:02:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:02:21 INFO - 'LOGNAME': 'cltbld', 15:02:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:02:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:21 INFO - 'MOZ_NO_REMOTE': '1', 15:02:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:02:21 INFO - 'NO_EM_RESTART': '1', 15:02:21 INFO - 'PAGER': '/bin/cat', 15:02:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:21 INFO - 'PWD': '/builds/slave/test', 15:02:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:02:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:02:21 INFO - 'SHELL': '/bin/bash', 15:02:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Kbolnk1Vvl/Listeners', 15:02:21 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 15:02:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:02:21 INFO - 'USER': 'cltbld', 15:02:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:02:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:21 INFO - 'XPC_FLAGS': '0x0', 15:02:21 INFO - 'XPC_SERVICE_NAME': '0', 15:02:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:02:21 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/GhDMFqZZRPiL17ulMQ--VQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0115', '--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 15:02:21 INFO - mozversion application_buildid: 20160216140711 15:02:21 INFO - mozversion application_changeset: 39742e742b69087a03366c396d365e03e5df997d 15:02:21 INFO - mozversion application_display_name: Nightly 15:02:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:02:21 INFO - mozversion application_name: Firefox 15:02:21 INFO - mozversion application_remotingname: firefox 15:02:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:02:21 INFO - mozversion application_vendor: Mozilla 15:02:21 INFO - mozversion application_version: 47.0a1 15:02:21 INFO - mozversion platform_buildid: 20160216140711 15:02:21 INFO - mozversion platform_changeset: 39742e742b69087a03366c396d365e03e5df997d 15:02:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:02:21 INFO - mozversion platform_version: 47.0a1 15:02:21 INFO - using testdate: 1455663741 15:02:21 INFO - actual date: 1455663741 15:02:21 INFO - starting webserver on 'localhost:49279' 15:02:21 INFO - SUITE-START | Running 2 tests 15:02:21 INFO - TEST-START | dromaeo_css 15:02:21 INFO - operating with platform_type : mac_ 15:02:21 INFO - Initialising browser for dromaeo_css test... 15:02:21 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmprosxXT/profile http://localhost:49279/getInfo.html) 15:02:25 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 15:02:25 INFO - PROCESS | 1668 | colorDepth:24 15:02:25 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 15:02:25 INFO - PROCESS | 1668 | __metrics 15:02:25 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 15:02:25 INFO - TEST-INFO | 1668: exit 0 15:02:25 INFO - Browser initialized. 15:02:25 INFO - Running cycle 1/1 for dromaeo_css test... 15:02:25 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmprosxXT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:02:37 INFO - PROCESS | 1672 | RSS: Main: 256303104 15:02:37 INFO - PROCESS | 1672 | 15:03:27 INFO - PROCESS | 1672 | 1455663807460 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] 15:05:37 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 15:05:38 INFO - PROCESS | 1672 | RSS: Main: 270409728 15:05:38 INFO - PROCESS | 1672 | 15:08:40 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 15:08:41 INFO - PROCESS | 1672 | RSS: Main: 281411584 15:08:41 INFO - PROCESS | 1672 | 15:11:42 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 15:11:43 INFO - PROCESS | 1672 | RSS: Main: 282820608 15:11:43 INFO - PROCESS | 1672 | 15:14:45 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 15:14:45 INFO - PROCESS | 1672 | RSS: Main: 285437952 15:14:45 INFO - PROCESS | 1672 | 15:17:48 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 15:17:48 INFO - PROCESS | 1672 | RSS: Main: 286199808 15:17:48 INFO - PROCESS | 1672 | 15:20:51 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 15:20:51 INFO - PROCESS | 1672 | RSS: Main: 289349632 15:20:51 INFO - PROCESS | 1672 | 15:20:51 INFO - PROCESS | 1672 | __start_tp_report 15:20:51 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 15:20:51 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 15:20:51 INFO - PROCESS | 1672 | |i|pagename|runs| 15:20:51 INFO - PROCESS | 1672 | |0;dojo.html;2939.882844519083;2995.4458425191333;3204.6474887762342;3494.0740703713504;3535.6287589803087;4825.975870120649;5752.02215623344;5766.711664416784;5769.913451298234;5771.98990176719;4807.855764327067;5574.136008918614;5792.275965504301;5837.562182836283;5915.615484993483;5208.973955130219;5260.395054568736;5277.12927366984;5340.786368545273;5346.117890548055;339.50136458315296;5249.606279529032;5257.290265814105;5307.938412317532;5334.199870019509;4385.890352741191;5233.322706623087;5243.6853788772605;5250.789968401259;5259.0270799901755;5146.330976973007;5291.074062039128;5291.1798671206025;5307.124324486455;5310.62825602208;5052.444231134609;5169.095408303532;5213.765380557884;5220.817271395521;5237.947620523784;5604.355499117612;5655.208270842086;5667.093265077568;5712.857178570527;5739.942600573982;6132.50939924805;6142.529470848956;6176.413240742122;6181.103739957681;6225.906611400833;6164.4143806338325;6186.164867742842;6228.408301211378;6238;6241.469475094623;5849.18111464391;5850;5867.677277749722;5882.852928676817;5931.4661680448535;6165.10605962133;6185.134081228632;6250.062490626351;6260.280067792171;6275.748970041147;6134.877302453926;6142.01727723571;6144.2319710036245;6151.907721384183;6170.660613666201;6135.171751813537;6194.5973511721595;6220.942439785247;6261.812145635638;6269.96865015672;6246.063090536456;6255.718492667841;6258.718357673915;6285.962816135287;6308.211473565804;6169.475594574512;6270.3416141305415;6273.0904018917;6278.246610406689;6282.277538083087;4747.8100875965265;4812.783424745895;4874.439439464436;4897.094037603055;4908.705477671279;4414.404055452537;4419.845305414295;4420.160169567772;4425.247707889666;4457.153140903218;5585.329760428694;5635.464630860061;5644.040513112781;5671.404502527258;5780.046292361797;6185.783497577653;6186.226721659793;6198.597091189058;6217.347178546278;6232.501399887998;4638.512956139624;5247.58019358458;5659.830205093854;5672.376038635747;5741.25363702716;4375.146846364928;5346.866328341823;5385.8114965976;5386.299781028441;5445.700486473203;5246.711430871263;5737.913931291034;6273.466755325757;6278.183836101278;6281.214848143891;6140.938590614215;6152.046432802923;6155.72299246526;6199.845003874939;6243.687815609293;6139.447449729367;6235.095911092775;6295.18162638854;6339.96830015847;6363.3636636336;6055.303640081447;6111.99152139892;6135.355787642234;6137.478314343331;6151.169592105009;6107.46191531438;6127.036821038878;6223.626582405071;6230.376962303914;6238.157848690369;6087.695615219132;6121.910283036266;6125.632462052291;6159.476444502267;6186.4741496973265;5119.385673719177;6156.569040167145;6158.168647232566;6159.106929495288;6201.317855036033;4956;5861.413858614104;5894.410558944071;5943.643381396957;5984.431479009487;4763.4522029967;5448.673079615236;6156.415140561639;6177.4749146323065;6182.350853160354;5913.556483263858;6055.455009049207;6088.5737998341465;6098.75604975796;6120.969395152996 15:20:51 INFO - PROCESS | 1672 | |1;ext.html;446.80563954679735;462.946761122471;475.9238521836507;486.5110563883298;544.9836504904853;29077.709222907764;29817.701822981762;37571.24857502848;37736.811315943414;38012;39215.41176882342;39497.80251098748;39736.80131599345;39797.40303895444;39817.60182398175;9313.254939604849;9486.288528360401;9544.952275238615;9563.995780443058;9582.233421326311;9431.151196392324;9572.234221262283;9578.568964396583;9636.373635713691;9667.12995830375;9596.18432433244;9672.613095476172;9688.564014619358;9701.805963880719;9709.07763762445;9596.95201523995;9606.567704453317;9647.083527064917;9651.517424128766;9688.515574221296;9526.285528585384;9573.946865844751;9652.613895444174;9682.854757178648;9684.75788105296;38055.61944380548;38362.80818595917;38518.614813852066;38564.03589910247;38795.61204387948;2853.443578502193;2894.9276268093254;3068.171593669719;3647.598764135943;4064.878053658395;26861.462770744474;27613.171604851887;27704.445911081868;27825.165245042477;27917;2306.723193216808;2765.0045983445943;2783.846888421136;2807.1578526441986;2848.30216596933;333224.33387833147;335686;336348;336608.99999999756;336762;49291.767705807644;49599.760005999415;60598;60633;60884.69557652272;55048.72475637676;67755;68240;68344.6582767083;68782;16357.59106022335;16493.09287989172;16643.83356166423;16756.916215418845;16953.660926781395;12803;12850.293233872228;12893.226406415644;12927.224366538037;12972.935135324451;20633.484162895747;21211.833349165943;21247;21256.681149782766;21264.25575104864;6987.89518157228;8164.183581641788;8305.37709671777;8308.916910830936;8373.95813020931;931.7856892914532;979.8236317462926;990.5641517732175;1015.9847602285971;1057.117307048623;27647.723522764918;27660.50530460473;27764.72235277662;27879;28108.859455703;966.5988614724811;1080.702806728156;1086.5165001574223;1121.876593574706;1206.837076994612;13137.686231376785;14524.273786310641;14921.925390373195;15427.9200455967;15853.365865365487;511355;516033.83966160606;518666;518757.40621297405;519009;58747.41252587419;58781;58874.11688824671;58975.705121474115;59324;1385.6420707706302;1404.56458497866;1452.6223181972764;1461.9488317908822;1582.2009885007997;26626.201213963614;26971.325716857235;28857.567136493388;30416.69583304227;30706.385872282877;55278;55328.89342213214;56198.43801561932;56328;56619.71690141523;329425;330942;331918;332741;334184;31147.221319467193;31175.90884319038;31251.68748312488;31340.52989205118;31538.526922096647;44626.88432789206;45259;45728.08543829172;46497;46674.53325466702;35546.46680299746;36676.44985325276;37005.44491832571;37552;38256.426153607164;32964.34071318608;34889;35086.64913350834;35243;35389.11527211737;31568;34634.307313854086;36757.26485470222;37562;37957.810210948766;28750.281242968256;31832.840835795672;33085.503717443775;33279.6688132472;33313.167170820925;17278.740818887978;23604.52790944206;24118;24333.02667893335;24353.634695479228 15:20:51 INFO - PROCESS | 1672 | |2;jquery.html;303.61744202305096;346.9375512407767;352.51705163925425;356.16657022567205;368.86905148672236;15448.768268475982;19050.523736906584;19515.804841951613;19561.60876782465;20685.793142068593;19069.713954290695;20243.49391265219;20612.896935515302;20630.793692063075;20994;5804.767809287623;6100.2679678438535;6346.333634968331;6545.869082618345;6632.767853125141;6286.49708023357;6464.870702585969;6598.934010659904;6611.471082313404;6630.104935833673;6572.507061970347;6611.074449577063;6612.107365505643;6637.40263376296;6675.33246675331;6382.20222472191;6624.56940298879;6658.533902626818;6659.533832631718;6697.531172817905;5998.370171132012;6102.481289090432;6347.365263473662;6391.488680905516;6393.712282947278;26016.739832601812;26281;26478.470430591282;26941.46117077667;27049.729502705115;2308.4575124845646;2322.094383190557;2371.750966148547;2460;2501.124606387768;14906.552803415914;15497.922510387489;15780.368785248576;15882.602934926605;15923.840761592352;1800.4778614201866;1877.07084992928;1882.8023057578894;1931.8551108666766;1968.7539057617798;102208;104003;104085.47957260242;104174;105070.42394364091;16155.353785848669;16724.163791810362;17458.47624571265;18916.959567223934;19080.61838763217;12872.871271287355;13104.410301536454;13185.53850615243;13217.867821321855;27679.584806227922;6085.66528840918;8353.37349698775;8381.874271885927;8404.537750423786;8433.114522975122;8480.236778689825;8553.101924297984;8596.183362580545;8616.353773467015;8720.43317184381;3811.4854494643423;3905.941410878839;4362.345648152803;4408.845690400821;4522.208613492626;1828.6708392489213;1834.6789311870368;1904.9332373870677;1933.139752809986;1961.35275359134;893.4639216470066;894.1952242981239;896.878921345623;948.9003654616304;976.3019441099648;16733.414330498374;18561.72157417613;18765.90617046906;19374.128164232643;19986.90006549987;949.5619698444557;1006.9295149339476;1025.7538190834146;1047.8375851742992;1085.945702714861;10405.84391234132;10840.67477975662;10925.449229000607;11227.494762735696;11365.374904380338;705828;742582;745156;748264;748605;101533;103027;119161.40419298022;120430.3978480102;120825;1153.988460115405;1180.9468573914194;1195.988040119605;1198.1133960868895;1206.083376633747;17561.648767024333;18126.637467250846;18177.272909083487;18177.364282179275;18541.721874172166;39960;41274.79362603168;45859.31211031904;49673.50326496689;52441.47558524366;64818;66876.6656166716;71291.28708712847;73482;73999;10633.521491532745;11166.218364714392;11240.381779002233;11402.087832973508;11408.030317423112;12557.560485383334;12583.93708031454;12634.178778379375;12800.871991279968;12897.806532901826;6324.30432652417;7231.963840180765;7444.920486529531;7511.399088073051;7791;7321;7492.363149132167;7769.339606133316;7775.105862825621;7794.649240784292;7669.3864490841715;7723.9227607723205;7848.293653571206;7913.525188488709;7947.125816160334;10753.301035432673;10829.837552436562;10868.782624347627;10920.235583509397;11049;7278.053852999076;7987.281144697005;9096.772580685536;10894.346339219672;11020.173486988348 15:20:51 INFO - PROCESS | 1672 | |3;mootools.html;1536.2856271833598;1540.2760702469839;1793.5157507472982;1917.913693883775;1925.4897452175167;7381.003564518788;7952.284294413502;8747.475151490915;8893.377463577544;8911.465312081264;8236.67053317868;8633.870491942625;8650.740477785661;8798.560071996406;8837.734867953972;2447.449323902126;2463.4949835283724;2474.505098980202;2491.476789874129;2496.3883848457153;2419.2621250518587;2498.1631153563485;2515.6478093066985;2517.119008347073;2518.3955850595817;1916.79242077491;2352.8941197646145;2465.9753402466013;2496.463260399014;2506.160436253848;2460.520198561281;2480.9751902480925;2492.700875894895;2500.9996001599507;2503.912363067284;2476.2942561370105;2495.2264797912703;2496.5381404440236;2501.2871331670567;2508.2099138771227;8537.914620853837;8583.52790596517;8601.870971935426;8635.006974197984;8708.651653933899;5417.864553386157;5496.532794712414;5566.109422492382;5585.525230355424;5626.971865140648;3257.820819854907;3606.8376923038263;3642.8360723767496;3714.461403096563;3716.4982727332003;1064.9307794993301;1065.616378103882;1096.5394534295615;1097.917656175782;1103.227740581588;11933;11964.581239656658;12103.334316612583;12129.393530323448;12147;4211.578842115764;4580.977095114503;4833.951660483421;4999.900001999939;5073.34046573943;9602.615895364108;10287.948560257151;10353.275270730977;10390.584376625002;10450.843237351446;5441.646292990943;5443.156310771837;5462.317210348707;5485.177223416519;5548.500634942875;4927.556519913225;4987.80048798044;4996.775145118479;4998.425181104147;5001.274815151783;3860.536735591691;3878.1274213302345;3897.240038192582;3920.2747491714126;3934.5278566572197;1288.4588472841428;1305.549585393038;1309.07055990248;1309.9738005239842;1317.9802302965463;952.1288021460425;1079.4980334144661;1112.471576001409;1211.4124649544963;1361.836579610453;8053.073896501977;8055.234752698484;8083.9191608083165;8160.143184965612;8169.5506747129475;635.8442181665429;645.6545748024878;647.4464332995316;648.1153225846685;790.5533373643873;6019.608725432833;6177.567570270038;6232.532560058014;6232.56372053961;6232.688365581703;10373.533191006423;10485.68542943713;10603.363798172135;10764.730881728019;10824.35053896753;10470.214733894989;10507.106895913934;10538.841917371246;10547;10592.364458132382;8131.186881311822;8171.65167747315;8296.045954715164;8300.70947516834;8370.12113728062;7991.081025681889;8190.385721071063;8192.057913340042;8297.087320394872;8305.003399592088;9618.855717164388;9651.613935442503;9706.029397060238;9861.112499874758;9884.752881177741;9412.717618471457;9702.660406886007;10130.79738405213;10255.948720256649;10298.536565854705;6263.874722505616;7525;7569.280918312751;7569.772906812805;7577.696892124253;7946.443748937751;8160.795980100545;8174.468659537111;8220.58897055133;8225.506469611842;7004.684789184397;7741.032370953631;7743.4966727162555;7772.261635144652;7775.377969762519;7598.696052157852;7627.809304767426;7676.731314403969;7721.112072111779;7781.883271751041;7647.770566883002;7681.193474685301;7696.961515192388;7745.302922736981;7782.221777822172;6988.37104660583;7017.859642807218;7018.298170182941;7053.506254562131;7087.61018144007;6989.091418115612;7008.22909479967;7046.788596342118;7057.6471176442;7114.786556403316 15:20:51 INFO - PROCESS | 1672 | |4;prototype.html;319.63242271387907;325.1529764962273;325.16108440224224;331.5044009206237;333.49142557599674;6644.036614690879;6746.6626668666495;6822.420094291985;6836.316368363167;6849.315068493148;5759.942400575993;6414.647194404306;6717.7312907483765;6734.663266836651;6751.696173672184;4079.1433798902117;5041.319421878045;5041.798328066873;5056.241563765446;5060.898782024357;4994.525520075587;5078.669886457387;5109.233614957768;5121.487851214867;5138.152204886208;4944.480829512903;5032.446430892599;5053.5451809337155;5076.289319495274;5085.821996230133;5010.674306170124;5012.799488020475;5034.848954531351;5038.622103342245;5055.721935293557;4330;4330.9389199645975;4342.370356298351;4343.717658352229;4347.391365208873;5274.947250527484;6287.4655654269445;6574.572652777602;6582.539222254444;6604.702788374535;5912.822615321505;5917;5918.289805223358;5925.703714814242;5932.228810254683;6151.354107818659;6251.156093927307;7072.858542829166;7279.344858962719;7341.229170937028;3991.4012898065234;4207.684423668237;4776.952230477686;4832.371791667096;4833.709977401367;7681.692732290701;7687.577183254919;7695.461317707763;7696.461247712662;7737.381009519281;3641.708663306929;4847.394075740533;4882.5361590649545;4893.972265824145;4920.803167873317;4778.450478195052;4783.5933945614315;4787.539800360923;4788.664793464493;4791.976040119777;5716.485516303553;5731.742071606787;5748.425157484218;5759;5810.854728631818;7194.352508274281;7329.816754581178;7343.926560734324;7344.853102937911;7383.446241531799;1596.5449846793608;1645.1609679063763;1667.5580971042684;1668.5328108129743;1677.5302915183768;885.5129678676702;1060.4432672846663;1061.3207547169818;1066.3388699006666;1077.3482043363651;5392.272043274186;6386.808395748135;6617.272100068989;6710.496712746563;6719.958406447008;7536.397088232929;7540.245975402416;7543.170251272356;7551.207123252089;7558.848823023509;5410.567154627621;6493.805185844432;6633.668316584151;6672.5996440212775;6680.933190668031;3984.322665146932;3992.86024989124;3997.7401468904427;4008.4588580541836;4026.013626661428;6755.864882702318;7122.608256545836;7788.961055194801;7811.687532498637;7818.061832580127;6278.591891527036;7517.511361761577;7695.268949449794;7782.260685234894;7810.648520816577;7662.616869156632;7809.618066489775;7833;7841.882371764428;7852.607369631495;6683.231428385798;6949.652517374212;7608.0489938757655;7621.542707437571;7646.311831935152;7469.7385591504035;7474.962625187057;7488.5506869588;7490.588017659081;7491;7481.102267727908;7635.656395462106;7932.762017139495;7940.126586075643;8007.599620019092;4714.434267887876;4779.808807647655;4791.808327666854;4801.087793319258;4826.903461930671;6505.837354066186;7630.351420129351;7645.694172233048;7648.388128949782;7691.88462173079;5612.5509959202345;6048.5161187105805;7263.927360726537;7318.938753880764;7343.082114735658;7246.166690830411;7285.562866228043;7286.48994570375;7299.5620262784405;7299.890501642373;5772.5381969441505;6952.783262928866;7109.111361079865;7135.393491553276;7167.8924816126755;6153;7106.401059761512;7347.595882226529;7349.118105827335;7360.558366497813;7180.7845764627145;7197.928020719726;7202.063731715053;7207.747728829466;7226.349628533247 15:20:51 INFO - PROCESS | 1672 | |5;yui.html;722.609790713015;729.3982464466816;742.7251916790785;745.6793578761133;751.7143485475518;12220.694482637939;14331.06848054877;14817;14832.851671483282;14864.405423783062;13573.18560886345;13629.454821807116;15348.539543813675;15867.285972131252;15902.681946361095;684.729531834925;872.0320444306815;873.1312344217481;873.135595760196;879.6657270237301;701.6842420910585;841.5918279634373;847.3009766942266;878.2227728460326;893.1470445724318;892.9464232146059;901.2249465459699;903.9728808135767;916.8578870275118;918.7703074231442;911.7492689510372;913.3789023464042;914.9039350868163;916.5142474488532;918.485648037098;645.3546453546453;673.239239659182;677.4512644757762;682.8634273145391;683.282553319013;15114.319855606414;15171.924140379338;15268.465603703928;15312.234388280653;15327.080375177526;12674.936625316814;12737.617871463779;12770.87229127706;12787.424565894557;13201.471941122343;10268.127209187229;10372.94813525935;11019.779604407948;11419.086473082134;11576.652700419001;3523.260115375774;3525.453554699026;3526.5415495985358;3536.504889315498;3675.5956844747056;75431.62284188544;75770.62114689447;76654.23345766526;77242.6137869307;77617;9251.398659087137;9419.811603767886;9493.430394176372;9544.0455954404;9943.502824858728;20219.898900505403;20529.973501325174;20536.07587658529;20564.280250191172;20576.176952922015;6027.035674292092;6254.312025677172;7255.600941948243;7430.145533263636;7430.517016393917;4133.81397837098;4199.475065616798;4209.17921005401;4260.55264197261;4268.205044332392;3552.5914519830035;3557.4130268505924;3565;3571.053670777246;3595.802230877327;591.2638764737928;679.6296018669836;691.5712258399724;700.4571457120772;711.1608302203449;574.8965186266512;591.795830438498;603.2730559675581;616.3128112154915;629.1412222316596;8172.264496195371;8430.367722420842;9118.544072796334;9147.222486088624;9581.329306948446;505.84824552634797;533.7624756983183;599.7630935780343;620.3052581109187;633.1073186806581;3932.1545867638597;3996.480457540501;4041.1715598302276;4100.36444351126;4108.609682080198;83407.5829620848;84299.57850210709;84328.15671843325;86228;91798;78516.4296714074;79721.40557188824;80894;80983.19016809875;83033.58483207667;69085.96371054438;69483.65258173677;69661;70495.99999999898;70553.23616909618;8124.593770311342;8152.062512811102;8210.83578328442;8354.122817104117;8369.204925532065;48219.276710848666;48907.510924890295;49003;49143.262851057974;49283.26075108805;64818.67590662016;69031;69444.65277673579;70565.64717176382;71359.43202839942;9954.701358959242;9959.850602241117;10030.34802737849;10091.69724908254;10402.635907743193;10122.696319110439;10605;11028.448577570929;11125.888741112485;11831.408429578314;10304.793904121725;10684.89315106839;10764.515596798006;10848.620298289521;10970.067544258827;10646.988536089058;10655.57377704883;10684.145268378667;10808.675739727822;10862.619808306672;10405.687829365132;10526.947365263431;10582.417967011888;10757.408342541235;11040.558377664804;7743.380529557735;8999.955000224956;9130.360874738704;9377.296702747457;9572.856407154037;7796.337311328373;9630.422174669542;9868.704955681069;9869.555869986012;9908.653197138066 15:20:51 INFO - PROCESS | 1672 | __end_tp_report 15:20:51 INFO - PROCESS | 1672 | __start_cc_report 15:20:51 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,361 15:20:51 INFO - PROCESS | 1672 | __end_cc_report 15:20:51 INFO - PROCESS | 1672 | __startTimestamp1455664851638__endTimestamp 15:20:51 INFO - PROCESS | 1672 | 15:20:51 INFO - PROCESS | 1672 | ------- Summary: start ------- 15:20:51 INFO - PROCESS | 1672 | Number of tests: 6 15:20:51 INFO - PROCESS | 1672 | 15:20:51 INFO - PROCESS | 1672 | [#0] dojo.html Cycles:165 Average:5655.29 Median:5915.62 stddev:798.60 (13.5%) stddev-sans-first:772.11 15:20:51 INFO - PROCESS | 1672 | Values: 2939.9 2995.4 3204.6 3494.1 3535.6 4826.0 5752.0 5766.7 5769.9 5772.0 4807.9 5574.1 5792.3 5837.6 5915.6 5209.0 5260.4 5277.1 5340.8 5346.1 339.5 5249.6 5257.3 5307.9 5334.2 4385.9 5233.3 5243.7 5250.8 5259.0 5146.3 5291.1 5291.2 5307.1 5310.6 5052.4 5169.1 5213.8 5220.8 5237.9 5604.4 5655.2 5667.1 5712.9 5739.9 6132.5 6142.5 6176.4 6181.1 6225.9 6164.4 6186.2 6228.4 6238.0 6241.5 5849.2 5850.0 5867.7 5882.9 5931.5 6165.1 6185.1 6250.1 6260.3 6275.7 6134.9 6142.0 6144.2 6151.9 6170.7 6135.2 6194.6 6220.9 6261.8 6270.0 6246.1 6255.7 6258.7 6286.0 6308.2 6169.5 6270.3 6273.1 6278.2 6282.3 4747.8 4812.8 4874.4 4897.1 4908.7 4414.4 4419.8 4420.2 4425.2 4457.2 5585.3 5635.5 5644.0 5671.4 5780.0 6185.8 6186.2 6198.6 6217.3 6232.5 4638.5 5247.6 5659.8 5672.4 5741.3 4375.1 5346.9 5385.8 5386.3 5445.7 5246.7 5737.9 6273.5 6278.2 6281.2 6140.9 6152.0 6155.7 6199.8 6243.7 6139.4 6235.1 6295.2 6340.0 6363.4 6055.3 6112.0 6135.4 6137.5 6151.2 6107.5 6127.0 6223.6 6230.4 6238.2 6087.7 6121.9 6125.6 6159.5 6186.5 5119.4 6156.6 6158.2 6159.1 6201.3 4956.0 5861.4 5894.4 5943.6 5984.4 4763.5 5448.7 6156.4 6177.5 6182.4 5913.6 6055.5 6088.6 6098.8 6121.0 15:20:51 INFO - PROCESS | 1672 | 15:20:51 INFO - PROCESS | 1672 | [#1] ext.html Cycles:180 Average:55234.53 Median:36716.86 stddev:107139.44 (291.8%) stddev-sans-first:107361.03 15:20:51 INFO - PROCESS | 1672 | Values: 446.8 462.9 475.9 486.5 545.0 29077.7 29817.7 37571.2 37736.8 38012.0 39215.4 39497.8 39736.8 39797.4 39817.6 9313.3 9486.3 9545.0 9564.0 9582.2 9431.2 9572.2 9578.6 9636.4 9667.1 9596.2 9672.6 9688.6 9701.8 9709.1 9597.0 9606.6 9647.1 9651.5 9688.5 9526.3 9573.9 9652.6 9682.9 9684.8 38055.6 38362.8 38518.6 38564.0 38795.6 2853.4 2894.9 3068.2 3647.6 4064.9 26861.5 27613.2 27704.4 27825.2 27917.0 2306.7 2765.0 2783.8 2807.2 2848.3 333224.3 335686.0 336348.0 336609.0 336762.0 49291.8 49599.8 60598.0 60633.0 60884.7 55048.7 67755.0 68240.0 68344.7 68782.0 16357.6 16493.1 16643.8 16756.9 16953.7 12803.0 12850.3 12893.2 12927.2 12972.9 20633.5 21211.8 21247.0 21256.7 21264.3 6987.9 8164.2 8305.4 8308.9 8374.0 931.8 979.8 990.6 1016.0 1057.1 27647.7 27660.5 27764.7 27879.0 28108.9 966.6 1080.7 1086.5 1121.9 1206.8 13137.7 14524.3 14921.9 15427.9 15853.4 511355.0 516033.8 518666.0 518757.4 519009.0 58747.4 58781.0 58874.1 58975.7 59324.0 1385.6 1404.6 1452.6 1461.9 1582.2 26626.2 26971.3 28857.6 30416.7 30706.4 55278.0 55328.9 56198.4 56328.0 56619.7 329425.0 330942.0 331918.0 332741.0 334184.0 31147.2 31175.9 31251.7 31340.5 31538.5 44626.9 45259.0 45728.1 46497.0 46674.5 35546.5 36676.4 37005.4 37552.0 38256.4 32964.3 34889.0 35086.6 35243.0 35389.1 31568.0 34634.3 36757.3 37562.0 37957.8 28750.3 31832.8 33085.5 33279.7 33313.2 17278.7 23604.5 24118.0 24333.0 24353.6 15:20:51 INFO - PROCESS | 1672 | 15:20:51 INFO - PROCESS | 1672 | [#2] jquery.html Cycles:180 Average:37862.48 Median:26148.87 stddev:121477.22 (464.6%) stddev-sans-first:121785.25 15:20:51 INFO - PROCESS | 1672 | Values: 303.6 346.9 352.5 356.2 368.9 15448.8 19050.5 19515.8 19561.6 20685.8 19069.7 20243.5 20612.9 20630.8 20994.0 5804.8 6100.3 6346.3 6545.9 6632.8 6286.5 6464.9 6598.9 6611.5 6630.1 6572.5 6611.1 6612.1 6637.4 6675.3 6382.2 6624.6 6658.5 6659.5 6697.5 5998.4 6102.5 6347.4 6391.5 6393.7 26016.7 26281.0 26478.5 26941.5 27049.7 2308.5 2322.1 2371.8 2460.0 2501.1 14906.6 15497.9 15780.4 15882.6 15923.8 1800.5 1877.1 1882.8 1931.9 1968.8 102208.0 104003.0 104085.5 104174.0 105070.4 16155.4 16724.2 17458.5 18917.0 19080.6 12872.9 13104.4 13185.5 13217.9 27679.6 6085.7 8353.4 8381.9 8404.5 8433.1 8480.2 8553.1 8596.2 8616.4 8720.4 3811.5 3905.9 4362.3 4408.8 4522.2 1828.7 1834.7 1904.9 1933.1 1961.4 893.5 894.2 896.9 948.9 976.3 16733.4 18561.7 18765.9 19374.1 19986.9 949.6 1006.9 1025.8 1047.8 1085.9 10405.8 10840.7 10925.4 11227.5 11365.4 705828.0 742582.0 745156.0 748264.0 748605.0 101533.0 103027.0 119161.4 120430.4 120825.0 1154.0 1180.9 1196.0 1198.1 1206.1 17561.6 18126.6 18177.3 18177.4 18541.7 39960.0 41274.8 45859.3 49673.5 52441.5 64818.0 66876.7 71291.3 73482.0 73999.0 10633.5 11166.2 11240.4 11402.1 11408.0 12557.6 12583.9 12634.2 12800.9 12897.8 6324.3 7232.0 7444.9 7511.4 7791.0 7321.0 7492.4 7769.3 7775.1 7794.6 7669.4 7723.9 7848.3 7913.5 7947.1 10753.3 10829.8 10868.8 10920.2 11049.0 7278.1 7987.3 9096.8 10894.3 11020.2 15:20:51 INFO - PROCESS | 1672 | 15:20:51 INFO - PROCESS | 1672 | [#3] mootools.html Cycles:180 Average:6068.59 Median:5490.86 stddev:3214.64 (58.5%) stddev-sans-first:3205.61 15:20:51 INFO - PROCESS | 1672 | Values: 1536.3 1540.3 1793.5 1917.9 1925.5 7381.0 7952.3 8747.5 8893.4 8911.5 8236.7 8633.9 8650.7 8798.6 8837.7 2447.4 2463.5 2474.5 2491.5 2496.4 2419.3 2498.2 2515.6 2517.1 2518.4 1916.8 2352.9 2466.0 2496.5 2506.2 2460.5 2481.0 2492.7 2501.0 2503.9 2476.3 2495.2 2496.5 2501.3 2508.2 8537.9 8583.5 8601.9 8635.0 8708.7 5417.9 5496.5 5566.1 5585.5 5627.0 3257.8 3606.8 3642.8 3714.5 3716.5 1064.9 1065.6 1096.5 1097.9 1103.2 11933.0 11964.6 12103.3 12129.4 12147.0 4211.6 4581.0 4834.0 4999.9 5073.3 9602.6 10287.9 10353.3 10390.6 10450.8 5441.6 5443.2 5462.3 5485.2 5548.5 4927.6 4987.8 4996.8 4998.4 5001.3 3860.5 3878.1 3897.2 3920.3 3934.5 1288.5 1305.5 1309.1 1310.0 1318.0 952.1 1079.5 1112.5 1211.4 1361.8 8053.1 8055.2 8083.9 8160.1 8169.6 635.8 645.7 647.4 648.1 790.6 6019.6 6177.6 6232.5 6232.6 6232.7 10373.5 10485.7 10603.4 10764.7 10824.4 10470.2 10507.1 10538.8 10547.0 10592.4 8131.2 8171.7 8296.0 8300.7 8370.1 7991.1 8190.4 8192.1 8297.1 8305.0 9618.9 9651.6 9706.0 9861.1 9884.8 9412.7 9702.7 10130.8 10255.9 10298.5 6263.9 7525.0 7569.3 7569.8 7577.7 7946.4 8160.8 8174.5 8220.6 8225.5 7004.7 7741.0 7743.5 7772.3 7775.4 7598.7 7627.8 7676.7 7721.1 7781.9 7647.8 7681.2 7697.0 7745.3 7782.2 6988.4 7017.9 7018.3 7053.5 7087.6 6989.1 7008.2 7046.8 7057.6 7114.8 15:20:51 INFO - PROCESS | 1672 | 15:20:51 INFO - PROCESS | 1672 | [#4] prototype.html Cycles:180 Average:5866.65 Median:6578.56 stddev:1887.13 (28.7%) stddev-sans-first:1845.93 15:20:51 INFO - PROCESS | 1672 | Values: 319.6 325.2 325.2 331.5 333.5 6644.0 6746.7 6822.4 6836.3 6849.3 5759.9 6414.6 6717.7 6734.7 6751.7 4079.1 5041.3 5041.8 5056.2 5060.9 4994.5 5078.7 5109.2 5121.5 5138.2 4944.5 5032.4 5053.5 5076.3 5085.8 5010.7 5012.8 5034.8 5038.6 5055.7 4330.0 4330.9 4342.4 4343.7 4347.4 5274.9 6287.5 6574.6 6582.5 6604.7 5912.8 5917.0 5918.3 5925.7 5932.2 6151.4 6251.2 7072.9 7279.3 7341.2 3991.4 4207.7 4777.0 4832.4 4833.7 7681.7 7687.6 7695.5 7696.5 7737.4 3641.7 4847.4 4882.5 4894.0 4920.8 4778.5 4783.6 4787.5 4788.7 4792.0 5716.5 5731.7 5748.4 5759.0 5810.9 7194.4 7329.8 7343.9 7344.9 7383.4 1596.5 1645.2 1667.6 1668.5 1677.5 885.5 1060.4 1061.3 1066.3 1077.3 5392.3 6386.8 6617.3 6710.5 6720.0 7536.4 7540.2 7543.2 7551.2 7558.8 5410.6 6493.8 6633.7 6672.6 6680.9 3984.3 3992.9 3997.7 4008.5 4026.0 6755.9 7122.6 7789.0 7811.7 7818.1 6278.6 7517.5 7695.3 7782.3 7810.6 7662.6 7809.6 7833.0 7841.9 7852.6 6683.2 6949.7 7608.0 7621.5 7646.3 7469.7 7475.0 7488.6 7490.6 7491.0 7481.1 7635.7 7932.8 7940.1 8007.6 4714.4 4779.8 4791.8 4801.1 4826.9 6505.8 7630.4 7645.7 7648.4 7691.9 5612.6 6048.5 7263.9 7318.9 7343.1 7246.2 7285.6 7286.5 7299.6 7299.9 5772.5 6952.8 7109.1 7135.4 7167.9 6153.0 7106.4 7347.6 7349.1 7360.6 7180.8 7197.9 7202.1 7207.7 7226.3 15:20:51 INFO - PROCESS | 1672 | 15:20:51 INFO - PROCESS | 1672 | [#5] yui.html Cycles:180 Average:17965.51 Median:639.23 stddev:25149.55 (3934.3%) stddev-sans-first:25186.77 15:20:51 INFO - PROCESS | 1672 | Values: 722.6 729.4 742.7 745.7 751.7 12220.7 14331.1 14817.0 14832.9 14864.4 13573.2 13629.5 15348.5 15867.3 15902.7 684.7 872.0 873.1 873.1 879.7 701.7 841.6 847.3 878.2 893.1 892.9 901.2 904.0 916.9 918.8 911.7 913.4 914.9 916.5 918.5 645.4 673.2 677.5 682.9 683.3 15114.3 15171.9 15268.5 15312.2 15327.1 12674.9 12737.6 12770.9 12787.4 13201.5 10268.1 10372.9 11019.8 11419.1 11576.7 3523.3 3525.5 3526.5 3536.5 3675.6 75431.6 75770.6 76654.2 77242.6 77617.0 9251.4 9419.8 9493.4 9544.0 9943.5 20219.9 20530.0 20536.1 20564.3 20576.2 6027.0 6254.3 7255.6 7430.1 7430.5 4133.8 4199.5 4209.2 4260.6 4268.2 3552.6 3557.4 3565.0 3571.1 3595.8 591.3 679.6 691.6 700.5 711.2 574.9 591.8 603.3 616.3 629.1 8172.3 8430.4 9118.5 9147.2 9581.3 505.8 533.8 599.8 620.3 633.1 3932.2 3996.5 4041.2 4100.4 4108.6 83407.6 84299.6 84328.2 86228.0 91798.0 78516.4 79721.4 80894.0 80983.2 83033.6 69086.0 69483.7 69661.0 70496.0 70553.2 8124.6 8152.1 8210.8 8354.1 8369.2 48219.3 48907.5 49003.0 49143.3 49283.3 64818.7 69031.0 69444.7 70565.6 71359.4 9954.7 9959.9 10030.3 10091.7 10402.6 10122.7 10605.0 11028.4 11125.9 11831.4 10304.8 10684.9 10764.5 10848.6 10970.1 10647.0 10655.6 10684.1 10808.7 10862.6 10405.7 10526.9 10582.4 10757.4 11040.6 7743.4 9000.0 9130.4 9377.3 9572.9 7796.3 9630.4 9868.7 9869.6 9908.7 15:20:51 INFO - PROCESS | 1672 | -------- Summary: end -------- 15:20:51 INFO - PROCESS | 1672 | 15:20:52 INFO - TEST-INFO | 1672: exit 0 15:20:52 INFO - TEST-OK | dromaeo_css | took 1110209ms 15:20:52 INFO - TEST-START | kraken 15:20:52 INFO - operating with platform_type : mac_ 15:20:52 INFO - Initialising browser for kraken test... 15:20:52 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmpn8V1Mh/profile http://localhost:49279/getInfo.html) 15:20:54 INFO - PROCESS | 1684 | __metrics Screen width/height:1600/1200 15:20:54 INFO - PROCESS | 1684 | colorDepth:24 15:20:54 INFO - PROCESS | 1684 | Browser inner width/height: 1024/689 15:20:54 INFO - PROCESS | 1684 | __metrics 15:20:55 ERROR - PROCESS | 1684 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 15:20:55 INFO - TEST-INFO | 1684: exit 0 15:20:55 INFO - Browser initialized. 15:20:55 INFO - Running cycle 1/1 for kraken test... 15:20:55 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmpn8V1Mh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:21:07 INFO - PROCESS | 1687 | RSS: Main: 256376832 15:21:07 INFO - PROCESS | 1687 | 15:21:10 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 15:21:11 INFO - PROCESS | 1687 | RSS: Main: 269025280 15:21:11 INFO - PROCESS | 1687 | 15:21:13 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 15:21:14 INFO - PROCESS | 1687 | RSS: Main: 276496384 15:21:14 INFO - PROCESS | 1687 | 15:21:17 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 15:21:18 INFO - PROCESS | 1687 | RSS: Main: 280756224 15:21:18 INFO - PROCESS | 1687 | 15:21:20 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 15:21:20 INFO - PROCESS | 1687 | RSS: Main: 282902528 15:21:20 INFO - PROCESS | 1687 | 15:21:22 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:21:23 INFO - PROCESS | 1687 | RSS: Main: 284188672 15:21:23 INFO - PROCESS | 1687 | 15:21:26 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 15:21:26 INFO - PROCESS | 1687 | RSS: Main: 283353088 15:21:26 INFO - PROCESS | 1687 | 15:21:29 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 15:21:30 INFO - PROCESS | 1687 | RSS: Main: 283238400 15:21:30 INFO - PROCESS | 1687 | 15:21:33 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 15:21:34 INFO - PROCESS | 1687 | RSS: Main: 283734016 15:21:34 INFO - PROCESS | 1687 | 15:21:35 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:21:36 INFO - PROCESS | 1687 | RSS: Main: 283488256 15:21:36 INFO - PROCESS | 1687 | 15:21:38 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:21:38 INFO - PROCESS | 1687 | RSS: Main: 284504064 15:21:38 INFO - PROCESS | 1687 | 15:21:41 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:21:41 INFO - PROCESS | 1687 | RSS: Main: 284459008 15:21:41 INFO - PROCESS | 1687 | 15:21:44 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:21:44 INFO - PROCESS | 1687 | RSS: Main: 284217344 15:21:44 INFO - PROCESS | 1687 | 15:21:47 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:21:48 INFO - PROCESS | 1687 | RSS: Main: 283303936 15:21:48 INFO - PROCESS | 1687 | 15:21:49 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 15:21:49 INFO - PROCESS | 1687 | RSS: Main: 285622272 15:21:49 INFO - PROCESS | 1687 | 15:21:49 INFO - PROCESS | 1687 | __start_tp_report 15:21:49 INFO - PROCESS | 1687 | _x_x_mozilla_page_load 15:21:49 INFO - PROCESS | 1687 | _x_x_mozilla_page_load_details 15:21:49 INFO - PROCESS | 1687 | |i|pagename|runs| 15:21:49 INFO - PROCESS | 1687 | |0;ai-astar;117;109;114;115;116;126;116;131;166;156 15:21:49 INFO - PROCESS | 1687 | |1;audio-beat-detection;154;122;147;185;122;150;124;107;188;155 15:21:49 INFO - PROCESS | 1687 | |2;audio-dft;191;197;200;195;206;213;234;195;206;194 15:21:49 INFO - PROCESS | 1687 | |3;audio-fft;71;70;78;141;58;49;69;90;150;58 15:21:49 INFO - PROCESS | 1687 | |4;audio-oscillator;85;89;114;80;84;95;155;101;81;115 15:21:49 INFO - PROCESS | 1687 | |5;imaging-gaussian-blur;88;93;124;95;89;100;131;117;89;96 15:21:49 INFO - PROCESS | 1687 | |6;imaging-darkroom;95;98;96;111;125;98;122;112;153;153 15:21:49 INFO - PROCESS | 1687 | |7;imaging-desaturate;143;149;91;98;88;103;146;143;92;91 15:21:49 INFO - PROCESS | 1687 | |8;json-parse-financial;57;56;60;78;82;88;86;84;56;56 15:21:49 INFO - PROCESS | 1687 | |9;json-stringify-tinderbox;64;66;74;66;76;71;70;68;65;67 15:21:49 INFO - PROCESS | 1687 | |10;stanford-crypto-aes;85;84;92;72;112;113;73;67;86;116 15:21:49 INFO - PROCESS | 1687 | |11;stanford-crypto-ccm;128;123;142;133;134;137;121;127;127;107 15:21:49 INFO - PROCESS | 1687 | |12;stanford-crypto-pbkdf2;148;156;141;124;128;145;184;178;139;137 15:21:49 INFO - PROCESS | 1687 | |13;stanford-crypto-sha256-iterative;68;67;69;66;67;66;66;68;69;66 15:21:49 INFO - PROCESS | 1687 | __end_tp_report 15:21:49 INFO - PROCESS | 1687 | __start_cc_report 15:21:49 INFO - PROCESS | 1687 | _x_x_mozilla_cycle_collect,881 15:21:49 INFO - PROCESS | 1687 | __end_cc_report 15:21:49 INFO - PROCESS | 1687 | __startTimestamp1455664909959__endTimestamp 15:21:49 INFO - PROCESS | 1687 | 15:21:49 INFO - PROCESS | 1687 | ------- Summary: start ------- 15:21:49 INFO - PROCESS | 1687 | Number of tests: 14 15:21:49 INFO - PROCESS | 1687 | 15:21:49 INFO - PROCESS | 1687 | [#0] ai-astar Cycles:10 Average:126.60 Median:121.50 stddev:19.31 (15.9%) stddev-sans-first:20.17 15:21:49 INFO - PROCESS | 1687 | Values: 117.0 109.0 114.0 115.0 116.0 126.0 116.0 131.0 166.0 156.0 15:21:49 INFO - PROCESS | 1687 | 15:21:49 INFO - PROCESS | 1687 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:152.00 stddev:27.08 (17.8%) stddev-sans-first:28.54 15:21:49 INFO - PROCESS | 1687 | Values: 154.0 122.0 147.0 185.0 122.0 150.0 124.0 107.0 188.0 155.0 15:21:49 INFO - PROCESS | 1687 | 15:21:49 INFO - PROCESS | 1687 | [#2] audio-dft Cycles:10 Average:203.10 Median:203.00 stddev:12.81 (6.3%) stddev-sans-first:12.82 15:21:49 INFO - PROCESS | 1687 | Values: 191.0 197.0 200.0 195.0 206.0 213.0 234.0 195.0 206.0 194.0 15:21:49 INFO - PROCESS | 1687 | 15:21:49 INFO - PROCESS | 1687 | [#3] audio-fft Cycles:10 Average:83.40 Median:69.50 stddev:34.71 (49.9%) stddev-sans-first:36.52 15:21:49 INFO - PROCESS | 1687 | Values: 71.0 70.0 78.0 141.0 58.0 49.0 69.0 90.0 150.0 58.0 15:21:49 INFO - PROCESS | 1687 | 15:21:49 INFO - PROCESS | 1687 | [#4] audio-oscillator Cycles:10 Average:99.90 Median:82.50 stddev:23.18 (28.1%) stddev-sans-first:23.95 15:21:49 INFO - PROCESS | 1687 | Values: 85.0 89.0 114.0 80.0 84.0 95.0 155.0 101.0 81.0 115.0 15:21:49 INFO - PROCESS | 1687 | 15:21:49 INFO - PROCESS | 1687 | [#5] imaging-gaussian-blur Cycles:10 Average:102.20 Median:89.00 stddev:15.82 (17.8%) stddev-sans-first:15.93 15:21:49 INFO - PROCESS | 1687 | Values: 88.0 93.0 124.0 95.0 89.0 100.0 131.0 117.0 89.0 96.0 15:21:49 INFO - PROCESS | 1687 | 15:21:49 INFO - PROCESS | 1687 | [#6] imaging-darkroom Cycles:10 Average:116.30 Median:124.00 stddev:22.07 (17.8%) stddev-sans-first:22.02 15:21:49 INFO - PROCESS | 1687 | Values: 95.0 98.0 96.0 111.0 125.0 98.0 122.0 112.0 153.0 153.0 15:21:49 INFO - PROCESS | 1687 | 15:21:49 INFO - PROCESS | 1687 | [#7] imaging-desaturate Cycles:10 Average:114.40 Median:89.50 stddev:26.92 (30.1%) stddev-sans-first:26.49 15:21:49 INFO - PROCESS | 1687 | Values: 143.0 149.0 91.0 98.0 88.0 103.0 146.0 143.0 92.0 91.0 15:21:49 INFO - PROCESS | 1687 | 15:21:49 INFO - PROCESS | 1687 | [#8] json-parse-financial Cycles:10 Average:70.30 Median:80.00 stddev:14.30 (17.9%) stddev-sans-first:14.33 15:21:49 INFO - PROCESS | 1687 | Values: 57.0 56.0 60.0 78.0 82.0 88.0 86.0 84.0 56.0 56.0 15:21:49 INFO - PROCESS | 1687 | 15:21:49 INFO - PROCESS | 1687 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:3.97 (5.8%) stddev-sans-first:3.83 15:21:49 INFO - PROCESS | 1687 | Values: 64.0 66.0 74.0 66.0 76.0 71.0 70.0 68.0 65.0 67.0 15:21:49 INFO - PROCESS | 1687 | 15:21:49 INFO - PROCESS | 1687 | [#10] stanford-crypto-aes Cycles:10 Average:90.00 Median:78.50 stddev:17.99 (22.9%) stddev-sans-first:18.99 15:21:49 INFO - PROCESS | 1687 | Values: 85.0 84.0 92.0 72.0 112.0 113.0 73.0 67.0 86.0 116.0 15:21:49 INFO - PROCESS | 1687 | 15:21:49 INFO - PROCESS | 1687 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:130.50 stddev:9.75 (7.5%) stddev-sans-first:10.34 15:21:49 INFO - PROCESS | 1687 | Values: 128.0 123.0 142.0 133.0 134.0 137.0 121.0 127.0 127.0 107.0 15:21:49 INFO - PROCESS | 1687 | 15:21:49 INFO - PROCESS | 1687 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.00 Median:146.50 stddev:19.71 (13.5%) stddev-sans-first:20.90 15:21:49 INFO - PROCESS | 1687 | Values: 148.0 156.0 141.0 124.0 128.0 145.0 184.0 178.0 139.0 137.0 15:21:49 INFO - PROCESS | 1687 | 15:21:49 INFO - PROCESS | 1687 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.23 (1.8%) stddev-sans-first:1.27 15:21:49 INFO - PROCESS | 1687 | Values: 68.0 67.0 69.0 66.0 67.0 66.0 66.0 68.0 69.0 66.0 15:21:49 INFO - PROCESS | 1687 | -------- Summary: end -------- 15:21:49 INFO - PROCESS | 1687 | 15:21:50 INFO - TEST-INFO | 1687: exit 0 15:21:50 INFO - TEST-OK | kraken | took 58603ms 15:21:50 INFO - SUITE-END | took 1168s 15:21:51 INFO - Completed test suite (00:19:29) 15:21:51 INFO - Working with test: dromaeo_css 15:21:51 INFO - Generating results file: dromaeo_css 15:21:51 INFO - Working with test: kraken 15:21:51 INFO - Generating results file: kraken 15:21:51 INFO - javascript benchmark 15:21:51 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:21:51 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 15:21:51 INFO - process_Request line: dromaeo_css 7511.83 graph.html#tests=[[72,64,61]] 15:21:51 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:21:51 INFO - process_Request line: kraken 1563.40 graph.html#tests=[[232,64,61]] 15:21:51 INFO - RETURN: dromaeo_css: 7511.83 15:21:51 INFO - RETURN: kraken: 1563.40 15:21:51 INFO - javascript benchmark 15:21:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2939.882844519083, 2995.4458425191333, 3204.6474887762342, 3494.0740703713504, 3535.6287589803087, 4825.975870120649, 5752.02215623344, 5766.711664416784, 5769.913451298234, 5771.98990176719, 4807.855764327067, 5574.136008918614, 5792.275965504301, 5837.562182836283, 5915.615484993483, 5208.973955130219, 5260.395054568736, 5277.12927366984, 5340.786368545273, 5346.117890548055, 339.50136458315296, 5249.606279529032, 5257.290265814105, 5307.938412317532, 5334.199870019509, 4385.890352741191, 5233.322706623087, 5243.6853788772605, 5250.789968401259, 5259.0270799901755, 5146.330976973007, 5291.074062039128, 5291.1798671206025, 5307.124324486455, 5310.62825602208, 5052.444231134609, 5169.095408303532, 5213.765380557884, 5220.817271395521, 5237.947620523784, 5604.355499117612, 5655.208270842086, 5667.093265077568, 5712.857178570527, 5739.942600573982, 6132.50939924805, 6142.529470848956, 6176.413240742122, 6181.103739957681, 6225.906611400833, 6164.4143806338325, 6186.164867742842, 6228.408301211378, 6238.0, 6241.469475094623, 5849.18111464391, 5850.0, 5867.677277749722, 5882.852928676817, 5931.4661680448535, 6165.10605962133, 6185.134081228632, 6250.062490626351, 6260.280067792171, 6275.748970041147, 6134.877302453926, 6142.01727723571, 6144.2319710036245, 6151.907721384183, 6170.660613666201, 6135.171751813537, 6194.5973511721595, 6220.942439785247, 6261.812145635638, 6269.96865015672, 6246.063090536456, 6255.718492667841, 6258.718357673915, 6285.962816135287, 6308.211473565804, 6169.475594574512, 6270.3416141305415, 6273.0904018917, 6278.246610406689, 6282.277538083087, 4747.8100875965265, 4812.783424745895, 4874.439439464436, 4897.094037603055, 4908.705477671279, 4414.404055452537, 4419.845305414295, 4420.160169567772, 4425.247707889666, 4457.153140903218, 5585.329760428694, 5635.464630860061, 5644.040513112781, 5671.404502527258, 5780.046292361797, 6185.783497577653, 6186.226721659793, 6198.597091189058, 6217.347178546278, 6232.501399887998, 4638.512956139624, 5247.58019358458, 5659.830205093854, 5672.376038635747, 5741.25363702716, 4375.146846364928, 5346.866328341823, 5385.8114965976, 5386.299781028441, 5445.700486473203, 5246.711430871263, 5737.913931291034, 6273.466755325757, 6278.183836101278, 6281.214848143891, 6140.938590614215, 6152.046432802923, 6155.72299246526, 6199.845003874939, 6243.687815609293, 6139.447449729367, 6235.095911092775, 6295.18162638854, 6339.96830015847, 6363.3636636336, 6055.303640081447, 6111.99152139892, 6135.355787642234, 6137.478314343331, 6151.169592105009, 6107.46191531438, 6127.036821038878, 6223.626582405071, 6230.376962303914, 6238.157848690369, 6087.695615219132, 6121.910283036266, 6125.632462052291, 6159.476444502267, 6186.4741496973265, 5119.385673719177, 6156.569040167145, 6158.168647232566, 6159.106929495288, 6201.317855036033, 4956.0, 5861.413858614104, 5894.410558944071, 5943.643381396957, 5984.431479009487, 4763.4522029967, 5448.673079615236, 6156.415140561639, 6177.4749146323065, 6182.350853160354, 5913.556483263858, 6055.455009049207, 6088.5737998341465, 6098.75604975796, 6120.969395152996], "unit": "score", "name": "dojo.html", "value": 5606.441701879525}, {"lowerIsBetter": false, "replicates": [446.80563954679735, 462.946761122471, 475.9238521836507, 486.5110563883298, 544.9836504904853, 29077.709222907764, 29817.701822981762, 37571.24857502848, 37736.811315943414, 38012.0, 39215.41176882342, 39497.80251098748, 39736.80131599345, 39797.40303895444, 39817.60182398175, 9313.254939604849, 9486.288528360401, 9544.952275238615, 9563.995780443058, 9582.233421326311, 9431.151196392324, 9572.234221262283, 9578.568964396583, 9636.373635713691, 9667.12995830375, 9596.18432433244, 9672.613095476172, 9688.564014619358, 9701.805963880719, 9709.07763762445, 9596.95201523995, 9606.567704453317, 9647.083527064917, 9651.517424128766, 9688.515574221296, 9526.285528585384, 9573.946865844751, 9652.613895444174, 9682.854757178648, 9684.75788105296, 38055.61944380548, 38362.80818595917, 38518.614813852066, 38564.03589910247, 38795.61204387948, 2853.443578502193, 2894.9276268093254, 3068.171593669719, 3647.598764135943, 4064.878053658395, 26861.462770744474, 27613.171604851887, 27704.445911081868, 27825.165245042477, 27917.0, 2306.723193216808, 2765.0045983445943, 2783.846888421136, 2807.1578526441986, 2848.30216596933, 333224.33387833147, 335686.0, 336348.0, 336608.99999999756, 336762.0, 49291.767705807644, 49599.760005999415, 60598.0, 60633.0, 60884.69557652272, 55048.72475637676, 67755.0, 68240.0, 68344.6582767083, 68782.0, 16357.59106022335, 16493.09287989172, 16643.83356166423, 16756.916215418845, 16953.660926781395, 12803.0, 12850.293233872228, 12893.226406415644, 12927.224366538037, 12972.935135324451, 20633.484162895747, 21211.833349165943, 21247.0, 21256.681149782766, 21264.25575104864, 6987.89518157228, 8164.183581641788, 8305.37709671777, 8308.916910830936, 8373.95813020931, 931.7856892914532, 979.8236317462926, 990.5641517732175, 1015.9847602285971, 1057.117307048623, 27647.723522764918, 27660.50530460473, 27764.72235277662, 27879.0, 28108.859455703, 966.5988614724811, 1080.702806728156, 1086.5165001574223, 1121.876593574706, 1206.837076994612, 13137.686231376785, 14524.273786310641, 14921.925390373195, 15427.9200455967, 15853.365865365487, 511355.0, 516033.83966160606, 518666.0, 518757.40621297405, 519009.0, 58747.41252587419, 58781.0, 58874.11688824671, 58975.705121474115, 59324.0, 1385.6420707706302, 1404.56458497866, 1452.6223181972764, 1461.9488317908822, 1582.2009885007997, 26626.201213963614, 26971.325716857235, 28857.567136493388, 30416.69583304227, 30706.385872282877, 55278.0, 55328.89342213214, 56198.43801561932, 56328.0, 56619.71690141523, 329425.0, 330942.0, 331918.0, 332741.0, 334184.0, 31147.221319467193, 31175.90884319038, 31251.68748312488, 31340.52989205118, 31538.526922096647, 44626.88432789206, 45259.0, 45728.08543829172, 46497.0, 46674.53325466702, 35546.46680299746, 36676.44985325276, 37005.44491832571, 37552.0, 38256.426153607164, 32964.34071318608, 34889.0, 35086.64913350834, 35243.0, 35389.11527211737, 31568.0, 34634.307313854086, 36757.26485470222, 37562.0, 37957.810210948766, 28750.281242968256, 31832.840835795672, 33085.503717443775, 33279.6688132472, 33313.167170820925, 17278.740818887978, 23604.52790944206, 24118.0, 24333.02667893335, 24353.634695479228], "unit": "score", "name": "ext.html", "value": 19039.3630589668}, {"lowerIsBetter": false, "replicates": [303.61744202305096, 346.9375512407767, 352.51705163925425, 356.16657022567205, 368.86905148672236, 15448.768268475982, 19050.523736906584, 19515.804841951613, 19561.60876782465, 20685.793142068593, 19069.713954290695, 20243.49391265219, 20612.896935515302, 20630.793692063075, 20994.0, 5804.767809287623, 6100.2679678438535, 6346.333634968331, 6545.869082618345, 6632.767853125141, 6286.49708023357, 6464.870702585969, 6598.934010659904, 6611.471082313404, 6630.104935833673, 6572.507061970347, 6611.074449577063, 6612.107365505643, 6637.40263376296, 6675.33246675331, 6382.20222472191, 6624.56940298879, 6658.533902626818, 6659.533832631718, 6697.531172817905, 5998.370171132012, 6102.481289090432, 6347.365263473662, 6391.488680905516, 6393.712282947278, 26016.739832601812, 26281.0, 26478.470430591282, 26941.46117077667, 27049.729502705115, 2308.4575124845646, 2322.094383190557, 2371.750966148547, 2460.0, 2501.124606387768, 14906.552803415914, 15497.922510387489, 15780.368785248576, 15882.602934926605, 15923.840761592352, 1800.4778614201866, 1877.07084992928, 1882.8023057578894, 1931.8551108666766, 1968.7539057617798, 102208.0, 104003.0, 104085.47957260242, 104174.0, 105070.42394364091, 16155.353785848669, 16724.163791810362, 17458.47624571265, 18916.959567223934, 19080.61838763217, 12872.871271287355, 13104.410301536454, 13185.53850615243, 13217.867821321855, 27679.584806227922, 6085.66528840918, 8353.37349698775, 8381.874271885927, 8404.537750423786, 8433.114522975122, 8480.236778689825, 8553.101924297984, 8596.183362580545, 8616.353773467015, 8720.43317184381, 3811.4854494643423, 3905.941410878839, 4362.345648152803, 4408.845690400821, 4522.208613492626, 1828.6708392489213, 1834.6789311870368, 1904.9332373870677, 1933.139752809986, 1961.35275359134, 893.4639216470066, 894.1952242981239, 896.878921345623, 948.9003654616304, 976.3019441099648, 16733.414330498374, 18561.72157417613, 18765.90617046906, 19374.128164232643, 19986.90006549987, 949.5619698444557, 1006.9295149339476, 1025.7538190834146, 1047.8375851742992, 1085.945702714861, 10405.84391234132, 10840.67477975662, 10925.449229000607, 11227.494762735696, 11365.374904380338, 705828.0, 742582.0, 745156.0, 748264.0, 748605.0, 101533.0, 103027.0, 119161.40419298022, 120430.3978480102, 120825.0, 1153.988460115405, 1180.9468573914194, 1195.988040119605, 1198.1133960868895, 1206.083376633747, 17561.648767024333, 18126.637467250846, 18177.272909083487, 18177.364282179275, 18541.721874172166, 39960.0, 41274.79362603168, 45859.31211031904, 49673.50326496689, 52441.47558524366, 64818.0, 66876.6656166716, 71291.28708712847, 73482.0, 73999.0, 10633.521491532745, 11166.218364714392, 11240.381779002233, 11402.087832973508, 11408.030317423112, 12557.560485383334, 12583.93708031454, 12634.178778379375, 12800.871991279968, 12897.806532901826, 6324.30432652417, 7231.963840180765, 7444.920486529531, 7511.399088073051, 7791.0, 7321.0, 7492.363149132167, 7769.339606133316, 7775.105862825621, 7794.649240784292, 7669.3864490841715, 7723.9227607723205, 7848.293653571206, 7913.525188488709, 7947.125816160334, 10753.301035432673, 10829.837552436562, 10868.782624347627, 10920.235583509397, 11049.0, 7278.053852999076, 7987.281144697005, 9096.772580685536, 10894.346339219672, 11020.173486988348], "unit": "score", "name": "jquery.html", "value": 9676.988851304563}, {"lowerIsBetter": false, "replicates": [1536.2856271833598, 1540.2760702469839, 1793.5157507472982, 1917.913693883775, 1925.4897452175167, 7381.003564518788, 7952.284294413502, 8747.475151490915, 8893.377463577544, 8911.465312081264, 8236.67053317868, 8633.870491942625, 8650.740477785661, 8798.560071996406, 8837.734867953972, 2447.449323902126, 2463.4949835283724, 2474.505098980202, 2491.476789874129, 2496.3883848457153, 2419.2621250518587, 2498.1631153563485, 2515.6478093066985, 2517.119008347073, 2518.3955850595817, 1916.79242077491, 2352.8941197646145, 2465.9753402466013, 2496.463260399014, 2506.160436253848, 2460.520198561281, 2480.9751902480925, 2492.700875894895, 2500.9996001599507, 2503.912363067284, 2476.2942561370105, 2495.2264797912703, 2496.5381404440236, 2501.2871331670567, 2508.2099138771227, 8537.914620853837, 8583.52790596517, 8601.870971935426, 8635.006974197984, 8708.651653933899, 5417.864553386157, 5496.532794712414, 5566.109422492382, 5585.525230355424, 5626.971865140648, 3257.820819854907, 3606.8376923038263, 3642.8360723767496, 3714.461403096563, 3716.4982727332003, 1064.9307794993301, 1065.616378103882, 1096.5394534295615, 1097.917656175782, 1103.227740581588, 11933.0, 11964.581239656658, 12103.334316612583, 12129.393530323448, 12147.0, 4211.578842115764, 4580.977095114503, 4833.951660483421, 4999.900001999939, 5073.34046573943, 9602.615895364108, 10287.948560257151, 10353.275270730977, 10390.584376625002, 10450.843237351446, 5441.646292990943, 5443.156310771837, 5462.317210348707, 5485.177223416519, 5548.500634942875, 4927.556519913225, 4987.80048798044, 4996.775145118479, 4998.425181104147, 5001.274815151783, 3860.536735591691, 3878.1274213302345, 3897.240038192582, 3920.2747491714126, 3934.5278566572197, 1288.4588472841428, 1305.549585393038, 1309.07055990248, 1309.9738005239842, 1317.9802302965463, 952.1288021460425, 1079.4980334144661, 1112.471576001409, 1211.4124649544963, 1361.836579610453, 8053.073896501977, 8055.234752698484, 8083.9191608083165, 8160.143184965612, 8169.5506747129475, 635.8442181665429, 645.6545748024878, 647.4464332995316, 648.1153225846685, 790.5533373643873, 6019.608725432833, 6177.567570270038, 6232.532560058014, 6232.56372053961, 6232.688365581703, 10373.533191006423, 10485.68542943713, 10603.363798172135, 10764.730881728019, 10824.35053896753, 10470.214733894989, 10507.106895913934, 10538.841917371246, 10547.0, 10592.364458132382, 8131.186881311822, 8171.65167747315, 8296.045954715164, 8300.70947516834, 8370.12113728062, 7991.081025681889, 8190.385721071063, 8192.057913340042, 8297.087320394872, 8305.003399592088, 9618.855717164388, 9651.613935442503, 9706.029397060238, 9861.112499874758, 9884.752881177741, 9412.717618471457, 9702.660406886007, 10130.79738405213, 10255.948720256649, 10298.536565854705, 6263.874722505616, 7525.0, 7569.280918312751, 7569.772906812805, 7577.696892124253, 7946.443748937751, 8160.795980100545, 8174.468659537111, 8220.58897055133, 8225.506469611842, 7004.684789184397, 7741.032370953631, 7743.4966727162555, 7772.261635144652, 7775.377969762519, 7598.696052157852, 7627.809304767426, 7676.731314403969, 7721.112072111779, 7781.883271751041, 7647.770566883002, 7681.193474685301, 7696.961515192388, 7745.302922736981, 7782.221777822172, 6988.37104660583, 7017.859642807218, 7018.298170182941, 7053.506254562131, 7087.61018144007, 6989.091418115612, 7008.22909479967, 7046.788596342118, 7057.6471176442, 7114.786556403316], "unit": "score", "name": "mootools.html", "value": 4887.921516667296}, {"lowerIsBetter": false, "replicates": [319.63242271387907, 325.1529764962273, 325.16108440224224, 331.5044009206237, 333.49142557599674, 6644.036614690879, 6746.6626668666495, 6822.420094291985, 6836.316368363167, 6849.315068493148, 5759.942400575993, 6414.647194404306, 6717.7312907483765, 6734.663266836651, 6751.696173672184, 4079.1433798902117, 5041.319421878045, 5041.798328066873, 5056.241563765446, 5060.898782024357, 4994.525520075587, 5078.669886457387, 5109.233614957768, 5121.487851214867, 5138.152204886208, 4944.480829512903, 5032.446430892599, 5053.5451809337155, 5076.289319495274, 5085.821996230133, 5010.674306170124, 5012.799488020475, 5034.848954531351, 5038.622103342245, 5055.721935293557, 4330.0, 4330.9389199645975, 4342.370356298351, 4343.717658352229, 4347.391365208873, 5274.947250527484, 6287.4655654269445, 6574.572652777602, 6582.539222254444, 6604.702788374535, 5912.822615321505, 5917.0, 5918.289805223358, 5925.703714814242, 5932.228810254683, 6151.354107818659, 6251.156093927307, 7072.858542829166, 7279.344858962719, 7341.229170937028, 3991.4012898065234, 4207.684423668237, 4776.952230477686, 4832.371791667096, 4833.709977401367, 7681.692732290701, 7687.577183254919, 7695.461317707763, 7696.461247712662, 7737.381009519281, 3641.708663306929, 4847.394075740533, 4882.5361590649545, 4893.972265824145, 4920.803167873317, 4778.450478195052, 4783.5933945614315, 4787.539800360923, 4788.664793464493, 4791.976040119777, 5716.485516303553, 5731.742071606787, 5748.425157484218, 5759.0, 5810.854728631818, 7194.352508274281, 7329.816754581178, 7343.926560734324, 7344.853102937911, 7383.446241531799, 1596.5449846793608, 1645.1609679063763, 1667.5580971042684, 1668.5328108129743, 1677.5302915183768, 885.5129678676702, 1060.4432672846663, 1061.3207547169818, 1066.3388699006666, 1077.3482043363651, 5392.272043274186, 6386.808395748135, 6617.272100068989, 6710.496712746563, 6719.958406447008, 7536.397088232929, 7540.245975402416, 7543.170251272356, 7551.207123252089, 7558.848823023509, 5410.567154627621, 6493.805185844432, 6633.668316584151, 6672.5996440212775, 6680.933190668031, 3984.322665146932, 3992.86024989124, 3997.7401468904427, 4008.4588580541836, 4026.013626661428, 6755.864882702318, 7122.608256545836, 7788.961055194801, 7811.687532498637, 7818.061832580127, 6278.591891527036, 7517.511361761577, 7695.268949449794, 7782.260685234894, 7810.648520816577, 7662.616869156632, 7809.618066489775, 7833.0, 7841.882371764428, 7852.607369631495, 6683.231428385798, 6949.652517374212, 7608.0489938757655, 7621.542707437571, 7646.311831935152, 7469.7385591504035, 7474.962625187057, 7488.5506869588, 7490.588017659081, 7491.0, 7481.102267727908, 7635.656395462106, 7932.762017139495, 7940.126586075643, 8007.599620019092, 4714.434267887876, 4779.808807647655, 4791.808327666854, 4801.087793319258, 4826.903461930671, 6505.837354066186, 7630.351420129351, 7645.694172233048, 7648.388128949782, 7691.88462173079, 5612.5509959202345, 6048.5161187105805, 7263.927360726537, 7318.938753880764, 7343.082114735658, 7246.166690830411, 7285.562866228043, 7286.48994570375, 7299.5620262784405, 7299.890501642373, 5772.5381969441505, 6952.783262928866, 7109.111361079865, 7135.393491553276, 7167.8924816126755, 6153.0, 7106.401059761512, 7347.595882226529, 7349.118105827335, 7360.558366497813, 7180.7845764627145, 7197.928020719726, 7202.063731715053, 7207.747728829466, 7226.349628533247], "unit": "score", "name": "prototype.html", "value": 5232.360914668867}, {"lowerIsBetter": false, "replicates": [722.609790713015, 729.3982464466816, 742.7251916790785, 745.6793578761133, 751.7143485475518, 12220.694482637939, 14331.06848054877, 14817.0, 14832.851671483282, 14864.405423783062, 13573.18560886345, 13629.454821807116, 15348.539543813675, 15867.285972131252, 15902.681946361095, 684.729531834925, 872.0320444306815, 873.1312344217481, 873.135595760196, 879.6657270237301, 701.6842420910585, 841.5918279634373, 847.3009766942266, 878.2227728460326, 893.1470445724318, 892.9464232146059, 901.2249465459699, 903.9728808135767, 916.8578870275118, 918.7703074231442, 911.7492689510372, 913.3789023464042, 914.9039350868163, 916.5142474488532, 918.485648037098, 645.3546453546453, 673.239239659182, 677.4512644757762, 682.8634273145391, 683.282553319013, 15114.319855606414, 15171.924140379338, 15268.465603703928, 15312.234388280653, 15327.080375177526, 12674.936625316814, 12737.617871463779, 12770.87229127706, 12787.424565894557, 13201.471941122343, 10268.127209187229, 10372.94813525935, 11019.779604407948, 11419.086473082134, 11576.652700419001, 3523.260115375774, 3525.453554699026, 3526.5415495985358, 3536.504889315498, 3675.5956844747056, 75431.62284188544, 75770.62114689447, 76654.23345766526, 77242.6137869307, 77617.0, 9251.398659087137, 9419.811603767886, 9493.430394176372, 9544.0455954404, 9943.502824858728, 20219.898900505403, 20529.973501325174, 20536.07587658529, 20564.280250191172, 20576.176952922015, 6027.035674292092, 6254.312025677172, 7255.600941948243, 7430.145533263636, 7430.517016393917, 4133.81397837098, 4199.475065616798, 4209.17921005401, 4260.55264197261, 4268.205044332392, 3552.5914519830035, 3557.4130268505924, 3565.0, 3571.053670777246, 3595.802230877327, 591.2638764737928, 679.6296018669836, 691.5712258399724, 700.4571457120772, 711.1608302203449, 574.8965186266512, 591.795830438498, 603.2730559675581, 616.3128112154915, 629.1412222316596, 8172.264496195371, 8430.367722420842, 9118.544072796334, 9147.222486088624, 9581.329306948446, 505.84824552634797, 533.7624756983183, 599.7630935780343, 620.3052581109187, 633.1073186806581, 3932.1545867638597, 3996.480457540501, 4041.1715598302276, 4100.36444351126, 4108.609682080198, 83407.5829620848, 84299.57850210709, 84328.15671843325, 86228.0, 91798.0, 78516.4296714074, 79721.40557188824, 80894.0, 80983.19016809875, 83033.58483207667, 69085.96371054438, 69483.65258173677, 69661.0, 70495.99999999898, 70553.23616909618, 8124.593770311342, 8152.062512811102, 8210.83578328442, 8354.122817104117, 8369.204925532065, 48219.276710848666, 48907.510924890295, 49003.0, 49143.262851057974, 49283.26075108805, 64818.67590662016, 69031.0, 69444.65277673579, 70565.64717176382, 71359.43202839942, 9954.701358959242, 9959.850602241117, 10030.34802737849, 10091.69724908254, 10402.635907743193, 10122.696319110439, 10605.0, 11028.448577570929, 11125.888741112485, 11831.408429578314, 10304.793904121725, 10684.89315106839, 10764.515596798006, 10848.620298289521, 10970.067544258827, 10646.988536089058, 10655.57377704883, 10684.145268378667, 10808.675739727822, 10862.619808306672, 10405.687829365132, 10526.947365263431, 10582.417967011888, 10757.408342541235, 11040.558377664804, 7743.380529557735, 8999.955000224956, 9130.360874738704, 9377.296702747457, 9572.856407154037, 7796.337311328373, 9630.422174669542, 9868.704955681069, 9869.555869986012, 9908.653197138066], "unit": "score", "name": "yui.html", "value": 6800.485639989038}], "name": "dromaeo_css", "value": 7511.833681046198}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 109.0, 114.0, 115.0, 116.0, 126.0, 116.0, 131.0, 166.0, 156.0], "unit": "score", "name": "ai-astar", "value": 126.6}, {"lowerIsBetter": true, "replicates": [154.0, 122.0, 147.0, 185.0, 122.0, 150.0, 124.0, 107.0, 188.0, 155.0], "unit": "score", "name": "audio-beat-detection", "value": 145.4}, {"lowerIsBetter": true, "replicates": [191.0, 197.0, 200.0, 195.0, 206.0, 213.0, 234.0, 195.0, 206.0, 194.0], "unit": "score", "name": "audio-dft", "value": 203.1}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 78.0, 141.0, 58.0, 49.0, 69.0, 90.0, 150.0, 58.0], "unit": "score", "name": "audio-fft", "value": 83.4}, {"lowerIsBetter": true, "replicates": [85.0, 89.0, 114.0, 80.0, 84.0, 95.0, 155.0, 101.0, 81.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 99.9}, {"lowerIsBetter": true, "replicates": [88.0, 93.0, 124.0, 95.0, 89.0, 100.0, 131.0, 117.0, 89.0, 96.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 102.2}, {"lowerIsBetter": true, "replicates": [95.0, 98.0, 96.0, 111.0, 125.0, 98.0, 122.0, 112.0, 153.0, 153.0], "unit": "score", "name": "imaging-darkroom", "value": 116.3}, {"lowerIsBetter": true, "replicates": [143.0, 149.0, 91.0, 98.0, 88.0, 103.0, 146.0, 143.0, 92.0, 91.0], "unit": "score", "name": "imaging-desaturate", "value": 114.4}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 60.0, 78.0, 82.0, 88.0, 86.0, 84.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 70.3}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 74.0, 66.0, 76.0, 71.0, 70.0, 68.0, 65.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 92.0, 72.0, 112.0, 113.0, 73.0, 67.0, 86.0, 116.0], "unit": "score", "name": "stanford-crypto-aes", "value": 90.0}, {"lowerIsBetter": true, "replicates": [128.0, 123.0, 142.0, 133.0, 134.0, 137.0, 121.0, 127.0, 127.0, 107.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.9}, {"lowerIsBetter": true, "replicates": [148.0, 156.0, 141.0, 124.0, 128.0, 145.0, 184.0, 178.0, 139.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.0}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 69.0, 66.0, 67.0, 66.0, 66.0, 68.0, 69.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1563.4}]} 15:21:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1563.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7511.83"}}} 15:21:51 INFO - Return code: 0 15:21:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:21:51 ERROR - # TBPL SUCCESS # 15:21:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:21:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:21:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:21:51 INFO - 2016-02-16 15:21:51.365 screenresolution[1692:10289] starting screenresolution argv=screenresolution get 15:21:51 INFO - 2016-02-16 15:21:51.368 screenresolution[1692:10289] Display 0: 1600x1200x32@60 15:21:51 INFO - 2016-02-16 15:21:51.374 screenresolution[1693:10292] starting screenresolution argv=screenresolution list 15:21:51 INFO - Available Modes on Display 0 15:21:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:21:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:21:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:21:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:21:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:21:51 INFO - Intel Iris: 15:21:51 INFO - Chipset Model: Intel Iris 15:21:51 INFO - Type: GPU 15:21:51 INFO - Bus: Built-In 15:21:51 INFO - VRAM (Dynamic, Max): 1536 MB 15:21:51 INFO - Vendor: Intel (0x8086) 15:21:51 INFO - Device ID: 0x0a2e 15:21:51 INFO - Revision ID: 0x0009 15:21:51 INFO - Displays: 15:21:51 INFO - Display: 15:21:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:21:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:21:51 INFO - Display Serial Number: 1600x1200 60 15:21:51 INFO - Main Display: Yes 15:21:51 INFO - Mirror: Off 15:21:51 INFO - Online: Yes 15:21:51 INFO - Rotation: Supported 15:21:51 INFO - Return code: 0 15:21:51 INFO - Running post-action listener: _resource_record_post_action 15:21:51 INFO - Running post-run listener: _resource_record_post_run 15:21:52 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 39241216; Write bytes: 709774336; Read time: 424; Write time: 2017 15:21:52 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 399456768; Write bytes: 393332736; Read time: 29787; Write time: 685 15:21:52 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 37426688; Write bytes: 302781440; Read time: 404; Write time: 1294 15:21:52 INFO - Running post-run listener: _upload_blobber_files 15:21:52 INFO - Blob upload gear active. 15:21:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:21:52 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 15:21:52 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'] 15:21:52 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 15:21:53 INFO - (blobuploader) - INFO - Open directory for files ... 15:21:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:21:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:21:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:21:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:21:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:21:54 INFO - (blobuploader) - INFO - Done attempting. 15:21:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:21:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:21:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:21:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:21:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:21:55 INFO - (blobuploader) - INFO - Done attempting. 15:21:55 INFO - (blobuploader) - INFO - Iteration through files over. 15:21:55 INFO - Return code: 0 15:21:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:21:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:21:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4b53f78f9bb834e83564513bc9e7dac32d1bd9dc477ee6b5d4d91ca4b1400b6dbcfb76619f91346a8f184fb8124febbc26a94351d9ff021c7c9641579bd9b0e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85ac9790e92946beee20e993b3d5c9baef2b9440a51e92b24c48fde35c6b3f309124d328e6ffab5522181428c12adcfefa6c3e71a0d6cdb1772095ec66523ccb"} 15:21:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:21:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:21:55 INFO - Contents: 15:21:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4b53f78f9bb834e83564513bc9e7dac32d1bd9dc477ee6b5d4d91ca4b1400b6dbcfb76619f91346a8f184fb8124febbc26a94351d9ff021c7c9641579bd9b0e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85ac9790e92946beee20e993b3d5c9baef2b9440a51e92b24c48fde35c6b3f309124d328e6ffab5522181428c12adcfefa6c3e71a0d6cdb1772095ec66523ccb"} 15:21:55 INFO - Running post-run listener: copy_logs_to_upload_dir 15:21:55 INFO - Copying logs to upload dir... 15:21:55 INFO - mkdir: /builds/slave/test/build/upload/logs 15:21:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.216219 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-16 15:21:55.481577) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-16 15:21:55.485561) ========= 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.Y8cNim4GfL/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.Kbolnk1Vvl/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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/e4b53f78f9bb834e83564513bc9e7dac32d1bd9dc477ee6b5d4d91ca4b1400b6dbcfb76619f91346a8f184fb8124febbc26a94351d9ff021c7c9641579bd9b0e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85ac9790e92946beee20e993b3d5c9baef2b9440a51e92b24c48fde35c6b3f309124d328e6ffab5522181428c12adcfefa6c3e71a0d6cdb1772095ec66523ccb"} build_url:https://queue.taskcluster.net/v1/task/GhDMFqZZRPiL17ulMQ--VQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011167 build_url: 'https://queue.taskcluster.net/v1/task/GhDMFqZZRPiL17ulMQ--VQ/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/e4b53f78f9bb834e83564513bc9e7dac32d1bd9dc477ee6b5d4d91ca4b1400b6dbcfb76619f91346a8f184fb8124febbc26a94351d9ff021c7c9641579bd9b0e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85ac9790e92946beee20e993b3d5c9baef2b9440a51e92b24c48fde35c6b3f309124d328e6ffab5522181428c12adcfefa6c3e71a0d6cdb1772095ec66523ccb"}' ========= master_lag: 0.09 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-16 15:21:55.585941) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 15:21:55.586354) ========= 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.Y8cNim4GfL/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.Kbolnk1Vvl/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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.005034 ========= master_lag: 0.14 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 15:21:55.734061) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-16 15:21:55.734468) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-16 15:21:55.735308) ========= ========= Total master_lag: 4.46 =========