builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0182 starttime: 1456172106.63 results: success (0) buildid: 20160222102827 builduid: 077170087a584da5870bf79168f25557 revision: 7d4147c08c3e554544c4607766b1983d5922c0a6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 12:15:06.632900) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 12:15:06.633283) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 12:15:06.633578) ========= 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.EeGZltctQo/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.2zr3MZCNuW/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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.005853 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 12:15:06.656457) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 12:15:06.656789) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 12:15:06.673743) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 12:15:06.674104) ========= 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.EeGZltctQo/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.2zr3MZCNuW/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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.005508 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 12:15:06.722418) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 12:15:06.722731) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 12:15:06.723073) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 12:15:06.723341) ========= 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.EeGZltctQo/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.2zr3MZCNuW/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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-22 12:15:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.29M=0.001s 2016-02-22 12:15:06 (8.29 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142218 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 12:15:06.881240) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 12:15:06.881551) ========= 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.EeGZltctQo/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.2zr3MZCNuW/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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.020836 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 12:15:06.929497) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-22 12:15:06.929884) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7d4147c08c3e554544c4607766b1983d5922c0a6 --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 7d4147c08c3e554544c4607766b1983d5922c0a6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EeGZltctQo/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.2zr3MZCNuW/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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-22 12:15:07,000 truncating revision to first 12 chars 2016-02-22 12:15:07,000 Setting DEBUG logging. 2016-02-22 12:15:07,000 attempt 1/10 2016-02-22 12:15:07,000 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7d4147c08c3e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-22 12:15:08,112 unpacking tar archive at: fx-team-7d4147c08c3e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.359489 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-22 12:15:08.305395) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 12:15:08.305757) ========= echo 7d4147c08c3e554544c4607766b1983d5922c0a6 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7d4147c08c3e554544c4607766b1983d5922c0a6'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EeGZltctQo/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.2zr3MZCNuW/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 7d4147c08c3e554544c4607766b1983d5922c0a6 program finished with exit code 0 elapsedTime=0.005146 script_repo_revision: '7d4147c08c3e554544c4607766b1983d5922c0a6' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 12:15:08.356297) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 12:15:08.356617) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 12:15:08.370374) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-02-22 12:15:08.370736) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.EeGZltctQo/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.2zr3MZCNuW/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 12:15:08 INFO - MultiFileLogger online at 20160222 12:15:08 in /builds/slave/test 12:15:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:15:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:15:08 INFO - {'append_to_log': False, 12:15:08 INFO - 'base_work_dir': '/builds/slave/test', 12:15:08 INFO - 'blob_upload_branch': 'Fx-Team', 12:15:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:15:08 INFO - 'branch': 'Fx-Team', 12:15:08 INFO - 'buildbot_json_path': 'buildprops.json', 12:15:08 INFO - 'config_files': ('talos/mac_config.py',), 12:15:08 INFO - 'default_actions': ('clobber', 12:15:08 INFO - 'read-buildbot-config', 12:15:08 INFO - 'download-and-extract', 12:15:08 INFO - 'populate-webroot', 12:15:08 INFO - 'create-virtualenv', 12:15:08 INFO - 'install', 12:15:08 INFO - 'run-tests'), 12:15:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:15:08 INFO - 'download_minidump_stackwalk': True, 12:15:08 INFO - 'download_symbols': 'ondemand', 12:15:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:15:08 INFO - 'tooltool.py': '/tools/tooltool.py', 12:15:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:15:08 INFO - '/tools/misc-python/virtualenv.py')}, 12:15:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:15:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:15:08 INFO - 'installer_path': 'installer.exe', 12:15:08 INFO - 'log_level': 'info', 12:15:08 INFO - 'log_name': 'talos', 12:15:08 INFO - 'log_to_console': True, 12:15:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:15:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:15:08 INFO - 'opt_config_files': (), 12:15:08 INFO - 'pip_index': False, 12:15:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:15:08 INFO - 'cmd': ('bash', 12:15:08 INFO - '-c', 12:15:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:15:08 INFO - 'enabled': True, 12:15:08 INFO - 'halt_on_failure': False, 12:15:08 INFO - 'name': 'check_screen_resolution'},), 12:15:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:15:08 INFO - 'cmd': ('bash', 12:15:08 INFO - '-c', 12:15:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:15:08 INFO - 'enabled': True, 12:15:08 INFO - 'halt_on_failure': False, 12:15:08 INFO - 'name': 'check_screen_resolution'},), 12:15:08 INFO - 'run_cmd_checks_enabled': True, 12:15:08 INFO - 'sps_profile': False, 12:15:08 INFO - 'sps_profile_interval': 0, 12:15:08 INFO - 'suite': 'dromaeojs', 12:15:08 INFO - 'system_bits': '32', 12:15:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:15:08 INFO - 'title': 't-yosemite-r7-0182', 12:15:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:15:08 INFO - 'use_talos_json': True, 12:15:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:15:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:15:08 INFO - 'work_dir': 'build'} 12:15:08 INFO - ##### 12:15:08 INFO - ##### Running clobber step. 12:15:08 INFO - ##### 12:15:08 INFO - Running pre-action listener: _resource_record_pre_action 12:15:08 INFO - Running main action method: clobber 12:15:08 INFO - rmtree: /builds/slave/test/build 12:15:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:15:09 INFO - Running post-action listener: _resource_record_post_action 12:15:09 INFO - ##### 12:15:09 INFO - ##### Running read-buildbot-config step. 12:15:09 INFO - ##### 12:15:09 INFO - Running pre-action listener: _resource_record_pre_action 12:15:09 INFO - Running main action method: read_buildbot_config 12:15:09 INFO - Using buildbot properties: 12:15:09 INFO - { 12:15:09 INFO - "project": "", 12:15:09 INFO - "product": "firefox", 12:15:09 INFO - "script_repo_revision": "production", 12:15:09 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 12:15:09 INFO - "repository": "", 12:15:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 12:15:09 INFO - "buildid": "20160222102827", 12:15:09 INFO - "pgo_build": "False", 12:15:09 INFO - "basedir": "/builds/slave/test", 12:15:09 INFO - "buildnumber": 479, 12:15:09 INFO - "slavename": "t-yosemite-r7-0182", 12:15:09 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 12:15:09 INFO - "platform": "yosemite_r7", 12:15:09 INFO - "scheduler": "tests-fx-team-macosx64-talos", 12:15:09 INFO - "branch": "fx-team", 12:15:09 INFO - "repo_path": "integration/fx-team", 12:15:09 INFO - "revision": "7d4147c08c3e554544c4607766b1983d5922c0a6", 12:15:09 INFO - "stage_platform": "macosx64", 12:15:09 INFO - "builduid": "077170087a584da5870bf79168f25557", 12:15:09 INFO - "slavebuilddir": "test" 12:15:09 INFO - } 12:15:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 12:15:09 INFO - Running post-action listener: _resource_record_post_action 12:15:09 INFO - ##### 12:15:09 INFO - ##### Running download-and-extract step. 12:15:09 INFO - ##### 12:15:09 INFO - Running pre-action listener: _resource_record_pre_action 12:15:09 INFO - Running main action method: download_and_extract 12:15:09 INFO - mkdir: /builds/slave/test/build/tests 12:15:09 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')]} 12:15:09 INFO - https://queue.taskcluster.net/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:15:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/test_packages.json 12:15:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/test_packages.json 12:15:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:15:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:15:11 INFO - Downloaded 1277 bytes. 12:15:11 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:15:11 INFO - Using the following test package requirements: 12:15:11 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 12:15:11 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:15:11 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 12:15:11 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:15:11 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 12:15:11 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:15:11 INFO - u'jsshell-mac.zip'], 12:15:11 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:15:11 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 12:15:11 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 12:15:11 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:15:11 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 12:15:11 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:15:11 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 12:15:11 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:15:11 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 12:15:11 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 12:15:11 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:15:11 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 12:15:11 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:15:11 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')]} 12:15:11 INFO - https://queue.taskcluster.net/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:15:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:15:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:15:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyhACxtjS9CDBKOgYbEQDQ/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 12:15:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyhACxtjS9CDBKOgYbEQDQ/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 12:15:12 INFO - Downloaded 17825495 bytes. 12:15:12 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'] 12:15:12 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 12:15:15 INFO - Return code: 0 12:15:15 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 12:15: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')]} 12:15:15 INFO - https://queue.taskcluster.net/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:15:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:15:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:15:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyhACxtjS9CDBKOgYbEQDQ/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 12:15:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyhACxtjS9CDBKOgYbEQDQ/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 12:15:16 INFO - Downloaded 17825495 bytes. 12:15:16 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'] 12:15:16 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 12:15:20 INFO - Return code: 0 12:15: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')]} 12:15:20 INFO - https://queue.taskcluster.net/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:15:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 12:15:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 12:15:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyhACxtjS9CDBKOgYbEQDQ/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 12:15:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyhACxtjS9CDBKOgYbEQDQ/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 12:15:22 INFO - Downloaded 10707015 bytes. 12:15:22 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'] 12:15:22 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 12:15:23 INFO - Return code: 0 12:15: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')]} 12:15:23 INFO - https://queue.taskcluster.net/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:15:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 12:15:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 12:15:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 12:15:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyhACxtjS9CDBKOgYbEQDQ/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 12:15:29 INFO - Downloaded 111278564 bytes. 12:15:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 12:15:29 INFO - mkdir: /builds/slave/test/properties 12:15:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:15:29 INFO - Writing to file /builds/slave/test/properties/build_url 12:15:29 INFO - Contents: 12:15:29 INFO - build_url:https://queue.taskcluster.net/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 12:15:30 INFO - Running post-action listener: _resource_record_post_action 12:15:30 INFO - Running post-action listener: set_extra_try_arguments 12:15:30 INFO - ##### 12:15:30 INFO - ##### Running populate-webroot step. 12:15:30 INFO - ##### 12:15:30 INFO - Running pre-action listener: _resource_record_pre_action 12:15:30 INFO - Running main action method: populate_webroot 12:15:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:15:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:15:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:15:30 INFO - '--tppagecycles', 12:15:30 INFO - '7'], 12:15:30 INFO - 'tests': ['tsvgm']}}, 12:15:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:15:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:15:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:15:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:15:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:15:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:15:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:15:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:30 INFO - 'talos_options': ['--e10s'], 12:15:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:15:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:30 INFO - 'tests': ['damp', 'tps']}, 12:15:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:30 INFO - 'talos_options': ['--e10s'], 12:15:30 INFO - 'tests': ['damp', 'tps']}, 12:15:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:15:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:15:30 INFO - 'other': {'tests': ['a11yr', 12:15:30 INFO - 'ts_paint', 12:15:30 INFO - 'tpaint', 12:15:30 INFO - 'sessionrestore', 12:15:30 INFO - 'sessionrestore_no_auto_restore']}, 12:15:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:15:30 INFO - 'tests': ['a11yr', 12:15:30 INFO - 'ts_paint', 12:15:30 INFO - 'tpaint', 12:15:30 INFO - 'sessionrestore', 12:15:30 INFO - 'sessionrestore_no_auto_restore']}, 12:15:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:15:30 INFO - 'tests': ['a11yr', 12:15:30 INFO - 'ts_paint', 12:15:30 INFO - 'tpaint', 12:15:30 INFO - 'sessionrestore', 12:15:30 INFO - 'sessionrestore_no_auto_restore']}, 12:15:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:15:30 INFO - 'tests': ['a11yr', 12:15:30 INFO - 'ts_paint', 12:15:30 INFO - 'tpaint', 12:15:30 INFO - 'sessionrestore', 12:15:30 INFO - 'sessionrestore_no_auto_restore']}, 12:15:30 INFO - 'other_l64': {'tests': ['a11yr', 12:15:30 INFO - 'ts_paint', 12:15:30 INFO - 'tpaint', 12:15:30 INFO - 'sessionrestore', 12:15:30 INFO - 'sessionrestore_no_auto_restore']}, 12:15:30 INFO - 'other_nol64': {'tests': ['a11yr', 12:15:30 INFO - 'ts_paint', 12:15:30 INFO - 'tpaint', 12:15:30 INFO - 'sessionrestore', 12:15:30 INFO - 'sessionrestore_no_auto_restore']}, 12:15:30 INFO - 'svgr': {'tests': ['tsvgx', 12:15:30 INFO - 'tsvgr_opacity', 12:15:30 INFO - 'tart', 12:15:30 INFO - 'tscrollx', 12:15:30 INFO - 'cart']}, 12:15:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:15:30 INFO - 'tests': ['tsvgx', 12:15:30 INFO - 'tsvgr_opacity', 12:15:30 INFO - 'tart', 12:15:30 INFO - 'tscrollx', 12:15:30 INFO - 'cart']}, 12:15:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:30 INFO - 'tests': ['tp5o']}, 12:15:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:30 INFO - 'talos_options': ['--e10s'], 12:15:30 INFO - 'tests': ['tp5o']}, 12:15:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:30 INFO - 'talos_options': ['--xperf_path', 12:15:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:15:30 INFO - 'tests': ['tp5n']}, 12:15:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:30 INFO - 'talos_options': ['--e10s', 12:15:30 INFO - '--xperf_path', 12:15:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:15:30 INFO - 'tests': ['tp5n']}}, 12:15:30 INFO - 'talos.zip': {'path': '', 12:15:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:15:30 INFO - Running post-action listener: _resource_record_post_action 12:15:30 INFO - ##### 12:15:30 INFO - ##### Running create-virtualenv step. 12:15:30 INFO - ##### 12:15:30 INFO - Running pre-action listener: _resource_record_pre_action 12:15:30 INFO - Running main action method: create_virtualenv 12:15:30 INFO - Creating virtualenv /builds/slave/test/build/venv 12:15:30 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 12:15:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:15:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:15:30 INFO - Using real prefix '/tools/python27' 12:15:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:15:31 INFO - Installing distribute.............................................................................................................................................................................................done. 12:15:34 INFO - Installing pip.................done. 12:15:34 INFO - Return code: 0 12:15:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:34 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 0x10fa45a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa4d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf1accd7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e9d30>, '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 0x10f70ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e0b20>, '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.EeGZltctQo/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.2zr3MZCNuW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 12:15:34 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 12:15:34 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 12:15:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EeGZltctQo/Render', 12:15:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:34 INFO - 'HOME': '/Users/cltbld', 12:15:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:34 INFO - 'LOGNAME': 'cltbld', 12:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:34 INFO - 'MOZ_NO_REMOTE': '1', 12:15:34 INFO - 'NO_EM_RESTART': '1', 12:15:34 INFO - 'PAGER': '/bin/cat', 12:15:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:34 INFO - 'PWD': '/builds/slave/test', 12:15:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:34 INFO - 'SHELL': '/bin/bash', 12:15:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2zr3MZCNuW/Listeners', 12:15:34 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 12:15:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:34 INFO - 'USER': 'cltbld', 12:15:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:34 INFO - 'XPC_FLAGS': '0x0', 12:15:34 INFO - 'XPC_SERVICE_NAME': '0', 12:15:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:34 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 12:15:34 INFO - Cleaning up... 12:15:34 INFO - Return code: 0 12:15:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:34 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 0x10fa45a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa4d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf1accd7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e9d30>, '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 0x10f70ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e0b20>, '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.EeGZltctQo/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.2zr3MZCNuW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 12:15:34 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 12:15:34 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 12:15:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EeGZltctQo/Render', 12:15:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:34 INFO - 'HOME': '/Users/cltbld', 12:15:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:34 INFO - 'LOGNAME': 'cltbld', 12:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:34 INFO - 'MOZ_NO_REMOTE': '1', 12:15:34 INFO - 'NO_EM_RESTART': '1', 12:15:34 INFO - 'PAGER': '/bin/cat', 12:15:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:34 INFO - 'PWD': '/builds/slave/test', 12:15:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:34 INFO - 'SHELL': '/bin/bash', 12:15:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2zr3MZCNuW/Listeners', 12:15:34 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 12:15:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:34 INFO - 'USER': 'cltbld', 12:15:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:34 INFO - 'XPC_FLAGS': '0x0', 12:15:34 INFO - 'XPC_SERVICE_NAME': '0', 12:15:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:34 INFO - Downloading/unpacking psutil>=0.7.1 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:15:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:15:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:15:37 INFO - Installing collected packages: psutil 12:15:37 INFO - Running setup.py install for psutil 12:15:37 INFO - building 'psutil._psutil_osx' extension 12:15:37 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 12:15:38 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 12:15:38 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 12:15:38 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 12:15:38 INFO - building 'psutil._psutil_posix' extension 12:15:38 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 12:15:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:15:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:15:38 INFO - ^ 12:15:38 INFO - 1 warning generated. 12:15:38 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 12:15:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:15:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:15:38 INFO - Successfully installed psutil 12:15:38 INFO - Cleaning up... 12:15:38 INFO - Return code: 0 12:15:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:38 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 0x10fa45a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa4d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf1accd7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e9d30>, '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 0x10f70ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e0b20>, '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.EeGZltctQo/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.2zr3MZCNuW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 12:15:38 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 12:15:38 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 12:15:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EeGZltctQo/Render', 12:15:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:38 INFO - 'HOME': '/Users/cltbld', 12:15:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:38 INFO - 'LOGNAME': 'cltbld', 12:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:38 INFO - 'MOZ_NO_REMOTE': '1', 12:15:38 INFO - 'NO_EM_RESTART': '1', 12:15:38 INFO - 'PAGER': '/bin/cat', 12:15:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:38 INFO - 'PWD': '/builds/slave/test', 12:15:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:38 INFO - 'SHELL': '/bin/bash', 12:15:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2zr3MZCNuW/Listeners', 12:15:38 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 12:15:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:38 INFO - 'USER': 'cltbld', 12:15:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:38 INFO - 'XPC_FLAGS': '0x0', 12:15:38 INFO - 'XPC_SERVICE_NAME': '0', 12:15:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:15:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:15:41 INFO - Installing collected packages: mozsystemmonitor 12:15:41 INFO - Running setup.py install for mozsystemmonitor 12:15:41 INFO - Successfully installed mozsystemmonitor 12:15:41 INFO - Cleaning up... 12:15:41 INFO - Return code: 0 12:15:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:15: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')]} 12:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15: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')]} 12:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15: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', '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 0x10fa45a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa4d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf1accd7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e9d30>, '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 0x10f70ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e0b20>, '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.EeGZltctQo/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.2zr3MZCNuW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 12:15: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:15: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 blobuploader==1.2.4 12:15:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EeGZltctQo/Render', 12:15:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:41 INFO - 'HOME': '/Users/cltbld', 12:15:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:41 INFO - 'LOGNAME': 'cltbld', 12:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:41 INFO - 'MOZ_NO_REMOTE': '1', 12:15:41 INFO - 'NO_EM_RESTART': '1', 12:15:41 INFO - 'PAGER': '/bin/cat', 12:15:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:41 INFO - 'PWD': '/builds/slave/test', 12:15:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:41 INFO - 'SHELL': '/bin/bash', 12:15:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2zr3MZCNuW/Listeners', 12:15:41 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 12:15:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:41 INFO - 'USER': 'cltbld', 12:15:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:41 INFO - 'XPC_FLAGS': '0x0', 12:15:41 INFO - 'XPC_SERVICE_NAME': '0', 12:15:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:41 INFO - Downloading/unpacking blobuploader==1.2.4 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15:43 INFO - Downloading blobuploader-1.2.4.tar.gz 12:15:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:15:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:15:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15:45 INFO - Downloading docopt-0.6.1.tar.gz 12:15:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:15:45 INFO - Installing collected packages: blobuploader, requests, docopt 12:15:45 INFO - Running setup.py install for blobuploader 12:15:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:15:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:15:45 INFO - Running setup.py install for requests 12:15:45 INFO - Running setup.py install for docopt 12:15:46 INFO - Successfully installed blobuploader requests docopt 12:15:46 INFO - Cleaning up... 12:15:46 INFO - Return code: 0 12:15:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:46 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')]} 12:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:46 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')]} 12:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:46 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 0x10fa45a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa4d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf1accd7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e9d30>, '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 0x10f70ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e0b20>, '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.EeGZltctQo/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.2zr3MZCNuW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 12:15:46 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 12:15:46 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 12:15:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EeGZltctQo/Render', 12:15:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:46 INFO - 'HOME': '/Users/cltbld', 12:15:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:46 INFO - 'LOGNAME': 'cltbld', 12:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:46 INFO - 'MOZ_NO_REMOTE': '1', 12:15:46 INFO - 'NO_EM_RESTART': '1', 12:15:46 INFO - 'PAGER': '/bin/cat', 12:15:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:46 INFO - 'PWD': '/builds/slave/test', 12:15:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:46 INFO - 'SHELL': '/bin/bash', 12:15:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2zr3MZCNuW/Listeners', 12:15:46 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 12:15:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:46 INFO - 'USER': 'cltbld', 12:15:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:46 INFO - 'XPC_FLAGS': '0x0', 12:15:46 INFO - 'XPC_SERVICE_NAME': '0', 12:15:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:15:46 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-e8HbMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:15:46 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-1F7JRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:15:46 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-2uhXZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:15:46 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-QEWtGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:15:46 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-o7YyiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:15:46 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-8FyEzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:15:46 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-LBxis9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:15:47 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-ZUkHld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:15:47 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-QuEHuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:15:47 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-O3Ou19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:15:47 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-SMyD7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:15:47 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-hMwqeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:15:47 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-9UTpW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:15:47 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-LXih_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:47 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-RvxoaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:15:47 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-FbmwxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:15:48 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-AvJiIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:15:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:15:48 INFO - Running setup.py install for manifestparser 12:15:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:15:48 INFO - Running setup.py install for mozcrash 12:15:48 INFO - Running setup.py install for mozdebug 12:15:48 INFO - Running setup.py install for mozdevice 12:15:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:15:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:15:48 INFO - Running setup.py install for mozfile 12:15:48 INFO - Running setup.py install for mozhttpd 12:15:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:15:49 INFO - Running setup.py install for mozinfo 12:15:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:15:49 INFO - Running setup.py install for mozInstall 12:15:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:15:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:15:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:15:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:15:49 INFO - Running setup.py install for mozleak 12:15:49 INFO - Running setup.py install for mozlog 12:15:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:15:49 INFO - Running setup.py install for moznetwork 12:15:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:15:49 INFO - Running setup.py install for mozprocess 12:15:49 INFO - Running setup.py install for mozprofile 12:15:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:15:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:15:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:15:50 INFO - Running setup.py install for mozrunner 12:15:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:15:50 INFO - Running setup.py install for mozscreenshot 12:15:50 INFO - Running setup.py install for moztest 12:15:50 INFO - Running setup.py install for mozversion 12:15:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:15:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:15:50 INFO - Cleaning up... 12:15:50 INFO - Return code: 0 12:15:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:50 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 0x10fa45a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa4d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf1accd7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e9d30>, '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 0x10f70ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e0b20>, '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.EeGZltctQo/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.2zr3MZCNuW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 12:15:50 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 12:15:50 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 12:15:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EeGZltctQo/Render', 12:15:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:50 INFO - 'HOME': '/Users/cltbld', 12:15:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:50 INFO - 'LOGNAME': 'cltbld', 12:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:50 INFO - 'MOZ_NO_REMOTE': '1', 12:15:50 INFO - 'NO_EM_RESTART': '1', 12:15:50 INFO - 'PAGER': '/bin/cat', 12:15:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:50 INFO - 'PWD': '/builds/slave/test', 12:15:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:50 INFO - 'SHELL': '/bin/bash', 12:15:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2zr3MZCNuW/Listeners', 12:15:50 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 12:15:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:50 INFO - 'USER': 'cltbld', 12:15:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:50 INFO - 'XPC_FLAGS': '0x0', 12:15:50 INFO - 'XPC_SERVICE_NAME': '0', 12:15:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:15:51 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-VSmbEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:15:51 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)) 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:15:51 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-ql3CDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:15:51 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)) 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:15:51 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-BUVy8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:15:51 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)) 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:15:51 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-JRE1y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:15:51 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)) 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:15:51 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-AptC1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:15:51 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)) 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:15:51 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-Jsi7Ts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:15:51 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)) 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:15:51 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-x_UpJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:15:51 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)) 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:15:51 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-E08wRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:15:51 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)) 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:15:51 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-HEwsfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:15:51 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)) 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:15:51 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-fCP3sB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:15:52 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)) 12:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:15:52 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-4zPfEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:15:52 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)) 12:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:15:52 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-Uw1jHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:15:52 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)) 12:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:15:52 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-D2SWZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:15:52 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)) 12:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:15:52 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-nZF9By-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:15:52 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)) 12:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:52 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-bTjELk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:52 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)) 12:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:15:52 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-yM7P9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:15:52 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)) 12:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:15:52 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-9uTKyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:15:52 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)) 12:15:52 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)) 12:15:52 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)) 12:15:52 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)) 12:15:52 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)) 12:15:52 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)) 12:15:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:15:52 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 12:15:52 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 12:15:52 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 12:15:52 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 12:15:52 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 12:15:52 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 12:15:55 INFO - Downloading blessings-1.6.tar.gz 12:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:15:55 INFO - Installing collected packages: blessings 12:15:55 INFO - Running setup.py install for blessings 12:15:55 INFO - Successfully installed blessings 12:15:55 INFO - Cleaning up... 12:15:55 INFO - Return code: 0 12:15:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:15:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:15:55 INFO - Reading from file tmpfile_stdout 12:15:55 INFO - Current package versions: 12:15:55 INFO - blessings == 1.6 12:15:55 INFO - blobuploader == 1.2.4 12:15:55 INFO - docopt == 0.6.1 12:15:55 INFO - manifestparser == 1.1 12:15:55 INFO - mozInstall == 1.12 12:15:55 INFO - mozcrash == 0.16 12:15:55 INFO - mozdebug == 0.1 12:15:55 INFO - mozdevice == 0.48 12:15:55 INFO - mozfile == 1.2 12:15:55 INFO - mozhttpd == 0.7 12:15:55 INFO - mozinfo == 0.9 12:15:55 INFO - mozleak == 0.1 12:15:55 INFO - mozlog == 3.1 12:15:55 INFO - moznetwork == 0.27 12:15:55 INFO - mozprocess == 0.22 12:15:55 INFO - mozprofile == 0.28 12:15:55 INFO - mozrunner == 6.11 12:15:55 INFO - mozscreenshot == 0.1 12:15:55 INFO - mozsystemmonitor == 0.0 12:15:55 INFO - moztest == 0.7 12:15:55 INFO - mozversion == 1.4 12:15:55 INFO - psutil == 3.1.1 12:15:55 INFO - requests == 1.2.3 12:15:55 INFO - wsgiref == 0.1.2 12:15:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15: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')]} 12:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15: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')]} 12:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:55 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 0x10fa45a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa4d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf1accd7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e9d30>, '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 0x10f70ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e0b20>, '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.EeGZltctQo/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.2zr3MZCNuW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 12:15:55 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 12:15:55 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 12:15:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EeGZltctQo/Render', 12:15:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:55 INFO - 'HOME': '/Users/cltbld', 12:15:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:55 INFO - 'LOGNAME': 'cltbld', 12:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:55 INFO - 'MOZ_NO_REMOTE': '1', 12:15:55 INFO - 'NO_EM_RESTART': '1', 12:15:55 INFO - 'PAGER': '/bin/cat', 12:15:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:55 INFO - 'PWD': '/builds/slave/test', 12:15:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:55 INFO - 'SHELL': '/bin/bash', 12:15:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2zr3MZCNuW/Listeners', 12:15:55 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 12:15:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:55 INFO - 'USER': 'cltbld', 12:15:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:55 INFO - 'XPC_FLAGS': '0x0', 12:15:55 INFO - 'XPC_SERVICE_NAME': '0', 12:15:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:55 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)) 12:15:55 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)) 12:15:55 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)) 12:15:55 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)) 12:15:55 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)) 12:15:55 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)) 12:15:55 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)) 12:15:55 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)) 12:15:55 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)) 12:15:55 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)) 12:15:55 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)) 12:15:55 INFO - Cleaning up... 12:15:56 INFO - Return code: 0 12:15:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:15: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')]} 12:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15: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')]} 12:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:56 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 0x10fa45a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa4d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf1accd7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e9d30>, '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 0x10f70ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e0b20>, '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.EeGZltctQo/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.2zr3MZCNuW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 12:15:56 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 12:15:56 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 12:15:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EeGZltctQo/Render', 12:15:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:56 INFO - 'HOME': '/Users/cltbld', 12:15:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:56 INFO - 'LOGNAME': 'cltbld', 12:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:56 INFO - 'MOZ_NO_REMOTE': '1', 12:15:56 INFO - 'NO_EM_RESTART': '1', 12:15:56 INFO - 'PAGER': '/bin/cat', 12:15:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:56 INFO - 'PWD': '/builds/slave/test', 12:15:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:56 INFO - 'SHELL': '/bin/bash', 12:15:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2zr3MZCNuW/Listeners', 12:15:56 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 12:15:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:56 INFO - 'USER': 'cltbld', 12:15:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:56 INFO - 'XPC_FLAGS': '0x0', 12:15:56 INFO - 'XPC_SERVICE_NAME': '0', 12:15:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:56 INFO - Downloading/unpacking jsonschema 12:15:56 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 12:15:56 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 12:15:56 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 12:15:56 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 12:15:56 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 12:15:56 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 12:15:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:15:58 INFO - Downloading/unpacking functools32 (from jsonschema) 12:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:58 INFO - Downloading functools32-3.2.3-2.tar.gz 12:15:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:15:59 INFO - warning: no files found matching '*.txt' 12:15:59 INFO - no previously-included directories found matching 'build' 12:15:59 INFO - no previously-included directories found matching 'dist' 12:15:59 INFO - no previously-included directories found matching '.git*' 12:15:59 INFO - Installing collected packages: jsonschema, functools32 12:15:59 INFO - Running setup.py install for functools32 12:15:59 INFO - warning: no files found matching '*.txt' 12:15:59 INFO - no previously-included directories found matching 'build' 12:15:59 INFO - no previously-included directories found matching 'dist' 12:15:59 INFO - no previously-included directories found matching '.git*' 12:15:59 INFO - Successfully installed jsonschema functools32 12:15:59 INFO - Cleaning up... 12:15:59 INFO - Return code: 0 12:15:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:15:59 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')]} 12:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:59 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')]} 12:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:59 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 0x10fa45a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa4d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf1accd7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e9d30>, '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 0x10f70ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e0b20>, '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.EeGZltctQo/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.2zr3MZCNuW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 12:15:59 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 12:15:59 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 12:15:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EeGZltctQo/Render', 12:15:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:59 INFO - 'HOME': '/Users/cltbld', 12:15:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:59 INFO - 'LOGNAME': 'cltbld', 12:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:59 INFO - 'MOZ_NO_REMOTE': '1', 12:15:59 INFO - 'NO_EM_RESTART': '1', 12:15:59 INFO - 'PAGER': '/bin/cat', 12:15:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:59 INFO - 'PWD': '/builds/slave/test', 12:15:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:59 INFO - 'SHELL': '/bin/bash', 12:15:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2zr3MZCNuW/Listeners', 12:15:59 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 12:15:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:59 INFO - 'USER': 'cltbld', 12:15:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:59 INFO - 'XPC_FLAGS': '0x0', 12:15:59 INFO - 'XPC_SERVICE_NAME': '0', 12:15:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:59 INFO - Downloading/unpacking flake8 12:15:59 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 12:15:59 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 12:15:59 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 12:15:59 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 12:15:59 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 12:15:59 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 12:16:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:16:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:16:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:16:02 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 12:16:02 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 12:16:02 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 12:16:02 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 12:16:02 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 12:16:02 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 12:16:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:16:02 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 12:16:02 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 12:16:02 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 12:16:02 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 12:16:02 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 12:16:02 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 12:16:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:16:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:16:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:16:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:16:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:16:03 INFO - no previously-included directories found matching 'docs/_build' 12:16:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:16:03 INFO - Running setup.py install for pep8 12:16:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:16:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:16:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:16:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:16:03 INFO - no previously-included directories found matching 'docs/_build' 12:16:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:16:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:16:03 INFO - Cleaning up... 12:16:03 INFO - Return code: 0 12:16:03 INFO - Running post-action listener: _resource_record_post_action 12:16:03 INFO - Running post-action listener: _start_resource_monitoring 12:16:03 INFO - Starting resource monitoring. 12:16:03 INFO - ##### 12:16:03 INFO - ##### Running install step. 12:16:03 INFO - ##### 12:16:03 INFO - Running pre-action listener: _resource_record_pre_action 12:16:03 INFO - Running main action method: install 12:16:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:16:03 INFO - Reading from file tmpfile_stdout 12:16:03 INFO - Detecting whether we're running mozinstall >=1.0... 12:16:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:16:03 INFO - Reading from file tmpfile_stdout 12:16:03 INFO - Output received: 12:16:03 INFO - Usage: mozinstall [options] installer 12:16:03 INFO - Options: 12:16:03 INFO - -h, --help show this help message and exit 12:16:03 INFO - -d DEST, --destination=DEST 12:16:03 INFO - Directory to install application into. [default: 12:16:03 INFO - "/builds/slave/test"] 12:16:03 INFO - --app=APP Application being installed. [default: firefox] 12:16:03 INFO - mkdir: /builds/slave/test/build/application 12:16:03 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'] 12:16:03 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 12:16:37 INFO - Reading from file tmpfile_stdout 12:16:37 INFO - Output received: 12:16:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:16:37 INFO - Running post-action listener: _resource_record_post_action 12:16:37 INFO - ##### 12:16:37 INFO - ##### Running run-tests step. 12:16:37 INFO - ##### 12:16:37 INFO - Running pre-action listener: _resource_record_pre_action 12:16:37 INFO - Running main action method: run_tests 12:16:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:16:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:16:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:16:37 INFO - 2016-02-22 12:16:37.772 screenresolution[2550:19666] starting screenresolution argv=screenresolution get 12:16:37 INFO - 2016-02-22 12:16:37.774 screenresolution[2550:19666] Display 0: 1600x1200x32@60 12:16:37 INFO - 2016-02-22 12:16:37.780 screenresolution[2551:19669] starting screenresolution argv=screenresolution list 12:16:37 INFO - Available Modes on Display 0 12:16:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:16:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:16:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:16:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:16:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:16:38 INFO - Intel Iris: 12:16:38 INFO - Chipset Model: Intel Iris 12:16:38 INFO - Type: GPU 12:16:38 INFO - Bus: Built-In 12:16:38 INFO - VRAM (Dynamic, Max): 1536 MB 12:16:38 INFO - Vendor: Intel (0x8086) 12:16:38 INFO - Device ID: 0x0a2e 12:16:38 INFO - Revision ID: 0x0009 12:16:38 INFO - Displays: 12:16:38 INFO - Display: 12:16:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:16:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:16:38 INFO - Display Serial Number: 1600x1200 60 12:16:38 INFO - Main Display: Yes 12:16:38 INFO - Mirror: Off 12:16:38 INFO - Online: Yes 12:16:38 INFO - Rotation: Supported 12:16:38 INFO - Return code: 0 12:16:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:16:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:16:38 INFO - Python 2.7.3 12:16:38 INFO - Return code: 0 12:16:38 INFO - grabbing minidump binary from tooltool 12:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:38 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 0x10f8e9d30>, '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 0x10f70ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:16:38 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 12:16:38 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 12:16:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:16:38 INFO - Return code: 0 12:16:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:16:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:16:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:16:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:16:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:16:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:16:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:16:39 INFO - Return code: 0 12:16:39 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0182', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:16:39 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0182 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:16:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EeGZltctQo/Render', 12:16:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:16:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:16:39 INFO - 'HOME': '/Users/cltbld', 12:16:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:16:39 INFO - 'LOGNAME': 'cltbld', 12:16:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:16:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:39 INFO - 'MOZ_NO_REMOTE': '1', 12:16:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:16:39 INFO - 'NO_EM_RESTART': '1', 12:16:39 INFO - 'PAGER': '/bin/cat', 12:16:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:39 INFO - 'PWD': '/builds/slave/test', 12:16:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:16:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:16:39 INFO - 'SHELL': '/bin/bash', 12:16:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2zr3MZCNuW/Listeners', 12:16:39 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 12:16:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:16:39 INFO - 'USER': 'cltbld', 12:16:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:16:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:39 INFO - 'XPC_FLAGS': '0x0', 12:16:39 INFO - 'XPC_SERVICE_NAME': '0', 12:16:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:16:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0182', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:16:39 INFO - mozversion application_buildid: 20160222102827 12:16:39 INFO - mozversion application_changeset: 7d4147c08c3e554544c4607766b1983d5922c0a6 12:16:39 INFO - mozversion application_display_name: Nightly 12:16:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:16:39 INFO - mozversion application_name: Firefox 12:16:39 INFO - mozversion application_remotingname: firefox 12:16:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:16:39 INFO - mozversion application_vendor: Mozilla 12:16:39 INFO - mozversion application_version: 47.0a1 12:16:39 INFO - mozversion platform_buildid: 20160222102827 12:16:39 INFO - mozversion platform_changeset: 7d4147c08c3e554544c4607766b1983d5922c0a6 12:16:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:16:39 INFO - mozversion platform_version: 47.0a1 12:16:39 INFO - using testdate: 1456172199 12:16:39 INFO - actual date: 1456172199 12:16:39 INFO - starting webserver on 'localhost:52088' 12:16:39 INFO - SUITE-START | Running 2 tests 12:16:39 INFO - TEST-START | dromaeo_css 12:16:39 INFO - operating with platform_type : mac_ 12:16:39 INFO - Initialising browser for dromaeo_css test... 12:16:39 INFO - TEST-INFO | started process 2569 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmp771dBA/profile http://localhost:52088/getInfo.html) 12:16:41 INFO - PROCESS | 2569 | __metrics Screen width/height:1600/1200 12:16:41 INFO - PROCESS | 2569 | colorDepth:24 12:16:41 INFO - PROCESS | 2569 | Browser inner width/height: 1024/689 12:16:41 INFO - PROCESS | 2569 | __metrics 12:16:41 INFO - PROCESS | 2569 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:16:41 INFO - PROCESS | 2569 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:16:42 INFO - TEST-INFO | 2569: exit 0 12:16:42 INFO - Browser initialized. 12:16:42 INFO - Running cycle 1/1 for dromaeo_css test... 12:16:42 INFO - TEST-INFO | started process 2572 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmp771dBA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:16:54 INFO - PROCESS | 2572 | RSS: Main: 244371456 12:16:54 INFO - PROCESS | 2572 | 12:17:46 INFO - PROCESS | 2572 | 1456172266031 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] 12:19:56 INFO - PROCESS | 2572 | Cycle 1(1): loaded http://localhost:52088/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52088/tests/dromaeo/cssquery-ext.html) 12:19:57 INFO - PROCESS | 2572 | RSS: Main: 348536832 12:19:57 INFO - PROCESS | 2572 | 12:23:00 INFO - PROCESS | 2572 | Cycle 1(1): loaded http://localhost:52088/tests/dromaeo/cssquery-ext.html (next: http://localhost:52088/tests/dromaeo/cssquery-jquery.html) 12:23:00 INFO - PROCESS | 2572 | RSS: Main: 380784640 12:23:00 INFO - PROCESS | 2572 | 12:26:03 INFO - PROCESS | 2572 | Cycle 1(1): loaded http://localhost:52088/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52088/tests/dromaeo/cssquery-mootools.html) 12:26:03 INFO - PROCESS | 2572 | RSS: Main: 375742464 12:26:03 INFO - PROCESS | 2572 | 12:29:05 INFO - PROCESS | 2572 | Cycle 1(1): loaded http://localhost:52088/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52088/tests/dromaeo/cssquery-prototype.html) 12:29:06 INFO - PROCESS | 2572 | RSS: Main: 335011840 12:29:06 INFO - PROCESS | 2572 | 12:32:09 INFO - PROCESS | 2572 | Cycle 1(1): loaded http://localhost:52088/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52088/tests/dromaeo/cssquery-yui.html) 12:32:10 INFO - PROCESS | 2572 | RSS: Main: 336302080 12:32:10 INFO - PROCESS | 2572 | 12:35:12 INFO - PROCESS | 2572 | Cycle 1(1): loaded http://localhost:52088/tests/dromaeo/cssquery-yui.html (next: http://localhost:52088/tests/dromaeo/cssquery-dojo.html) 12:35:13 INFO - PROCESS | 2572 | RSS: Main: 387670016 12:35:13 INFO - PROCESS | 2572 | 12:35:13 INFO - PROCESS | 2572 | __start_tp_report 12:35:13 INFO - PROCESS | 2572 | _x_x_mozilla_page_load 12:35:13 INFO - PROCESS | 2572 | _x_x_mozilla_page_load_details 12:35:13 INFO - PROCESS | 2572 | |i|pagename|runs| 12:35:13 INFO - PROCESS | 2572 | |0;dojo.html;3350.3801796667617;3383.2387712764616;3417.606975197853;3425.1265927188565;3441.827908604569;5470.152126420411;5523.7238138093135;5523.972380138099;5546.306711661043;5567.220589117527;5581.49766521013;5586.525145362639;5603.2435621191225;5659.037963546197;5685;4948.010397920412;4949.455559888409;4957.182064959277;4965.528274813905;5172.146595811687;4643.16423043852;4895.241237608177;5086.084504789136;5090.898182036357;5127.154019586782;4991.700497970115;5018.197088465864;5058.468860769622;5097.6941383517105;5163.974180129113;5032.169692000852;5072.974635126838;5080.263361812554;5087.084324821531;5090.0583392072585;4977.352944117278;5021.799128034874;5042.067217564762;5046.697198168122;5073;4467.419235499397;5452.4274951129955;5488.231647569343;5514.80698175562;5571.721413929328;6100.45095941363;6114.571979961404;6124.938750612481;6128.693565321716;6134.04922237054;6026.276846778371;6118.405988989689;6215.782447614311;6227.1282020517165;6242.625442473466;5655.321361436613;5682.460166284196;5698.6580805151;5701.40135285789;5721.4850663440075;6283.08895210192;6284.528660350492;6291.874162516816;6294.527910406738;6320.273168585672;5105.923411148836;5838.94161058384;5950.613210141327;5977.442484318413;5979.372165922516;6153.538484613672;6154.446099851035;6158.815235542941;6167.629942203482;6171.814845554641;6085.69571521431;6089.877367678366;6098.795324190732;6106.542009349228;6125.29649783737;6019.729112189962;6074.483668888106;6095.6952152392205;6124.6325220486915;6143.542582966759;4048.716589838742;4797.856064318076;4815.783289751969;4817.759112044454;4835.637327200474;4284.143171365677;4303.741775493418;4311.159323931866;4328.285832837547;4356.956430435718;5183.170692689152;5536.972315138399;5580.274564306615;5582.358028826656;5621.128725047624;4956.727379994135;6157.784477543264;6174.845628859224;6210.72051757672;6241.78153764616;5464.726763661801;5585.162225666182;5585.69278689676;5596.076647353222;5607.158926161109;5218;5227.738613069408;5228.503292187236;5263.289455923478;5290.68255904647;6276.121343011982;6281;6282.963311053625;6287.025511045796;6289.622622642656;6079.696015199311;6119.357467465852;6185.907211391743;6199.318075011655;6212.720427580679;6248.812535623939;6301.558890877594;6301.716422761078;6312.337204593451;6328.7152078157515;5997.700114994145;6102.084687296941;6108.930937086081;6112.663803490851;6113.510919126548;6043.2748070231855;6059.182010428536;6120.7551697931585;6193.907091393723;6202.782902598387;5919.467247947533;5943.940560594512;5956.225690660186;5957.731902064331;5960.0761881908375;5886.793962211302;5928.881422371443;5940.61386009908;5944.732487038007;5962.821115366546;5626.43735626434;5739.942600574108;5787.652740835563;5790.073588225863;5866.266716660418;5839.562032847469;5876.500497457764;5890.175375447355;5898.174255604305;5969;5626.738452199089;5796.971015144897;5804.738786754522;5807.651540907559;5807.883842323215 12:35:13 INFO - PROCESS | 2572 | |1;ext.html;478.54538188720704;490.93372394726714;514.7040451740248;522.9346331708537;525.4692760312083;28990.565141522868;38471.23057538851;39072.80463597681;39103.21793564134;39111.608883911154;41829;42298.154036919244;42309.94225144373;42417.78791106048;42450.7877460613;9562.235021198323;9762.755931101743;9770.560324785401;9784.559694813715;9791.755206119833;9635.807283854354;9723.319367644232;9736.464494452837;9740.75648108796;9866.112049915506;9776.266779991494;9794.363366381198;9820.558074886612;9882.110610045094;9893.4558599277;9806.705798826046;9896.95051524745;9897.80204395908;9902.653407130789;9910.55402506889;9675.758106047335;9774.31579789415;9792.363496372713;9798.804023919552;9824.852627210597;40196.59803401987;40582.594174058475;40591.985200369934;40605.18789624191;40638.39042414366;3110.766692498049;3171.2864605463815;3241.675832416763;3329.017939707792;3336.4161271777584;24884.875575622187;27502;27554;28136;28568.571471427946;2687.7446642568925;2691.946161076787;2740.328619488218;2889.58101075345;2937.1922721251613;429936;433373.6662633365;433894;433927;435508.64491355;45457.31814022792;64130.35869641337;64762.02856957149;64903.67548162229;64928.67535662386;45709.7714511432;45752.54247457549;45906.770466147456;45942.540574594495;46002.53997460049;15202.391904323924;15555.14446705442;15570.766438503431;15595.532134035997;15599.220038998004;12511.999040076773;12588.937055314847;12593.370331483573;12593.811092833615;12598.992080633527;14583.635409114644;14610.26948652563;14821.77767333491;14827;14853.702925941638;6176.505879529627;6271.184745983084;6306.148669929593;6306.211723534559;6308;967.4630580028152;1009.369144284822;1023.4217667018111;1071.7374243310283;1086;24970;29660.458502410467;29708.702912971024;29896;30595;936.8501039833594;946.3328353510758;1016.1768967136643;1088.0968795899385;1098.4892025208317;12387.009039276836;14343.497977570734;14534.563963081124;14748.115113093034;14840.92579537117;670422;927496;973706;980531;984287;60929;61078.38921610727;61867;61963.211655475614;62024;1252.1172573335593;1421.5593166118535;1425.4512012874911;1440.337444775415;1562.9531114066597;24669.753302467463;29835.270591176104;30006.54990175193;30566.84716576403;30635.54046689257;54158.916821662555;54550.90898182093;54898.72550637221;54982.72508637431;55020.724896375265;508650;510404;510834;510869;513678;32486.35027299488;33884.49173262453;33981.66018339884;34016.65983340135;34017.577714897896;44821.55178448174;45027;45182;45767.855803605176;46579;37347;37606;38144.80927595344;38292;38381.80809095937;29856.25359366033;36432.81783591065;36610.63389366072;37576.43635345417;37723.11384430822;36812.447813282284;37604.059898502754;37699;37811.67659131917;37823;26045.0884219059;32219.516707248942;33462.82880099185;33552.32895342031;33614.663853361155;23358.416039599146;24740.628890567015;24779.25662230136;25387.36531586725;25649.230523084338 12:35:13 INFO - PROCESS | 2572 | |2;jquery.html;332.08510553425316;348.89533140057983;368.9225262694834;370.6608453265262;374.8687959214277;15643.374265029413;16160;19283.903580482096;19860.304889328876;20607.690884636744;19264.422067338;19509.804901950974;19803.108860101293;19891.900540497278;20205;5440.80302333488;5662.5753068519925;5663.631863928831;5829.358770535259;5877.853053673671;5787.450192231731;5801;5814.738336774834;5844.386339434362;5847.239858818348;5658.490735833774;5702.287214098238;5778.451047150535;5795.420457954213;5863.208466856983;5771.336296325934;5799.333076696171;5832.329282132524;5833.591648584601;5834.883302333951;4911.336969509106;4997.525235102659;5043.268726034741;5066.594672426197;5075.289459475676;20563.588728225503;25341.493170136495;25501.107461238767;25750.09874654378;25779;2144.0887622760265;2205.5699138667965;2270.126001489422;2338.40370705469;2724.9727502725113;12337.568185113478;14191.503297384543;14550.054246474052;14794.778078328834;15210.391584336723;1662.4929396534053;1721.3975108711975;1761.9030953297563;1799.4691565988064;1812.28414776164;98225.50887245589;98984;99832.52260944752;101218.49390753073;101818;10227.744306392251;10435.478226088666;10655.200859935536;10665.200109991627;10819;10671.679849604525;11850;12215.75568488643;12328.691782705504;12829.935850320875;8258.958705206436;8336.208060234389;8347.916520834835;8394.034686011064;8436.156384361637;8651.134886511298;8653.307735381155;8660.610272537751;8714.215720585178;8748.8687669685;6054.091886217103;6160.7535698571555;6171.228596425447;6175.62946223228;6247.687615619201;1788.919498622539;1808.9366872159674;1810.9909450452926;1811.1306572845108;1853.2401715296664;876.9912300877037;927.7448701607112;940.8635747816666;1021.9627078515313;1040.6357774778767;19882.60234795296;20503.487412814502;20689.0689918951;20701.963117192303;21126.366209013755;944.4616568555857;966;1000.134748693681;1011.6863772230632;1036.7563622548696;7798.259165379393;10892.564297428173;11089.667309980714;11108.277961932448;11152.665420037412;522612.773872264;526610;531026;532564;536653.3167334138;73573;99104;102408;113846;124657;979.4612962870535;1012.5899010900597;1018.2108865629049;1018.9694309170736;1022.3303736052898;17289.049102299494;17576.91211543934;17609.29562817473;17685.38101166453;17726.379576714753;50858;52547.474525255784;53210.73394633002;54251.45748542464;56974.71512642576;63249.786257480766;63467.73064538775;72671.63664181645;74542.62728686322;77612;8020.398470114881;8201.30288925448;8215.178482151738;8245;8271.669133234604;6892.689828957608;11177.826328235744;11453.713657158305;13621.318934053059;13884.375203116086;11236.94381528087;11497.195196336175;11497.942510287396;11616.767664646828;11817.763644726885;11305.547778088785;11423.771524569629;11456.484458199568;11495.137864660017;11971.880281197426;11366.431678416211;11832.704182395164;11880.405979700807;11965.341906195243;12026.75946481083;8037.115917248981;8072.233137851895;8172.141925097779;8226.30076443485;8317;8972.237359824489;10118.49407529606;11387.405763192994;11937.940310298392;11952.402379880798 12:35:13 INFO - PROCESS | 2572 | |3;mootools.html;1406.3319923036565;1535.7849901013856;1559.9844001559982;1799.0914588132998;1949.7660280766302;7929.286364227226;8523.914760852389;8617.095205003478;8618.482891026528;8673.479591224523;8345.499270043802;8612.00961889383;8612.39713220075;8625.439346442477;8628.964524257082;2168.4253672776726;2409.3856066702965;2472.851628902272;2477.5911974524274;2514.358838496181;2469.9873052048665;2510.159096702607;2514.6102354135137;2516.043903316737;2517.307740371394;2462.7167875694254;2492.090387008747;2493.87530623469;2496.2012156110054;2501.1746123779108;2383.9046438142454;2443.9389015274583;2445.6576079348906;2452.0682140786566;2453.460238747473;2425.514897020603;2455.9754402455924;2479.7024357077084;2481.8759062047006;2484.1305543059966;8660.566971651393;8725.869111963326;8736.170063843925;8743.606537705818;8790.428622139605;5326.6005049621435;5472.480114389126;5491.835244942658;5523.1163013917985;5541.418151094158;3634.164142247298;3636.5817930938015;3742.438634204864;3745.4569087482437;3758.661720445173;1043.8747350317935;1045.989540104597;1058.185197398007;1093.03812644872;1093.5243169221415;11720.648380548597;11797.823032654604;11872.821907671392;11894.702632434171;11922.284662920252;4973.353464049723;5016.673916195436;5032.421271553745;5071.39143302806;5092.439831618519;10181.440020798927;10209.489525523693;10216;10235.437050962268;10289.43408112546;4986.102501549756;5567.387587365387;5579.358373787067;5585.720713964285;5593.74828132735;4512.097580483916;4832.516748325139;4847.878803029953;4850.393700787402;4852.611791056707;3985.960140398617;3986.5216174059296;3994.78028708418;4041.4139949707715;4043.5147782266317;1311.4033114932683;1317.2820812657126;1318.0049062957405;1323.245749922535;1333.7599232138114;1084.4306738962107;1229.2317301686446;1294.3463550906731;1319.6700824793802;1349.1230700045048;8130.918690813134;8138.145494723087;8166.754997350089;8168.959155204186;8169.346452283803;513.099510359317;1084.3168803653648;1215.2647648172906;1270.510853321478;1296.3323888197585;5197;6203.131561581382;6245.781397651061;6256.468200203034;6269.529785266123;10139.239557033252;10266.281360304856;10457.320274182306;10623.681289561171;10630.946845265878;10338.638147664946;10396.908324625956;10479.895201048044;10481.266311358284;10491.842622360671;7785.688572457038;8134.1698117923;8194.344452443791;8325.25072743456;8327.292180164633;7649.808754781175;7715.922840771745;7829.177936316605;7840.882386764089;7856.214378562327;8723.214910658071;9011.324150688855;9287.6284948604;9430.622775089194;9462.290328225274;9146.634134634805;9699.078587534173;9776.804463910825;9777.266704997295;9792.951035244778;6435.324290949383;6637;6665.466762659073;7257.310555497219;7377.8524429510035;8077.798055048671;8109.7161599343735;8150.510969341858;8171.305439037748;8196.959015204886;7164.67758950838;7315.414766818535;7330.486865919548;7428;7473.439492038227;7193.784186474414;7248.855022899618;7258.383037441666;7283.890741638774;7292.927070729224;7518.210587888412;7647.655855486405;7670.42471814605;7700;7765.417593680384;6979.476539259677;7014.263502332182;7027.191872934678;7032.050673159262;7053.294670532906;6931.376176144171;7131.25121862197;7152.249013853679;7158.319959603829;7158.785236442915 12:35:13 INFO - PROCESS | 2572 | |4;prototype.html;321.5177234148777;327.5643394285599;331.633544932849;333.4564659604844;337.54431517451445;6585.374389433002;6586.407223349897;6609.702563384647;6610.107635469216;6612.537122401433;6513.706883190256;6523.6738163091895;6534.379233972777;6540.182477190351;6574.8685026299445;3940.586238444965;4843.104025755238;4866.270059491087;4875.536824001714;4884.853454396374;4865.951340486603;4872.147374209517;4872.6345524085655;4890.21756518957;4898.51014898509;4421.292593185091;4575.633949284049;4769.332293478916;4831.347768051321;4847.927281090769;3897.766134031953;4750.572448479654;4766.928496072579;4779.880502987418;4794.376731024944;4080.5511393746665;4085.8774236772647;4087.816048277805;4091.7954102294766;4102.610252026053;5992.64044157352;6104.328523862371;6213.943629582982;6261.749530018794;6298.842528936813;5661.179129026309;5683.602147849652;5687.175359572881;5691.630044047124;5698.43015698431;7008.579485230903;7019.087518622598;7029.578225306447;7039.190493093309;7050.541714788523;4654.069186162781;4656.906861862743;4661.254199328125;4668.066386722635;4674.415698037746;7009.474289428263;7333.596652184127;7374;7390;7420;4701.459332176843;4760.476347601761;4761.428628564525;4762.333273341735;4770.284457331428;4821.686590371684;4826.155422800995;4827.468978412372;4838.903221935612;4842.95157048425;5694.658320500783;5706;5709.371969083398;5712.942870571324;5714.457126572969;7014;7023.964880175668;7028.543144695578;7033.507654464139;7039.648017599099;1552.6118470382405;1651;1672.222416576298;1673.7322028475628;1675.4052311429512;1034.9534270957824;1035.0839507036328;1050.3172937590475;1052.5368837711383;1052.547404616007;5338.706371149547;6476.093346931433;6556.3443655634055;6562.212534495796;6563.245226798979;7134.143902731706;7281.490295679251;7288.161861385903;7298.70090921358;7299.635018249066;5475.288212532345;5791.884162316815;6485.4487368573255;6616.106825578581;6690.364415380531;3698.870539531157;3845.6346647068485;3911.2177564487215;3914.0606254499285;3915.8433662653742;6388.233411990591;7680.9231907680205;7688.192739762357;7689.807754806175;7697.4226932980255;7312.853742925112;7576.166621671612;7624.046994125734;7646.579438130845;7652.387808975269;7611.619419029026;7650.961745191238;7659.387249020065;7666.156722760492;7700.3454706350585;5989.460948514655;7360.595167265852;7360.889586656097;7382.5570465772225;7405.518641288299;7241.746538871114;7258.564486130849;7261.237570055279;7277.417806575567;7297;7385;7639.961800191186;7645.61771911391;7685.346745526693;7732.110807257012;4629.722216667011;4663.673542851968;4668.5564871337165;4671.392718946515;4678.783516285722;7316.670749816378;7358.411327093927;7389.704411823467;7394.815129621803;7401.4078873688895;7103.467239957127;7106.289371062852;7112.395446387115;7118.110236220473;7119.85760284781;5794.3626201117;6835.658217089225;7092.645367731696;7094.3969762568695;7097.077379940574;6883.174019117738;6936.098307220231;6939.548929319578;6944.201416836926;6958.826029349307;7071.611061391673;7074.646267686492;7086.185088714864;7086.716531338689;7092.148942126978;6942.340477654615;6947.65261736901;6948.235694073547;6954.79135625932;6966.12923384577 12:35:13 INFO - PROCESS | 2572 | |5;yui.html;667.4460198035631;729.1214087025136;736.4035131543449;746.2947514598707;757.7575175943697;14618.195999220052;14843.851561484382;14847.585055437256;14854.257287135653;14870.702585948275;12844.165129266614;12860.356982150879;12925.935370323159;12930.806037909439;12943.352832358369;878.5431575580694;905.9003509613938;908.4322298563397;909.2816674826879;910.8588168833808;712.1845486917476;721.588694444167;876.1107475911955;892.848215803315;896.2829736211005;928.8792456980583;937.1752857485437;938.4838338913604;938.9014153513886;940.4075432477564;737.5242968285426;928.424376886328;929;929.3262384771054;929.9721008369726;648.5136147889083;683.1733602341174;687.1685260834396;692.2039654397433;693.9548929319578;14865.331060102322;14979.775303370458;14995.700085998327;15005.474808381654;15106.018108822891;12148.45331960064;12260.080493962989;12344.259344439273;12668.936655316757;12985.220886746825;10051.949740251324;10079.848802267972;10162.898371016268;10211.336263142946;10929.234953553254;3508.824558772051;3516.753827232095;3540.805255710935;3589.856405743767;3591.586967498745;75729.62135189289;76601.23398765997;77073.84389234165;85406.29187416217;86268.56865715694;9438.386504877299;9526.904730952601;9590.184834289164;9679.66121185755;9728.659496917573;20495.590088198154;20499.59000820005;20524.89737551303;20536.38390848277;20542.17831286732;7374.299441553044;7528.134264559646;7687.500312479671;7695.268949449794;7850.528968261922;4051.2910240707756;4129.112240868228;4133.689973252018;4148.253314403436;4308.116836048603;3527.9294414111573;3535.5934067582043;3558.839852206657;3572.4641303804638;3580.03339098442;634.3624657219465;641.1120597971842;646.3278190681732;654.1822721598003;659.0509666080828;549.9285092937893;586.3901542395946;597.3220394851875;634.2579182356561;638.7221558622015;7740.690372385154;9235.722928312161;9283.58223879927;9366.438013719198;9499.90500095004;540.0575994888866;575.6200907401095;593.6853467662146;618.7463140112533;624.9875002499924;3942.7777389009498;3986.960130398717;4012;4064.309067458539;4115.1975364804175;85485;86732;86865.13134868696;90303.54848225717;99477.0104597904;82189;82837;83237.58381208056;84264;84371.57814210889;72936;72999;74126;74284;74887;8041.919580804117;8100.35197184212;8207.302379297827;8213.219744124299;8301.626426810928;42695;49765;50096.24855627241;50403.74798125986;50909.218177365095;68078.3192168072;72062;72166.63916680383;72212;73465.6326718363;9627.5667594957;9785.657501987396;9832.96753840865;10330.225233107698;10444.843327349943;11891.702707432383;11928.58249961282;11930.284182949052;12065.81901271464;12634.557790477289;9459.763505912408;11302.717432064264;11791.88208117908;11889.227200231957;11916.285022898654;11603;11900.988415984739;11916.463759130687;11918.225315354473;11960.102992275788;11233.71915702114;11692.94153529261;11794;11794.705132371759;12386.62840114798;9630.47032413224;9668.9033109668;9780.168685661798;9831.803363932824;10127.037931396506;8118.391120665856;9058.818823623622;9179.816403672023;9928.702138935843;10039.799204015733 12:35:13 INFO - PROCESS | 2572 | __end_tp_report 12:35:13 INFO - PROCESS | 2572 | __start_cc_report 12:35:13 INFO - PROCESS | 2572 | _x_x_mozilla_cycle_collect,1012 12:35:13 INFO - PROCESS | 2572 | __end_cc_report 12:35:13 INFO - PROCESS | 2572 | __startTimestamp1456173313131__endTimestamp 12:35:13 INFO - PROCESS | 2572 | 12:35:13 INFO - PROCESS | 2572 | ------- Summary: start ------- 12:35:13 INFO - PROCESS | 2572 | Number of tests: 6 12:35:13 INFO - PROCESS | 2572 | 12:35:13 INFO - PROCESS | 2572 | [#0] dojo.html Cycles:165 Average:5602.67 Median:5796.97 stddev:657.11 (11.3%) stddev-sans-first:634.92 12:35:13 INFO - PROCESS | 2572 | Values: 3350.4 3383.2 3417.6 3425.1 3441.8 5470.2 5523.7 5524.0 5546.3 5567.2 5581.5 5586.5 5603.2 5659.0 5685.0 4948.0 4949.5 4957.2 4965.5 5172.1 4643.2 4895.2 5086.1 5090.9 5127.2 4991.7 5018.2 5058.5 5097.7 5164.0 5032.2 5073.0 5080.3 5087.1 5090.1 4977.4 5021.8 5042.1 5046.7 5073.0 4467.4 5452.4 5488.2 5514.8 5571.7 6100.5 6114.6 6124.9 6128.7 6134.0 6026.3 6118.4 6215.8 6227.1 6242.6 5655.3 5682.5 5698.7 5701.4 5721.5 6283.1 6284.5 6291.9 6294.5 6320.3 5105.9 5838.9 5950.6 5977.4 5979.4 6153.5 6154.4 6158.8 6167.6 6171.8 6085.7 6089.9 6098.8 6106.5 6125.3 6019.7 6074.5 6095.7 6124.6 6143.5 4048.7 4797.9 4815.8 4817.8 4835.6 4284.1 4303.7 4311.2 4328.3 4357.0 5183.2 5537.0 5580.3 5582.4 5621.1 4956.7 6157.8 6174.8 6210.7 6241.8 5464.7 5585.2 5585.7 5596.1 5607.2 5218.0 5227.7 5228.5 5263.3 5290.7 6276.1 6281.0 6283.0 6287.0 6289.6 6079.7 6119.4 6185.9 6199.3 6212.7 6248.8 6301.6 6301.7 6312.3 6328.7 5997.7 6102.1 6108.9 6112.7 6113.5 6043.3 6059.2 6120.8 6193.9 6202.8 5919.5 5943.9 5956.2 5957.7 5960.1 5886.8 5928.9 5940.6 5944.7 5962.8 5626.4 5739.9 5787.7 5790.1 5866.3 5839.6 5876.5 5890.2 5898.2 5969.0 5626.7 5797.0 5804.7 5807.7 5807.9 12:35:13 INFO - PROCESS | 2572 | 12:35:13 INFO - PROCESS | 2572 | [#1] ext.html Cycles:180 Average:73576.70 Median:39107.41 stddev:177013.04 (452.6%) stddev-sans-first:177424.52 12:35:13 INFO - PROCESS | 2572 | Values: 478.5 490.9 514.7 522.9 525.5 28990.6 38471.2 39072.8 39103.2 39111.6 41829.0 42298.2 42309.9 42417.8 42450.8 9562.2 9762.8 9770.6 9784.6 9791.8 9635.8 9723.3 9736.5 9740.8 9866.1 9776.3 9794.4 9820.6 9882.1 9893.5 9806.7 9897.0 9897.8 9902.7 9910.6 9675.8 9774.3 9792.4 9798.8 9824.9 40196.6 40582.6 40592.0 40605.2 40638.4 3110.8 3171.3 3241.7 3329.0 3336.4 24884.9 27502.0 27554.0 28136.0 28568.6 2687.7 2691.9 2740.3 2889.6 2937.2 429936.0 433373.7 433894.0 433927.0 435508.6 45457.3 64130.4 64762.0 64903.7 64928.7 45709.8 45752.5 45906.8 45942.5 46002.5 15202.4 15555.1 15570.8 15595.5 15599.2 12512.0 12588.9 12593.4 12593.8 12599.0 14583.6 14610.3 14821.8 14827.0 14853.7 6176.5 6271.2 6306.1 6306.2 6308.0 967.5 1009.4 1023.4 1071.7 1086.0 24970.0 29660.5 29708.7 29896.0 30595.0 936.9 946.3 1016.2 1088.1 1098.5 12387.0 14343.5 14534.6 14748.1 14840.9 670422.0 927496.0 973706.0 980531.0 984287.0 60929.0 61078.4 61867.0 61963.2 62024.0 1252.1 1421.6 1425.5 1440.3 1563.0 24669.8 29835.3 30006.5 30566.8 30635.5 54158.9 54550.9 54898.7 54982.7 55020.7 508650.0 510404.0 510834.0 510869.0 513678.0 32486.4 33884.5 33981.7 34016.7 34017.6 44821.6 45027.0 45182.0 45767.9 46579.0 37347.0 37606.0 38144.8 38292.0 38381.8 29856.3 36432.8 36610.6 37576.4 37723.1 36812.4 37604.1 37699.0 37811.7 37823.0 26045.1 32219.5 33462.8 33552.3 33614.7 23358.4 24740.6 24779.3 25387.4 25649.2 12:35:13 INFO - PROCESS | 2572 | 12:35:13 INFO - PROCESS | 2572 | [#2] jquery.html Cycles:180 Average:31625.21 Median:13839.95 stddev:88009.82 (635.9%) stddev-sans-first:88225.34 12:35:13 INFO - PROCESS | 2572 | Values: 332.1 348.9 368.9 370.7 374.9 15643.4 16160.0 19283.9 19860.3 20607.7 19264.4 19509.8 19803.1 19891.9 20205.0 5440.8 5662.6 5663.6 5829.4 5877.9 5787.5 5801.0 5814.7 5844.4 5847.2 5658.5 5702.3 5778.5 5795.4 5863.2 5771.3 5799.3 5832.3 5833.6 5834.9 4911.3 4997.5 5043.3 5066.6 5075.3 20563.6 25341.5 25501.1 25750.1 25779.0 2144.1 2205.6 2270.1 2338.4 2725.0 12337.6 14191.5 14550.1 14794.8 15210.4 1662.5 1721.4 1761.9 1799.5 1812.3 98225.5 98984.0 99832.5 101218.5 101818.0 10227.7 10435.5 10655.2 10665.2 10819.0 10671.7 11850.0 12215.8 12328.7 12829.9 8259.0 8336.2 8347.9 8394.0 8436.2 8651.1 8653.3 8660.6 8714.2 8748.9 6054.1 6160.8 6171.2 6175.6 6247.7 1788.9 1808.9 1811.0 1811.1 1853.2 877.0 927.7 940.9 1022.0 1040.6 19882.6 20503.5 20689.1 20702.0 21126.4 944.5 966.0 1000.1 1011.7 1036.8 7798.3 10892.6 11089.7 11108.3 11152.7 522612.8 526610.0 531026.0 532564.0 536653.3 73573.0 99104.0 102408.0 113846.0 124657.0 979.5 1012.6 1018.2 1019.0 1022.3 17289.0 17576.9 17609.3 17685.4 17726.4 50858.0 52547.5 53210.7 54251.5 56974.7 63249.8 63467.7 72671.6 74542.6 77612.0 8020.4 8201.3 8215.2 8245.0 8271.7 6892.7 11177.8 11453.7 13621.3 13884.4 11236.9 11497.2 11497.9 11616.8 11817.8 11305.5 11423.8 11456.5 11495.1 11971.9 11366.4 11832.7 11880.4 11965.3 12026.8 8037.1 8072.2 8172.1 8226.3 8317.0 8972.2 10118.5 11387.4 11937.9 11952.4 12:35:13 INFO - PROCESS | 2572 | 12:35:13 INFO - PROCESS | 2572 | [#3] mootools.html Cycles:180 Average:6004.99 Median:2855.05 stddev:3120.62 (109.3%) stddev-sans-first:3110.22 12:35:13 INFO - PROCESS | 2572 | Values: 1406.3 1535.8 1560.0 1799.1 1949.8 7929.3 8523.9 8617.1 8618.5 8673.5 8345.5 8612.0 8612.4 8625.4 8629.0 2168.4 2409.4 2472.9 2477.6 2514.4 2470.0 2510.2 2514.6 2516.0 2517.3 2462.7 2492.1 2493.9 2496.2 2501.2 2383.9 2443.9 2445.7 2452.1 2453.5 2425.5 2456.0 2479.7 2481.9 2484.1 8660.6 8725.9 8736.2 8743.6 8790.4 5326.6 5472.5 5491.8 5523.1 5541.4 3634.2 3636.6 3742.4 3745.5 3758.7 1043.9 1046.0 1058.2 1093.0 1093.5 11720.6 11797.8 11872.8 11894.7 11922.3 4973.4 5016.7 5032.4 5071.4 5092.4 10181.4 10209.5 10216.0 10235.4 10289.4 4986.1 5567.4 5579.4 5585.7 5593.7 4512.1 4832.5 4847.9 4850.4 4852.6 3986.0 3986.5 3994.8 4041.4 4043.5 1311.4 1317.3 1318.0 1323.2 1333.8 1084.4 1229.2 1294.3 1319.7 1349.1 8130.9 8138.1 8166.8 8169.0 8169.3 513.1 1084.3 1215.3 1270.5 1296.3 5197.0 6203.1 6245.8 6256.5 6269.5 10139.2 10266.3 10457.3 10623.7 10630.9 10338.6 10396.9 10479.9 10481.3 10491.8 7785.7 8134.2 8194.3 8325.3 8327.3 7649.8 7715.9 7829.2 7840.9 7856.2 8723.2 9011.3 9287.6 9430.6 9462.3 9146.6 9699.1 9776.8 9777.3 9793.0 6435.3 6637.0 6665.5 7257.3 7377.9 8077.8 8109.7 8150.5 8171.3 8197.0 7164.7 7315.4 7330.5 7428.0 7473.4 7193.8 7248.9 7258.4 7283.9 7292.9 7518.2 7647.7 7670.4 7700.0 7765.4 6979.5 7014.3 7027.2 7032.1 7053.3 6931.4 7131.3 7152.2 7158.3 7158.8 12:35:13 INFO - PROCESS | 2572 | 12:35:13 INFO - PROCESS | 2572 | [#4] prototype.html Cycles:180 Average:5761.95 Median:6537.28 stddev:1849.56 (28.3%) stddev-sans-first:1809.11 12:35:13 INFO - PROCESS | 2572 | Values: 321.5 327.6 331.6 333.5 337.5 6585.4 6586.4 6609.7 6610.1 6612.5 6513.7 6523.7 6534.4 6540.2 6574.9 3940.6 4843.1 4866.3 4875.5 4884.9 4866.0 4872.1 4872.6 4890.2 4898.5 4421.3 4575.6 4769.3 4831.3 4847.9 3897.8 4750.6 4766.9 4779.9 4794.4 4080.6 4085.9 4087.8 4091.8 4102.6 5992.6 6104.3 6213.9 6261.7 6298.8 5661.2 5683.6 5687.2 5691.6 5698.4 7008.6 7019.1 7029.6 7039.2 7050.5 4654.1 4656.9 4661.3 4668.1 4674.4 7009.5 7333.6 7374.0 7390.0 7420.0 4701.5 4760.5 4761.4 4762.3 4770.3 4821.7 4826.2 4827.5 4838.9 4843.0 5694.7 5706.0 5709.4 5712.9 5714.5 7014.0 7024.0 7028.5 7033.5 7039.6 1552.6 1651.0 1672.2 1673.7 1675.4 1035.0 1035.1 1050.3 1052.5 1052.5 5338.7 6476.1 6556.3 6562.2 6563.2 7134.1 7281.5 7288.2 7298.7 7299.6 5475.3 5791.9 6485.4 6616.1 6690.4 3698.9 3845.6 3911.2 3914.1 3915.8 6388.2 7680.9 7688.2 7689.8 7697.4 7312.9 7576.2 7624.0 7646.6 7652.4 7611.6 7651.0 7659.4 7666.2 7700.3 5989.5 7360.6 7360.9 7382.6 7405.5 7241.7 7258.6 7261.2 7277.4 7297.0 7385.0 7640.0 7645.6 7685.3 7732.1 4629.7 4663.7 4668.6 4671.4 4678.8 7316.7 7358.4 7389.7 7394.8 7401.4 7103.5 7106.3 7112.4 7118.1 7119.9 5794.4 6835.7 7092.6 7094.4 7097.1 6883.2 6936.1 6939.5 6944.2 6958.8 7071.6 7074.6 7086.2 7086.7 7092.1 6942.3 6947.7 6948.2 6954.8 6966.1 12:35:13 INFO - PROCESS | 2572 | 12:35:13 INFO - PROCESS | 2572 | [#5] yui.html Cycles:180 Average:18504.16 Median:647.42 stddev:26230.50 (4051.5%) stddev-sans-first:26269.89 12:35:13 INFO - PROCESS | 2572 | Values: 667.4 729.1 736.4 746.3 757.8 14618.2 14843.9 14847.6 14854.3 14870.7 12844.2 12860.4 12925.9 12930.8 12943.4 878.5 905.9 908.4 909.3 910.9 712.2 721.6 876.1 892.8 896.3 928.9 937.2 938.5 938.9 940.4 737.5 928.4 929.0 929.3 930.0 648.5 683.2 687.2 692.2 694.0 14865.3 14979.8 14995.7 15005.5 15106.0 12148.5 12260.1 12344.3 12668.9 12985.2 10051.9 10079.8 10162.9 10211.3 10929.2 3508.8 3516.8 3540.8 3589.9 3591.6 75729.6 76601.2 77073.8 85406.3 86268.6 9438.4 9526.9 9590.2 9679.7 9728.7 20495.6 20499.6 20524.9 20536.4 20542.2 7374.3 7528.1 7687.5 7695.3 7850.5 4051.3 4129.1 4133.7 4148.3 4308.1 3527.9 3535.6 3558.8 3572.5 3580.0 634.4 641.1 646.3 654.2 659.1 549.9 586.4 597.3 634.3 638.7 7740.7 9235.7 9283.6 9366.4 9499.9 540.1 575.6 593.7 618.7 625.0 3942.8 3987.0 4012.0 4064.3 4115.2 85485.0 86732.0 86865.1 90303.5 99477.0 82189.0 82837.0 83237.6 84264.0 84371.6 72936.0 72999.0 74126.0 74284.0 74887.0 8041.9 8100.4 8207.3 8213.2 8301.6 42695.0 49765.0 50096.2 50403.7 50909.2 68078.3 72062.0 72166.6 72212.0 73465.6 9627.6 9785.7 9833.0 10330.2 10444.8 11891.7 11928.6 11930.3 12065.8 12634.6 9459.8 11302.7 11791.9 11889.2 11916.3 11603.0 11901.0 11916.5 11918.2 11960.1 11233.7 11692.9 11794.0 11794.7 12386.6 9630.5 9668.9 9780.2 9831.8 10127.0 8118.4 9058.8 9179.8 9928.7 10039.8 12:35:13 INFO - PROCESS | 2572 | -------- Summary: end -------- 12:35:13 INFO - PROCESS | 2572 | 12:35:13 INFO - TEST-INFO | 2572: exit 0 12:35:13 INFO - TEST-OK | dromaeo_css | took 1114065ms 12:35:13 INFO - TEST-START | kraken 12:35:13 INFO - operating with platform_type : mac_ 12:35:13 INFO - Initialising browser for kraken test... 12:35:13 INFO - TEST-INFO | started process 2575 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmpwsRNyK/profile http://localhost:52088/getInfo.html) 12:35:15 INFO - PROCESS | 2575 | __metrics Screen width/height:1600/1200 12:35:15 INFO - PROCESS | 2575 | colorDepth:24 12:35:15 INFO - PROCESS | 2575 | Browser inner width/height: 1024/689 12:35:15 INFO - PROCESS | 2575 | __metrics 12:35:15 INFO - PROCESS | 2575 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:35:15 INFO - PROCESS | 2575 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:35:16 INFO - TEST-INFO | 2575: exit 0 12:35:16 INFO - Browser initialized. 12:35:16 INFO - Running cycle 1/1 for kraken test... 12:35:16 INFO - TEST-INFO | started process 2577 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmpwsRNyK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:35:28 INFO - PROCESS | 2577 | RSS: Main: 244666368 12:35:28 INFO - PROCESS | 2577 | 12:35:31 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:52088/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52088/tests/kraken/driver.html?testName=audio-beat-detection) 12:35:31 INFO - PROCESS | 2577 | RSS: Main: 290729984 12:35:31 INFO - PROCESS | 2577 | 12:35:34 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:52088/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52088/tests/kraken/driver.html?testName=audio-dft) 12:35:35 INFO - PROCESS | 2577 | RSS: Main: 301592576 12:35:35 INFO - PROCESS | 2577 | 12:35:38 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:52088/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52088/tests/kraken/driver.html?testName=audio-fft) 12:35:38 INFO - PROCESS | 2577 | RSS: Main: 287580160 12:35:38 INFO - PROCESS | 2577 | 12:35:40 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:52088/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52088/tests/kraken/driver.html?testName=audio-oscillator) 12:35:41 INFO - PROCESS | 2577 | RSS: Main: 289288192 12:35:41 INFO - PROCESS | 2577 | 12:35:43 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:52088/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52088/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:35:44 INFO - PROCESS | 2577 | RSS: Main: 288866304 12:35:44 INFO - PROCESS | 2577 | 12:35:46 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:52088/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52088/tests/kraken/driver.html?testName=imaging-darkroom) 12:35:47 INFO - PROCESS | 2577 | RSS: Main: 288555008 12:35:47 INFO - PROCESS | 2577 | 12:35:50 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:52088/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52088/tests/kraken/driver.html?testName=imaging-desaturate) 12:35:50 INFO - PROCESS | 2577 | RSS: Main: 290672640 12:35:50 INFO - PROCESS | 2577 | 12:35:53 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:52088/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52088/tests/kraken/driver.html?testName=json-parse-financial) 12:35:54 INFO - PROCESS | 2577 | RSS: Main: 292274176 12:35:54 INFO - PROCESS | 2577 | 12:35:55 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:52088/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52088/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:35:56 INFO - PROCESS | 2577 | RSS: Main: 326234112 12:35:56 INFO - PROCESS | 2577 | 12:35:58 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:52088/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52088/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:35:58 INFO - PROCESS | 2577 | RSS: Main: 324145152 12:35:58 INFO - PROCESS | 2577 | 12:36:00 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:52088/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52088/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:36:01 INFO - PROCESS | 2577 | RSS: Main: 331878400 12:36:01 INFO - PROCESS | 2577 | 12:36:03 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:52088/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52088/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:36:04 INFO - PROCESS | 2577 | RSS: Main: 332713984 12:36:04 INFO - PROCESS | 2577 | 12:36:06 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:52088/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52088/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:36:07 INFO - PROCESS | 2577 | RSS: Main: 333914112 12:36:07 INFO - PROCESS | 2577 | 12:36:09 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:52088/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52088/tests/kraken/driver.html?testName=ai-astar) 12:36:09 INFO - PROCESS | 2577 | RSS: Main: 394129408 12:36:09 INFO - PROCESS | 2577 | 12:36:09 INFO - PROCESS | 2577 | __start_tp_report 12:36:09 INFO - PROCESS | 2577 | _x_x_mozilla_page_load 12:36:09 INFO - PROCESS | 2577 | _x_x_mozilla_page_load_details 12:36:09 INFO - PROCESS | 2577 | |i|pagename|runs| 12:36:09 INFO - PROCESS | 2577 | |0;ai-astar;111;108;110;110;117;159;168;110;111;109 12:36:09 INFO - PROCESS | 2577 | |1;audio-beat-detection;161;106;170;189;138;142;141;121;160;122 12:36:09 INFO - PROCESS | 2577 | |2;audio-dft;185;185;185;185;186;188;189;181;181;183 12:36:09 INFO - PROCESS | 2577 | |3;audio-fft;74;77;88;77;56;57;57;81;78;56 12:36:09 INFO - PROCESS | 2577 | |4;audio-oscillator;93;94;126;80;80;83;113;78;78;110 12:36:09 INFO - PROCESS | 2577 | |5;imaging-gaussian-blur;84;90;85;90;85;90;102;139;84;91 12:36:09 INFO - PROCESS | 2577 | |6;imaging-darkroom;94;98;94;94;94;93;93;93;92;93 12:36:09 INFO - PROCESS | 2577 | |7;imaging-desaturate;89;86;87;87;88;89;87;89;92;72 12:36:09 INFO - PROCESS | 2577 | |8;json-parse-financial;57;53;52;54;54;52;54;64;51;53 12:36:09 INFO - PROCESS | 2577 | |9;json-stringify-tinderbox;66;63;70;79;73;70;67;68;67;68 12:36:09 INFO - PROCESS | 2577 | |10;stanford-crypto-aes;83;83;84;82;86;81;84;82;85;84 12:36:09 INFO - PROCESS | 2577 | |11;stanford-crypto-ccm;121;124;122;124;122;127;127;126;128;119 12:36:09 INFO - PROCESS | 2577 | |12;stanford-crypto-pbkdf2;140;163;172;135;139;127;139;156;139;138 12:36:09 INFO - PROCESS | 2577 | |13;stanford-crypto-sha256-iterative;67;70;89;96;96;93;67;66;67;67 12:36:09 INFO - PROCESS | 2577 | __end_tp_report 12:36:09 INFO - PROCESS | 2577 | __start_cc_report 12:36:09 INFO - PROCESS | 2577 | _x_x_mozilla_cycle_collect,1178 12:36:09 INFO - PROCESS | 2577 | __end_cc_report 12:36:09 INFO - PROCESS | 2577 | __startTimestamp1456173369669__endTimestamp 12:36:09 INFO - PROCESS | 2577 | 12:36:09 INFO - PROCESS | 2577 | ------- Summary: start ------- 12:36:09 INFO - PROCESS | 2577 | Number of tests: 14 12:36:09 INFO - PROCESS | 2577 | 12:36:09 INFO - PROCESS | 2577 | [#0] ai-astar Cycles:10 Average:121.30 Median:111.00 stddev:22.47 (20.2%) stddev-sans-first:23.52 12:36:09 INFO - PROCESS | 2577 | Values: 111.0 108.0 110.0 110.0 117.0 159.0 168.0 110.0 111.0 109.0 12:36:09 INFO - PROCESS | 2577 | 12:36:09 INFO - PROCESS | 2577 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:151.00 stddev:25.26 (16.7%) stddev-sans-first:26.12 12:36:09 INFO - PROCESS | 2577 | Values: 161.0 106.0 170.0 189.0 138.0 142.0 141.0 121.0 160.0 122.0 12:36:09 INFO - PROCESS | 2577 | 12:36:09 INFO - PROCESS | 2577 | [#2] audio-dft Cycles:10 Average:184.80 Median:185.00 stddev:2.62 (1.4%) stddev-sans-first:2.77 12:36:09 INFO - PROCESS | 2577 | Values: 185.0 185.0 185.0 185.0 186.0 188.0 189.0 181.0 181.0 183.0 12:36:09 INFO - PROCESS | 2577 | 12:36:09 INFO - PROCESS | 2577 | [#3] audio-fft Cycles:10 Average:70.10 Median:77.00 stddev:12.26 (15.9%) stddev-sans-first:12.92 12:36:09 INFO - PROCESS | 2577 | Values: 74.0 77.0 88.0 77.0 56.0 57.0 57.0 81.0 78.0 56.0 12:36:09 INFO - PROCESS | 2577 | 12:36:09 INFO - PROCESS | 2577 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:80.00 stddev:17.21 (21.5%) stddev-sans-first:18.25 12:36:09 INFO - PROCESS | 2577 | Values: 93.0 94.0 126.0 80.0 80.0 83.0 113.0 78.0 78.0 110.0 12:36:09 INFO - PROCESS | 2577 | 12:36:09 INFO - PROCESS | 2577 | [#5] imaging-gaussian-blur Cycles:10 Average:94.00 Median:87.50 stddev:16.69 (19.1%) stddev-sans-first:17.31 12:36:09 INFO - PROCESS | 2577 | Values: 84.0 90.0 85.0 90.0 85.0 90.0 102.0 139.0 84.0 91.0 12:36:09 INFO - PROCESS | 2577 | 12:36:09 INFO - PROCESS | 2577 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:1.62 (1.7%) stddev-sans-first:1.72 12:36:09 INFO - PROCESS | 2577 | Values: 94.0 98.0 94.0 94.0 94.0 93.0 93.0 93.0 92.0 93.0 12:36:09 INFO - PROCESS | 2577 | 12:36:09 INFO - PROCESS | 2577 | [#7] imaging-desaturate Cycles:10 Average:86.60 Median:88.50 stddev:5.40 (6.1%) stddev-sans-first:5.66 12:36:09 INFO - PROCESS | 2577 | Values: 89.0 86.0 87.0 87.0 88.0 89.0 87.0 89.0 92.0 72.0 12:36:09 INFO - PROCESS | 2577 | 12:36:09 INFO - PROCESS | 2577 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:3.75 (6.9%) stddev-sans-first:3.86 12:36:09 INFO - PROCESS | 2577 | Values: 57.0 53.0 52.0 54.0 54.0 52.0 54.0 64.0 51.0 53.0 12:36:09 INFO - PROCESS | 2577 | 12:36:09 INFO - PROCESS | 2577 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:4.38 (6.4%) stddev-sans-first:4.50 12:36:09 INFO - PROCESS | 2577 | Values: 66.0 63.0 70.0 79.0 73.0 70.0 67.0 68.0 67.0 68.0 12:36:09 INFO - PROCESS | 2577 | 12:36:09 INFO - PROCESS | 2577 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:84.00 stddev:1.51 (1.8%) stddev-sans-first:1.59 12:36:09 INFO - PROCESS | 2577 | Values: 83.0 83.0 84.0 82.0 86.0 81.0 84.0 82.0 85.0 84.0 12:36:09 INFO - PROCESS | 2577 | 12:36:09 INFO - PROCESS | 2577 | [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:125.00 stddev:2.98 (2.4%) stddev-sans-first:2.96 12:36:09 INFO - PROCESS | 2577 | Values: 121.0 124.0 122.0 124.0 122.0 127.0 127.0 126.0 128.0 119.0 12:36:09 INFO - PROCESS | 2577 | 12:36:09 INFO - PROCESS | 2577 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.80 Median:139.50 stddev:14.06 (10.1%) stddev-sans-first:14.81 12:36:09 INFO - PROCESS | 2577 | Values: 140.0 163.0 172.0 135.0 139.0 127.0 139.0 156.0 139.0 138.0 12:36:09 INFO - PROCESS | 2577 | 12:36:09 INFO - PROCESS | 2577 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.80 Median:79.50 stddev:13.69 (17.2%) stddev-sans-first:13.95 12:36:09 INFO - PROCESS | 2577 | Values: 67.0 70.0 89.0 96.0 96.0 93.0 67.0 66.0 67.0 67.0 12:36:09 INFO - PROCESS | 2577 | -------- Summary: end -------- 12:36:09 INFO - PROCESS | 2577 | 12:36:10 INFO - TEST-INFO | 2577: exit 0 12:36:10 INFO - TEST-OK | kraken | took 56775ms 12:36:10 INFO - SUITE-END | took 1170s 12:36:10 INFO - Completed test suite (00:19:31) 12:36:10 INFO - Working with test: dromaeo_css 12:36:10 INFO - Generating results file: dromaeo_css 12:36:10 INFO - Working with test: kraken 12:36:10 INFO - Generating results file: kraken 12:36:10 INFO - javascript benchmark 12:36:10 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:36:11 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 12:36:11 INFO - process_Request line: dromaeo_css 7497.80 graph.html#tests=[[72,64,59]] 12:36:11 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:36:11 INFO - process_Request line: kraken 1442.60 graph.html#tests=[[232,64,59]] 12:36:11 INFO - RETURN: dromaeo_css: 7497.80 12:36:11 INFO - RETURN: kraken: 1442.60 12:36:11 INFO - javascript benchmark 12:36:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3350.3801796667617, 3383.2387712764616, 3417.606975197853, 3425.1265927188565, 3441.827908604569, 5470.152126420411, 5523.7238138093135, 5523.972380138099, 5546.306711661043, 5567.220589117527, 5581.49766521013, 5586.525145362639, 5603.2435621191225, 5659.037963546197, 5685.0, 4948.010397920412, 4949.455559888409, 4957.182064959277, 4965.528274813905, 5172.146595811687, 4643.16423043852, 4895.241237608177, 5086.084504789136, 5090.898182036357, 5127.154019586782, 4991.700497970115, 5018.197088465864, 5058.468860769622, 5097.6941383517105, 5163.974180129113, 5032.169692000852, 5072.974635126838, 5080.263361812554, 5087.084324821531, 5090.0583392072585, 4977.352944117278, 5021.799128034874, 5042.067217564762, 5046.697198168122, 5073.0, 4467.419235499397, 5452.4274951129955, 5488.231647569343, 5514.80698175562, 5571.721413929328, 6100.45095941363, 6114.571979961404, 6124.938750612481, 6128.693565321716, 6134.04922237054, 6026.276846778371, 6118.405988989689, 6215.782447614311, 6227.1282020517165, 6242.625442473466, 5655.321361436613, 5682.460166284196, 5698.6580805151, 5701.40135285789, 5721.4850663440075, 6283.08895210192, 6284.528660350492, 6291.874162516816, 6294.527910406738, 6320.273168585672, 5105.923411148836, 5838.94161058384, 5950.613210141327, 5977.442484318413, 5979.372165922516, 6153.538484613672, 6154.446099851035, 6158.815235542941, 6167.629942203482, 6171.814845554641, 6085.69571521431, 6089.877367678366, 6098.795324190732, 6106.542009349228, 6125.29649783737, 6019.729112189962, 6074.483668888106, 6095.6952152392205, 6124.6325220486915, 6143.542582966759, 4048.716589838742, 4797.856064318076, 4815.783289751969, 4817.759112044454, 4835.637327200474, 4284.143171365677, 4303.741775493418, 4311.159323931866, 4328.285832837547, 4356.956430435718, 5183.170692689152, 5536.972315138399, 5580.274564306615, 5582.358028826656, 5621.128725047624, 4956.727379994135, 6157.784477543264, 6174.845628859224, 6210.72051757672, 6241.78153764616, 5464.726763661801, 5585.162225666182, 5585.69278689676, 5596.076647353222, 5607.158926161109, 5218.0, 5227.738613069408, 5228.503292187236, 5263.289455923478, 5290.68255904647, 6276.121343011982, 6281.0, 6282.963311053625, 6287.025511045796, 6289.622622642656, 6079.696015199311, 6119.357467465852, 6185.907211391743, 6199.318075011655, 6212.720427580679, 6248.812535623939, 6301.558890877594, 6301.716422761078, 6312.337204593451, 6328.7152078157515, 5997.700114994145, 6102.084687296941, 6108.930937086081, 6112.663803490851, 6113.510919126548, 6043.2748070231855, 6059.182010428536, 6120.7551697931585, 6193.907091393723, 6202.782902598387, 5919.467247947533, 5943.940560594512, 5956.225690660186, 5957.731902064331, 5960.0761881908375, 5886.793962211302, 5928.881422371443, 5940.61386009908, 5944.732487038007, 5962.821115366546, 5626.43735626434, 5739.942600574108, 5787.652740835563, 5790.073588225863, 5866.266716660418, 5839.562032847469, 5876.500497457764, 5890.175375447355, 5898.174255604305, 5969.0, 5626.738452199089, 5796.971015144897, 5804.738786754522, 5807.651540907559, 5807.883842323215], "unit": "score", "name": "dojo.html", "value": 5560.830571520705}, {"lowerIsBetter": false, "replicates": [478.54538188720704, 490.93372394726714, 514.7040451740248, 522.9346331708537, 525.4692760312083, 28990.565141522868, 38471.23057538851, 39072.80463597681, 39103.21793564134, 39111.608883911154, 41829.0, 42298.154036919244, 42309.94225144373, 42417.78791106048, 42450.7877460613, 9562.235021198323, 9762.755931101743, 9770.560324785401, 9784.559694813715, 9791.755206119833, 9635.807283854354, 9723.319367644232, 9736.464494452837, 9740.75648108796, 9866.112049915506, 9776.266779991494, 9794.363366381198, 9820.558074886612, 9882.110610045094, 9893.4558599277, 9806.705798826046, 9896.95051524745, 9897.80204395908, 9902.653407130789, 9910.55402506889, 9675.758106047335, 9774.31579789415, 9792.363496372713, 9798.804023919552, 9824.852627210597, 40196.59803401987, 40582.594174058475, 40591.985200369934, 40605.18789624191, 40638.39042414366, 3110.766692498049, 3171.2864605463815, 3241.675832416763, 3329.017939707792, 3336.4161271777584, 24884.875575622187, 27502.0, 27554.0, 28136.0, 28568.571471427946, 2687.7446642568925, 2691.946161076787, 2740.328619488218, 2889.58101075345, 2937.1922721251613, 429936.0, 433373.6662633365, 433894.0, 433927.0, 435508.64491355, 45457.31814022792, 64130.35869641337, 64762.02856957149, 64903.67548162229, 64928.67535662386, 45709.7714511432, 45752.54247457549, 45906.770466147456, 45942.540574594495, 46002.53997460049, 15202.391904323924, 15555.14446705442, 15570.766438503431, 15595.532134035997, 15599.220038998004, 12511.999040076773, 12588.937055314847, 12593.370331483573, 12593.811092833615, 12598.992080633527, 14583.635409114644, 14610.26948652563, 14821.77767333491, 14827.0, 14853.702925941638, 6176.505879529627, 6271.184745983084, 6306.148669929593, 6306.211723534559, 6308.0, 967.4630580028152, 1009.369144284822, 1023.4217667018111, 1071.7374243310283, 1086.0, 24970.0, 29660.458502410467, 29708.702912971024, 29896.0, 30595.0, 936.8501039833594, 946.3328353510758, 1016.1768967136643, 1088.0968795899385, 1098.4892025208317, 12387.009039276836, 14343.497977570734, 14534.563963081124, 14748.115113093034, 14840.92579537117, 670422.0, 927496.0, 973706.0, 980531.0, 984287.0, 60929.0, 61078.38921610727, 61867.0, 61963.211655475614, 62024.0, 1252.1172573335593, 1421.5593166118535, 1425.4512012874911, 1440.337444775415, 1562.9531114066597, 24669.753302467463, 29835.270591176104, 30006.54990175193, 30566.84716576403, 30635.54046689257, 54158.916821662555, 54550.90898182093, 54898.72550637221, 54982.72508637431, 55020.724896375265, 508650.0, 510404.0, 510834.0, 510869.0, 513678.0, 32486.35027299488, 33884.49173262453, 33981.66018339884, 34016.65983340135, 34017.577714897896, 44821.55178448174, 45027.0, 45182.0, 45767.855803605176, 46579.0, 37347.0, 37606.0, 38144.80927595344, 38292.0, 38381.80809095937, 29856.25359366033, 36432.81783591065, 36610.63389366072, 37576.43635345417, 37723.11384430822, 36812.447813282284, 37604.059898502754, 37699.0, 37811.67659131917, 37823.0, 26045.0884219059, 32219.516707248942, 33462.82880099185, 33552.32895342031, 33614.663853361155, 23358.416039599146, 24740.628890567015, 24779.25662230136, 25387.36531586725, 25649.230523084338], "unit": "score", "name": "ext.html", "value": 19480.17927545569}, {"lowerIsBetter": false, "replicates": [332.08510553425316, 348.89533140057983, 368.9225262694834, 370.6608453265262, 374.8687959214277, 15643.374265029413, 16160.0, 19283.903580482096, 19860.304889328876, 20607.690884636744, 19264.422067338, 19509.804901950974, 19803.108860101293, 19891.900540497278, 20205.0, 5440.80302333488, 5662.5753068519925, 5663.631863928831, 5829.358770535259, 5877.853053673671, 5787.450192231731, 5801.0, 5814.738336774834, 5844.386339434362, 5847.239858818348, 5658.490735833774, 5702.287214098238, 5778.451047150535, 5795.420457954213, 5863.208466856983, 5771.336296325934, 5799.333076696171, 5832.329282132524, 5833.591648584601, 5834.883302333951, 4911.336969509106, 4997.525235102659, 5043.268726034741, 5066.594672426197, 5075.289459475676, 20563.588728225503, 25341.493170136495, 25501.107461238767, 25750.09874654378, 25779.0, 2144.0887622760265, 2205.5699138667965, 2270.126001489422, 2338.40370705469, 2724.9727502725113, 12337.568185113478, 14191.503297384543, 14550.054246474052, 14794.778078328834, 15210.391584336723, 1662.4929396534053, 1721.3975108711975, 1761.9030953297563, 1799.4691565988064, 1812.28414776164, 98225.50887245589, 98984.0, 99832.52260944752, 101218.49390753073, 101818.0, 10227.744306392251, 10435.478226088666, 10655.200859935536, 10665.200109991627, 10819.0, 10671.679849604525, 11850.0, 12215.75568488643, 12328.691782705504, 12829.935850320875, 8258.958705206436, 8336.208060234389, 8347.916520834835, 8394.034686011064, 8436.156384361637, 8651.134886511298, 8653.307735381155, 8660.610272537751, 8714.215720585178, 8748.8687669685, 6054.091886217103, 6160.7535698571555, 6171.228596425447, 6175.62946223228, 6247.687615619201, 1788.919498622539, 1808.9366872159674, 1810.9909450452926, 1811.1306572845108, 1853.2401715296664, 876.9912300877037, 927.7448701607112, 940.8635747816666, 1021.9627078515313, 1040.6357774778767, 19882.60234795296, 20503.487412814502, 20689.0689918951, 20701.963117192303, 21126.366209013755, 944.4616568555857, 966.0, 1000.134748693681, 1011.6863772230632, 1036.7563622548696, 7798.259165379393, 10892.564297428173, 11089.667309980714, 11108.277961932448, 11152.665420037412, 522612.773872264, 526610.0, 531026.0, 532564.0, 536653.3167334138, 73573.0, 99104.0, 102408.0, 113846.0, 124657.0, 979.4612962870535, 1012.5899010900597, 1018.2108865629049, 1018.9694309170736, 1022.3303736052898, 17289.049102299494, 17576.91211543934, 17609.29562817473, 17685.38101166453, 17726.379576714753, 50858.0, 52547.474525255784, 53210.73394633002, 54251.45748542464, 56974.71512642576, 63249.786257480766, 63467.73064538775, 72671.63664181645, 74542.62728686322, 77612.0, 8020.398470114881, 8201.30288925448, 8215.178482151738, 8245.0, 8271.669133234604, 6892.689828957608, 11177.826328235744, 11453.713657158305, 13621.318934053059, 13884.375203116086, 11236.94381528087, 11497.195196336175, 11497.942510287396, 11616.767664646828, 11817.763644726885, 11305.547778088785, 11423.771524569629, 11456.484458199568, 11495.137864660017, 11971.880281197426, 11366.431678416211, 11832.704182395164, 11880.405979700807, 11965.341906195243, 12026.75946481083, 8037.115917248981, 8072.233137851895, 8172.141925097779, 8226.30076443485, 8317.0, 8972.237359824489, 10118.49407529606, 11387.405763192994, 11937.940310298392, 11952.402379880798], "unit": "score", "name": "jquery.html", "value": 9389.425343468925}, {"lowerIsBetter": false, "replicates": [1406.3319923036565, 1535.7849901013856, 1559.9844001559982, 1799.0914588132998, 1949.7660280766302, 7929.286364227226, 8523.914760852389, 8617.095205003478, 8618.482891026528, 8673.479591224523, 8345.499270043802, 8612.00961889383, 8612.39713220075, 8625.439346442477, 8628.964524257082, 2168.4253672776726, 2409.3856066702965, 2472.851628902272, 2477.5911974524274, 2514.358838496181, 2469.9873052048665, 2510.159096702607, 2514.6102354135137, 2516.043903316737, 2517.307740371394, 2462.7167875694254, 2492.090387008747, 2493.87530623469, 2496.2012156110054, 2501.1746123779108, 2383.9046438142454, 2443.9389015274583, 2445.6576079348906, 2452.0682140786566, 2453.460238747473, 2425.514897020603, 2455.9754402455924, 2479.7024357077084, 2481.8759062047006, 2484.1305543059966, 8660.566971651393, 8725.869111963326, 8736.170063843925, 8743.606537705818, 8790.428622139605, 5326.6005049621435, 5472.480114389126, 5491.835244942658, 5523.1163013917985, 5541.418151094158, 3634.164142247298, 3636.5817930938015, 3742.438634204864, 3745.4569087482437, 3758.661720445173, 1043.8747350317935, 1045.989540104597, 1058.185197398007, 1093.03812644872, 1093.5243169221415, 11720.648380548597, 11797.823032654604, 11872.821907671392, 11894.702632434171, 11922.284662920252, 4973.353464049723, 5016.673916195436, 5032.421271553745, 5071.39143302806, 5092.439831618519, 10181.440020798927, 10209.489525523693, 10216.0, 10235.437050962268, 10289.43408112546, 4986.102501549756, 5567.387587365387, 5579.358373787067, 5585.720713964285, 5593.74828132735, 4512.097580483916, 4832.516748325139, 4847.878803029953, 4850.393700787402, 4852.611791056707, 3985.960140398617, 3986.5216174059296, 3994.78028708418, 4041.4139949707715, 4043.5147782266317, 1311.4033114932683, 1317.2820812657126, 1318.0049062957405, 1323.245749922535, 1333.7599232138114, 1084.4306738962107, 1229.2317301686446, 1294.3463550906731, 1319.6700824793802, 1349.1230700045048, 8130.918690813134, 8138.145494723087, 8166.754997350089, 8168.959155204186, 8169.346452283803, 513.099510359317, 1084.3168803653648, 1215.2647648172906, 1270.510853321478, 1296.3323888197585, 5197.0, 6203.131561581382, 6245.781397651061, 6256.468200203034, 6269.529785266123, 10139.239557033252, 10266.281360304856, 10457.320274182306, 10623.681289561171, 10630.946845265878, 10338.638147664946, 10396.908324625956, 10479.895201048044, 10481.266311358284, 10491.842622360671, 7785.688572457038, 8134.1698117923, 8194.344452443791, 8325.25072743456, 8327.292180164633, 7649.808754781175, 7715.922840771745, 7829.177936316605, 7840.882386764089, 7856.214378562327, 8723.214910658071, 9011.324150688855, 9287.6284948604, 9430.622775089194, 9462.290328225274, 9146.634134634805, 9699.078587534173, 9776.804463910825, 9777.266704997295, 9792.951035244778, 6435.324290949383, 6637.0, 6665.466762659073, 7257.310555497219, 7377.8524429510035, 8077.798055048671, 8109.7161599343735, 8150.510969341858, 8171.305439037748, 8196.959015204886, 7164.67758950838, 7315.414766818535, 7330.486865919548, 7428.0, 7473.439492038227, 7193.784186474414, 7248.855022899618, 7258.383037441666, 7283.890741638774, 7292.927070729224, 7518.210587888412, 7647.655855486405, 7670.42471814605, 7700.0, 7765.417593680384, 6979.476539259677, 7014.263502332182, 7027.191872934678, 7032.050673159262, 7053.294670532906, 6931.376176144171, 7131.25121862197, 7152.249013853679, 7158.319959603829, 7158.785236442915], "unit": "score", "name": "mootools.html", "value": 4917.172276810216}, {"lowerIsBetter": false, "replicates": [321.5177234148777, 327.5643394285599, 331.633544932849, 333.4564659604844, 337.54431517451445, 6585.374389433002, 6586.407223349897, 6609.702563384647, 6610.107635469216, 6612.537122401433, 6513.706883190256, 6523.6738163091895, 6534.379233972777, 6540.182477190351, 6574.8685026299445, 3940.586238444965, 4843.104025755238, 4866.270059491087, 4875.536824001714, 4884.853454396374, 4865.951340486603, 4872.147374209517, 4872.6345524085655, 4890.21756518957, 4898.51014898509, 4421.292593185091, 4575.633949284049, 4769.332293478916, 4831.347768051321, 4847.927281090769, 3897.766134031953, 4750.572448479654, 4766.928496072579, 4779.880502987418, 4794.376731024944, 4080.5511393746665, 4085.8774236772647, 4087.816048277805, 4091.7954102294766, 4102.610252026053, 5992.64044157352, 6104.328523862371, 6213.943629582982, 6261.749530018794, 6298.842528936813, 5661.179129026309, 5683.602147849652, 5687.175359572881, 5691.630044047124, 5698.43015698431, 7008.579485230903, 7019.087518622598, 7029.578225306447, 7039.190493093309, 7050.541714788523, 4654.069186162781, 4656.906861862743, 4661.254199328125, 4668.066386722635, 4674.415698037746, 7009.474289428263, 7333.596652184127, 7374.0, 7390.0, 7420.0, 4701.459332176843, 4760.476347601761, 4761.428628564525, 4762.333273341735, 4770.284457331428, 4821.686590371684, 4826.155422800995, 4827.468978412372, 4838.903221935612, 4842.95157048425, 5694.658320500783, 5706.0, 5709.371969083398, 5712.942870571324, 5714.457126572969, 7014.0, 7023.964880175668, 7028.543144695578, 7033.507654464139, 7039.648017599099, 1552.6118470382405, 1651.0, 1672.222416576298, 1673.7322028475628, 1675.4052311429512, 1034.9534270957824, 1035.0839507036328, 1050.3172937590475, 1052.5368837711383, 1052.547404616007, 5338.706371149547, 6476.093346931433, 6556.3443655634055, 6562.212534495796, 6563.245226798979, 7134.143902731706, 7281.490295679251, 7288.161861385903, 7298.70090921358, 7299.635018249066, 5475.288212532345, 5791.884162316815, 6485.4487368573255, 6616.106825578581, 6690.364415380531, 3698.870539531157, 3845.6346647068485, 3911.2177564487215, 3914.0606254499285, 3915.8433662653742, 6388.233411990591, 7680.9231907680205, 7688.192739762357, 7689.807754806175, 7697.4226932980255, 7312.853742925112, 7576.166621671612, 7624.046994125734, 7646.579438130845, 7652.387808975269, 7611.619419029026, 7650.961745191238, 7659.387249020065, 7666.156722760492, 7700.3454706350585, 5989.460948514655, 7360.595167265852, 7360.889586656097, 7382.5570465772225, 7405.518641288299, 7241.746538871114, 7258.564486130849, 7261.237570055279, 7277.417806575567, 7297.0, 7385.0, 7639.961800191186, 7645.61771911391, 7685.346745526693, 7732.110807257012, 4629.722216667011, 4663.673542851968, 4668.5564871337165, 4671.392718946515, 4678.783516285722, 7316.670749816378, 7358.411327093927, 7389.704411823467, 7394.815129621803, 7401.4078873688895, 7103.467239957127, 7106.289371062852, 7112.395446387115, 7118.110236220473, 7119.85760284781, 5794.3626201117, 6835.658217089225, 7092.645367731696, 7094.3969762568695, 7097.077379940574, 6883.174019117738, 6936.098307220231, 6939.548929319578, 6944.201416836926, 6958.826029349307, 7071.611061391673, 7074.646267686492, 7086.185088714864, 7086.716531338689, 7092.148942126978, 6942.340477654615, 6947.65261736901, 6948.235694073547, 6954.79135625932, 6966.12923384577], "unit": "score", "name": "prototype.html", "value": 5143.102977694386}, {"lowerIsBetter": false, "replicates": [667.4460198035631, 729.1214087025136, 736.4035131543449, 746.2947514598707, 757.7575175943697, 14618.195999220052, 14843.851561484382, 14847.585055437256, 14854.257287135653, 14870.702585948275, 12844.165129266614, 12860.356982150879, 12925.935370323159, 12930.806037909439, 12943.352832358369, 878.5431575580694, 905.9003509613938, 908.4322298563397, 909.2816674826879, 910.8588168833808, 712.1845486917476, 721.588694444167, 876.1107475911955, 892.848215803315, 896.2829736211005, 928.8792456980583, 937.1752857485437, 938.4838338913604, 938.9014153513886, 940.4075432477564, 737.5242968285426, 928.424376886328, 929.0, 929.3262384771054, 929.9721008369726, 648.5136147889083, 683.1733602341174, 687.1685260834396, 692.2039654397433, 693.9548929319578, 14865.331060102322, 14979.775303370458, 14995.700085998327, 15005.474808381654, 15106.018108822891, 12148.45331960064, 12260.080493962989, 12344.259344439273, 12668.936655316757, 12985.220886746825, 10051.949740251324, 10079.848802267972, 10162.898371016268, 10211.336263142946, 10929.234953553254, 3508.824558772051, 3516.753827232095, 3540.805255710935, 3589.856405743767, 3591.586967498745, 75729.62135189289, 76601.23398765997, 77073.84389234165, 85406.29187416217, 86268.56865715694, 9438.386504877299, 9526.904730952601, 9590.184834289164, 9679.66121185755, 9728.659496917573, 20495.590088198154, 20499.59000820005, 20524.89737551303, 20536.38390848277, 20542.17831286732, 7374.299441553044, 7528.134264559646, 7687.500312479671, 7695.268949449794, 7850.528968261922, 4051.2910240707756, 4129.112240868228, 4133.689973252018, 4148.253314403436, 4308.116836048603, 3527.9294414111573, 3535.5934067582043, 3558.839852206657, 3572.4641303804638, 3580.03339098442, 634.3624657219465, 641.1120597971842, 646.3278190681732, 654.1822721598003, 659.0509666080828, 549.9285092937893, 586.3901542395946, 597.3220394851875, 634.2579182356561, 638.7221558622015, 7740.690372385154, 9235.722928312161, 9283.58223879927, 9366.438013719198, 9499.90500095004, 540.0575994888866, 575.6200907401095, 593.6853467662146, 618.7463140112533, 624.9875002499924, 3942.7777389009498, 3986.960130398717, 4012.0, 4064.309067458539, 4115.1975364804175, 85485.0, 86732.0, 86865.13134868696, 90303.54848225717, 99477.0104597904, 82189.0, 82837.0, 83237.58381208056, 84264.0, 84371.57814210889, 72936.0, 72999.0, 74126.0, 74284.0, 74887.0, 8041.919580804117, 8100.35197184212, 8207.302379297827, 8213.219744124299, 8301.626426810928, 42695.0, 49765.0, 50096.24855627241, 50403.74798125986, 50909.218177365095, 68078.3192168072, 72062.0, 72166.63916680383, 72212.0, 73465.6326718363, 9627.5667594957, 9785.657501987396, 9832.96753840865, 10330.225233107698, 10444.843327349943, 11891.702707432383, 11928.58249961282, 11930.284182949052, 12065.81901271464, 12634.557790477289, 9459.763505912408, 11302.717432064264, 11791.88208117908, 11889.227200231957, 11916.285022898654, 11603.0, 11900.988415984739, 11916.463759130687, 11918.225315354473, 11960.102992275788, 11233.71915702114, 11692.94153529261, 11794.0, 11794.705132371759, 12386.62840114798, 9630.47032413224, 9668.9033109668, 9780.168685661798, 9831.803363932824, 10127.037931396506, 8118.391120665856, 9058.818823623622, 9179.816403672023, 9928.702138935843, 10039.799204015733], "unit": "score", "name": "yui.html", "value": 6906.463761839283}], "name": "dromaeo_css", "value": 7497.798976779082}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 110.0, 110.0, 117.0, 159.0, 168.0, 110.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 121.3}, {"lowerIsBetter": true, "replicates": [161.0, 106.0, 170.0, 189.0, 138.0, 142.0, 141.0, 121.0, 160.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [185.0, 185.0, 185.0, 185.0, 186.0, 188.0, 189.0, 181.0, 181.0, 183.0], "unit": "score", "name": "audio-dft", "value": 184.8}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 88.0, 77.0, 56.0, 57.0, 57.0, 81.0, 78.0, 56.0], "unit": "score", "name": "audio-fft", "value": 70.1}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 126.0, 80.0, 80.0, 83.0, 113.0, 78.0, 78.0, 110.0], "unit": "score", "name": "audio-oscillator", "value": 93.5}, {"lowerIsBetter": true, "replicates": [84.0, 90.0, 85.0, 90.0, 85.0, 90.0, 102.0, 139.0, 84.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 94.0}, {"lowerIsBetter": true, "replicates": [94.0, 98.0, 94.0, 94.0, 94.0, 93.0, 93.0, 93.0, 92.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.8}, {"lowerIsBetter": true, "replicates": [89.0, 86.0, 87.0, 87.0, 88.0, 89.0, 87.0, 89.0, 92.0, 72.0], "unit": "score", "name": "imaging-desaturate", "value": 86.6}, {"lowerIsBetter": true, "replicates": [57.0, 53.0, 52.0, 54.0, 54.0, 52.0, 54.0, 64.0, 51.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.4}, {"lowerIsBetter": true, "replicates": [66.0, 63.0, 70.0, 79.0, 73.0, 70.0, 67.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 84.0, 82.0, 86.0, 81.0, 84.0, 82.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [121.0, 124.0, 122.0, 124.0, 122.0, 127.0, 127.0, 126.0, 128.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.0}, {"lowerIsBetter": true, "replicates": [140.0, 163.0, 172.0, 135.0, 139.0, 127.0, 139.0, 156.0, 139.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.8}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 89.0, 96.0, 96.0, 93.0, 67.0, 66.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 77.8}], "name": "kraken", "value": 1442.6}]} 12:36:11 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1442.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7497.80"}}} 12:36:11 INFO - Return code: 0 12:36:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:36:11 INFO - # TBPL SUCCESS # 12:36:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:36:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:36:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:36:11 INFO - 2016-02-22 12:36:11.405 screenresolution[2581:21574] starting screenresolution argv=screenresolution get 12:36:11 INFO - 2016-02-22 12:36:11.408 screenresolution[2581:21574] Display 0: 1600x1200x32@60 12:36:11 INFO - 2016-02-22 12:36:11.414 screenresolution[2582:21577] starting screenresolution argv=screenresolution list 12:36:11 INFO - Available Modes on Display 0 12:36:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:36:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:36:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:36:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:36:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:36:11 INFO - Intel Iris: 12:36:11 INFO - Chipset Model: Intel Iris 12:36:11 INFO - Type: GPU 12:36:11 INFO - Bus: Built-In 12:36:11 INFO - VRAM (Dynamic, Max): 1536 MB 12:36:11 INFO - Vendor: Intel (0x8086) 12:36:11 INFO - Device ID: 0x0a2e 12:36:11 INFO - Revision ID: 0x0009 12:36:11 INFO - Displays: 12:36:11 INFO - Display: 12:36:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:36:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:36:11 INFO - Display Serial Number: 1600x1200 60 12:36:11 INFO - Main Display: Yes 12:36:11 INFO - Mirror: Off 12:36:11 INFO - Online: Yes 12:36:11 INFO - Rotation: Supported 12:36:11 INFO - Return code: 0 12:36:11 INFO - Running post-action listener: _resource_record_post_action 12:36:11 INFO - Running post-run listener: _resource_record_post_run 12:36:12 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 0; Write bytes: 704784384; Read time: 0; Write time: 1936 12:36:12 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 403884544; Write bytes: 404764160; Read time: 30419; Write time: 737 12:36:12 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 0; Write bytes: 298291712; Read time: 0; Write time: 1191 12:36:12 INFO - Running post-run listener: _upload_blobber_files 12:36:12 INFO - Blob upload gear active. 12:36:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:36:12 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 12:36:12 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'] 12:36:12 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 12:36:13 INFO - (blobuploader) - INFO - Open directory for files ... 12:36:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:36:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:36:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:36:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:36:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:36:13 INFO - (blobuploader) - INFO - Done attempting. 12:36:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:36:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:36:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:36:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:36:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:36:14 INFO - (blobuploader) - INFO - Done attempting. 12:36:14 INFO - (blobuploader) - INFO - Iteration through files over. 12:36:14 INFO - Return code: 0 12:36:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:36:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:36:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdc726309b3eab5c54275eb9069a6b4f4eaba4998bb10b11dc875128363e57fe8b400b0a08a51105d0ac4b09783f9c9d8553d6e2358306ef8bd119fd6b7d8ce5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b5b450165f5fe254ab56a432b5a470fa85a95873dd85c04ba65828eeccd067c8902d0bd3bb3f3f6908ff820fba0a9e4a405d41a71afdc4a3218838a986388bd4"} 12:36:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:36:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:36:14 INFO - Contents: 12:36:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdc726309b3eab5c54275eb9069a6b4f4eaba4998bb10b11dc875128363e57fe8b400b0a08a51105d0ac4b09783f9c9d8553d6e2358306ef8bd119fd6b7d8ce5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b5b450165f5fe254ab56a432b5a470fa85a95873dd85c04ba65828eeccd067c8902d0bd3bb3f3f6908ff820fba0a9e4a405d41a71afdc4a3218838a986388bd4"} 12:36:14 INFO - Running post-run listener: copy_logs_to_upload_dir 12:36:14 INFO - Copying logs to upload dir... 12:36:14 INFO - mkdir: /builds/slave/test/build/upload/logs 12:36:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.573962 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-02-22 12:36:14.977168) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 12:36:14.981112) ========= 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.EeGZltctQo/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.2zr3MZCNuW/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdc726309b3eab5c54275eb9069a6b4f4eaba4998bb10b11dc875128363e57fe8b400b0a08a51105d0ac4b09783f9c9d8553d6e2358306ef8bd119fd6b7d8ce5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b5b450165f5fe254ab56a432b5a470fa85a95873dd85c04ba65828eeccd067c8902d0bd3bb3f3f6908ff820fba0a9e4a405d41a71afdc4a3218838a986388bd4"} build_url:https://queue.taskcluster.net/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011035 build_url: 'https://queue.taskcluster.net/v1/task/eyhACxtjS9CDBKOgYbEQDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdc726309b3eab5c54275eb9069a6b4f4eaba4998bb10b11dc875128363e57fe8b400b0a08a51105d0ac4b09783f9c9d8553d6e2358306ef8bd119fd6b7d8ce5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b5b450165f5fe254ab56a432b5a470fa85a95873dd85c04ba65828eeccd067c8902d0bd3bb3f3f6908ff820fba0a9e4a405d41a71afdc4a3218838a986388bd4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 12:36:15.013070) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 12:36:15.013415) ========= 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.EeGZltctQo/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.2zr3MZCNuW/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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.005290 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 12:36:15.065632) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 12:36:15.065947) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 12:36:15.066366) ========= ========= Total master_lag: 0.26 =========