builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0132 starttime: 1456399681.53 results: success (0) buildid: 20160225015135 builduid: 14832b8aa5f048e190b8e6a4bb5f306e revision: 5db80ec25d4688fc6b76e39ba9baed18b1b14b78 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 03:28:01.534255) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 03:28:01.534744) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 03:28:01.535101) ========= 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.uUWUvOpbek/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.3k9Pj5M48A/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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.005752 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 03:28:01.561606) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 03:28:01.562230) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 03:28:01.581082) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:28:01.581400) ========= 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.uUWUvOpbek/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.3k9Pj5M48A/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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.005825 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:28:01.630008) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 03:28:01.630381) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 03:28:01.630814) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:28:01.631138) ========= 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.uUWUvOpbek/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.3k9Pj5M48A/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-25 03:28:01-- 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% 165M=0s 2016-02-25 03:28:01 (165 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.152366 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:28:01.799556) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:28:01.799949) ========= 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.uUWUvOpbek/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.3k9Pj5M48A/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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.025009 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:28:01.849097) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:28:01.849520) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5db80ec25d4688fc6b76e39ba9baed18b1b14b78 --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 5db80ec25d4688fc6b76e39ba9baed18b1b14b78 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uUWUvOpbek/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.3k9Pj5M48A/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-25 03:28:01,919 truncating revision to first 12 chars 2016-02-25 03:28:01,919 Setting DEBUG logging. 2016-02-25 03:28:01,919 attempt 1/10 2016-02-25 03:28:01,919 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5db80ec25d46?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-25 03:28:02,193 unpacking tar archive at: fx-team-5db80ec25d46/testing/mozharness/ program finished with exit code 0 elapsedTime=0.527110 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:28:02.393183) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 03:28:02.393561) ========= echo 5db80ec25d4688fc6b76e39ba9baed18b1b14b78 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5db80ec25d4688fc6b76e39ba9baed18b1b14b78'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uUWUvOpbek/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.3k9Pj5M48A/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 5db80ec25d4688fc6b76e39ba9baed18b1b14b78 program finished with exit code 0 elapsedTime=0.005249 script_repo_revision: '5db80ec25d4688fc6b76e39ba9baed18b1b14b78' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 03:28:02.444093) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 03:28:02.444721) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 03:28:02.458758) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-25 03:28:02.459094) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uUWUvOpbek/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.3k9Pj5M48A/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 03:28:02 INFO - MultiFileLogger online at 20160225 03:28:02 in /builds/slave/test 03:28:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 03:28:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:28:02 INFO - {'append_to_log': False, 03:28:02 INFO - 'base_work_dir': '/builds/slave/test', 03:28:02 INFO - 'blob_upload_branch': 'Fx-Team', 03:28:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:28:02 INFO - 'branch': 'Fx-Team', 03:28:02 INFO - 'buildbot_json_path': 'buildprops.json', 03:28:02 INFO - 'config_files': ('talos/mac_config.py',), 03:28:02 INFO - 'default_actions': ('clobber', 03:28:02 INFO - 'read-buildbot-config', 03:28:02 INFO - 'download-and-extract', 03:28:02 INFO - 'populate-webroot', 03:28:02 INFO - 'create-virtualenv', 03:28:02 INFO - 'install', 03:28:02 INFO - 'run-tests'), 03:28:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:28:02 INFO - 'download_minidump_stackwalk': True, 03:28:02 INFO - 'download_symbols': 'ondemand', 03:28:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:28:02 INFO - 'tooltool.py': '/tools/tooltool.py', 03:28:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:28:02 INFO - '/tools/misc-python/virtualenv.py')}, 03:28:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:28:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:28:02 INFO - 'installer_path': 'installer.exe', 03:28:02 INFO - 'log_level': 'info', 03:28:02 INFO - 'log_name': 'talos', 03:28:02 INFO - 'log_to_console': True, 03:28:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:28:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:28:02 INFO - 'opt_config_files': (), 03:28:02 INFO - 'pip_index': False, 03:28:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:28:02 INFO - 'cmd': ('bash', 03:28:02 INFO - '-c', 03:28:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:28:02 INFO - 'enabled': True, 03:28:02 INFO - 'halt_on_failure': False, 03:28:02 INFO - 'name': 'check_screen_resolution'},), 03:28:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:28:02 INFO - 'cmd': ('bash', 03:28:02 INFO - '-c', 03:28:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:28:02 INFO - 'enabled': True, 03:28:02 INFO - 'halt_on_failure': False, 03:28:02 INFO - 'name': 'check_screen_resolution'},), 03:28:02 INFO - 'run_cmd_checks_enabled': True, 03:28:02 INFO - 'sps_profile': False, 03:28:02 INFO - 'sps_profile_interval': 0, 03:28:02 INFO - 'suite': 'dromaeojs-e10s', 03:28:02 INFO - 'system_bits': '32', 03:28:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:28:02 INFO - 'title': 't-yosemite-r7-0132', 03:28:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:28:02 INFO - 'use_talos_json': True, 03:28:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:28:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:28:02 INFO - 'work_dir': 'build'} 03:28:02 INFO - ##### 03:28:02 INFO - ##### Running clobber step. 03:28:02 INFO - ##### 03:28:02 INFO - Running pre-action listener: _resource_record_pre_action 03:28:02 INFO - Running main action method: clobber 03:28:02 INFO - rmtree: /builds/slave/test/build 03:28:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:28:04 INFO - Running post-action listener: _resource_record_post_action 03:28:04 INFO - ##### 03:28:04 INFO - ##### Running read-buildbot-config step. 03:28:04 INFO - ##### 03:28:04 INFO - Running pre-action listener: _resource_record_pre_action 03:28:04 INFO - Running main action method: read_buildbot_config 03:28:04 INFO - Using buildbot properties: 03:28:04 INFO - { 03:28:04 INFO - "project": "", 03:28:04 INFO - "product": "firefox", 03:28:04 INFO - "script_repo_revision": "production", 03:28:04 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 03:28:04 INFO - "repository": "", 03:28:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 03:28:04 INFO - "buildid": "20160225015135", 03:28:04 INFO - "pgo_build": "False", 03:28:04 INFO - "basedir": "/builds/slave/test", 03:28:04 INFO - "buildnumber": 453, 03:28:04 INFO - "slavename": "t-yosemite-r7-0132", 03:28:04 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 03:28:04 INFO - "platform": "yosemite_r7", 03:28:04 INFO - "scheduler": "tests-fx-team-macosx64-talos", 03:28:04 INFO - "branch": "fx-team", 03:28:04 INFO - "repo_path": "integration/fx-team", 03:28:04 INFO - "revision": "5db80ec25d4688fc6b76e39ba9baed18b1b14b78", 03:28:04 INFO - "stage_platform": "macosx64", 03:28:04 INFO - "builduid": "14832b8aa5f048e190b8e6a4bb5f306e", 03:28:04 INFO - "slavebuilddir": "test" 03:28:04 INFO - } 03:28:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 03:28:04 INFO - Running post-action listener: _resource_record_post_action 03:28:04 INFO - ##### 03:28:04 INFO - ##### Running download-and-extract step. 03:28:04 INFO - ##### 03:28:04 INFO - Running pre-action listener: _resource_record_pre_action 03:28:04 INFO - Running main action method: download_and_extract 03:28:04 INFO - mkdir: /builds/slave/test/build/tests 03:28:04 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')]} 03:28:04 INFO - https://queue.taskcluster.net/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:28:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/test_packages.json 03:28:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/test_packages.json 03:28:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:28:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:28:05 INFO - Downloaded 1277 bytes. 03:28:05 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:28:05 INFO - Using the following test package requirements: 03:28:05 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 03:28:05 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:28:05 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 03:28:05 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:28:05 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 03:28:05 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:28:05 INFO - u'jsshell-mac.zip'], 03:28:05 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:28:05 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 03:28:05 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 03:28:05 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:28:05 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 03:28:05 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:28:05 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 03:28:05 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:28:05 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 03:28:05 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 03:28:05 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:28:05 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 03:28:05 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:28: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')]} 03:28:05 INFO - https://queue.taskcluster.net/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:28:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:28:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:28:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:28:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:28:06 INFO - Downloaded 17828705 bytes. 03:28:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:28:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:28:09 INFO - Return code: 0 03:28:09 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:28: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')]} 03:28:09 INFO - https://queue.taskcluster.net/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:28:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:28:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:28:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:28:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:28:10 INFO - Downloaded 17828705 bytes. 03:28:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:28:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:28:13 INFO - Return code: 0 03:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:13 INFO - https://queue.taskcluster.net/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:28:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 03:28:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 03:28:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 03:28:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:28:14 INFO - Downloaded 10707015 bytes. 03:28:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:28:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 03:28:14 INFO - Return code: 0 03:28:14 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')]} 03:28:14 INFO - https://queue.taskcluster.net/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:28:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:28:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:28:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 03:28:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 03:28:17 INFO - Downloaded 111416900 bytes. 03:28:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:28:17 INFO - mkdir: /builds/slave/test/properties 03:28:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:28:17 INFO - Writing to file /builds/slave/test/properties/build_url 03:28:17 INFO - Contents: 03:28:17 INFO - build_url:https://queue.taskcluster.net/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:28:18 INFO - Running post-action listener: _resource_record_post_action 03:28:18 INFO - Running post-action listener: set_extra_try_arguments 03:28:18 INFO - ##### 03:28:18 INFO - ##### Running populate-webroot step. 03:28:18 INFO - ##### 03:28:18 INFO - Running pre-action listener: _resource_record_pre_action 03:28:18 INFO - Running main action method: populate_webroot 03:28:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:28:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:28:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:28:18 INFO - '--tppagecycles', 03:28:18 INFO - '7'], 03:28:18 INFO - 'tests': ['tsvgm']}}, 03:28:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:28:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:28:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:28:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:28:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:28:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:28:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:18 INFO - 'talos_options': ['--e10s'], 03:28:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:18 INFO - 'tests': ['damp', 'tps']}, 03:28:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:18 INFO - 'talos_options': ['--e10s'], 03:28:18 INFO - 'tests': ['damp', 'tps']}, 03:28:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:28:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:28:18 INFO - 'other': {'tests': ['a11yr', 03:28:18 INFO - 'ts_paint', 03:28:18 INFO - 'tpaint', 03:28:18 INFO - 'sessionrestore', 03:28:18 INFO - 'sessionrestore_no_auto_restore']}, 03:28:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:28:18 INFO - 'tests': ['a11yr', 03:28:18 INFO - 'ts_paint', 03:28:18 INFO - 'tpaint', 03:28:18 INFO - 'sessionrestore', 03:28:18 INFO - 'sessionrestore_no_auto_restore']}, 03:28:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:28:18 INFO - 'tests': ['a11yr', 03:28:18 INFO - 'ts_paint', 03:28:18 INFO - 'tpaint', 03:28:18 INFO - 'sessionrestore', 03:28:18 INFO - 'sessionrestore_no_auto_restore']}, 03:28:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:28:18 INFO - 'tests': ['a11yr', 03:28:18 INFO - 'ts_paint', 03:28:18 INFO - 'tpaint', 03:28:18 INFO - 'sessionrestore', 03:28:18 INFO - 'sessionrestore_no_auto_restore']}, 03:28:18 INFO - 'other_l64': {'tests': ['a11yr', 03:28:18 INFO - 'ts_paint', 03:28:18 INFO - 'tpaint', 03:28:18 INFO - 'sessionrestore', 03:28:18 INFO - 'sessionrestore_no_auto_restore']}, 03:28:18 INFO - 'other_nol64': {'tests': ['a11yr', 03:28:18 INFO - 'ts_paint', 03:28:18 INFO - 'tpaint', 03:28:18 INFO - 'sessionrestore', 03:28:18 INFO - 'sessionrestore_no_auto_restore']}, 03:28:18 INFO - 'svgr': {'tests': ['tsvgx', 03:28:18 INFO - 'tsvgr_opacity', 03:28:18 INFO - 'tart', 03:28:18 INFO - 'tscrollx', 03:28:18 INFO - 'cart']}, 03:28:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:28:18 INFO - 'tests': ['tsvgx', 03:28:18 INFO - 'tsvgr_opacity', 03:28:18 INFO - 'tart', 03:28:18 INFO - 'tscrollx', 03:28:18 INFO - 'cart']}, 03:28:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:18 INFO - 'tests': ['tp5o']}, 03:28:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:18 INFO - 'talos_options': ['--e10s'], 03:28:18 INFO - 'tests': ['tp5o']}, 03:28:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:18 INFO - 'talos_options': ['--xperf_path', 03:28:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:18 INFO - 'tests': ['tp5n']}, 03:28:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:18 INFO - 'talos_options': ['--e10s', 03:28:18 INFO - '--xperf_path', 03:28:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:18 INFO - 'tests': ['tp5n']}}, 03:28:18 INFO - 'talos.zip': {'path': '', 03:28:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:28:18 INFO - Running post-action listener: _resource_record_post_action 03:28:18 INFO - ##### 03:28:18 INFO - ##### Running create-virtualenv step. 03:28:18 INFO - ##### 03:28:18 INFO - Running pre-action listener: _resource_record_pre_action 03:28:18 INFO - Running main action method: create_virtualenv 03:28:18 INFO - Creating virtualenv /builds/slave/test/build/venv 03:28:18 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 03:28:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:28:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:28:19 INFO - Using real prefix '/tools/python27' 03:28:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:28:19 INFO - Installing distribute.............................................................................................................................................................................................done. 03:28:22 INFO - Installing pip.................done. 03:28:22 INFO - Return code: 0 03:28:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:28:22 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')]} 03:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:22 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')]} 03:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:22 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 0x1040c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040ce4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff271dd0d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f6bd30>, '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 0x103d8fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f62b20>, '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.uUWUvOpbek/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.3k9Pj5M48A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 03:28:22 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 03:28:22 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 03:28:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uUWUvOpbek/Render', 03:28:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:22 INFO - 'HOME': '/Users/cltbld', 03:28:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:22 INFO - 'LOGNAME': 'cltbld', 03:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:22 INFO - 'MOZ_NO_REMOTE': '1', 03:28:22 INFO - 'NO_EM_RESTART': '1', 03:28:22 INFO - 'PAGER': '/bin/cat', 03:28:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:22 INFO - 'PWD': '/builds/slave/test', 03:28:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:22 INFO - 'SHELL': '/bin/bash', 03:28:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3k9Pj5M48A/Listeners', 03:28:22 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 03:28:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:22 INFO - 'USER': 'cltbld', 03:28:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:22 INFO - 'XPC_FLAGS': '0x0', 03:28:22 INFO - 'XPC_SERVICE_NAME': '0', 03:28:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:22 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 03:28:22 INFO - Cleaning up... 03:28:22 INFO - Return code: 0 03:28:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:28:22 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')]} 03:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:22 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')]} 03:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:22 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 0x1040c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040ce4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff271dd0d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f6bd30>, '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 0x103d8fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f62b20>, '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.uUWUvOpbek/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.3k9Pj5M48A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 03:28:22 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 03:28:22 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 03:28:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uUWUvOpbek/Render', 03:28:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:22 INFO - 'HOME': '/Users/cltbld', 03:28:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:22 INFO - 'LOGNAME': 'cltbld', 03:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:22 INFO - 'MOZ_NO_REMOTE': '1', 03:28:22 INFO - 'NO_EM_RESTART': '1', 03:28:22 INFO - 'PAGER': '/bin/cat', 03:28:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:22 INFO - 'PWD': '/builds/slave/test', 03:28:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:22 INFO - 'SHELL': '/bin/bash', 03:28:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3k9Pj5M48A/Listeners', 03:28:22 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 03:28:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:22 INFO - 'USER': 'cltbld', 03:28:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:22 INFO - 'XPC_FLAGS': '0x0', 03:28:22 INFO - 'XPC_SERVICE_NAME': '0', 03:28:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:23 INFO - Downloading/unpacking psutil>=0.7.1 03:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:28:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:26 INFO - Installing collected packages: psutil 03:28:26 INFO - Running setup.py install for psutil 03:28:26 INFO - building 'psutil._psutil_osx' extension 03:28:26 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 03:28:26 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 03:28:26 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 03:28:26 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 03:28:26 INFO - building 'psutil._psutil_posix' extension 03:28:26 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 03:28:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:28:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:28:27 INFO - ^ 03:28:27 INFO - 1 warning generated. 03:28:27 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 03:28:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:27 INFO - Successfully installed psutil 03:28:27 INFO - Cleaning up... 03:28:27 INFO - Return code: 0 03:28:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:28:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1040c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040ce4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff271dd0d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f6bd30>, '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 0x103d8fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f62b20>, '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.uUWUvOpbek/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.3k9Pj5M48A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 03:28:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:28:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:28:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uUWUvOpbek/Render', 03:28:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:27 INFO - 'HOME': '/Users/cltbld', 03:28:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:27 INFO - 'LOGNAME': 'cltbld', 03:28:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:27 INFO - 'MOZ_NO_REMOTE': '1', 03:28:27 INFO - 'NO_EM_RESTART': '1', 03:28:27 INFO - 'PAGER': '/bin/cat', 03:28:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:27 INFO - 'PWD': '/builds/slave/test', 03:28:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:27 INFO - 'SHELL': '/bin/bash', 03:28:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3k9Pj5M48A/Listeners', 03:28:27 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 03:28:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:27 INFO - 'USER': 'cltbld', 03:28:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:27 INFO - 'XPC_FLAGS': '0x0', 03:28:27 INFO - 'XPC_SERVICE_NAME': '0', 03:28:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:28:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:28:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:28:29 INFO - Installing collected packages: mozsystemmonitor 03:28:29 INFO - Running setup.py install for mozsystemmonitor 03:28:30 INFO - Successfully installed mozsystemmonitor 03:28:30 INFO - Cleaning up... 03:28:30 INFO - Return code: 0 03:28:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:30 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 0x1040c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040ce4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff271dd0d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f6bd30>, '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 0x103d8fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f62b20>, '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.uUWUvOpbek/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.3k9Pj5M48A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 03:28:30 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 03:28:30 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 03:28:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uUWUvOpbek/Render', 03:28:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:30 INFO - 'HOME': '/Users/cltbld', 03:28:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:30 INFO - 'LOGNAME': 'cltbld', 03:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:30 INFO - 'MOZ_NO_REMOTE': '1', 03:28:30 INFO - 'NO_EM_RESTART': '1', 03:28:30 INFO - 'PAGER': '/bin/cat', 03:28:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:30 INFO - 'PWD': '/builds/slave/test', 03:28:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:30 INFO - 'SHELL': '/bin/bash', 03:28:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3k9Pj5M48A/Listeners', 03:28:30 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 03:28:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:30 INFO - 'USER': 'cltbld', 03:28:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:30 INFO - 'XPC_FLAGS': '0x0', 03:28:30 INFO - 'XPC_SERVICE_NAME': '0', 03:28:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:30 INFO - Downloading/unpacking blobuploader==1.2.4 03:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:32 INFO - Downloading blobuploader-1.2.4.tar.gz 03:28:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:28:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:28:32 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 03:28:32 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 03:28:32 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 03:28:32 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 03:28:32 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 03:28:32 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 03:28:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:28:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:28:33 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 03:28:33 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 03:28:33 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 03:28:33 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 03:28:33 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 03:28:33 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 03:28:33 INFO - Downloading docopt-0.6.1.tar.gz 03:28:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:28:34 INFO - Installing collected packages: blobuploader, requests, docopt 03:28:34 INFO - Running setup.py install for blobuploader 03:28:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:28:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:28:34 INFO - Running setup.py install for requests 03:28:34 INFO - Running setup.py install for docopt 03:28:34 INFO - Successfully installed blobuploader requests docopt 03:28:34 INFO - Cleaning up... 03:28:34 INFO - Return code: 0 03:28:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28: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')]} 03:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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')]} 03:28:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:34 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 0x1040c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040ce4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff271dd0d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f6bd30>, '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 0x103d8fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f62b20>, '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.uUWUvOpbek/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.3k9Pj5M48A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 03:28:34 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 03:28:34 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 03:28:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uUWUvOpbek/Render', 03:28:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:34 INFO - 'HOME': '/Users/cltbld', 03:28:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:34 INFO - 'LOGNAME': 'cltbld', 03:28:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:34 INFO - 'MOZ_NO_REMOTE': '1', 03:28:34 INFO - 'NO_EM_RESTART': '1', 03:28:34 INFO - 'PAGER': '/bin/cat', 03:28:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:34 INFO - 'PWD': '/builds/slave/test', 03:28:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:34 INFO - 'SHELL': '/bin/bash', 03:28:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3k9Pj5M48A/Listeners', 03:28:34 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 03:28:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:34 INFO - 'USER': 'cltbld', 03:28:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:34 INFO - 'XPC_FLAGS': '0x0', 03:28:34 INFO - 'XPC_SERVICE_NAME': '0', 03:28:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:35 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-2sedQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:35 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-HtwlEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:35 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-T7ckTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:35 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-sa_FNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:35 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-b3yijT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:35 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-tyxoBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:35 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-fJY7aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:35 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-WXg_OZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:35 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-RCFoGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:36 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-JXgACZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:36 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-oxu_kv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:36 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-2dVwug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:36 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-ZaKFLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:36 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-69UtZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:36 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-swyXa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:36 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-dWZd_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:36 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-gYbJez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:28:36 INFO - Running setup.py install for manifestparser 03:28:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:28:37 INFO - Running setup.py install for mozcrash 03:28:37 INFO - Running setup.py install for mozdebug 03:28:37 INFO - Running setup.py install for mozdevice 03:28:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:28:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:28:37 INFO - Running setup.py install for mozfile 03:28:37 INFO - Running setup.py install for mozhttpd 03:28:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:28:37 INFO - Running setup.py install for mozinfo 03:28:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:28:37 INFO - Running setup.py install for mozInstall 03:28:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:28:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:28:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:28:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:28:38 INFO - Running setup.py install for mozleak 03:28:38 INFO - Running setup.py install for mozlog 03:28:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:28:38 INFO - Running setup.py install for moznetwork 03:28:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:28:38 INFO - Running setup.py install for mozprocess 03:28:38 INFO - Running setup.py install for mozprofile 03:28:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:28:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:28:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:28:38 INFO - Running setup.py install for mozrunner 03:28:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:28:38 INFO - Running setup.py install for mozscreenshot 03:28:39 INFO - Running setup.py install for moztest 03:28:39 INFO - Running setup.py install for mozversion 03:28:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:28:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:28:39 INFO - Cleaning up... 03:28:39 INFO - Return code: 0 03:28:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:39 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')]} 03:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:39 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')]} 03:28:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:39 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 0x1040c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040ce4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff271dd0d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f6bd30>, '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 0x103d8fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f62b20>, '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.uUWUvOpbek/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.3k9Pj5M48A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 03:28:39 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 03:28:39 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 03:28:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uUWUvOpbek/Render', 03:28:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:39 INFO - 'HOME': '/Users/cltbld', 03:28:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:39 INFO - 'LOGNAME': 'cltbld', 03:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:39 INFO - 'MOZ_NO_REMOTE': '1', 03:28:39 INFO - 'NO_EM_RESTART': '1', 03:28:39 INFO - 'PAGER': '/bin/cat', 03:28:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:39 INFO - 'PWD': '/builds/slave/test', 03:28:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:39 INFO - 'SHELL': '/bin/bash', 03:28:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3k9Pj5M48A/Listeners', 03:28:39 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 03:28:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:39 INFO - 'USER': 'cltbld', 03:28:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:39 INFO - 'XPC_FLAGS': '0x0', 03:28:39 INFO - 'XPC_SERVICE_NAME': '0', 03:28:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:39 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-CwhtXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:39 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)) 03:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:39 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-SzxwSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:39 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-Rg8ep5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:40 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)) 03:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:40 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-7tmZ7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:40 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)) 03:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:40 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-RGG1yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:40 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)) 03:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:40 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-ipfsT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:40 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)) 03:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:40 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-_WQgE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:40 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)) 03:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:40 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-Eufx0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:40 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)) 03:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:40 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-xugXUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:40 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)) 03:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:40 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-Owfrgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:40 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)) 03:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:40 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-ko8ek0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:40 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)) 03:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:40 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-LTQXLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:40 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)) 03:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:41 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-sH2EMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:41 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)) 03:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:41 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-M2QMHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:41 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)) 03:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:41 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-LS_4bD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:41 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)) 03:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:41 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-rGHQrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:41 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)) 03:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:41 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-_ZH8XR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:41 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)) 03:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:28:41 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)) 03:28:41 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)) 03:28:41 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)) 03:28:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:43 INFO - Downloading blessings-1.6.tar.gz 03:28:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:28:43 INFO - Installing collected packages: blessings 03:28:43 INFO - Running setup.py install for blessings 03:28:44 INFO - Successfully installed blessings 03:28:44 INFO - Cleaning up... 03:28:44 INFO - Return code: 0 03:28:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:28:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:44 INFO - Reading from file tmpfile_stdout 03:28:44 INFO - Current package versions: 03:28:44 INFO - blessings == 1.6 03:28:44 INFO - blobuploader == 1.2.4 03:28:44 INFO - docopt == 0.6.1 03:28:44 INFO - manifestparser == 1.1 03:28:44 INFO - mozInstall == 1.12 03:28:44 INFO - mozcrash == 0.16 03:28:44 INFO - mozdebug == 0.1 03:28:44 INFO - mozdevice == 0.48 03:28:44 INFO - mozfile == 1.2 03:28:44 INFO - mozhttpd == 0.7 03:28:44 INFO - mozinfo == 0.9 03:28:44 INFO - mozleak == 0.1 03:28:44 INFO - mozlog == 3.1 03:28:44 INFO - moznetwork == 0.27 03:28:44 INFO - mozprocess == 0.22 03:28:44 INFO - mozprofile == 0.28 03:28:44 INFO - mozrunner == 6.11 03:28:44 INFO - mozscreenshot == 0.1 03:28:44 INFO - mozsystemmonitor == 0.0 03:28:44 INFO - moztest == 0.7 03:28:44 INFO - mozversion == 1.4 03:28:44 INFO - psutil == 3.1.1 03:28:44 INFO - requests == 1.2.3 03:28:44 INFO - wsgiref == 0.1.2 03:28:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:44 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 0x1040c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040ce4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff271dd0d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f6bd30>, '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 0x103d8fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f62b20>, '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.uUWUvOpbek/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.3k9Pj5M48A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 03:28:44 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 03:28:44 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 03:28:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uUWUvOpbek/Render', 03:28:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:44 INFO - 'HOME': '/Users/cltbld', 03:28:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:44 INFO - 'LOGNAME': 'cltbld', 03:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:44 INFO - 'MOZ_NO_REMOTE': '1', 03:28:44 INFO - 'NO_EM_RESTART': '1', 03:28:44 INFO - 'PAGER': '/bin/cat', 03:28:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:44 INFO - 'PWD': '/builds/slave/test', 03:28:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:44 INFO - 'SHELL': '/bin/bash', 03:28:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3k9Pj5M48A/Listeners', 03:28:44 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 03:28:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:44 INFO - 'USER': 'cltbld', 03:28:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:44 INFO - 'XPC_FLAGS': '0x0', 03:28:44 INFO - 'XPC_SERVICE_NAME': '0', 03:28:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:44 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)) 03:28:44 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)) 03:28:44 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)) 03:28:44 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)) 03:28:44 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)) 03:28:44 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)) 03:28:44 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)) 03:28:44 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)) 03:28:44 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)) 03:28:44 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)) 03:28:44 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)) 03:28:44 INFO - Cleaning up... 03:28:44 INFO - Return code: 0 03:28:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:44 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 0x1040c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040ce4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff271dd0d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f6bd30>, '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 0x103d8fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f62b20>, '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.uUWUvOpbek/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.3k9Pj5M48A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 03:28:44 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 03:28:44 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 03:28:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uUWUvOpbek/Render', 03:28:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:44 INFO - 'HOME': '/Users/cltbld', 03:28:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:44 INFO - 'LOGNAME': 'cltbld', 03:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:44 INFO - 'MOZ_NO_REMOTE': '1', 03:28:44 INFO - 'NO_EM_RESTART': '1', 03:28:44 INFO - 'PAGER': '/bin/cat', 03:28:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:44 INFO - 'PWD': '/builds/slave/test', 03:28:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:44 INFO - 'SHELL': '/bin/bash', 03:28:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3k9Pj5M48A/Listeners', 03:28:44 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 03:28:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:44 INFO - 'USER': 'cltbld', 03:28:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:44 INFO - 'XPC_FLAGS': '0x0', 03:28:44 INFO - 'XPC_SERVICE_NAME': '0', 03:28:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:45 INFO - Downloading/unpacking jsonschema 03:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:28:47 INFO - Downloading/unpacking functools32 (from jsonschema) 03:28:47 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 03:28:47 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 03:28:47 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 03:28:47 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 03:28:47 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 03:28:47 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 03:28:47 INFO - Downloading functools32-3.2.3-2.tar.gz 03:28:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:28:47 INFO - warning: no files found matching '*.txt' 03:28:47 INFO - no previously-included directories found matching 'build' 03:28:47 INFO - no previously-included directories found matching 'dist' 03:28:47 INFO - no previously-included directories found matching '.git*' 03:28:47 INFO - Installing collected packages: jsonschema, functools32 03:28:48 INFO - Running setup.py install for functools32 03:28:48 INFO - warning: no files found matching '*.txt' 03:28:48 INFO - no previously-included directories found matching 'build' 03:28:48 INFO - no previously-included directories found matching 'dist' 03:28:48 INFO - no previously-included directories found matching '.git*' 03:28:48 INFO - Successfully installed jsonschema functools32 03:28:48 INFO - Cleaning up... 03:28:48 INFO - Return code: 0 03:28:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:48 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 0x1040c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040ce4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff271dd0d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f6bd30>, '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 0x103d8fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f62b20>, '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.uUWUvOpbek/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.3k9Pj5M48A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 03:28:48 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 03:28:48 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 03:28:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uUWUvOpbek/Render', 03:28:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:48 INFO - 'HOME': '/Users/cltbld', 03:28:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:48 INFO - 'LOGNAME': 'cltbld', 03:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:48 INFO - 'MOZ_NO_REMOTE': '1', 03:28:48 INFO - 'NO_EM_RESTART': '1', 03:28:48 INFO - 'PAGER': '/bin/cat', 03:28:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:48 INFO - 'PWD': '/builds/slave/test', 03:28:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:48 INFO - 'SHELL': '/bin/bash', 03:28:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3k9Pj5M48A/Listeners', 03:28:48 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 03:28:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:48 INFO - 'USER': 'cltbld', 03:28:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:48 INFO - 'XPC_FLAGS': '0x0', 03:28:48 INFO - 'XPC_SERVICE_NAME': '0', 03:28:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:48 INFO - Downloading/unpacking flake8 03:28: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 03:28: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 03:28: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 03:28: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 03:28: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 03:28: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 03:28:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:28:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:28:50 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 03:28:50 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 03:28:50 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 03:28:50 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 03:28:50 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 03:28:50 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 03:28:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:28:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:28: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 03:28: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 03:28: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 03:28: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 03:28: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 03:28: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 03:28:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:28: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 03:28: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 03:28: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 03:28: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 03:28: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 03:28: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 03:28:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:28:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:28:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:28:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:28:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:28:52 INFO - no previously-included directories found matching 'docs/_build' 03:28:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:28:52 INFO - Running setup.py install for pep8 03:28:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:28:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:28:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:28:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:28:52 INFO - no previously-included directories found matching 'docs/_build' 03:28:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:28:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:28:52 INFO - Cleaning up... 03:28:52 INFO - Return code: 0 03:28:52 INFO - Running post-action listener: _resource_record_post_action 03:28:52 INFO - Running post-action listener: _start_resource_monitoring 03:28:52 INFO - Starting resource monitoring. 03:28:52 INFO - ##### 03:28:52 INFO - ##### Running install step. 03:28:52 INFO - ##### 03:28:52 INFO - Running pre-action listener: _resource_record_pre_action 03:28:52 INFO - Running main action method: install 03:28:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:52 INFO - Reading from file tmpfile_stdout 03:28:52 INFO - Detecting whether we're running mozinstall >=1.0... 03:28:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:28:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:28:52 INFO - Reading from file tmpfile_stdout 03:28:52 INFO - Output received: 03:28:52 INFO - Usage: mozinstall [options] installer 03:28:52 INFO - Options: 03:28:52 INFO - -h, --help show this help message and exit 03:28:52 INFO - -d DEST, --destination=DEST 03:28:52 INFO - Directory to install application into. [default: 03:28:52 INFO - "/builds/slave/test"] 03:28:52 INFO - --app=APP Application being installed. [default: firefox] 03:28:52 INFO - mkdir: /builds/slave/test/build/application 03:28:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:28:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:29:27 INFO - Reading from file tmpfile_stdout 03:29:27 INFO - Output received: 03:29:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:29:27 INFO - Running post-action listener: _resource_record_post_action 03:29:27 INFO - ##### 03:29:27 INFO - ##### Running run-tests step. 03:29:27 INFO - ##### 03:29:27 INFO - Running pre-action listener: _resource_record_pre_action 03:29:27 INFO - Running main action method: run_tests 03:29:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:29:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:29:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:29:27 INFO - 2016-02-25 03:29:27.595 screenresolution[1653:7351] starting screenresolution argv=screenresolution get 03:29:27 INFO - 2016-02-25 03:29:27.598 screenresolution[1653:7351] Display 0: 1600x1200x32@60 03:29:27 INFO - 2016-02-25 03:29:27.603 screenresolution[1654:7353] starting screenresolution argv=screenresolution list 03:29:27 INFO - Available Modes on Display 0 03:29:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:29:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:29:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:29:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:29:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:29:27 INFO - Intel Iris: 03:29:27 INFO - Chipset Model: Intel Iris 03:29:27 INFO - Type: GPU 03:29:27 INFO - Bus: Built-In 03:29:27 INFO - VRAM (Dynamic, Max): 1536 MB 03:29:27 INFO - Vendor: Intel (0x8086) 03:29:27 INFO - Device ID: 0x0a2e 03:29:27 INFO - Revision ID: 0x0009 03:29:27 INFO - Displays: 03:29:27 INFO - Display: 03:29:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:29:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:29:27 INFO - Display Serial Number: 1600x1200 60 03:29:27 INFO - Main Display: Yes 03:29:27 INFO - Mirror: Off 03:29:27 INFO - Online: Yes 03:29:27 INFO - Rotation: Supported 03:29:27 INFO - Return code: 0 03:29:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:29:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:29:27 INFO - Python 2.7.3 03:29:27 INFO - Return code: 0 03:29:27 INFO - grabbing minidump binary from tooltool 03:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:27 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 0x103f6bd30>, '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 0x103d8fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f62b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:29:27 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 03:29:27 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 03:29:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:29:27 INFO - Return code: 0 03:29:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:29:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:29:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:29:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:29:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:29:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:29:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:29:29 INFO - Return code: 0 03:29:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0132', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:29:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0132 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:29:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uUWUvOpbek/Render', 03:29:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:29:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:29:29 INFO - 'HOME': '/Users/cltbld', 03:29:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:29:29 INFO - 'LOGNAME': 'cltbld', 03:29:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:29:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:29 INFO - 'MOZ_NO_REMOTE': '1', 03:29:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:29:29 INFO - 'NO_EM_RESTART': '1', 03:29:29 INFO - 'PAGER': '/bin/cat', 03:29:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:29 INFO - 'PWD': '/builds/slave/test', 03:29:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:29:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:29:29 INFO - 'SHELL': '/bin/bash', 03:29:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3k9Pj5M48A/Listeners', 03:29:29 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 03:29:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:29:29 INFO - 'USER': 'cltbld', 03:29:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:29:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:29 INFO - 'XPC_FLAGS': '0x0', 03:29:29 INFO - 'XPC_SERVICE_NAME': '0', 03:29:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:29:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0132', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:29:29 INFO - mozversion application_buildid: 20160225015135 03:29:29 INFO - mozversion application_changeset: 5db80ec25d4688fc6b76e39ba9baed18b1b14b78 03:29:29 INFO - mozversion application_display_name: Nightly 03:29:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:29:29 INFO - mozversion application_name: Firefox 03:29:29 INFO - mozversion application_remotingname: firefox 03:29:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:29:29 INFO - mozversion application_vendor: Mozilla 03:29:29 INFO - mozversion application_version: 47.0a1 03:29:29 INFO - mozversion platform_buildid: 20160225015135 03:29:29 INFO - mozversion platform_changeset: 5db80ec25d4688fc6b76e39ba9baed18b1b14b78 03:29:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:29:29 INFO - mozversion platform_version: 47.0a1 03:29:29 INFO - using testdate: 1456399769 03:29:29 INFO - actual date: 1456399769 03:29:29 INFO - starting webserver on 'localhost:49274' 03:29:29 INFO - SUITE-START | Running 2 tests 03:29:29 INFO - TEST-START | dromaeo_css 03:29:29 INFO - operating with platform_type : mac_ 03:29:29 INFO - Initialising browser for dromaeo_css test... 03:29:29 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpPNYUl3/profile http://localhost:49274/getInfo.html) 03:29:32 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 03:29:32 INFO - PROCESS | 1672 | colorDepth:24 03:29:32 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 03:29:32 INFO - PROCESS | 1672 | __metrics 03:29:32 ERROR - PROCESS | 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:29:33 INFO - TEST-INFO | 1672: exit 0 03:29:33 INFO - Browser initialized. 03:29:33 INFO - Running cycle 1/1 for dromaeo_css test... 03:29:33 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpPNYUl3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:45 INFO - PROCESS | 1676 | RSS: Main: 256630784 03:29:45 INFO - PROCESS | 1676 | 03:30:35 INFO - PROCESS | 1676 | 1456399835499 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] 03:32:46 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 03:32:47 INFO - PROCESS | 1676 | RSS: Main: 272723968 03:32:47 INFO - PROCESS | 1676 | 03:35:49 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 03:35:50 INFO - PROCESS | 1676 | RSS: Main: 283951104 03:35:50 INFO - PROCESS | 1676 | 03:38:52 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 03:38:52 INFO - PROCESS | 1676 | RSS: Main: 285880320 03:38:52 INFO - PROCESS | 1676 | 03:41:54 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 03:41:55 INFO - PROCESS | 1676 | RSS: Main: 287293440 03:41:55 INFO - PROCESS | 1676 | 03:44:57 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 03:44:58 INFO - PROCESS | 1676 | RSS: Main: 290988032 03:44:58 INFO - PROCESS | 1676 | 03:48:00 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 03:48:01 INFO - PROCESS | 1676 | RSS: Main: 291430400 03:48:01 INFO - PROCESS | 1676 | 03:48:01 INFO - PROCESS | 1676 | __start_tp_report 03:48:01 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 03:48:01 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 03:48:01 INFO - PROCESS | 1676 | |i|pagename|runs| 03:48:01 INFO - PROCESS | 1676 | |0;dojo.html;2935.8678859451325;3017.487027205375;3379.9831000845;3582.355176068308;3616.674499295063;5844;5934.88130237395;5935.347111817702;5950.672713000783;5978.342382337939;5709.2007119003265;5919.141724449953;5923.229980102581;5957.344692083867;5962.6124301920345;5251.2385704072985;5325.973370133144;5341.4925582069645;5371.409144994048;5384.246205531229;5288.18033204852;5351.545118664918;5391.218273350361;5401.4868587484125;5416.620836541444;5326.733663316838;5348.679079255237;5382.461753824606;5399.514043736063;5404.351477822647;5232.895342093175;5308.124159513675;5331;5392.865178370533;5394.109971854639;5198.636095473318;5274.630775845692;5276.7889284428575;5303.840884773463;5322.76047577856;5088.720120393377;5511.614187006911;5724.826410585862;5763.452472015194;5786.739596718157;6293.961496353097;6315.494760419156;6316.273628532732;6319.842003949892;6338.87322253557;5022.59819214462;5979.86382587307;6277.654728989904;6300.968495157541;6317.241930968313;5699.2590963174935;5709.115087161496;5801.7389217485315;5849.444302791228;5857.0335894577765;6341.207349081365;6344.270408902943;6364.172657554581;6385.776497822554;6410.935890641033;6118.816435506942;6126.356732543108;6143.416375444325;6144.17053697754;6146.600470969463;6142.007694998287;6174.289956654952;6222.937770622327;6223;6262.3111457739615;6136.304638670889;6316.399942005502;6323.620582765049;6327.873442531123;6334.89139400603;5243.842684719464;5666.688332141689;6021.638701677914;6105.839890420806;6264.68676566179;4154.792260387029;4480.529544397857;4727.787249573777;4909.410870695539;4937.086638971802;3874.2638898609175;4416.4037854889175;4426.956702954271;4427.490838553543;4474.642028637766;5245.868853278622;5619;5635.774569017193;5968.074948383008;6025.969870150621;6248.218972628421;6267.0286105653695;6297.2128483939505;6302.558820882586;6359.777407790705;4958.578520825698;5237.057329680618;5730.169125476783;5940.762369505258;5961.463468287875;5304.681719096867;5408.783648654088;5410.404855465896;5433.646812957145;5443.5100840923715;6273.654948977759;6281.59169653971;6371.74513019474;6379.075034120119;6411.3909178627955;6253.8749225014335;6272.435480806749;6282.183316169052;6294.8111556653375;6296.6851657417865;6203.658798766111;6277.686115694106;6362.936370636235;6393.2328120625825;6412.711427985845;6115.727150604437;6185.381461853958;6257.937420625735;6293.905591416224;6319.24169099711;6258.186435763504;6267.2165979252595;6292.685365731787;6308.653024083719;6316.968415157895;4850.223964165716;6025.276966764016;6145.617236121837;6192.504599632109;6237.407446292595;6252.218472690914;6273.090401891609;6286.779962701284;6287.245530536182;6303.959846625439;4841.588464980516;5069;6056.606320589148;6127.172831667668;6152.230971128609;5344.46555344478;5921.171036055042;6129.695011270001;6226.688665566794;6227.719752611234;4989.401271847401;6035.064564992434;6042.335343112166;6077.453029227391;6092.177556029879 03:48:01 INFO - PROCESS | 1676 | |1;ext.html;428.2975919492032;464.1367057273471;479.0490875611912;526.1739069660634;531.4260598553562;36653.601567811864;37455.06362340943;37495.437568436464;37540;37618.62381376186;38458.8077059615;38997.41503877444;39013.634522791705;39024.219515609744;39071;9335.206507446876;9518.857737071561;9525;9565.808683826319;9577.138057574817;9440.103190196955;9696.70909872705;9706.320557560974;9716.465594392306;9738.172255358302;9694.903050969471;9751.707448776513;9757.463339516324;9764.316497845153;9812.950935245313;9652.469114198717;9711.90288097117;9748.512574371289;9748.658796942073;9765.023497650249;9506.667266645634;9596.32825702201;9634.518274086267;9635.951820240924;9666.275029372826;37781.81109094465;37929.81035094835;38040.80979595112;38114.42828357577;38265.426018609745;3308.3217940322415;3377.9831100844585;3536.7701099428455;3688.2070354873563;4002.779847108408;24226.515469690683;28637.997670081448;28902.13293601174;29194.270143246376;29673.554896676567;2748.367875388652;2790.1768978151495;2806.424682939992;2980.672126066131;2985.208919636298;486950;487785;490594;490763.5461822704;491241;44218.77890610526;44674.55325446704;44747.77626111849;63066.68466657729;63708.088757337355;43199.9200020002;43417.34873976893;43430.78284608557;43659.34510982338;43670.56329436728;14585.781213281809;14753.92623036878;14777;14897.329620167118;14918.627034324229;11800.937915587638;11922.701932451584;11940.820887686692;12017.579384721494;12019.158658893793;13131.409086591126;13386.799198012037;14331.498397556035;14370;14483.131012139305;5467.589930755209;6360.52296077796;6469.770743558709;6476.579022363531;6493.967530162319;893.9106089391009;920.6685593186447;994.8507723841337;1050.2595670052594;1160.2168536238175;27059.782309796108;29617.703822961925;31714.524282135786;31887.84056079705;32795.67204327974;932.6222879733718;1005.653049697853;1043.5669197283194;1050.8949105089582;1073.9516721747384;14184.36170372315;14264.786028209584;14277.857221427861;14438.927805361116;14551.708965820624;625549;632178;637083;641285;644910;54697.45302547003;54807.177892331645;55015.724921375135;55205.447945520835;55229.44770552243;1418.659521714781;1447.21126985793;1453.571196497036;1456.9344379502948;1466.8386477487682;23939;28030.2992425191;28269.28939464399;28385;28476;46329.3050604248;46582.30126548172;46774;46987.765061174476;47012.58962231139;481413;486265;487381;489676;493508;31953.68046319507;32561;32607.510887336233;32734.508982365758;32935.835320823244;42300.36549451699;42643.36034959416;42669.786651067785;43256;43450.91372715707;35388;35966.640333596326;36097.27805443929;36309.27381452409;36410;35749.46375804417;37123;37884.62115378921;38339.424908625835;40237.994050148984;35610.46584301186;36191.095222619646;37311.44032839564;38361.61638383692;38540.03649908775;30080.849595751883;31757.523637145;31762.205944851565;31803;32028.679713203503;20618.896905515976;24263.150789722276;24410.755892441557;24539;24593.262202133963 03:48:01 INFO - PROCESS | 1676 | |2;jquery.html;353.71879355912046;359.5361983041876;362.20496011255295;362.42193701046835;364.54614005563076;15876.52370428889;17531.948083115007;19270.90364548177;20410.183592656314;20511;19744.605107897834;19950;20490.38528844137;20972.846493442892;21064.262750803726;5612.971935140339;5680.261565996425;5731.942680573204;5774.682392468412;5828.213191219194;5056.418511871127;5726.828195154152;5819.7963071292515;5848.707564621774;5851.210086638313;4128.793560321987;5536.280283563131;5789.334226563936;5838.941610583882;6111.755529778803;6289.584843410219;6315.494760419178;6326.49388048955;6334.778282760128;6342.112104305401;5234.26720259164;5494.120940649477;5497.862553436156;5521.199426083235;5526.392096869341;25342.36644083894;25374;25454.87272563644;25644.74355256442;25728;2134.306350436099;2275.2719129878446;2355.658429527709;2406;2414.4446777241333;14369.56891293263;14773.482928097572;14843.851561484355;14961.027533210307;15422.845771542365;1753.32496988659;1765.0380542604312;1770.3361239535175;1773.0336966353368;1787.5531117220694;105079;106328.93671063345;106942;106991;109075;10508.527116279633;11069.833952490719;11139.387333696724;11211.94394028041;11238.887611123784;13115.950723942062;13229.073964822563;13230.338483076;13286.800697989538;13326.267055311857;8712.825743485095;8714.259287960467;8715.477071375737;8728.519931403835;8780.165884240987;8803.603837827313;8895.421797583136;8908;8961.014288428267;8992.685256016008;5532.612717109763;5616.382197958222;6231.750729970841;6375.6174629522375;6467.611943283418;1518.58238984278;1739.721644536868;1808.8965730904138;1839.6688596052838;1891.1773378580363;396.179907591289;402.9335159698675;823.3001948343859;901.985266575103;928.0997432490474;9165.725028249164;20161.798382015993;20745.377638670863;20936.057877395553;20956.161753529992;434.1729006243112;879.6217626420572;937.9155875971195;972.7324985629009;974.8635191073255;6098.237720284965;6128.601640893327;6178.104174894705;6194.9690251549355;6278.372162783777;468699;589591;590001;591246;628894;69961;106222;118664;125735;129718;467.83391895877156;471.8207081309149;473.56432082484196;476.5091955286061;478.78215411987463;10957.452127393757;11296.83054754163;11400.372979486208;11466.484008219817;11639.941800290944;53474.73262633662;54636.18045729238;54735.16853820194;55093;55298.170527442926;65131.34868651253;65418.01872971814;68503.31496684969;73159;74731;8087.47431416956;8207.261346478846;8347.95826020866;8359;8539.658413663385;11929.642110736691;13269.66825829362;13500;13557.051006429456;13589.388477518338;11245.212835101791;11497.310161390344;11652.650420487398;11674;11809.586664466702;11296.943515282372;11383.601573944872;11439.942800286279;11656.472226366168;11762.411879406167;11846.289222646668;11956.880431195577;12004.39978001114;12013.579524716593;12047.939760301142;8244.258016778518;8427.452215605967;8433.030201526903;8446.535440550828;8515.957420212859;9400.388974716621;11965.521379144737;12021.398930053638;12076;12121.939390302992 03:48:01 INFO - PROCESS | 1676 | |3;mootools.html;1576.8817338699596;1598.2647981928317;1861.3857427049074;1895.431370588823;1918.7697476302847;7759.41804364672;8541.188587084232;8846.142310114876;8962.731118066453;8982.326325525588;8715;8749.606267717953;8811.867821982676;8817.030126686059;8884.11158884113;2429.489807140498;2439.4633180700307;2442.9877850610724;2446.926592202237;2460.323411061954;2453.791747153631;2463.1379017343875;2485.5086947831246;2494.114589320792;2501.0746023971064;1935.8064193580599;2175.4887601413657;2435.0990133650484;2462.8645424501647;2493;1933.5262860599173;2192.8049213178856;2342.0865862313626;2379.3932547200525;2384.225126833786;2043.7343145391003;2328.1502251678016;2425.575524283261;2427.8543287402813;2442.7801497865275;8568.914310856937;8686.348523860735;8712.869306960401;8737.126287371211;8750.649974001033;5286.15421532553;5413.052715774724;5445.50990410861;5457.481539253765;5555.444455554412;3328.5839270091237;3692.02161427222;3743.569489508714;3753.568339640949;3763.0216143802536;1022.8874823769379;1045.3884477580625;1065.9360438373722;1071.9410432426214;1090.8581884355062;12005.159638825286;12031.51873925042;12090.455929483107;12113.333766642743;12144.696382590417;4580.496145424001;4603.710960930945;4919.680220785637;4979.029089327619;4997.775100120503;10022.799544009078;10173.694789156338;10275.845862312071;10289.74275643115;10323.277370584137;5475.589330800206;5490.725463726798;5508.779648814083;5531.25328080712;5542.806001789918;4925.21196608541;4937.1606826839525;4989.226669866177;5035.018171456604;5041.722705251246;3764.887053388403;3779.527559055118;3784.848606055782;3794.867179648699;3808.21931504041;1335.4724883670895;1336.659151916255;1338.0834128621925;1348.6898013456764;1356.125299182022;979.8089372572423;1140.6121918547733;1161.0305394995273;1285.126114242324;1339.7923321885123;7970.840583188304;8023.117457079717;8031.638576264082;8048.0342358917305;8057.476264042935;1201.0511695760251;1204.1390405859677;1206.2943178240653;1212.7872127872129;1231.4212320209488;6041.395860413923;6121.112438696364;6167.167432396659;6180.598261113013;6198.163247961557;10312.948435257926;10501.579936802595;10828;10898.782024359627;10904.563817447372;10063.245256605784;10647.893521064845;10685.412302323446;10782.946085269523;10788;7937.2459616336355;8096.959515202504;8161.795955101051;8222.876656850152;8279.254867061993;8040.075391330072;8062.959685201537;8174.67301307941;8175.1007389188335;8198.098209197104;7575.696972121274;9573.377730447499;9635;9782.559784809842;9831.508424578886;9618;9824.115829575087;9871.50642467888;10096.798064038825;10240.795184096127;7569.205233450409;7597.772066838003;7660.3488703460835;7680.155182929761;7695.384369250559;8142.796430089295;8299.95850020746;8307.086220515617;8341.874871877048;8345.95827020861;6898.482613803884;7164.391026762783;7397.630118494161;7489.176190619137;7612.162662107275;6775.627340496123;6836.42762164695;6871.106756121672;7080.079589653312;7371.226021267689;7144.678234526629;7303.8539229216185;7745.031871016123;7763.378929685498;7805.726799561988;7029.648517573998;7032.683529241299;7073.434125270069;7078.504504684829;7106.4314854810455;6097.725602347817;7121.715131394686;7150.213476517683;7188.496805223794;7201.171865235356 03:48:01 INFO - PROCESS | 1676 | |4;prototype.html;302.10124878486505;324.2364232233091;328.7287987410387;328.912838097904;332.7005694874614;5369.677819330843;6843.38409543141;6891.689873955672;6975.546589471694;6986.056882320885;5262.605304602161;6814.829629259259;6838.418734407582;6888.24229334774;6966.40785533229;5094.77073531692;5120.615953803461;5124.8975020499565;5143.53708166264;5152.124138896378;5134.486551344854;5148.845534633967;5150.716710580917;5151.407588127376;5156.071907056728;5048.359283232946;5050.898982020358;5053.823116190934;5057.5701065409485;5059.671121377117;4735.337052812609;4941.678790878582;5047.596192304625;5071;5080.3649543807205;4152.875413737563;4166.500019997619;4170.9582904171175;4174.519930208035;4176.934881605202;6545.280019197884;6563.868722625521;6587.473002159816;6606.207255129367;6608.2730899601;5696.658200507983;5828.038373668382;5833.970830145865;5840.503557197643;5887.911681324784;7253.891191632129;7255.746048888316;7257.78226653196;7263.491555591111;7327.34053935143;3848.826802793853;4653.976730116327;4667.6732628716;4668.159731248374;4671.3226582145735;7774.339181169607;7808.492447990862;7825.569593672346;7827.295543401065;7841.843163136762;3691.427828686558;4495.348174514677;4610.608098311681;4693.6949098308505;4716.245400735935;4265.55211702773;4767.523247675204;4768.356271903318;4773.546513081321;4774.331593576902;4706.717596944194;4839.346688197048;4899.755012249373;5814.418558144152;5835.620684655484;7375.18872923978;7376.815579610553;7383.15093764224;7387.926120738832;7399.963000185072;1650.6946214950271;1662.3766087717106;1666.9916650416912;1669.1320513333242;1678.6055277009893;1031.5615863258085;1062.2351906627216;1068.5307701909874;1071.6517131931998;1081.572778752404;5766.481016708516;6837.692303846339;6974.407175390149;6977.9651101745185;7002.40479559233;6254.312025677263;7679.1936846631415;7703.576303303372;7717.498362606412;7724.922750772533;6971.930280697229;6980.197277313073;6990.720371185197;6993.930060699429;7006.369426751617;3922.3135951208424;3923.7841918694176;4039.979800100981;4069.1251380953236;4077.9796101019306;6434.356564343529;7846.33306168982;7968.7609371718945;8047.396445266511;8051.5571643559;8020.19798020205;8022.157673444204;8028.397870159644;8034.15641357649;8044.1955804419085;8043.356531477468;8043.919560804317;8054.315383192377;8079.394045446497;8092.069412017693;6367.80896573085;7710.306072453506;7728.343090837342;7730.574818384818;7838.137804841577;7588.089429268523;7618.276263754934;7620.123685775985;7648.961755191411;7653.311201991847;8055.033395992518;8077.474964127313;8078.919210807817;8079.111297757125;8092.069412017458;4725.976370118127;4766.737829419277;4780.976095119502;4786.497417771084;4795.20879054952;7528.55989627922;7642.7325043623205;7702.576358300347;7723.53658780475;7734.458587898793;7366.926330736838;7455.552666840007;7470.514416562906;7472.663730132048;7495.62521873915;6038.818835434944;7413.481056326005;7416.332530072319;7428.182899880901;7430.962845185955;6989.37095661393;7250.528715633467;7264.055672762507;7264.273572642905;7300.379467745302;7454.068241469817;7483.550986940801;7486.7005319786595;7488.775336739906;7496.062992125984;7229.674664639999;7253.927460725326;7262.745803896838;7282.3809976152625;7282.781516554512 03:48:01 INFO - PROCESS | 1676 | |5;yui.html;662.3438618824091;669.9816279255534;698.6227437183921;714.8034290570092;741.1328745367919;15323.540293791177;17212.569685757862;17367.913160434196;17402.56493587661;17404.477865664034;15937.442189523368;15994.360225590963;16016.35934562616;16047.518574442756;16047.759283610756;848.1942154952789;861.5649097205902;880.0231742765525;894.0880302091863;896.5382827843666;882.8675698645222;883.1786438612088;884.0938038510546;884.3190743127788;886.6985225023491;915.2540679346345;921.2814005076051;925.4678559828092;931.3294428011855;934.2292608597934;902.9638814447414;920.9401388909699;921.1985572551889;924.2421214604027;926.7683079230193;679.2290749998738;686.4439803758921;688.7623769799411;690.1097584116484;690.927452617478;15198.392064317413;15374.154421506813;15410;15479;15542.456014039455;10851.348919064882;11235.887641123565;11938.28370297785;12794.104412691115;12961.740765184737;10102.292839501239;10210.846837297446;10256.128229100535;10258.076773090383;10310.484475776182;3076.26169719268;3504.3341765064556;3546.5921419036627;3554.0581745837376;3556.946645800315;80800.19199807986;81349.18650813475;81907;86956.13043869543;87585.68621470683;9717.076877696607;9841.114299713061;9876.259280553988;9915.305928585074;10490.475476226311;21761.782382176294;21956.23153189631;21982.120715171535;21994.670079948814;22014.559708806053;7409.962950185214;7603.353714934182;7667.616619169019;7673.501222420525;7817.452778305464;4085.7344272622186;4128.3601041838565;4131.153113611703;4140.523839758406;4141.440905477722;3496.0560648625237;3498.212902097008;3502.8598856045983;3513.4202856528896;3519.278547897675;589.4135335341277;620.3548309757891;652.670401447266;657.4740207833714;667.9866402671919;507.4266079330333;520.4613225311784;595.684287327717;597.6234971967633;601.20940962634;7084.822879428056;8385.83228335442;8413.621387037598;8598.140185981478;8782.780430489162;500.5920175057317;544.3032917865139;590.153130258081;625.7059182184366;626.7493002798917;3895.454636350913;4016.638502534786;4139.296319625671;4168.353905144708;4411.955880441219;86983;88883.55558222167;89668.10331896598;89915.55042224878;92087;78938.81591776013;79135;79489.4102117966;79565.60217198876;79682.60158699169;53678.73160634172;65426.67286663631;72630;75471.35850245215;76090;7561.508501947355;8879.822403552022;8892.688755893512;8940.86588701157;9025.81948361016;31992.840035799672;46255.53744462512;46495.372661956666;47446;48257.75871120622;57169.714151428976;62713;63044.36955630385;63103.36896630975;63414;11174.66476005721;11379.260348077349;11421.600243991752;11462.598809041643;11899.702507437383;11372.54509819598;11963.700907477383;12390.62828115158;12716.491340346283;12752.48990040388;11212.66362009141;11267.647717935375;11297.887021130013;11633.59282425111;12405.75188496207;11401.087912967108;11406.771864562828;11586.527017376922;11726.296422214695;12393.876061239273;11082.833757493483;11496.712582185512;11514.712132196762;11530.077593792645;11553.480093395649;9276.62893484253;9481.431114133175;9508.572114254737;9675.371100878421;10569.312994655324;7602.885956710765;8980.012198658273;9164.911031324502;9510;9710.75723106928 03:48:01 INFO - PROCESS | 1676 | __end_tp_report 03:48:01 INFO - PROCESS | 1676 | __start_cc_report 03:48:01 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,349 03:48:01 INFO - PROCESS | 1676 | __end_cc_report 03:48:01 INFO - PROCESS | 1676 | __startTimestamp1456400881200__endTimestamp 03:48:01 INFO - PROCESS | 1676 | 03:48:01 INFO - PROCESS | 1676 | ------- Summary: start ------- 03:48:01 INFO - PROCESS | 1676 | Number of tests: 6 03:48:01 INFO - PROCESS | 1676 | 03:48:01 INFO - PROCESS | 1676 | [#0] dojo.html Cycles:165 Average:5738.38 Median:5978.34 stddev:693.19 (11.6%) stddev-sans-first:659.53 03:48:01 INFO - PROCESS | 1676 | Values: 2935.9 3017.5 3380.0 3582.4 3616.7 5844.0 5934.9 5935.3 5950.7 5978.3 5709.2 5919.1 5923.2 5957.3 5962.6 5251.2 5326.0 5341.5 5371.4 5384.2 5288.2 5351.5 5391.2 5401.5 5416.6 5326.7 5348.7 5382.5 5399.5 5404.4 5232.9 5308.1 5331.0 5392.9 5394.1 5198.6 5274.6 5276.8 5303.8 5322.8 5088.7 5511.6 5724.8 5763.5 5786.7 6294.0 6315.5 6316.3 6319.8 6338.9 5022.6 5979.9 6277.7 6301.0 6317.2 5699.3 5709.1 5801.7 5849.4 5857.0 6341.2 6344.3 6364.2 6385.8 6410.9 6118.8 6126.4 6143.4 6144.2 6146.6 6142.0 6174.3 6222.9 6223.0 6262.3 6136.3 6316.4 6323.6 6327.9 6334.9 5243.8 5666.7 6021.6 6105.8 6264.7 4154.8 4480.5 4727.8 4909.4 4937.1 3874.3 4416.4 4427.0 4427.5 4474.6 5245.9 5619.0 5635.8 5968.1 6026.0 6248.2 6267.0 6297.2 6302.6 6359.8 4958.6 5237.1 5730.2 5940.8 5961.5 5304.7 5408.8 5410.4 5433.6 5443.5 6273.7 6281.6 6371.7 6379.1 6411.4 6253.9 6272.4 6282.2 6294.8 6296.7 6203.7 6277.7 6362.9 6393.2 6412.7 6115.7 6185.4 6257.9 6293.9 6319.2 6258.2 6267.2 6292.7 6308.7 6317.0 4850.2 6025.3 6145.6 6192.5 6237.4 6252.2 6273.1 6286.8 6287.2 6304.0 4841.6 5069.0 6056.6 6127.2 6152.2 5344.5 5921.2 6129.7 6226.7 6227.7 4989.4 6035.1 6042.3 6077.5 6092.2 03:48:01 INFO - PROCESS | 1676 | 03:48:01 INFO - PROCESS | 1676 | [#1] ext.html Cycles:180 Average:65907.73 Median:38302.43 stddev:144974.17 (378.5%) stddev-sans-first:145297.50 03:48:01 INFO - PROCESS | 1676 | Values: 428.3 464.1 479.0 526.2 531.4 36653.6 37455.1 37495.4 37540.0 37618.6 38458.8 38997.4 39013.6 39024.2 39071.0 9335.2 9518.9 9525.0 9565.8 9577.1 9440.1 9696.7 9706.3 9716.5 9738.2 9694.9 9751.7 9757.5 9764.3 9813.0 9652.5 9711.9 9748.5 9748.7 9765.0 9506.7 9596.3 9634.5 9636.0 9666.3 37781.8 37929.8 38040.8 38114.4 38265.4 3308.3 3378.0 3536.8 3688.2 4002.8 24226.5 28638.0 28902.1 29194.3 29673.6 2748.4 2790.2 2806.4 2980.7 2985.2 486950.0 487785.0 490594.0 490763.5 491241.0 44218.8 44674.6 44747.8 63066.7 63708.1 43199.9 43417.3 43430.8 43659.3 43670.6 14585.8 14753.9 14777.0 14897.3 14918.6 11800.9 11922.7 11940.8 12017.6 12019.2 13131.4 13386.8 14331.5 14370.0 14483.1 5467.6 6360.5 6469.8 6476.6 6494.0 893.9 920.7 994.9 1050.3 1160.2 27059.8 29617.7 31714.5 31887.8 32795.7 932.6 1005.7 1043.6 1050.9 1074.0 14184.4 14264.8 14277.9 14438.9 14551.7 625549.0 632178.0 637083.0 641285.0 644910.0 54697.5 54807.2 55015.7 55205.4 55229.4 1418.7 1447.2 1453.6 1456.9 1466.8 23939.0 28030.3 28269.3 28385.0 28476.0 46329.3 46582.3 46774.0 46987.8 47012.6 481413.0 486265.0 487381.0 489676.0 493508.0 31953.7 32561.0 32607.5 32734.5 32935.8 42300.4 42643.4 42669.8 43256.0 43450.9 35388.0 35966.6 36097.3 36309.3 36410.0 35749.5 37123.0 37884.6 38339.4 40238.0 35610.5 36191.1 37311.4 38361.6 38540.0 30080.8 31757.5 31762.2 31803.0 32028.7 20618.9 24263.2 24410.8 24539.0 24593.3 03:48:01 INFO - PROCESS | 1676 | 03:48:01 INFO - PROCESS | 1676 | [#2] jquery.html Cycles:180 Average:33094.79 Median:363.48 stddev:95745.14 (26340.9%) stddev-sans-first:95982.17 03:48:01 INFO - PROCESS | 1676 | Values: 353.7 359.5 362.2 362.4 364.5 15876.5 17531.9 19270.9 20410.2 20511.0 19744.6 19950.0 20490.4 20972.8 21064.3 5613.0 5680.3 5731.9 5774.7 5828.2 5056.4 5726.8 5819.8 5848.7 5851.2 4128.8 5536.3 5789.3 5838.9 6111.8 6289.6 6315.5 6326.5 6334.8 6342.1 5234.3 5494.1 5497.9 5521.2 5526.4 25342.4 25374.0 25454.9 25644.7 25728.0 2134.3 2275.3 2355.7 2406.0 2414.4 14369.6 14773.5 14843.9 14961.0 15422.8 1753.3 1765.0 1770.3 1773.0 1787.6 105079.0 106328.9 106942.0 106991.0 109075.0 10508.5 11069.8 11139.4 11211.9 11238.9 13116.0 13229.1 13230.3 13286.8 13326.3 8712.8 8714.3 8715.5 8728.5 8780.2 8803.6 8895.4 8908.0 8961.0 8992.7 5532.6 5616.4 6231.8 6375.6 6467.6 1518.6 1739.7 1808.9 1839.7 1891.2 396.2 402.9 823.3 902.0 928.1 9165.7 20161.8 20745.4 20936.1 20956.2 434.2 879.6 937.9 972.7 974.9 6098.2 6128.6 6178.1 6195.0 6278.4 468699.0 589591.0 590001.0 591246.0 628894.0 69961.0 106222.0 118664.0 125735.0 129718.0 467.8 471.8 473.6 476.5 478.8 10957.5 11296.8 11400.4 11466.5 11639.9 53474.7 54636.2 54735.2 55093.0 55298.2 65131.3 65418.0 68503.3 73159.0 74731.0 8087.5 8207.3 8348.0 8359.0 8539.7 11929.6 13269.7 13500.0 13557.1 13589.4 11245.2 11497.3 11652.7 11674.0 11809.6 11296.9 11383.6 11439.9 11656.5 11762.4 11846.3 11956.9 12004.4 12013.6 12047.9 8244.3 8427.5 8433.0 8446.5 8516.0 9400.4 11965.5 12021.4 12076.0 12121.9 03:48:01 INFO - PROCESS | 1676 | 03:48:01 INFO - PROCESS | 1676 | [#3] mootools.html Cycles:180 Average:6046.67 Median:5163.94 stddev:3196.07 (61.9%) stddev-sans-first:3187.38 03:48:01 INFO - PROCESS | 1676 | Values: 1576.9 1598.3 1861.4 1895.4 1918.8 7759.4 8541.2 8846.1 8962.7 8982.3 8715.0 8749.6 8811.9 8817.0 8884.1 2429.5 2439.5 2443.0 2446.9 2460.3 2453.8 2463.1 2485.5 2494.1 2501.1 1935.8 2175.5 2435.1 2462.9 2493.0 1933.5 2192.8 2342.1 2379.4 2384.2 2043.7 2328.2 2425.6 2427.9 2442.8 8568.9 8686.3 8712.9 8737.1 8750.6 5286.2 5413.1 5445.5 5457.5 5555.4 3328.6 3692.0 3743.6 3753.6 3763.0 1022.9 1045.4 1065.9 1071.9 1090.9 12005.2 12031.5 12090.5 12113.3 12144.7 4580.5 4603.7 4919.7 4979.0 4997.8 10022.8 10173.7 10275.8 10289.7 10323.3 5475.6 5490.7 5508.8 5531.3 5542.8 4925.2 4937.2 4989.2 5035.0 5041.7 3764.9 3779.5 3784.8 3794.9 3808.2 1335.5 1336.7 1338.1 1348.7 1356.1 979.8 1140.6 1161.0 1285.1 1339.8 7970.8 8023.1 8031.6 8048.0 8057.5 1201.1 1204.1 1206.3 1212.8 1231.4 6041.4 6121.1 6167.2 6180.6 6198.2 10312.9 10501.6 10828.0 10898.8 10904.6 10063.2 10647.9 10685.4 10782.9 10788.0 7937.2 8097.0 8161.8 8222.9 8279.3 8040.1 8063.0 8174.7 8175.1 8198.1 7575.7 9573.4 9635.0 9782.6 9831.5 9618.0 9824.1 9871.5 10096.8 10240.8 7569.2 7597.8 7660.3 7680.2 7695.4 8142.8 8300.0 8307.1 8341.9 8346.0 6898.5 7164.4 7397.6 7489.2 7612.2 6775.6 6836.4 6871.1 7080.1 7371.2 7144.7 7303.9 7745.0 7763.4 7805.7 7029.6 7032.7 7073.4 7078.5 7106.4 6097.7 7121.7 7150.2 7188.5 7201.2 03:48:01 INFO - PROCESS | 1676 | 03:48:01 INFO - PROCESS | 1676 | [#4] prototype.html Cycles:180 Average:5984.77 Median:6865.81 stddev:1983.15 (28.9%) stddev-sans-first:1942.31 03:48:01 INFO - PROCESS | 1676 | Values: 302.1 324.2 328.7 328.9 332.7 5369.7 6843.4 6891.7 6975.5 6986.1 5262.6 6814.8 6838.4 6888.2 6966.4 5094.8 5120.6 5124.9 5143.5 5152.1 5134.5 5148.8 5150.7 5151.4 5156.1 5048.4 5050.9 5053.8 5057.6 5059.7 4735.3 4941.7 5047.6 5071.0 5080.4 4152.9 4166.5 4171.0 4174.5 4176.9 6545.3 6563.9 6587.5 6606.2 6608.3 5696.7 5828.0 5834.0 5840.5 5887.9 7253.9 7255.7 7257.8 7263.5 7327.3 3848.8 4654.0 4667.7 4668.2 4671.3 7774.3 7808.5 7825.6 7827.3 7841.8 3691.4 4495.3 4610.6 4693.7 4716.2 4265.6 4767.5 4768.4 4773.5 4774.3 4706.7 4839.3 4899.8 5814.4 5835.6 7375.2 7376.8 7383.2 7387.9 7400.0 1650.7 1662.4 1667.0 1669.1 1678.6 1031.6 1062.2 1068.5 1071.7 1081.6 5766.5 6837.7 6974.4 6978.0 7002.4 6254.3 7679.2 7703.6 7717.5 7724.9 6971.9 6980.2 6990.7 6993.9 7006.4 3922.3 3923.8 4040.0 4069.1 4078.0 6434.4 7846.3 7968.8 8047.4 8051.6 8020.2 8022.2 8028.4 8034.2 8044.2 8043.4 8043.9 8054.3 8079.4 8092.1 6367.8 7710.3 7728.3 7730.6 7838.1 7588.1 7618.3 7620.1 7649.0 7653.3 8055.0 8077.5 8078.9 8079.1 8092.1 4726.0 4766.7 4781.0 4786.5 4795.2 7528.6 7642.7 7702.6 7723.5 7734.5 7366.9 7455.6 7470.5 7472.7 7495.6 6038.8 7413.5 7416.3 7428.2 7431.0 6989.4 7250.5 7264.1 7264.3 7300.4 7454.1 7483.6 7486.7 7488.8 7496.1 7229.7 7253.9 7262.7 7282.4 7282.8 03:48:01 INFO - PROCESS | 1676 | 03:48:01 INFO - PROCESS | 1676 | [#5] yui.html Cycles:180 Average:18147.20 Median:596.65 stddev:25242.57 (4230.7%) stddev-sans-first:25279.23 03:48:01 INFO - PROCESS | 1676 | Values: 662.3 670.0 698.6 714.8 741.1 15323.5 17212.6 17367.9 17402.6 17404.5 15937.4 15994.4 16016.4 16047.5 16047.8 848.2 861.6 880.0 894.1 896.5 882.9 883.2 884.1 884.3 886.7 915.3 921.3 925.5 931.3 934.2 903.0 920.9 921.2 924.2 926.8 679.2 686.4 688.8 690.1 690.9 15198.4 15374.2 15410.0 15479.0 15542.5 10851.3 11235.9 11938.3 12794.1 12961.7 10102.3 10210.8 10256.1 10258.1 10310.5 3076.3 3504.3 3546.6 3554.1 3556.9 80800.2 81349.2 81907.0 86956.1 87585.7 9717.1 9841.1 9876.3 9915.3 10490.5 21761.8 21956.2 21982.1 21994.7 22014.6 7410.0 7603.4 7667.6 7673.5 7817.5 4085.7 4128.4 4131.2 4140.5 4141.4 3496.1 3498.2 3502.9 3513.4 3519.3 589.4 620.4 652.7 657.5 668.0 507.4 520.5 595.7 597.6 601.2 7084.8 8385.8 8413.6 8598.1 8782.8 500.6 544.3 590.2 625.7 626.7 3895.5 4016.6 4139.3 4168.4 4412.0 86983.0 88883.6 89668.1 89915.6 92087.0 78938.8 79135.0 79489.4 79565.6 79682.6 53678.7 65426.7 72630.0 75471.4 76090.0 7561.5 8879.8 8892.7 8940.9 9025.8 31992.8 46255.5 46495.4 47446.0 48257.8 57169.7 62713.0 63044.4 63103.4 63414.0 11174.7 11379.3 11421.6 11462.6 11899.7 11372.5 11963.7 12390.6 12716.5 12752.5 11212.7 11267.6 11297.9 11633.6 12405.8 11401.1 11406.8 11586.5 11726.3 12393.9 11082.8 11496.7 11514.7 11530.1 11553.5 9276.6 9481.4 9508.6 9675.4 10569.3 7602.9 8980.0 9164.9 9510.0 9710.8 03:48:01 INFO - PROCESS | 1676 | -------- Summary: end -------- 03:48:01 INFO - PROCESS | 1676 | 03:48:01 INFO - TEST-INFO | 1676: exit 0 03:48:01 INFO - TEST-OK | dromaeo_css | took 1111915ms 03:48:01 INFO - TEST-START | kraken 03:48:01 INFO - operating with platform_type : mac_ 03:48:01 INFO - Initialising browser for kraken test... 03:48:01 INFO - TEST-INFO | started process 1711 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmppwD_j2/profile http://localhost:49274/getInfo.html) 03:48:04 INFO - PROCESS | 1711 | __metrics Screen width/height:1600/1200 03:48:04 INFO - PROCESS | 1711 | colorDepth:24 03:48:04 INFO - PROCESS | 1711 | Browser inner width/height: 1024/689 03:48:04 INFO - PROCESS | 1711 | __metrics 03:48:04 ERROR - PROCESS | 1711 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:48:05 INFO - TEST-INFO | 1711: exit 0 03:48:05 INFO - Browser initialized. 03:48:05 INFO - Running cycle 1/1 for kraken test... 03:48:05 INFO - TEST-INFO | started process 1714 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmppwD_j2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:17 INFO - PROCESS | 1714 | RSS: Main: 256397312 03:48:17 INFO - PROCESS | 1714 | 03:48:19 INFO - PROCESS | 1714 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 03:48:20 INFO - PROCESS | 1714 | RSS: Main: 269635584 03:48:20 INFO - PROCESS | 1714 | 03:48:23 INFO - PROCESS | 1714 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 03:48:23 INFO - PROCESS | 1714 | RSS: Main: 277000192 03:48:23 INFO - PROCESS | 1714 | 03:48:27 INFO - PROCESS | 1714 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 03:48:27 INFO - PROCESS | 1714 | RSS: Main: 279617536 03:48:27 INFO - PROCESS | 1714 | 03:48:29 INFO - PROCESS | 1714 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 03:48:30 INFO - PROCESS | 1714 | RSS: Main: 281280512 03:48:30 INFO - PROCESS | 1714 | 03:48:32 INFO - PROCESS | 1714 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:48:32 INFO - PROCESS | 1714 | RSS: Main: 281841664 03:48:32 INFO - PROCESS | 1714 | 03:48:35 INFO - PROCESS | 1714 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 03:48:36 INFO - PROCESS | 1714 | RSS: Main: 283783168 03:48:36 INFO - PROCESS | 1714 | 03:48:39 INFO - PROCESS | 1714 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 03:48:39 INFO - PROCESS | 1714 | RSS: Main: 283856896 03:48:39 INFO - PROCESS | 1714 | 03:48:43 INFO - PROCESS | 1714 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 03:48:43 INFO - PROCESS | 1714 | RSS: Main: 284405760 03:48:43 INFO - PROCESS | 1714 | 03:48:45 INFO - PROCESS | 1714 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:48:45 INFO - PROCESS | 1714 | RSS: Main: 283099136 03:48:45 INFO - PROCESS | 1714 | 03:48:47 INFO - PROCESS | 1714 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:48:48 INFO - PROCESS | 1714 | RSS: Main: 283168768 03:48:48 INFO - PROCESS | 1714 | 03:48:50 INFO - PROCESS | 1714 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:48:51 INFO - PROCESS | 1714 | RSS: Main: 282681344 03:48:51 INFO - PROCESS | 1714 | 03:48:53 INFO - PROCESS | 1714 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:48:54 INFO - PROCESS | 1714 | RSS: Main: 284712960 03:48:54 INFO - PROCESS | 1714 | 03:48:56 INFO - PROCESS | 1714 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:48:57 INFO - PROCESS | 1714 | RSS: Main: 283983872 03:48:57 INFO - PROCESS | 1714 | 03:48:59 INFO - PROCESS | 1714 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 03:48:59 INFO - PROCESS | 1714 | RSS: Main: 286035968 03:48:59 INFO - PROCESS | 1714 | 03:48:59 INFO - PROCESS | 1714 | __start_tp_report 03:48:59 INFO - PROCESS | 1714 | _x_x_mozilla_page_load 03:48:59 INFO - PROCESS | 1714 | _x_x_mozilla_page_load_details 03:48:59 INFO - PROCESS | 1714 | |i|pagename|runs| 03:48:59 INFO - PROCESS | 1714 | |0;ai-astar;114;104;162;114;145;147;168;170;114;114 03:48:59 INFO - PROCESS | 1714 | |1;audio-beat-detection;179;160;144;153;125;140;174;112;179;147 03:48:59 INFO - PROCESS | 1714 | |2;audio-dft;190;194;200;211;225;197;197;196;204;199 03:48:59 INFO - PROCESS | 1714 | |3;audio-fft;69;78;72;106;58;55;58;58;108;57 03:48:59 INFO - PROCESS | 1714 | |4;audio-oscillator;85;96;119;92;117;117;117;80;81;111 03:48:59 INFO - PROCESS | 1714 | |5;imaging-gaussian-blur;87;114;127;113;87;93;86;92;87;113 03:48:59 INFO - PROCESS | 1714 | |6;imaging-darkroom;117;95;101;97;100;148;99;132;143;97 03:48:59 INFO - PROCESS | 1714 | |7;imaging-desaturate;146;149;92;95;96;132;112;148;144;105 03:48:59 INFO - PROCESS | 1714 | |8;json-parse-financial;56;75;78;81;77;80;82;91;54;55 03:48:59 INFO - PROCESS | 1714 | |9;json-stringify-tinderbox;65;69;72;78;75;70;65;68;72;67 03:48:59 INFO - PROCESS | 1714 | |10;stanford-crypto-aes;97;85;88;84;89;87;85;87;86;84 03:48:59 INFO - PROCESS | 1714 | |11;stanford-crypto-ccm;129;128;123;135;139;141;138;128;127;127 03:48:59 INFO - PROCESS | 1714 | |12;stanford-crypto-pbkdf2;143;159;143;142;141;148;144;142;176;164 03:48:59 INFO - PROCESS | 1714 | |13;stanford-crypto-sha256-iterative;68;66;64;56;80;55;61;84;95;98 03:48:59 INFO - PROCESS | 1714 | __end_tp_report 03:48:59 INFO - PROCESS | 1714 | __start_cc_report 03:48:59 INFO - PROCESS | 1714 | _x_x_mozilla_cycle_collect,896 03:48:59 INFO - PROCESS | 1714 | __end_cc_report 03:48:59 INFO - PROCESS | 1714 | __startTimestamp1456400939477__endTimestamp 03:48:59 INFO - PROCESS | 1714 | 03:48:59 INFO - PROCESS | 1714 | ------- Summary: start ------- 03:48:59 INFO - PROCESS | 1714 | Number of tests: 14 03:48:59 INFO - PROCESS | 1714 | 03:48:59 INFO - PROCESS | 1714 | [#0] ai-astar Cycles:10 Average:135.20 Median:146.00 stddev:25.84 (17.7%) stddev-sans-first:26.25 03:48:59 INFO - PROCESS | 1714 | Values: 114.0 104.0 162.0 114.0 145.0 147.0 168.0 170.0 114.0 114.0 03:48:59 INFO - PROCESS | 1714 | 03:48:59 INFO - PROCESS | 1714 | [#1] audio-beat-detection Cycles:10 Average:151.30 Median:156.50 stddev:22.52 (14.4%) stddev-sans-first:21.54 03:48:59 INFO - PROCESS | 1714 | Values: 179.0 160.0 144.0 153.0 125.0 140.0 174.0 112.0 179.0 147.0 03:48:59 INFO - PROCESS | 1714 | 03:48:59 INFO - PROCESS | 1714 | [#2] audio-dft Cycles:10 Average:201.30 Median:199.50 stddev:10.09 (5.1%) stddev-sans-first:9.84 03:48:59 INFO - PROCESS | 1714 | Values: 190.0 194.0 200.0 211.0 225.0 197.0 197.0 196.0 204.0 199.0 03:48:59 INFO - PROCESS | 1714 | 03:48:59 INFO - PROCESS | 1714 | [#3] audio-fft Cycles:10 Average:71.90 Median:58.00 stddev:20.00 (34.5%) stddev-sans-first:21.18 03:48:59 INFO - PROCESS | 1714 | Values: 69.0 78.0 72.0 106.0 58.0 55.0 58.0 58.0 108.0 57.0 03:48:59 INFO - PROCESS | 1714 | 03:48:59 INFO - PROCESS | 1714 | [#4] audio-oscillator Cycles:10 Average:101.50 Median:80.50 stddev:16.30 (20.3%) stddev-sans-first:16.16 03:48:59 INFO - PROCESS | 1714 | Values: 85.0 96.0 119.0 92.0 117.0 117.0 117.0 80.0 81.0 111.0 03:48:59 INFO - PROCESS | 1714 | 03:48:59 INFO - PROCESS | 1714 | [#5] imaging-gaussian-blur Cycles:10 Average:99.90 Median:87.00 stddev:15.20 (17.5%) stddev-sans-first:15.39 03:48:59 INFO - PROCESS | 1714 | Values: 87.0 114.0 127.0 113.0 87.0 93.0 86.0 92.0 87.0 113.0 03:48:59 INFO - PROCESS | 1714 | 03:48:59 INFO - PROCESS | 1714 | [#6] imaging-darkroom Cycles:10 Average:112.90 Median:121.50 stddev:20.67 (17.0%) stddev-sans-first:21.88 03:48:59 INFO - PROCESS | 1714 | Values: 117.0 95.0 101.0 97.0 100.0 148.0 99.0 132.0 143.0 97.0 03:48:59 INFO - PROCESS | 1714 | 03:48:59 INFO - PROCESS | 1714 | [#7] imaging-desaturate Cycles:10 Average:121.90 Median:148.50 stddev:24.17 (16.3%) stddev-sans-first:24.01 03:48:59 INFO - PROCESS | 1714 | Values: 146.0 149.0 92.0 95.0 96.0 132.0 112.0 148.0 144.0 105.0 03:48:59 INFO - PROCESS | 1714 | 03:48:59 INFO - PROCESS | 1714 | [#8] json-parse-financial Cycles:10 Average:72.90 Median:79.00 stddev:13.07 (16.5%) stddev-sans-first:12.35 03:48:59 INFO - PROCESS | 1714 | Values: 56.0 75.0 78.0 81.0 77.0 80.0 82.0 91.0 54.0 55.0 03:48:59 INFO - PROCESS | 1714 | 03:48:59 INFO - PROCESS | 1714 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:71.00 stddev:4.23 (6.0%) stddev-sans-first:4.06 03:48:59 INFO - PROCESS | 1714 | Values: 65.0 69.0 72.0 78.0 75.0 70.0 65.0 68.0 72.0 67.0 03:48:59 INFO - PROCESS | 1714 | 03:48:59 INFO - PROCESS | 1714 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:87.00 stddev:3.82 (4.4%) stddev-sans-first:1.76 03:48:59 INFO - PROCESS | 1714 | Values: 97.0 85.0 88.0 84.0 89.0 87.0 85.0 87.0 86.0 84.0 03:48:59 INFO - PROCESS | 1714 | 03:48:59 INFO - PROCESS | 1714 | [#11] stanford-crypto-ccm Cycles:10 Average:131.50 Median:132.00 stddev:6.19 (4.7%) stddev-sans-first:6.50 03:48:59 INFO - PROCESS | 1714 | Values: 129.0 128.0 123.0 135.0 139.0 141.0 138.0 128.0 127.0 127.0 03:48:59 INFO - PROCESS | 1714 | 03:48:59 INFO - PROCESS | 1714 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.20 Median:146.00 stddev:12.02 (8.2%) stddev-sans-first:12.46 03:48:59 INFO - PROCESS | 1714 | Values: 143.0 159.0 143.0 142.0 141.0 148.0 144.0 142.0 176.0 164.0 03:48:59 INFO - PROCESS | 1714 | 03:48:59 INFO - PROCESS | 1714 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:74.00 stddev:15.60 (21.1%) stddev-sans-first:16.45 03:48:59 INFO - PROCESS | 1714 | Values: 68.0 66.0 64.0 56.0 80.0 55.0 61.0 84.0 95.0 98.0 03:48:59 INFO - PROCESS | 1714 | -------- Summary: end -------- 03:48:59 INFO - PROCESS | 1714 | 03:49:00 INFO - TEST-INFO | 1714: exit 0 03:49:00 INFO - TEST-OK | kraken | took 58486ms 03:49:00 INFO - SUITE-END | took 1170s 03:49:00 INFO - Completed test suite (00:19:30) 03:49:00 INFO - Working with test: dromaeo_css 03:49:00 INFO - Generating results file: dromaeo_css 03:49:00 INFO - Working with test: kraken 03:49:00 INFO - Generating results file: kraken 03:49:00 INFO - javascript benchmark 03:49:00 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:49:01 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 03:49:01 INFO - process_Request line: dromaeo_css 7483.98 graph.html#tests=[[72,64,61]] 03:49:01 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:49:01 INFO - process_Request line: kraken 1580.50 graph.html#tests=[[232,64,61]] 03:49:01 INFO - RETURN: dromaeo_css: 7483.98 03:49:01 INFO - RETURN: kraken: 1580.50 03:49:01 INFO - javascript benchmark 03:49:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2935.8678859451325, 3017.487027205375, 3379.9831000845, 3582.355176068308, 3616.674499295063, 5844.0, 5934.88130237395, 5935.347111817702, 5950.672713000783, 5978.342382337939, 5709.2007119003265, 5919.141724449953, 5923.229980102581, 5957.344692083867, 5962.6124301920345, 5251.2385704072985, 5325.973370133144, 5341.4925582069645, 5371.409144994048, 5384.246205531229, 5288.18033204852, 5351.545118664918, 5391.218273350361, 5401.4868587484125, 5416.620836541444, 5326.733663316838, 5348.679079255237, 5382.461753824606, 5399.514043736063, 5404.351477822647, 5232.895342093175, 5308.124159513675, 5331.0, 5392.865178370533, 5394.109971854639, 5198.636095473318, 5274.630775845692, 5276.7889284428575, 5303.840884773463, 5322.76047577856, 5088.720120393377, 5511.614187006911, 5724.826410585862, 5763.452472015194, 5786.739596718157, 6293.961496353097, 6315.494760419156, 6316.273628532732, 6319.842003949892, 6338.87322253557, 5022.59819214462, 5979.86382587307, 6277.654728989904, 6300.968495157541, 6317.241930968313, 5699.2590963174935, 5709.115087161496, 5801.7389217485315, 5849.444302791228, 5857.0335894577765, 6341.207349081365, 6344.270408902943, 6364.172657554581, 6385.776497822554, 6410.935890641033, 6118.816435506942, 6126.356732543108, 6143.416375444325, 6144.17053697754, 6146.600470969463, 6142.007694998287, 6174.289956654952, 6222.937770622327, 6223.0, 6262.3111457739615, 6136.304638670889, 6316.399942005502, 6323.620582765049, 6327.873442531123, 6334.89139400603, 5243.842684719464, 5666.688332141689, 6021.638701677914, 6105.839890420806, 6264.68676566179, 4154.792260387029, 4480.529544397857, 4727.787249573777, 4909.410870695539, 4937.086638971802, 3874.2638898609175, 4416.4037854889175, 4426.956702954271, 4427.490838553543, 4474.642028637766, 5245.868853278622, 5619.0, 5635.774569017193, 5968.074948383008, 6025.969870150621, 6248.218972628421, 6267.0286105653695, 6297.2128483939505, 6302.558820882586, 6359.777407790705, 4958.578520825698, 5237.057329680618, 5730.169125476783, 5940.762369505258, 5961.463468287875, 5304.681719096867, 5408.783648654088, 5410.404855465896, 5433.646812957145, 5443.5100840923715, 6273.654948977759, 6281.59169653971, 6371.74513019474, 6379.075034120119, 6411.3909178627955, 6253.8749225014335, 6272.435480806749, 6282.183316169052, 6294.8111556653375, 6296.6851657417865, 6203.658798766111, 6277.686115694106, 6362.936370636235, 6393.2328120625825, 6412.711427985845, 6115.727150604437, 6185.381461853958, 6257.937420625735, 6293.905591416224, 6319.24169099711, 6258.186435763504, 6267.2165979252595, 6292.685365731787, 6308.653024083719, 6316.968415157895, 4850.223964165716, 6025.276966764016, 6145.617236121837, 6192.504599632109, 6237.407446292595, 6252.218472690914, 6273.090401891609, 6286.779962701284, 6287.245530536182, 6303.959846625439, 4841.588464980516, 5069.0, 6056.606320589148, 6127.172831667668, 6152.230971128609, 5344.46555344478, 5921.171036055042, 6129.695011270001, 6226.688665566794, 6227.719752611234, 4989.401271847401, 6035.064564992434, 6042.335343112166, 6077.453029227391, 6092.177556029879], "unit": "score", "name": "dojo.html", "value": 5694.2063425342385}, {"lowerIsBetter": false, "replicates": [428.2975919492032, 464.1367057273471, 479.0490875611912, 526.1739069660634, 531.4260598553562, 36653.601567811864, 37455.06362340943, 37495.437568436464, 37540.0, 37618.62381376186, 38458.8077059615, 38997.41503877444, 39013.634522791705, 39024.219515609744, 39071.0, 9335.206507446876, 9518.857737071561, 9525.0, 9565.808683826319, 9577.138057574817, 9440.103190196955, 9696.70909872705, 9706.320557560974, 9716.465594392306, 9738.172255358302, 9694.903050969471, 9751.707448776513, 9757.463339516324, 9764.316497845153, 9812.950935245313, 9652.469114198717, 9711.90288097117, 9748.512574371289, 9748.658796942073, 9765.023497650249, 9506.667266645634, 9596.32825702201, 9634.518274086267, 9635.951820240924, 9666.275029372826, 37781.81109094465, 37929.81035094835, 38040.80979595112, 38114.42828357577, 38265.426018609745, 3308.3217940322415, 3377.9831100844585, 3536.7701099428455, 3688.2070354873563, 4002.779847108408, 24226.515469690683, 28637.997670081448, 28902.13293601174, 29194.270143246376, 29673.554896676567, 2748.367875388652, 2790.1768978151495, 2806.424682939992, 2980.672126066131, 2985.208919636298, 486950.0, 487785.0, 490594.0, 490763.5461822704, 491241.0, 44218.77890610526, 44674.55325446704, 44747.77626111849, 63066.68466657729, 63708.088757337355, 43199.9200020002, 43417.34873976893, 43430.78284608557, 43659.34510982338, 43670.56329436728, 14585.781213281809, 14753.92623036878, 14777.0, 14897.329620167118, 14918.627034324229, 11800.937915587638, 11922.701932451584, 11940.820887686692, 12017.579384721494, 12019.158658893793, 13131.409086591126, 13386.799198012037, 14331.498397556035, 14370.0, 14483.131012139305, 5467.589930755209, 6360.52296077796, 6469.770743558709, 6476.579022363531, 6493.967530162319, 893.9106089391009, 920.6685593186447, 994.8507723841337, 1050.2595670052594, 1160.2168536238175, 27059.782309796108, 29617.703822961925, 31714.524282135786, 31887.84056079705, 32795.67204327974, 932.6222879733718, 1005.653049697853, 1043.5669197283194, 1050.8949105089582, 1073.9516721747384, 14184.36170372315, 14264.786028209584, 14277.857221427861, 14438.927805361116, 14551.708965820624, 625549.0, 632178.0, 637083.0, 641285.0, 644910.0, 54697.45302547003, 54807.177892331645, 55015.724921375135, 55205.447945520835, 55229.44770552243, 1418.659521714781, 1447.21126985793, 1453.571196497036, 1456.9344379502948, 1466.8386477487682, 23939.0, 28030.2992425191, 28269.28939464399, 28385.0, 28476.0, 46329.3050604248, 46582.30126548172, 46774.0, 46987.765061174476, 47012.58962231139, 481413.0, 486265.0, 487381.0, 489676.0, 493508.0, 31953.68046319507, 32561.0, 32607.510887336233, 32734.508982365758, 32935.835320823244, 42300.36549451699, 42643.36034959416, 42669.786651067785, 43256.0, 43450.91372715707, 35388.0, 35966.640333596326, 36097.27805443929, 36309.27381452409, 36410.0, 35749.46375804417, 37123.0, 37884.62115378921, 38339.424908625835, 40237.994050148984, 35610.46584301186, 36191.095222619646, 37311.44032839564, 38361.61638383692, 38540.03649908775, 30080.849595751883, 31757.523637145, 31762.205944851565, 31803.0, 32028.679713203503, 20618.896905515976, 24263.150789722276, 24410.755892441557, 24539.0, 24593.262202133963], "unit": "score", "name": "ext.html", "value": 18864.07528788156}, {"lowerIsBetter": false, "replicates": [353.71879355912046, 359.5361983041876, 362.20496011255295, 362.42193701046835, 364.54614005563076, 15876.52370428889, 17531.948083115007, 19270.90364548177, 20410.183592656314, 20511.0, 19744.605107897834, 19950.0, 20490.38528844137, 20972.846493442892, 21064.262750803726, 5612.971935140339, 5680.261565996425, 5731.942680573204, 5774.682392468412, 5828.213191219194, 5056.418511871127, 5726.828195154152, 5819.7963071292515, 5848.707564621774, 5851.210086638313, 4128.793560321987, 5536.280283563131, 5789.334226563936, 5838.941610583882, 6111.755529778803, 6289.584843410219, 6315.494760419178, 6326.49388048955, 6334.778282760128, 6342.112104305401, 5234.26720259164, 5494.120940649477, 5497.862553436156, 5521.199426083235, 5526.392096869341, 25342.36644083894, 25374.0, 25454.87272563644, 25644.74355256442, 25728.0, 2134.306350436099, 2275.2719129878446, 2355.658429527709, 2406.0, 2414.4446777241333, 14369.56891293263, 14773.482928097572, 14843.851561484355, 14961.027533210307, 15422.845771542365, 1753.32496988659, 1765.0380542604312, 1770.3361239535175, 1773.0336966353368, 1787.5531117220694, 105079.0, 106328.93671063345, 106942.0, 106991.0, 109075.0, 10508.527116279633, 11069.833952490719, 11139.387333696724, 11211.94394028041, 11238.887611123784, 13115.950723942062, 13229.073964822563, 13230.338483076, 13286.800697989538, 13326.267055311857, 8712.825743485095, 8714.259287960467, 8715.477071375737, 8728.519931403835, 8780.165884240987, 8803.603837827313, 8895.421797583136, 8908.0, 8961.014288428267, 8992.685256016008, 5532.612717109763, 5616.382197958222, 6231.750729970841, 6375.6174629522375, 6467.611943283418, 1518.58238984278, 1739.721644536868, 1808.8965730904138, 1839.6688596052838, 1891.1773378580363, 396.179907591289, 402.9335159698675, 823.3001948343859, 901.985266575103, 928.0997432490474, 9165.725028249164, 20161.798382015993, 20745.377638670863, 20936.057877395553, 20956.161753529992, 434.1729006243112, 879.6217626420572, 937.9155875971195, 972.7324985629009, 974.8635191073255, 6098.237720284965, 6128.601640893327, 6178.104174894705, 6194.9690251549355, 6278.372162783777, 468699.0, 589591.0, 590001.0, 591246.0, 628894.0, 69961.0, 106222.0, 118664.0, 125735.0, 129718.0, 467.83391895877156, 471.8207081309149, 473.56432082484196, 476.5091955286061, 478.78215411987463, 10957.452127393757, 11296.83054754163, 11400.372979486208, 11466.484008219817, 11639.941800290944, 53474.73262633662, 54636.18045729238, 54735.16853820194, 55093.0, 55298.170527442926, 65131.34868651253, 65418.01872971814, 68503.31496684969, 73159.0, 74731.0, 8087.47431416956, 8207.261346478846, 8347.95826020866, 8359.0, 8539.658413663385, 11929.642110736691, 13269.66825829362, 13500.0, 13557.051006429456, 13589.388477518338, 11245.212835101791, 11497.310161390344, 11652.650420487398, 11674.0, 11809.586664466702, 11296.943515282372, 11383.601573944872, 11439.942800286279, 11656.472226366168, 11762.411879406167, 11846.289222646668, 11956.880431195577, 12004.39978001114, 12013.579524716593, 12047.939760301142, 8244.258016778518, 8427.452215605967, 8433.030201526903, 8446.535440550828, 8515.957420212859, 9400.388974716621, 11965.521379144737, 12021.398930053638, 12076.0, 12121.939390302992], "unit": "score", "name": "jquery.html", "value": 9021.577237111742}, {"lowerIsBetter": false, "replicates": [1576.8817338699596, 1598.2647981928317, 1861.3857427049074, 1895.431370588823, 1918.7697476302847, 7759.41804364672, 8541.188587084232, 8846.142310114876, 8962.731118066453, 8982.326325525588, 8715.0, 8749.606267717953, 8811.867821982676, 8817.030126686059, 8884.11158884113, 2429.489807140498, 2439.4633180700307, 2442.9877850610724, 2446.926592202237, 2460.323411061954, 2453.791747153631, 2463.1379017343875, 2485.5086947831246, 2494.114589320792, 2501.0746023971064, 1935.8064193580599, 2175.4887601413657, 2435.0990133650484, 2462.8645424501647, 2493.0, 1933.5262860599173, 2192.8049213178856, 2342.0865862313626, 2379.3932547200525, 2384.225126833786, 2043.7343145391003, 2328.1502251678016, 2425.575524283261, 2427.8543287402813, 2442.7801497865275, 8568.914310856937, 8686.348523860735, 8712.869306960401, 8737.126287371211, 8750.649974001033, 5286.15421532553, 5413.052715774724, 5445.50990410861, 5457.481539253765, 5555.444455554412, 3328.5839270091237, 3692.02161427222, 3743.569489508714, 3753.568339640949, 3763.0216143802536, 1022.8874823769379, 1045.3884477580625, 1065.9360438373722, 1071.9410432426214, 1090.8581884355062, 12005.159638825286, 12031.51873925042, 12090.455929483107, 12113.333766642743, 12144.696382590417, 4580.496145424001, 4603.710960930945, 4919.680220785637, 4979.029089327619, 4997.775100120503, 10022.799544009078, 10173.694789156338, 10275.845862312071, 10289.74275643115, 10323.277370584137, 5475.589330800206, 5490.725463726798, 5508.779648814083, 5531.25328080712, 5542.806001789918, 4925.21196608541, 4937.1606826839525, 4989.226669866177, 5035.018171456604, 5041.722705251246, 3764.887053388403, 3779.527559055118, 3784.848606055782, 3794.867179648699, 3808.21931504041, 1335.4724883670895, 1336.659151916255, 1338.0834128621925, 1348.6898013456764, 1356.125299182022, 979.8089372572423, 1140.6121918547733, 1161.0305394995273, 1285.126114242324, 1339.7923321885123, 7970.840583188304, 8023.117457079717, 8031.638576264082, 8048.0342358917305, 8057.476264042935, 1201.0511695760251, 1204.1390405859677, 1206.2943178240653, 1212.7872127872129, 1231.4212320209488, 6041.395860413923, 6121.112438696364, 6167.167432396659, 6180.598261113013, 6198.163247961557, 10312.948435257926, 10501.579936802595, 10828.0, 10898.782024359627, 10904.563817447372, 10063.245256605784, 10647.893521064845, 10685.412302323446, 10782.946085269523, 10788.0, 7937.2459616336355, 8096.959515202504, 8161.795955101051, 8222.876656850152, 8279.254867061993, 8040.075391330072, 8062.959685201537, 8174.67301307941, 8175.1007389188335, 8198.098209197104, 7575.696972121274, 9573.377730447499, 9635.0, 9782.559784809842, 9831.508424578886, 9618.0, 9824.115829575087, 9871.50642467888, 10096.798064038825, 10240.795184096127, 7569.205233450409, 7597.772066838003, 7660.3488703460835, 7680.155182929761, 7695.384369250559, 8142.796430089295, 8299.95850020746, 8307.086220515617, 8341.874871877048, 8345.95827020861, 6898.482613803884, 7164.391026762783, 7397.630118494161, 7489.176190619137, 7612.162662107275, 6775.627340496123, 6836.42762164695, 6871.106756121672, 7080.079589653312, 7371.226021267689, 7144.678234526629, 7303.8539229216185, 7745.031871016123, 7763.378929685498, 7805.726799561988, 7029.648517573998, 7032.683529241299, 7073.434125270069, 7078.504504684829, 7106.4314854810455, 6097.725602347817, 7121.715131394686, 7150.213476517683, 7188.496805223794, 7201.171865235356], "unit": "score", "name": "mootools.html", "value": 4929.35718324195}, {"lowerIsBetter": false, "replicates": [302.10124878486505, 324.2364232233091, 328.7287987410387, 328.912838097904, 332.7005694874614, 5369.677819330843, 6843.38409543141, 6891.689873955672, 6975.546589471694, 6986.056882320885, 5262.605304602161, 6814.829629259259, 6838.418734407582, 6888.24229334774, 6966.40785533229, 5094.77073531692, 5120.615953803461, 5124.8975020499565, 5143.53708166264, 5152.124138896378, 5134.486551344854, 5148.845534633967, 5150.716710580917, 5151.407588127376, 5156.071907056728, 5048.359283232946, 5050.898982020358, 5053.823116190934, 5057.5701065409485, 5059.671121377117, 4735.337052812609, 4941.678790878582, 5047.596192304625, 5071.0, 5080.3649543807205, 4152.875413737563, 4166.500019997619, 4170.9582904171175, 4174.519930208035, 4176.934881605202, 6545.280019197884, 6563.868722625521, 6587.473002159816, 6606.207255129367, 6608.2730899601, 5696.658200507983, 5828.038373668382, 5833.970830145865, 5840.503557197643, 5887.911681324784, 7253.891191632129, 7255.746048888316, 7257.78226653196, 7263.491555591111, 7327.34053935143, 3848.826802793853, 4653.976730116327, 4667.6732628716, 4668.159731248374, 4671.3226582145735, 7774.339181169607, 7808.492447990862, 7825.569593672346, 7827.295543401065, 7841.843163136762, 3691.427828686558, 4495.348174514677, 4610.608098311681, 4693.6949098308505, 4716.245400735935, 4265.55211702773, 4767.523247675204, 4768.356271903318, 4773.546513081321, 4774.331593576902, 4706.717596944194, 4839.346688197048, 4899.755012249373, 5814.418558144152, 5835.620684655484, 7375.18872923978, 7376.815579610553, 7383.15093764224, 7387.926120738832, 7399.963000185072, 1650.6946214950271, 1662.3766087717106, 1666.9916650416912, 1669.1320513333242, 1678.6055277009893, 1031.5615863258085, 1062.2351906627216, 1068.5307701909874, 1071.6517131931998, 1081.572778752404, 5766.481016708516, 6837.692303846339, 6974.407175390149, 6977.9651101745185, 7002.40479559233, 6254.312025677263, 7679.1936846631415, 7703.576303303372, 7717.498362606412, 7724.922750772533, 6971.930280697229, 6980.197277313073, 6990.720371185197, 6993.930060699429, 7006.369426751617, 3922.3135951208424, 3923.7841918694176, 4039.979800100981, 4069.1251380953236, 4077.9796101019306, 6434.356564343529, 7846.33306168982, 7968.7609371718945, 8047.396445266511, 8051.5571643559, 8020.19798020205, 8022.157673444204, 8028.397870159644, 8034.15641357649, 8044.1955804419085, 8043.356531477468, 8043.919560804317, 8054.315383192377, 8079.394045446497, 8092.069412017693, 6367.80896573085, 7710.306072453506, 7728.343090837342, 7730.574818384818, 7838.137804841577, 7588.089429268523, 7618.276263754934, 7620.123685775985, 7648.961755191411, 7653.311201991847, 8055.033395992518, 8077.474964127313, 8078.919210807817, 8079.111297757125, 8092.069412017458, 4725.976370118127, 4766.737829419277, 4780.976095119502, 4786.497417771084, 4795.20879054952, 7528.55989627922, 7642.7325043623205, 7702.576358300347, 7723.53658780475, 7734.458587898793, 7366.926330736838, 7455.552666840007, 7470.514416562906, 7472.663730132048, 7495.62521873915, 6038.818835434944, 7413.481056326005, 7416.332530072319, 7428.182899880901, 7430.962845185955, 6989.37095661393, 7250.528715633467, 7264.055672762507, 7264.273572642905, 7300.379467745302, 7454.068241469817, 7483.550986940801, 7486.7005319786595, 7488.775336739906, 7496.062992125984, 7229.674664639999, 7253.927460725326, 7262.745803896838, 7282.3809976152625, 7282.781516554512], "unit": "score", "name": "prototype.html", "value": 5314.949114706629}, {"lowerIsBetter": false, "replicates": [662.3438618824091, 669.9816279255534, 698.6227437183921, 714.8034290570092, 741.1328745367919, 15323.540293791177, 17212.569685757862, 17367.913160434196, 17402.56493587661, 17404.477865664034, 15937.442189523368, 15994.360225590963, 16016.35934562616, 16047.518574442756, 16047.759283610756, 848.1942154952789, 861.5649097205902, 880.0231742765525, 894.0880302091863, 896.5382827843666, 882.8675698645222, 883.1786438612088, 884.0938038510546, 884.3190743127788, 886.6985225023491, 915.2540679346345, 921.2814005076051, 925.4678559828092, 931.3294428011855, 934.2292608597934, 902.9638814447414, 920.9401388909699, 921.1985572551889, 924.2421214604027, 926.7683079230193, 679.2290749998738, 686.4439803758921, 688.7623769799411, 690.1097584116484, 690.927452617478, 15198.392064317413, 15374.154421506813, 15410.0, 15479.0, 15542.456014039455, 10851.348919064882, 11235.887641123565, 11938.28370297785, 12794.104412691115, 12961.740765184737, 10102.292839501239, 10210.846837297446, 10256.128229100535, 10258.076773090383, 10310.484475776182, 3076.26169719268, 3504.3341765064556, 3546.5921419036627, 3554.0581745837376, 3556.946645800315, 80800.19199807986, 81349.18650813475, 81907.0, 86956.13043869543, 87585.68621470683, 9717.076877696607, 9841.114299713061, 9876.259280553988, 9915.305928585074, 10490.475476226311, 21761.782382176294, 21956.23153189631, 21982.120715171535, 21994.670079948814, 22014.559708806053, 7409.962950185214, 7603.353714934182, 7667.616619169019, 7673.501222420525, 7817.452778305464, 4085.7344272622186, 4128.3601041838565, 4131.153113611703, 4140.523839758406, 4141.440905477722, 3496.0560648625237, 3498.212902097008, 3502.8598856045983, 3513.4202856528896, 3519.278547897675, 589.4135335341277, 620.3548309757891, 652.670401447266, 657.4740207833714, 667.9866402671919, 507.4266079330333, 520.4613225311784, 595.684287327717, 597.6234971967633, 601.20940962634, 7084.822879428056, 8385.83228335442, 8413.621387037598, 8598.140185981478, 8782.780430489162, 500.5920175057317, 544.3032917865139, 590.153130258081, 625.7059182184366, 626.7493002798917, 3895.454636350913, 4016.638502534786, 4139.296319625671, 4168.353905144708, 4411.955880441219, 86983.0, 88883.55558222167, 89668.10331896598, 89915.55042224878, 92087.0, 78938.81591776013, 79135.0, 79489.4102117966, 79565.60217198876, 79682.60158699169, 53678.73160634172, 65426.67286663631, 72630.0, 75471.35850245215, 76090.0, 7561.508501947355, 8879.822403552022, 8892.688755893512, 8940.86588701157, 9025.81948361016, 31992.840035799672, 46255.53744462512, 46495.372661956666, 47446.0, 48257.75871120622, 57169.714151428976, 62713.0, 63044.36955630385, 63103.36896630975, 63414.0, 11174.66476005721, 11379.260348077349, 11421.600243991752, 11462.598809041643, 11899.702507437383, 11372.54509819598, 11963.700907477383, 12390.62828115158, 12716.491340346283, 12752.48990040388, 11212.66362009141, 11267.647717935375, 11297.887021130013, 11633.59282425111, 12405.75188496207, 11401.087912967108, 11406.771864562828, 11586.527017376922, 11726.296422214695, 12393.876061239273, 11082.833757493483, 11496.712582185512, 11514.712132196762, 11530.077593792645, 11553.480093395649, 9276.62893484253, 9481.431114133175, 9508.572114254737, 9675.371100878421, 10569.312994655324, 7602.885956710765, 8980.012198658273, 9164.911031324502, 9510.0, 9710.75723106928], "unit": "score", "name": "yui.html", "value": 6920.275165209217}], "name": "dromaeo_css", "value": 7483.9801818685555}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 104.0, 162.0, 114.0, 145.0, 147.0, 168.0, 170.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 135.2}, {"lowerIsBetter": true, "replicates": [179.0, 160.0, 144.0, 153.0, 125.0, 140.0, 174.0, 112.0, 179.0, 147.0], "unit": "score", "name": "audio-beat-detection", "value": 151.3}, {"lowerIsBetter": true, "replicates": [190.0, 194.0, 200.0, 211.0, 225.0, 197.0, 197.0, 196.0, 204.0, 199.0], "unit": "score", "name": "audio-dft", "value": 201.3}, {"lowerIsBetter": true, "replicates": [69.0, 78.0, 72.0, 106.0, 58.0, 55.0, 58.0, 58.0, 108.0, 57.0], "unit": "score", "name": "audio-fft", "value": 71.9}, {"lowerIsBetter": true, "replicates": [85.0, 96.0, 119.0, 92.0, 117.0, 117.0, 117.0, 80.0, 81.0, 111.0], "unit": "score", "name": "audio-oscillator", "value": 101.5}, {"lowerIsBetter": true, "replicates": [87.0, 114.0, 127.0, 113.0, 87.0, 93.0, 86.0, 92.0, 87.0, 113.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 99.9}, {"lowerIsBetter": true, "replicates": [117.0, 95.0, 101.0, 97.0, 100.0, 148.0, 99.0, 132.0, 143.0, 97.0], "unit": "score", "name": "imaging-darkroom", "value": 112.9}, {"lowerIsBetter": true, "replicates": [146.0, 149.0, 92.0, 95.0, 96.0, 132.0, 112.0, 148.0, 144.0, 105.0], "unit": "score", "name": "imaging-desaturate", "value": 121.9}, {"lowerIsBetter": true, "replicates": [56.0, 75.0, 78.0, 81.0, 77.0, 80.0, 82.0, 91.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 72.9}, {"lowerIsBetter": true, "replicates": [65.0, 69.0, 72.0, 78.0, 75.0, 70.0, 65.0, 68.0, 72.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.1}, {"lowerIsBetter": true, "replicates": [97.0, 85.0, 88.0, 84.0, 89.0, 87.0, 85.0, 87.0, 86.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.2}, {"lowerIsBetter": true, "replicates": [129.0, 128.0, 123.0, 135.0, 139.0, 141.0, 138.0, 128.0, 127.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 131.5}, {"lowerIsBetter": true, "replicates": [143.0, 159.0, 143.0, 142.0, 141.0, 148.0, 144.0, 142.0, 176.0, 164.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.2}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 64.0, 56.0, 80.0, 55.0, 61.0, 84.0, 95.0, 98.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.7}], "name": "kraken", "value": 1580.5}]} 03:49:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1580.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7483.98"}}} 03:49:01 INFO - Return code: 0 03:49:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:49:01 ERROR - # TBPL SUCCESS # 03:49:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:49:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:49:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:49:01 INFO - 2016-02-25 03:49:01.218 screenresolution[1719:10254] starting screenresolution argv=screenresolution get 03:49:01 INFO - 2016-02-25 03:49:01.221 screenresolution[1719:10254] Display 0: 1600x1200x32@60 03:49:01 INFO - 2016-02-25 03:49:01.227 screenresolution[1720:10257] starting screenresolution argv=screenresolution list 03:49:01 INFO - Available Modes on Display 0 03:49:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:49:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:49:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:49:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:49:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:49:01 INFO - Intel Iris: 03:49:01 INFO - Chipset Model: Intel Iris 03:49:01 INFO - Type: GPU 03:49:01 INFO - Bus: Built-In 03:49:01 INFO - VRAM (Dynamic, Max): 1536 MB 03:49:01 INFO - Vendor: Intel (0x8086) 03:49:01 INFO - Device ID: 0x0a2e 03:49:01 INFO - Revision ID: 0x0009 03:49:01 INFO - Displays: 03:49:01 INFO - Display: 03:49:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:49:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:49:01 INFO - Display Serial Number: 1600x1200 60 03:49:01 INFO - Main Display: Yes 03:49:01 INFO - Mirror: Off 03:49:01 INFO - Online: Yes 03:49:01 INFO - Rotation: Supported 03:49:01 INFO - Return code: 0 03:49:01 INFO - Running post-action listener: _resource_record_post_action 03:49:01 INFO - Running post-run listener: _resource_record_post_run 03:49:02 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 38888960; Write bytes: 713353216; Read time: 422; Write time: 1967 03:49:02 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 382878208; Write bytes: 380653056; Read time: 29508; Write time: 665 03:49:02 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 37926400; Write bytes: 303094272; Read time: 407; Write time: 1243 03:49:02 INFO - Running post-run listener: _upload_blobber_files 03:49:02 INFO - Blob upload gear active. 03:49:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:49:02 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 03:49:02 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'] 03:49:02 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 03:49:02 INFO - (blobuploader) - INFO - Open directory for files ... 03:49:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:49:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:49:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:04 INFO - (blobuploader) - INFO - Done attempting. 03:49:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:49:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:49:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:04 INFO - (blobuploader) - INFO - Done attempting. 03:49:04 INFO - (blobuploader) - INFO - Iteration through files over. 03:49:04 INFO - Return code: 0 03:49:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:49:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:49:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3556ce33c4c1b97de9a811a95fbbe888253d936ec8db7fac4dcc001964afb971937b6b9bc04fca2ff03d288c19bbfd03c71c1acd2a3e454618227834d3ebe231", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2873c4d4f78ac5435992a5247951c7bfd2226ac3a7d1cd2847b9b57166f0b3bb3eeee3bf38ead0f980cb030d4d5e0d3ac35af01112c8d61fa6c25acd8b9d95d5"} 03:49:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:49:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:49:04 INFO - Contents: 03:49:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3556ce33c4c1b97de9a811a95fbbe888253d936ec8db7fac4dcc001964afb971937b6b9bc04fca2ff03d288c19bbfd03c71c1acd2a3e454618227834d3ebe231", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2873c4d4f78ac5435992a5247951c7bfd2226ac3a7d1cd2847b9b57166f0b3bb3eeee3bf38ead0f980cb030d4d5e0d3ac35af01112c8d61fa6c25acd8b9d95d5"} 03:49:04 INFO - Running post-run listener: copy_logs_to_upload_dir 03:49:04 INFO - Copying logs to upload dir... 03:49:04 INFO - mkdir: /builds/slave/test/build/upload/logs 03:49:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.566412 ========= master_lag: 1.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-25 03:49:06.050263) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-02-25 03:49:06.053956) ========= 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.uUWUvOpbek/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.3k9Pj5M48A/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3556ce33c4c1b97de9a811a95fbbe888253d936ec8db7fac4dcc001964afb971937b6b9bc04fca2ff03d288c19bbfd03c71c1acd2a3e454618227834d3ebe231", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2873c4d4f78ac5435992a5247951c7bfd2226ac3a7d1cd2847b9b57166f0b3bb3eeee3bf38ead0f980cb030d4d5e0d3ac35af01112c8d61fa6c25acd8b9d95d5"} build_url:https://queue.taskcluster.net/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011083 build_url: 'https://queue.taskcluster.net/v1/task/QSTIMlL6RlCEuv-Fgu_8gA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3556ce33c4c1b97de9a811a95fbbe888253d936ec8db7fac4dcc001964afb971937b6b9bc04fca2ff03d288c19bbfd03c71c1acd2a3e454618227834d3ebe231", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2873c4d4f78ac5435992a5247951c7bfd2226ac3a7d1cd2847b9b57166f0b3bb3eeee3bf38ead0f980cb030d4d5e0d3ac35af01112c8d61fa6c25acd8b9d95d5"}' ========= master_lag: 1.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-02-25 03:49:07.073259) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-02-25 03:49:07.073620) ========= 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.uUWUvOpbek/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.3k9Pj5M48A/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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.004961 ========= master_lag: 5.79 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-02-25 03:49:12.869753) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 03:49:12.870135) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 03:49:12.897596) ========= ========= Total master_lag: 7.99 =========