builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0023 starttime: 1460115313.34 results: success (0) buildid: 20160408030055 builduid: 6f702b63d3354324a6c4db67b9bf87fe revision: 5ae810198a9c8c7f4e75cd0881bfc8d1295cbc8d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 04:35:13.344550) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 04:35:13.344975) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 04:35:13.345351) ========= 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.xmhui2pWE2/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.xS5PsSLCmJ/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005853 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 04:35:13.368801) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 04:35:13.369116) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 04:35:13.385430) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:35:13.385764) ========= 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.xmhui2pWE2/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.xS5PsSLCmJ/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.005602 ========= master_lag: 0.32 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:35:13.709284) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 04:35:13.709580) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 04:35:13.709954) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:35:13.710223) ========= 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.xmhui2pWE2/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.xS5PsSLCmJ/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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-04-08 04:35:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.70M=0.002s 2016-04-08 04:35:14 (7.70 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.523635 ========= master_lag: 0.43 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:35:14.659565) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:35:14.659886) ========= 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.xmhui2pWE2/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.xS5PsSLCmJ/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.020242 ========= master_lag: 0.18 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:35:14.863362) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:35:14.863705) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5ae810198a9c8c7f4e75cd0881bfc8d1295cbc8d --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 5ae810198a9c8c7f4e75cd0881bfc8d1295cbc8d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xmhui2pWE2/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.xS5PsSLCmJ/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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-04-08 04:35:14,945 truncating revision to first 12 chars 2016-04-08 04:35:14,945 Setting DEBUG logging. 2016-04-08 04:35:14,945 attempt 1/10 2016-04-08 04:35:14,945 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5ae810198a9c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-08 04:35:15,666 unpacking tar archive at: fx-team-5ae810198a9c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.964899 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:35:15.849532) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 04:35:15.850020) ========= echo 5ae810198a9c8c7f4e75cd0881bfc8d1295cbc8d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5ae810198a9c8c7f4e75cd0881bfc8d1295cbc8d'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xmhui2pWE2/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.xS5PsSLCmJ/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 5ae810198a9c8c7f4e75cd0881bfc8d1295cbc8d program finished with exit code 0 elapsedTime=0.005080 script_repo_revision: '5ae810198a9c8c7f4e75cd0881bfc8d1295cbc8d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 04:35:15.903657) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 04:35:15.904025) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 04:35:15.919972) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-04-08 04:35:15.920357) ========= /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.xmhui2pWE2/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.xS5PsSLCmJ/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 04:35:16 INFO - MultiFileLogger online at 20160408 04:35:16 in /builds/slave/test 04:35:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:35:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:35:16 INFO - {'append_to_log': False, 04:35:16 INFO - 'base_work_dir': '/builds/slave/test', 04:35:16 INFO - 'blob_upload_branch': 'Fx-Team', 04:35:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:35:16 INFO - 'branch': 'Fx-Team', 04:35:16 INFO - 'buildbot_json_path': 'buildprops.json', 04:35:16 INFO - 'config_files': ('talos/mac_config.py',), 04:35:16 INFO - 'default_actions': ('clobber', 04:35:16 INFO - 'read-buildbot-config', 04:35:16 INFO - 'download-and-extract', 04:35:16 INFO - 'populate-webroot', 04:35:16 INFO - 'create-virtualenv', 04:35:16 INFO - 'install', 04:35:16 INFO - 'run-tests'), 04:35:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:35:16 INFO - 'download_minidump_stackwalk': True, 04:35:16 INFO - 'download_symbols': 'ondemand', 04:35:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:35:16 INFO - 'tooltool.py': '/tools/tooltool.py', 04:35:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:35:16 INFO - '/tools/misc-python/virtualenv.py')}, 04:35:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:35:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:35:16 INFO - 'installer_path': 'installer.exe', 04:35:16 INFO - 'log_level': 'info', 04:35:16 INFO - 'log_name': 'talos', 04:35:16 INFO - 'log_to_console': True, 04:35:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:35:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:35:16 INFO - 'opt_config_files': (), 04:35:16 INFO - 'pip_index': False, 04:35:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:35:16 INFO - 'cmd': ('bash', 04:35:16 INFO - '-c', 04:35:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:35:16 INFO - 'enabled': True, 04:35:16 INFO - 'halt_on_failure': False, 04:35:16 INFO - 'name': 'check_screen_resolution'},), 04:35:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:35:16 INFO - 'cmd': ('bash', 04:35:16 INFO - '-c', 04:35:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:35:16 INFO - 'enabled': True, 04:35:16 INFO - 'halt_on_failure': False, 04:35:16 INFO - 'name': 'check_screen_resolution'},), 04:35:16 INFO - 'run_cmd_checks_enabled': True, 04:35:16 INFO - 'sps_profile': False, 04:35:16 INFO - 'sps_profile_interval': 0, 04:35:16 INFO - 'suite': 'dromaeojs', 04:35:16 INFO - 'system_bits': '32', 04:35:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:35:16 INFO - 'title': 't-yosemite-r7-0023', 04:35:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:35:16 INFO - 'use_talos_json': True, 04:35:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:35:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:35:16 INFO - 'work_dir': 'build'} 04:35:16 INFO - ##### 04:35:16 INFO - ##### Running clobber step. 04:35:16 INFO - ##### 04:35:16 INFO - Running pre-action listener: _resource_record_pre_action 04:35:16 INFO - Running main action method: clobber 04:35:16 INFO - rmtree: /builds/slave/test/build 04:35:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:35:17 INFO - Running post-action listener: _resource_record_post_action 04:35:17 INFO - ##### 04:35:17 INFO - ##### Running read-buildbot-config step. 04:35:17 INFO - ##### 04:35:17 INFO - Running pre-action listener: _resource_record_pre_action 04:35:17 INFO - Running main action method: read_buildbot_config 04:35:17 INFO - Using buildbot properties: 04:35:17 INFO - { 04:35:17 INFO - "project": "", 04:35:17 INFO - "product": "firefox", 04:35:17 INFO - "script_repo_revision": "production", 04:35:17 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:35:17 INFO - "repository": "", 04:35:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:35:17 INFO - "buildid": "20160408030055", 04:35:17 INFO - "pgo_build": "False", 04:35:17 INFO - "basedir": "/builds/slave/test", 04:35:17 INFO - "buildnumber": 589, 04:35:17 INFO - "slavename": "t-yosemite-r7-0023", 04:35:17 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:35:17 INFO - "platform": "yosemite_r7", 04:35:17 INFO - "scheduler": "tests-fx-team-macosx64-talos", 04:35:17 INFO - "branch": "fx-team", 04:35:17 INFO - "repo_path": "integration/fx-team", 04:35:17 INFO - "revision": "5ae810198a9c8c7f4e75cd0881bfc8d1295cbc8d", 04:35:17 INFO - "stage_platform": "macosx64", 04:35:17 INFO - "builduid": "6f702b63d3354324a6c4db67b9bf87fe", 04:35:17 INFO - "slavebuilddir": "test" 04:35:17 INFO - } 04:35:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/HA7E95dtSVyTnZMFdLv_5w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 04:35:17 INFO - Running post-action listener: _resource_record_post_action 04:35:17 INFO - ##### 04:35:17 INFO - ##### Running download-and-extract step. 04:35:17 INFO - ##### 04:35:17 INFO - Running pre-action listener: _resource_record_pre_action 04:35:17 INFO - Running main action method: download_and_extract 04:35:17 INFO - mkdir: /builds/slave/test/build/tests 04:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:17 INFO - https://queue.taskcluster.net/v1/task/HA7E95dtSVyTnZMFdLv_5w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:35:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HA7E95dtSVyTnZMFdLv_5w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:35:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HA7E95dtSVyTnZMFdLv_5w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:35:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HA7E95dtSVyTnZMFdLv_5w/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 04:35:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HA7E95dtSVyTnZMFdLv_5w/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 04:35:18 INFO - Downloaded 1199 bytes. 04:35:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:35:18 INFO - Using the following test package requirements: 04:35:18 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:35:18 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:35:18 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 04:35:18 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:35:18 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 04:35:18 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:35:18 INFO - u'jsshell-mac.zip'], 04:35:18 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:35:18 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 04:35:18 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:35:18 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:35:18 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 04:35:18 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:35:18 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 04:35:18 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:35:18 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 04:35:18 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:35:18 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 04:35:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:35: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')]} 04:35:18 INFO - https://queue.taskcluster.net/v1/task/HA7E95dtSVyTnZMFdLv_5w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:35:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HA7E95dtSVyTnZMFdLv_5w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:35:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HA7E95dtSVyTnZMFdLv_5w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:35:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HA7E95dtSVyTnZMFdLv_5w/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 04:35:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HA7E95dtSVyTnZMFdLv_5w/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 04:35:20 INFO - Downloaded 18014525 bytes. 04:35:20 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'] 04:35:20 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 04:35:23 INFO - Return code: 0 04:35:23 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 04:35: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')]} 04:35:23 INFO - https://queue.taskcluster.net/v1/task/HA7E95dtSVyTnZMFdLv_5w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:35:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HA7E95dtSVyTnZMFdLv_5w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:35:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HA7E95dtSVyTnZMFdLv_5w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:35:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HA7E95dtSVyTnZMFdLv_5w/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 04:35:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HA7E95dtSVyTnZMFdLv_5w/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 04:35:28 INFO - Downloaded 18014525 bytes. 04:35:28 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'] 04:35:28 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 04:35:31 INFO - Return code: 0 04:35:31 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')]} 04:35:31 INFO - https://queue.taskcluster.net/v1/task/HA7E95dtSVyTnZMFdLv_5w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:35:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HA7E95dtSVyTnZMFdLv_5w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:35:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HA7E95dtSVyTnZMFdLv_5w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:35:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HA7E95dtSVyTnZMFdLv_5w/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 04:35:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HA7E95dtSVyTnZMFdLv_5w/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 04:35:34 INFO - Downloaded 10847693 bytes. 04:35:34 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'] 04:35:34 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 04:35:34 INFO - Return code: 0 04:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:34 INFO - https://queue.taskcluster.net/v1/task/HA7E95dtSVyTnZMFdLv_5w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:35:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HA7E95dtSVyTnZMFdLv_5w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:35:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HA7E95dtSVyTnZMFdLv_5w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:35:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HA7E95dtSVyTnZMFdLv_5w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 04:35:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HA7E95dtSVyTnZMFdLv_5w/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 04:35:38 INFO - Downloaded 108784480 bytes. 04:35:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HA7E95dtSVyTnZMFdLv_5w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:35:38 INFO - mkdir: /builds/slave/test/properties 04:35:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:35:38 INFO - Writing to file /builds/slave/test/properties/build_url 04:35:38 INFO - Contents: 04:35:38 INFO - build_url:https://queue.taskcluster.net/v1/task/HA7E95dtSVyTnZMFdLv_5w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:35:39 INFO - Running post-action listener: _resource_record_post_action 04:35:39 INFO - Running post-action listener: set_extra_try_arguments 04:35:39 INFO - ##### 04:35:39 INFO - ##### Running populate-webroot step. 04:35:39 INFO - ##### 04:35:39 INFO - Running pre-action listener: _resource_record_pre_action 04:35:39 INFO - Running main action method: populate_webroot 04:35:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:35:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:35:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:35:39 INFO - '--tppagecycles', 04:35:39 INFO - '7'], 04:35:39 INFO - 'tests': ['tsvgm']}}, 04:35:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:35:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:35:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:35:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:35:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:35:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:35:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:39 INFO - 'talos_options': ['--disable-e10s'], 04:35:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:35:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:35:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:39 INFO - 'talos_options': ['--disable-e10s'], 04:35:39 INFO - 'tests': ['damp', 'tps']}, 04:35:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:39 INFO - 'tests': ['damp', 'tps']}, 04:35:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:35:39 INFO - 'tests': ['dromaeo_dom']}, 04:35:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:35:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:35:39 INFO - 'tests': ['a11yr', 04:35:39 INFO - 'ts_paint', 04:35:39 INFO - 'tpaint', 04:35:39 INFO - 'sessionrestore', 04:35:39 INFO - 'sessionrestore_no_auto_restore', 04:35:39 INFO - 'tabpaint']}, 04:35:39 INFO - 'other-e10s': {'tests': ['a11yr', 04:35:39 INFO - 'ts_paint', 04:35:39 INFO - 'tpaint', 04:35:39 INFO - 'sessionrestore', 04:35:39 INFO - 'sessionrestore_no_auto_restore', 04:35:39 INFO - 'tabpaint']}, 04:35:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:35:39 INFO - 'ts_paint', 04:35:39 INFO - 'tpaint', 04:35:39 INFO - 'sessionrestore', 04:35:39 INFO - 'sessionrestore_no_auto_restore', 04:35:39 INFO - 'tabpaint']}, 04:35:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:35:39 INFO - 'ts_paint', 04:35:39 INFO - 'tpaint', 04:35:39 INFO - 'sessionrestore', 04:35:39 INFO - 'sessionrestore_no_auto_restore', 04:35:39 INFO - 'tabpaint']}, 04:35:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:35:39 INFO - 'tests': ['a11yr', 04:35:39 INFO - 'ts_paint', 04:35:39 INFO - 'tpaint', 04:35:39 INFO - 'sessionrestore', 04:35:39 INFO - 'sessionrestore_no_auto_restore', 04:35:39 INFO - 'tabpaint']}, 04:35:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:35:39 INFO - 'tests': ['a11yr', 04:35:39 INFO - 'ts_paint', 04:35:39 INFO - 'tpaint', 04:35:39 INFO - 'sessionrestore', 04:35:39 INFO - 'sessionrestore_no_auto_restore', 04:35:39 INFO - 'tabpaint']}, 04:35:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:35:39 INFO - 'tests': ['tsvgx', 04:35:39 INFO - 'tsvgr_opacity', 04:35:39 INFO - 'tart', 04:35:39 INFO - 'tscrollx', 04:35:39 INFO - 'cart']}, 04:35:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:35:39 INFO - 'tsvgr_opacity', 04:35:39 INFO - 'tart', 04:35:39 INFO - 'tscrollx', 04:35:39 INFO - 'cart']}, 04:35:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:39 INFO - 'talos_options': ['--disable-e10s'], 04:35:39 INFO - 'tests': ['tp5o']}, 04:35:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:39 INFO - 'tests': ['tp5o']}, 04:35:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:39 INFO - 'talos_options': ['--disable-e10s', 04:35:39 INFO - '--xperf_path', 04:35:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:35:39 INFO - 'tests': ['tp5n']}, 04:35:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:39 INFO - 'talos_options': ['--xperf_path', 04:35:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:35:39 INFO - 'tests': ['tp5n']}}, 04:35:39 INFO - 'talos.zip': {'path': '', 04:35:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:35:39 INFO - Running post-action listener: _resource_record_post_action 04:35:39 INFO - ##### 04:35:39 INFO - ##### Running create-virtualenv step. 04:35:39 INFO - ##### 04:35:39 INFO - Running pre-action listener: _resource_record_pre_action 04:35:39 INFO - Running main action method: create_virtualenv 04:35:39 INFO - Creating virtualenv /builds/slave/test/build/venv 04:35:39 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 04:35:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:35:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:35:39 INFO - Using real prefix '/tools/python27' 04:35:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:35:40 INFO - Installing distribute.............................................................................................................................................................................................done. 04:35:43 INFO - Installing pip.................done. 04:35:43 INFO - Return code: 0 04:35:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:35:43 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')]} 04:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:43 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')]} 04:35:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:43 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 0x101488a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101498420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb90a5abbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101327e00>, '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 0x101150db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101322b20>, '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.xmhui2pWE2/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.xS5PsSLCmJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 04:35:43 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 04:35:43 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 04:35:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xmhui2pWE2/Render', 04:35:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:43 INFO - 'HOME': '/Users/cltbld', 04:35:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:43 INFO - 'LOGNAME': 'cltbld', 04:35:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:43 INFO - 'MOZ_NO_REMOTE': '1', 04:35:43 INFO - 'NO_EM_RESTART': '1', 04:35:43 INFO - 'PAGER': '/bin/cat', 04:35:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:43 INFO - 'PWD': '/builds/slave/test', 04:35:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:43 INFO - 'SHELL': '/bin/bash', 04:35:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xS5PsSLCmJ/Listeners', 04:35:43 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 04:35:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:43 INFO - 'USER': 'cltbld', 04:35:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:43 INFO - 'XPC_FLAGS': '0x0', 04:35:43 INFO - 'XPC_SERVICE_NAME': '0', 04:35:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:43 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 04:35:43 INFO - Cleaning up... 04:35:43 INFO - Return code: 0 04:35:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:35:43 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')]} 04:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:43 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')]} 04:35:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:43 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 0x101488a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101498420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb90a5abbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101327e00>, '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 0x101150db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101322b20>, '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.xmhui2pWE2/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.xS5PsSLCmJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 04:35:43 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 04:35:43 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 04:35:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xmhui2pWE2/Render', 04:35:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:43 INFO - 'HOME': '/Users/cltbld', 04:35:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:43 INFO - 'LOGNAME': 'cltbld', 04:35:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:43 INFO - 'MOZ_NO_REMOTE': '1', 04:35:43 INFO - 'NO_EM_RESTART': '1', 04:35:43 INFO - 'PAGER': '/bin/cat', 04:35:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:43 INFO - 'PWD': '/builds/slave/test', 04:35:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:43 INFO - 'SHELL': '/bin/bash', 04:35:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xS5PsSLCmJ/Listeners', 04:35:43 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 04:35:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:43 INFO - 'USER': 'cltbld', 04:35:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:43 INFO - 'XPC_FLAGS': '0x0', 04:35:43 INFO - 'XPC_SERVICE_NAME': '0', 04:35:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:43 INFO - Downloading/unpacking psutil>=0.7.1 04:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:35:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:35:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:35:47 INFO - Installing collected packages: psutil 04:35:47 INFO - Running setup.py install for psutil 04:35:47 INFO - building 'psutil._psutil_osx' extension 04:35:47 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 04:35:47 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 04:35:47 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 04:35:47 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 04:35:47 INFO - building 'psutil._psutil_posix' extension 04:35:47 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 04:35:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:35:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:35:47 INFO - ^ 04:35:47 INFO - 1 warning generated. 04:35:47 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 04:35:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:35:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:35:47 INFO - Successfully installed psutil 04:35:47 INFO - Cleaning up... 04:35:47 INFO - Return code: 0 04:35:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:35:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:47 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 0x101488a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101498420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb90a5abbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101327e00>, '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 0x101150db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101322b20>, '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.xmhui2pWE2/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.xS5PsSLCmJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 04:35:47 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 04:35:47 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 04:35:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xmhui2pWE2/Render', 04:35:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:47 INFO - 'HOME': '/Users/cltbld', 04:35:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:47 INFO - 'LOGNAME': 'cltbld', 04:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:47 INFO - 'MOZ_NO_REMOTE': '1', 04:35:47 INFO - 'NO_EM_RESTART': '1', 04:35:47 INFO - 'PAGER': '/bin/cat', 04:35:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:47 INFO - 'PWD': '/builds/slave/test', 04:35:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:47 INFO - 'SHELL': '/bin/bash', 04:35:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xS5PsSLCmJ/Listeners', 04:35:47 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 04:35:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:47 INFO - 'USER': 'cltbld', 04:35:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:47 INFO - 'XPC_FLAGS': '0x0', 04:35:47 INFO - 'XPC_SERVICE_NAME': '0', 04:35:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:35:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:35:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:35:50 INFO - Installing collected packages: mozsystemmonitor 04:35:50 INFO - Running setup.py install for mozsystemmonitor 04:35:50 INFO - Successfully installed mozsystemmonitor 04:35:50 INFO - Cleaning up... 04:35:50 INFO - Return code: 0 04:35:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:50 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 0x101488a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101498420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb90a5abbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101327e00>, '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 0x101150db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101322b20>, '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.xmhui2pWE2/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.xS5PsSLCmJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 04:35:50 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 04:35:50 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 04:35:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xmhui2pWE2/Render', 04:35:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:50 INFO - 'HOME': '/Users/cltbld', 04:35:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:50 INFO - 'LOGNAME': 'cltbld', 04:35:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:50 INFO - 'MOZ_NO_REMOTE': '1', 04:35:50 INFO - 'NO_EM_RESTART': '1', 04:35:50 INFO - 'PAGER': '/bin/cat', 04:35:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:50 INFO - 'PWD': '/builds/slave/test', 04:35:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:50 INFO - 'SHELL': '/bin/bash', 04:35:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xS5PsSLCmJ/Listeners', 04:35:50 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 04:35:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:50 INFO - 'USER': 'cltbld', 04:35:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:50 INFO - 'XPC_FLAGS': '0x0', 04:35:50 INFO - 'XPC_SERVICE_NAME': '0', 04:35:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:51 INFO - Downloading/unpacking blobuploader==1.2.4 04:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:53 INFO - Downloading blobuploader-1.2.4.tar.gz 04:35:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:35:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:35:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:54 INFO - Downloading docopt-0.6.1.tar.gz 04:35:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:35:55 INFO - Installing collected packages: blobuploader, requests, docopt 04:35:55 INFO - Running setup.py install for blobuploader 04:35:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:35:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:35:55 INFO - Running setup.py install for requests 04:35:55 INFO - Running setup.py install for docopt 04:35:55 INFO - Successfully installed blobuploader requests docopt 04:35:55 INFO - Cleaning up... 04:35:55 INFO - Return code: 0 04:35:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:55 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 0x101488a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101498420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb90a5abbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101327e00>, '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 0x101150db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101322b20>, '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.xmhui2pWE2/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.xS5PsSLCmJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 04:35:55 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 04:35:55 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 04:35:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xmhui2pWE2/Render', 04:35:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:55 INFO - 'HOME': '/Users/cltbld', 04:35:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:55 INFO - 'LOGNAME': 'cltbld', 04:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:55 INFO - 'MOZ_NO_REMOTE': '1', 04:35:55 INFO - 'NO_EM_RESTART': '1', 04:35:55 INFO - 'PAGER': '/bin/cat', 04:35:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:55 INFO - 'PWD': '/builds/slave/test', 04:35:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:55 INFO - 'SHELL': '/bin/bash', 04:35:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xS5PsSLCmJ/Listeners', 04:35:55 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 04:35:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:55 INFO - 'USER': 'cltbld', 04:35:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:55 INFO - 'XPC_FLAGS': '0x0', 04:35:55 INFO - 'XPC_SERVICE_NAME': '0', 04:35:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:35:56 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-_XdlQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:35:56 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-wabAIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:35:56 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-iSlEbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:35:56 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-MzaRBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:35:56 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-zz22zJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:35:56 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-ncjhn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:35:56 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-pwVNsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:35:56 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-o2ubK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:35:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-1qUBpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:35:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-dtskma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:35:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-qOp3KP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:35:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-6PXYZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:35:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-HA4Pcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:35:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-_UqkoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-sH8IRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:35:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-ZH42nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:35:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-Bo4pkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:35:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:35:57 INFO - Running setup.py install for manifestparser 04:35:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:35:58 INFO - Running setup.py install for mozcrash 04:35:58 INFO - Running setup.py install for mozdebug 04:35:58 INFO - Running setup.py install for mozdevice 04:35:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:35:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:35:58 INFO - Running setup.py install for mozfile 04:35:58 INFO - Running setup.py install for mozhttpd 04:35:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:35:58 INFO - Running setup.py install for mozinfo 04:35:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:35:59 INFO - Running setup.py install for mozInstall 04:35:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:35:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:35:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:35:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:35:59 INFO - Running setup.py install for mozleak 04:35:59 INFO - Running setup.py install for mozlog 04:35:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:35:59 INFO - Running setup.py install for moznetwork 04:35:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:35:59 INFO - Running setup.py install for mozprocess 04:35:59 INFO - Running setup.py install for mozprofile 04:35:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:35:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:35:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:35:59 INFO - Running setup.py install for mozrunner 04:36:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:36:00 INFO - Running setup.py install for mozscreenshot 04:36:00 INFO - Running setup.py install for moztest 04:36:00 INFO - Running setup.py install for mozversion 04:36:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:36:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:36:00 INFO - Cleaning up... 04:36:00 INFO - Return code: 0 04:36:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:00 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 0x101488a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101498420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb90a5abbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101327e00>, '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 0x101150db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101322b20>, '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.xmhui2pWE2/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.xS5PsSLCmJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 04:36:00 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 04:36:00 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 04:36:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xmhui2pWE2/Render', 04:36:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:00 INFO - 'HOME': '/Users/cltbld', 04:36:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:00 INFO - 'LOGNAME': 'cltbld', 04:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:00 INFO - 'MOZ_NO_REMOTE': '1', 04:36:00 INFO - 'NO_EM_RESTART': '1', 04:36:00 INFO - 'PAGER': '/bin/cat', 04:36:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:00 INFO - 'PWD': '/builds/slave/test', 04:36:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:00 INFO - 'SHELL': '/bin/bash', 04:36:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xS5PsSLCmJ/Listeners', 04:36:00 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 04:36:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:00 INFO - 'USER': 'cltbld', 04:36:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:00 INFO - 'XPC_FLAGS': '0x0', 04:36:00 INFO - 'XPC_SERVICE_NAME': '0', 04:36:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:36:00 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-fnO_GS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:36:00 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)) 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:36:00 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-sXWsDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:36:01 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)) 04:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:36:01 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-cwGuRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:36:01 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)) 04:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:36:01 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-BsS5DP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:36:01 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)) 04:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:36:01 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-DfixqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:36:01 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)) 04:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:36:01 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-huUh8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:36:01 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)) 04:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:36:01 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-_S9mPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:36:01 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)) 04:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:36:01 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-Dg_0ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:36:01 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)) 04:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:36:01 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-HEYz03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:36:01 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)) 04:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:36:01 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-DX5Dm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:36:01 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)) 04:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:36:01 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-RBBwyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:36:02 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)) 04:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:36:02 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-rGNdgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:36:02 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)) 04:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:36:02 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-CnhvVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:36:02 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)) 04:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:36:02 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-g0YdH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:36:02 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)) 04:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:02 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-EphpdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:02 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)) 04:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:36:02 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-G1FfTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:36:02 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)) 04:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:36:02 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-tSjELK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:36:02 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)) 04:36:02 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)) 04:36:02 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)) 04:36:02 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)) 04:36:02 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)) 04:36:02 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)) 04:36:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36:05 INFO - Downloading blessings-1.6.tar.gz 04:36:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:36:05 INFO - Installing collected packages: blessings 04:36:05 INFO - Running setup.py install for blessings 04:36:05 INFO - Successfully installed blessings 04:36:05 INFO - Cleaning up... 04:36:05 INFO - Return code: 0 04:36:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:36:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:36:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:36:05 INFO - Reading from file tmpfile_stdout 04:36:05 INFO - Current package versions: 04:36:05 INFO - blessings == 1.6 04:36:05 INFO - blobuploader == 1.2.4 04:36:05 INFO - docopt == 0.6.1 04:36:05 INFO - manifestparser == 1.1 04:36:05 INFO - mozInstall == 1.12 04:36:05 INFO - mozcrash == 0.17 04:36:05 INFO - mozdebug == 0.1 04:36:05 INFO - mozdevice == 0.48 04:36:05 INFO - mozfile == 1.2 04:36:05 INFO - mozhttpd == 0.7 04:36:05 INFO - mozinfo == 0.9 04:36:05 INFO - mozleak == 0.1 04:36:05 INFO - mozlog == 3.1 04:36:05 INFO - moznetwork == 0.27 04:36:05 INFO - mozprocess == 0.22 04:36:05 INFO - mozprofile == 0.28 04:36:05 INFO - mozrunner == 6.11 04:36:05 INFO - mozscreenshot == 0.1 04:36:05 INFO - mozsystemmonitor == 0.0 04:36:05 INFO - moztest == 0.7 04:36:05 INFO - mozversion == 1.4 04:36:05 INFO - psutil == 3.1.1 04:36:05 INFO - requests == 1.2.3 04:36:05 INFO - wsgiref == 0.1.2 04:36:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36: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')]} 04:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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')]} 04:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:05 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 0x101488a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101498420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb90a5abbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101327e00>, '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 0x101150db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101322b20>, '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.xmhui2pWE2/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.xS5PsSLCmJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 04:36:05 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 04:36:05 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 04:36:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xmhui2pWE2/Render', 04:36:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:05 INFO - 'HOME': '/Users/cltbld', 04:36:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:05 INFO - 'LOGNAME': 'cltbld', 04:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:05 INFO - 'MOZ_NO_REMOTE': '1', 04:36:05 INFO - 'NO_EM_RESTART': '1', 04:36:05 INFO - 'PAGER': '/bin/cat', 04:36:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:05 INFO - 'PWD': '/builds/slave/test', 04:36:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:05 INFO - 'SHELL': '/bin/bash', 04:36:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xS5PsSLCmJ/Listeners', 04:36:05 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 04:36:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:05 INFO - 'USER': 'cltbld', 04:36:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:05 INFO - 'XPC_FLAGS': '0x0', 04:36:05 INFO - 'XPC_SERVICE_NAME': '0', 04:36:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:06 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)) 04:36:06 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)) 04:36:06 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)) 04:36:06 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)) 04:36:06 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)) 04:36:06 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)) 04:36:06 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)) 04:36:06 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)) 04:36:06 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)) 04:36:06 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)) 04:36:06 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)) 04:36:06 INFO - Cleaning up... 04:36:06 INFO - Return code: 0 04:36:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:36: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')]} 04:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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')]} 04:36:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101488a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101498420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb90a5abbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101327e00>, '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 0x101150db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101322b20>, '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.xmhui2pWE2/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.xS5PsSLCmJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 04:36: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', 'jsonschema'] in /builds/slave/test/build 04:36: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 jsonschema 04:36:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xmhui2pWE2/Render', 04:36:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:06 INFO - 'HOME': '/Users/cltbld', 04:36:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:06 INFO - 'LOGNAME': 'cltbld', 04:36:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:06 INFO - 'MOZ_NO_REMOTE': '1', 04:36:06 INFO - 'NO_EM_RESTART': '1', 04:36:06 INFO - 'PAGER': '/bin/cat', 04:36:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:06 INFO - 'PWD': '/builds/slave/test', 04:36:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:06 INFO - 'SHELL': '/bin/bash', 04:36:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xS5PsSLCmJ/Listeners', 04:36:06 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 04:36:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:06 INFO - 'USER': 'cltbld', 04:36:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:06 INFO - 'XPC_FLAGS': '0x0', 04:36:06 INFO - 'XPC_SERVICE_NAME': '0', 04:36:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:06 INFO - Downloading/unpacking jsonschema 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:36:08 INFO - Downloading/unpacking functools32 (from jsonschema) 04:36:08 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 04:36:08 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 04:36:08 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 04:36:08 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 04:36:08 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 04:36:08 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 04:36:09 INFO - Downloading functools32-3.2.3-2.tar.gz 04:36:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:36:09 INFO - warning: no files found matching '*.txt' 04:36:09 INFO - no previously-included directories found matching 'build' 04:36:09 INFO - no previously-included directories found matching 'dist' 04:36:09 INFO - no previously-included directories found matching '.git*' 04:36:09 INFO - Installing collected packages: jsonschema, functools32 04:36:09 INFO - Running setup.py install for functools32 04:36:09 INFO - warning: no files found matching '*.txt' 04:36:09 INFO - no previously-included directories found matching 'build' 04:36:09 INFO - no previously-included directories found matching 'dist' 04:36:09 INFO - no previously-included directories found matching '.git*' 04:36:09 INFO - Successfully installed jsonschema functools32 04:36:09 INFO - Cleaning up... 04:36:09 INFO - Return code: 0 04:36:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:36: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')]} 04:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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')]} 04:36:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101488a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101498420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb90a5abbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101327e00>, '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 0x101150db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101322b20>, '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.xmhui2pWE2/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.xS5PsSLCmJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 04:36: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', 'flake8'] in /builds/slave/test/build 04:36: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 flake8 04:36:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xmhui2pWE2/Render', 04:36:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:09 INFO - 'HOME': '/Users/cltbld', 04:36:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:09 INFO - 'LOGNAME': 'cltbld', 04:36:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:09 INFO - 'MOZ_NO_REMOTE': '1', 04:36:09 INFO - 'NO_EM_RESTART': '1', 04:36:09 INFO - 'PAGER': '/bin/cat', 04:36:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:09 INFO - 'PWD': '/builds/slave/test', 04:36:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:09 INFO - 'SHELL': '/bin/bash', 04:36:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xS5PsSLCmJ/Listeners', 04:36:09 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 04:36:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:09 INFO - 'USER': 'cltbld', 04:36:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:09 INFO - 'XPC_FLAGS': '0x0', 04:36:09 INFO - 'XPC_SERVICE_NAME': '0', 04:36:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:09 INFO - Downloading/unpacking flake8 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:36:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:36:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:36: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 04:36: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 04:36: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 04:36: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 04:36:13 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 04:36:13 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 04:36:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:36:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:36:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:36:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:36:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:36:13 INFO - no previously-included directories found matching 'docs/_build' 04:36:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:36:13 INFO - Running setup.py install for pep8 04:36:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:36:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:36:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:36:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:36:13 INFO - no previously-included directories found matching 'docs/_build' 04:36:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:36:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:36:13 INFO - Cleaning up... 04:36:13 INFO - Return code: 0 04:36:13 INFO - Running post-action listener: _resource_record_post_action 04:36:13 INFO - Running post-action listener: _start_resource_monitoring 04:36:13 INFO - Starting resource monitoring. 04:36:13 INFO - ##### 04:36:13 INFO - ##### Running install step. 04:36:13 INFO - ##### 04:36:13 INFO - Running pre-action listener: _resource_record_pre_action 04:36:13 INFO - Running main action method: install 04:36:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:36:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:36:14 INFO - Reading from file tmpfile_stdout 04:36:14 INFO - Detecting whether we're running mozinstall >=1.0... 04:36:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:36:14 INFO - Reading from file tmpfile_stdout 04:36:14 INFO - Output received: 04:36:14 INFO - Usage: mozinstall [options] installer 04:36:14 INFO - Options: 04:36:14 INFO - -h, --help show this help message and exit 04:36:14 INFO - -d DEST, --destination=DEST 04:36:14 INFO - Directory to install application into. [default: 04:36:14 INFO - "/builds/slave/test"] 04:36:14 INFO - --app=APP Application being installed. [default: firefox] 04:36:14 INFO - mkdir: /builds/slave/test/build/application 04:36:14 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'] 04:36:14 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 04:36:47 INFO - Reading from file tmpfile_stdout 04:36:47 INFO - Output received: 04:36:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:36:47 INFO - Running post-action listener: _resource_record_post_action 04:36:47 INFO - ##### 04:36:47 INFO - ##### Running run-tests step. 04:36:47 INFO - ##### 04:36:47 INFO - Running pre-action listener: _resource_record_pre_action 04:36:47 INFO - Running main action method: run_tests 04:36:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:36:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:36:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:36:47 INFO - 2016-04-08 04:36:47.491 screenresolution[1940:12659] starting screenresolution argv=screenresolution get 04:36:47 INFO - 2016-04-08 04:36:47.493 screenresolution[1940:12659] Display 0: 1600x1200x32@60 04:36:47 INFO - 2016-04-08 04:36:47.499 screenresolution[1941:12661] starting screenresolution argv=screenresolution list 04:36:47 INFO - Available Modes on Display 0 04:36:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:36:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:36:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:36:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:36:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:36:47 INFO - Intel Iris: 04:36:47 INFO - Chipset Model: Intel Iris 04:36:47 INFO - Type: GPU 04:36:47 INFO - Bus: Built-In 04:36:47 INFO - VRAM (Dynamic, Max): 1536 MB 04:36:47 INFO - Vendor: Intel (0x8086) 04:36:47 INFO - Device ID: 0x0a2e 04:36:47 INFO - Revision ID: 0x0009 04:36:47 INFO - Displays: 04:36:47 INFO - Display: 04:36:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:36:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:36:47 INFO - Display Serial Number: 1600x1200 60 04:36:47 INFO - Main Display: Yes 04:36:47 INFO - Mirror: Off 04:36:47 INFO - Online: Yes 04:36:47 INFO - Rotation: Supported 04:36:47 INFO - Return code: 0 04:36:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:36:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:36:47 INFO - Python 2.7.3 04:36:47 INFO - Return code: 0 04:36:47 INFO - grabbing minidump binary from tooltool 04:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:47 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 0x101327e00>, '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 0x101150db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101322b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:36:47 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 04:36:47 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 04:36:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:36:47 INFO - Return code: 0 04:36:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:36:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:36:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:36:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:36:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:36:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:36:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:36:49 INFO - Return code: 0 04:36:49 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/HA7E95dtSVyTnZMFdLv_5w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--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 04:36:49 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/HA7E95dtSVyTnZMFdLv_5w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0023 --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 04:36:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xmhui2pWE2/Render', 04:36:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:49 INFO - 'HOME': '/Users/cltbld', 04:36:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:49 INFO - 'LOGNAME': 'cltbld', 04:36:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:36:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:49 INFO - 'MOZ_NO_REMOTE': '1', 04:36:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:36:49 INFO - 'NO_EM_RESTART': '1', 04:36:49 INFO - 'PAGER': '/bin/cat', 04:36:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:49 INFO - 'PWD': '/builds/slave/test', 04:36:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:36:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:49 INFO - 'SHELL': '/bin/bash', 04:36:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xS5PsSLCmJ/Listeners', 04:36:49 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 04:36:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:49 INFO - 'USER': 'cltbld', 04:36:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:49 INFO - 'XPC_FLAGS': '0x0', 04:36:49 INFO - 'XPC_SERVICE_NAME': '0', 04:36:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:49 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/HA7E95dtSVyTnZMFdLv_5w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--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 04:36:49 INFO - mozversion application_buildid: 20160408030055 04:36:49 INFO - mozversion application_changeset: 5ae810198a9c8c7f4e75cd0881bfc8d1295cbc8d 04:36:49 INFO - mozversion application_display_name: Nightly 04:36:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:36:49 INFO - mozversion application_name: Firefox 04:36:49 INFO - mozversion application_remotingname: firefox 04:36:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:36:49 INFO - mozversion application_vendor: Mozilla 04:36:49 INFO - mozversion application_version: 48.0a1 04:36:49 INFO - mozversion platform_buildid: 20160408030055 04:36:49 INFO - mozversion platform_changeset: 5ae810198a9c8c7f4e75cd0881bfc8d1295cbc8d 04:36:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:36:49 INFO - mozversion platform_version: 48.0a1 04:36:49 INFO - using testdate: 1460115409 04:36:49 INFO - actual date: 1460115409 04:36:49 INFO - starting webserver on 'localhost:50808' 04:36:49 INFO - SUITE-START | Running 2 tests 04:36:49 INFO - TEST-START | dromaeo_css 04:36:49 INFO - operating with platform_type : mac_ 04:36:49 INFO - Initialising browser for dromaeo_css test... 04:36:49 INFO - TEST-INFO | started process 1959 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpYRZpbe/profile http://localhost:50808/getInfo.html) 04:36:51 INFO - PROCESS | 1959 | __metrics Screen width/height:1600/1200 04:36:51 INFO - PROCESS | 1959 | colorDepth:24 04:36:51 INFO - PROCESS | 1959 | Browser inner width/height: 1024/689 04:36:51 INFO - PROCESS | 1959 | __metrics 04:36:51 INFO - PROCESS | 1959 | 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" 04:36:51 ERROR - PROCESS | 1959 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:36:52 INFO - TEST-INFO | 1959: exit 0 04:36:52 INFO - Browser initialized. 04:36:52 INFO - Running cycle 1/1 for dromaeo_css test... 04:36:52 INFO - TEST-INFO | started process 1961 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpYRZpbe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:37:04 INFO - PROCESS | 1961 | RSS: Main: 237481984 04:37:04 INFO - PROCESS | 1961 | 04:37:55 INFO - PROCESS | 1961 | 1460115475217 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] 04:40:04 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:50808/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50808/tests/dromaeo/cssquery-ext.html) 04:40:07 INFO - PROCESS | 1961 | RSS: Main: 452366336 04:40:07 INFO - PROCESS | 1961 | 04:43:10 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:50808/tests/dromaeo/cssquery-ext.html (next: http://localhost:50808/tests/dromaeo/cssquery-jquery.html) 04:43:11 INFO - PROCESS | 1961 | RSS: Main: 381452288 04:43:11 INFO - PROCESS | 1961 | 04:46:13 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:50808/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50808/tests/dromaeo/cssquery-mootools.html) 04:46:13 INFO - PROCESS | 1961 | RSS: Main: 375791616 04:46:13 INFO - PROCESS | 1961 | 04:49:15 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:50808/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50808/tests/dromaeo/cssquery-prototype.html) 04:49:16 INFO - PROCESS | 1961 | RSS: Main: 339795968 04:49:16 INFO - PROCESS | 1961 | 04:52:19 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:50808/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50808/tests/dromaeo/cssquery-yui.html) 04:52:20 INFO - PROCESS | 1961 | RSS: Main: 343056384 04:52:20 INFO - PROCESS | 1961 | 04:55:23 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:50808/tests/dromaeo/cssquery-yui.html (next: http://localhost:50808/tests/dromaeo/cssquery-dojo.html) 04:55:23 INFO - PROCESS | 1961 | RSS: Main: 383275008 04:55:23 INFO - PROCESS | 1961 | 04:55:23 INFO - PROCESS | 1961 | __start_tp_report 04:55:23 INFO - PROCESS | 1961 | _x_x_mozilla_page_load 04:55:23 INFO - PROCESS | 1961 | _x_x_mozilla_page_load_details 04:55:23 INFO - PROCESS | 1961 | |i|pagename|runs| 04:55:23 INFO - PROCESS | 1961 | |0;dojo.html;3211.2453573410253;3449.655034496551;3483.2336885885097;3483.912902177445;3521.9786261984027;5114.130597798374;5332.666833291672;5620.718964051791;5729.6848673323;5742.913856292159;5756.424357564241;5790.536757059435;5819.88360232794;5897.262842144732;5971;5137.537621614054;5140.742962851861;5160.793568257265;5182.740862956856;5252.894942101156;5327.493888080626;5338.652987555796;5384.7846086156505;5404.594655400841;5437.673739575618;4307.547707490731;5110.948890511103;5229.790808367661;5237.423883372826;5251.159814429711;4720.772599124218;4877.585405240558;5224.634275600672;5266.420693723688;5282.788688452457;5177.611679124043;5197.8960420791755;5220.686758794484;5241.318628578299;5259.474052594748;5551.417101204396;5618.494335509783;5683.4600712932615;5718.513926316268;5744.253247077853;6226.034964580497;6245.56281060326;6246;6256.610852775065;6257.655828929453;5888.205092312526;6222.377762223787;6233.501319894398;6250.562460627758;6254.562180647356;5038.798448062036;5745.683987380692;5764.452377024218;5861.0915308127305;5873;6243.406876346739;6260.499160067275;6270.184875966095;6274.403931626488;6278.152449419361;6102.786402475892;6127;6172.69136543171;6180.81457556274;6181.536384771161;6151.323354431009;6211.3167551569295;6319.810405687745;6320.936790632127;6328.177336946167;5285.916387140627;6301.212348456443;6303.590266632654;6307.085472606446;6313.305536390993;6256.155419018465;6311.021791622214;6320;6321.273053598803;6323.399277068671;4892.972475780126;4926.1379258629595;4973.626977976666;4974.353334066548;5035.219540971156;4483.170613436525;4530.886727831765;4536.56902594253;4538.88652783683;4541;5637;5662.943370566324;5738.2540269765495;5786.334571524244;5792.623479473821;6281.466075383552;6288.591241569284;6290.056491526308;6311.021791622214;6321.051842223703;5753.252077229933;5761.308642962871;5765.423457654201;5766.654000759884;5807.738651760681;5312.76092575835;5379.327584051994;5411.431799661058;5445.891082178334;5448.673079615157;5773.88452230953;5817.981853175677;6242.094896239929;6252.124702541648;6256.843578910563;4691.343211950261;6201.410865967726;6304.211973503312;6308.432241098323;6313.021481670348;5326.840194794162;6161.229846269216;6209.689515524296;6247.9062814056915;6307.873842523216;6212.502999759918;6236.65698386575;6237.1891654084675;6242.781502647567;6249.25008998923;6296.622202667854;6309.779157729457;6310.905336419865;6318.589291696025;6330.461910737639;5898.8230353089475;5934.732937017759;6036.9094463582205;6090.3605121461605;6118.877622447437;6072.423119803611;6086.391360863879;6119.204503414528;6125.571210015256;6127.969360153171;5928.199693041557;5934.465898069195;5937.317208521075;5953.910691339547;5954.612950158225;6056.182415373868;6056.820793652542;6077.4226448487325;6121.666376154927;6140.381550880894;5954.46409823118;5995.790147344822;6002.87994240104;6009.188759517409;6069.544784141119 04:55:23 INFO - PROCESS | 1961 | |1;ext.html;502.7536507111515;530.0564994310126;577.5091172503371;585.932617748959;627.6861569215392;22905.885470572666;35612.465813012794;36860.81569592155;37008.259834803284;37146.81426592863;38894.833155005326;39334.803325983405;39459;39511.40732889002;39634;9444.480553569569;9651.034896510362;9651.855222171673;9653.951730241339;9657.661981830637;9494.145526902577;9612.18296444803;9612.663556775515;9615.759606009835;9620.663276785313;9569.521523923811;9637.807243855119;9640.421574705506;9642.13220810127;9649.710508684751;9533.952330238339;9621.037896210393;9624.807503849885;9628;9630.759231019245;9530.428174309563;9653.17947974423;9653.22774178064;9660.75848103796;9661.178799802025;38674.613253867385;39059.02352441183;39140.41289380661;39148.21703565913;39182.80408597939;3151.6375616803903;3162.7153556180056;3341.4820702791108;3649.59854416014;3797.126660867988;26775.79276017211;27550.44899102007;28536.85852565895;28677.85661071681;28727.994520191693;2738.794590405708;2743.27303264633;2761.295869553271;2811.46582149393;2844.8862045518154;419743;423704;423737.38888722216;424028;424689;49542.293482119865;50916.236256456184;52464.21303680448;53566.464335356926;59008.11487827686;58365.70817145887;58605.70697146487;58694.82610347769;58780.24027236837;59828.70085649544;15148.772768408482;15464.768028479582;15491.845081549265;15501.457448989231;15517.224138793015;10908.34549927007;11972.16194866351;11991.04071674264;12108.273503589813;12360.505579776709;15299.847001529843;15308.464203752816;15332.616684582752;15339.233038348038;15491.915565910504;5912.526997840162;6852.280510546321;7022.332878376546;7079.115110611174;7079.575225486487;921.9815603687889;940.4028441939417;970.4327511069572;1050.2070936442938;1145.7980767316458;27606.309842254104;27607.30981725473;28313.86744530237;28529.858805647957;28579;1043.160255993917;1067.594314160614;1100.0979197058334;1158.415000424797;1174.9941250293864;13331.33343332849;13485.730285394433;13873.86126138746;13911.234882081582;13941.372638231303;559034;559982;569269;570250;570256;53725.731371342896;54062;54167.72916135394;54203.72898135563;54317.72841135769;1317.967050823737;1334.8932085432948;1449.5868677426884;1450.4053338131316;1494.9327280272414;23333.76666233316;26382.868085659447;27581.862090689418;28234;28970.42059158847;45791.77104114591;45800.312995305765;46459.83850403767;46462;46488.83777905444;375083.12458437536;378187.2181278262;378651;379391;379935;22355;22841.657375139053;24698;24872.87563562243;25588.104416345337;39569;39761.60238397695;39932.600673992885;41834;41960.95097622584;29678.55482167726;31295.687043129277;34469.48295775515;35493.467597986564;35640.87182563446;33859.4921076189;34373.82813085918;34433.13917152091;35146.82426587851;35182;34504.13739656529;34703.30593388169;34826;35373.82313088418;35381.46927796137;28993.42013159767;30495.390092198475;30617.693823062375;30682.53161529489;30740.92406765842;22927.65608515907;23059.769402305763;23529.529409412058;23547.41131471727;23629.29112126639 04:55:23 INFO - PROCESS | 1961 | |2;jquery.html;364.8321771984887;395.2628348130736;396.3519645379805;397.11138238884564;403.6145481065583;14156.560298938224;19415.61168776627;19628;20305.593888122246;20348.287809926656;19885.40916726662;19978.800211997914;20069.598608027867;20794;20800.375988720363;5723.51350135239;6017.729202185912;6027.336992930774;6028.728707208164;6037.064255040454;5555.250041244421;5684.488396044355;5993.580449368546;6004.42957918997;6018.849528761794;3879.8836034919;4110.6300432961025;5650.858728531778;6010.699465026732;6024.186734790813;4710.623150148014;5995.190649262359;5998.460138587527;6002.039673652238;6005.219321488178;5744.942550574524;5784.392638772911;5802.5938184327115;5807.332156801937;5811.157382179603;23433.531329373487;24125.155619553232;24211.7578824213;24224;24541.63187552188;1759.3402474072223;1994.3418671838258;2049.1291201239565;2073.4919944613516;2150.7526634436927;9490;9722.416655000723;9895.950520247425;10123.392596444164;10198.235132365027;1710.1534740303505;1722.0786879019665;1732.9220185091574;1776.6624341375098;1800.8739388242827;110244;114057.28914066295;114266;115478.42260788642;117289.41355293168;9727.173190278905;11355.659330220107;11709.590164344378;11748.236364636272;11869.881301186877;14923.776143357858;15056.94601377915;15065.397384104514;15097;15141;8187.4678145920325;8359.456635318686;8408.411411201158;8456.534890581077;8463.884028992752;8078.272955434039;8090.514569125871;8166.265036146775;8198.098209196984;8221.260086592116;3782.319182547113;4480.619147372445;4547.272436410159;4559.088182363541;4615.792289346988;1918.1368384227153;1983.6627773278578;1988.1550341104974;1989.4330115916894;2020.282799606148;691.5643144818832;732.1982429239973;810.9837803243902;906.6237511432681;954.2413781044087;19099.331523396613;19467.929263890623;19793.703094453595;19808.60382792336;19915.402537923885;820.5651004967377;928.5960607135918;940.3981451870808;953.1231267234161;990.7671697151163;9478.478683672463;10142.898571014342;10186.185105191567;10194.286399951932;10198;514792;598413;619093.199492142;622913;623832;123222.15166772506;123612.38193808973;124584;125852.30255428392;135486.64513354938;1006.3710181136789;1027.04997876962;1028.1517747858047;1046.6075221791828;1047.3140093238787;16081.839181608035;16654.583635409213;16667.74998375001;17028.574285642957;17404;38160.61839381682;45407.318890217335;48111.75944120257;48398.5160148394;49175;68827.31172688409;71275.57448850891;71598;71732.9240061389;72335.63832180806;5298.97350513245;5375.059364611256;7873.488223265469;7986.480878743096;8252.504849709037;11142.888571114185;11887.405629718307;11895.464704088165;12087.576934807239;12524.436400362189;9749.171320437843;10577.9471102644;10855.78288434211;11059.50232239535;11130.276532025393;9968.152707019985;10624.946875265574;10764.3541387517;10963.890361096286;11147.777044458902;6623.966880165568;8768.956155219183;9442.10300021497;9754.707358779247;11133.665990020312;7979.601019948863;8184.590770461572;8208.302294305051;8244.258016778518;8245.83508329842;10536.051755342056;10648;10938.835917461403;10948.288361256493;10990.725231869268 04:55:23 INFO - PROCESS | 1961 | |3;mootools.html;1402.3759427054965;1588.2535208452032;1593.3865461797209;1853.2123847364867;1990;7773.766786996385;8433.156684331563;8657.220850123487;8658.95670521648;8686.261667758232;8289.668413263462;8529.232369086782;8532.70135545256;8535.359848011409;8543.444676096065;1779.937702180424;2081.8646787958774;2193.4406726284774;2194.7805219478005;2439.5730747119183;2217.168561789329;2371.6086845670443;2461.729209786931;2464.199135281032;2471.4933438645035;2037.908294126768;2416.516696660666;2428.672129262545;2430.1858877276136;2433.841800282976;2420.576399130145;2421.2615152378517;2424.818138639609;2426.417659761662;2426.890789914449;2390.796782273509;2421.9273421797375;2424.9515009699708;2429.671994280767;2436.5248776488593;8651.005134409497;8655.307575393954;8752.431091979;8752.78118047054;8755.212030917184;4488.528704486047;5173.198154286091;5370.5435038021815;5375.516203541661;5427.240186373871;3423.4180189367867;3480.3387356402454;3644.2164934538937;3649.324874898126;3659.451082337644;1041.0890470838017;1045.1795340657623;1051.0645525482328;1054.3357684658693;1057.619257067455;11466.942665286704;11474.655760327203;11490.540378384854;11496.367699776509;11498.367589782558;4601.815927362935;4692.53074692528;4874.8537543873745;4887;4891.461939186686;9820.803583928424;9830.803383932282;9841.212702983745;9857.55640996157;9871.654492092743;5352.892942141136;5353.678779273256;5365.168398898177;5369.516743493026;5371.274877891513;4801.279808028754;4837.153498137882;4892.608591312686;4897;4910.975445122752;3950.7234493585174;4023.008610737645;4039.6970227233073;4081.428599996003;4087.7751723654887;1336.1916040795372;1336.2717319061135;1349.305107869448;1355.4578168732585;1364.7134101838526;1150.7871043856912;1301.6680746409604;1346.8787809097228;1354.7425989062046;1360.2450639894755;8047.275745182962;8142.674293028213;8146.307563857138;8184.468009579358;8235.629396677165;475.8168105279423;506.9391672999264;510.8978204359143;520.4457253025515;520.9062368773581;6159.5688301818445;6252.562320637512;6280.277768056732;6316.715747791269;6321.96839015802;10069.194464442828;10631.362118272773;10632.734181645521;10645.308054976402;10649.467526623637;9857.457839818879;10436.791264174826;10491.213159012952;10509.684709458728;10592.470376481146;7793.4154938378715;8066.23370779775;8089.555074470961;8102.432829701982;8108.108108108104;8044.477108987897;8218.137095605114;8284.58577071132;8287.212714792086;8296;9699;9712.125908668253;9815.509224538888;9843.901560984585;9863.063009014133;9712.368696035017;9878.802423951625;9974.202063834731;10001;10107.64623238183;7407;7495.213002634645;7558.962205188939;7596.126445458622;7610.467267291237;8150.470219435718;8189.590520473834;8226.0540037894;8251.422400432153;8260.710875119343;7319.304666056716;7433.10802703679;7501.32488076054;7560.470767046474;7585.431092667962;7208.423326134001;7269.854602907806;7311.23232060626;7475.4019678426685;7497.812554686177;7719.8070048247;7777.92222077772;7799.9220007799195;7809.92190078092;7814.648340824563;6911.550749201286;6968.338007889242;7048.894266585903;7088.716451341888;7105.609191494517;7100.893486597602;7137.393321567725;7186.856262874818;7188.317109874553;7193.604351760703 04:55:23 INFO - PROCESS | 1961 | |4;prototype.html;322.33759623972736;324.3043671325008;329.3511781789873;331.58551810237213;337.4061651493371;5938.673372964486;5987.281526216854;5987.730552125154;6015.187949626799;6095.116208149816;4950.405951285851;5177.974110129454;6016.849578760533;6022.578419510636;6029.547783916202;4144.461220041406;4249.660027197817;4366.541513141122;4391.890202744933;4559.726416415009;4509.954900451003;4522.5025247222775;4524.253498172798;4543.636509079282;4550.385697930787;3617.403128483797;4517.728936263835;4558.635309175274;4561.977190114045;4593.793279302439;4261.2329780639475;4328.5455027222315;4401.405810215612;4528.7056341337875;4563.7489938053395;3273.4598791199423;3675.8345874435713;3858.797198325411;3893;3923.7645741255615;5784.888515691742;5786.913196302059;5815.680137592431;5852.385499522574;5877.118432235156;4288.421063156465;4325.291509853621;4958.925616115761;5133.922991155136;5261.605379596507;5752.101806403918;6300.68496575174;6314.87370252597;6327.050942358637;6333.683315834236;3893.8459847523595;4236.597523235288;4242.342436922282;4243.7056697707185;4248.362745588156;6271.682946581223;6326.905096423558;6516.185476815398;6684.197896252481;6769.52613317068;4072.9796351018053;4086.0806318578084;4095.1809638072505;4095.672346212296;4109.198706252312;3520.577530696333;4193.391958166048;4195.734303476089;4350.151720414552;4382.912341753211;4856;5095.566876815438;5102.4897510248675;5116.744162791845;5134.871628209325;5893;6370.140031095835;6374;6448.290688024407;6472.514561407819;1280.9752198241556;1281.532240732126;1465.0184376467791;1486.2568715642178;1516.5601975427223;837.8114924142019;927.846905260638;932.396278401149;993.4039576254335;994.8855881573712;4997.375328083916;5691.060974939089;5908.05471124618;5977.342492325841;6001.549883758736;6273.811785646438;6541.215054193527;6596.899457255178;6608.43828274602;6609;5229.313334099451;5732.856678583069;5958.672273025025;5974.641521508724;5974.820755377345;3416.265502916885;3440.690337869554;3456.9110730119933;3465.081753335368;3473.5484387029524;5347.705876176769;6478.870422591522;6806.523543351917;6818.863322871435;6880.036794848726;6229;6264.310925798159;6465.224173099258;6733.360330768569;6756.83107922296;5666.433356664383;5717;6473.96416573346;6764.932350676529;6819.24988251292;5650.35020972577;6024.457798798129;6205.82089403012;6544.018397240452;6603.240627327918;5170.767315470737;6475.643839588868;6479.1901012373455;6535.771248006297;6571.474282057328;5696.829095127153;6454.580452270588;6467.514936379885;6580;6668.266490685924;4088.3867419887256;4217.114405974657;4270;4329.813444210654;4341.089920434999;6161.291451483136;6539.934600653933;6583.506237032338;6611.140551728245;6612.702428390638;5798.01433756254;5833.766649333979;6160.383961603804;6305.9684701578035;6356.936430635819;5715.542756579381;6185;6275.623462592076;6347.42873141401;6412.519061070345;6230.906536402048;6290.654014029273;6299.322787815252;6322.301453649667;6326.810195694136;5281.841544753664;5974.9402505974385;6372.713227904663;6453.128827608213;6456.225252969673;6014.6391216527145;6274.341194174546;6279.560430769802;6316.715747791269;6336.714847831767 04:55:23 INFO - PROCESS | 1961 | |5;yui.html;651.6220592056607;679.4055201698512;682.4574463301675;718.3391280022379;719.5682590445733;14862.702745945087;15267.022930528523;15324.923375383107;15355.923220383896;15358.155301458415;13967.231802250872;14021;14026.088304260216;14052;14078.22569758663;711.4521818199983;732.7105793211679;868.0668281597308;897.1970086772335;912.0469109780263;894.9328800339968;902.5171533229724;904.4663648447415;908.0193391137589;909.0409617853162;981.9410835349902;983.7540614846289;984.3404918704449;986.1519093579516;988.7231575158931;755.5655498088594;932.8973812880544;971.9805603887883;972.367960825462;972.3679608254691;717.9676914538858;721.5382155420535;721.570665454054;721.7365661533503;721.9386352160072;12185.390730463441;14889;14889.776653350209;14933.925330373278;14943.252837358088;12437.813432798515;12502.3748812559;12568.497260109585;12648.620541383772;12867.292298923556;9892.80214395708;10191.980801919823;10207.387556746618;10219.335743176669;10769.1009032181;3469.60099588548;3503.1421313009732;3554.2891421715503;3580.6777390034763;3618.095476130967;77069.99999999943;77306.22693773046;77561.61219193925;77689.22310776876;77705.61147194228;8241.8351632967;8721.651133954698;9543.570539325747;9613.279004074722;9882.901170988198;22510.77489225087;22512.887435562716;22698.205562805222;22731.318060458212;22747.09011639516;6639.336066393419;7469.253074692596;7608.771736847903;7648.73229436967;7666.9616651917495;4062.207869465426;4153.626173644326;4168.062186008185;4168.729032612931;4173.31140361843;3462.186386199241;3573.2317551726505;3577.195131095483;3577.6601222883783;3690.409534474471;587.7090840034125;681.1009467502848;694.2952902803659;695.9686814093378;709.3748758097178;438.6512722385711;565.799141304839;569.880046228031;608.5709574749791;610.5146408605169;7808.687652493837;8018.679252829821;8102.716404925799;8219.219174178443;8325.25072743456;512.7897561999562;575.3584753000374;578.5631847954767;604.8578584032749;622.6233128957007;3501.3172431376147;3882.320593896057;3938.350172221609;3958.940615890764;4056.8894871236375;93949;94459;95024.57463138059;96170.51914740521;96323.51838240903;79361;80155.19844801594;80620;80693.52717964529;80981.59509202416;68719;68928.6553567239;69362.30637693558;71806.64096679483;72485;7491.850162996819;7550.207228240955;7569.545827250383;7713.575753333621;7867.370610351272;41689.37465937953;43954;44375.77812111048;45277.64167074993;45885.082298353176;51069.74465127651;59346.81306373935;64991;65483.67258163869;65648;10417.270791044553;10627.628033018807;10747.247692661438;10844.96972787584;11020.173486988348;9348.737920380661;10852.837207441737;10919.672409827717;11368.488418021043;11915.285082895054;10225.233107517115;10336.896631033593;10358.378497290187;10562.577496900345;10688.144948403953;10478.553985307837;10688.839667405151;10785.083267922315;10812.45937703096;10908.781824363627;10126.848097278695;10311.175105991353;10316.381017138996;10577.36535807854;10591.046805787517;7174.67713952863;8950.731478055668;9355.672551460666;9400.435973841591;9778.706638800848;9128.361014729171;9305.581248843682;9413.952930235306;9475.336726429085;9481.573329200064 04:55:23 INFO - PROCESS | 1961 | __end_tp_report 04:55:23 INFO - PROCESS | 1961 | __start_cc_report 04:55:23 INFO - PROCESS | 1961 | _x_x_mozilla_cycle_collect,2254 04:55:23 INFO - PROCESS | 1961 | __end_cc_report 04:55:23 INFO - PROCESS | 1961 | __startTimestamp1460116523331__endTimestamp 04:55:23 INFO - PROCESS | 1961 | 04:55:23 INFO - PROCESS | 1961 | ------- Summary: start ------- 04:55:23 INFO - PROCESS | 1961 | Number of tests: 6 04:55:23 INFO - PROCESS | 1961 | 04:55:23 INFO - PROCESS | 1961 | [#0] dojo.html Cycles:165 Average:5726.08 Median:5934.47 stddev:645.24 (10.9%) stddev-sans-first:616.32 04:55:23 INFO - PROCESS | 1961 | Values: 3211.2 3449.7 3483.2 3483.9 3522.0 5114.1 5332.7 5620.7 5729.7 5742.9 5756.4 5790.5 5819.9 5897.3 5971.0 5137.5 5140.7 5160.8 5182.7 5252.9 5327.5 5338.7 5384.8 5404.6 5437.7 4307.5 5110.9 5229.8 5237.4 5251.2 4720.8 4877.6 5224.6 5266.4 5282.8 5177.6 5197.9 5220.7 5241.3 5259.5 5551.4 5618.5 5683.5 5718.5 5744.3 6226.0 6245.6 6246.0 6256.6 6257.7 5888.2 6222.4 6233.5 6250.6 6254.6 5038.8 5745.7 5764.5 5861.1 5873.0 6243.4 6260.5 6270.2 6274.4 6278.2 6102.8 6127.0 6172.7 6180.8 6181.5 6151.3 6211.3 6319.8 6320.9 6328.2 5285.9 6301.2 6303.6 6307.1 6313.3 6256.2 6311.0 6320.0 6321.3 6323.4 4893.0 4926.1 4973.6 4974.4 5035.2 4483.2 4530.9 4536.6 4538.9 4541.0 5637.0 5662.9 5738.3 5786.3 5792.6 6281.5 6288.6 6290.1 6311.0 6321.1 5753.3 5761.3 5765.4 5766.7 5807.7 5312.8 5379.3 5411.4 5445.9 5448.7 5773.9 5818.0 6242.1 6252.1 6256.8 4691.3 6201.4 6304.2 6308.4 6313.0 5326.8 6161.2 6209.7 6247.9 6307.9 6212.5 6236.7 6237.2 6242.8 6249.3 6296.6 6309.8 6310.9 6318.6 6330.5 5898.8 5934.7 6036.9 6090.4 6118.9 6072.4 6086.4 6119.2 6125.6 6128.0 5928.2 5934.5 5937.3 5953.9 5954.6 6056.2 6056.8 6077.4 6121.7 6140.4 5954.5 5995.8 6002.9 6009.2 6069.5 04:55:23 INFO - PROCESS | 1961 | 04:55:23 INFO - PROCESS | 1961 | [#1] ext.html Cycles:180 Average:58820.54 Median:206114.97 stddev:123292.31 (59.8%) stddev-sans-first:123560.43 04:55:23 INFO - PROCESS | 1961 | Values: 502.8 530.1 577.5 585.9 627.7 22905.9 35612.5 36860.8 37008.3 37146.8 38894.8 39334.8 39459.0 39511.4 39634.0 9444.5 9651.0 9651.9 9654.0 9657.7 9494.1 9612.2 9612.7 9615.8 9620.7 9569.5 9637.8 9640.4 9642.1 9649.7 9534.0 9621.0 9624.8 9628.0 9630.8 9530.4 9653.2 9653.2 9660.8 9661.2 38674.6 39059.0 39140.4 39148.2 39182.8 3151.6 3162.7 3341.5 3649.6 3797.1 26775.8 27550.4 28536.9 28677.9 28728.0 2738.8 2743.3 2761.3 2811.5 2844.9 419743.0 423704.0 423737.4 424028.0 424689.0 49542.3 50916.2 52464.2 53566.5 59008.1 58365.7 58605.7 58694.8 58780.2 59828.7 15148.8 15464.8 15491.8 15501.5 15517.2 10908.3 11972.2 11991.0 12108.3 12360.5 15299.8 15308.5 15332.6 15339.2 15491.9 5912.5 6852.3 7022.3 7079.1 7079.6 922.0 940.4 970.4 1050.2 1145.8 27606.3 27607.3 28313.9 28529.9 28579.0 1043.2 1067.6 1100.1 1158.4 1175.0 13331.3 13485.7 13873.9 13911.2 13941.4 559034.0 559982.0 569269.0 570250.0 570256.0 53725.7 54062.0 54167.7 54203.7 54317.7 1318.0 1334.9 1449.6 1450.4 1494.9 23333.8 26382.9 27581.9 28234.0 28970.4 45791.8 45800.3 46459.8 46462.0 46488.8 375083.1 378187.2 378651.0 379391.0 379935.0 22355.0 22841.7 24698.0 24872.9 25588.1 39569.0 39761.6 39932.6 41834.0 41961.0 29678.6 31295.7 34469.5 35493.5 35640.9 33859.5 34373.8 34433.1 35146.8 35182.0 34504.1 34703.3 34826.0 35373.8 35381.5 28993.4 30495.4 30617.7 30682.5 30740.9 22927.7 23059.8 23529.5 23547.4 23629.3 04:55:23 INFO - PROCESS | 1961 | 04:55:23 INFO - PROCESS | 1961 | [#2] jquery.html Cycles:180 Average:34059.40 Median:20971.47 stddev:99556.22 (474.7%) stddev-sans-first:99803.36 04:55:23 INFO - PROCESS | 1961 | Values: 364.8 395.3 396.4 397.1 403.6 14156.6 19415.6 19628.0 20305.6 20348.3 19885.4 19978.8 20069.6 20794.0 20800.4 5723.5 6017.7 6027.3 6028.7 6037.1 5555.3 5684.5 5993.6 6004.4 6018.8 3879.9 4110.6 5650.9 6010.7 6024.2 4710.6 5995.2 5998.5 6002.0 6005.2 5744.9 5784.4 5802.6 5807.3 5811.2 23433.5 24125.2 24211.8 24224.0 24541.6 1759.3 1994.3 2049.1 2073.5 2150.8 9490.0 9722.4 9896.0 10123.4 10198.2 1710.2 1722.1 1732.9 1776.7 1800.9 110244.0 114057.3 114266.0 115478.4 117289.4 9727.2 11355.7 11709.6 11748.2 11869.9 14923.8 15056.9 15065.4 15097.0 15141.0 8187.5 8359.5 8408.4 8456.5 8463.9 8078.3 8090.5 8166.3 8198.1 8221.3 3782.3 4480.6 4547.3 4559.1 4615.8 1918.1 1983.7 1988.2 1989.4 2020.3 691.6 732.2 811.0 906.6 954.2 19099.3 19467.9 19793.7 19808.6 19915.4 820.6 928.6 940.4 953.1 990.8 9478.5 10142.9 10186.2 10194.3 10198.0 514792.0 598413.0 619093.2 622913.0 623832.0 123222.2 123612.4 124584.0 125852.3 135486.6 1006.4 1027.0 1028.2 1046.6 1047.3 16081.8 16654.6 16667.7 17028.6 17404.0 38160.6 45407.3 48111.8 48398.5 49175.0 68827.3 71275.6 71598.0 71732.9 72335.6 5299.0 5375.1 7873.5 7986.5 8252.5 11142.9 11887.4 11895.5 12087.6 12524.4 9749.2 10577.9 10855.8 11059.5 11130.3 9968.2 10624.9 10764.4 10963.9 11147.8 6624.0 8769.0 9442.1 9754.7 11133.7 7979.6 8184.6 8208.3 8244.3 8245.8 10536.1 10648.0 10938.8 10948.3 10990.7 04:55:23 INFO - PROCESS | 1961 | 04:55:23 INFO - PROCESS | 1961 | [#3] mootools.html Cycles:180 Average:6006.70 Median:5367.34 stddev:3182.21 (59.3%) stddev-sans-first:3172.31 04:55:23 INFO - PROCESS | 1961 | Values: 1402.4 1588.3 1593.4 1853.2 1990.0 7773.8 8433.2 8657.2 8659.0 8686.3 8289.7 8529.2 8532.7 8535.4 8543.4 1779.9 2081.9 2193.4 2194.8 2439.6 2217.2 2371.6 2461.7 2464.2 2471.5 2037.9 2416.5 2428.7 2430.2 2433.8 2420.6 2421.3 2424.8 2426.4 2426.9 2390.8 2421.9 2425.0 2429.7 2436.5 8651.0 8655.3 8752.4 8752.8 8755.2 4488.5 5173.2 5370.5 5375.5 5427.2 3423.4 3480.3 3644.2 3649.3 3659.5 1041.1 1045.2 1051.1 1054.3 1057.6 11466.9 11474.7 11490.5 11496.4 11498.4 4601.8 4692.5 4874.9 4887.0 4891.5 9820.8 9830.8 9841.2 9857.6 9871.7 5352.9 5353.7 5365.2 5369.5 5371.3 4801.3 4837.2 4892.6 4897.0 4911.0 3950.7 4023.0 4039.7 4081.4 4087.8 1336.2 1336.3 1349.3 1355.5 1364.7 1150.8 1301.7 1346.9 1354.7 1360.2 8047.3 8142.7 8146.3 8184.5 8235.6 475.8 506.9 510.9 520.4 520.9 6159.6 6252.6 6280.3 6316.7 6322.0 10069.2 10631.4 10632.7 10645.3 10649.5 9857.5 10436.8 10491.2 10509.7 10592.5 7793.4 8066.2 8089.6 8102.4 8108.1 8044.5 8218.1 8284.6 8287.2 8296.0 9699.0 9712.1 9815.5 9843.9 9863.1 9712.4 9878.8 9974.2 10001.0 10107.6 7407.0 7495.2 7559.0 7596.1 7610.5 8150.5 8189.6 8226.1 8251.4 8260.7 7319.3 7433.1 7501.3 7560.5 7585.4 7208.4 7269.9 7311.2 7475.4 7497.8 7719.8 7777.9 7799.9 7809.9 7814.6 6911.6 6968.3 7048.9 7088.7 7105.6 7100.9 7137.4 7186.9 7188.3 7193.6 04:55:23 INFO - PROCESS | 1961 | 04:55:23 INFO - PROCESS | 1961 | [#4] prototype.html Cycles:180 Average:5111.51 Median:5864.75 stddev:1611.79 (27.5%) stddev-sans-first:1575.72 04:55:23 INFO - PROCESS | 1961 | Values: 322.3 324.3 329.4 331.6 337.4 5938.7 5987.3 5987.7 6015.2 6095.1 4950.4 5178.0 6016.8 6022.6 6029.5 4144.5 4249.7 4366.5 4391.9 4559.7 4510.0 4522.5 4524.3 4543.6 4550.4 3617.4 4517.7 4558.6 4562.0 4593.8 4261.2 4328.5 4401.4 4528.7 4563.7 3273.5 3675.8 3858.8 3893.0 3923.8 5784.9 5786.9 5815.7 5852.4 5877.1 4288.4 4325.3 4958.9 5133.9 5261.6 5752.1 6300.7 6314.9 6327.1 6333.7 3893.8 4236.6 4242.3 4243.7 4248.4 6271.7 6326.9 6516.2 6684.2 6769.5 4073.0 4086.1 4095.2 4095.7 4109.2 3520.6 4193.4 4195.7 4350.2 4382.9 4856.0 5095.6 5102.5 5116.7 5134.9 5893.0 6370.1 6374.0 6448.3 6472.5 1281.0 1281.5 1465.0 1486.3 1516.6 837.8 927.8 932.4 993.4 994.9 4997.4 5691.1 5908.1 5977.3 6001.5 6273.8 6541.2 6596.9 6608.4 6609.0 5229.3 5732.9 5958.7 5974.6 5974.8 3416.3 3440.7 3456.9 3465.1 3473.5 5347.7 6478.9 6806.5 6818.9 6880.0 6229.0 6264.3 6465.2 6733.4 6756.8 5666.4 5717.0 6474.0 6764.9 6819.2 5650.4 6024.5 6205.8 6544.0 6603.2 5170.8 6475.6 6479.2 6535.8 6571.5 5696.8 6454.6 6467.5 6580.0 6668.3 4088.4 4217.1 4270.0 4329.8 4341.1 6161.3 6539.9 6583.5 6611.1 6612.7 5798.0 5833.8 6160.4 6306.0 6356.9 5715.5 6185.0 6275.6 6347.4 6412.5 6230.9 6290.7 6299.3 6322.3 6326.8 5281.8 5974.9 6372.7 6453.1 6456.2 6014.6 6274.3 6279.6 6316.7 6336.7 04:55:23 INFO - PROCESS | 1961 | 04:55:23 INFO - PROCESS | 1961 | [#5] yui.html Cycles:180 Average:17881.69 Median:32806.81 stddev:25441.69 (77.6%) stddev-sans-first:25480.17 04:55:23 INFO - PROCESS | 1961 | Values: 651.6 679.4 682.5 718.3 719.6 14862.7 15267.0 15324.9 15355.9 15358.2 13967.2 14021.0 14026.1 14052.0 14078.2 711.5 732.7 868.1 897.2 912.0 894.9 902.5 904.5 908.0 909.0 981.9 983.8 984.3 986.2 988.7 755.6 932.9 972.0 972.4 972.4 718.0 721.5 721.6 721.7 721.9 12185.4 14889.0 14889.8 14933.9 14943.3 12437.8 12502.4 12568.5 12648.6 12867.3 9892.8 10192.0 10207.4 10219.3 10769.1 3469.6 3503.1 3554.3 3580.7 3618.1 77070.0 77306.2 77561.6 77689.2 77705.6 8241.8 8721.7 9543.6 9613.3 9882.9 22510.8 22512.9 22698.2 22731.3 22747.1 6639.3 7469.3 7608.8 7648.7 7667.0 4062.2 4153.6 4168.1 4168.7 4173.3 3462.2 3573.2 3577.2 3577.7 3690.4 587.7 681.1 694.3 696.0 709.4 438.7 565.8 569.9 608.6 610.5 7808.7 8018.7 8102.7 8219.2 8325.3 512.8 575.4 578.6 604.9 622.6 3501.3 3882.3 3938.4 3958.9 4056.9 93949.0 94459.0 95024.6 96170.5 96323.5 79361.0 80155.2 80620.0 80693.5 80981.6 68719.0 68928.7 69362.3 71806.6 72485.0 7491.9 7550.2 7569.5 7713.6 7867.4 41689.4 43954.0 44375.8 45277.6 45885.1 51069.7 59346.8 64991.0 65483.7 65648.0 10417.3 10627.6 10747.2 10845.0 11020.2 9348.7 10852.8 10919.7 11368.5 11915.3 10225.2 10336.9 10358.4 10562.6 10688.1 10478.6 10688.8 10785.1 10812.5 10908.8 10126.8 10311.2 10316.4 10577.4 10591.0 7174.7 8950.7 9355.7 9400.4 9778.7 9128.4 9305.6 9414.0 9475.3 9481.6 04:55:23 INFO - PROCESS | 1961 | -------- Summary: end -------- 04:55:23 INFO - PROCESS | 1961 | 04:55:23 INFO - TEST-INFO | 1961: exit 0 04:55:23 INFO - TEST-OK | dromaeo_css | took 1114666ms 04:55:23 INFO - TEST-START | kraken 04:55:23 INFO - operating with platform_type : mac_ 04:55:23 INFO - Initialising browser for kraken test... 04:55:23 INFO - TEST-INFO | started process 1965 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpi5hFwS/profile http://localhost:50808/getInfo.html) 04:55:26 INFO - PROCESS | 1965 | __metrics Screen width/height:1600/1200 04:55:26 INFO - PROCESS | 1965 | colorDepth:24 04:55:26 INFO - PROCESS | 1965 | Browser inner width/height: 1024/689 04:55:26 INFO - PROCESS | 1965 | __metrics 04:55:26 INFO - PROCESS | 1965 | 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" 04:55:26 ERROR - PROCESS | 1965 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:55:26 INFO - TEST-INFO | 1965: exit 0 04:55:26 INFO - Browser initialized. 04:55:26 INFO - Running cycle 1/1 for kraken test... 04:55:26 INFO - TEST-INFO | started process 1967 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpi5hFwS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:55:38 INFO - PROCESS | 1967 | RSS: Main: 237494272 04:55:38 INFO - PROCESS | 1967 | 04:55:41 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50808/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50808/tests/kraken/driver.html?testName=audio-beat-detection) 04:55:42 INFO - PROCESS | 1967 | RSS: Main: 283750400 04:55:42 INFO - PROCESS | 1967 | 04:55:44 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50808/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50808/tests/kraken/driver.html?testName=audio-dft) 04:55:45 INFO - PROCESS | 1967 | RSS: Main: 294203392 04:55:45 INFO - PROCESS | 1967 | 04:55:48 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50808/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50808/tests/kraken/driver.html?testName=audio-fft) 04:55:49 INFO - PROCESS | 1967 | RSS: Main: 279523328 04:55:49 INFO - PROCESS | 1967 | 04:55:51 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50808/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50808/tests/kraken/driver.html?testName=audio-oscillator) 04:55:51 INFO - PROCESS | 1967 | RSS: Main: 282284032 04:55:51 INFO - PROCESS | 1967 | 04:55:53 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50808/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50808/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:55:54 INFO - PROCESS | 1967 | RSS: Main: 283406336 04:55:54 INFO - PROCESS | 1967 | 04:55:57 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50808/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50808/tests/kraken/driver.html?testName=imaging-darkroom) 04:55:58 INFO - PROCESS | 1967 | RSS: Main: 283590656 04:55:58 INFO - PROCESS | 1967 | 04:56:00 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50808/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50808/tests/kraken/driver.html?testName=imaging-desaturate) 04:56:01 INFO - PROCESS | 1967 | RSS: Main: 283738112 04:56:01 INFO - PROCESS | 1967 | 04:56:04 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50808/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50808/tests/kraken/driver.html?testName=json-parse-financial) 04:56:04 INFO - PROCESS | 1967 | RSS: Main: 284319744 04:56:04 INFO - PROCESS | 1967 | 04:56:06 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50808/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50808/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:56:06 INFO - PROCESS | 1967 | RSS: Main: 318816256 04:56:06 INFO - PROCESS | 1967 | 04:56:08 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50808/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50808/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:56:09 INFO - PROCESS | 1967 | RSS: Main: 318705664 04:56:09 INFO - PROCESS | 1967 | 04:56:11 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50808/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50808/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:56:12 INFO - PROCESS | 1967 | RSS: Main: 324464640 04:56:12 INFO - PROCESS | 1967 | 04:56:14 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50808/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50808/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:56:15 INFO - PROCESS | 1967 | RSS: Main: 325558272 04:56:15 INFO - PROCESS | 1967 | 04:56:18 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50808/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50808/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:56:19 INFO - PROCESS | 1967 | RSS: Main: 325500928 04:56:19 INFO - PROCESS | 1967 | 04:56:20 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50808/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50808/tests/kraken/driver.html?testName=ai-astar) 04:56:21 INFO - PROCESS | 1967 | RSS: Main: 389750784 04:56:21 INFO - PROCESS | 1967 | 04:56:21 INFO - PROCESS | 1967 | __start_tp_report 04:56:21 INFO - PROCESS | 1967 | _x_x_mozilla_page_load 04:56:21 INFO - PROCESS | 1967 | _x_x_mozilla_page_load_details 04:56:21 INFO - PROCESS | 1967 | |i|pagename|runs| 04:56:21 INFO - PROCESS | 1967 | |0;ai-astar;113;111;113;113;114;115;118;113;112;114 04:56:21 INFO - PROCESS | 1967 | |1;audio-beat-detection;183;154;166;162;123;141;162;121;164;120 04:56:21 INFO - PROCESS | 1967 | |2;audio-dft;185;184;188;187;186;186;183;183;181;182 04:56:21 INFO - PROCESS | 1967 | |3;audio-fft;74;74;83;79;55;76;88;83;79;56 04:56:21 INFO - PROCESS | 1967 | |4;audio-oscillator;99;89;128;79;78;81;113;80;79;117 04:56:21 INFO - PROCESS | 1967 | |5;imaging-gaussian-blur;86;83;87;85;87;85;77;71;117;129 04:56:21 INFO - PROCESS | 1967 | |6;imaging-darkroom;92;93;93;95;92;93;94;94;105;150 04:56:21 INFO - PROCESS | 1967 | |7;imaging-desaturate;82;85;84;85;85;84;84;85;87;87 04:56:21 INFO - PROCESS | 1967 | |8;json-parse-financial;56;55;54;53;52;55;55;67;55;53 04:56:21 INFO - PROCESS | 1967 | |9;json-stringify-tinderbox;63;62;74;76;71;69;69;69;69;70 04:56:21 INFO - PROCESS | 1967 | |10;stanford-crypto-aes;87;86;84;85;83;87;83;84;85;86 04:56:21 INFO - PROCESS | 1967 | |11;stanford-crypto-ccm;146;145;149;154;158;140;141;141;145;143 04:56:21 INFO - PROCESS | 1967 | |12;stanford-crypto-pbkdf2;174;172;175;170;167;215;178;174;217;200 04:56:21 INFO - PROCESS | 1967 | |13;stanford-crypto-sha256-iterative;68;68;70;68;67;69;67;69;70;68 04:56:21 INFO - PROCESS | 1967 | __end_tp_report 04:56:21 INFO - PROCESS | 1967 | __start_cc_report 04:56:21 INFO - PROCESS | 1967 | _x_x_mozilla_cycle_collect,1306 04:56:21 INFO - PROCESS | 1967 | __end_cc_report 04:56:21 INFO - PROCESS | 1967 | __startTimestamp1460116581179__endTimestamp 04:56:21 INFO - PROCESS | 1967 | 04:56:21 INFO - PROCESS | 1967 | ------- Summary: start ------- 04:56:21 INFO - PROCESS | 1967 | Number of tests: 14 04:56:21 INFO - PROCESS | 1967 | 04:56:21 INFO - PROCESS | 1967 | [#0] ai-astar Cycles:10 Average:113.60 Median:113.50 stddev:1.90 (1.7%) stddev-sans-first:2.00 04:56:21 INFO - PROCESS | 1967 | Values: 113.0 111.0 113.0 113.0 114.0 115.0 118.0 113.0 112.0 114.0 04:56:21 INFO - PROCESS | 1967 | 04:56:21 INFO - PROCESS | 1967 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:162.00 stddev:22.10 (13.6%) stddev-sans-first:19.86 04:56:21 INFO - PROCESS | 1967 | Values: 183.0 154.0 166.0 162.0 123.0 141.0 162.0 121.0 164.0 120.0 04:56:21 INFO - PROCESS | 1967 | 04:56:21 INFO - PROCESS | 1967 | [#2] audio-dft Cycles:10 Average:184.50 Median:185.50 stddev:2.27 (1.2%) stddev-sans-first:2.40 04:56:21 INFO - PROCESS | 1967 | Values: 185.0 184.0 188.0 187.0 186.0 186.0 183.0 183.0 181.0 182.0 04:56:21 INFO - PROCESS | 1967 | 04:56:21 INFO - PROCESS | 1967 | [#3] audio-fft Cycles:10 Average:74.70 Median:79.00 stddev:11.02 (13.9%) stddev-sans-first:11.68 04:56:21 INFO - PROCESS | 1967 | Values: 74.0 74.0 83.0 79.0 55.0 76.0 88.0 83.0 79.0 56.0 04:56:21 INFO - PROCESS | 1967 | 04:56:21 INFO - PROCESS | 1967 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:79.50 stddev:18.76 (23.6%) stddev-sans-first:19.82 04:56:21 INFO - PROCESS | 1967 | Values: 99.0 89.0 128.0 79.0 78.0 81.0 113.0 80.0 79.0 117.0 04:56:21 INFO - PROCESS | 1967 | 04:56:21 INFO - PROCESS | 1967 | [#5] imaging-gaussian-blur Cycles:10 Average:90.70 Median:85.00 stddev:17.98 (21.1%) stddev-sans-first:18.99 04:56:21 INFO - PROCESS | 1967 | Values: 86.0 83.0 87.0 85.0 87.0 85.0 77.0 71.0 117.0 129.0 04:56:21 INFO - PROCESS | 1967 | 04:56:21 INFO - PROCESS | 1967 | [#6] imaging-darkroom Cycles:10 Average:100.10 Median:93.00 stddev:17.94 (19.3%) stddev-sans-first:18.79 04:56:21 INFO - PROCESS | 1967 | Values: 92.0 93.0 93.0 95.0 92.0 93.0 94.0 94.0 105.0 150.0 04:56:21 INFO - PROCESS | 1967 | 04:56:21 INFO - PROCESS | 1967 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:1.48 (1.7%) stddev-sans-first:1.17 04:56:21 INFO - PROCESS | 1967 | Values: 82.0 85.0 84.0 85.0 85.0 84.0 84.0 85.0 87.0 87.0 04:56:21 INFO - PROCESS | 1967 | 04:56:21 INFO - PROCESS | 1967 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.00 stddev:4.22 (7.7%) stddev-sans-first:4.48 04:56:21 INFO - PROCESS | 1967 | Values: 56.0 55.0 54.0 53.0 52.0 55.0 55.0 67.0 55.0 53.0 04:56:21 INFO - PROCESS | 1967 | 04:56:21 INFO - PROCESS | 1967 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.50 stddev:4.26 (6.1%) stddev-sans-first:3.89 04:56:21 INFO - PROCESS | 1967 | Values: 63.0 62.0 74.0 76.0 71.0 69.0 69.0 69.0 69.0 70.0 04:56:21 INFO - PROCESS | 1967 | 04:56:21 INFO - PROCESS | 1967 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.50 stddev:1.49 (1.7%) stddev-sans-first:1.39 04:56:21 INFO - PROCESS | 1967 | Values: 87.0 86.0 84.0 85.0 83.0 87.0 83.0 84.0 85.0 86.0 04:56:21 INFO - PROCESS | 1967 | 04:56:21 INFO - PROCESS | 1967 | [#11] stanford-crypto-ccm Cycles:10 Average:146.20 Median:145.50 stddev:5.90 (4.1%) stddev-sans-first:6.26 04:56:21 INFO - PROCESS | 1967 | Values: 146.0 145.0 149.0 154.0 158.0 140.0 141.0 141.0 145.0 143.0 04:56:21 INFO - PROCESS | 1967 | 04:56:21 INFO - PROCESS | 1967 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.20 Median:176.50 stddev:19.01 (10.8%) stddev-sans-first:19.80 04:56:21 INFO - PROCESS | 1967 | Values: 174.0 172.0 175.0 170.0 167.0 215.0 178.0 174.0 217.0 200.0 04:56:21 INFO - PROCESS | 1967 | 04:56:21 INFO - PROCESS | 1967 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.07 (1.6%) stddev-sans-first:1.13 04:56:21 INFO - PROCESS | 1967 | Values: 68.0 68.0 70.0 68.0 67.0 69.0 67.0 69.0 70.0 68.0 04:56:21 INFO - PROCESS | 1967 | -------- Summary: end -------- 04:56:21 INFO - PROCESS | 1967 | 04:56:21 INFO - TEST-INFO | 1967: exit 0 04:56:22 INFO - TEST-OK | kraken | took 58090ms 04:56:22 INFO - SUITE-END | took 1172s 04:56:22 INFO - Completed test suite (00:19:33) 04:56:22 INFO - javascript benchmark 04:56:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3211.2453573410253, 3449.655034496551, 3483.2336885885097, 3483.912902177445, 3521.9786261984027, 5114.130597798374, 5332.666833291672, 5620.718964051791, 5729.6848673323, 5742.913856292159, 5756.424357564241, 5790.536757059435, 5819.88360232794, 5897.262842144732, 5971.0, 5137.537621614054, 5140.742962851861, 5160.793568257265, 5182.740862956856, 5252.894942101156, 5327.493888080626, 5338.652987555796, 5384.7846086156505, 5404.594655400841, 5437.673739575618, 4307.547707490731, 5110.948890511103, 5229.790808367661, 5237.423883372826, 5251.159814429711, 4720.772599124218, 4877.585405240558, 5224.634275600672, 5266.420693723688, 5282.788688452457, 5177.611679124043, 5197.8960420791755, 5220.686758794484, 5241.318628578299, 5259.474052594748, 5551.417101204396, 5618.494335509783, 5683.4600712932615, 5718.513926316268, 5744.253247077853, 6226.034964580497, 6245.56281060326, 6246.0, 6256.610852775065, 6257.655828929453, 5888.205092312526, 6222.377762223787, 6233.501319894398, 6250.562460627758, 6254.562180647356, 5038.798448062036, 5745.683987380692, 5764.452377024218, 5861.0915308127305, 5873.0, 6243.406876346739, 6260.499160067275, 6270.184875966095, 6274.403931626488, 6278.152449419361, 6102.786402475892, 6127.0, 6172.69136543171, 6180.81457556274, 6181.536384771161, 6151.323354431009, 6211.3167551569295, 6319.810405687745, 6320.936790632127, 6328.177336946167, 5285.916387140627, 6301.212348456443, 6303.590266632654, 6307.085472606446, 6313.305536390993, 6256.155419018465, 6311.021791622214, 6320.0, 6321.273053598803, 6323.399277068671, 4892.972475780126, 4926.1379258629595, 4973.626977976666, 4974.353334066548, 5035.219540971156, 4483.170613436525, 4530.886727831765, 4536.56902594253, 4538.88652783683, 4541.0, 5637.0, 5662.943370566324, 5738.2540269765495, 5786.334571524244, 5792.623479473821, 6281.466075383552, 6288.591241569284, 6290.056491526308, 6311.021791622214, 6321.051842223703, 5753.252077229933, 5761.308642962871, 5765.423457654201, 5766.654000759884, 5807.738651760681, 5312.76092575835, 5379.327584051994, 5411.431799661058, 5445.891082178334, 5448.673079615157, 5773.88452230953, 5817.981853175677, 6242.094896239929, 6252.124702541648, 6256.843578910563, 4691.343211950261, 6201.410865967726, 6304.211973503312, 6308.432241098323, 6313.021481670348, 5326.840194794162, 6161.229846269216, 6209.689515524296, 6247.9062814056915, 6307.873842523216, 6212.502999759918, 6236.65698386575, 6237.1891654084675, 6242.781502647567, 6249.25008998923, 6296.622202667854, 6309.779157729457, 6310.905336419865, 6318.589291696025, 6330.461910737639, 5898.8230353089475, 5934.732937017759, 6036.9094463582205, 6090.3605121461605, 6118.877622447437, 6072.423119803611, 6086.391360863879, 6119.204503414528, 6125.571210015256, 6127.969360153171, 5928.199693041557, 5934.465898069195, 5937.317208521075, 5953.910691339547, 5954.612950158225, 6056.182415373868, 6056.820793652542, 6077.4226448487325, 6121.666376154927, 6140.381550880894, 5954.46409823118, 5995.790147344822, 6002.87994240104, 6009.188759517409, 6069.544784141119], "value": 5687.159524255997, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.7536507111515, 530.0564994310126, 577.5091172503371, 585.932617748959, 627.6861569215392, 22905.885470572666, 35612.465813012794, 36860.81569592155, 37008.259834803284, 37146.81426592863, 38894.833155005326, 39334.803325983405, 39459.0, 39511.40732889002, 39634.0, 9444.480553569569, 9651.034896510362, 9651.855222171673, 9653.951730241339, 9657.661981830637, 9494.145526902577, 9612.18296444803, 9612.663556775515, 9615.759606009835, 9620.663276785313, 9569.521523923811, 9637.807243855119, 9640.421574705506, 9642.13220810127, 9649.710508684751, 9533.952330238339, 9621.037896210393, 9624.807503849885, 9628.0, 9630.759231019245, 9530.428174309563, 9653.17947974423, 9653.22774178064, 9660.75848103796, 9661.178799802025, 38674.613253867385, 39059.02352441183, 39140.41289380661, 39148.21703565913, 39182.80408597939, 3151.6375616803903, 3162.7153556180056, 3341.4820702791108, 3649.59854416014, 3797.126660867988, 26775.79276017211, 27550.44899102007, 28536.85852565895, 28677.85661071681, 28727.994520191693, 2738.794590405708, 2743.27303264633, 2761.295869553271, 2811.46582149393, 2844.8862045518154, 419743.0, 423704.0, 423737.38888722216, 424028.0, 424689.0, 49542.293482119865, 50916.236256456184, 52464.21303680448, 53566.464335356926, 59008.11487827686, 58365.70817145887, 58605.70697146487, 58694.82610347769, 58780.24027236837, 59828.70085649544, 15148.772768408482, 15464.768028479582, 15491.845081549265, 15501.457448989231, 15517.224138793015, 10908.34549927007, 11972.16194866351, 11991.04071674264, 12108.273503589813, 12360.505579776709, 15299.847001529843, 15308.464203752816, 15332.616684582752, 15339.233038348038, 15491.915565910504, 5912.526997840162, 6852.280510546321, 7022.332878376546, 7079.115110611174, 7079.575225486487, 921.9815603687889, 940.4028441939417, 970.4327511069572, 1050.2070936442938, 1145.7980767316458, 27606.309842254104, 27607.30981725473, 28313.86744530237, 28529.858805647957, 28579.0, 1043.160255993917, 1067.594314160614, 1100.0979197058334, 1158.415000424797, 1174.9941250293864, 13331.33343332849, 13485.730285394433, 13873.86126138746, 13911.234882081582, 13941.372638231303, 559034.0, 559982.0, 569269.0, 570250.0, 570256.0, 53725.731371342896, 54062.0, 54167.72916135394, 54203.72898135563, 54317.72841135769, 1317.967050823737, 1334.8932085432948, 1449.5868677426884, 1450.4053338131316, 1494.9327280272414, 23333.76666233316, 26382.868085659447, 27581.862090689418, 28234.0, 28970.42059158847, 45791.77104114591, 45800.312995305765, 46459.83850403767, 46462.0, 46488.83777905444, 375083.12458437536, 378187.2181278262, 378651.0, 379391.0, 379935.0, 22355.0, 22841.657375139053, 24698.0, 24872.87563562243, 25588.104416345337, 39569.0, 39761.60238397695, 39932.600673992885, 41834.0, 41960.95097622584, 29678.55482167726, 31295.687043129277, 34469.48295775515, 35493.467597986564, 35640.87182563446, 33859.4921076189, 34373.82813085918, 34433.13917152091, 35146.82426587851, 35182.0, 34504.13739656529, 34703.30593388169, 34826.0, 35373.82313088418, 35381.46927796137, 28993.42013159767, 30495.390092198475, 30617.693823062375, 30682.53161529489, 30740.92406765842, 22927.65608515907, 23059.769402305763, 23529.529409412058, 23547.41131471727, 23629.29112126639], "value": 18477.378547224565, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.8321771984887, 395.2628348130736, 396.3519645379805, 397.11138238884564, 403.6145481065583, 14156.560298938224, 19415.61168776627, 19628.0, 20305.593888122246, 20348.287809926656, 19885.40916726662, 19978.800211997914, 20069.598608027867, 20794.0, 20800.375988720363, 5723.51350135239, 6017.729202185912, 6027.336992930774, 6028.728707208164, 6037.064255040454, 5555.250041244421, 5684.488396044355, 5993.580449368546, 6004.42957918997, 6018.849528761794, 3879.8836034919, 4110.6300432961025, 5650.858728531778, 6010.699465026732, 6024.186734790813, 4710.623150148014, 5995.190649262359, 5998.460138587527, 6002.039673652238, 6005.219321488178, 5744.942550574524, 5784.392638772911, 5802.5938184327115, 5807.332156801937, 5811.157382179603, 23433.531329373487, 24125.155619553232, 24211.7578824213, 24224.0, 24541.63187552188, 1759.3402474072223, 1994.3418671838258, 2049.1291201239565, 2073.4919944613516, 2150.7526634436927, 9490.0, 9722.416655000723, 9895.950520247425, 10123.392596444164, 10198.235132365027, 1710.1534740303505, 1722.0786879019665, 1732.9220185091574, 1776.6624341375098, 1800.8739388242827, 110244.0, 114057.28914066295, 114266.0, 115478.42260788642, 117289.41355293168, 9727.173190278905, 11355.659330220107, 11709.590164344378, 11748.236364636272, 11869.881301186877, 14923.776143357858, 15056.94601377915, 15065.397384104514, 15097.0, 15141.0, 8187.4678145920325, 8359.456635318686, 8408.411411201158, 8456.534890581077, 8463.884028992752, 8078.272955434039, 8090.514569125871, 8166.265036146775, 8198.098209196984, 8221.260086592116, 3782.319182547113, 4480.619147372445, 4547.272436410159, 4559.088182363541, 4615.792289346988, 1918.1368384227153, 1983.6627773278578, 1988.1550341104974, 1989.4330115916894, 2020.282799606148, 691.5643144818832, 732.1982429239973, 810.9837803243902, 906.6237511432681, 954.2413781044087, 19099.331523396613, 19467.929263890623, 19793.703094453595, 19808.60382792336, 19915.402537923885, 820.5651004967377, 928.5960607135918, 940.3981451870808, 953.1231267234161, 990.7671697151163, 9478.478683672463, 10142.898571014342, 10186.185105191567, 10194.286399951932, 10198.0, 514792.0, 598413.0, 619093.199492142, 622913.0, 623832.0, 123222.15166772506, 123612.38193808973, 124584.0, 125852.30255428392, 135486.64513354938, 1006.3710181136789, 1027.04997876962, 1028.1517747858047, 1046.6075221791828, 1047.3140093238787, 16081.839181608035, 16654.583635409213, 16667.74998375001, 17028.574285642957, 17404.0, 38160.61839381682, 45407.318890217335, 48111.75944120257, 48398.5160148394, 49175.0, 68827.31172688409, 71275.57448850891, 71598.0, 71732.9240061389, 72335.63832180806, 5298.97350513245, 5375.059364611256, 7873.488223265469, 7986.480878743096, 8252.504849709037, 11142.888571114185, 11887.405629718307, 11895.464704088165, 12087.576934807239, 12524.436400362189, 9749.171320437843, 10577.9471102644, 10855.78288434211, 11059.50232239535, 11130.276532025393, 9968.152707019985, 10624.946875265574, 10764.3541387517, 10963.890361096286, 11147.777044458902, 6623.966880165568, 8768.956155219183, 9442.10300021497, 9754.707358779247, 11133.665990020312, 7979.601019948863, 8184.590770461572, 8208.302294305051, 8244.258016778518, 8245.83508329842, 10536.051755342056, 10648.0, 10938.835917461403, 10948.288361256493, 10990.725231869268], "value": 9156.587414694088, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1402.3759427054965, 1588.2535208452032, 1593.3865461797209, 1853.2123847364867, 1990.0, 7773.766786996385, 8433.156684331563, 8657.220850123487, 8658.95670521648, 8686.261667758232, 8289.668413263462, 8529.232369086782, 8532.70135545256, 8535.359848011409, 8543.444676096065, 1779.937702180424, 2081.8646787958774, 2193.4406726284774, 2194.7805219478005, 2439.5730747119183, 2217.168561789329, 2371.6086845670443, 2461.729209786931, 2464.199135281032, 2471.4933438645035, 2037.908294126768, 2416.516696660666, 2428.672129262545, 2430.1858877276136, 2433.841800282976, 2420.576399130145, 2421.2615152378517, 2424.818138639609, 2426.417659761662, 2426.890789914449, 2390.796782273509, 2421.9273421797375, 2424.9515009699708, 2429.671994280767, 2436.5248776488593, 8651.005134409497, 8655.307575393954, 8752.431091979, 8752.78118047054, 8755.212030917184, 4488.528704486047, 5173.198154286091, 5370.5435038021815, 5375.516203541661, 5427.240186373871, 3423.4180189367867, 3480.3387356402454, 3644.2164934538937, 3649.324874898126, 3659.451082337644, 1041.0890470838017, 1045.1795340657623, 1051.0645525482328, 1054.3357684658693, 1057.619257067455, 11466.942665286704, 11474.655760327203, 11490.540378384854, 11496.367699776509, 11498.367589782558, 4601.815927362935, 4692.53074692528, 4874.8537543873745, 4887.0, 4891.461939186686, 9820.803583928424, 9830.803383932282, 9841.212702983745, 9857.55640996157, 9871.654492092743, 5352.892942141136, 5353.678779273256, 5365.168398898177, 5369.516743493026, 5371.274877891513, 4801.279808028754, 4837.153498137882, 4892.608591312686, 4897.0, 4910.975445122752, 3950.7234493585174, 4023.008610737645, 4039.6970227233073, 4081.428599996003, 4087.7751723654887, 1336.1916040795372, 1336.2717319061135, 1349.305107869448, 1355.4578168732585, 1364.7134101838526, 1150.7871043856912, 1301.6680746409604, 1346.8787809097228, 1354.7425989062046, 1360.2450639894755, 8047.275745182962, 8142.674293028213, 8146.307563857138, 8184.468009579358, 8235.629396677165, 475.8168105279423, 506.9391672999264, 510.8978204359143, 520.4457253025515, 520.9062368773581, 6159.5688301818445, 6252.562320637512, 6280.277768056732, 6316.715747791269, 6321.96839015802, 10069.194464442828, 10631.362118272773, 10632.734181645521, 10645.308054976402, 10649.467526623637, 9857.457839818879, 10436.791264174826, 10491.213159012952, 10509.684709458728, 10592.470376481146, 7793.4154938378715, 8066.23370779775, 8089.555074470961, 8102.432829701982, 8108.108108108104, 8044.477108987897, 8218.137095605114, 8284.58577071132, 8287.212714792086, 8296.0, 9699.0, 9712.125908668253, 9815.509224538888, 9843.901560984585, 9863.063009014133, 9712.368696035017, 9878.802423951625, 9974.202063834731, 10001.0, 10107.64623238183, 7407.0, 7495.213002634645, 7558.962205188939, 7596.126445458622, 7610.467267291237, 8150.470219435718, 8189.590520473834, 8226.0540037894, 8251.422400432153, 8260.710875119343, 7319.304666056716, 7433.10802703679, 7501.32488076054, 7560.470767046474, 7585.431092667962, 7208.423326134001, 7269.854602907806, 7311.23232060626, 7475.4019678426685, 7497.812554686177, 7719.8070048247, 7777.92222077772, 7799.9220007799195, 7809.92190078092, 7814.648340824563, 6911.550749201286, 6968.338007889242, 7048.894266585903, 7088.716451341888, 7105.609191494517, 7100.893486597602, 7137.393321567725, 7186.856262874818, 7188.317109874553, 7193.604351760703], "value": 4806.283403522332, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.33759623972736, 324.3043671325008, 329.3511781789873, 331.58551810237213, 337.4061651493371, 5938.673372964486, 5987.281526216854, 5987.730552125154, 6015.187949626799, 6095.116208149816, 4950.405951285851, 5177.974110129454, 6016.849578760533, 6022.578419510636, 6029.547783916202, 4144.461220041406, 4249.660027197817, 4366.541513141122, 4391.890202744933, 4559.726416415009, 4509.954900451003, 4522.5025247222775, 4524.253498172798, 4543.636509079282, 4550.385697930787, 3617.403128483797, 4517.728936263835, 4558.635309175274, 4561.977190114045, 4593.793279302439, 4261.2329780639475, 4328.5455027222315, 4401.405810215612, 4528.7056341337875, 4563.7489938053395, 3273.4598791199423, 3675.8345874435713, 3858.797198325411, 3893.0, 3923.7645741255615, 5784.888515691742, 5786.913196302059, 5815.680137592431, 5852.385499522574, 5877.118432235156, 4288.421063156465, 4325.291509853621, 4958.925616115761, 5133.922991155136, 5261.605379596507, 5752.101806403918, 6300.68496575174, 6314.87370252597, 6327.050942358637, 6333.683315834236, 3893.8459847523595, 4236.597523235288, 4242.342436922282, 4243.7056697707185, 4248.362745588156, 6271.682946581223, 6326.905096423558, 6516.185476815398, 6684.197896252481, 6769.52613317068, 4072.9796351018053, 4086.0806318578084, 4095.1809638072505, 4095.672346212296, 4109.198706252312, 3520.577530696333, 4193.391958166048, 4195.734303476089, 4350.151720414552, 4382.912341753211, 4856.0, 5095.566876815438, 5102.4897510248675, 5116.744162791845, 5134.871628209325, 5893.0, 6370.140031095835, 6374.0, 6448.290688024407, 6472.514561407819, 1280.9752198241556, 1281.532240732126, 1465.0184376467791, 1486.2568715642178, 1516.5601975427223, 837.8114924142019, 927.846905260638, 932.396278401149, 993.4039576254335, 994.8855881573712, 4997.375328083916, 5691.060974939089, 5908.05471124618, 5977.342492325841, 6001.549883758736, 6273.811785646438, 6541.215054193527, 6596.899457255178, 6608.43828274602, 6609.0, 5229.313334099451, 5732.856678583069, 5958.672273025025, 5974.641521508724, 5974.820755377345, 3416.265502916885, 3440.690337869554, 3456.9110730119933, 3465.081753335368, 3473.5484387029524, 5347.705876176769, 6478.870422591522, 6806.523543351917, 6818.863322871435, 6880.036794848726, 6229.0, 6264.310925798159, 6465.224173099258, 6733.360330768569, 6756.83107922296, 5666.433356664383, 5717.0, 6473.96416573346, 6764.932350676529, 6819.24988251292, 5650.35020972577, 6024.457798798129, 6205.82089403012, 6544.018397240452, 6603.240627327918, 5170.767315470737, 6475.643839588868, 6479.1901012373455, 6535.771248006297, 6571.474282057328, 5696.829095127153, 6454.580452270588, 6467.514936379885, 6580.0, 6668.266490685924, 4088.3867419887256, 4217.114405974657, 4270.0, 4329.813444210654, 4341.089920434999, 6161.291451483136, 6539.934600653933, 6583.506237032338, 6611.140551728245, 6612.702428390638, 5798.01433756254, 5833.766649333979, 6160.383961603804, 6305.9684701578035, 6356.936430635819, 5715.542756579381, 6185.0, 6275.623462592076, 6347.42873141401, 6412.519061070345, 6230.906536402048, 6290.654014029273, 6299.322787815252, 6322.301453649667, 6326.810195694136, 5281.841544753664, 5974.9402505974385, 6372.713227904663, 6453.128827608213, 6456.225252969673, 6014.6391216527145, 6274.341194174546, 6279.560430769802, 6316.715747791269, 6336.714847831767], "value": 4584.587022912447, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.6220592056607, 679.4055201698512, 682.4574463301675, 718.3391280022379, 719.5682590445733, 14862.702745945087, 15267.022930528523, 15324.923375383107, 15355.923220383896, 15358.155301458415, 13967.231802250872, 14021.0, 14026.088304260216, 14052.0, 14078.22569758663, 711.4521818199983, 732.7105793211679, 868.0668281597308, 897.1970086772335, 912.0469109780263, 894.9328800339968, 902.5171533229724, 904.4663648447415, 908.0193391137589, 909.0409617853162, 981.9410835349902, 983.7540614846289, 984.3404918704449, 986.1519093579516, 988.7231575158931, 755.5655498088594, 932.8973812880544, 971.9805603887883, 972.367960825462, 972.3679608254691, 717.9676914538858, 721.5382155420535, 721.570665454054, 721.7365661533503, 721.9386352160072, 12185.390730463441, 14889.0, 14889.776653350209, 14933.925330373278, 14943.252837358088, 12437.813432798515, 12502.3748812559, 12568.497260109585, 12648.620541383772, 12867.292298923556, 9892.80214395708, 10191.980801919823, 10207.387556746618, 10219.335743176669, 10769.1009032181, 3469.60099588548, 3503.1421313009732, 3554.2891421715503, 3580.6777390034763, 3618.095476130967, 77069.99999999943, 77306.22693773046, 77561.61219193925, 77689.22310776876, 77705.61147194228, 8241.8351632967, 8721.651133954698, 9543.570539325747, 9613.279004074722, 9882.901170988198, 22510.77489225087, 22512.887435562716, 22698.205562805222, 22731.318060458212, 22747.09011639516, 6639.336066393419, 7469.253074692596, 7608.771736847903, 7648.73229436967, 7666.9616651917495, 4062.207869465426, 4153.626173644326, 4168.062186008185, 4168.729032612931, 4173.31140361843, 3462.186386199241, 3573.2317551726505, 3577.195131095483, 3577.6601222883783, 3690.409534474471, 587.7090840034125, 681.1009467502848, 694.2952902803659, 695.9686814093378, 709.3748758097178, 438.6512722385711, 565.799141304839, 569.880046228031, 608.5709574749791, 610.5146408605169, 7808.687652493837, 8018.679252829821, 8102.716404925799, 8219.219174178443, 8325.25072743456, 512.7897561999562, 575.3584753000374, 578.5631847954767, 604.8578584032749, 622.6233128957007, 3501.3172431376147, 3882.320593896057, 3938.350172221609, 3958.940615890764, 4056.8894871236375, 93949.0, 94459.0, 95024.57463138059, 96170.51914740521, 96323.51838240903, 79361.0, 80155.19844801594, 80620.0, 80693.52717964529, 80981.59509202416, 68719.0, 68928.6553567239, 69362.30637693558, 71806.64096679483, 72485.0, 7491.850162996819, 7550.207228240955, 7569.545827250383, 7713.575753333621, 7867.370610351272, 41689.37465937953, 43954.0, 44375.77812111048, 45277.64167074993, 45885.082298353176, 51069.74465127651, 59346.81306373935, 64991.0, 65483.67258163869, 65648.0, 10417.270791044553, 10627.628033018807, 10747.247692661438, 10844.96972787584, 11020.173486988348, 9348.737920380661, 10852.837207441737, 10919.672409827717, 11368.488418021043, 11915.285082895054, 10225.233107517115, 10336.896631033593, 10358.378497290187, 10562.577496900345, 10688.144948403953, 10478.553985307837, 10688.839667405151, 10785.083267922315, 10812.45937703096, 10908.781824363627, 10126.848097278695, 10311.175105991353, 10316.381017138996, 10577.36535807854, 10591.046805787517, 7174.67713952863, 8950.731478055668, 9355.672551460666, 9400.435973841591, 9778.706638800848, 9128.361014729171, 9305.581248843682, 9413.952930235306, 9475.336726429085, 9481.573329200064], "value": 6753.691699063168, "unit": "score"}], "name": "dromaeo_css", "value": 7233.127345636122, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 113.0, 113.0, 114.0, 115.0, 118.0, 113.0, 112.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 154.0, 166.0, 162.0, 123.0, 141.0, 162.0, 121.0, 164.0, 120.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 188.0, 187.0, 186.0, 186.0, 183.0, 183.0, 181.0, 182.0], "value": 184.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 83.0, 79.0, 55.0, 76.0, 88.0, 83.0, 79.0, 56.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 89.0, 128.0, 79.0, 78.0, 81.0, 113.0, 80.0, 79.0, 117.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 87.0, 85.0, 87.0, 85.0, 77.0, 71.0, 117.0, 129.0], "value": 90.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 93.0, 95.0, 92.0, 93.0, 94.0, 94.0, 105.0, 150.0], "value": 100.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 84.0, 85.0, 85.0, 84.0, 84.0, 85.0, 87.0, 87.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 53.0, 52.0, 55.0, 55.0, 67.0, 55.0, 53.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 74.0, 76.0, 71.0, 69.0, 69.0, 69.0, 69.0, 70.0], "value": 69.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 84.0, 85.0, 83.0, 87.0, 83.0, 84.0, 85.0, 86.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 149.0, 154.0, 158.0, 140.0, 141.0, 141.0, 145.0, 143.0], "value": 146.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 172.0, 175.0, 170.0, 167.0, 215.0, 178.0, 174.0, 217.0, 200.0], "value": 184.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 70.0, 68.0, 67.0, 69.0, 67.0, 69.0, 70.0, 68.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1500.8000000000002, "alertThreshold": 2.0}]} 04:56:22 INFO - Return code: 0 04:56:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:56:22 ERROR - # TBPL SUCCESS # 04:56:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:56:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:56:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:56:22 INFO - 2016-04-08 04:56:22.521 screenresolution[1971:14846] starting screenresolution argv=screenresolution get 04:56:22 INFO - 2016-04-08 04:56:22.524 screenresolution[1971:14846] Display 0: 1600x1200x32@60 04:56:22 INFO - 2016-04-08 04:56:22.530 screenresolution[1972:14849] starting screenresolution argv=screenresolution list 04:56:22 INFO - Available Modes on Display 0 04:56:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:56:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:56:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:56:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:56:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:56:22 INFO - Intel Iris: 04:56:22 INFO - Chipset Model: Intel Iris 04:56:22 INFO - Type: GPU 04:56:22 INFO - Bus: Built-In 04:56:22 INFO - VRAM (Dynamic, Max): 1536 MB 04:56:22 INFO - Vendor: Intel (0x8086) 04:56:22 INFO - Device ID: 0x0a2e 04:56:22 INFO - Revision ID: 0x0009 04:56:22 INFO - Displays: 04:56:22 INFO - Display: 04:56:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:56:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:56:22 INFO - Display Serial Number: 1600x1200 60 04:56:22 INFO - Main Display: Yes 04:56:22 INFO - Mirror: Off 04:56:22 INFO - Online: Yes 04:56:22 INFO - Rotation: Supported 04:56:22 INFO - Return code: 0 04:56:22 INFO - Running post-action listener: _resource_record_post_action 04:56:22 INFO - Running post-run listener: _resource_record_post_run 04:56:23 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 499712; Write bytes: 694605824; Read time: 6; Write time: 2091 04:56:23 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 381118976; Write bytes: 374970368; Read time: 28258; Write time: 878 04:56:23 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 499712; Write bytes: 300064768; Read time: 6; Write time: 1171 04:56:23 INFO - Running post-run listener: _upload_blobber_files 04:56:23 INFO - Blob upload gear active. 04:56:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:56:23 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 04:56:23 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'] 04:56:23 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 04:56:24 INFO - (blobuploader) - INFO - Open directory for files ... 04:56:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:56:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:56:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:25 INFO - (blobuploader) - INFO - Done attempting. 04:56:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:56:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:56:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:26 INFO - (blobuploader) - INFO - Done attempting. 04:56:26 INFO - (blobuploader) - INFO - Iteration through files over. 04:56:26 INFO - Return code: 0 04:56:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:56:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:56:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d881807779811f00264a1d81bcfa34037698c3505f59e0748602c571e8afb643ced11157907201dc8ef8d23733e2bdb1ece95ae0712b0750b60a0f6af0f0cc2f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cdc88a680b4fd33ab9ea84c0d755d397c19c97fc5058eb6c2f2bf53d9941433a24b15e0e68db0abe4f2b8ee5257bd681b0496c830f0a7bb0c51cf207bf16aa4a"} 04:56:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:56:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:56:26 INFO - Contents: 04:56:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d881807779811f00264a1d81bcfa34037698c3505f59e0748602c571e8afb643ced11157907201dc8ef8d23733e2bdb1ece95ae0712b0750b60a0f6af0f0cc2f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cdc88a680b4fd33ab9ea84c0d755d397c19c97fc5058eb6c2f2bf53d9941433a24b15e0e68db0abe4f2b8ee5257bd681b0496c830f0a7bb0c51cf207bf16aa4a"} 04:56:26 INFO - Running post-run listener: copy_logs_to_upload_dir 04:56:26 INFO - Copying logs to upload dir... 04:56:26 INFO - mkdir: /builds/slave/test/build/upload/logs 04:56:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.472299 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-04-08 04:56:26.439574) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 04:56:26.443565) ========= 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.xmhui2pWE2/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.xS5PsSLCmJ/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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/d881807779811f00264a1d81bcfa34037698c3505f59e0748602c571e8afb643ced11157907201dc8ef8d23733e2bdb1ece95ae0712b0750b60a0f6af0f0cc2f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cdc88a680b4fd33ab9ea84c0d755d397c19c97fc5058eb6c2f2bf53d9941433a24b15e0e68db0abe4f2b8ee5257bd681b0496c830f0a7bb0c51cf207bf16aa4a"} build_url:https://queue.taskcluster.net/v1/task/HA7E95dtSVyTnZMFdLv_5w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011415 build_url: 'https://queue.taskcluster.net/v1/task/HA7E95dtSVyTnZMFdLv_5w/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/d881807779811f00264a1d81bcfa34037698c3505f59e0748602c571e8afb643ced11157907201dc8ef8d23733e2bdb1ece95ae0712b0750b60a0f6af0f0cc2f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cdc88a680b4fd33ab9ea84c0d755d397c19c97fc5058eb6c2f2bf53d9941433a24b15e0e68db0abe4f2b8ee5257bd681b0496c830f0a7bb0c51cf207bf16aa4a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 04:56:26.476567) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:56:26.477193) ========= 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.xmhui2pWE2/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.xS5PsSLCmJ/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.005377 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:56:26.526786) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 04:56:26.527106) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 04:56:26.527494) ========= ========= Total master_lag: 1.13 =========