builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0123 starttime: 1457642558.48 results: success (0) buildid: 20160310104625 builduid: 6aefd1c0e5804bf382fbb178119666df revision: dd5aaa1e47adcf1506c854a89bb934bb288e6f79 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 12:42:38.480451) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 12:42:38.480970) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 12:42:38.481274) ========= 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.2uGrDWRS2O/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.Lt9FUMJaiw/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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.005380 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 12:42:38.505294) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 12:42:38.506020) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 12:42:38.521683) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 12:42:38.521956) ========= 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.2uGrDWRS2O/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.Lt9FUMJaiw/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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.005116 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 12:42:38.571436) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 12:42:38.572030) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 12:42:38.572775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 12:42:38.573163) ========= 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.2uGrDWRS2O/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.Lt9FUMJaiw/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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-03-10 12:42:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 10.7M=0.001s 2016-03-10 12:42:38 (10.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088649 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 12:42:38.678822) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 12:42:38.679133) ========= 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.2uGrDWRS2O/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.Lt9FUMJaiw/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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.019298 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 12:42:38.731149) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-10 12:42:38.732004) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dd5aaa1e47adcf1506c854a89bb934bb288e6f79 --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 dd5aaa1e47adcf1506c854a89bb934bb288e6f79 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2uGrDWRS2O/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.Lt9FUMJaiw/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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-03-10 12:42:38,807 truncating revision to first 12 chars 2016-03-10 12:42:38,807 Setting DEBUG logging. 2016-03-10 12:42:38,807 attempt 1/10 2016-03-10 12:42:38,807 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dd5aaa1e47ad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-10 12:42:40,243 unpacking tar archive at: fx-team-dd5aaa1e47ad/testing/mozharness/ program finished with exit code 0 elapsedTime=1.686828 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-10 12:42:40.439916) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 12:42:40.440807) ========= echo dd5aaa1e47adcf1506c854a89bb934bb288e6f79 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'dd5aaa1e47adcf1506c854a89bb934bb288e6f79'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2uGrDWRS2O/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.Lt9FUMJaiw/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 dd5aaa1e47adcf1506c854a89bb934bb288e6f79 program finished with exit code 0 elapsedTime=0.005476 script_repo_revision: 'dd5aaa1e47adcf1506c854a89bb934bb288e6f79' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 12:42:40.492418) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 12:42:40.493682) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 12:42:40.507980) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-03-10 12:42:40.508266) ========= /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.2uGrDWRS2O/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.Lt9FUMJaiw/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 12:42:40 INFO - MultiFileLogger online at 20160310 12:42:40 in /builds/slave/test 12:42:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:42:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:42:40 INFO - {'append_to_log': False, 12:42:40 INFO - 'base_work_dir': '/builds/slave/test', 12:42:40 INFO - 'blob_upload_branch': 'Fx-Team', 12:42:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:42:40 INFO - 'branch': 'Fx-Team', 12:42:40 INFO - 'buildbot_json_path': 'buildprops.json', 12:42:40 INFO - 'config_files': ('talos/mac_config.py',), 12:42:40 INFO - 'default_actions': ('clobber', 12:42:40 INFO - 'read-buildbot-config', 12:42:40 INFO - 'download-and-extract', 12:42:40 INFO - 'populate-webroot', 12:42:40 INFO - 'create-virtualenv', 12:42:40 INFO - 'install', 12:42:40 INFO - 'run-tests'), 12:42:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:42:40 INFO - 'download_minidump_stackwalk': True, 12:42:40 INFO - 'download_symbols': 'ondemand', 12:42:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:42:40 INFO - 'tooltool.py': '/tools/tooltool.py', 12:42:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:42:40 INFO - '/tools/misc-python/virtualenv.py')}, 12:42:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:42:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:42:40 INFO - 'installer_path': 'installer.exe', 12:42:40 INFO - 'log_level': 'info', 12:42:40 INFO - 'log_name': 'talos', 12:42:40 INFO - 'log_to_console': True, 12:42:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:42:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:42:40 INFO - 'opt_config_files': (), 12:42:40 INFO - 'pip_index': False, 12:42:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:42:40 INFO - 'cmd': ('bash', 12:42:40 INFO - '-c', 12:42:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:42:40 INFO - 'enabled': True, 12:42:40 INFO - 'halt_on_failure': False, 12:42:40 INFO - 'name': 'check_screen_resolution'},), 12:42:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:42:40 INFO - 'cmd': ('bash', 12:42:40 INFO - '-c', 12:42:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:42:40 INFO - 'enabled': True, 12:42:40 INFO - 'halt_on_failure': False, 12:42:40 INFO - 'name': 'check_screen_resolution'},), 12:42:40 INFO - 'run_cmd_checks_enabled': True, 12:42:40 INFO - 'sps_profile': False, 12:42:40 INFO - 'sps_profile_interval': 0, 12:42:40 INFO - 'suite': 'dromaeojs', 12:42:40 INFO - 'system_bits': '32', 12:42:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:42:40 INFO - 'title': 't-yosemite-r7-0123', 12:42:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:42:40 INFO - 'use_talos_json': True, 12:42:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:42:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:42:40 INFO - 'work_dir': 'build'} 12:42:40 INFO - ##### 12:42:40 INFO - ##### Running clobber step. 12:42:40 INFO - ##### 12:42:40 INFO - Running pre-action listener: _resource_record_pre_action 12:42:40 INFO - Running main action method: clobber 12:42:40 INFO - rmtree: /builds/slave/test/build 12:42:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:42:42 INFO - Running post-action listener: _resource_record_post_action 12:42:42 INFO - ##### 12:42:42 INFO - ##### Running read-buildbot-config step. 12:42:42 INFO - ##### 12:42:42 INFO - Running pre-action listener: _resource_record_pre_action 12:42:42 INFO - Running main action method: read_buildbot_config 12:42:42 INFO - Using buildbot properties: 12:42:42 INFO - { 12:42:42 INFO - "project": "", 12:42:42 INFO - "product": "firefox", 12:42:42 INFO - "script_repo_revision": "production", 12:42:42 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 12:42:42 INFO - "repository": "", 12:42:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 12:42:42 INFO - "buildid": "20160310104625", 12:42:42 INFO - "pgo_build": "False", 12:42:42 INFO - "basedir": "/builds/slave/test", 12:42:42 INFO - "buildnumber": 518, 12:42:42 INFO - "slavename": "t-yosemite-r7-0123", 12:42:42 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 12:42:42 INFO - "platform": "yosemite_r7", 12:42:42 INFO - "scheduler": "tests-fx-team-macosx64-talos", 12:42:42 INFO - "branch": "fx-team", 12:42:42 INFO - "repo_path": "integration/fx-team", 12:42:42 INFO - "revision": "dd5aaa1e47adcf1506c854a89bb934bb288e6f79", 12:42:42 INFO - "stage_platform": "macosx64", 12:42:42 INFO - "builduid": "6aefd1c0e5804bf382fbb178119666df", 12:42:42 INFO - "slavebuilddir": "test" 12:42:42 INFO - } 12:42:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 12:42:42 INFO - Running post-action listener: _resource_record_post_action 12:42:42 INFO - ##### 12:42:42 INFO - ##### Running download-and-extract step. 12:42:42 INFO - ##### 12:42:42 INFO - Running pre-action listener: _resource_record_pre_action 12:42:42 INFO - Running main action method: download_and_extract 12:42:42 INFO - mkdir: /builds/slave/test/build/tests 12:42: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')]} 12:42:42 INFO - https://queue.taskcluster.net/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 12:42:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 12:42:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 12:42:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 12:42:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 12:42:44 INFO - Downloaded 1199 bytes. 12:42:44 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 12:42:44 INFO - Using the following test package requirements: 12:42:44 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 12:42:44 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:42:44 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 12:42:44 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:42:44 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 12:42:44 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:42:44 INFO - u'jsshell-mac.zip'], 12:42:44 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:42:44 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 12:42:44 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 12:42:44 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:42:44 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 12:42:44 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:42:44 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 12:42:44 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:42:44 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 12:42:44 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:42:44 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 12:42:44 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:42:44 INFO - https://queue.taskcluster.net/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:42:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:42:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:42:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:42:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:42:45 INFO - Downloaded 17867499 bytes. 12:42:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:42:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:42:48 INFO - Return code: 0 12:42:48 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:42:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:42:48 INFO - https://queue.taskcluster.net/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:42:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:42:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:42:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:42:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:42:49 INFO - Downloaded 17867499 bytes. 12:42:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:42:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:42:52 INFO - Return code: 0 12:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:42:52 INFO - https://queue.taskcluster.net/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:42:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 12:42:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 12:42:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 12:42:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:42:53 INFO - Downloaded 10845161 bytes. 12:42:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:42:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 12:42:54 INFO - Return code: 0 12:42: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')]} 12:42:54 INFO - https://queue.taskcluster.net/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:42:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 12:42:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 12:42:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 12:42:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 12:42:57 INFO - Downloaded 110985809 bytes. 12:42:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 12:42:57 INFO - mkdir: /builds/slave/test/properties 12:42:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:42:57 INFO - Writing to file /builds/slave/test/properties/build_url 12:42:57 INFO - Contents: 12:42:57 INFO - build_url:https://queue.taskcluster.net/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 12:42:58 INFO - Running post-action listener: _resource_record_post_action 12:42:58 INFO - Running post-action listener: set_extra_try_arguments 12:42:58 INFO - ##### 12:42:58 INFO - ##### Running populate-webroot step. 12:42:58 INFO - ##### 12:42:58 INFO - Running pre-action listener: _resource_record_pre_action 12:42:58 INFO - Running main action method: populate_webroot 12:42:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:42:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:42:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:42:58 INFO - '--tppagecycles', 12:42:58 INFO - '7'], 12:42:58 INFO - 'tests': ['tsvgm']}}, 12:42:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:42:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:42:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:42:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:42:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:42:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:42:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:42:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:58 INFO - 'talos_options': ['--e10s'], 12:42:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:42:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:58 INFO - 'tests': ['damp', 'tps']}, 12:42:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:58 INFO - 'talos_options': ['--e10s'], 12:42:58 INFO - 'tests': ['damp', 'tps']}, 12:42:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:42:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:42:58 INFO - 'other': {'tests': ['a11yr', 12:42:58 INFO - 'ts_paint', 12:42:58 INFO - 'tpaint', 12:42:58 INFO - 'sessionrestore', 12:42:58 INFO - 'sessionrestore_no_auto_restore', 12:42:58 INFO - 'tabpaint']}, 12:42:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:42:58 INFO - 'tests': ['a11yr', 12:42:58 INFO - 'ts_paint', 12:42:58 INFO - 'tpaint', 12:42:58 INFO - 'sessionrestore', 12:42:58 INFO - 'sessionrestore_no_auto_restore', 12:42:58 INFO - 'tabpaint']}, 12:42:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:42:58 INFO - 'tests': ['a11yr', 12:42:58 INFO - 'ts_paint', 12:42:58 INFO - 'tpaint', 12:42:58 INFO - 'sessionrestore', 12:42:58 INFO - 'sessionrestore_no_auto_restore', 12:42:58 INFO - 'tabpaint']}, 12:42:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:42:58 INFO - 'tests': ['a11yr', 12:42:58 INFO - 'ts_paint', 12:42:58 INFO - 'tpaint', 12:42:58 INFO - 'sessionrestore', 12:42:58 INFO - 'sessionrestore_no_auto_restore', 12:42:58 INFO - 'tabpaint']}, 12:42:58 INFO - 'other_l64': {'tests': ['a11yr', 12:42:58 INFO - 'ts_paint', 12:42:58 INFO - 'tpaint', 12:42:58 INFO - 'sessionrestore', 12:42:58 INFO - 'sessionrestore_no_auto_restore', 12:42:58 INFO - 'tabpaint']}, 12:42:58 INFO - 'other_nol64': {'tests': ['a11yr', 12:42:58 INFO - 'ts_paint', 12:42:58 INFO - 'tpaint', 12:42:58 INFO - 'sessionrestore', 12:42:58 INFO - 'sessionrestore_no_auto_restore', 12:42:58 INFO - 'tabpaint']}, 12:42:58 INFO - 'svgr': {'tests': ['tsvgx', 12:42:58 INFO - 'tsvgr_opacity', 12:42:58 INFO - 'tart', 12:42:58 INFO - 'tscrollx', 12:42:58 INFO - 'cart']}, 12:42:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:42:58 INFO - 'tests': ['tsvgx', 12:42:58 INFO - 'tsvgr_opacity', 12:42:58 INFO - 'tart', 12:42:58 INFO - 'tscrollx', 12:42:58 INFO - 'cart']}, 12:42:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:58 INFO - 'tests': ['tp5o']}, 12:42:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:58 INFO - 'talos_options': ['--e10s'], 12:42:58 INFO - 'tests': ['tp5o']}, 12:42:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:58 INFO - 'talos_options': ['--xperf_path', 12:42:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:42:58 INFO - 'tests': ['tp5n']}, 12:42:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:58 INFO - 'talos_options': ['--e10s', 12:42:58 INFO - '--xperf_path', 12:42:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:42:58 INFO - 'tests': ['tp5n']}}, 12:42:58 INFO - 'talos.zip': {'path': '', 12:42:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:42:58 INFO - Running post-action listener: _resource_record_post_action 12:42:58 INFO - ##### 12:42:58 INFO - ##### Running create-virtualenv step. 12:42:58 INFO - ##### 12:42:58 INFO - Running pre-action listener: _resource_record_pre_action 12:42:58 INFO - Running main action method: create_virtualenv 12:42:58 INFO - Creating virtualenv /builds/slave/test/build/venv 12:42:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:42:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:42:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:42:58 INFO - Using real prefix '/tools/python27' 12:42:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:42:59 INFO - Installing distribute.............................................................................................................................................................................................done. 12:43:01 INFO - Installing pip.................done. 12:43:01 INFO - Return code: 0 12:43:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:01 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 0x100d94a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d9c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcefb48c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c38d30>, '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 0x100a5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c2fb20>, '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.2uGrDWRS2O/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.Lt9FUMJaiw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:43:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:43:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2uGrDWRS2O/Render', 12:43:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:01 INFO - 'HOME': '/Users/cltbld', 12:43:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:01 INFO - 'LOGNAME': 'cltbld', 12:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:01 INFO - 'MOZ_NO_REMOTE': '1', 12:43:01 INFO - 'NO_EM_RESTART': '1', 12:43:01 INFO - 'PAGER': '/bin/cat', 12:43:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:01 INFO - 'PWD': '/builds/slave/test', 12:43:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:01 INFO - 'SHELL': '/bin/bash', 12:43:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lt9FUMJaiw/Listeners', 12:43:01 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 12:43:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:01 INFO - 'USER': 'cltbld', 12:43:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:01 INFO - 'XPC_FLAGS': '0x0', 12:43:01 INFO - 'XPC_SERVICE_NAME': '0', 12:43:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:43:02 INFO - Cleaning up... 12:43:02 INFO - Return code: 0 12:43:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:02 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 0x100d94a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d9c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcefb48c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c38d30>, '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 0x100a5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c2fb20>, '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.2uGrDWRS2O/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.Lt9FUMJaiw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:43:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:43:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:43:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2uGrDWRS2O/Render', 12:43:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:02 INFO - 'HOME': '/Users/cltbld', 12:43:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:02 INFO - 'LOGNAME': 'cltbld', 12:43:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:02 INFO - 'MOZ_NO_REMOTE': '1', 12:43:02 INFO - 'NO_EM_RESTART': '1', 12:43:02 INFO - 'PAGER': '/bin/cat', 12:43:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:02 INFO - 'PWD': '/builds/slave/test', 12:43:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:02 INFO - 'SHELL': '/bin/bash', 12:43:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lt9FUMJaiw/Listeners', 12:43:02 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 12:43:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:02 INFO - 'USER': 'cltbld', 12:43:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:02 INFO - 'XPC_FLAGS': '0x0', 12:43:02 INFO - 'XPC_SERVICE_NAME': '0', 12:43:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:02 INFO - Downloading/unpacking psutil>=0.7.1 12:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:43:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:43:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:43:05 INFO - Installing collected packages: psutil 12:43:05 INFO - Running setup.py install for psutil 12:43:05 INFO - building 'psutil._psutil_osx' extension 12:43:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 12:43:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 12:43:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 12:43:05 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 12:43:05 INFO - building 'psutil._psutil_posix' extension 12:43:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 12:43:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:43:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:43:05 INFO - ^ 12:43:05 INFO - 1 warning generated. 12:43:05 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 12:43:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:43:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:43:06 INFO - Successfully installed psutil 12:43:06 INFO - Cleaning up... 12:43:06 INFO - Return code: 0 12:43:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:06 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 0x100d94a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d9c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcefb48c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c38d30>, '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 0x100a5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c2fb20>, '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.2uGrDWRS2O/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.Lt9FUMJaiw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:43:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:43:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2uGrDWRS2O/Render', 12:43:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:06 INFO - 'HOME': '/Users/cltbld', 12:43:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:06 INFO - 'LOGNAME': 'cltbld', 12:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:06 INFO - 'MOZ_NO_REMOTE': '1', 12:43:06 INFO - 'NO_EM_RESTART': '1', 12:43:06 INFO - 'PAGER': '/bin/cat', 12:43:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:06 INFO - 'PWD': '/builds/slave/test', 12:43:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:06 INFO - 'SHELL': '/bin/bash', 12:43:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lt9FUMJaiw/Listeners', 12:43:06 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 12:43:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:06 INFO - 'USER': 'cltbld', 12:43:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:06 INFO - 'XPC_FLAGS': '0x0', 12:43:06 INFO - 'XPC_SERVICE_NAME': '0', 12:43:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:43: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 12:43: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 12:43: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 12:43: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 12:43: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 12:43: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 12:43:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:43:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:43:08 INFO - Installing collected packages: mozsystemmonitor 12:43:08 INFO - Running setup.py install for mozsystemmonitor 12:43:08 INFO - Successfully installed mozsystemmonitor 12:43:08 INFO - Cleaning up... 12:43:09 INFO - Return code: 0 12:43:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:09 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 0x100d94a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d9c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcefb48c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c38d30>, '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 0x100a5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c2fb20>, '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.2uGrDWRS2O/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.Lt9FUMJaiw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:43:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:43:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:43:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2uGrDWRS2O/Render', 12:43:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:09 INFO - 'HOME': '/Users/cltbld', 12:43:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:09 INFO - 'LOGNAME': 'cltbld', 12:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:09 INFO - 'MOZ_NO_REMOTE': '1', 12:43:09 INFO - 'NO_EM_RESTART': '1', 12:43:09 INFO - 'PAGER': '/bin/cat', 12:43:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:09 INFO - 'PWD': '/builds/slave/test', 12:43:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:09 INFO - 'SHELL': '/bin/bash', 12:43:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lt9FUMJaiw/Listeners', 12:43:09 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 12:43:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:09 INFO - 'USER': 'cltbld', 12:43:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:09 INFO - 'XPC_FLAGS': '0x0', 12:43:09 INFO - 'XPC_SERVICE_NAME': '0', 12:43:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:09 INFO - Downloading/unpacking blobuploader==1.2.4 12:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:11 INFO - Downloading blobuploader-1.2.4.tar.gz 12:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:43:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:43:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:12 INFO - Downloading docopt-0.6.1.tar.gz 12:43:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:43:12 INFO - Installing collected packages: blobuploader, requests, docopt 12:43:12 INFO - Running setup.py install for blobuploader 12:43:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:43:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:43:12 INFO - Running setup.py install for requests 12:43:13 INFO - Running setup.py install for docopt 12:43:13 INFO - Successfully installed blobuploader requests docopt 12:43:13 INFO - Cleaning up... 12:43:13 INFO - Return code: 0 12:43:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:13 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 0x100d94a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d9c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcefb48c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c38d30>, '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 0x100a5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c2fb20>, '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.2uGrDWRS2O/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.Lt9FUMJaiw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:43:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:43:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2uGrDWRS2O/Render', 12:43:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:13 INFO - 'HOME': '/Users/cltbld', 12:43:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:13 INFO - 'LOGNAME': 'cltbld', 12:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:13 INFO - 'MOZ_NO_REMOTE': '1', 12:43:13 INFO - 'NO_EM_RESTART': '1', 12:43:13 INFO - 'PAGER': '/bin/cat', 12:43:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:13 INFO - 'PWD': '/builds/slave/test', 12:43:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:13 INFO - 'SHELL': '/bin/bash', 12:43:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lt9FUMJaiw/Listeners', 12:43:13 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 12:43:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:13 INFO - 'USER': 'cltbld', 12:43:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:13 INFO - 'XPC_FLAGS': '0x0', 12:43:13 INFO - 'XPC_SERVICE_NAME': '0', 12:43:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:43:14 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-MJzSlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:43:14 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-KfvvUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:43:14 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-nEoAGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:43:14 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-RwsLyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:43:14 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-5dGyRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:43:14 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-lX9n8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:43:14 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-vU7cUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:43:14 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-NtI7nD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:43:14 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-BJ5OJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:43:14 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-gbbAQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:43:15 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-5uPCnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:43:15 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-NZEut6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:43:15 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-w_uGSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:43:15 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-xehARZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:15 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-YvEynS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:43:15 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-y2T1vU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:43:15 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-d7HoDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:43:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:43:15 INFO - Running setup.py install for manifestparser 12:43:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:43:15 INFO - Running setup.py install for mozcrash 12:43:16 INFO - Running setup.py install for mozdebug 12:43:16 INFO - Running setup.py install for mozdevice 12:43:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:43:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:43:16 INFO - Running setup.py install for mozfile 12:43:16 INFO - Running setup.py install for mozhttpd 12:43:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:43:16 INFO - Running setup.py install for mozinfo 12:43:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:43:16 INFO - Running setup.py install for mozInstall 12:43:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:43:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:43:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:43:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:43:16 INFO - Running setup.py install for mozleak 12:43:17 INFO - Running setup.py install for mozlog 12:43:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:43:17 INFO - Running setup.py install for moznetwork 12:43:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:43:17 INFO - Running setup.py install for mozprocess 12:43:17 INFO - Running setup.py install for mozprofile 12:43:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:43:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:43:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:43:17 INFO - Running setup.py install for mozrunner 12:43:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:43:17 INFO - Running setup.py install for mozscreenshot 12:43:18 INFO - Running setup.py install for moztest 12:43:18 INFO - Running setup.py install for mozversion 12:43:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:43:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:43:18 INFO - Cleaning up... 12:43:18 INFO - Return code: 0 12:43:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:18 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 0x100d94a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d9c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcefb48c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c38d30>, '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 0x100a5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c2fb20>, '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.2uGrDWRS2O/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.Lt9FUMJaiw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:43:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:43:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:43:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2uGrDWRS2O/Render', 12:43:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:18 INFO - 'HOME': '/Users/cltbld', 12:43:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:18 INFO - 'LOGNAME': 'cltbld', 12:43:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:18 INFO - 'MOZ_NO_REMOTE': '1', 12:43:18 INFO - 'NO_EM_RESTART': '1', 12:43:18 INFO - 'PAGER': '/bin/cat', 12:43:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:18 INFO - 'PWD': '/builds/slave/test', 12:43:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:18 INFO - 'SHELL': '/bin/bash', 12:43:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lt9FUMJaiw/Listeners', 12:43:18 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 12:43:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:18 INFO - 'USER': 'cltbld', 12:43:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:18 INFO - 'XPC_FLAGS': '0x0', 12:43:18 INFO - 'XPC_SERVICE_NAME': '0', 12:43:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:43:18 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-26avGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:43:18 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-31_UWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:43:18 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-3MWvsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:43:18 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-SrMLZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:43:19 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-9BQ7Fw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:43:19 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-x99vL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:43:19 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-jUhUjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:43:19 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-cn2we8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:43:19 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-blVEuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:43:19 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-biQwFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:43:19 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-VO2GXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:43:19 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-DWvWjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:43:19 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-d6EJTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:43:20 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-Nq18ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:20 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-9jDTEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:43:20 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-CwWvj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:43:20 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-0_Tvlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:43:20 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:43:20 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:43:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:22 INFO - Downloading blessings-1.6.tar.gz 12:43:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:43:22 INFO - Installing collected packages: blessings 12:43:22 INFO - Running setup.py install for blessings 12:43:23 INFO - Successfully installed blessings 12:43:23 INFO - Cleaning up... 12:43:23 INFO - Return code: 0 12:43:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:43:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:43:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:43:23 INFO - Reading from file tmpfile_stdout 12:43:23 INFO - Current package versions: 12:43:23 INFO - blessings == 1.6 12:43:23 INFO - blobuploader == 1.2.4 12:43:23 INFO - docopt == 0.6.1 12:43:23 INFO - manifestparser == 1.1 12:43:23 INFO - mozInstall == 1.12 12:43:23 INFO - mozcrash == 0.17 12:43:23 INFO - mozdebug == 0.1 12:43:23 INFO - mozdevice == 0.48 12:43:23 INFO - mozfile == 1.2 12:43:23 INFO - mozhttpd == 0.7 12:43:23 INFO - mozinfo == 0.9 12:43:23 INFO - mozleak == 0.1 12:43:23 INFO - mozlog == 3.1 12:43:23 INFO - moznetwork == 0.27 12:43:23 INFO - mozprocess == 0.22 12:43:23 INFO - mozprofile == 0.28 12:43:23 INFO - mozrunner == 6.11 12:43:23 INFO - mozscreenshot == 0.1 12:43:23 INFO - mozsystemmonitor == 0.0 12:43:23 INFO - moztest == 0.7 12:43:23 INFO - mozversion == 1.4 12:43:23 INFO - psutil == 3.1.1 12:43:23 INFO - requests == 1.2.3 12:43:23 INFO - wsgiref == 0.1.2 12:43:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:43:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:23 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 0x100d94a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d9c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcefb48c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c38d30>, '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 0x100a5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c2fb20>, '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.2uGrDWRS2O/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.Lt9FUMJaiw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:43:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:43:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:43:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2uGrDWRS2O/Render', 12:43:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:23 INFO - 'HOME': '/Users/cltbld', 12:43:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:23 INFO - 'LOGNAME': 'cltbld', 12:43:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:23 INFO - 'MOZ_NO_REMOTE': '1', 12:43:23 INFO - 'NO_EM_RESTART': '1', 12:43:23 INFO - 'PAGER': '/bin/cat', 12:43:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:23 INFO - 'PWD': '/builds/slave/test', 12:43:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:23 INFO - 'SHELL': '/bin/bash', 12:43:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lt9FUMJaiw/Listeners', 12:43:23 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 12:43:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:23 INFO - 'USER': 'cltbld', 12:43:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:23 INFO - 'XPC_FLAGS': '0x0', 12:43:23 INFO - 'XPC_SERVICE_NAME': '0', 12:43:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:43:23 INFO - Cleaning up... 12:43:23 INFO - Return code: 0 12:43:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:43:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100d94a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d9c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcefb48c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c38d30>, '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 0x100a5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c2fb20>, '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.2uGrDWRS2O/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.Lt9FUMJaiw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:43:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:43:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:43:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2uGrDWRS2O/Render', 12:43:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:23 INFO - 'HOME': '/Users/cltbld', 12:43:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:23 INFO - 'LOGNAME': 'cltbld', 12:43:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:23 INFO - 'MOZ_NO_REMOTE': '1', 12:43:23 INFO - 'NO_EM_RESTART': '1', 12:43:23 INFO - 'PAGER': '/bin/cat', 12:43:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:23 INFO - 'PWD': '/builds/slave/test', 12:43:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:23 INFO - 'SHELL': '/bin/bash', 12:43:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lt9FUMJaiw/Listeners', 12:43:23 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 12:43:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:23 INFO - 'USER': 'cltbld', 12:43:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:23 INFO - 'XPC_FLAGS': '0x0', 12:43:23 INFO - 'XPC_SERVICE_NAME': '0', 12:43:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:23 INFO - Downloading/unpacking jsonschema 12:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:43:26 INFO - Downloading/unpacking functools32 (from jsonschema) 12:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:26 INFO - Downloading functools32-3.2.3-2.tar.gz 12:43:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:43:26 INFO - warning: no files found matching '*.txt' 12:43:26 INFO - no previously-included directories found matching 'build' 12:43:26 INFO - no previously-included directories found matching 'dist' 12:43:26 INFO - no previously-included directories found matching '.git*' 12:43:26 INFO - Installing collected packages: jsonschema, functools32 12:43:26 INFO - Running setup.py install for functools32 12:43:26 INFO - warning: no files found matching '*.txt' 12:43:26 INFO - no previously-included directories found matching 'build' 12:43:26 INFO - no previously-included directories found matching 'dist' 12:43:26 INFO - no previously-included directories found matching '.git*' 12:43:26 INFO - Successfully installed jsonschema functools32 12:43:26 INFO - Cleaning up... 12:43:27 INFO - Return code: 0 12:43:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100d94a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d9c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcefb48c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c38d30>, '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 0x100a5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c2fb20>, '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.2uGrDWRS2O/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.Lt9FUMJaiw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:43:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:43:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:43:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2uGrDWRS2O/Render', 12:43:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:27 INFO - 'HOME': '/Users/cltbld', 12:43:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:27 INFO - 'LOGNAME': 'cltbld', 12:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:27 INFO - 'MOZ_NO_REMOTE': '1', 12:43:27 INFO - 'NO_EM_RESTART': '1', 12:43:27 INFO - 'PAGER': '/bin/cat', 12:43:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:27 INFO - 'PWD': '/builds/slave/test', 12:43:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:27 INFO - 'SHELL': '/bin/bash', 12:43:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lt9FUMJaiw/Listeners', 12:43:27 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 12:43:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:27 INFO - 'USER': 'cltbld', 12:43:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:27 INFO - 'XPC_FLAGS': '0x0', 12:43:27 INFO - 'XPC_SERVICE_NAME': '0', 12:43:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:27 INFO - Downloading/unpacking flake8 12:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:43:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:43:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:43:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:43:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:43:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:43:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:43:30 INFO - no previously-included directories found matching 'docs/_build' 12:43:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:43:30 INFO - Running setup.py install for pep8 12:43:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:43:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:43:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:43:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:43:31 INFO - no previously-included directories found matching 'docs/_build' 12:43:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:43:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:43:31 INFO - Cleaning up... 12:43:31 INFO - Return code: 0 12:43:31 INFO - Running post-action listener: _resource_record_post_action 12:43:31 INFO - Running post-action listener: _start_resource_monitoring 12:43:31 INFO - Starting resource monitoring. 12:43:31 INFO - ##### 12:43:31 INFO - ##### Running install step. 12:43:31 INFO - ##### 12:43:31 INFO - Running pre-action listener: _resource_record_pre_action 12:43:31 INFO - Running main action method: install 12:43:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:43:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:43:31 INFO - Reading from file tmpfile_stdout 12:43:31 INFO - Detecting whether we're running mozinstall >=1.0... 12:43:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:43:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:43:31 INFO - Reading from file tmpfile_stdout 12:43:31 INFO - Output received: 12:43:31 INFO - Usage: mozinstall [options] installer 12:43:31 INFO - Options: 12:43:31 INFO - -h, --help show this help message and exit 12:43:31 INFO - -d DEST, --destination=DEST 12:43:31 INFO - Directory to install application into. [default: 12:43:31 INFO - "/builds/slave/test"] 12:43:31 INFO - --app=APP Application being installed. [default: firefox] 12:43:31 INFO - mkdir: /builds/slave/test/build/application 12:43:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:43:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:44:04 INFO - Reading from file tmpfile_stdout 12:44:04 INFO - Output received: 12:44:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:44:04 INFO - Running post-action listener: _resource_record_post_action 12:44:04 INFO - ##### 12:44:04 INFO - ##### Running run-tests step. 12:44:04 INFO - ##### 12:44:04 INFO - Running pre-action listener: _resource_record_pre_action 12:44:04 INFO - Running main action method: run_tests 12:44:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:44:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:44:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:44:04 INFO - 2016-03-10 12:44:04.898 screenresolution[1934:10318] starting screenresolution argv=screenresolution get 12:44:04 INFO - 2016-03-10 12:44:04.901 screenresolution[1934:10318] Display 0: 1600x1200x32@60 12:44:04 INFO - 2016-03-10 12:44:04.907 screenresolution[1935:10320] starting screenresolution argv=screenresolution list 12:44:04 INFO - Available Modes on Display 0 12:44:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:44:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:44:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:44:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:44:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:44:05 INFO - Intel Iris: 12:44:05 INFO - Chipset Model: Intel Iris 12:44:05 INFO - Type: GPU 12:44:05 INFO - Bus: Built-In 12:44:05 INFO - VRAM (Dynamic, Max): 1536 MB 12:44:05 INFO - Vendor: Intel (0x8086) 12:44:05 INFO - Device ID: 0x0a2e 12:44:05 INFO - Revision ID: 0x0009 12:44:05 INFO - Displays: 12:44:05 INFO - Display: 12:44:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:44:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:44:05 INFO - Display Serial Number: 1600x1200 60 12:44:05 INFO - Main Display: Yes 12:44:05 INFO - Mirror: Off 12:44:05 INFO - Online: Yes 12:44:05 INFO - Rotation: Supported 12:44:05 INFO - Return code: 0 12:44:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:44:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:44:05 INFO - Python 2.7.3 12:44:05 INFO - Return code: 0 12:44:05 INFO - grabbing minidump binary from tooltool 12:44:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:05 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 0x100c38d30>, '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 0x100a5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c2fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:44:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:44:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 12:44:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:44:05 INFO - Return code: 0 12:44:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:44:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:44:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:44:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:44:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:44:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:44:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:44:06 INFO - Return code: 0 12:44:06 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/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0123', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:44:06 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/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0123 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:44:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2uGrDWRS2O/Render', 12:44:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:44:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:44:06 INFO - 'HOME': '/Users/cltbld', 12:44:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:44:06 INFO - 'LOGNAME': 'cltbld', 12:44:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:44:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:06 INFO - 'MOZ_NO_REMOTE': '1', 12:44:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:44:06 INFO - 'NO_EM_RESTART': '1', 12:44:06 INFO - 'PAGER': '/bin/cat', 12:44:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:06 INFO - 'PWD': '/builds/slave/test', 12:44:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:44:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:44:06 INFO - 'SHELL': '/bin/bash', 12:44:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lt9FUMJaiw/Listeners', 12:44:06 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 12:44:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:44:06 INFO - 'USER': 'cltbld', 12:44:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:44:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:06 INFO - 'XPC_FLAGS': '0x0', 12:44:06 INFO - 'XPC_SERVICE_NAME': '0', 12:44:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:44:06 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/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0123', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:44:06 INFO - mozversion application_buildid: 20160310104625 12:44:06 INFO - mozversion application_changeset: dd5aaa1e47adcf1506c854a89bb934bb288e6f79 12:44:06 INFO - mozversion application_display_name: Nightly 12:44:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:44:06 INFO - mozversion application_name: Firefox 12:44:06 INFO - mozversion application_remotingname: firefox 12:44:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:44:06 INFO - mozversion application_vendor: Mozilla 12:44:06 INFO - mozversion application_version: 48.0a1 12:44:06 INFO - mozversion platform_buildid: 20160310104625 12:44:06 INFO - mozversion platform_changeset: dd5aaa1e47adcf1506c854a89bb934bb288e6f79 12:44:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:44:06 INFO - mozversion platform_version: 48.0a1 12:44:06 INFO - using testdate: 1457642646 12:44:06 INFO - actual date: 1457642646 12:44:06 INFO - starting webserver on 'localhost:49478' 12:44:06 INFO - SUITE-START | Running 2 tests 12:44:06 INFO - TEST-START | dromaeo_css 12:44:06 INFO - operating with platform_type : mac_ 12:44:06 INFO - Initialising browser for dromaeo_css test... 12:44:06 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpCCRa_T/profile http://localhost:49478/getInfo.html) 12:44:08 INFO - PROCESS | 1953 | __metrics Screen width/height:1600/1200 12:44:08 INFO - PROCESS | 1953 | colorDepth:24 12:44:08 INFO - PROCESS | 1953 | Browser inner width/height: 1024/689 12:44:08 INFO - PROCESS | 1953 | __metrics 12:44:08 INFO - PROCESS | 1953 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:44:08 ERROR - PROCESS | 1953 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:44:09 INFO - TEST-INFO | 1953: exit 0 12:44:09 INFO - Browser initialized. 12:44:09 INFO - Running cycle 1/1 for dromaeo_css test... 12:44:09 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpCCRa_T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:44:21 INFO - PROCESS | 1956 | RSS: Main: 243167232 12:44:21 INFO - PROCESS | 1956 | 12:45:13 INFO - PROCESS | 1956 | 1457642713225 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:47:22 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49478/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49478/tests/dromaeo/cssquery-ext.html) 12:47:24 INFO - PROCESS | 1956 | RSS: Main: 299286528 12:47:24 INFO - PROCESS | 1956 | 12:50:26 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49478/tests/dromaeo/cssquery-ext.html (next: http://localhost:49478/tests/dromaeo/cssquery-jquery.html) 12:50:27 INFO - PROCESS | 1956 | RSS: Main: 378540032 12:50:27 INFO - PROCESS | 1956 | 12:53:29 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49478/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49478/tests/dromaeo/cssquery-mootools.html) 12:53:29 INFO - PROCESS | 1956 | RSS: Main: 374964224 12:53:29 INFO - PROCESS | 1956 | 12:56:32 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49478/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49478/tests/dromaeo/cssquery-prototype.html) 12:56:32 INFO - PROCESS | 1956 | RSS: Main: 337240064 12:56:32 INFO - PROCESS | 1956 | 12:59:35 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49478/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49478/tests/dromaeo/cssquery-yui.html) 12:59:36 INFO - PROCESS | 1956 | RSS: Main: 337444864 12:59:36 INFO - PROCESS | 1956 | 13:02:39 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49478/tests/dromaeo/cssquery-yui.html (next: http://localhost:49478/tests/dromaeo/cssquery-dojo.html) 13:02:39 INFO - PROCESS | 1956 | RSS: Main: 377901056 13:02:39 INFO - PROCESS | 1956 | 13:02:39 INFO - PROCESS | 1956 | __start_tp_report 13:02:39 INFO - PROCESS | 1956 | _x_x_mozilla_page_load 13:02:39 INFO - PROCESS | 1956 | _x_x_mozilla_page_load_details 13:02:39 INFO - PROCESS | 1956 | |i|pagename|runs| 13:02:39 INFO - PROCESS | 1956 | |0;dojo.html;2899.9855000724997;3460.2733425980537;3469.6009958854725;3488.3372159289715;3532.894013179604;5589.8602534936645;5595.636283641566;5614.10174372101;5635.408282130374;5725.885482290362;5666.065099258628;5706.486416222539;5741.885162296751;5797.246357973468;5809.825705228839;5079.898402031957;5128.53843154116;5142.974285128569;5145.922811157836;5254.684718916858;5215.191645294985;5235.397929238148;5275.947240527584;5286.7885284588765;5317.41508434072;5069.543741063304;5181.740912954338;5187.144121219994;5189.247559103909;5191.8442446726285;4546.204414227497;5103.413107492649;5189.273501709764;5191.143461328877;5241.109011468059;5080.79676812927;5120.948790512084;5127.820526281562;5143.3570803649545;5158.226266060084;5484.122540393518;5581.609287349887;5606.859828504279;5621.7751289948355;5621.887562248773;5367.5169234769055;6082.698368372759;6238.781642642532;6249.187605611287;6252.218472690914;6268.341824108448;6313.621182729051;6320.525960552931;6340.048992651093;6360.459360954324;5576.553875689935;5774.2782152230975;5787.826365209008;5795.971020144872;5811.186433899257;6261.154744109578;6309.179806625201;6314.116023756677;6316.178896743486;6335.556511044275;5105.8723531911255;6118.174046503754;6199.070139479114;6201.658908759971;6221.9377806222265;6099.461111717566;6189.50483961282;6303.936960630427;6307.779227727007;6312.495000399957;5576.944230557724;5982.8632559813495;6229.719662615194;6284.088807123033;6300.810975670737;6246.219222597176;6265.342139075423;6277.717502712298;6302.873942521215;6314.55798094129;4106.507219133723;4840.080384726891;4867.756612169377;4894.363732714724;4956.058348913695;3831.59768224338;3975.34406822871;4273.145370925828;4372.23485889968;4419.558044195554;5670.121131224667;5715.914261286084;5717.113847353667;5721.856953576111;5764.164196191528;6128.846778830565;6185.721642526097;6191.25704915413;6191.5665903387235;6327.746890124344;5690.5447564194765;5762.135679648086;5763.625364351387;5797.24635797352;5833.416658334133;5362.249285100089;5374.086405311106;5376;5382.30030096085;5398.838034858961;6184.536159788124;6228.813135605939;6360.204974378203;6374.1394911688185;6378.2346118466085;6183.258009038944;6194.566380353513;6202.224721909762;6213.316535181217;6219.968900155471;6234.251889773256;6276.058591211172;6335.366463353628;6346.492280617447;6350.142730731292;6184.505239580732;6204.472619827366;6212.409821066992;6219.160413344141;6223.408776166257;6128.417800308964;6137.8465538360115;6199.845003874759;6203.751849925952;6227.314995350417;6050.334463209131;6112.533877023262;6114.996965385453;6124.777645458507;6140.662263575367;5012.824551140692;6116.3272040076445;6145.938540614716;6163.260408750979;6168.383161683796;5854.970725146347;5998.940010599838;6038.909416358671;6040.607360521552;6067.484263837447;6091.208142941389;6116.1836049259855;6154.076888466766;6180.598261113013;6184.196054512884;5820.243368362086;5905.4685078343155;5969.70151492415;5985.610935289193;6023.247094113236 13:02:39 INFO - PROCESS | 1956 | |1;ext.html;488.51636879489274;577.4687287695319;601.4166258729032;640.3596403596404;648.9805305840825;29811.850940745295;30305.54541681871;30355.54466682999;30359.54460683086;30368.392632147345;40219.39670904932;40627.796861015726;40672.186556268854;40718.59281407185;40819.18361632765;9505.429674219535;9699.060187962401;9704.02959704031;9708.368956017835;9715.951420242924;9469.810603787955;9599.90400095997;9609.087136722;9609.231261499099;9651.131398174162;9581.664641737541;9643.421394716304;9648.228141748643;9660.951695241514;9664.22686185107;9552.665656702016;9617.471039092847;9623.278254130899;9627.80744385112;9662.903370966342;9457;9626.759331016781;9769.267304952156;9769.804603907953;9776.706698799047;40990.79504602458;41109.794451027854;41300.79349603263;41367.379489307685;41424.37863432051;3334.7832390894514;3452.602950660681;3468.5664291963503;3727.9627203727887;3813.0848596336955;28548.143555693154;29262.26844328909;29545.556816647768;29747.40505189884;29764.70235297641;2780.0547813743224;2784.1090850927712;2819.252897982016;2875.928101797451;2916.2709322669334;514018.9999999963;521700.2639788808;526556;526583;528038;46132;46465.5353446468;46672.299915501295;66401;66932.665336673;45088.54911450909;45183.09633807371;45431;45497.31754023692;45529.77235113803;16109.516714498584;16259.918700406659;16265.186740662919;16267.918660406858;16285.511434656742;12939.5471158509;13035.674108147183;13038.41327140281;13052.890504307241;13075.150115242479;14845.628859278388;14897.702045959237;14949.327280272197;14979.925100374647;15154.16652084146;6027.698615069229;6139.447449729546;6493.577917435352;6575.178102737158;6617.485355564854;936.9344145909857;938.3056538161711;993.255427040055;997.837519290019;1017.8269694151863;29096.563551546744;29191.708082919326;29380.265493362836;29970.400591988473;30004.84997574998;1084.4252546150553;1105.535675016495;1111.366521082991;1174.2484809721784;1181.5746331320718;14702.852971470362;14845.851541484662;14864.851351486346;15226.543203703906;15287.694246115016;552580.7419258042;560988;562750;564802;566900;57729.71135144297;58827.41172588219;59054.40945590575;59147.40852591419;59183.40816591779;1341.6109328294685;1356.423520004014;1480.7186634539403;1480.8445113263167;1601.5915941435092;28465;28581;29239.85380073086;29326.62743784492;29339.70660293455;48064;55776;56872.431275686715;56974.43025569857;57034.14448783189;499585;500580;513124;513850;516020;36070.45894311535;41684;44267.77866110649;44807.32789008233;45055.54944450645;42353;43604.781976089915;44811.32783008192;44862.775686121364;45005;34765.13087172841;35834.28331433409;36556;37291.81354093212;37397.81301093477;35723.10692232611;36149.638503614624;36208.27583448369;36573.63426365809;37923.86228413152;29154.242937384635;31804.5229321565;32822.835885820416;37412.43881341837;38422.039449013995;30339.393212135194;32149;32165.105140537464;32379.51430728494;32987;24594.139205127736;24643.38391540154;25194.874025630488;25208.36979075538;25466.363340916625 13:02:39 INFO - PROCESS | 1956 | |2;jquery.html;365.9359612067888;366.47410965264845;366.98715544955934;375.46871177284146;379.5123266602416;18734.344297949574;19673.508162295933;20662.89668551659;20690.275840345592;20708.585828283427;11966.34185119818;12355.196912200701;12380.257184568933;12381.628551143458;12392.938035309833;5268;5349.117395629716;5487.204355368469;5492.780288788444;5574.581906357019;5444.727763611803;5458.563314934816;5475.370332411784;5487.341519017724;5495.477929596682;5383.946160538403;5492.945070549304;5498.5876059295715;5673.149027645865;6126.877462450749;6011.699415029253;6040.184575082396;6076.96961515194;6082.695865206744;6086.695665216722;5210.4268530461995;5253.763580638881;5258.97370513145;5299.629025968184;5313.256144139824;13340.399682014333;13381;13684.247366394844;13764.242966636932;13795.517156899461;2024.4028011736573;2100.222917520512;2135.0819147766456;2230.7657695942016;2286.5769832581027;10330.896691033144;10648.467576621139;13496.190228586316;15005.549833505012;15178.620534486616;1679.6304812941135;1734.6270551831417;1736.739489076636;1779.172684701607;1843.3916807453509;74592;102021;105257;107830.06934618593;110640.4467977663;10043.849342259871;11249.04383127427;11392.658220253406;11467.254628449124;11525.596604118815;12381.75236495283;12665;13188.076834621676;14020.158790472604;14072.929635351758;6524.902126468107;6536.150300460909;6650.933490665128;7049.3655570997835;8835.646574136963;8910.287177025823;8927.642894284156;8941.061188575106;9037.819243615091;9045.68340108093;4481.820727170942;4561.133384656904;4575.656825738083;4604.930926036112;4614.238650622609;1877.5118469198108;1942.3784388995387;1947.6494231038548;1960.9607807843763;1977.2091163534415;719.9136103667594;869.0787764969153;938.1228551304553;942.0532364973158;1024.7950409918046;18729.906350468435;19651.901740491492;20449.48876278105;20637.896810515853;20700.58598828045;836.878582699186;898.9370744047853;964.9276304277067;996.267743208741;1012.1093437774712;10695.251332406657;10994.835077473845;11085.722856928642;11100.222984391015;11125.276857004268;589471;596861;621655;646103;666524;118373.40813295878;123871;125111.3744431272;126094;126524.10213846799;1025.47700672656;1054.7046826888484;1072.5870539842217;1075.2365820267698;1075.9892401076045;17753.55616109556;17781.73327400116;17866;18512.814871851107;18617.255309787997;38118;45361;51255.71860703363;54611;54867.17699234594;69570.0826264635;69845;71112.28887711056;71214;71808;7739.187385324685;7890.921090789248;7926.682932682628;8021;8219.876701849358;9441;12700.682482938;13320.866791331962;13660.590182294547;13833.584992450242;9906.702798916043;10861.239713219999;11257.831132532854;11790.823137652771;12055.15613907018;11405.315681059163;11438.94280528592;11777.646670599896;11919.582814601446;11945;6173.722182501888;9151.908480915372;11659.600847898306;11849.763004740029;12126.514939402678;8144.104148543537;8175.018997720312;8227.670893164446;8262.339012878834;8267.29727973129;8560.143985601639;11025.724356891142;11750;11850.585229516926;12058.974987125841 13:02:39 INFO - PROCESS | 1956 | |3;mootools.html;1427.9000469967107;1568.2629164292782;1584.746440569509;1862.3761040051581;1984.5137941204398;7998.640061197246;8722.040575536694;8853.158949899766;8869.246114080312;8874.911250887506;8474.1949514796;8734.475931444118;8745.475271483716;8750.562471876397;8753.781155471117;2194.7256592925883;2423.1397853761923;2458.5697502937005;2485.9875700621474;2490.638857365681;2525.4949010197943;2534.353739796349;2534.556452620784;2539.5047965646704;2540.6062060380577;2422.7819496245334;2492.239866840613;2493.2146373892256;2500.199936020474;2503.68703912011;2438.317271164068;2485.155047283923;2500.0749722602754;2504.2236906559024;2505.924822255335;2449.8407603505716;2482.3669964159203;2491;2501.7873480754156;2506.4987002599555;8869.733907982707;8939.016708162162;8955.641774329019;8959.193672569434;8969.955150224207;4718.740469274188;5445.591580631469;5619.157126431068;5620.578456615729;5628.380878103405;3563.4120370138894;3666.853325866962;3720;3741.420079887622;3747.025773298935;1037.159900480613;1053.3837704942619;1059.0838924330476;1068.2842495528014;1072.978540429187;11950.940245298718;11952;11953.462094205695;11954.222975506564;11960.581379651758;4888.853334399973;4927.482614325444;5008.198688209942;5032.672876263031;5044.344235249468;10177.592896284066;10201.795964080677;10201.948990255001;10213.438260895573;10228.64199753005;5583.860403489864;5585.804496842591;5585.944140558542;5596.300462442195;5599.692016939108;4471.306947423154;4654;4973.651844370859;5002.399712034579;5002.874928126753;3970.285348637273;4007.479027726377;4035.4955630546183;4065.8170382332864;4068.7355321903983;1314.1523717202351;1327.6831928285203;1330.361426515278;1334.8197993270785;1337.8461476930083;1356.1456282541935;1373.6428528582442;1413.6677880698028;1417.340936464549;1420.978685319721;8201.917980820115;8268.09051004389;8270.214329638675;8307.08622051574;8316.750497485085;526.4971951786035;535.868712165522;536.7262696025056;539.8380485854307;541.1909195752376;6233.1273621693;6242.656653883989;6277.121203031579;6288.748450061947;6310.684465776784;10448.895511044944;10718.732031699114;10721.731956701145;10739.570417183226;10831.404272764916;10478.266521343585;10624.309419887682;10636.574537018432;10699.983501567338;10760.139188864872;8315.334773218128;8354.958225208835;8410.116937721574;8486.090629608412;8509.021462531764;7736.690532378641;7944.245296696805;7945.721899733713;7982.361411087215;7989.640466179152;9443.763905902133;9579.856302155613;9723.902760972584;9765;9807.509624518603;9755.31712780127;9966.352187107816;9973;10059.29584929048;10118.49407529606;6150.2927163375;6808.080909077211;7102.573845569283;7495.1005879294835;7559.962200189184;8296.419250652396;8322.54226017575;8326.417150799385;8333.6666533338;8341.666333346599;7296.854062918818;7409.37020353276;7414.851702965802;7533;7575.507592006502;7296.525725827804;7317.67070481819;7351.007613972045;7418.851622967619;7460.66427010775;7784.494007889469;7815.25755053269;7851.764447066597;7852.764417067498;7853.489523180975;7013.929860701532;7046.189688185719;7083.858322833617;7098.467614928798;7104.3961263293195;7164.785056448315;7168.569885806868;7221.783346499614;7223.2415596361625;7225.5664660120565 13:02:39 INFO - PROCESS | 1956 | |4;prototype.html;331.03833364077354;334.47654420831395;340.7035878785457;341.3514322786706;347.63324692449453;6484.935150648492;6525.967370163155;6540.78995385854;6547.508936829733;6564.146660934078;5398.217258497515;6393.041043843415;6455.193100862392;6477.481801455884;6492.7078281477325;4605.815767369318;4672.813087476514;4747.430308363001;4804.039192161582;4833.516648335173;3864.8260828262796;4759.85720428386;4803.879903002436;4824.975875120619;4830.87922801931;4791.496892826255;4798.592119669815;4800.159972004903;4800.255960326155;4815.686980346284;3684.9815750921343;3786.905327366838;4630.444346678387;4696.624270058387;4702.788374523155;4054.635082842529;4069.125138095294;4087.7751723655188;4094.9181016379507;4105.44576482177;6112.847178820521;6126.23422072241;6137.84655383619;6138.785142520035;6156.138140660311;5571.749271282802;5585.804496842591;5594.272744543224;5601.075822489284;5602.24369710088;6752.729890804362;6763.898541521881;6776.796696099125;6780.08468856703;6782.321767823228;4303.203907277164;4472.418585583886;4478.216312145361;4482.282834746457;4483.260262056757;7024.367806897404;7206.315400036988;7215.927840721578;7283.053203083618;7301.561906285587;4568.383268258809;4568.406107206042;4572.51988541205;4572.565606267399;4579.633629309647;4627.699199552018;4640.071985602825;4642.698224615389;4642.930356044662;4654.953450465519;5490.725463726878;5509.311336082989;5515.917261241085;5519.751611177507;5522.6134170608475;6194.5044396448175;6648.002799580102;6738.663066846736;6911.723531058701;6968.6864091115;1595.0987691954008;1597.9520614381354;1608.2843134805134;1608.8954217975795;1610.8147563030168;987.3483500889379;1001.7996400719885;1036.233187441303;1037.0407373179778;1063.0538820449806;5116.411612664591;6331.430171284606;6375.4262116409745;6404.839879003062;6412.2625898022325;7025.964870175617;7098.041764361745;7147.9285207148305;7153.785386438415;7165.462590305748;6365.103877735619;6420.2072098637245;6436.259830119596;6442.871142577123;6446.387593178641;3759.3045286622064;3769.0577355661085;3797.3354662933875;3798.9050273742823;3803.7717736935874;7266.091738532684;7516.398688104939;7598.126215485179;7617.619119044137;7623.771286861403;7422.109346878409;7471.215522370073;7474.028376311045;7478.2147874473485;7479.252074792586;7568.205338439495;7589.506682065648;7603.239676032353;7606.592780335655;7610.277023682741;5583.385827559046;7250.166230883516;7255.746048888263;7260.491765576359;7275.380862889461;7014.088168538057;7028.367446929801;7053.188883278283;7119.216886142417;7158.534695244793;7548.509346892434;7550.848983020419;7551.8867216992885;7562.941188233762;7583.2416758323725;4569.748663823389;4594.954050459586;4617.12274667812;4626.537346265347;4629.375034370317;6872.62200578973;7146.285371462812;7148.857022859618;7155.570665759863;7166.641667916688;6856.554323968926;6956.965215173892;6961.095057642474;6987.1266091738535;6993.300669932966;6882.277360877036;6928.099347084847;6937.306269373023;6942.236354000955;6948.5483443576;6782.966085169543;6785.321467853175;6786.558873673195;6798.796036118924;6812.625305608239;6733.570419447709;6881.13985751781;6959.304069593;6973.7210511581;6980.441564674916;6601.174853143357;6609.537332386687;6733.360330768569;6787.89818152738;6806.693698783665 13:02:39 INFO - PROCESS | 1956 | |5;yui.html;762.8703120469523;768.0936494935977;778.614585780039;778.9454738168326;779.9766007019784;14910.5526834195;15106;15121.168335741544;15137;15144.242787860618;13845.30773461328;13887.305634718248;13951.023428360018;13968.022238443287;14016.789748153786;749.2357795049074;761.9047619047619;925.4123631493999;928.3316012471043;961.7932144588912;948.2461443152675;950.0736781637917;954.9809003819954;958.6692591056075;961.2550273537994;1014.3102690170681;1016.8627235323247;1017.8676772019664;1020.0819262663588;1022.3354819367396;798.3453568074182;806.7458750493605;808.3977436809585;981.4160574458186;998.610541888664;742.4431676242818;742.5284944060506;744.765398899345;744.9366803821682;748.5097261293861;15095.245237738069;15113.017653852465;15134.243287835565;15153.848461515354;15166.090034597959;12589.748205035849;12621.558245461365;12629.179103358345;12949.417276222594;12960.80558791619;9835.803283934352;10025.248106391977;10083.697489075266;10167.339122957059;10877.510512026978;3538.3630946429635;3585.533880595532;3610.62088480711;3645.890623281279;3661.1030297577;76408.61795690986;77393.22606773916;77855;78255.04362390928;78694.60652696757;9642.4214547126;9713.3686310391;9767.706968790948;9783.559739811726;10414.739631509274;22503.437414064778;22756.4310892229;22808.087676492756;22816.543669126855;22890.771092288865;7588.696452141852;7788.337991270692;7809.804754881174;7980.561069141253;8088.71689490865;3930.194310166409;3993;4101.671866250693;4114.835406583763;4140.585941405896;3674.375356189454;3713.795741234258;3720.4977328060363;3743.737938344344;3745.700343972476;674.3660958698807;680.4318394140848;680.9353111454404;683.6718375179942;684.5653010338372;505.79009710969535;511.7978398532633;525.8028239410221;527.8126265175807;637.4549759955172;7889.802754931173;8170.468919520212;8297.709580164665;8403.117672644406;8452.070272270046;519.2470917170118;581.7556626216999;584.7170811716209;603.0020316376404;622.3682961793783;3243.7242834359345;3769;3976.562578116405;3995.9400608990886;4032.475778148822;88869.11130888609;89910;90262.09737902536;90490;91796;77971.44057118939;78170.60914695504;79173.20826791774;79184.81222781663;80618.19381806107;68662.28344291433;69142.96285555721;69856;70002.99999999898;70390.64804676046;7782.571958542335;7868.134505204537;8046.919530804851;8061.879071814044;8125.512469251864;48713;48871;48993.51006490032;49043;50178.49821501738;63207.683961579896;65277.67361163164;65420.67289663521;65853;66085.66957165183;10311.587536498457;10382.792344153226;10623.145993348135;10668.03987641085;10830.133589312994;10875.836862446911;10900.34597924127;10913.454327283445;10945.616903408343;11308.886911130783;10342.844857326996;10576.41829699374;10601.946990265;10673;10769.353838769699;10325.9483702581;10784;10862.782744344911;11042.834357484484;11317.886821131684;10159.288849780445;10383.53274102652;10510.737231568966;10694.304870183412;10765.869583693913;8839.436563396543;8886.866696999421;8915;9051.728448146567;9059.709001429557;6330.556861019684;8925.464472131693;9026.954865225633;9036.90963090387;9048.095190480899 13:02:39 INFO - PROCESS | 1956 | __end_tp_report 13:02:39 INFO - PROCESS | 1956 | __start_cc_report 13:02:39 INFO - PROCESS | 1956 | _x_x_mozilla_cycle_collect,1381 13:02:39 INFO - PROCESS | 1956 | __end_cc_report 13:02:39 INFO - PROCESS | 1956 | __startTimestamp1457643759429__endTimestamp 13:02:39 INFO - PROCESS | 1956 | 13:02:39 INFO - PROCESS | 1956 | ------- Summary: start ------- 13:02:39 INFO - PROCESS | 1956 | Number of tests: 6 13:02:39 INFO - PROCESS | 1956 | 13:02:39 INFO - PROCESS | 1956 | [#0] dojo.html Cycles:165 Average:5708.28 Median:5969.70 stddev:682.47 (11.4%) stddev-sans-first:648.03 13:02:39 INFO - PROCESS | 1956 | Values: 2900.0 3460.3 3469.6 3488.3 3532.9 5589.9 5595.6 5614.1 5635.4 5725.9 5666.1 5706.5 5741.9 5797.2 5809.8 5079.9 5128.5 5143.0 5145.9 5254.7 5215.2 5235.4 5275.9 5286.8 5317.4 5069.5 5181.7 5187.1 5189.2 5191.8 4546.2 5103.4 5189.3 5191.1 5241.1 5080.8 5120.9 5127.8 5143.4 5158.2 5484.1 5581.6 5606.9 5621.8 5621.9 5367.5 6082.7 6238.8 6249.2 6252.2 6268.3 6313.6 6320.5 6340.0 6360.5 5576.6 5774.3 5787.8 5796.0 5811.2 6261.2 6309.2 6314.1 6316.2 6335.6 5105.9 6118.2 6199.1 6201.7 6221.9 6099.5 6189.5 6303.9 6307.8 6312.5 5576.9 5982.9 6229.7 6284.1 6300.8 6246.2 6265.3 6277.7 6302.9 6314.6 4106.5 4840.1 4867.8 4894.4 4956.1 3831.6 3975.3 4273.1 4372.2 4419.6 5670.1 5715.9 5717.1 5721.9 5764.2 6128.8 6185.7 6191.3 6191.6 6327.7 5690.5 5762.1 5763.6 5797.2 5833.4 5362.2 5374.1 5376.0 5382.3 5398.8 6184.5 6228.8 6360.2 6374.1 6378.2 6183.3 6194.6 6202.2 6213.3 6220.0 6234.3 6276.1 6335.4 6346.5 6350.1 6184.5 6204.5 6212.4 6219.2 6223.4 6128.4 6137.8 6199.8 6203.8 6227.3 6050.3 6112.5 6115.0 6124.8 6140.7 5012.8 6116.3 6145.9 6163.3 6168.4 5855.0 5998.9 6038.9 6040.6 6067.5 6091.2 6116.2 6154.1 6180.6 6184.2 5820.2 5905.5 5969.7 5985.6 6023.2 13:02:39 INFO - PROCESS | 1956 | 13:02:39 INFO - PROCESS | 1956 | [#1] ext.html Cycles:180 Average:66162.78 Median:40768.89 stddev:141779.98 (347.8%) stddev-sans-first:142091.97 13:02:39 INFO - PROCESS | 1956 | Values: 488.5 577.5 601.4 640.4 649.0 29811.9 30305.5 30355.5 30359.5 30368.4 40219.4 40627.8 40672.2 40718.6 40819.2 9505.4 9699.1 9704.0 9708.4 9716.0 9469.8 9599.9 9609.1 9609.2 9651.1 9581.7 9643.4 9648.2 9661.0 9664.2 9552.7 9617.5 9623.3 9627.8 9662.9 9457.0 9626.8 9769.3 9769.8 9776.7 40990.8 41109.8 41300.8 41367.4 41424.4 3334.8 3452.6 3468.6 3728.0 3813.1 28548.1 29262.3 29545.6 29747.4 29764.7 2780.1 2784.1 2819.3 2875.9 2916.3 514019.0 521700.3 526556.0 526583.0 528038.0 46132.0 46465.5 46672.3 66401.0 66932.7 45088.5 45183.1 45431.0 45497.3 45529.8 16109.5 16259.9 16265.2 16267.9 16285.5 12939.5 13035.7 13038.4 13052.9 13075.2 14845.6 14897.7 14949.3 14979.9 15154.2 6027.7 6139.4 6493.6 6575.2 6617.5 936.9 938.3 993.3 997.8 1017.8 29096.6 29191.7 29380.3 29970.4 30004.8 1084.4 1105.5 1111.4 1174.2 1181.6 14702.9 14845.9 14864.9 15226.5 15287.7 552580.7 560988.0 562750.0 564802.0 566900.0 57729.7 58827.4 59054.4 59147.4 59183.4 1341.6 1356.4 1480.7 1480.8 1601.6 28465.0 28581.0 29239.9 29326.6 29339.7 48064.0 55776.0 56872.4 56974.4 57034.1 499585.0 500580.0 513124.0 513850.0 516020.0 36070.5 41684.0 44267.8 44807.3 45055.5 42353.0 43604.8 44811.3 44862.8 45005.0 34765.1 35834.3 36556.0 37291.8 37397.8 35723.1 36149.6 36208.3 36573.6 37923.9 29154.2 31804.5 32822.8 37412.4 38422.0 30339.4 32149.0 32165.1 32379.5 32987.0 24594.1 24643.4 25194.9 25208.4 25466.4 13:02:39 INFO - PROCESS | 1956 | 13:02:39 INFO - PROCESS | 1956 | [#2] jquery.html Cycles:180 Average:34186.80 Median:20704.59 stddev:103630.87 (500.5%) stddev-sans-first:103890.46 13:02:39 INFO - PROCESS | 1956 | Values: 365.9 366.5 367.0 375.5 379.5 18734.3 19673.5 20662.9 20690.3 20708.6 11966.3 12355.2 12380.3 12381.6 12392.9 5268.0 5349.1 5487.2 5492.8 5574.6 5444.7 5458.6 5475.4 5487.3 5495.5 5383.9 5492.9 5498.6 5673.1 6126.9 6011.7 6040.2 6077.0 6082.7 6086.7 5210.4 5253.8 5259.0 5299.6 5313.3 13340.4 13381.0 13684.2 13764.2 13795.5 2024.4 2100.2 2135.1 2230.8 2286.6 10330.9 10648.5 13496.2 15005.5 15178.6 1679.6 1734.6 1736.7 1779.2 1843.4 74592.0 102021.0 105257.0 107830.1 110640.4 10043.8 11249.0 11392.7 11467.3 11525.6 12381.8 12665.0 13188.1 14020.2 14072.9 6524.9 6536.2 6650.9 7049.4 8835.6 8910.3 8927.6 8941.1 9037.8 9045.7 4481.8 4561.1 4575.7 4604.9 4614.2 1877.5 1942.4 1947.6 1961.0 1977.2 719.9 869.1 938.1 942.1 1024.8 18729.9 19651.9 20449.5 20637.9 20700.6 836.9 898.9 964.9 996.3 1012.1 10695.3 10994.8 11085.7 11100.2 11125.3 589471.0 596861.0 621655.0 646103.0 666524.0 118373.4 123871.0 125111.4 126094.0 126524.1 1025.5 1054.7 1072.6 1075.2 1076.0 17753.6 17781.7 17866.0 18512.8 18617.3 38118.0 45361.0 51255.7 54611.0 54867.2 69570.1 69845.0 71112.3 71214.0 71808.0 7739.2 7890.9 7926.7 8021.0 8219.9 9441.0 12700.7 13320.9 13660.6 13833.6 9906.7 10861.2 11257.8 11790.8 12055.2 11405.3 11438.9 11777.6 11919.6 11945.0 6173.7 9151.9 11659.6 11849.8 12126.5 8144.1 8175.0 8227.7 8262.3 8267.3 8560.1 11025.7 11750.0 11850.6 12059.0 13:02:39 INFO - PROCESS | 1956 | 13:02:39 INFO - PROCESS | 1956 | [#3] mootools.html Cycles:180 Average:6096.85 Median:538.28 stddev:3216.59 (597.6%) stddev-sans-first:3206.47 13:02:39 INFO - PROCESS | 1956 | Values: 1427.9 1568.3 1584.7 1862.4 1984.5 7998.6 8722.0 8853.2 8869.2 8874.9 8474.2 8734.5 8745.5 8750.6 8753.8 2194.7 2423.1 2458.6 2486.0 2490.6 2525.5 2534.4 2534.6 2539.5 2540.6 2422.8 2492.2 2493.2 2500.2 2503.7 2438.3 2485.2 2500.1 2504.2 2505.9 2449.8 2482.4 2491.0 2501.8 2506.5 8869.7 8939.0 8955.6 8959.2 8970.0 4718.7 5445.6 5619.2 5620.6 5628.4 3563.4 3666.9 3720.0 3741.4 3747.0 1037.2 1053.4 1059.1 1068.3 1073.0 11950.9 11952.0 11953.5 11954.2 11960.6 4888.9 4927.5 5008.2 5032.7 5044.3 10177.6 10201.8 10201.9 10213.4 10228.6 5583.9 5585.8 5585.9 5596.3 5599.7 4471.3 4654.0 4973.7 5002.4 5002.9 3970.3 4007.5 4035.5 4065.8 4068.7 1314.2 1327.7 1330.4 1334.8 1337.8 1356.1 1373.6 1413.7 1417.3 1421.0 8201.9 8268.1 8270.2 8307.1 8316.8 526.5 535.9 536.7 539.8 541.2 6233.1 6242.7 6277.1 6288.7 6310.7 10448.9 10718.7 10721.7 10739.6 10831.4 10478.3 10624.3 10636.6 10700.0 10760.1 8315.3 8355.0 8410.1 8486.1 8509.0 7736.7 7944.2 7945.7 7982.4 7989.6 9443.8 9579.9 9723.9 9765.0 9807.5 9755.3 9966.4 9973.0 10059.3 10118.5 6150.3 6808.1 7102.6 7495.1 7560.0 8296.4 8322.5 8326.4 8333.7 8341.7 7296.9 7409.4 7414.9 7533.0 7575.5 7296.5 7317.7 7351.0 7418.9 7460.7 7784.5 7815.3 7851.8 7852.8 7853.5 7013.9 7046.2 7083.9 7098.5 7104.4 7164.8 7168.6 7221.8 7223.2 7225.6 13:02:39 INFO - PROCESS | 1956 | 13:02:39 INFO - PROCESS | 1956 | [#4] prototype.html Cycles:180 Average:5650.88 Median:6439.57 stddev:1822.59 (28.3%) stddev-sans-first:1783.42 13:02:39 INFO - PROCESS | 1956 | Values: 331.0 334.5 340.7 341.4 347.6 6484.9 6526.0 6540.8 6547.5 6564.1 5398.2 6393.0 6455.2 6477.5 6492.7 4605.8 4672.8 4747.4 4804.0 4833.5 3864.8 4759.9 4803.9 4825.0 4830.9 4791.5 4798.6 4800.2 4800.3 4815.7 3685.0 3786.9 4630.4 4696.6 4702.8 4054.6 4069.1 4087.8 4094.9 4105.4 6112.8 6126.2 6137.8 6138.8 6156.1 5571.7 5585.8 5594.3 5601.1 5602.2 6752.7 6763.9 6776.8 6780.1 6782.3 4303.2 4472.4 4478.2 4482.3 4483.3 7024.4 7206.3 7215.9 7283.1 7301.6 4568.4 4568.4 4572.5 4572.6 4579.6 4627.7 4640.1 4642.7 4642.9 4655.0 5490.7 5509.3 5515.9 5519.8 5522.6 6194.5 6648.0 6738.7 6911.7 6968.7 1595.1 1598.0 1608.3 1608.9 1610.8 987.3 1001.8 1036.2 1037.0 1063.1 5116.4 6331.4 6375.4 6404.8 6412.3 7026.0 7098.0 7147.9 7153.8 7165.5 6365.1 6420.2 6436.3 6442.9 6446.4 3759.3 3769.1 3797.3 3798.9 3803.8 7266.1 7516.4 7598.1 7617.6 7623.8 7422.1 7471.2 7474.0 7478.2 7479.3 7568.2 7589.5 7603.2 7606.6 7610.3 5583.4 7250.2 7255.7 7260.5 7275.4 7014.1 7028.4 7053.2 7119.2 7158.5 7548.5 7550.8 7551.9 7562.9 7583.2 4569.7 4595.0 4617.1 4626.5 4629.4 6872.6 7146.3 7148.9 7155.6 7166.6 6856.6 6957.0 6961.1 6987.1 6993.3 6882.3 6928.1 6937.3 6942.2 6948.5 6783.0 6785.3 6786.6 6798.8 6812.6 6733.6 6881.1 6959.3 6973.7 6980.4 6601.2 6609.5 6733.4 6787.9 6806.7 13:02:39 INFO - PROCESS | 1956 | 13:02:39 INFO - PROCESS | 1956 | [#5] yui.html Cycles:180 Average:17997.34 Median:583.24 stddev:25237.33 (4327.1%) stddev-sans-first:25274.95 13:02:39 INFO - PROCESS | 1956 | Values: 762.9 768.1 778.6 778.9 780.0 14910.6 15106.0 15121.2 15137.0 15144.2 13845.3 13887.3 13951.0 13968.0 14016.8 749.2 761.9 925.4 928.3 961.8 948.2 950.1 955.0 958.7 961.3 1014.3 1016.9 1017.9 1020.1 1022.3 798.3 806.7 808.4 981.4 998.6 742.4 742.5 744.8 744.9 748.5 15095.2 15113.0 15134.2 15153.8 15166.1 12589.7 12621.6 12629.2 12949.4 12960.8 9835.8 10025.2 10083.7 10167.3 10877.5 3538.4 3585.5 3610.6 3645.9 3661.1 76408.6 77393.2 77855.0 78255.0 78694.6 9642.4 9713.4 9767.7 9783.6 10414.7 22503.4 22756.4 22808.1 22816.5 22890.8 7588.7 7788.3 7809.8 7980.6 8088.7 3930.2 3993.0 4101.7 4114.8 4140.6 3674.4 3713.8 3720.5 3743.7 3745.7 674.4 680.4 680.9 683.7 684.6 505.8 511.8 525.8 527.8 637.5 7889.8 8170.5 8297.7 8403.1 8452.1 519.2 581.8 584.7 603.0 622.4 3243.7 3769.0 3976.6 3995.9 4032.5 88869.1 89910.0 90262.1 90490.0 91796.0 77971.4 78170.6 79173.2 79184.8 80618.2 68662.3 69143.0 69856.0 70003.0 70390.6 7782.6 7868.1 8046.9 8061.9 8125.5 48713.0 48871.0 48993.5 49043.0 50178.5 63207.7 65277.7 65420.7 65853.0 66085.7 10311.6 10382.8 10623.1 10668.0 10830.1 10875.8 10900.3 10913.5 10945.6 11308.9 10342.8 10576.4 10601.9 10673.0 10769.4 10325.9 10784.0 10862.8 11042.8 11317.9 10159.3 10383.5 10510.7 10694.3 10765.9 8839.4 8886.9 8915.0 9051.7 9059.7 6330.6 8925.5 9027.0 9036.9 9048.1 13:02:39 INFO - PROCESS | 1956 | -------- Summary: end -------- 13:02:39 INFO - PROCESS | 1956 | 13:02:39 INFO - TEST-INFO | 1956: exit 0 13:02:39 INFO - TEST-OK | dromaeo_css | took 1113345ms 13:02:39 INFO - TEST-START | kraken 13:02:39 INFO - operating with platform_type : mac_ 13:02:39 INFO - Initialising browser for kraken test... 13:02:39 INFO - TEST-INFO | started process 1961 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmp2OgUmR/profile http://localhost:49478/getInfo.html) 13:02:42 INFO - PROCESS | 1961 | __metrics Screen width/height:1600/1200 13:02:42 INFO - PROCESS | 1961 | colorDepth:24 13:02:42 INFO - PROCESS | 1961 | Browser inner width/height: 1024/689 13:02:42 INFO - PROCESS | 1961 | __metrics 13:02:42 INFO - PROCESS | 1961 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:02:42 ERROR - PROCESS | 1961 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:02:42 INFO - TEST-INFO | 1961: exit 0 13:02:42 INFO - Browser initialized. 13:02:42 INFO - Running cycle 1/1 for kraken test... 13:02:42 INFO - TEST-INFO | started process 1963 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmp2OgUmR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:02:54 INFO - PROCESS | 1963 | RSS: Main: 243572736 13:02:54 INFO - PROCESS | 1963 | 13:02:57 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49478/tests/kraken/driver.html?testName=audio-beat-detection) 13:02:57 INFO - PROCESS | 1963 | RSS: Main: 291041280 13:02:57 INFO - PROCESS | 1963 | 13:03:00 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49478/tests/kraken/driver.html?testName=audio-dft) 13:03:01 INFO - PROCESS | 1963 | RSS: Main: 302850048 13:03:01 INFO - PROCESS | 1963 | 13:03:04 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49478/tests/kraken/driver.html?testName=audio-fft) 13:03:05 INFO - PROCESS | 1963 | RSS: Main: 290242560 13:03:05 INFO - PROCESS | 1963 | 13:03:07 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49478/tests/kraken/driver.html?testName=audio-oscillator) 13:03:07 INFO - PROCESS | 1963 | RSS: Main: 292814848 13:03:07 INFO - PROCESS | 1963 | 13:03:09 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49478/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:03:10 INFO - PROCESS | 1963 | RSS: Main: 293576704 13:03:10 INFO - PROCESS | 1963 | 13:03:13 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49478/tests/kraken/driver.html?testName=imaging-darkroom) 13:03:13 INFO - PROCESS | 1963 | RSS: Main: 293888000 13:03:13 INFO - PROCESS | 1963 | 13:03:16 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49478/tests/kraken/driver.html?testName=imaging-desaturate) 13:03:16 INFO - PROCESS | 1963 | RSS: Main: 292360192 13:03:16 INFO - PROCESS | 1963 | 13:03:19 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49478/tests/kraken/driver.html?testName=json-parse-financial) 13:03:20 INFO - PROCESS | 1963 | RSS: Main: 293830656 13:03:20 INFO - PROCESS | 1963 | 13:03:21 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49478/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:03:22 INFO - PROCESS | 1963 | RSS: Main: 326340608 13:03:22 INFO - PROCESS | 1963 | 13:03:24 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49478/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:03:24 INFO - PROCESS | 1963 | RSS: Main: 327036928 13:03:24 INFO - PROCESS | 1963 | 13:03:26 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49478/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:03:27 INFO - PROCESS | 1963 | RSS: Main: 330575872 13:03:27 INFO - PROCESS | 1963 | 13:03:30 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49478/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:03:30 INFO - PROCESS | 1963 | RSS: Main: 333885440 13:03:30 INFO - PROCESS | 1963 | 13:03:33 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49478/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:03:33 INFO - PROCESS | 1963 | RSS: Main: 332259328 13:03:33 INFO - PROCESS | 1963 | 13:03:35 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49478/tests/kraken/driver.html?testName=ai-astar) 13:03:35 INFO - PROCESS | 1963 | RSS: Main: 393146368 13:03:35 INFO - PROCESS | 1963 | 13:03:35 INFO - PROCESS | 1963 | __start_tp_report 13:03:35 INFO - PROCESS | 1963 | _x_x_mozilla_page_load 13:03:35 INFO - PROCESS | 1963 | _x_x_mozilla_page_load_details 13:03:35 INFO - PROCESS | 1963 | |i|pagename|runs| 13:03:35 INFO - PROCESS | 1963 | |0;ai-astar;111;106;110;110;110;111;114;110;111;119 13:03:35 INFO - PROCESS | 1963 | |1;audio-beat-detection;155;112;142;155;117;144;135;139;187;149 13:03:35 INFO - PROCESS | 1963 | |2;audio-dft;185;184;187;185;185;184;185;185;179;177 13:03:35 INFO - PROCESS | 1963 | |3;audio-fft;72;75;84;85;78;83;83;96;80;60 13:03:35 INFO - PROCESS | 1963 | |4;audio-oscillator;94;98;131;78;79;77;119;77;79;117 13:03:35 INFO - PROCESS | 1963 | |5;imaging-gaussian-blur;86;83;85;83;86;83;85;83;86;83 13:03:35 INFO - PROCESS | 1963 | |6;imaging-darkroom;92;92;93;93;91;91;91;93;90;91 13:03:35 INFO - PROCESS | 1963 | |7;imaging-desaturate;84;87;87;86;85;84;84;85;84;86 13:03:35 INFO - PROCESS | 1963 | |8;json-parse-financial;51;57;53;53;56;56;56;62;53;50 13:03:35 INFO - PROCESS | 1963 | |9;json-stringify-tinderbox;63;68;73;75;67;67;65;66;67;67 13:03:35 INFO - PROCESS | 1963 | |10;stanford-crypto-aes;96;96;110;108;83;83;81;83;82;82 13:03:35 INFO - PROCESS | 1963 | |11;stanford-crypto-ccm;133;132;122;122;120;131;132;114;124;124 13:03:35 INFO - PROCESS | 1963 | |12;stanford-crypto-pbkdf2;135;125;134;136;136;125;133;136;137;144 13:03:35 INFO - PROCESS | 1963 | |13;stanford-crypto-sha256-iterative;66;67;67;66;66;65;66;71;66;66 13:03:35 INFO - PROCESS | 1963 | __end_tp_report 13:03:35 INFO - PROCESS | 1963 | __start_cc_report 13:03:35 INFO - PROCESS | 1963 | _x_x_mozilla_cycle_collect,1246 13:03:35 INFO - PROCESS | 1963 | __end_cc_report 13:03:35 INFO - PROCESS | 1963 | __startTimestamp1457643815743__endTimestamp 13:03:35 INFO - PROCESS | 1963 | 13:03:35 INFO - PROCESS | 1963 | ------- Summary: start ------- 13:03:35 INFO - PROCESS | 1963 | Number of tests: 14 13:03:35 INFO - PROCESS | 1963 | 13:03:35 INFO - PROCESS | 1963 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:3.36 (3.0%) stddev-sans-first:3.56 13:03:35 INFO - PROCESS | 1963 | Values: 111.0 106.0 110.0 110.0 110.0 111.0 114.0 110.0 111.0 119.0 13:03:35 INFO - PROCESS | 1963 | 13:03:35 INFO - PROCESS | 1963 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:146.50 stddev:21.02 (14.3%) stddev-sans-first:21.88 13:03:35 INFO - PROCESS | 1963 | Values: 155.0 112.0 142.0 155.0 117.0 144.0 135.0 139.0 187.0 149.0 13:03:35 INFO - PROCESS | 1963 | 13:03:35 INFO - PROCESS | 1963 | [#2] audio-dft Cycles:10 Average:183.60 Median:185.00 stddev:3.10 (1.7%) stddev-sans-first:3.24 13:03:35 INFO - PROCESS | 1963 | Values: 185.0 184.0 187.0 185.0 185.0 184.0 185.0 185.0 179.0 177.0 13:03:35 INFO - PROCESS | 1963 | 13:03:35 INFO - PROCESS | 1963 | [#3] audio-fft Cycles:10 Average:79.60 Median:83.00 stddev:9.47 (11.4%) stddev-sans-first:9.63 13:03:35 INFO - PROCESS | 1963 | Values: 72.0 75.0 84.0 85.0 78.0 83.0 83.0 96.0 80.0 60.0 13:03:35 INFO - PROCESS | 1963 | 13:03:35 INFO - PROCESS | 1963 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:78.50 stddev:20.59 (26.2%) stddev-sans-first:21.83 13:03:35 INFO - PROCESS | 1963 | Values: 94.0 98.0 131.0 78.0 79.0 77.0 119.0 77.0 79.0 117.0 13:03:35 INFO - PROCESS | 1963 | 13:03:35 INFO - PROCESS | 1963 | [#5] imaging-gaussian-blur Cycles:10 Average:84.30 Median:85.00 stddev:1.42 (1.7%) stddev-sans-first:1.36 13:03:35 INFO - PROCESS | 1963 | Values: 86.0 83.0 85.0 83.0 86.0 83.0 85.0 83.0 86.0 83.0 13:03:35 INFO - PROCESS | 1963 | 13:03:35 INFO - PROCESS | 1963 | [#6] imaging-darkroom Cycles:10 Average:91.70 Median:92.00 stddev:1.06 (1.2%) stddev-sans-first:1.12 13:03:35 INFO - PROCESS | 1963 | Values: 92.0 92.0 93.0 93.0 91.0 91.0 91.0 93.0 90.0 91.0 13:03:35 INFO - PROCESS | 1963 | 13:03:35 INFO - PROCESS | 1963 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.50 stddev:1.23 (1.4%) stddev-sans-first:1.22 13:03:35 INFO - PROCESS | 1963 | Values: 84.0 87.0 87.0 86.0 85.0 84.0 84.0 85.0 84.0 86.0 13:03:35 INFO - PROCESS | 1963 | 13:03:35 INFO - PROCESS | 1963 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:56.00 stddev:3.47 (6.2%) stddev-sans-first:3.41 13:03:35 INFO - PROCESS | 1963 | Values: 51.0 57.0 53.0 53.0 56.0 56.0 56.0 62.0 53.0 50.0 13:03:35 INFO - PROCESS | 1963 | 13:03:35 INFO - PROCESS | 1963 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:67.00 stddev:3.58 (5.3%) stddev-sans-first:3.35 13:03:35 INFO - PROCESS | 1963 | Values: 63.0 68.0 73.0 75.0 67.0 67.0 65.0 66.0 67.0 67.0 13:03:35 INFO - PROCESS | 1963 | 13:03:35 INFO - PROCESS | 1963 | [#10] stanford-crypto-aes Cycles:10 Average:90.40 Median:83.00 stddev:11.31 (13.6%) stddev-sans-first:11.81 13:03:35 INFO - PROCESS | 1963 | Values: 96.0 96.0 110.0 108.0 83.0 83.0 81.0 83.0 82.0 82.0 13:03:35 INFO - PROCESS | 1963 | 13:03:35 INFO - PROCESS | 1963 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:127.50 stddev:6.35 (5.0%) stddev-sans-first:6.11 13:03:35 INFO - PROCESS | 1963 | Values: 133.0 132.0 122.0 122.0 120.0 131.0 132.0 114.0 124.0 124.0 13:03:35 INFO - PROCESS | 1963 | 13:03:35 INFO - PROCESS | 1963 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.10 Median:136.00 stddev:5.63 (4.1%) stddev-sans-first:5.96 13:03:35 INFO - PROCESS | 1963 | Values: 135.0 125.0 134.0 136.0 136.0 125.0 133.0 136.0 137.0 144.0 13:03:35 INFO - PROCESS | 1963 | 13:03:35 INFO - PROCESS | 1963 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.00 stddev:1.65 (2.5%) stddev-sans-first:1.73 13:03:35 INFO - PROCESS | 1963 | Values: 66.0 67.0 67.0 66.0 66.0 65.0 66.0 71.0 66.0 66.0 13:03:35 INFO - PROCESS | 1963 | -------- Summary: end -------- 13:03:35 INFO - PROCESS | 1963 | 13:03:36 INFO - TEST-INFO | 1963: exit 0 13:03:36 INFO - TEST-OK | kraken | took 56512ms 13:03:36 INFO - SUITE-END | took 1169s 13:03:36 INFO - Completed test suite (00:19:30) 13:03:36 INFO - javascript benchmark 13:03:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2899.9855000724997, 3460.2733425980537, 3469.6009958854725, 3488.3372159289715, 3532.894013179604, 5589.8602534936645, 5595.636283641566, 5614.10174372101, 5635.408282130374, 5725.885482290362, 5666.065099258628, 5706.486416222539, 5741.885162296751, 5797.246357973468, 5809.825705228839, 5079.898402031957, 5128.53843154116, 5142.974285128569, 5145.922811157836, 5254.684718916858, 5215.191645294985, 5235.397929238148, 5275.947240527584, 5286.7885284588765, 5317.41508434072, 5069.543741063304, 5181.740912954338, 5187.144121219994, 5189.247559103909, 5191.8442446726285, 4546.204414227497, 5103.413107492649, 5189.273501709764, 5191.143461328877, 5241.109011468059, 5080.79676812927, 5120.948790512084, 5127.820526281562, 5143.3570803649545, 5158.226266060084, 5484.122540393518, 5581.609287349887, 5606.859828504279, 5621.7751289948355, 5621.887562248773, 5367.5169234769055, 6082.698368372759, 6238.781642642532, 6249.187605611287, 6252.218472690914, 6268.341824108448, 6313.621182729051, 6320.525960552931, 6340.048992651093, 6360.459360954324, 5576.553875689935, 5774.2782152230975, 5787.826365209008, 5795.971020144872, 5811.186433899257, 6261.154744109578, 6309.179806625201, 6314.116023756677, 6316.178896743486, 6335.556511044275, 5105.8723531911255, 6118.174046503754, 6199.070139479114, 6201.658908759971, 6221.9377806222265, 6099.461111717566, 6189.50483961282, 6303.936960630427, 6307.779227727007, 6312.495000399957, 5576.944230557724, 5982.8632559813495, 6229.719662615194, 6284.088807123033, 6300.810975670737, 6246.219222597176, 6265.342139075423, 6277.717502712298, 6302.873942521215, 6314.55798094129, 4106.507219133723, 4840.080384726891, 4867.756612169377, 4894.363732714724, 4956.058348913695, 3831.59768224338, 3975.34406822871, 4273.145370925828, 4372.23485889968, 4419.558044195554, 5670.121131224667, 5715.914261286084, 5717.113847353667, 5721.856953576111, 5764.164196191528, 6128.846778830565, 6185.721642526097, 6191.25704915413, 6191.5665903387235, 6327.746890124344, 5690.5447564194765, 5762.135679648086, 5763.625364351387, 5797.24635797352, 5833.416658334133, 5362.249285100089, 5374.086405311106, 5376.0, 5382.30030096085, 5398.838034858961, 6184.536159788124, 6228.813135605939, 6360.204974378203, 6374.1394911688185, 6378.2346118466085, 6183.258009038944, 6194.566380353513, 6202.224721909762, 6213.316535181217, 6219.968900155471, 6234.251889773256, 6276.058591211172, 6335.366463353628, 6346.492280617447, 6350.142730731292, 6184.505239580732, 6204.472619827366, 6212.409821066992, 6219.160413344141, 6223.408776166257, 6128.417800308964, 6137.8465538360115, 6199.845003874759, 6203.751849925952, 6227.314995350417, 6050.334463209131, 6112.533877023262, 6114.996965385453, 6124.777645458507, 6140.662263575367, 5012.824551140692, 6116.3272040076445, 6145.938540614716, 6163.260408750979, 6168.383161683796, 5854.970725146347, 5998.940010599838, 6038.909416358671, 6040.607360521552, 6067.484263837447, 6091.208142941389, 6116.1836049259855, 6154.076888466766, 6180.598261113013, 6184.196054512884, 5820.243368362086, 5905.4685078343155, 5969.70151492415, 5985.610935289193, 6023.247094113236], "unit": "score", "name": "dojo.html", "value": 5663.110524381085}, {"lowerIsBetter": false, "replicates": [488.51636879489274, 577.4687287695319, 601.4166258729032, 640.3596403596404, 648.9805305840825, 29811.850940745295, 30305.54541681871, 30355.54466682999, 30359.54460683086, 30368.392632147345, 40219.39670904932, 40627.796861015726, 40672.186556268854, 40718.59281407185, 40819.18361632765, 9505.429674219535, 9699.060187962401, 9704.02959704031, 9708.368956017835, 9715.951420242924, 9469.810603787955, 9599.90400095997, 9609.087136722, 9609.231261499099, 9651.131398174162, 9581.664641737541, 9643.421394716304, 9648.228141748643, 9660.951695241514, 9664.22686185107, 9552.665656702016, 9617.471039092847, 9623.278254130899, 9627.80744385112, 9662.903370966342, 9457.0, 9626.759331016781, 9769.267304952156, 9769.804603907953, 9776.706698799047, 40990.79504602458, 41109.794451027854, 41300.79349603263, 41367.379489307685, 41424.37863432051, 3334.7832390894514, 3452.602950660681, 3468.5664291963503, 3727.9627203727887, 3813.0848596336955, 28548.143555693154, 29262.26844328909, 29545.556816647768, 29747.40505189884, 29764.70235297641, 2780.0547813743224, 2784.1090850927712, 2819.252897982016, 2875.928101797451, 2916.2709322669334, 514018.9999999963, 521700.2639788808, 526556.0, 526583.0, 528038.0, 46132.0, 46465.5353446468, 46672.299915501295, 66401.0, 66932.665336673, 45088.54911450909, 45183.09633807371, 45431.0, 45497.31754023692, 45529.77235113803, 16109.516714498584, 16259.918700406659, 16265.186740662919, 16267.918660406858, 16285.511434656742, 12939.5471158509, 13035.674108147183, 13038.41327140281, 13052.890504307241, 13075.150115242479, 14845.628859278388, 14897.702045959237, 14949.327280272197, 14979.925100374647, 15154.16652084146, 6027.698615069229, 6139.447449729546, 6493.577917435352, 6575.178102737158, 6617.485355564854, 936.9344145909857, 938.3056538161711, 993.255427040055, 997.837519290019, 1017.8269694151863, 29096.563551546744, 29191.708082919326, 29380.265493362836, 29970.400591988473, 30004.84997574998, 1084.4252546150553, 1105.535675016495, 1111.366521082991, 1174.2484809721784, 1181.5746331320718, 14702.852971470362, 14845.851541484662, 14864.851351486346, 15226.543203703906, 15287.694246115016, 552580.7419258042, 560988.0, 562750.0, 564802.0, 566900.0, 57729.71135144297, 58827.41172588219, 59054.40945590575, 59147.40852591419, 59183.40816591779, 1341.6109328294685, 1356.423520004014, 1480.7186634539403, 1480.8445113263167, 1601.5915941435092, 28465.0, 28581.0, 29239.85380073086, 29326.62743784492, 29339.70660293455, 48064.0, 55776.0, 56872.431275686715, 56974.43025569857, 57034.14448783189, 499585.0, 500580.0, 513124.0, 513850.0, 516020.0, 36070.45894311535, 41684.0, 44267.77866110649, 44807.32789008233, 45055.54944450645, 42353.0, 43604.781976089915, 44811.32783008192, 44862.775686121364, 45005.0, 34765.13087172841, 35834.28331433409, 36556.0, 37291.81354093212, 37397.81301093477, 35723.10692232611, 36149.638503614624, 36208.27583448369, 36573.63426365809, 37923.86228413152, 29154.242937384635, 31804.5229321565, 32822.835885820416, 37412.43881341837, 38422.039449013995, 30339.393212135194, 32149.0, 32165.105140537464, 32379.51430728494, 32987.0, 24594.139205127736, 24643.38391540154, 25194.874025630488, 25208.36979075538, 25466.363340916625], "unit": "score", "name": "ext.html", "value": 19441.859619398354}, {"lowerIsBetter": false, "replicates": [365.9359612067888, 366.47410965264845, 366.98715544955934, 375.46871177284146, 379.5123266602416, 18734.344297949574, 19673.508162295933, 20662.89668551659, 20690.275840345592, 20708.585828283427, 11966.34185119818, 12355.196912200701, 12380.257184568933, 12381.628551143458, 12392.938035309833, 5268.0, 5349.117395629716, 5487.204355368469, 5492.780288788444, 5574.581906357019, 5444.727763611803, 5458.563314934816, 5475.370332411784, 5487.341519017724, 5495.477929596682, 5383.946160538403, 5492.945070549304, 5498.5876059295715, 5673.149027645865, 6126.877462450749, 6011.699415029253, 6040.184575082396, 6076.96961515194, 6082.695865206744, 6086.695665216722, 5210.4268530461995, 5253.763580638881, 5258.97370513145, 5299.629025968184, 5313.256144139824, 13340.399682014333, 13381.0, 13684.247366394844, 13764.242966636932, 13795.517156899461, 2024.4028011736573, 2100.222917520512, 2135.0819147766456, 2230.7657695942016, 2286.5769832581027, 10330.896691033144, 10648.467576621139, 13496.190228586316, 15005.549833505012, 15178.620534486616, 1679.6304812941135, 1734.6270551831417, 1736.739489076636, 1779.172684701607, 1843.3916807453509, 74592.0, 102021.0, 105257.0, 107830.06934618593, 110640.4467977663, 10043.849342259871, 11249.04383127427, 11392.658220253406, 11467.254628449124, 11525.596604118815, 12381.75236495283, 12665.0, 13188.076834621676, 14020.158790472604, 14072.929635351758, 6524.902126468107, 6536.150300460909, 6650.933490665128, 7049.3655570997835, 8835.646574136963, 8910.287177025823, 8927.642894284156, 8941.061188575106, 9037.819243615091, 9045.68340108093, 4481.820727170942, 4561.133384656904, 4575.656825738083, 4604.930926036112, 4614.238650622609, 1877.5118469198108, 1942.3784388995387, 1947.6494231038548, 1960.9607807843763, 1977.2091163534415, 719.9136103667594, 869.0787764969153, 938.1228551304553, 942.0532364973158, 1024.7950409918046, 18729.906350468435, 19651.901740491492, 20449.48876278105, 20637.896810515853, 20700.58598828045, 836.878582699186, 898.9370744047853, 964.9276304277067, 996.267743208741, 1012.1093437774712, 10695.251332406657, 10994.835077473845, 11085.722856928642, 11100.222984391015, 11125.276857004268, 589471.0, 596861.0, 621655.0, 646103.0, 666524.0, 118373.40813295878, 123871.0, 125111.3744431272, 126094.0, 126524.10213846799, 1025.47700672656, 1054.7046826888484, 1072.5870539842217, 1075.2365820267698, 1075.9892401076045, 17753.55616109556, 17781.73327400116, 17866.0, 18512.814871851107, 18617.255309787997, 38118.0, 45361.0, 51255.71860703363, 54611.0, 54867.17699234594, 69570.0826264635, 69845.0, 71112.28887711056, 71214.0, 71808.0, 7739.187385324685, 7890.921090789248, 7926.682932682628, 8021.0, 8219.876701849358, 9441.0, 12700.682482938, 13320.866791331962, 13660.590182294547, 13833.584992450242, 9906.702798916043, 10861.239713219999, 11257.831132532854, 11790.823137652771, 12055.15613907018, 11405.315681059163, 11438.94280528592, 11777.646670599896, 11919.582814601446, 11945.0, 6173.722182501888, 9151.908480915372, 11659.600847898306, 11849.763004740029, 12126.514939402678, 8144.104148543537, 8175.018997720312, 8227.670893164446, 8262.339012878834, 8267.29727973129, 8560.143985601639, 11025.724356891142, 11750.0, 11850.585229516926, 12058.974987125841], "unit": "score", "name": "jquery.html", "value": 9087.03881934106}, {"lowerIsBetter": false, "replicates": [1427.9000469967107, 1568.2629164292782, 1584.746440569509, 1862.3761040051581, 1984.5137941204398, 7998.640061197246, 8722.040575536694, 8853.158949899766, 8869.246114080312, 8874.911250887506, 8474.1949514796, 8734.475931444118, 8745.475271483716, 8750.562471876397, 8753.781155471117, 2194.7256592925883, 2423.1397853761923, 2458.5697502937005, 2485.9875700621474, 2490.638857365681, 2525.4949010197943, 2534.353739796349, 2534.556452620784, 2539.5047965646704, 2540.6062060380577, 2422.7819496245334, 2492.239866840613, 2493.2146373892256, 2500.199936020474, 2503.68703912011, 2438.317271164068, 2485.155047283923, 2500.0749722602754, 2504.2236906559024, 2505.924822255335, 2449.8407603505716, 2482.3669964159203, 2491.0, 2501.7873480754156, 2506.4987002599555, 8869.733907982707, 8939.016708162162, 8955.641774329019, 8959.193672569434, 8969.955150224207, 4718.740469274188, 5445.591580631469, 5619.157126431068, 5620.578456615729, 5628.380878103405, 3563.4120370138894, 3666.853325866962, 3720.0, 3741.420079887622, 3747.025773298935, 1037.159900480613, 1053.3837704942619, 1059.0838924330476, 1068.2842495528014, 1072.978540429187, 11950.940245298718, 11952.0, 11953.462094205695, 11954.222975506564, 11960.581379651758, 4888.853334399973, 4927.482614325444, 5008.198688209942, 5032.672876263031, 5044.344235249468, 10177.592896284066, 10201.795964080677, 10201.948990255001, 10213.438260895573, 10228.64199753005, 5583.860403489864, 5585.804496842591, 5585.944140558542, 5596.300462442195, 5599.692016939108, 4471.306947423154, 4654.0, 4973.651844370859, 5002.399712034579, 5002.874928126753, 3970.285348637273, 4007.479027726377, 4035.4955630546183, 4065.8170382332864, 4068.7355321903983, 1314.1523717202351, 1327.6831928285203, 1330.361426515278, 1334.8197993270785, 1337.8461476930083, 1356.1456282541935, 1373.6428528582442, 1413.6677880698028, 1417.340936464549, 1420.978685319721, 8201.917980820115, 8268.09051004389, 8270.214329638675, 8307.08622051574, 8316.750497485085, 526.4971951786035, 535.868712165522, 536.7262696025056, 539.8380485854307, 541.1909195752376, 6233.1273621693, 6242.656653883989, 6277.121203031579, 6288.748450061947, 6310.684465776784, 10448.895511044944, 10718.732031699114, 10721.731956701145, 10739.570417183226, 10831.404272764916, 10478.266521343585, 10624.309419887682, 10636.574537018432, 10699.983501567338, 10760.139188864872, 8315.334773218128, 8354.958225208835, 8410.116937721574, 8486.090629608412, 8509.021462531764, 7736.690532378641, 7944.245296696805, 7945.721899733713, 7982.361411087215, 7989.640466179152, 9443.763905902133, 9579.856302155613, 9723.902760972584, 9765.0, 9807.509624518603, 9755.31712780127, 9966.352187107816, 9973.0, 10059.29584929048, 10118.49407529606, 6150.2927163375, 6808.080909077211, 7102.573845569283, 7495.1005879294835, 7559.962200189184, 8296.419250652396, 8322.54226017575, 8326.417150799385, 8333.6666533338, 8341.666333346599, 7296.854062918818, 7409.37020353276, 7414.851702965802, 7533.0, 7575.507592006502, 7296.525725827804, 7317.67070481819, 7351.007613972045, 7418.851622967619, 7460.66427010775, 7784.494007889469, 7815.25755053269, 7851.764447066597, 7852.764417067498, 7853.489523180975, 7013.929860701532, 7046.189688185719, 7083.858322833617, 7098.467614928798, 7104.3961263293195, 7164.785056448315, 7168.569885806868, 7221.783346499614, 7223.2415596361625, 7225.5664660120565], "unit": "score", "name": "mootools.html", "value": 4902.573777094753}, {"lowerIsBetter": false, "replicates": [331.03833364077354, 334.47654420831395, 340.7035878785457, 341.3514322786706, 347.63324692449453, 6484.935150648492, 6525.967370163155, 6540.78995385854, 6547.508936829733, 6564.146660934078, 5398.217258497515, 6393.041043843415, 6455.193100862392, 6477.481801455884, 6492.7078281477325, 4605.815767369318, 4672.813087476514, 4747.430308363001, 4804.039192161582, 4833.516648335173, 3864.8260828262796, 4759.85720428386, 4803.879903002436, 4824.975875120619, 4830.87922801931, 4791.496892826255, 4798.592119669815, 4800.159972004903, 4800.255960326155, 4815.686980346284, 3684.9815750921343, 3786.905327366838, 4630.444346678387, 4696.624270058387, 4702.788374523155, 4054.635082842529, 4069.125138095294, 4087.7751723655188, 4094.9181016379507, 4105.44576482177, 6112.847178820521, 6126.23422072241, 6137.84655383619, 6138.785142520035, 6156.138140660311, 5571.749271282802, 5585.804496842591, 5594.272744543224, 5601.075822489284, 5602.24369710088, 6752.729890804362, 6763.898541521881, 6776.796696099125, 6780.08468856703, 6782.321767823228, 4303.203907277164, 4472.418585583886, 4478.216312145361, 4482.282834746457, 4483.260262056757, 7024.367806897404, 7206.315400036988, 7215.927840721578, 7283.053203083618, 7301.561906285587, 4568.383268258809, 4568.406107206042, 4572.51988541205, 4572.565606267399, 4579.633629309647, 4627.699199552018, 4640.071985602825, 4642.698224615389, 4642.930356044662, 4654.953450465519, 5490.725463726878, 5509.311336082989, 5515.917261241085, 5519.751611177507, 5522.6134170608475, 6194.5044396448175, 6648.002799580102, 6738.663066846736, 6911.723531058701, 6968.6864091115, 1595.0987691954008, 1597.9520614381354, 1608.2843134805134, 1608.8954217975795, 1610.8147563030168, 987.3483500889379, 1001.7996400719885, 1036.233187441303, 1037.0407373179778, 1063.0538820449806, 5116.411612664591, 6331.430171284606, 6375.4262116409745, 6404.839879003062, 6412.2625898022325, 7025.964870175617, 7098.041764361745, 7147.9285207148305, 7153.785386438415, 7165.462590305748, 6365.103877735619, 6420.2072098637245, 6436.259830119596, 6442.871142577123, 6446.387593178641, 3759.3045286622064, 3769.0577355661085, 3797.3354662933875, 3798.9050273742823, 3803.7717736935874, 7266.091738532684, 7516.398688104939, 7598.126215485179, 7617.619119044137, 7623.771286861403, 7422.109346878409, 7471.215522370073, 7474.028376311045, 7478.2147874473485, 7479.252074792586, 7568.205338439495, 7589.506682065648, 7603.239676032353, 7606.592780335655, 7610.277023682741, 5583.385827559046, 7250.166230883516, 7255.746048888263, 7260.491765576359, 7275.380862889461, 7014.088168538057, 7028.367446929801, 7053.188883278283, 7119.216886142417, 7158.534695244793, 7548.509346892434, 7550.848983020419, 7551.8867216992885, 7562.941188233762, 7583.2416758323725, 4569.748663823389, 4594.954050459586, 4617.12274667812, 4626.537346265347, 4629.375034370317, 6872.62200578973, 7146.285371462812, 7148.857022859618, 7155.570665759863, 7166.641667916688, 6856.554323968926, 6956.965215173892, 6961.095057642474, 6987.1266091738535, 6993.300669932966, 6882.277360877036, 6928.099347084847, 6937.306269373023, 6942.236354000955, 6948.5483443576, 6782.966085169543, 6785.321467853175, 6786.558873673195, 6798.796036118924, 6812.625305608239, 6733.570419447709, 6881.13985751781, 6959.304069593, 6973.7210511581, 6980.441564674916, 6601.174853143357, 6609.537332386687, 6733.360330768569, 6787.89818152738, 6806.693698783665], "unit": "score", "name": "prototype.html", "value": 5046.522145208487}, {"lowerIsBetter": false, "replicates": [762.8703120469523, 768.0936494935977, 778.614585780039, 778.9454738168326, 779.9766007019784, 14910.5526834195, 15106.0, 15121.168335741544, 15137.0, 15144.242787860618, 13845.30773461328, 13887.305634718248, 13951.023428360018, 13968.022238443287, 14016.789748153786, 749.2357795049074, 761.9047619047619, 925.4123631493999, 928.3316012471043, 961.7932144588912, 948.2461443152675, 950.0736781637917, 954.9809003819954, 958.6692591056075, 961.2550273537994, 1014.3102690170681, 1016.8627235323247, 1017.8676772019664, 1020.0819262663588, 1022.3354819367396, 798.3453568074182, 806.7458750493605, 808.3977436809585, 981.4160574458186, 998.610541888664, 742.4431676242818, 742.5284944060506, 744.765398899345, 744.9366803821682, 748.5097261293861, 15095.245237738069, 15113.017653852465, 15134.243287835565, 15153.848461515354, 15166.090034597959, 12589.748205035849, 12621.558245461365, 12629.179103358345, 12949.417276222594, 12960.80558791619, 9835.803283934352, 10025.248106391977, 10083.697489075266, 10167.339122957059, 10877.510512026978, 3538.3630946429635, 3585.533880595532, 3610.62088480711, 3645.890623281279, 3661.1030297577, 76408.61795690986, 77393.22606773916, 77855.0, 78255.04362390928, 78694.60652696757, 9642.4214547126, 9713.3686310391, 9767.706968790948, 9783.559739811726, 10414.739631509274, 22503.437414064778, 22756.4310892229, 22808.087676492756, 22816.543669126855, 22890.771092288865, 7588.696452141852, 7788.337991270692, 7809.804754881174, 7980.561069141253, 8088.71689490865, 3930.194310166409, 3993.0, 4101.671866250693, 4114.835406583763, 4140.585941405896, 3674.375356189454, 3713.795741234258, 3720.4977328060363, 3743.737938344344, 3745.700343972476, 674.3660958698807, 680.4318394140848, 680.9353111454404, 683.6718375179942, 684.5653010338372, 505.79009710969535, 511.7978398532633, 525.8028239410221, 527.8126265175807, 637.4549759955172, 7889.802754931173, 8170.468919520212, 8297.709580164665, 8403.117672644406, 8452.070272270046, 519.2470917170118, 581.7556626216999, 584.7170811716209, 603.0020316376404, 622.3682961793783, 3243.7242834359345, 3769.0, 3976.562578116405, 3995.9400608990886, 4032.475778148822, 88869.11130888609, 89910.0, 90262.09737902536, 90490.0, 91796.0, 77971.44057118939, 78170.60914695504, 79173.20826791774, 79184.81222781663, 80618.19381806107, 68662.28344291433, 69142.96285555721, 69856.0, 70002.99999999898, 70390.64804676046, 7782.571958542335, 7868.134505204537, 8046.919530804851, 8061.879071814044, 8125.512469251864, 48713.0, 48871.0, 48993.51006490032, 49043.0, 50178.49821501738, 63207.683961579896, 65277.67361163164, 65420.67289663521, 65853.0, 66085.66957165183, 10311.587536498457, 10382.792344153226, 10623.145993348135, 10668.03987641085, 10830.133589312994, 10875.836862446911, 10900.34597924127, 10913.454327283445, 10945.616903408343, 11308.886911130783, 10342.844857326996, 10576.41829699374, 10601.946990265, 10673.0, 10769.353838769699, 10325.9483702581, 10784.0, 10862.782744344911, 11042.834357484484, 11317.886821131684, 10159.288849780445, 10383.53274102652, 10510.737231568966, 10694.304870183412, 10765.869583693913, 8839.436563396543, 8886.866696999421, 8915.0, 9051.728448146567, 9059.709001429557, 6330.556861019684, 8925.464472131693, 9026.954865225633, 9036.90963090387, 9048.095190480899], "unit": "score", "name": "yui.html", "value": 6848.338540039832}], "name": "dromaeo_css", "value": 7439.46826634864}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 110.0, 110.0, 110.0, 111.0, 114.0, 110.0, 111.0, 119.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [155.0, 112.0, 142.0, 155.0, 117.0, 144.0, 135.0, 139.0, 187.0, 149.0], "unit": "score", "name": "audio-beat-detection", "value": 143.5}, {"lowerIsBetter": true, "replicates": [185.0, 184.0, 187.0, 185.0, 185.0, 184.0, 185.0, 185.0, 179.0, 177.0], "unit": "score", "name": "audio-dft", "value": 183.6}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 84.0, 85.0, 78.0, 83.0, 83.0, 96.0, 80.0, 60.0], "unit": "score", "name": "audio-fft", "value": 79.6}, {"lowerIsBetter": true, "replicates": [94.0, 98.0, 131.0, 78.0, 79.0, 77.0, 119.0, 77.0, 79.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 94.9}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 85.0, 83.0, 86.0, 83.0, 85.0, 83.0, 86.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 84.3}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 93.0, 93.0, 91.0, 91.0, 91.0, 93.0, 90.0, 91.0], "unit": "score", "name": "imaging-darkroom", "value": 91.7}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 87.0, 86.0, 85.0, 84.0, 84.0, 85.0, 84.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 85.2}, {"lowerIsBetter": true, "replicates": [51.0, 57.0, 53.0, 53.0, 56.0, 56.0, 56.0, 62.0, 53.0, 50.0], "unit": "score", "name": "json-parse-financial", "value": 54.7}, {"lowerIsBetter": true, "replicates": [63.0, 68.0, 73.0, 75.0, 67.0, 67.0, 65.0, 66.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 110.0, 108.0, 83.0, 83.0, 81.0, 83.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 90.4}, {"lowerIsBetter": true, "replicates": [133.0, 132.0, 122.0, 122.0, 120.0, 131.0, 132.0, 114.0, 124.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.4}, {"lowerIsBetter": true, "replicates": [135.0, 125.0, 134.0, 136.0, 136.0, 125.0, 133.0, 136.0, 137.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.1}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 66.0, 66.0, 65.0, 66.0, 71.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1413.0}]} 13:03:37 INFO - Return code: 0 13:03:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:03:37 ERROR - # TBPL SUCCESS # 13:03:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:03:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:03:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:03:37 INFO - 2016-03-10 13:03:37.070 screenresolution[1967:12393] starting screenresolution argv=screenresolution get 13:03:37 INFO - 2016-03-10 13:03:37.072 screenresolution[1967:12393] Display 0: 1600x1200x32@60 13:03:37 INFO - 2016-03-10 13:03:37.078 screenresolution[1968:12396] starting screenresolution argv=screenresolution list 13:03:37 INFO - Available Modes on Display 0 13:03:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:03:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:03:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:03:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:03:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:03:37 INFO - Intel Iris: 13:03:37 INFO - Chipset Model: Intel Iris 13:03:37 INFO - Type: GPU 13:03:37 INFO - Bus: Built-In 13:03:37 INFO - VRAM (Dynamic, Max): 1536 MB 13:03:37 INFO - Vendor: Intel (0x8086) 13:03:37 INFO - Device ID: 0x0a2e 13:03:37 INFO - Revision ID: 0x0009 13:03:37 INFO - Displays: 13:03:37 INFO - Display: 13:03:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:03:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:03:37 INFO - Display Serial Number: 1600x1200 60 13:03:37 INFO - Main Display: Yes 13:03:37 INFO - Mirror: Off 13:03:37 INFO - Online: Yes 13:03:37 INFO - Rotation: Supported 13:03:37 INFO - Return code: 0 13:03:37 INFO - Running post-action listener: _resource_record_post_action 13:03:37 INFO - Running post-run listener: _resource_record_post_run 13:03:38 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 2658304; Write bytes: 703915520; Read time: 45; Write time: 2078 13:03:38 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 386736640; Write bytes: 381654528; Read time: 28818; Write time: 739 13:03:38 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 2658304; Write bytes: 299532288; Read time: 45; Write time: 1291 13:03:38 INFO - Running post-run listener: _upload_blobber_files 13:03:38 INFO - Blob upload gear active. 13:03:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:03:38 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 13:03:38 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'] 13:03:38 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 13:03:38 INFO - (blobuploader) - INFO - Open directory for files ... 13:03:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:03:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:03:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:03:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:03:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:03:39 INFO - (blobuploader) - INFO - Done attempting. 13:03:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:03:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:03:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:03:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:03:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:03:40 INFO - (blobuploader) - INFO - Done attempting. 13:03:40 INFO - (blobuploader) - INFO - Iteration through files over. 13:03:40 INFO - Return code: 0 13:03:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:03:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:03:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/88005f9ba39fb5426c90a691d0c47b4a8ba880a4ef572c00c02d1d6513560b766bfe546333f88536e27cbd7dfe7547a638031bf4790e550614ad1b08bd7a4843", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c618d29dd544f227e6461048aac70a29eb9a0e9c78ec082266dc23ab688e7e3425ed69818f777d839850952278522d0a2e6e9d89e9bdce78a18046ef6aced9b"} 13:03:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:03:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:03:40 INFO - Contents: 13:03:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/88005f9ba39fb5426c90a691d0c47b4a8ba880a4ef572c00c02d1d6513560b766bfe546333f88536e27cbd7dfe7547a638031bf4790e550614ad1b08bd7a4843", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c618d29dd544f227e6461048aac70a29eb9a0e9c78ec082266dc23ab688e7e3425ed69818f777d839850952278522d0a2e6e9d89e9bdce78a18046ef6aced9b"} 13:03:40 INFO - Running post-run listener: copy_logs_to_upload_dir 13:03:40 INFO - Copying logs to upload dir... 13:03:40 INFO - mkdir: /builds/slave/test/build/upload/logs 13:03:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.000085 ========= master_lag: 23.47 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-03-10 13:04:03.982574) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-03-10 13:04:03.983747) ========= 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.2uGrDWRS2O/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.Lt9FUMJaiw/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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/88005f9ba39fb5426c90a691d0c47b4a8ba880a4ef572c00c02d1d6513560b766bfe546333f88536e27cbd7dfe7547a638031bf4790e550614ad1b08bd7a4843", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c618d29dd544f227e6461048aac70a29eb9a0e9c78ec082266dc23ab688e7e3425ed69818f777d839850952278522d0a2e6e9d89e9bdce78a18046ef6aced9b"} build_url:https://queue.taskcluster.net/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/HWbaAS19R1y2CJMO1aWSIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/88005f9ba39fb5426c90a691d0c47b4a8ba880a4ef572c00c02d1d6513560b766bfe546333f88536e27cbd7dfe7547a638031bf4790e550614ad1b08bd7a4843", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c618d29dd544f227e6461048aac70a29eb9a0e9c78ec082266dc23ab688e7e3425ed69818f777d839850952278522d0a2e6e9d89e9bdce78a18046ef6aced9b"}' ========= master_lag: 2.58 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-03-10 13:04:06.570801) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 11 secs) (at 2016-03-10 13:04:06.571094) ========= 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.2uGrDWRS2O/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.Lt9FUMJaiw/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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.005128 ========= master_lag: 11.93 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 11 secs) (at 2016-03-10 13:04:18.503528) ========= ========= Started reboot skipped (results: 3, elapsed: 5 secs) (at 2016-03-10 13:04:18.504055) ========= ========= Finished reboot skipped (results: 3, elapsed: 5 secs) (at 2016-03-10 13:04:24.278085) ========= ========= Total master_lag: 38.16 =========