builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0038 starttime: 1456468754.76 results: success (0) buildid: 20160225204826 builduid: cf5eca0fc3e7445398820d82de4b6fe1 revision: 4e0bcdfc72de10bbfd2216a0d08081d9aecc3709 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 22:39:14.764391) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 22:39:14.764899) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 22:39:14.765230) ========= 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.kGeNRgSkup/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.eRtGfBMPwM/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.006024 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 22:39:14.789699) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 22:39:14.790046) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 22:39:14.805395) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 22:39:14.805704) ========= 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.kGeNRgSkup/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.eRtGfBMPwM/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.005533 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 22:39:14.857402) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 22:39:14.858000) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 22:39:14.858720) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 22:39:14.859054) ========= 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.kGeNRgSkup/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.eRtGfBMPwM/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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-25 22:39:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 47.6M=0s 2016-02-25 22:39:15 (47.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185360 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 22:39:15.066827) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 22:39:15.067197) ========= 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.kGeNRgSkup/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.eRtGfBMPwM/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.020380 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 22:39:15.119460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-25 22:39:15.120270) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4e0bcdfc72de10bbfd2216a0d08081d9aecc3709 --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 4e0bcdfc72de10bbfd2216a0d08081d9aecc3709 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kGeNRgSkup/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.eRtGfBMPwM/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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-25 22:39:15,195 truncating revision to first 12 chars 2016-02-25 22:39:15,195 Setting DEBUG logging. 2016-02-25 22:39:15,195 attempt 1/10 2016-02-25 22:39:15,195 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4e0bcdfc72de?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-25 22:39:15,973 unpacking tar archive at: fx-team-4e0bcdfc72de/testing/mozharness/ program finished with exit code 0 elapsedTime=1.044574 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-25 22:39:16.183589) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 22:39:16.184294) ========= echo 4e0bcdfc72de10bbfd2216a0d08081d9aecc3709 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4e0bcdfc72de10bbfd2216a0d08081d9aecc3709'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kGeNRgSkup/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.eRtGfBMPwM/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 4e0bcdfc72de10bbfd2216a0d08081d9aecc3709 program finished with exit code 0 elapsedTime=0.005132 script_repo_revision: '4e0bcdfc72de10bbfd2216a0d08081d9aecc3709' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 22:39:16.236193) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 22:39:16.236546) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 22:39:16.250651) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-25 22:39:16.251037) ========= /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.kGeNRgSkup/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.eRtGfBMPwM/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 22:39:16 INFO - MultiFileLogger online at 20160225 22:39:16 in /builds/slave/test 22:39:16 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 22:39:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:39:16 INFO - {'append_to_log': False, 22:39:16 INFO - 'base_work_dir': '/builds/slave/test', 22:39:16 INFO - 'blob_upload_branch': 'Fx-Team', 22:39:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:39:16 INFO - 'branch': 'Fx-Team', 22:39:16 INFO - 'buildbot_json_path': 'buildprops.json', 22:39:16 INFO - 'config_files': ('talos/mac_config.py',), 22:39:16 INFO - 'default_actions': ('clobber', 22:39:16 INFO - 'read-buildbot-config', 22:39:16 INFO - 'download-and-extract', 22:39:16 INFO - 'populate-webroot', 22:39:16 INFO - 'create-virtualenv', 22:39:16 INFO - 'install', 22:39:16 INFO - 'run-tests'), 22:39:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:39:16 INFO - 'download_minidump_stackwalk': True, 22:39:16 INFO - 'download_symbols': 'ondemand', 22:39:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:39:16 INFO - 'tooltool.py': '/tools/tooltool.py', 22:39:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:39:16 INFO - '/tools/misc-python/virtualenv.py')}, 22:39:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:39:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:39:16 INFO - 'installer_path': 'installer.exe', 22:39:16 INFO - 'log_level': 'info', 22:39:16 INFO - 'log_name': 'talos', 22:39:16 INFO - 'log_to_console': True, 22:39:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:39:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:39:16 INFO - 'opt_config_files': (), 22:39:16 INFO - 'pip_index': False, 22:39:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:39:16 INFO - 'cmd': ('bash', 22:39:16 INFO - '-c', 22:39:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:39:16 INFO - 'enabled': True, 22:39:16 INFO - 'halt_on_failure': False, 22:39:16 INFO - 'name': 'check_screen_resolution'},), 22:39:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:39:16 INFO - 'cmd': ('bash', 22:39:16 INFO - '-c', 22:39:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:39:16 INFO - 'enabled': True, 22:39:16 INFO - 'halt_on_failure': False, 22:39:16 INFO - 'name': 'check_screen_resolution'},), 22:39:16 INFO - 'run_cmd_checks_enabled': True, 22:39:16 INFO - 'sps_profile': False, 22:39:16 INFO - 'sps_profile_interval': 0, 22:39:16 INFO - 'suite': 'dromaeojs', 22:39:16 INFO - 'system_bits': '32', 22:39:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:39:16 INFO - 'title': 't-yosemite-r7-0038', 22:39:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:39:16 INFO - 'use_talos_json': True, 22:39:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:39:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:39:16 INFO - 'work_dir': 'build'} 22:39:16 INFO - ##### 22:39:16 INFO - ##### Running clobber step. 22:39:16 INFO - ##### 22:39:16 INFO - Running pre-action listener: _resource_record_pre_action 22:39:16 INFO - Running main action method: clobber 22:39:16 INFO - rmtree: /builds/slave/test/build 22:39:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:39:17 INFO - Running post-action listener: _resource_record_post_action 22:39:17 INFO - ##### 22:39:17 INFO - ##### Running read-buildbot-config step. 22:39:17 INFO - ##### 22:39:17 INFO - Running pre-action listener: _resource_record_pre_action 22:39:17 INFO - Running main action method: read_buildbot_config 22:39:17 INFO - Using buildbot properties: 22:39:17 INFO - { 22:39:17 INFO - "project": "", 22:39:17 INFO - "product": "firefox", 22:39:17 INFO - "script_repo_revision": "production", 22:39:17 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 22:39:17 INFO - "repository": "", 22:39:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 22:39:17 INFO - "buildid": "20160225204826", 22:39:17 INFO - "pgo_build": "False", 22:39:17 INFO - "basedir": "/builds/slave/test", 22:39:17 INFO - "buildnumber": 415, 22:39:17 INFO - "slavename": "t-yosemite-r7-0038", 22:39:17 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 22:39:17 INFO - "platform": "yosemite_r7", 22:39:17 INFO - "scheduler": "tests-fx-team-macosx64-talos", 22:39:17 INFO - "branch": "fx-team", 22:39:17 INFO - "repo_path": "integration/fx-team", 22:39:17 INFO - "revision": "4e0bcdfc72de10bbfd2216a0d08081d9aecc3709", 22:39:17 INFO - "stage_platform": "macosx64", 22:39:17 INFO - "builduid": "cf5eca0fc3e7445398820d82de4b6fe1", 22:39:17 INFO - "slavebuilddir": "test" 22:39:17 INFO - } 22:39:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 22:39:17 INFO - Running post-action listener: _resource_record_post_action 22:39:17 INFO - ##### 22:39:17 INFO - ##### Running download-and-extract step. 22:39:17 INFO - ##### 22:39:17 INFO - Running pre-action listener: _resource_record_pre_action 22:39:17 INFO - Running main action method: download_and_extract 22:39:17 INFO - mkdir: /builds/slave/test/build/tests 22:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:17 INFO - https://queue.taskcluster.net/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:39:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/artifacts/public/build/test_packages.json 22:39:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/artifacts/public/build/test_packages.json 22:39:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:39:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:39:19 INFO - Downloaded 1277 bytes. 22:39:19 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:39:19 INFO - Using the following test package requirements: 22:39:19 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 22:39:19 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 22:39:19 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 22:39:19 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 22:39:19 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 22:39:19 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 22:39:19 INFO - u'jsshell-mac.zip'], 22:39:19 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 22:39:19 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 22:39:19 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 22:39:19 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 22:39:19 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 22:39:19 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 22:39:19 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 22:39:19 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 22:39:19 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 22:39:19 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 22:39:19 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 22:39:19 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 22:39:19 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:19 INFO - https://queue.taskcluster.net/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:39:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 22:39:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 22:39:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/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 22:39:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/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 22:39:21 INFO - Downloaded 17830506 bytes. 22:39:21 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'] 22:39:21 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 22:39:24 INFO - Return code: 0 22:39:24 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 22:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:24 INFO - https://queue.taskcluster.net/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:39:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 22:39:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 22:39:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/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 22:39:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/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 22:39:25 INFO - Downloaded 17830506 bytes. 22:39:25 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'] 22:39:25 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 22:39:28 INFO - Return code: 0 22:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:28 INFO - https://queue.taskcluster.net/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 22:39:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 22:39:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 22:39:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/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 22:39:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/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 22:39:30 INFO - Downloaded 10713410 bytes. 22:39:30 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'] 22:39:30 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 22:39:30 INFO - Return code: 0 22:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:30 INFO - https://queue.taskcluster.net/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 22:39:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 22:39:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 22:39:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 22:39:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/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 22:39:33 INFO - Downloaded 111443519 bytes. 22:39:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 22:39:33 INFO - mkdir: /builds/slave/test/properties 22:39:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:39:33 INFO - Writing to file /builds/slave/test/properties/build_url 22:39:33 INFO - Contents: 22:39:33 INFO - build_url:https://queue.taskcluster.net/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 22:39:34 INFO - Running post-action listener: _resource_record_post_action 22:39:34 INFO - Running post-action listener: set_extra_try_arguments 22:39:34 INFO - ##### 22:39:34 INFO - ##### Running populate-webroot step. 22:39:34 INFO - ##### 22:39:34 INFO - Running pre-action listener: _resource_record_pre_action 22:39:34 INFO - Running main action method: populate_webroot 22:39:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:39:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:39:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:39:34 INFO - '--tppagecycles', 22:39:34 INFO - '7'], 22:39:34 INFO - 'tests': ['tsvgm']}}, 22:39:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:39:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:39:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:39:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:39:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:39:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:39:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:39:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:39:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:39:34 INFO - 'talos_options': ['--e10s'], 22:39:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:39:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:39:34 INFO - 'tests': ['damp', 'tps']}, 22:39:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:39:34 INFO - 'talos_options': ['--e10s'], 22:39:34 INFO - 'tests': ['damp', 'tps']}, 22:39:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:39:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:39:34 INFO - 'other': {'tests': ['a11yr', 22:39:34 INFO - 'ts_paint', 22:39:34 INFO - 'tpaint', 22:39:34 INFO - 'sessionrestore', 22:39:34 INFO - 'sessionrestore_no_auto_restore']}, 22:39:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:39:34 INFO - 'tests': ['a11yr', 22:39:34 INFO - 'ts_paint', 22:39:34 INFO - 'tpaint', 22:39:34 INFO - 'sessionrestore', 22:39:34 INFO - 'sessionrestore_no_auto_restore']}, 22:39:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:39:34 INFO - 'tests': ['a11yr', 22:39:34 INFO - 'ts_paint', 22:39:34 INFO - 'tpaint', 22:39:34 INFO - 'sessionrestore', 22:39:34 INFO - 'sessionrestore_no_auto_restore']}, 22:39:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:39:34 INFO - 'tests': ['a11yr', 22:39:34 INFO - 'ts_paint', 22:39:34 INFO - 'tpaint', 22:39:34 INFO - 'sessionrestore', 22:39:34 INFO - 'sessionrestore_no_auto_restore']}, 22:39:34 INFO - 'other_l64': {'tests': ['a11yr', 22:39:34 INFO - 'ts_paint', 22:39:34 INFO - 'tpaint', 22:39:34 INFO - 'sessionrestore', 22:39:34 INFO - 'sessionrestore_no_auto_restore']}, 22:39:34 INFO - 'other_nol64': {'tests': ['a11yr', 22:39:34 INFO - 'ts_paint', 22:39:34 INFO - 'tpaint', 22:39:34 INFO - 'sessionrestore', 22:39:34 INFO - 'sessionrestore_no_auto_restore']}, 22:39:34 INFO - 'svgr': {'tests': ['tsvgx', 22:39:34 INFO - 'tsvgr_opacity', 22:39:34 INFO - 'tart', 22:39:34 INFO - 'tscrollx', 22:39:34 INFO - 'cart']}, 22:39:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:39:34 INFO - 'tests': ['tsvgx', 22:39:34 INFO - 'tsvgr_opacity', 22:39:34 INFO - 'tart', 22:39:34 INFO - 'tscrollx', 22:39:34 INFO - 'cart']}, 22:39:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:39:34 INFO - 'tests': ['tp5o']}, 22:39:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:39:34 INFO - 'talos_options': ['--e10s'], 22:39:34 INFO - 'tests': ['tp5o']}, 22:39:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:39:34 INFO - 'talos_options': ['--xperf_path', 22:39:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:39:34 INFO - 'tests': ['tp5n']}, 22:39:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:39:34 INFO - 'talos_options': ['--e10s', 22:39:34 INFO - '--xperf_path', 22:39:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:39:34 INFO - 'tests': ['tp5n']}}, 22:39:34 INFO - 'talos.zip': {'path': '', 22:39:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:39:34 INFO - Running post-action listener: _resource_record_post_action 22:39:34 INFO - ##### 22:39:34 INFO - ##### Running create-virtualenv step. 22:39:34 INFO - ##### 22:39:34 INFO - Running pre-action listener: _resource_record_pre_action 22:39:34 INFO - Running main action method: create_virtualenv 22:39:34 INFO - Creating virtualenv /builds/slave/test/build/venv 22:39:34 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 22:39:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:39:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:39:34 INFO - Using real prefix '/tools/python27' 22:39:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:39:35 INFO - Installing distribute.............................................................................................................................................................................................done. 22:39:38 INFO - Installing pip.................done. 22:39:38 INFO - Return code: 0 22:39:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:39: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')]} 22:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39: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')]} 22:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101abfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ac74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0d0c9a390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101963d30>, '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 0x101787db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10195ab20>, '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.kGeNRgSkup/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.eRtGfBMPwM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 22:39: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', 'pip>=1.5'] in /builds/slave/test/build 22:39: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 pip>=1.5 22:39:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kGeNRgSkup/Render', 22:39:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:39:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:39:38 INFO - 'HOME': '/Users/cltbld', 22:39:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:39:38 INFO - 'LOGNAME': 'cltbld', 22:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:38 INFO - 'MOZ_NO_REMOTE': '1', 22:39:38 INFO - 'NO_EM_RESTART': '1', 22:39:38 INFO - 'PAGER': '/bin/cat', 22:39:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:38 INFO - 'PWD': '/builds/slave/test', 22:39:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:39:38 INFO - 'SHELL': '/bin/bash', 22:39:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRtGfBMPwM/Listeners', 22:39:38 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 22:39:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:39:38 INFO - 'USER': 'cltbld', 22:39:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:39:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:38 INFO - 'XPC_FLAGS': '0x0', 22:39:38 INFO - 'XPC_SERVICE_NAME': '0', 22:39:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:38 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 22:39:38 INFO - Cleaning up... 22:39:38 INFO - Return code: 0 22:39:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:39: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')]} 22:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39: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')]} 22:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39: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', '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 0x101abfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ac74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0d0c9a390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101963d30>, '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 0x101787db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10195ab20>, '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.kGeNRgSkup/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.eRtGfBMPwM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 22:39: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', 'psutil>=0.7.1'] in /builds/slave/test/build 22:39: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 psutil>=0.7.1 22:39:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kGeNRgSkup/Render', 22:39:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:39:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:39:38 INFO - 'HOME': '/Users/cltbld', 22:39:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:39:38 INFO - 'LOGNAME': 'cltbld', 22:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:38 INFO - 'MOZ_NO_REMOTE': '1', 22:39:38 INFO - 'NO_EM_RESTART': '1', 22:39:38 INFO - 'PAGER': '/bin/cat', 22:39:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:38 INFO - 'PWD': '/builds/slave/test', 22:39:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:39:38 INFO - 'SHELL': '/bin/bash', 22:39:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRtGfBMPwM/Listeners', 22:39:38 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 22:39:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:39:38 INFO - 'USER': 'cltbld', 22:39:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:39:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:38 INFO - 'XPC_FLAGS': '0x0', 22:39:38 INFO - 'XPC_SERVICE_NAME': '0', 22:39:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:38 INFO - Downloading/unpacking psutil>=0.7.1 22:39: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 22:39: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 22:39: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 22:39: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 22:39: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 22:39: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 22:39:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:39:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:39:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:39:41 INFO - Installing collected packages: psutil 22:39:41 INFO - Running setup.py install for psutil 22:39:41 INFO - building 'psutil._psutil_osx' extension 22:39:41 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 22:39:41 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 22:39:42 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 22:39:42 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 22:39:42 INFO - building 'psutil._psutil_posix' extension 22:39:42 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 22:39:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:39:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:39:42 INFO - ^ 22:39:42 INFO - 1 warning generated. 22:39:42 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 22:39:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:39:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:39:42 INFO - Successfully installed psutil 22:39:42 INFO - Cleaning up... 22:39:42 INFO - Return code: 0 22:39:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:39:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:42 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 0x101abfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ac74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0d0c9a390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101963d30>, '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 0x101787db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10195ab20>, '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.kGeNRgSkup/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.eRtGfBMPwM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 22:39:42 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 22:39:42 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 22:39:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kGeNRgSkup/Render', 22:39:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:39:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:39:42 INFO - 'HOME': '/Users/cltbld', 22:39:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:39:42 INFO - 'LOGNAME': 'cltbld', 22:39:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:42 INFO - 'MOZ_NO_REMOTE': '1', 22:39:42 INFO - 'NO_EM_RESTART': '1', 22:39:42 INFO - 'PAGER': '/bin/cat', 22:39:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:39:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:42 INFO - 'PWD': '/builds/slave/test', 22:39:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:39:42 INFO - 'SHELL': '/bin/bash', 22:39:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRtGfBMPwM/Listeners', 22:39:42 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 22:39:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:39:42 INFO - 'USER': 'cltbld', 22:39:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:39:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:39:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:42 INFO - 'XPC_FLAGS': '0x0', 22:39:42 INFO - 'XPC_SERVICE_NAME': '0', 22:39:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:39:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:39:42 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 22:39:42 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 22:39:42 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 22:39:42 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 22:39:42 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 22:39:42 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 22:39:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:39:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:39:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:39:45 INFO - Installing collected packages: mozsystemmonitor 22:39:45 INFO - Running setup.py install for mozsystemmonitor 22:39:45 INFO - Successfully installed mozsystemmonitor 22:39:45 INFO - Cleaning up... 22:39:45 INFO - Return code: 0 22:39:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:39:45 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')]} 22:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:45 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')]} 22:39:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:45 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 0x101abfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ac74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0d0c9a390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101963d30>, '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 0x101787db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10195ab20>, '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.kGeNRgSkup/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.eRtGfBMPwM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 22:39:45 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 22:39:45 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 22:39:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kGeNRgSkup/Render', 22:39:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:39:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:39:45 INFO - 'HOME': '/Users/cltbld', 22:39:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:39:45 INFO - 'LOGNAME': 'cltbld', 22:39:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:45 INFO - 'MOZ_NO_REMOTE': '1', 22:39:45 INFO - 'NO_EM_RESTART': '1', 22:39:45 INFO - 'PAGER': '/bin/cat', 22:39:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:39:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:45 INFO - 'PWD': '/builds/slave/test', 22:39:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:39:45 INFO - 'SHELL': '/bin/bash', 22:39:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRtGfBMPwM/Listeners', 22:39:45 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 22:39:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:39:45 INFO - 'USER': 'cltbld', 22:39:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:39:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:39:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:45 INFO - 'XPC_FLAGS': '0x0', 22:39:45 INFO - 'XPC_SERVICE_NAME': '0', 22:39:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:39:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:45 INFO - Downloading/unpacking blobuploader==1.2.4 22:39:45 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 22:39:45 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 22:39:45 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 22:39:45 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 22:39:45 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 22:39:45 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 22:39:47 INFO - Downloading blobuploader-1.2.4.tar.gz 22:39:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:39:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:39:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:39:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:39:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:39:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:39:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:39:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:39:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:39:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:39:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:39:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:39:49 INFO - Downloading docopt-0.6.1.tar.gz 22:39:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:39:49 INFO - Installing collected packages: blobuploader, requests, docopt 22:39:49 INFO - Running setup.py install for blobuploader 22:39:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:39:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:39:49 INFO - Running setup.py install for requests 22:39:49 INFO - Running setup.py install for docopt 22:39:50 INFO - Successfully installed blobuploader requests docopt 22:39:50 INFO - Cleaning up... 22:39:50 INFO - Return code: 0 22:39:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:39: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')]} 22:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39: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')]} 22:39:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:50 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 0x101abfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ac74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0d0c9a390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101963d30>, '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 0x101787db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10195ab20>, '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.kGeNRgSkup/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.eRtGfBMPwM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 22:39:50 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 22:39:50 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 22:39:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kGeNRgSkup/Render', 22:39:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:39:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:39:50 INFO - 'HOME': '/Users/cltbld', 22:39:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:39:50 INFO - 'LOGNAME': 'cltbld', 22:39:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:50 INFO - 'MOZ_NO_REMOTE': '1', 22:39:50 INFO - 'NO_EM_RESTART': '1', 22:39:50 INFO - 'PAGER': '/bin/cat', 22:39:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:39:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:50 INFO - 'PWD': '/builds/slave/test', 22:39:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:39:50 INFO - 'SHELL': '/bin/bash', 22:39:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRtGfBMPwM/Listeners', 22:39:50 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 22:39:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:39:50 INFO - 'USER': 'cltbld', 22:39:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:39:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:39:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:50 INFO - 'XPC_FLAGS': '0x0', 22:39:50 INFO - 'XPC_SERVICE_NAME': '0', 22:39:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:39:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:39:50 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-cPydTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:39:50 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-7cBl0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:39:50 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-RSBMZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:39:50 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-EKyrZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:39:50 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-BMarfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:39:50 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-t22FQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:39:50 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-K6B9XY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:39:51 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-52X1Dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:39:51 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-XB_gDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:39:51 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-E0205f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:39:51 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-EeunGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:39:51 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-iBKKxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:39:51 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-MyDeVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:39:51 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-8jMLIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:39:51 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-yV4Sw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:39:51 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-q9NXeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:39:52 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-vLgKZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:39:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:39:52 INFO - Running setup.py install for manifestparser 22:39:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:39:52 INFO - Running setup.py install for mozcrash 22:39:52 INFO - Running setup.py install for mozdebug 22:39:52 INFO - Running setup.py install for mozdevice 22:39:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:39:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:39:52 INFO - Running setup.py install for mozfile 22:39:52 INFO - Running setup.py install for mozhttpd 22:39:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:39:53 INFO - Running setup.py install for mozinfo 22:39:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:39:53 INFO - Running setup.py install for mozInstall 22:39:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:39:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:39:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:39:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:39:53 INFO - Running setup.py install for mozleak 22:39:53 INFO - Running setup.py install for mozlog 22:39:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:39:53 INFO - Running setup.py install for moznetwork 22:39:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:39:53 INFO - Running setup.py install for mozprocess 22:39:53 INFO - Running setup.py install for mozprofile 22:39:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:39:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:39:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:39:54 INFO - Running setup.py install for mozrunner 22:39:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:39:54 INFO - Running setup.py install for mozscreenshot 22:39:54 INFO - Running setup.py install for moztest 22:39:54 INFO - Running setup.py install for mozversion 22:39:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:39:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:39:54 INFO - Cleaning up... 22:39:54 INFO - Return code: 0 22:39:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:54 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 0x101abfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ac74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0d0c9a390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101963d30>, '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 0x101787db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10195ab20>, '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.kGeNRgSkup/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.eRtGfBMPwM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 22:39:54 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 22:39:54 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 22:39:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kGeNRgSkup/Render', 22:39:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:39:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:39:54 INFO - 'HOME': '/Users/cltbld', 22:39:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:39:54 INFO - 'LOGNAME': 'cltbld', 22:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:54 INFO - 'MOZ_NO_REMOTE': '1', 22:39:54 INFO - 'NO_EM_RESTART': '1', 22:39:54 INFO - 'PAGER': '/bin/cat', 22:39:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:54 INFO - 'PWD': '/builds/slave/test', 22:39:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:39:54 INFO - 'SHELL': '/bin/bash', 22:39:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRtGfBMPwM/Listeners', 22:39:54 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 22:39:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:39:54 INFO - 'USER': 'cltbld', 22:39:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:39:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:54 INFO - 'XPC_FLAGS': '0x0', 22:39:54 INFO - 'XPC_SERVICE_NAME': '0', 22:39:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:39:55 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-HGDJTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:39:55 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)) 22:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:39:55 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-7cbESg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:39:55 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)) 22:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:39:55 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-4YQnK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:39:55 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)) 22:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:39:55 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-jlrNFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:39:55 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)) 22:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:39:55 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-dyOl_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:39:55 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)) 22:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:39:55 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-BOOfoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:39:55 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)) 22:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:39:55 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-Pd9i_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:39:55 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)) 22:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:39:55 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-joW3WD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:39:55 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)) 22:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:39:55 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-nBrt3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:39:55 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)) 22:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:39:55 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-uqsdLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:39:56 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)) 22:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:39:56 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-dhU3bm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:39:56 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)) 22:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:39:56 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-Vw2E7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:39:56 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)) 22:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:39:56 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-jG_N_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:39:56 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)) 22:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:39:56 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-J5lf6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:39:56 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)) 22:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:39:56 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-4iyWu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:39:56 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)) 22:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:39:56 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-G47mvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:39:56 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)) 22:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:39:56 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-Y2vJ6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:39:56 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)) 22:39:56 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)) 22:39:56 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)) 22:39:56 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)) 22:39:56 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)) 22:39:56 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)) 22:39:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:39: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 22:39: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 22:39: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 22:39: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 22:39: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 22:39: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 22:39:59 INFO - Downloading blessings-1.6.tar.gz 22:39:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:39:59 INFO - Installing collected packages: blessings 22:39:59 INFO - Running setup.py install for blessings 22:39:59 INFO - Successfully installed blessings 22:39:59 INFO - Cleaning up... 22:39:59 INFO - Return code: 0 22:39:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:39:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:39:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:39:59 INFO - Reading from file tmpfile_stdout 22:39:59 INFO - Current package versions: 22:39:59 INFO - blessings == 1.6 22:39:59 INFO - blobuploader == 1.2.4 22:39:59 INFO - docopt == 0.6.1 22:39:59 INFO - manifestparser == 1.1 22:39:59 INFO - mozInstall == 1.12 22:39:59 INFO - mozcrash == 0.16 22:39:59 INFO - mozdebug == 0.1 22:39:59 INFO - mozdevice == 0.48 22:39:59 INFO - mozfile == 1.2 22:39:59 INFO - mozhttpd == 0.7 22:39:59 INFO - mozinfo == 0.9 22:39:59 INFO - mozleak == 0.1 22:39:59 INFO - mozlog == 3.1 22:39:59 INFO - moznetwork == 0.27 22:39:59 INFO - mozprocess == 0.22 22:39:59 INFO - mozprofile == 0.28 22:39:59 INFO - mozrunner == 6.11 22:39:59 INFO - mozscreenshot == 0.1 22:39:59 INFO - mozsystemmonitor == 0.0 22:39:59 INFO - moztest == 0.7 22:39:59 INFO - mozversion == 1.4 22:39:59 INFO - psutil == 3.1.1 22:39:59 INFO - requests == 1.2.3 22:39:59 INFO - wsgiref == 0.1.2 22:39:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:39: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')]} 22:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39: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')]} 22:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:59 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 0x101abfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ac74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0d0c9a390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101963d30>, '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 0x101787db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10195ab20>, '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.kGeNRgSkup/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.eRtGfBMPwM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 22:39:59 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 22:39:59 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 22:39:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kGeNRgSkup/Render', 22:39:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:39:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:39:59 INFO - 'HOME': '/Users/cltbld', 22:39:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:39:59 INFO - 'LOGNAME': 'cltbld', 22:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:59 INFO - 'MOZ_NO_REMOTE': '1', 22:39:59 INFO - 'NO_EM_RESTART': '1', 22:39:59 INFO - 'PAGER': '/bin/cat', 22:39:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:59 INFO - 'PWD': '/builds/slave/test', 22:39:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:39:59 INFO - 'SHELL': '/bin/bash', 22:39:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRtGfBMPwM/Listeners', 22:39:59 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 22:39:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:39:59 INFO - 'USER': 'cltbld', 22:39:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:39:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:59 INFO - 'XPC_FLAGS': '0x0', 22:39:59 INFO - 'XPC_SERVICE_NAME': '0', 22:39:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:00 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)) 22:40:00 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)) 22:40:00 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)) 22:40:00 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)) 22:40:00 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)) 22:40:00 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)) 22:40:00 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)) 22:40:00 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)) 22:40:00 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)) 22:40:00 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)) 22:40:00 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)) 22:40:00 INFO - Cleaning up... 22:40:00 INFO - Return code: 0 22:40:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:00 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 0x101abfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ac74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0d0c9a390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101963d30>, '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 0x101787db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10195ab20>, '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.kGeNRgSkup/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.eRtGfBMPwM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 22:40:00 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 22:40:00 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 22:40:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kGeNRgSkup/Render', 22:40:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:40:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:40:00 INFO - 'HOME': '/Users/cltbld', 22:40:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:40:00 INFO - 'LOGNAME': 'cltbld', 22:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:00 INFO - 'MOZ_NO_REMOTE': '1', 22:40:00 INFO - 'NO_EM_RESTART': '1', 22:40:00 INFO - 'PAGER': '/bin/cat', 22:40:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:00 INFO - 'PWD': '/builds/slave/test', 22:40:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:40:00 INFO - 'SHELL': '/bin/bash', 22:40:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRtGfBMPwM/Listeners', 22:40:00 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 22:40:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:40:00 INFO - 'USER': 'cltbld', 22:40:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:40:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:00 INFO - 'XPC_FLAGS': '0x0', 22:40:00 INFO - 'XPC_SERVICE_NAME': '0', 22:40:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:00 INFO - Downloading/unpacking jsonschema 22:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:40:02 INFO - Downloading/unpacking functools32 (from jsonschema) 22:40: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 22:40: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 22:40: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 22:40: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 22:40: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 22:40: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 22:40:02 INFO - Downloading functools32-3.2.3-2.tar.gz 22:40:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:40:03 INFO - warning: no files found matching '*.txt' 22:40:03 INFO - no previously-included directories found matching 'build' 22:40:03 INFO - no previously-included directories found matching 'dist' 22:40:03 INFO - no previously-included directories found matching '.git*' 22:40:03 INFO - Installing collected packages: jsonschema, functools32 22:40:03 INFO - Running setup.py install for functools32 22:40:03 INFO - warning: no files found matching '*.txt' 22:40:03 INFO - no previously-included directories found matching 'build' 22:40:03 INFO - no previously-included directories found matching 'dist' 22:40:03 INFO - no previously-included directories found matching '.git*' 22:40:03 INFO - Successfully installed jsonschema functools32 22:40:03 INFO - Cleaning up... 22:40:03 INFO - Return code: 0 22:40:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:40:03 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')]} 22:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:03 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')]} 22:40:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:03 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 0x101abfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ac74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0d0c9a390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101963d30>, '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 0x101787db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10195ab20>, '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.kGeNRgSkup/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.eRtGfBMPwM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 22:40:03 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 22:40:03 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 22:40:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kGeNRgSkup/Render', 22:40:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:40:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:40:03 INFO - 'HOME': '/Users/cltbld', 22:40:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:40:03 INFO - 'LOGNAME': 'cltbld', 22:40:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:03 INFO - 'MOZ_NO_REMOTE': '1', 22:40:03 INFO - 'NO_EM_RESTART': '1', 22:40:03 INFO - 'PAGER': '/bin/cat', 22:40:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:40:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:03 INFO - 'PWD': '/builds/slave/test', 22:40:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:40:03 INFO - 'SHELL': '/bin/bash', 22:40:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRtGfBMPwM/Listeners', 22:40:03 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 22:40:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:40:03 INFO - 'USER': 'cltbld', 22:40:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:40:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:40:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:03 INFO - 'XPC_FLAGS': '0x0', 22:40:03 INFO - 'XPC_SERVICE_NAME': '0', 22:40:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:03 INFO - Downloading/unpacking flake8 22:40:03 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 22:40:03 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 22:40:03 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 22:40:03 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 22:40:03 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 22:40:03 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 22:40:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:40:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:40:05 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 22:40:05 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 22:40:05 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 22:40:05 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 22:40:05 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 22:40:05 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 22:40:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:40:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:40:06 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 22:40:06 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 22:40:06 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 22:40:06 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 22:40:06 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 22:40:06 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 22:40:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:40:06 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 22:40:06 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 22:40:06 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 22:40:06 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 22:40:06 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 22:40:06 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 22:40:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:40:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:40:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:40:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:40:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:40:07 INFO - no previously-included directories found matching 'docs/_build' 22:40:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:40:07 INFO - Running setup.py install for pep8 22:40:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:40:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:40:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:40:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:40:07 INFO - no previously-included directories found matching 'docs/_build' 22:40:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:40:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:40:07 INFO - Cleaning up... 22:40:07 INFO - Return code: 0 22:40:07 INFO - Running post-action listener: _resource_record_post_action 22:40:07 INFO - Running post-action listener: _start_resource_monitoring 22:40:07 INFO - Starting resource monitoring. 22:40:07 INFO - ##### 22:40:07 INFO - ##### Running install step. 22:40:07 INFO - ##### 22:40:07 INFO - Running pre-action listener: _resource_record_pre_action 22:40:07 INFO - Running main action method: install 22:40:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:40:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:40:07 INFO - Reading from file tmpfile_stdout 22:40:07 INFO - Detecting whether we're running mozinstall >=1.0... 22:40:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:40:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:40:07 INFO - Reading from file tmpfile_stdout 22:40:07 INFO - Output received: 22:40:07 INFO - Usage: mozinstall [options] installer 22:40:07 INFO - Options: 22:40:07 INFO - -h, --help show this help message and exit 22:40:07 INFO - -d DEST, --destination=DEST 22:40:07 INFO - Directory to install application into. [default: 22:40:07 INFO - "/builds/slave/test"] 22:40:07 INFO - --app=APP Application being installed. [default: firefox] 22:40:07 INFO - mkdir: /builds/slave/test/build/application 22:40:07 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'] 22:40:07 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 22:40:42 INFO - Reading from file tmpfile_stdout 22:40:42 INFO - Output received: 22:40:42 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:40:42 INFO - Running post-action listener: _resource_record_post_action 22:40:42 INFO - ##### 22:40:42 INFO - ##### Running run-tests step. 22:40:42 INFO - ##### 22:40:42 INFO - Running pre-action listener: _resource_record_pre_action 22:40:42 INFO - Running main action method: run_tests 22:40:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:40:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:40:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:40:42 INFO - 2016-02-25 22:40:42.594 screenresolution[2548:18503] starting screenresolution argv=screenresolution get 22:40:42 INFO - 2016-02-25 22:40:42.596 screenresolution[2548:18503] Display 0: 1600x1200x32@60 22:40:42 INFO - 2016-02-25 22:40:42.602 screenresolution[2549:18505] starting screenresolution argv=screenresolution list 22:40:42 INFO - Available Modes on Display 0 22:40:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:40:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:40:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:40:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:40:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:40:42 INFO - Intel Iris: 22:40:42 INFO - Chipset Model: Intel Iris 22:40:42 INFO - Type: GPU 22:40:42 INFO - Bus: Built-In 22:40:42 INFO - VRAM (Dynamic, Max): 1536 MB 22:40:42 INFO - Vendor: Intel (0x8086) 22:40:42 INFO - Device ID: 0x0a2e 22:40:42 INFO - Revision ID: 0x0009 22:40:42 INFO - Displays: 22:40:42 INFO - Display: 22:40:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:40:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:40:42 INFO - Display Serial Number: 1600x1200 60 22:40:42 INFO - Main Display: Yes 22:40:42 INFO - Mirror: Off 22:40:42 INFO - Online: Yes 22:40:42 INFO - Rotation: Supported 22:40:42 INFO - Return code: 0 22:40:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:40:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:40:42 INFO - Python 2.7.3 22:40:42 INFO - Return code: 0 22:40:42 INFO - grabbing minidump binary from tooltool 22:40:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:42 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 0x101963d30>, '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 0x101787db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10195ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:40:42 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 22:40:42 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 22:40:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:40:42 INFO - Return code: 0 22:40:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:40:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:40:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:40:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:40:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:40:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:40:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:40:44 INFO - Return code: 0 22:40:44 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/O9kcxWTkQ2KWPNSPQR6X8g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--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 22:40:44 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/O9kcxWTkQ2KWPNSPQR6X8g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0038 --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 22:40:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kGeNRgSkup/Render', 22:40:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:40:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:40:44 INFO - 'HOME': '/Users/cltbld', 22:40:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:40:44 INFO - 'LOGNAME': 'cltbld', 22:40:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:40:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:44 INFO - 'MOZ_NO_REMOTE': '1', 22:40:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:40:44 INFO - 'NO_EM_RESTART': '1', 22:40:44 INFO - 'PAGER': '/bin/cat', 22:40:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:44 INFO - 'PWD': '/builds/slave/test', 22:40:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:40:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:40:44 INFO - 'SHELL': '/bin/bash', 22:40:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRtGfBMPwM/Listeners', 22:40:44 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 22:40:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:40:44 INFO - 'USER': 'cltbld', 22:40:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:40:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:44 INFO - 'XPC_FLAGS': '0x0', 22:40:44 INFO - 'XPC_SERVICE_NAME': '0', 22:40:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:40:44 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/O9kcxWTkQ2KWPNSPQR6X8g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--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 22:40:44 INFO - mozversion application_buildid: 20160225204826 22:40:44 INFO - mozversion application_changeset: 4e0bcdfc72de10bbfd2216a0d08081d9aecc3709 22:40:44 INFO - mozversion application_display_name: Nightly 22:40:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:40:44 INFO - mozversion application_name: Firefox 22:40:44 INFO - mozversion application_remotingname: firefox 22:40:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:40:44 INFO - mozversion application_vendor: Mozilla 22:40:44 INFO - mozversion application_version: 47.0a1 22:40:44 INFO - mozversion platform_buildid: 20160225204826 22:40:44 INFO - mozversion platform_changeset: 4e0bcdfc72de10bbfd2216a0d08081d9aecc3709 22:40:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:40:44 INFO - mozversion platform_version: 47.0a1 22:40:44 INFO - using testdate: 1456468844 22:40:44 INFO - actual date: 1456468844 22:40:44 INFO - starting webserver on 'localhost:50187' 22:40:44 INFO - SUITE-START | Running 2 tests 22:40:44 INFO - TEST-START | dromaeo_css 22:40:44 INFO - operating with platform_type : mac_ 22:40:44 INFO - Initialising browser for dromaeo_css test... 22:40:44 INFO - TEST-INFO | started process 2567 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmp8U91ZN/profile http://localhost:50187/getInfo.html) 22:40:47 INFO - PROCESS | 2567 | __metrics Screen width/height:1600/1200 22:40:47 INFO - PROCESS | 2567 | colorDepth:24 22:40:47 INFO - PROCESS | 2567 | Browser inner width/height: 1024/689 22:40:47 INFO - PROCESS | 2567 | __metrics 22:40:47 INFO - PROCESS | 2567 | 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" 22:40:47 INFO - PROCESS | 2567 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:40:47 INFO - TEST-INFO | 2567: exit 0 22:40:47 INFO - Browser initialized. 22:40:47 INFO - Running cycle 1/1 for dromaeo_css test... 22:40:47 INFO - TEST-INFO | started process 2570 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmp8U91ZN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:40:59 INFO - PROCESS | 2570 | RSS: Main: 244367360 22:40:59 INFO - PROCESS | 2570 | 22:41:51 INFO - PROCESS | 2570 | 1456468911667 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] 22:44:00 INFO - PROCESS | 2570 | Cycle 1(1): loaded http://localhost:50187/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50187/tests/dromaeo/cssquery-ext.html) 22:44:02 INFO - PROCESS | 2570 | RSS: Main: 396050432 22:44:02 INFO - PROCESS | 2570 | 22:47:05 INFO - PROCESS | 2570 | Cycle 1(1): loaded http://localhost:50187/tests/dromaeo/cssquery-ext.html (next: http://localhost:50187/tests/dromaeo/cssquery-jquery.html) 22:47:05 INFO - PROCESS | 2570 | RSS: Main: 380477440 22:47:05 INFO - PROCESS | 2570 | 22:50:07 INFO - PROCESS | 2570 | Cycle 1(1): loaded http://localhost:50187/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50187/tests/dromaeo/cssquery-mootools.html) 22:50:08 INFO - PROCESS | 2570 | RSS: Main: 376844288 22:50:08 INFO - PROCESS | 2570 | 22:53:10 INFO - PROCESS | 2570 | Cycle 1(1): loaded http://localhost:50187/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50187/tests/dromaeo/cssquery-prototype.html) 22:53:10 INFO - PROCESS | 2570 | RSS: Main: 334471168 22:53:10 INFO - PROCESS | 2570 | 22:56:14 INFO - PROCESS | 2570 | Cycle 1(1): loaded http://localhost:50187/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50187/tests/dromaeo/cssquery-yui.html) 22:56:14 INFO - PROCESS | 2570 | RSS: Main: 335802368 22:56:14 INFO - PROCESS | 2570 | 22:59:17 INFO - PROCESS | 2570 | Cycle 1(1): loaded http://localhost:50187/tests/dromaeo/cssquery-yui.html (next: http://localhost:50187/tests/dromaeo/cssquery-dojo.html) 22:59:17 INFO - PROCESS | 2570 | RSS: Main: 412913664 22:59:17 INFO - PROCESS | 2570 | 22:59:17 INFO - PROCESS | 2570 | __start_tp_report 22:59:17 INFO - PROCESS | 2570 | _x_x_mozilla_page_load 22:59:17 INFO - PROCESS | 2570 | _x_x_mozilla_page_load_details 22:59:17 INFO - PROCESS | 2570 | |i|pagename|runs| 22:59:17 INFO - PROCESS | 2570 | |0;dojo.html;3306.9007929762106;3353.0946644406013;3404.8808291709797;3407.812570308633;3419.658034196579;5366.517013468787;5472.233887255782;5473.534749546288;5473.972630136844;5480.972595137024;5477.3427188737405;5510.91733623995;5530.5852061095375;5669.659820410779;5703.885922281552;4921.581665558432;4938.1111399947995;4958.925616115752;4984.875378115558;5120.078385890538;5030.195168772997;5045.697258164503;5084.466131056222;5099.796008159669;5114.718690472023;4927.408710954691;4985.277134815467;5031.496850314976;5038.319826823368;5066.771995260222;5050.545450909399;5051.19180931053;5051.469595692436;5082.872928176788;5088.160453525201;5009.699418034893;5013.5989120870245;5024.19612861944;5052.292679024939;5062.1900495920845;5350.91973620396;5363.678179309215;5450.8909821803345;5479.424660410639;5486.698231597261;5993.910091348634;6009.489193418521;6012.368701286389;6017.669028203447;6042.214512113397;5753.223314852483;6051.243594550681;6099.939000609981;6111.113888486189;6111.633302001894;5444.210589464545;5526.143447765603;5540.141278101901;5540.335159780852;5608.383077861432;5426.9185962210595;6202.379762023762;6227.501799856001;6230.221222347207;6244.219472565929;5856.033754430557;5867.941320586825;5885.205497257815;5894.852628684317;5895.174675545427;5807.390224026501;5969.194158788508;5979.431953964367;5980.312264089598;6001.489873360726;5995.670238136857;6010.248718910137;6010.909836352458;6024.638521688713;6041.6375017499095;5983.970080149571;5988.191594134736;6065.090236464477;6068.120122582201;6099.268087829489;4687.67186296956;4735.360726301905;4742.359781429463;4753.572178503951;4775.044991001813;4187.455630768041;4226.218149642326;4234.364845273172;4245.61789438952;4269.252880745857;4598.747068911175;5440.156775699773;5459.645123066988;5469.808556700496;5522.22688823565;5965.612235204698;5971.552133589911;5981.820545383645;5993.430624090704;6039.365866583946;5386.569074474032;5460.153676180198;5477.7261136943;5480.095784195563;5484.945150548443;5106.361704786902;5152.124138896396;5161.406438259648;5191.636585438983;5217.765200565984;6210.223722034746;6218.471429928416;6225.439710425992;6240.5319601031015;6244.000959846403;6009.489193418608;6019.398060193946;6023.277206735044;6029.547783916136;6086.60437071589;6096.254562767794;6144.72645121308;6213.347598502273;6249.78125765596;6259.3427690091885;5867.266591676041;5909.113632954919;5929.110633405024;5943.019401798655;5967.8209653710455;6019.638821670714;6022;6065.029595264737;6071.332153463027;6083.452489275986;5605.467480589337;5774.335951365647;5777.94222057774;5780.913286300624;5788.27646544182;4730.929036064393;5619.80330688424;5733.655980641175;5767.884642307046;5770.192173095854;5589.580781441489;5646.915296270641;5665.405132461197;5708.457696518824;5709.514691251124;4782.784774685217;5786.3056433228285;5787.536997040311;5801.1878337032;5809.186713859978;5571.3592936811165;5653.886922261614;5662;5672.205891175321;5698.116791897262 22:59:17 INFO - PROCESS | 2570 | |1;ext.html;447.6239958434914;503.87151276424504;541.8374487653703;596.1415561591308;603.776602657017;29498.705012949864;37697.057573560676;38091;38202;38281.80859095707;33487.33025339492;40603;40999.59000409995;41050;41063.17873642525;9523.999999999982;9737.51312434379;9744.31789774716;9748.902510974905;9764.316497845153;9588.472634005127;9772.218222542215;9774;9784;9788;9720.319577629569;9741.853872191923;9807.803843923117;9818.165455936218;9823.263255255848;8517.82964340716;9620.615175392975;9767.365121267096;9767.365121267096;9786.119249267529;9539;9707.174890134347;9708.805823883553;9715.27135464843;9730.36752611078;39467.802660986796;39774.40338394926;39828.20343593112;39836.60163398387;40069.39895901564;3171;3263.592050993626;3305.8347082645773;3450.9827450862836;3617.674409303149;28188.577171342447;28537.429251415062;28778.712212877814;29183;29352.559711604128;2709.634199383078;2742.931426714328;2751.683556391021;2820.1539538138477;2825.39254060378;348791;349246;350135;351163;353838;44095;44640;62206;62525;62628.373716263166;38044;41706.79146604308;43091.56908430876;43415;43579.782101089295;14898.925505372621;15031.924840375728;15044.924775376054;15046.097234165985;15074.924625376803;12483.687907802378;12562.685932851751;12565.371731413392;12565.623031309075;12574.622761317176;14450.060746051473;14470.710585788436;14496.275186240646;14500.202488863002;14610.342534585969;6185.505159587222;6222.160008398899;6238.844028899314;6282.403171698681;6292.835825372229;879.8724184993268;922.3359181389523;967.7967626798311;984.9310548261553;1110.3993166773423;28633.713662863105;28772.712272877423;29036.40171337489;29318.26704332409;30037.699623003926;985.3299756165733;1046.7173863057085;1067.7223921780237;1114.2367478277406;1141.8858114188681;11763.882361176278;12658;14433.989620726448;14611.123332599866;14843.777343339858;511087;511693;518277;519518;519878;57543.13685294724;57968.71015644895;58039.70980145072;58172.70913645405;58364.708176458844;1380.496118916588;1402.0886423824595;1417.3621870158263;1434.2613554019897;1448.4423496953539;27246.182614521596;28180.15459536217;28251.858740706164;28654.99707510227;28853.134405967015;45569.44305569549;46005.76997114993;46108.769456152506;46145.76927115343;46191.76904115458;273282;300950.48574270966;301086;301620;302366.48816756654;27800.304992375353;28239.729212185914;28241.858790705915;31465.21336966594;32464;31938.20154496156;32230.677693223704;40322.395164071975;40562;40746;35070.649293506736;35775;35779.10552236215;36335.90992270236;36535.26929461343;35165.64834351624;35233.47149792806;35707.82146089253;35866.28267434689;35907;35016.82491587526;35122.82438587791;35316.646833532366;35636.287274254886;35973.46039809353;30487.237819053815;31347.373052538365;31400;31527.211819703774;31537.950033247766;23762.049518019085;24065.278041658778;24267.894267894128;24385.878070609535;24425 22:59:17 INFO - PROCESS | 2570 | |2;jquery.html;346.33330838136584;354.76408188554615;358.6646485536024;362.4526964283932;365.35879531422347;19652.60694786105;20169.49576260594;21083.894580527114;21528;21589.784102158974;19829;20187.09158087886;20958.790412095874;20991.790082099174;21246.362609121752;5676.375598684142;5838.182654428383;5905.409459054082;5906.26171728534;5907.940920590782;4055.7566546007333;4169.541350451463;5632.549396048306;5823.67969761663;6540.836479088037;6487.967560162217;6498.0577816216855;6507.3492650735025;6513.609183448984;6518.478521718251;6124.969375153118;6353.174087368636;6365.554411191195;6370.171877655921;6392.904106438407;3687.668109870098;3871.8644847430205;3875.922481550353;5256.868578285574;5494.697791621459;25081.62377564338;25562.36094097644;26010.73989260102;26047.218583442525;26121;2097.528056187361;2105.4525823285903;2125.4048866317457;2143.1534543855246;2171.826253899684;14535.56393308192;14571.708565828623;14604.70790584193;14734.705305893822;15108.622284442978;1431.6564024634117;1777.4401063664905;1804.7653805005395;1808.2374156114392;1831.4047934421367;83648;90280.5485972566;91092.08907910969;91804;92499.07500924972;10365;10520.053195212467;10640.361578305326;10882.455877206266;10973.286736362112;12962.092653514352;13058.34708264583;13092.738145237043;13100.344982750825;13118.147320424332;8475.957620211982;8601.31189504838;8651.913480865236;8704.26013788835;8722.694705685271;8803.647854085893;8805.471671699719;8818.074102219303;8927.553622318988;8933.196012358789;5259.894802103937;6252.124702541648;6314.305426403092;6323.367663233732;6328.588641738273;1456.7086582683505;1655;1732.0819965418348;1732.159902447312;1774.7692799936183;797.9800504987422;927.4945154890601;936.1247233836385;971.8056388722284;991.2763682511807;18257.63484730298;20265.189392424138;20892.686609700868;21052.368428947157;21496.57006859854;905.6377449020313;908.336914052732;938.2165891480554;942.8774259346241;972.9513524323755;10140.594376224868;10490.73773155662;11039.558417663364;11046.558137674403;11200.43997800123;594646;617569;621738;642554;643638;76224.61887690637;126258.89928805674;128217;129160;131039;1057.3444464431948;1066.8879767624444;1130.1015692524463;1147.512307269407;1151.8963293303643;18452.538686532946;18646.254149833854;18688.906555467136;18770;19112.71330930065;50017.74991125021;51987.48012519978;52249.47750522598;52611.47388526219;54050.72974635102;68585.97121043288;68803.93588192362;68962.3103768976;69051;69370.65314673394;7886.290233878978;8034.276915077671;8082.515049097073;8105.473144245605;8329.333653307842;9741.512924353612;12848.393950756155;12957.805632915703;13212.867871321163;13214.339283035617;11315.98156165949;11364.090872730327;11386.772264554827;11735.823962640738;11738.41307934617;8666.350023748118;11190.608328708457;11282.210245282751;11544.845515448387;11770.941145294219;11379.317240965238;11645.301281923112;11843.052555795344;11883.524659013543;11967.222130561833;7954.00574928134;8002.279794818494;8037.357011438954;8074.757757267292;8405.285550728257;8586.313094952264;10181.694549163536;10915.83626245591;11282.041026512838;11661.53353865836 22:59:17 INFO - PROCESS | 2570 | |3;mootools.html;1368.2201145347155;1471.6835880285737;1501.3469140923698;1514.46236586012;1912.6079153773478;7950.1254861965135;8497.617607207683;8651.653933842654;8658.653653853855;8681.392302538825;8365.912431383927;8626.137386261371;8644.092370301107;8652.610632521535;8652.826943461127;2194.868307901523;2426.211481268586;2467.050185678513;2477.8389404688637;2504.611785173301;2501.862397568133;2509.7992160627105;2514.182890560566;2517.1567524879188;2517.2070797698666;2405.867677277749;2470.3700556358103;2494;2494.5260400523935;2495.7254701982765;2422.1643532981093;2467.8519288842726;2490.7011158661076;2493.7506249375097;2495.8643817063194;2451.325885381534;2495.962560561593;2496.7752902238703;2497.9375515612073;2504.6743923289855;8696.17386348296;8736.126387361277;8760.561971901443;8772.03507614162;8782;5354.651947623392;5498.202760599731;5507.531859791922;5538.446155384469;5571.0807716726695;3539.3629146753574;3651;3689.723270754704;3700.6854417374557;3727.589965103836;1049.6588608702125;1063.9680809575725;1073.1361254190374;1084.4035780320792;1086.190787863047;11685.182037257395;11889.405529723566;11890.643280701594;11900.285982841056;11902.642920712393;4872.244802055616;4919.2129259318335;5000.499950004971;5018.573421259161;5020;10193.910248399208;10200.489975501343;10200.979902009889;10214.897851021544;10224.693259202237;5476.424975377528;5477.397486276506;5507.807226747124;5531.087370583889;5533.446655334515;4428.734275943454;4590;4805.255185446262;4899.632527560448;4959.429665588504;3871.9225615488094;3976.741511801724;3986.5216174059296;4004.01901534126;4023.8591649292134;1219.9203704721208;1236.1285293867982;1303.8565757766637;1330.7072444062292;1334.3328335832084;908.5956749246654;1045.7699306152633;1072.903438690506;1114.1031469666834;1129.2434069173673;8033.839323213503;8090.474119182234;8134.75595732129;8149.633266503021;8152.714654987166;502.3344069108446;515.4355980201673;522.0003692928001;522.3131581969698;523.7407483295717;6190.690465476709;6210.068489726486;6249.250089989139;6277.843053923597;6282.654454004982;10301.639442619473;10654.840177397346;10744.925507449349;10783.191260655482;10832;9858.40849549015;10525.894741052645;10564.943505649373;10576.31253968505;10660.893391066145;8025.31784798287;8141.430099893069;8175.3459723222;8252.133525979685;8252.21603947624;7969.1632378601735;7997.520148791091;8005.199480051948;8055.355571554144;8080.909077274493;9281.860772088288;9444.48055356962;9457.054294570487;9474.194693450858;9484.004179561323;9556.61773529051;9797.06927841854;9935.751606209902;9941.105300522988;10127.696169114644;6817.147856517935;6882.69027893736;7313.670884810303;7486.7005319786595;7633.465657403928;8125.349972002107;8164;8165.959170204349;8179.75460736155;8191.221833925768;7130.2869713028285;7258.419326453765;7259.564426134449;7357;7402.6668799903055;6845.452363810784;7159.749408770668;7196.784096477114;7214.062171917617;7248;6725.831854203684;7589.962050189713;7608.505447145918;7683.193264707349;7685.807854803675;6850.6574671267235;6952;6952.860942781217;6954.235034146139;6957.165140183008;5934.228550288435;7118.5017048806085;7147.928520714934;7159.785206443815;7163.713451461883 22:59:17 INFO - PROCESS | 2570 | |4;prototype.html;315.81998260991236;319.3267279455653;325.76544887680876;329.6390452454563;330.1037682691492;5536.612437129403;6429.678516074195;6501.05734668474;6518.185226846645;6546.705398257078;6364.840878978016;6408.455281301083;6442.967785161068;6444.130042444269;6452.967735161317;4526.253168227238;4608.838690645828;4627.722336659811;4736.834210802623;4772.80908763649;4747.596454301389;4753.405824271966;4756.85729428116;4758.785854636532;4768.070226305872;4692.272697731857;4702.224133018048;4703.129920964632;4709.9058018839605;4719.716816990975;3861.2084522672785;4511.623954693817;4606.999999999984;4696.436427628672;4722.504137065627;3334.249793796401;4045.3122969095325;4047.251258517184;4050.0077481017047;4060.228556574271;5379.655086228443;5660.433956604348;6136.60112092717;6141.477974372184;6141.846453838645;5498.917516237259;5516.282883225155;5553.222548843165;5555.3611334696625;5559.138333558305;6868.793936181923;6873.896891546631;6877.828054298632;6878.3465570770695;6879.277675844064;4386.385905973167;4502.684812063157;4585.72485650862;4599.724016558984;4600.861974140781;7195.352418282328;7256.709731610729;7269.89095163573;7272.16370117438;7272.345488905971;4671.205894997858;4673.696209746356;4673.859784206479;4680.508546602626;4681.414823147106;3916.706247031484;4712.95287047132;4718.834840780556;4745.952540474551;4747.169245382044;5463.262459567907;5527.5452841973765;5546.417626149277;5555.0834112371;5557.944420555743;6677.065210870482;6789.524733268624;6922.7923162305215;6938.687759050855;6941.409980151744;1632.4939268826702;1640.6144556029324;1651.743979683151;1652.2564845819188;1653.7602047703015;943.4858002388714;1005.3816902604991;1024.948752562369;1033.8707661542308;1038.46000079958;6148.846278842975;6161.182451176914;6177.104319873593;6234.906476402857;6451.1936007999;7199.06412166415;7207.9279207207255;7230.891536626955;7237.674304656303;7240.348368646847;6384.786890490792;6450.290468048511;6536.313687062885;6546.509011824037;6576.80269591913;3747.868824591126;3802.08749900022;3810.333191691443;3810.942835857464;3811.809409529568;5745.425457454221;7456.925430745731;7519.398448124137;7569.296908195612;7612.086549613971;7436.665350059152;7449.813754656177;7459.992900958409;7478.401727861758;7513.361364284097;7526.09686837572;7534.321911027924;7539.170691224071;7540.773776786705;7571.091469023752;6939.89590156138;7211.134663840373;7231.566106033655;7235.131784185932;7241.275872412716;5798.391168927202;7126.821829454305;7136.107986501687;7166.57000579946;7167.569945803269;7576.3181313682035;7584.734534291273;7587.544747315179;7588.772336829904;7598.1249562724515;4673.509281525391;4726;4730;4736.478987311324;4739.763011849324;5237.816676416307;7061.788146355618;7124.501284910007;7150.42796576283;7172.888202328648;6679.866402672016;6982.720691172296;6986.6855991481525;6996.545224560387;7000.859982800417;6078.635281883101;6607.372299631527;6954.269801670752;6957.199922009034;6992.475564332593;6774.525783195129;6775.89836152468;6793.558418702769;6796.830079248059;6805.149356330458;6644.4020038196795;6953.235144134243;6956.226162328574;6956.617386043817;6967.303269672992;5955.927932972107;6564.113844631104;6616.437602803816;6727.865442691216;6810.387065164159 22:59:17 INFO - PROCESS | 2570 | |5;yui.html;662.3277373465932;665.633901354255;728.4682182007137;749.8826748145265;762.992370076299;14982.250887455624;15219.08685478872;15222;15234.314455849486;15268.931174817768;15561.922190389032;15902.84097159028;15958.76061859073;15971.961822481531;16028.679426411465;619.6808643548576;849.5030407211789;865.1996902864856;865.731623196811;872.9916945927464;696.2584847137807;856.5246288309985;869.2437579306013;870.4646642314995;871.289898732531;912.4479689787682;914.6981496106268;918.0131358789295;918.3066784577668;918.4351623751378;726.8546290741873;736.3961551527749;909.9226565741886;912.2701838529183;913.6573784830689;545.1713395638646;659.9472042236657;671.1040760584625;671.8253254153906;673.4275865514273;15075.773863392058;15093.924530377279;15140.621484462867;15145.772813407808;15152.696946061127;12165.330906800122;12260.0804939629;12280;12556.658698907948;12565.93717031409;9320;9769.462679552622;9933.155681766986;10113.140383067448;10398.844017339747;3447.3967055765393;3508.578970523528;3582.0865679251624;3630.3465376232266;3662.5421822272215;82122;83574.16425835724;83819.58090209571;84179;84296;9167.770805729777;9300.813983720287;9344.813103738023;9387.671431499864;9682;20453.977301135183;21103.261385851423;21113.68329475059;21134.894325528276;21137;7471.925280747231;7488.326050655467;7520.774376768706;7574.545527268271;7590.582517961565;4102.671786257092;4126.236646220459;4139.110091330378;4241.4698162729655;4362.9965108025335;3324.983375083109;3363.5963684358035;3365.8821941232427;3367.865285388606;3369.376665316924;645.4352441613588;649.818050945736;650.8080116365684;653.5229282623711;658.8352911772057;526.5866294958439;529.3674059498939;557.6041010882319;577.1083675721021;606.3209205689568;7766.417518686121;8182.345412366996;8239.382046346547;8362.623681934327;8443.408961372645;486.1492388320439;527.2697314219834;568.408854791021;608.3034925010837;614.8032629558498;3238.817831491536;3713.1274150574595;3848.3022782587723;4011.939820902689;4086.897827554335;76327.61836190784;85649.71525427124;86626.26747465016;86816;87637.56181219181;70522.94215586668;71330.9300360495;71486.64256678683;72060.63969680118;72799.63600181966;66977.30692891062;67280.6635966817;67378;67509.98735018978;67586.31034224086;7865.213478652089;7945.761627151194;7946.046474423106;7971.362291016821;8181.345492360478;47164.68947313172;47205.52794472011;47799;47812.52187478081;48018;57863.710681446326;64225.036624451604;64821.67589162024;66405;68394;9926.702198934043;9998.450085245382;10022.799544009225;10674.46627668598;10866.565337386415;10179;11968.521259149536;12464.875351246372;12478.126531142732;12752.808707869204;11541.596044138414;11714.297142171497;11723.35521546323;12121.454534546143;12226.938865305616;11511.251768635011;11765.11761617865;12008.339541325311;12101.152919295564;12494.187877787916;9717.22262219035;11544;11603.883961160618;11691.590794322157;11958.342291174069;9611.567479463301;9898.158656514277;9953.900460995297;10040;10114.595416183565;9272.767957037422;9416.152546270869;9435.669751558937;9811.950940245253;9902.950485247527 22:59:17 INFO - PROCESS | 2570 | __end_tp_report 22:59:17 INFO - PROCESS | 2570 | __start_cc_report 22:59:17 INFO - PROCESS | 2570 | _x_x_mozilla_cycle_collect,1355 22:59:17 INFO - PROCESS | 2570 | __end_cc_report 22:59:17 INFO - PROCESS | 2570 | __startTimestamp1456469957842__endTimestamp 22:59:17 INFO - PROCESS | 2570 | 22:59:17 INFO - PROCESS | 2570 | ------- Summary: start ------- 22:59:17 INFO - PROCESS | 2570 | Number of tests: 6 22:59:17 INFO - PROCESS | 2570 | 22:59:17 INFO - PROCESS | 2570 | [#0] dojo.html Cycles:165 Average:5515.73 Median:5662.00 stddev:616.61 (10.9%) stddev-sans-first:593.66 22:59:17 INFO - PROCESS | 2570 | Values: 3306.9 3353.1 3404.9 3407.8 3419.7 5366.5 5472.2 5473.5 5474.0 5481.0 5477.3 5510.9 5530.6 5669.7 5703.9 4921.6 4938.1 4958.9 4984.9 5120.1 5030.2 5045.7 5084.5 5099.8 5114.7 4927.4 4985.3 5031.5 5038.3 5066.8 5050.5 5051.2 5051.5 5082.9 5088.2 5009.7 5013.6 5024.2 5052.3 5062.2 5350.9 5363.7 5450.9 5479.4 5486.7 5993.9 6009.5 6012.4 6017.7 6042.2 5753.2 6051.2 6099.9 6111.1 6111.6 5444.2 5526.1 5540.1 5540.3 5608.4 5426.9 6202.4 6227.5 6230.2 6244.2 5856.0 5867.9 5885.2 5894.9 5895.2 5807.4 5969.2 5979.4 5980.3 6001.5 5995.7 6010.2 6010.9 6024.6 6041.6 5984.0 5988.2 6065.1 6068.1 6099.3 4687.7 4735.4 4742.4 4753.6 4775.0 4187.5 4226.2 4234.4 4245.6 4269.3 4598.7 5440.2 5459.6 5469.8 5522.2 5965.6 5971.6 5981.8 5993.4 6039.4 5386.6 5460.2 5477.7 5480.1 5484.9 5106.4 5152.1 5161.4 5191.6 5217.8 6210.2 6218.5 6225.4 6240.5 6244.0 6009.5 6019.4 6023.3 6029.5 6086.6 6096.3 6144.7 6213.3 6249.8 6259.3 5867.3 5909.1 5929.1 5943.0 5967.8 6019.6 6022.0 6065.0 6071.3 6083.5 5605.5 5774.3 5777.9 5780.9 5788.3 4730.9 5619.8 5733.7 5767.9 5770.2 5589.6 5646.9 5665.4 5708.5 5709.5 4782.8 5786.3 5787.5 5801.2 5809.2 5571.4 5653.9 5662.0 5672.2 5698.1 22:59:17 INFO - PROCESS | 2570 | 22:59:17 INFO - PROCESS | 2570 | [#1] ext.html Cycles:180 Average:53200.94 Median:35741.41 stddev:105885.69 (296.3%) stddev-sans-first:106108.64 22:59:17 INFO - PROCESS | 2570 | Values: 447.6 503.9 541.8 596.1 603.8 29498.7 37697.1 38091.0 38202.0 38281.8 33487.3 40603.0 40999.6 41050.0 41063.2 9524.0 9737.5 9744.3 9748.9 9764.3 9588.5 9772.2 9774.0 9784.0 9788.0 9720.3 9741.9 9807.8 9818.2 9823.3 8517.8 9620.6 9767.4 9767.4 9786.1 9539.0 9707.2 9708.8 9715.3 9730.4 39467.8 39774.4 39828.2 39836.6 40069.4 3171.0 3263.6 3305.8 3451.0 3617.7 28188.6 28537.4 28778.7 29183.0 29352.6 2709.6 2742.9 2751.7 2820.2 2825.4 348791.0 349246.0 350135.0 351163.0 353838.0 44095.0 44640.0 62206.0 62525.0 62628.4 38044.0 41706.8 43091.6 43415.0 43579.8 14898.9 15031.9 15044.9 15046.1 15074.9 12483.7 12562.7 12565.4 12565.6 12574.6 14450.1 14470.7 14496.3 14500.2 14610.3 6185.5 6222.2 6238.8 6282.4 6292.8 879.9 922.3 967.8 984.9 1110.4 28633.7 28772.7 29036.4 29318.3 30037.7 985.3 1046.7 1067.7 1114.2 1141.9 11763.9 12658.0 14434.0 14611.1 14843.8 511087.0 511693.0 518277.0 519518.0 519878.0 57543.1 57968.7 58039.7 58172.7 58364.7 1380.5 1402.1 1417.4 1434.3 1448.4 27246.2 28180.2 28251.9 28655.0 28853.1 45569.4 46005.8 46108.8 46145.8 46191.8 273282.0 300950.5 301086.0 301620.0 302366.5 27800.3 28239.7 28241.9 31465.2 32464.0 31938.2 32230.7 40322.4 40562.0 40746.0 35070.6 35775.0 35779.1 36335.9 36535.3 35165.6 35233.5 35707.8 35866.3 35907.0 35016.8 35122.8 35316.6 35636.3 35973.5 30487.2 31347.4 31400.0 31527.2 31538.0 23762.0 24065.3 24267.9 24385.9 24425.0 22:59:17 INFO - PROCESS | 2570 | 22:59:17 INFO - PROCESS | 2570 | [#2] jquery.html Cycles:180 Average:34523.04 Median:13233.67 stddev:103145.40 (779.4%) stddev-sans-first:103402.83 22:59:17 INFO - PROCESS | 2570 | Values: 346.3 354.8 358.7 362.5 365.4 19652.6 20169.5 21083.9 21528.0 21589.8 19829.0 20187.1 20958.8 20991.8 21246.4 5676.4 5838.2 5905.4 5906.3 5907.9 4055.8 4169.5 5632.5 5823.7 6540.8 6488.0 6498.1 6507.3 6513.6 6518.5 6125.0 6353.2 6365.6 6370.2 6392.9 3687.7 3871.9 3875.9 5256.9 5494.7 25081.6 25562.4 26010.7 26047.2 26121.0 2097.5 2105.5 2125.4 2143.2 2171.8 14535.6 14571.7 14604.7 14734.7 15108.6 1431.7 1777.4 1804.8 1808.2 1831.4 83648.0 90280.5 91092.1 91804.0 92499.1 10365.0 10520.1 10640.4 10882.5 10973.3 12962.1 13058.3 13092.7 13100.3 13118.1 8476.0 8601.3 8651.9 8704.3 8722.7 8803.6 8805.5 8818.1 8927.6 8933.2 5259.9 6252.1 6314.3 6323.4 6328.6 1456.7 1655.0 1732.1 1732.2 1774.8 798.0 927.5 936.1 971.8 991.3 18257.6 20265.2 20892.7 21052.4 21496.6 905.6 908.3 938.2 942.9 973.0 10140.6 10490.7 11039.6 11046.6 11200.4 594646.0 617569.0 621738.0 642554.0 643638.0 76224.6 126258.9 128217.0 129160.0 131039.0 1057.3 1066.9 1130.1 1147.5 1151.9 18452.5 18646.3 18688.9 18770.0 19112.7 50017.7 51987.5 52249.5 52611.5 54050.7 68586.0 68803.9 68962.3 69051.0 69370.7 7886.3 8034.3 8082.5 8105.5 8329.3 9741.5 12848.4 12957.8 13212.9 13214.3 11316.0 11364.1 11386.8 11735.8 11738.4 8666.4 11190.6 11282.2 11544.8 11770.9 11379.3 11645.3 11843.1 11883.5 11967.2 7954.0 8002.3 8037.4 8074.8 8405.3 8586.3 10181.7 10915.8 11282.0 11661.5 22:59:17 INFO - PROCESS | 2570 | 22:59:17 INFO - PROCESS | 2570 | [#3] mootools.html Cycles:180 Average:6003.18 Median:5476.91 stddev:3186.58 (58.2%) stddev-sans-first:3176.47 22:59:17 INFO - PROCESS | 2570 | Values: 1368.2 1471.7 1501.3 1514.5 1912.6 7950.1 8497.6 8651.7 8658.7 8681.4 8365.9 8626.1 8644.1 8652.6 8652.8 2194.9 2426.2 2467.1 2477.8 2504.6 2501.9 2509.8 2514.2 2517.2 2517.2 2405.9 2470.4 2494.0 2494.5 2495.7 2422.2 2467.9 2490.7 2493.8 2495.9 2451.3 2496.0 2496.8 2497.9 2504.7 8696.2 8736.1 8760.6 8772.0 8782.0 5354.7 5498.2 5507.5 5538.4 5571.1 3539.4 3651.0 3689.7 3700.7 3727.6 1049.7 1064.0 1073.1 1084.4 1086.2 11685.2 11889.4 11890.6 11900.3 11902.6 4872.2 4919.2 5000.5 5018.6 5020.0 10193.9 10200.5 10201.0 10214.9 10224.7 5476.4 5477.4 5507.8 5531.1 5533.4 4428.7 4590.0 4805.3 4899.6 4959.4 3871.9 3976.7 3986.5 4004.0 4023.9 1219.9 1236.1 1303.9 1330.7 1334.3 908.6 1045.8 1072.9 1114.1 1129.2 8033.8 8090.5 8134.8 8149.6 8152.7 502.3 515.4 522.0 522.3 523.7 6190.7 6210.1 6249.3 6277.8 6282.7 10301.6 10654.8 10744.9 10783.2 10832.0 9858.4 10525.9 10564.9 10576.3 10660.9 8025.3 8141.4 8175.3 8252.1 8252.2 7969.2 7997.5 8005.2 8055.4 8080.9 9281.9 9444.5 9457.1 9474.2 9484.0 9556.6 9797.1 9935.8 9941.1 10127.7 6817.1 6882.7 7313.7 7486.7 7633.5 8125.3 8164.0 8166.0 8179.8 8191.2 7130.3 7258.4 7259.6 7357.0 7402.7 6845.5 7159.7 7196.8 7214.1 7248.0 6725.8 7590.0 7608.5 7683.2 7685.8 6850.7 6952.0 6952.9 6954.2 6957.2 5934.2 7118.5 7147.9 7159.8 7163.7 22:59:17 INFO - PROCESS | 2570 | 22:59:17 INFO - PROCESS | 2570 | [#4] prototype.html Cycles:180 Average:5634.81 Median:6396.62 stddev:1811.66 (28.3%) stddev-sans-first:1772.21 22:59:17 INFO - PROCESS | 2570 | Values: 315.8 319.3 325.8 329.6 330.1 5536.6 6429.7 6501.1 6518.2 6546.7 6364.8 6408.5 6443.0 6444.1 6453.0 4526.3 4608.8 4627.7 4736.8 4772.8 4747.6 4753.4 4756.9 4758.8 4768.1 4692.3 4702.2 4703.1 4709.9 4719.7 3861.2 4511.6 4607.0 4696.4 4722.5 3334.2 4045.3 4047.3 4050.0 4060.2 5379.7 5660.4 6136.6 6141.5 6141.8 5498.9 5516.3 5553.2 5555.4 5559.1 6868.8 6873.9 6877.8 6878.3 6879.3 4386.4 4502.7 4585.7 4599.7 4600.9 7195.4 7256.7 7269.9 7272.2 7272.3 4671.2 4673.7 4673.9 4680.5 4681.4 3916.7 4713.0 4718.8 4746.0 4747.2 5463.3 5527.5 5546.4 5555.1 5557.9 6677.1 6789.5 6922.8 6938.7 6941.4 1632.5 1640.6 1651.7 1652.3 1653.8 943.5 1005.4 1024.9 1033.9 1038.5 6148.8 6161.2 6177.1 6234.9 6451.2 7199.1 7207.9 7230.9 7237.7 7240.3 6384.8 6450.3 6536.3 6546.5 6576.8 3747.9 3802.1 3810.3 3810.9 3811.8 5745.4 7456.9 7519.4 7569.3 7612.1 7436.7 7449.8 7460.0 7478.4 7513.4 7526.1 7534.3 7539.2 7540.8 7571.1 6939.9 7211.1 7231.6 7235.1 7241.3 5798.4 7126.8 7136.1 7166.6 7167.6 7576.3 7584.7 7587.5 7588.8 7598.1 4673.5 4726.0 4730.0 4736.5 4739.8 5237.8 7061.8 7124.5 7150.4 7172.9 6679.9 6982.7 6986.7 6996.5 7000.9 6078.6 6607.4 6954.3 6957.2 6992.5 6774.5 6775.9 6793.6 6796.8 6805.1 6644.4 6953.2 6956.2 6956.6 6967.3 5955.9 6564.1 6616.4 6727.9 6810.4 22:59:17 INFO - PROCESS | 2570 | 22:59:17 INFO - PROCESS | 2570 | [#5] yui.html Cycles:180 Average:17778.13 Median:32733.56 stddev:24487.87 (74.8%) stddev-sans-first:24522.84 22:59:17 INFO - PROCESS | 2570 | Values: 662.3 665.6 728.5 749.9 763.0 14982.3 15219.1 15222.0 15234.3 15268.9 15561.9 15902.8 15958.8 15972.0 16028.7 619.7 849.5 865.2 865.7 873.0 696.3 856.5 869.2 870.5 871.3 912.4 914.7 918.0 918.3 918.4 726.9 736.4 909.9 912.3 913.7 545.2 659.9 671.1 671.8 673.4 15075.8 15093.9 15140.6 15145.8 15152.7 12165.3 12260.1 12280.0 12556.7 12565.9 9320.0 9769.5 9933.2 10113.1 10398.8 3447.4 3508.6 3582.1 3630.3 3662.5 82122.0 83574.2 83819.6 84179.0 84296.0 9167.8 9300.8 9344.8 9387.7 9682.0 20454.0 21103.3 21113.7 21134.9 21137.0 7471.9 7488.3 7520.8 7574.5 7590.6 4102.7 4126.2 4139.1 4241.5 4363.0 3325.0 3363.6 3365.9 3367.9 3369.4 645.4 649.8 650.8 653.5 658.8 526.6 529.4 557.6 577.1 606.3 7766.4 8182.3 8239.4 8362.6 8443.4 486.1 527.3 568.4 608.3 614.8 3238.8 3713.1 3848.3 4011.9 4086.9 76327.6 85649.7 86626.3 86816.0 87637.6 70522.9 71330.9 71486.6 72060.6 72799.6 66977.3 67280.7 67378.0 67510.0 67586.3 7865.2 7945.8 7946.0 7971.4 8181.3 47164.7 47205.5 47799.0 47812.5 48018.0 57863.7 64225.0 64821.7 66405.0 68394.0 9926.7 9998.5 10022.8 10674.5 10866.6 10179.0 11968.5 12464.9 12478.1 12752.8 11541.6 11714.3 11723.4 12121.5 12226.9 11511.3 11765.1 12008.3 12101.2 12494.2 9717.2 11544.0 11603.9 11691.6 11958.3 9611.6 9898.2 9953.9 10040.0 10114.6 9272.8 9416.2 9435.7 9812.0 9903.0 22:59:17 INFO - PROCESS | 2570 | -------- Summary: end -------- 22:59:17 INFO - PROCESS | 2570 | 22:59:18 INFO - TEST-INFO | 2570: exit 0 22:59:18 INFO - TEST-OK | dromaeo_css | took 1113593ms 22:59:18 INFO - TEST-START | kraken 22:59:18 INFO - operating with platform_type : mac_ 22:59:18 INFO - Initialising browser for kraken test... 22:59:18 INFO - TEST-INFO | started process 2572 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpdxLRtN/profile http://localhost:50187/getInfo.html) 22:59:20 INFO - PROCESS | 2572 | __metrics Screen width/height:1600/1200 22:59:20 INFO - PROCESS | 2572 | colorDepth:24 22:59:20 INFO - PROCESS | 2572 | Browser inner width/height: 1024/689 22:59:20 INFO - PROCESS | 2572 | __metrics 22:59:20 INFO - PROCESS | 2572 | 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" 22:59:20 INFO - PROCESS | 2572 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:59:21 INFO - TEST-INFO | 2572: exit 0 22:59:21 INFO - Browser initialized. 22:59:21 INFO - Running cycle 1/1 for kraken test... 22:59:21 INFO - TEST-INFO | started process 2574 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpdxLRtN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:59:33 INFO - PROCESS | 2574 | RSS: Main: 242872320 22:59:33 INFO - PROCESS | 2574 | 22:59:35 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:50187/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50187/tests/kraken/driver.html?testName=audio-beat-detection) 22:59:36 INFO - PROCESS | 2574 | RSS: Main: 290131968 22:59:36 INFO - PROCESS | 2574 | 22:59:39 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:50187/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50187/tests/kraken/driver.html?testName=audio-dft) 22:59:39 INFO - PROCESS | 2574 | RSS: Main: 299745280 22:59:39 INFO - PROCESS | 2574 | 22:59:43 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:50187/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50187/tests/kraken/driver.html?testName=audio-fft) 22:59:43 INFO - PROCESS | 2574 | RSS: Main: 286343168 22:59:43 INFO - PROCESS | 2574 | 22:59:45 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:50187/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50187/tests/kraken/driver.html?testName=audio-oscillator) 22:59:46 INFO - PROCESS | 2574 | RSS: Main: 288706560 22:59:46 INFO - PROCESS | 2574 | 22:59:48 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:50187/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50187/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:59:48 INFO - PROCESS | 2574 | RSS: Main: 291008512 22:59:48 INFO - PROCESS | 2574 | 22:59:51 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:50187/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50187/tests/kraken/driver.html?testName=imaging-darkroom) 22:59:52 INFO - PROCESS | 2574 | RSS: Main: 290459648 22:59:52 INFO - PROCESS | 2574 | 22:59:55 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:50187/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50187/tests/kraken/driver.html?testName=imaging-desaturate) 22:59:55 INFO - PROCESS | 2574 | RSS: Main: 291610624 22:59:55 INFO - PROCESS | 2574 | 22:59:58 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:50187/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50187/tests/kraken/driver.html?testName=json-parse-financial) 22:59:59 INFO - PROCESS | 2574 | RSS: Main: 292429824 22:59:59 INFO - PROCESS | 2574 | 23:00:00 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:50187/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50187/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:00:01 INFO - PROCESS | 2574 | RSS: Main: 325664768 23:00:01 INFO - PROCESS | 2574 | 23:00:03 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:50187/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50187/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:00:03 INFO - PROCESS | 2574 | RSS: Main: 326131712 23:00:03 INFO - PROCESS | 2574 | 23:00:05 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:50187/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50187/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:00:06 INFO - PROCESS | 2574 | RSS: Main: 332480512 23:00:06 INFO - PROCESS | 2574 | 23:00:09 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:50187/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50187/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:00:09 INFO - PROCESS | 2574 | RSS: Main: 333324288 23:00:09 INFO - PROCESS | 2574 | 23:00:12 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:50187/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50187/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:00:12 INFO - PROCESS | 2574 | RSS: Main: 332709888 23:00:12 INFO - PROCESS | 2574 | 23:00:14 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:50187/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50187/tests/kraken/driver.html?testName=ai-astar) 23:00:14 INFO - PROCESS | 2574 | RSS: Main: 394543104 23:00:14 INFO - PROCESS | 2574 | 23:00:14 INFO - PROCESS | 2574 | __start_tp_report 23:00:14 INFO - PROCESS | 2574 | _x_x_mozilla_page_load 23:00:14 INFO - PROCESS | 2574 | _x_x_mozilla_page_load_details 23:00:14 INFO - PROCESS | 2574 | |i|pagename|runs| 23:00:14 INFO - PROCESS | 2574 | |0;ai-astar;113;109;111;109;113;113;116;111;112;111 23:00:14 INFO - PROCESS | 2574 | |1;audio-beat-detection;158;140;179;187;122;142;143;118;157;113 23:00:14 INFO - PROCESS | 2574 | |2;audio-dft;187;186;185;196;258;202;186;183;185;181 23:00:14 INFO - PROCESS | 2574 | |3;audio-fft;70;79;85;81;55;57;58;79;75;58 23:00:14 INFO - PROCESS | 2574 | |4;audio-oscillator;95;88;128;79;78;81;113;79;78;117 23:00:14 INFO - PROCESS | 2574 | |5;imaging-gaussian-blur;87;93;87;93;86;92;87;93;88;95 23:00:14 INFO - PROCESS | 2574 | |6;imaging-darkroom;95;94;96;95;96;96;96;95;95;95 23:00:14 INFO - PROCESS | 2574 | |7;imaging-desaturate;87;87;88;85;87;87;101;150;145;87 23:00:14 INFO - PROCESS | 2574 | |8;json-parse-financial;56;55;55;54;55;54;54;64;51;52 23:00:14 INFO - PROCESS | 2574 | |9;json-stringify-tinderbox;65;71;88;113;109;87;68;70;70;70 23:00:14 INFO - PROCESS | 2574 | |10;stanford-crypto-aes;86;83;83;82;83;82;83;81;83;85 23:00:14 INFO - PROCESS | 2574 | |11;stanford-crypto-ccm;124;126;124;122;121;123;131;128;132;126 23:00:14 INFO - PROCESS | 2574 | |12;stanford-crypto-pbkdf2;137;124;140;139;140;126;138;140;138;136 23:00:14 INFO - PROCESS | 2574 | |13;stanford-crypto-sha256-iterative;66;67;66;67;66;67;67;68;67;66 23:00:14 INFO - PROCESS | 2574 | __end_tp_report 23:00:14 INFO - PROCESS | 2574 | __start_cc_report 23:00:14 INFO - PROCESS | 2574 | _x_x_mozilla_cycle_collect,1300 23:00:14 INFO - PROCESS | 2574 | __end_cc_report 23:00:14 INFO - PROCESS | 2574 | __startTimestamp1456470014668__endTimestamp 23:00:14 INFO - PROCESS | 2574 | 23:00:14 INFO - PROCESS | 2574 | ------- Summary: start ------- 23:00:14 INFO - PROCESS | 2574 | Number of tests: 14 23:00:14 INFO - PROCESS | 2574 | 23:00:14 INFO - PROCESS | 2574 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.50 stddev:2.10 (1.9%) stddev-sans-first:2.18 23:00:14 INFO - PROCESS | 2574 | Values: 113.0 109.0 111.0 109.0 113.0 113.0 116.0 111.0 112.0 111.0 23:00:14 INFO - PROCESS | 2574 | 23:00:14 INFO - PROCESS | 2574 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:150.00 stddev:24.82 (16.5%) stddev-sans-first:25.94 23:00:14 INFO - PROCESS | 2574 | Values: 158.0 140.0 179.0 187.0 122.0 142.0 143.0 118.0 157.0 113.0 23:00:14 INFO - PROCESS | 2574 | 23:00:14 INFO - PROCESS | 2574 | [#2] audio-dft Cycles:10 Average:194.90 Median:186.50 stddev:23.06 (12.4%) stddev-sans-first:24.28 23:00:14 INFO - PROCESS | 2574 | Values: 187.0 186.0 185.0 196.0 258.0 202.0 186.0 183.0 185.0 181.0 23:00:14 INFO - PROCESS | 2574 | 23:00:14 INFO - PROCESS | 2574 | [#3] audio-fft Cycles:10 Average:69.70 Median:77.00 stddev:11.61 (15.1%) stddev-sans-first:12.32 23:00:14 INFO - PROCESS | 2574 | Values: 70.0 79.0 85.0 81.0 55.0 57.0 58.0 79.0 75.0 58.0 23:00:14 INFO - PROCESS | 2574 | 23:00:14 INFO - PROCESS | 2574 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:79.00 stddev:18.89 (23.9%) stddev-sans-first:20.03 23:00:14 INFO - PROCESS | 2574 | Values: 95.0 88.0 128.0 79.0 78.0 81.0 113.0 79.0 78.0 117.0 23:00:14 INFO - PROCESS | 2574 | 23:00:14 INFO - PROCESS | 2574 | [#5] imaging-gaussian-blur Cycles:10 Average:90.10 Median:92.50 stddev:3.38 (3.7%) stddev-sans-first:3.40 23:00:14 INFO - PROCESS | 2574 | Values: 87.0 93.0 87.0 93.0 86.0 92.0 87.0 93.0 88.0 95.0 23:00:14 INFO - PROCESS | 2574 | 23:00:14 INFO - PROCESS | 2574 | [#6] imaging-darkroom Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 23:00:14 INFO - PROCESS | 2574 | Values: 95.0 94.0 96.0 95.0 96.0 96.0 96.0 95.0 95.0 95.0 23:00:14 INFO - PROCESS | 2574 | 23:00:14 INFO - PROCESS | 2574 | [#7] imaging-desaturate Cycles:10 Average:100.40 Median:87.00 stddev:25.25 (29.0%) stddev-sans-first:26.31 23:00:14 INFO - PROCESS | 2574 | Values: 87.0 87.0 88.0 85.0 87.0 87.0 101.0 150.0 145.0 87.0 23:00:14 INFO - PROCESS | 2574 | 23:00:14 INFO - PROCESS | 2574 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:3.50 (6.4%) stddev-sans-first:3.69 23:00:14 INFO - PROCESS | 2574 | Values: 56.0 55.0 55.0 54.0 55.0 54.0 54.0 64.0 51.0 52.0 23:00:14 INFO - PROCESS | 2574 | 23:00:14 INFO - PROCESS | 2574 | [#9] json-stringify-tinderbox Cycles:10 Average:81.10 Median:70.00 stddev:17.58 (25.1%) stddev-sans-first:17.65 23:00:14 INFO - PROCESS | 2574 | Values: 65.0 71.0 88.0 113.0 109.0 87.0 68.0 70.0 70.0 70.0 23:00:14 INFO - PROCESS | 2574 | 23:00:14 INFO - PROCESS | 2574 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.00 stddev:1.45 (1.7%) stddev-sans-first:1.09 23:00:14 INFO - PROCESS | 2574 | Values: 86.0 83.0 83.0 82.0 83.0 82.0 83.0 81.0 83.0 85.0 23:00:14 INFO - PROCESS | 2574 | 23:00:14 INFO - PROCESS | 2574 | [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:126.00 stddev:3.68 (2.9%) stddev-sans-first:3.86 23:00:14 INFO - PROCESS | 2574 | Values: 124.0 126.0 124.0 122.0 121.0 123.0 131.0 128.0 132.0 126.0 23:00:14 INFO - PROCESS | 2574 | 23:00:14 INFO - PROCESS | 2574 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.80 Median:138.50 stddev:5.87 (4.2%) stddev-sans-first:6.20 23:00:14 INFO - PROCESS | 2574 | Values: 137.0 124.0 140.0 139.0 140.0 126.0 138.0 140.0 138.0 136.0 23:00:14 INFO - PROCESS | 2574 | 23:00:14 INFO - PROCESS | 2574 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 23:00:14 INFO - PROCESS | 2574 | Values: 66.0 67.0 66.0 67.0 66.0 67.0 67.0 68.0 67.0 66.0 23:00:14 INFO - PROCESS | 2574 | -------- Summary: end -------- 23:00:14 INFO - PROCESS | 2574 | 23:00:15 INFO - TEST-INFO | 2574: exit 0 23:00:15 INFO - TEST-OK | kraken | took 56961ms 23:00:15 INFO - SUITE-END | took 1170s 23:00:15 INFO - Completed test suite (00:19:30) 23:00:15 INFO - Working with test: dromaeo_css 23:00:15 INFO - Generating results file: dromaeo_css 23:00:15 INFO - Working with test: kraken 23:00:15 INFO - Generating results file: kraken 23:00:15 INFO - javascript benchmark 23:00:15 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:00:16 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 23:00:16 INFO - process_Request line: dromaeo_css 7329.37 graph.html#tests=[[72,64,59]] 23:00:16 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:00:16 INFO - process_Request line: kraken 1449.10 graph.html#tests=[[232,64,59]] 23:00:16 INFO - RETURN: dromaeo_css: 7329.37 23:00:16 INFO - RETURN: kraken: 1449.10 23:00:16 INFO - javascript benchmark 23:00:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3306.9007929762106, 3353.0946644406013, 3404.8808291709797, 3407.812570308633, 3419.658034196579, 5366.517013468787, 5472.233887255782, 5473.534749546288, 5473.972630136844, 5480.972595137024, 5477.3427188737405, 5510.91733623995, 5530.5852061095375, 5669.659820410779, 5703.885922281552, 4921.581665558432, 4938.1111399947995, 4958.925616115752, 4984.875378115558, 5120.078385890538, 5030.195168772997, 5045.697258164503, 5084.466131056222, 5099.796008159669, 5114.718690472023, 4927.408710954691, 4985.277134815467, 5031.496850314976, 5038.319826823368, 5066.771995260222, 5050.545450909399, 5051.19180931053, 5051.469595692436, 5082.872928176788, 5088.160453525201, 5009.699418034893, 5013.5989120870245, 5024.19612861944, 5052.292679024939, 5062.1900495920845, 5350.91973620396, 5363.678179309215, 5450.8909821803345, 5479.424660410639, 5486.698231597261, 5993.910091348634, 6009.489193418521, 6012.368701286389, 6017.669028203447, 6042.214512113397, 5753.223314852483, 6051.243594550681, 6099.939000609981, 6111.113888486189, 6111.633302001894, 5444.210589464545, 5526.143447765603, 5540.141278101901, 5540.335159780852, 5608.383077861432, 5426.9185962210595, 6202.379762023762, 6227.501799856001, 6230.221222347207, 6244.219472565929, 5856.033754430557, 5867.941320586825, 5885.205497257815, 5894.852628684317, 5895.174675545427, 5807.390224026501, 5969.194158788508, 5979.431953964367, 5980.312264089598, 6001.489873360726, 5995.670238136857, 6010.248718910137, 6010.909836352458, 6024.638521688713, 6041.6375017499095, 5983.970080149571, 5988.191594134736, 6065.090236464477, 6068.120122582201, 6099.268087829489, 4687.67186296956, 4735.360726301905, 4742.359781429463, 4753.572178503951, 4775.044991001813, 4187.455630768041, 4226.218149642326, 4234.364845273172, 4245.61789438952, 4269.252880745857, 4598.747068911175, 5440.156775699773, 5459.645123066988, 5469.808556700496, 5522.22688823565, 5965.612235204698, 5971.552133589911, 5981.820545383645, 5993.430624090704, 6039.365866583946, 5386.569074474032, 5460.153676180198, 5477.7261136943, 5480.095784195563, 5484.945150548443, 5106.361704786902, 5152.124138896396, 5161.406438259648, 5191.636585438983, 5217.765200565984, 6210.223722034746, 6218.471429928416, 6225.439710425992, 6240.5319601031015, 6244.000959846403, 6009.489193418608, 6019.398060193946, 6023.277206735044, 6029.547783916136, 6086.60437071589, 6096.254562767794, 6144.72645121308, 6213.347598502273, 6249.78125765596, 6259.3427690091885, 5867.266591676041, 5909.113632954919, 5929.110633405024, 5943.019401798655, 5967.8209653710455, 6019.638821670714, 6022.0, 6065.029595264737, 6071.332153463027, 6083.452489275986, 5605.467480589337, 5774.335951365647, 5777.94222057774, 5780.913286300624, 5788.27646544182, 4730.929036064393, 5619.80330688424, 5733.655980641175, 5767.884642307046, 5770.192173095854, 5589.580781441489, 5646.915296270641, 5665.405132461197, 5708.457696518824, 5709.514691251124, 4782.784774685217, 5786.3056433228285, 5787.536997040311, 5801.1878337032, 5809.186713859978, 5571.3592936811165, 5653.886922261614, 5662.0, 5672.205891175321, 5698.116791897262], "unit": "score", "name": "dojo.html", "value": 5478.073641157945}, {"lowerIsBetter": false, "replicates": [447.6239958434914, 503.87151276424504, 541.8374487653703, 596.1415561591308, 603.776602657017, 29498.705012949864, 37697.057573560676, 38091.0, 38202.0, 38281.80859095707, 33487.33025339492, 40603.0, 40999.59000409995, 41050.0, 41063.17873642525, 9523.999999999982, 9737.51312434379, 9744.31789774716, 9748.902510974905, 9764.316497845153, 9588.472634005127, 9772.218222542215, 9774.0, 9784.0, 9788.0, 9720.319577629569, 9741.853872191923, 9807.803843923117, 9818.165455936218, 9823.263255255848, 8517.82964340716, 9620.615175392975, 9767.365121267096, 9767.365121267096, 9786.119249267529, 9539.0, 9707.174890134347, 9708.805823883553, 9715.27135464843, 9730.36752611078, 39467.802660986796, 39774.40338394926, 39828.20343593112, 39836.60163398387, 40069.39895901564, 3171.0, 3263.592050993626, 3305.8347082645773, 3450.9827450862836, 3617.674409303149, 28188.577171342447, 28537.429251415062, 28778.712212877814, 29183.0, 29352.559711604128, 2709.634199383078, 2742.931426714328, 2751.683556391021, 2820.1539538138477, 2825.39254060378, 348791.0, 349246.0, 350135.0, 351163.0, 353838.0, 44095.0, 44640.0, 62206.0, 62525.0, 62628.373716263166, 38044.0, 41706.79146604308, 43091.56908430876, 43415.0, 43579.782101089295, 14898.925505372621, 15031.924840375728, 15044.924775376054, 15046.097234165985, 15074.924625376803, 12483.687907802378, 12562.685932851751, 12565.371731413392, 12565.623031309075, 12574.622761317176, 14450.060746051473, 14470.710585788436, 14496.275186240646, 14500.202488863002, 14610.342534585969, 6185.505159587222, 6222.160008398899, 6238.844028899314, 6282.403171698681, 6292.835825372229, 879.8724184993268, 922.3359181389523, 967.7967626798311, 984.9310548261553, 1110.3993166773423, 28633.713662863105, 28772.712272877423, 29036.40171337489, 29318.26704332409, 30037.699623003926, 985.3299756165733, 1046.7173863057085, 1067.7223921780237, 1114.2367478277406, 1141.8858114188681, 11763.882361176278, 12658.0, 14433.989620726448, 14611.123332599866, 14843.777343339858, 511087.0, 511693.0, 518277.0, 519518.0, 519878.0, 57543.13685294724, 57968.71015644895, 58039.70980145072, 58172.70913645405, 58364.708176458844, 1380.496118916588, 1402.0886423824595, 1417.3621870158263, 1434.2613554019897, 1448.4423496953539, 27246.182614521596, 28180.15459536217, 28251.858740706164, 28654.99707510227, 28853.134405967015, 45569.44305569549, 46005.76997114993, 46108.769456152506, 46145.76927115343, 46191.76904115458, 273282.0, 300950.48574270966, 301086.0, 301620.0, 302366.48816756654, 27800.304992375353, 28239.729212185914, 28241.858790705915, 31465.21336966594, 32464.0, 31938.20154496156, 32230.677693223704, 40322.395164071975, 40562.0, 40746.0, 35070.649293506736, 35775.0, 35779.10552236215, 36335.90992270236, 36535.26929461343, 35165.64834351624, 35233.47149792806, 35707.82146089253, 35866.28267434689, 35907.0, 35016.82491587526, 35122.82438587791, 35316.646833532366, 35636.287274254886, 35973.46039809353, 30487.237819053815, 31347.373052538365, 31400.0, 31527.211819703774, 31537.950033247766, 23762.049518019085, 24065.278041658778, 24267.894267894128, 24385.878070609535, 24425.0], "unit": "score", "name": "ext.html", "value": 18238.98810377981}, {"lowerIsBetter": false, "replicates": [346.33330838136584, 354.76408188554615, 358.6646485536024, 362.4526964283932, 365.35879531422347, 19652.60694786105, 20169.49576260594, 21083.894580527114, 21528.0, 21589.784102158974, 19829.0, 20187.09158087886, 20958.790412095874, 20991.790082099174, 21246.362609121752, 5676.375598684142, 5838.182654428383, 5905.409459054082, 5906.26171728534, 5907.940920590782, 4055.7566546007333, 4169.541350451463, 5632.549396048306, 5823.67969761663, 6540.836479088037, 6487.967560162217, 6498.0577816216855, 6507.3492650735025, 6513.609183448984, 6518.478521718251, 6124.969375153118, 6353.174087368636, 6365.554411191195, 6370.171877655921, 6392.904106438407, 3687.668109870098, 3871.8644847430205, 3875.922481550353, 5256.868578285574, 5494.697791621459, 25081.62377564338, 25562.36094097644, 26010.73989260102, 26047.218583442525, 26121.0, 2097.528056187361, 2105.4525823285903, 2125.4048866317457, 2143.1534543855246, 2171.826253899684, 14535.56393308192, 14571.708565828623, 14604.70790584193, 14734.705305893822, 15108.622284442978, 1431.6564024634117, 1777.4401063664905, 1804.7653805005395, 1808.2374156114392, 1831.4047934421367, 83648.0, 90280.5485972566, 91092.08907910969, 91804.0, 92499.07500924972, 10365.0, 10520.053195212467, 10640.361578305326, 10882.455877206266, 10973.286736362112, 12962.092653514352, 13058.34708264583, 13092.738145237043, 13100.344982750825, 13118.147320424332, 8475.957620211982, 8601.31189504838, 8651.913480865236, 8704.26013788835, 8722.694705685271, 8803.647854085893, 8805.471671699719, 8818.074102219303, 8927.553622318988, 8933.196012358789, 5259.894802103937, 6252.124702541648, 6314.305426403092, 6323.367663233732, 6328.588641738273, 1456.7086582683505, 1655.0, 1732.0819965418348, 1732.159902447312, 1774.7692799936183, 797.9800504987422, 927.4945154890601, 936.1247233836385, 971.8056388722284, 991.2763682511807, 18257.63484730298, 20265.189392424138, 20892.686609700868, 21052.368428947157, 21496.57006859854, 905.6377449020313, 908.336914052732, 938.2165891480554, 942.8774259346241, 972.9513524323755, 10140.594376224868, 10490.73773155662, 11039.558417663364, 11046.558137674403, 11200.43997800123, 594646.0, 617569.0, 621738.0, 642554.0, 643638.0, 76224.61887690637, 126258.89928805674, 128217.0, 129160.0, 131039.0, 1057.3444464431948, 1066.8879767624444, 1130.1015692524463, 1147.512307269407, 1151.8963293303643, 18452.538686532946, 18646.254149833854, 18688.906555467136, 18770.0, 19112.71330930065, 50017.74991125021, 51987.48012519978, 52249.47750522598, 52611.47388526219, 54050.72974635102, 68585.97121043288, 68803.93588192362, 68962.3103768976, 69051.0, 69370.65314673394, 7886.290233878978, 8034.276915077671, 8082.515049097073, 8105.473144245605, 8329.333653307842, 9741.512924353612, 12848.393950756155, 12957.805632915703, 13212.867871321163, 13214.339283035617, 11315.98156165949, 11364.090872730327, 11386.772264554827, 11735.823962640738, 11738.41307934617, 8666.350023748118, 11190.608328708457, 11282.210245282751, 11544.845515448387, 11770.941145294219, 11379.317240965238, 11645.301281923112, 11843.052555795344, 11883.524659013543, 11967.222130561833, 7954.00574928134, 8002.279794818494, 8037.357011438954, 8074.757757267292, 8405.285550728257, 8586.313094952264, 10181.694549163536, 10915.83626245591, 11282.041026512838, 11661.53353865836], "unit": "score", "name": "jquery.html", "value": 9495.773703724806}, {"lowerIsBetter": false, "replicates": [1368.2201145347155, 1471.6835880285737, 1501.3469140923698, 1514.46236586012, 1912.6079153773478, 7950.1254861965135, 8497.617607207683, 8651.653933842654, 8658.653653853855, 8681.392302538825, 8365.912431383927, 8626.137386261371, 8644.092370301107, 8652.610632521535, 8652.826943461127, 2194.868307901523, 2426.211481268586, 2467.050185678513, 2477.8389404688637, 2504.611785173301, 2501.862397568133, 2509.7992160627105, 2514.182890560566, 2517.1567524879188, 2517.2070797698666, 2405.867677277749, 2470.3700556358103, 2494.0, 2494.5260400523935, 2495.7254701982765, 2422.1643532981093, 2467.8519288842726, 2490.7011158661076, 2493.7506249375097, 2495.8643817063194, 2451.325885381534, 2495.962560561593, 2496.7752902238703, 2497.9375515612073, 2504.6743923289855, 8696.17386348296, 8736.126387361277, 8760.561971901443, 8772.03507614162, 8782.0, 5354.651947623392, 5498.202760599731, 5507.531859791922, 5538.446155384469, 5571.0807716726695, 3539.3629146753574, 3651.0, 3689.723270754704, 3700.6854417374557, 3727.589965103836, 1049.6588608702125, 1063.9680809575725, 1073.1361254190374, 1084.4035780320792, 1086.190787863047, 11685.182037257395, 11889.405529723566, 11890.643280701594, 11900.285982841056, 11902.642920712393, 4872.244802055616, 4919.2129259318335, 5000.499950004971, 5018.573421259161, 5020.0, 10193.910248399208, 10200.489975501343, 10200.979902009889, 10214.897851021544, 10224.693259202237, 5476.424975377528, 5477.397486276506, 5507.807226747124, 5531.087370583889, 5533.446655334515, 4428.734275943454, 4590.0, 4805.255185446262, 4899.632527560448, 4959.429665588504, 3871.9225615488094, 3976.741511801724, 3986.5216174059296, 4004.01901534126, 4023.8591649292134, 1219.9203704721208, 1236.1285293867982, 1303.8565757766637, 1330.7072444062292, 1334.3328335832084, 908.5956749246654, 1045.7699306152633, 1072.903438690506, 1114.1031469666834, 1129.2434069173673, 8033.839323213503, 8090.474119182234, 8134.75595732129, 8149.633266503021, 8152.714654987166, 502.3344069108446, 515.4355980201673, 522.0003692928001, 522.3131581969698, 523.7407483295717, 6190.690465476709, 6210.068489726486, 6249.250089989139, 6277.843053923597, 6282.654454004982, 10301.639442619473, 10654.840177397346, 10744.925507449349, 10783.191260655482, 10832.0, 9858.40849549015, 10525.894741052645, 10564.943505649373, 10576.31253968505, 10660.893391066145, 8025.31784798287, 8141.430099893069, 8175.3459723222, 8252.133525979685, 8252.21603947624, 7969.1632378601735, 7997.520148791091, 8005.199480051948, 8055.355571554144, 8080.909077274493, 9281.860772088288, 9444.48055356962, 9457.054294570487, 9474.194693450858, 9484.004179561323, 9556.61773529051, 9797.06927841854, 9935.751606209902, 9941.105300522988, 10127.696169114644, 6817.147856517935, 6882.69027893736, 7313.670884810303, 7486.7005319786595, 7633.465657403928, 8125.349972002107, 8164.0, 8165.959170204349, 8179.75460736155, 8191.221833925768, 7130.2869713028285, 7258.419326453765, 7259.564426134449, 7357.0, 7402.6668799903055, 6845.452363810784, 7159.749408770668, 7196.784096477114, 7214.062171917617, 7248.0, 6725.831854203684, 7589.962050189713, 7608.505447145918, 7683.193264707349, 7685.807854803675, 6850.6574671267235, 6952.0, 6952.860942781217, 6954.235034146139, 6957.165140183008, 5934.228550288435, 7118.5017048806085, 7147.928520714934, 7159.785206443815, 7163.713451461883], "unit": "score", "name": "mootools.html", "value": 4795.9017185418015}, {"lowerIsBetter": false, "replicates": [315.81998260991236, 319.3267279455653, 325.76544887680876, 329.6390452454563, 330.1037682691492, 5536.612437129403, 6429.678516074195, 6501.05734668474, 6518.185226846645, 6546.705398257078, 6364.840878978016, 6408.455281301083, 6442.967785161068, 6444.130042444269, 6452.967735161317, 4526.253168227238, 4608.838690645828, 4627.722336659811, 4736.834210802623, 4772.80908763649, 4747.596454301389, 4753.405824271966, 4756.85729428116, 4758.785854636532, 4768.070226305872, 4692.272697731857, 4702.224133018048, 4703.129920964632, 4709.9058018839605, 4719.716816990975, 3861.2084522672785, 4511.623954693817, 4606.999999999984, 4696.436427628672, 4722.504137065627, 3334.249793796401, 4045.3122969095325, 4047.251258517184, 4050.0077481017047, 4060.228556574271, 5379.655086228443, 5660.433956604348, 6136.60112092717, 6141.477974372184, 6141.846453838645, 5498.917516237259, 5516.282883225155, 5553.222548843165, 5555.3611334696625, 5559.138333558305, 6868.793936181923, 6873.896891546631, 6877.828054298632, 6878.3465570770695, 6879.277675844064, 4386.385905973167, 4502.684812063157, 4585.72485650862, 4599.724016558984, 4600.861974140781, 7195.352418282328, 7256.709731610729, 7269.89095163573, 7272.16370117438, 7272.345488905971, 4671.205894997858, 4673.696209746356, 4673.859784206479, 4680.508546602626, 4681.414823147106, 3916.706247031484, 4712.95287047132, 4718.834840780556, 4745.952540474551, 4747.169245382044, 5463.262459567907, 5527.5452841973765, 5546.417626149277, 5555.0834112371, 5557.944420555743, 6677.065210870482, 6789.524733268624, 6922.7923162305215, 6938.687759050855, 6941.409980151744, 1632.4939268826702, 1640.6144556029324, 1651.743979683151, 1652.2564845819188, 1653.7602047703015, 943.4858002388714, 1005.3816902604991, 1024.948752562369, 1033.8707661542308, 1038.46000079958, 6148.846278842975, 6161.182451176914, 6177.104319873593, 6234.906476402857, 6451.1936007999, 7199.06412166415, 7207.9279207207255, 7230.891536626955, 7237.674304656303, 7240.348368646847, 6384.786890490792, 6450.290468048511, 6536.313687062885, 6546.509011824037, 6576.80269591913, 3747.868824591126, 3802.08749900022, 3810.333191691443, 3810.942835857464, 3811.809409529568, 5745.425457454221, 7456.925430745731, 7519.398448124137, 7569.296908195612, 7612.086549613971, 7436.665350059152, 7449.813754656177, 7459.992900958409, 7478.401727861758, 7513.361364284097, 7526.09686837572, 7534.321911027924, 7539.170691224071, 7540.773776786705, 7571.091469023752, 6939.89590156138, 7211.134663840373, 7231.566106033655, 7235.131784185932, 7241.275872412716, 5798.391168927202, 7126.821829454305, 7136.107986501687, 7166.57000579946, 7167.569945803269, 7576.3181313682035, 7584.734534291273, 7587.544747315179, 7588.772336829904, 7598.1249562724515, 4673.509281525391, 4726.0, 4730.0, 4736.478987311324, 4739.763011849324, 5237.816676416307, 7061.788146355618, 7124.501284910007, 7150.42796576283, 7172.888202328648, 6679.866402672016, 6982.720691172296, 6986.6855991481525, 6996.545224560387, 7000.859982800417, 6078.635281883101, 6607.372299631527, 6954.269801670752, 6957.199922009034, 6992.475564332593, 6774.525783195129, 6775.89836152468, 6793.558418702769, 6796.830079248059, 6805.149356330458, 6644.4020038196795, 6953.235144134243, 6956.226162328574, 6956.617386043817, 6967.303269672992, 5955.927932972107, 6564.113844631104, 6616.437602803816, 6727.865442691216, 6810.387065164159], "unit": "score", "name": "prototype.html", "value": 5031.147178686411}, {"lowerIsBetter": false, "replicates": [662.3277373465932, 665.633901354255, 728.4682182007137, 749.8826748145265, 762.992370076299, 14982.250887455624, 15219.08685478872, 15222.0, 15234.314455849486, 15268.931174817768, 15561.922190389032, 15902.84097159028, 15958.76061859073, 15971.961822481531, 16028.679426411465, 619.6808643548576, 849.5030407211789, 865.1996902864856, 865.731623196811, 872.9916945927464, 696.2584847137807, 856.5246288309985, 869.2437579306013, 870.4646642314995, 871.289898732531, 912.4479689787682, 914.6981496106268, 918.0131358789295, 918.3066784577668, 918.4351623751378, 726.8546290741873, 736.3961551527749, 909.9226565741886, 912.2701838529183, 913.6573784830689, 545.1713395638646, 659.9472042236657, 671.1040760584625, 671.8253254153906, 673.4275865514273, 15075.773863392058, 15093.924530377279, 15140.621484462867, 15145.772813407808, 15152.696946061127, 12165.330906800122, 12260.0804939629, 12280.0, 12556.658698907948, 12565.93717031409, 9320.0, 9769.462679552622, 9933.155681766986, 10113.140383067448, 10398.844017339747, 3447.3967055765393, 3508.578970523528, 3582.0865679251624, 3630.3465376232266, 3662.5421822272215, 82122.0, 83574.16425835724, 83819.58090209571, 84179.0, 84296.0, 9167.770805729777, 9300.813983720287, 9344.813103738023, 9387.671431499864, 9682.0, 20453.977301135183, 21103.261385851423, 21113.68329475059, 21134.894325528276, 21137.0, 7471.925280747231, 7488.326050655467, 7520.774376768706, 7574.545527268271, 7590.582517961565, 4102.671786257092, 4126.236646220459, 4139.110091330378, 4241.4698162729655, 4362.9965108025335, 3324.983375083109, 3363.5963684358035, 3365.8821941232427, 3367.865285388606, 3369.376665316924, 645.4352441613588, 649.818050945736, 650.8080116365684, 653.5229282623711, 658.8352911772057, 526.5866294958439, 529.3674059498939, 557.6041010882319, 577.1083675721021, 606.3209205689568, 7766.417518686121, 8182.345412366996, 8239.382046346547, 8362.623681934327, 8443.408961372645, 486.1492388320439, 527.2697314219834, 568.408854791021, 608.3034925010837, 614.8032629558498, 3238.817831491536, 3713.1274150574595, 3848.3022782587723, 4011.939820902689, 4086.897827554335, 76327.61836190784, 85649.71525427124, 86626.26747465016, 86816.0, 87637.56181219181, 70522.94215586668, 71330.9300360495, 71486.64256678683, 72060.63969680118, 72799.63600181966, 66977.30692891062, 67280.6635966817, 67378.0, 67509.98735018978, 67586.31034224086, 7865.213478652089, 7945.761627151194, 7946.046474423106, 7971.362291016821, 8181.345492360478, 47164.68947313172, 47205.52794472011, 47799.0, 47812.52187478081, 48018.0, 57863.710681446326, 64225.036624451604, 64821.67589162024, 66405.0, 68394.0, 9926.702198934043, 9998.450085245382, 10022.799544009225, 10674.46627668598, 10866.565337386415, 10179.0, 11968.521259149536, 12464.875351246372, 12478.126531142732, 12752.808707869204, 11541.596044138414, 11714.297142171497, 11723.35521546323, 12121.454534546143, 12226.938865305616, 11511.251768635011, 11765.11761617865, 12008.339541325311, 12101.152919295564, 12494.187877787916, 9717.22262219035, 11544.0, 11603.883961160618, 11691.590794322157, 11958.342291174069, 9611.567479463301, 9898.158656514277, 9953.900460995297, 10040.0, 10114.595416183565, 9272.767957037422, 9416.152546270869, 9435.669751558937, 9811.950940245253, 9902.950485247527], "unit": "score", "name": "yui.html", "value": 6771.263919104544}], "name": "dromaeo_css", "value": 7329.371210694401}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 111.0, 109.0, 113.0, 113.0, 116.0, 111.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [158.0, 140.0, 179.0, 187.0, 122.0, 142.0, 143.0, 118.0, 157.0, 113.0], "unit": "score", "name": "audio-beat-detection", "value": 145.9}, {"lowerIsBetter": true, "replicates": [187.0, 186.0, 185.0, 196.0, 258.0, 202.0, 186.0, 183.0, 185.0, 181.0], "unit": "score", "name": "audio-dft", "value": 194.9}, {"lowerIsBetter": true, "replicates": [70.0, 79.0, 85.0, 81.0, 55.0, 57.0, 58.0, 79.0, 75.0, 58.0], "unit": "score", "name": "audio-fft", "value": 69.7}, {"lowerIsBetter": true, "replicates": [95.0, 88.0, 128.0, 79.0, 78.0, 81.0, 113.0, 79.0, 78.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 93.6}, {"lowerIsBetter": true, "replicates": [87.0, 93.0, 87.0, 93.0, 86.0, 92.0, 87.0, 93.0, 88.0, 95.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 90.1}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 95.3}, {"lowerIsBetter": true, "replicates": [87.0, 87.0, 88.0, 85.0, 87.0, 87.0, 101.0, 150.0, 145.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 100.4}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 55.0, 54.0, 55.0, 54.0, 54.0, 64.0, 51.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.0}, {"lowerIsBetter": true, "replicates": [65.0, 71.0, 88.0, 113.0, 109.0, 87.0, 68.0, 70.0, 70.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 81.1}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 83.0, 82.0, 83.0, 82.0, 83.0, 81.0, 83.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.1}, {"lowerIsBetter": true, "replicates": [124.0, 126.0, 124.0, 122.0, 121.0, 123.0, 131.0, 128.0, 132.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.7}, {"lowerIsBetter": true, "replicates": [137.0, 124.0, 140.0, 139.0, 140.0, 126.0, 138.0, 140.0, 138.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.8}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 67.0, 66.0, 67.0, 67.0, 68.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1449.1}]} 23:00:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1449.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7329.37"}}} 23:00:16 INFO - Return code: 0 23:00:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:00:16 INFO - # TBPL SUCCESS # 23:00:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:00:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:00:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:00:16 INFO - 2016-02-25 23:00:16.460 screenresolution[2578:20380] starting screenresolution argv=screenresolution get 23:00:16 INFO - 2016-02-25 23:00:16.462 screenresolution[2578:20380] Display 0: 1600x1200x32@60 23:00:16 INFO - 2016-02-25 23:00:16.468 screenresolution[2579:20384] starting screenresolution argv=screenresolution list 23:00:16 INFO - Available Modes on Display 0 23:00:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:00:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:00:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:00:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:00:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:00:16 INFO - Intel Iris: 23:00:16 INFO - Chipset Model: Intel Iris 23:00:16 INFO - Type: GPU 23:00:16 INFO - Bus: Built-In 23:00:16 INFO - VRAM (Dynamic, Max): 1536 MB 23:00:16 INFO - Vendor: Intel (0x8086) 23:00:16 INFO - Device ID: 0x0a2e 23:00:16 INFO - Revision ID: 0x0009 23:00:16 INFO - Displays: 23:00:16 INFO - Display: 23:00:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:00:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:00:16 INFO - Display Serial Number: 1600x1200 60 23:00:16 INFO - Main Display: Yes 23:00:16 INFO - Mirror: Off 23:00:16 INFO - Online: Yes 23:00:16 INFO - Rotation: Supported 23:00:16 INFO - Return code: 0 23:00:16 INFO - Running post-action listener: _resource_record_post_action 23:00:16 INFO - Running post-run listener: _resource_record_post_run 23:00:17 INFO - Total resource usage - Wall time: 1208s; CPU: 52.0%; Read bytes: 167936; Write bytes: 706604032; Read time: 2; Write time: 1918 23:00:17 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 384866816; Write bytes: 379672576; Read time: 29799; Write time: 722 23:00:17 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 167936; Write bytes: 299435008; Read time: 2; Write time: 1143 23:00:17 INFO - Running post-run listener: _upload_blobber_files 23:00:17 INFO - Blob upload gear active. 23:00:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:00:17 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 23:00:17 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'] 23:00:17 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 23:00:18 INFO - (blobuploader) - INFO - Open directory for files ... 23:00:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:00:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:00:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:00:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:00:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:00:18 INFO - (blobuploader) - INFO - Done attempting. 23:00:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:00:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:00:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:00:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:00:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:00:20 INFO - (blobuploader) - INFO - Done attempting. 23:00:20 INFO - (blobuploader) - INFO - Iteration through files over. 23:00:20 INFO - Return code: 0 23:00:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:00:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:00:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32382fce10848144f5e190eefcbec2f92f9bf441910f073962657150611af5896715b85ebbb8ca9d8f4f591ff67ac63f82e9ae3f89d0d1092caa6f2ac415feed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cc61128c6b85d9b3c849ad767f99c712e849eaccbcd27415a44a777726949eeea1ef4c87533f3a7486876051a03d4d88db8d975928cea4314f63bb720ae837a"} 23:00:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:00:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:00:20 INFO - Contents: 23:00:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32382fce10848144f5e190eefcbec2f92f9bf441910f073962657150611af5896715b85ebbb8ca9d8f4f591ff67ac63f82e9ae3f89d0d1092caa6f2ac415feed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cc61128c6b85d9b3c849ad767f99c712e849eaccbcd27415a44a777726949eeea1ef4c87533f3a7486876051a03d4d88db8d975928cea4314f63bb720ae837a"} 23:00:20 INFO - Running post-run listener: copy_logs_to_upload_dir 23:00:20 INFO - Copying logs to upload dir... 23:00:20 INFO - mkdir: /builds/slave/test/build/upload/logs 23:00:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.805996 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-25 23:00:20.091248) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 23:00:20.097332) ========= 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.kGeNRgSkup/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.eRtGfBMPwM/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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/32382fce10848144f5e190eefcbec2f92f9bf441910f073962657150611af5896715b85ebbb8ca9d8f4f591ff67ac63f82e9ae3f89d0d1092caa6f2ac415feed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cc61128c6b85d9b3c849ad767f99c712e849eaccbcd27415a44a777726949eeea1ef4c87533f3a7486876051a03d4d88db8d975928cea4314f63bb720ae837a"} build_url:https://queue.taskcluster.net/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011577 build_url: 'https://queue.taskcluster.net/v1/task/O9kcxWTkQ2KWPNSPQR6X8g/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/32382fce10848144f5e190eefcbec2f92f9bf441910f073962657150611af5896715b85ebbb8ca9d8f4f591ff67ac63f82e9ae3f89d0d1092caa6f2ac415feed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cc61128c6b85d9b3c849ad767f99c712e849eaccbcd27415a44a777726949eeea1ef4c87533f3a7486876051a03d4d88db8d975928cea4314f63bb720ae837a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 23:00:20.127798) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 23:00:20.128138) ========= 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.kGeNRgSkup/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.eRtGfBMPwM/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.005505 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 23:00:20.179541) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 23:00:20.180257) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 23:00:20.181054) ========= ========= Total master_lag: 0.28 =========