builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0103 starttime: 1454547225.65 results: success (0) buildid: 20160203160127 builduid: e40baffe6216463880c76ee78c365f9b revision: a81960ce939edd6bff30d85fa07350e780901dac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-03 16:53:45.646739) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-03 16:53:45.647132) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-03 16:53:45.647421) ========= 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.RhyHUauhg1/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.wTWuoo0NOl/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.005738 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-03 16:53:45.708251) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-03 16:53:45.708579) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-03 16:53:45.738904) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 16:53:45.739210) ========= 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.RhyHUauhg1/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.wTWuoo0NOl/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.005292 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 16:53:45.803031) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-03 16:53:45.803302) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-03 16:53:45.803682) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 16:53:45.804127) ========= 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.RhyHUauhg1/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.wTWuoo0NOl/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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-03 16:53:45-- 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% 8.31M=0.001s 2016-02-03 16:53:46 (8.31 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.463570 ========= master_lag: 0.18 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 16:53:46.446224) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 16:53:46.446551) ========= 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.RhyHUauhg1/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.wTWuoo0NOl/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.019451 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 16:53:46.496739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-03 16:53:46.497042) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a81960ce939edd6bff30d85fa07350e780901dac --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 a81960ce939edd6bff30d85fa07350e780901dac --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RhyHUauhg1/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.wTWuoo0NOl/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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-03 16:53:46,578 truncating revision to first 12 chars 2016-02-03 16:53:46,578 Setting DEBUG logging. 2016-02-03 16:53:46,578 attempt 1/10 2016-02-03 16:53:46,578 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a81960ce939e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-03 16:53:48,462 unpacking tar archive at: fx-team-a81960ce939e/testing/mozharness/ program finished with exit code 0 elapsedTime=2.123094 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-03 16:53:48.639519) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-03 16:53:48.639871) ========= echo a81960ce939edd6bff30d85fa07350e780901dac in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a81960ce939edd6bff30d85fa07350e780901dac'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RhyHUauhg1/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.wTWuoo0NOl/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 a81960ce939edd6bff30d85fa07350e780901dac program finished with exit code 0 elapsedTime=0.005073 script_repo_revision: 'a81960ce939edd6bff30d85fa07350e780901dac' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-03 16:53:48.698989) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-03 16:53:48.699284) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-03 16:53:48.746299) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-02-03 16:53:48.746603) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RhyHUauhg1/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.wTWuoo0NOl/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 16:53:48 INFO - MultiFileLogger online at 20160203 16:53:48 in /builds/slave/test 16:53:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:53:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:53:48 INFO - {'append_to_log': False, 16:53:48 INFO - 'base_work_dir': '/builds/slave/test', 16:53:48 INFO - 'blob_upload_branch': 'Fx-Team', 16:53:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:53:48 INFO - 'branch': 'Fx-Team', 16:53:48 INFO - 'buildbot_json_path': 'buildprops.json', 16:53:48 INFO - 'config_files': ('talos/mac_config.py',), 16:53:48 INFO - 'default_actions': ('clobber', 16:53:48 INFO - 'read-buildbot-config', 16:53:48 INFO - 'download-and-extract', 16:53:48 INFO - 'populate-webroot', 16:53:48 INFO - 'create-virtualenv', 16:53:48 INFO - 'install', 16:53:48 INFO - 'run-tests'), 16:53:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:53:48 INFO - 'download_minidump_stackwalk': True, 16:53:48 INFO - 'download_symbols': 'ondemand', 16:53:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:53:48 INFO - 'tooltool.py': '/tools/tooltool.py', 16:53:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:53:48 INFO - '/tools/misc-python/virtualenv.py')}, 16:53:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:53:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:53:48 INFO - 'installer_path': 'installer.exe', 16:53:48 INFO - 'log_level': 'info', 16:53:48 INFO - 'log_name': 'talos', 16:53:48 INFO - 'log_to_console': True, 16:53:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:53:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:53:48 INFO - 'opt_config_files': (), 16:53:48 INFO - 'pip_index': False, 16:53:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:53:48 INFO - 'cmd': ('bash', 16:53:48 INFO - '-c', 16:53:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:53:48 INFO - 'enabled': True, 16:53:48 INFO - 'halt_on_failure': False, 16:53:48 INFO - 'name': 'check_screen_resolution'},), 16:53:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:53:48 INFO - 'cmd': ('bash', 16:53:48 INFO - '-c', 16:53:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:53:48 INFO - 'enabled': True, 16:53:48 INFO - 'halt_on_failure': False, 16:53:48 INFO - 'name': 'check_screen_resolution'},), 16:53:48 INFO - 'run_cmd_checks_enabled': True, 16:53:48 INFO - 'sps_profile': False, 16:53:48 INFO - 'sps_profile_interval': 0, 16:53:48 INFO - 'suite': 'dromaeojs', 16:53:48 INFO - 'system_bits': '32', 16:53:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:53:48 INFO - 'title': 't-yosemite-r7-0103', 16:53:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:53:48 INFO - 'use_talos_json': True, 16:53:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:53:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:53:48 INFO - 'work_dir': 'build'} 16:53:48 INFO - ##### 16:53:48 INFO - ##### Running clobber step. 16:53:48 INFO - ##### 16:53:48 INFO - Running pre-action listener: _resource_record_pre_action 16:53:48 INFO - Running main action method: clobber 16:53:48 INFO - rmtree: /builds/slave/test/build 16:53:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:53:50 INFO - Running post-action listener: _resource_record_post_action 16:53:50 INFO - ##### 16:53:50 INFO - ##### Running read-buildbot-config step. 16:53:50 INFO - ##### 16:53:50 INFO - Running pre-action listener: _resource_record_pre_action 16:53:50 INFO - Running main action method: read_buildbot_config 16:53:50 INFO - Using buildbot properties: 16:53:50 INFO - { 16:53:50 INFO - "project": "", 16:53:50 INFO - "product": "firefox", 16:53:50 INFO - "script_repo_revision": "production", 16:53:50 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 16:53:50 INFO - "repository": "", 16:53:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 16:53:50 INFO - "buildid": "20160203160127", 16:53:50 INFO - "pgo_build": "False", 16:53:50 INFO - "basedir": "/builds/slave/test", 16:53:50 INFO - "buildnumber": 388, 16:53:50 INFO - "slavename": "t-yosemite-r7-0103", 16:53:50 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:53:50 INFO - "platform": "yosemite_r7", 16:53:50 INFO - "scheduler": "tests-fx-team-macosx64-talos", 16:53:50 INFO - "branch": "fx-team", 16:53:50 INFO - "repo_path": "integration/fx-team", 16:53:50 INFO - "revision": "a81960ce939edd6bff30d85fa07350e780901dac", 16:53:50 INFO - "stage_platform": "macosx64", 16:53:50 INFO - "builduid": "e40baffe6216463880c76ee78c365f9b", 16:53:50 INFO - "slavebuilddir": "test" 16:53:50 INFO - } 16:53:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 16:53:50 INFO - Running post-action listener: _resource_record_post_action 16:53:50 INFO - ##### 16:53:50 INFO - ##### Running download-and-extract step. 16:53:50 INFO - ##### 16:53:50 INFO - Running pre-action listener: _resource_record_pre_action 16:53:50 INFO - Running main action method: download_and_extract 16:53:50 INFO - mkdir: /builds/slave/test/build/tests 16:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:50 INFO - https://queue.taskcluster.net/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:53:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/test_packages.json 16:53:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/test_packages.json 16:53:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:53:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:53:57 INFO - Downloaded 1277 bytes. 16:53:57 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:53:57 INFO - Using the following test package requirements: 16:53:57 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:53:57 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:53:57 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 16:53:57 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:53:57 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 16:53:57 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:53:57 INFO - u'jsshell-mac.zip'], 16:53:57 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:53:57 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 16:53:57 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:53:57 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:53:57 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 16:53:57 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:53:57 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 16:53:57 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:53:57 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 16:53:57 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:53:57 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:53:57 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 16:53:57 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:53:57 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')]} 16:53:57 INFO - https://queue.taskcluster.net/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:53:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:53:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:53:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjwPsykcRcufT4NhKFqwZA/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 16:53:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjwPsykcRcufT4NhKFqwZA/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 16:54:02 INFO - Downloaded 17118706 bytes. 16:54:02 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'] 16:54:02 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 16:54:05 INFO - Return code: 0 16:54:05 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 16:54: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')]} 16:54:05 INFO - https://queue.taskcluster.net/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:54:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:54:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:54:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjwPsykcRcufT4NhKFqwZA/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 16:54:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjwPsykcRcufT4NhKFqwZA/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 16:54:09 INFO - Downloaded 17118706 bytes. 16:54:09 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'] 16:54:09 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 16:54:12 INFO - Return code: 0 16:54:12 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')]} 16:54:12 INFO - https://queue.taskcluster.net/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:54:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 16:54:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 16:54:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjwPsykcRcufT4NhKFqwZA/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 16:54:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjwPsykcRcufT4NhKFqwZA/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 16:54:13 INFO - Downloaded 10706582 bytes. 16:54:13 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'] 16:54:13 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 16:54:13 INFO - Return code: 0 16:54: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')]} 16:54:13 INFO - https://queue.taskcluster.net/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:54:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:54:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:54:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 16:54:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjwPsykcRcufT4NhKFqwZA/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 16:54:17 INFO - Downloaded 111118130 bytes. 16:54:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:54:17 INFO - mkdir: /builds/slave/test/properties 16:54:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:54:17 INFO - Writing to file /builds/slave/test/properties/build_url 16:54:17 INFO - Contents: 16:54:17 INFO - build_url:https://queue.taskcluster.net/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:54:18 INFO - Running post-action listener: _resource_record_post_action 16:54:18 INFO - Running post-action listener: set_extra_try_arguments 16:54:18 INFO - ##### 16:54:18 INFO - ##### Running populate-webroot step. 16:54:18 INFO - ##### 16:54:18 INFO - Running pre-action listener: _resource_record_pre_action 16:54:18 INFO - Running main action method: populate_webroot 16:54:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:54:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:54:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:54:18 INFO - '--tppagecycles', 16:54:18 INFO - '7'], 16:54:18 INFO - 'tests': ['tsvgm']}}, 16:54:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:54:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:54:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:54:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:54:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:54:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:54:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:54:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:18 INFO - 'talos_options': ['--e10s'], 16:54:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:54:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:18 INFO - 'tests': ['damp', 'tps']}, 16:54:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:18 INFO - 'talos_options': ['--e10s'], 16:54:18 INFO - 'tests': ['damp', 'tps']}, 16:54:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:54:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:54:18 INFO - 'other': {'tests': ['a11yr', 16:54:18 INFO - 'ts_paint', 16:54:18 INFO - 'tpaint', 16:54:18 INFO - 'sessionrestore', 16:54:18 INFO - 'sessionrestore_no_auto_restore']}, 16:54:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:54:18 INFO - 'tests': ['a11yr', 16:54:18 INFO - 'ts_paint', 16:54:18 INFO - 'tpaint', 16:54:18 INFO - 'sessionrestore', 16:54:18 INFO - 'sessionrestore_no_auto_restore']}, 16:54:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:54:18 INFO - 'tests': ['a11yr', 16:54:18 INFO - 'ts_paint', 16:54:18 INFO - 'tpaint', 16:54:18 INFO - 'sessionrestore', 16:54:18 INFO - 'sessionrestore_no_auto_restore']}, 16:54:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:54:18 INFO - 'tests': ['a11yr', 16:54:18 INFO - 'ts_paint', 16:54:18 INFO - 'tpaint', 16:54:18 INFO - 'sessionrestore', 16:54:18 INFO - 'sessionrestore_no_auto_restore']}, 16:54:18 INFO - 'other_l64': {'tests': ['a11yr', 16:54:18 INFO - 'ts_paint', 16:54:18 INFO - 'tpaint', 16:54:18 INFO - 'sessionrestore', 16:54:18 INFO - 'sessionrestore_no_auto_restore']}, 16:54:18 INFO - 'other_nol64': {'tests': ['a11yr', 16:54:18 INFO - 'ts_paint', 16:54:18 INFO - 'tpaint', 16:54:18 INFO - 'sessionrestore', 16:54:18 INFO - 'sessionrestore_no_auto_restore']}, 16:54:18 INFO - 'svgr': {'tests': ['tsvgx', 16:54:18 INFO - 'tsvgr_opacity', 16:54:18 INFO - 'tart', 16:54:18 INFO - 'tscrollx', 16:54:18 INFO - 'cart']}, 16:54:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:54:18 INFO - 'tests': ['tsvgx', 16:54:18 INFO - 'tsvgr_opacity', 16:54:18 INFO - 'tart', 16:54:18 INFO - 'tscrollx', 16:54:18 INFO - 'cart']}, 16:54:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:18 INFO - 'tests': ['tp5o']}, 16:54:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:18 INFO - 'talos_options': ['--e10s'], 16:54:18 INFO - 'tests': ['tp5o']}, 16:54:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:18 INFO - 'talos_options': ['--xperf_path', 16:54:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:54:18 INFO - 'tests': ['tp5n']}, 16:54:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:18 INFO - 'talos_options': ['--e10s', 16:54:18 INFO - '--xperf_path', 16:54:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:54:18 INFO - 'tests': ['tp5n']}}, 16:54:18 INFO - 'talos.zip': {'path': '', 16:54:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:54:18 INFO - Running post-action listener: _resource_record_post_action 16:54:18 INFO - ##### 16:54:18 INFO - ##### Running create-virtualenv step. 16:54:18 INFO - ##### 16:54:18 INFO - Running pre-action listener: _resource_record_pre_action 16:54:18 INFO - Running main action method: create_virtualenv 16:54:18 INFO - Creating virtualenv /builds/slave/test/build/venv 16:54: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 16:54:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:54:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:54:18 INFO - Using real prefix '/tools/python27' 16:54:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:54:19 INFO - Installing distribute.............................................................................................................................................................................................done. 16:54:21 INFO - Installing pip.................done. 16:54:21 INFO - Return code: 0 16:54:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:54:21 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')]} 16:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:21 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')]} 16:54:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:21 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 0x1099f1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099f84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff860d619e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109896d30>, '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 0x1096b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10988cb20>, '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.RhyHUauhg1/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.wTWuoo0NOl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 16:54:21 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 16:54:21 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 16:54:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RhyHUauhg1/Render', 16:54:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:21 INFO - 'HOME': '/Users/cltbld', 16:54:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:21 INFO - 'LOGNAME': 'cltbld', 16:54:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:21 INFO - 'MOZ_NO_REMOTE': '1', 16:54:21 INFO - 'NO_EM_RESTART': '1', 16:54:21 INFO - 'PAGER': '/bin/cat', 16:54:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:21 INFO - 'PWD': '/builds/slave/test', 16:54:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:21 INFO - 'SHELL': '/bin/bash', 16:54:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTWuoo0NOl/Listeners', 16:54:21 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 16:54:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:21 INFO - 'USER': 'cltbld', 16:54:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:21 INFO - 'XPC_FLAGS': '0x0', 16:54:21 INFO - 'XPC_SERVICE_NAME': '0', 16:54:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54: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 16:54:22 INFO - Cleaning up... 16:54:22 INFO - Return code: 0 16:54:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:54: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')]} 16:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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')]} 16:54:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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 0x1099f1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099f84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff860d619e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109896d30>, '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 0x1096b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10988cb20>, '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.RhyHUauhg1/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.wTWuoo0NOl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 16:54: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 16:54: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 16:54:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RhyHUauhg1/Render', 16:54:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:22 INFO - 'HOME': '/Users/cltbld', 16:54:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:22 INFO - 'LOGNAME': 'cltbld', 16:54:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:22 INFO - 'MOZ_NO_REMOTE': '1', 16:54:22 INFO - 'NO_EM_RESTART': '1', 16:54:22 INFO - 'PAGER': '/bin/cat', 16:54:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:22 INFO - 'PWD': '/builds/slave/test', 16:54:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:22 INFO - 'SHELL': '/bin/bash', 16:54:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTWuoo0NOl/Listeners', 16:54:22 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 16:54:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:22 INFO - 'USER': 'cltbld', 16:54:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:22 INFO - 'XPC_FLAGS': '0x0', 16:54:22 INFO - 'XPC_SERVICE_NAME': '0', 16:54:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:22 INFO - Downloading/unpacking psutil>=0.7.1 16:54:22 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 16:54:22 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 16:54:22 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 16:54:22 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 16:54:22 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 16:54:22 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 16:54:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:54:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:54:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:54:25 INFO - Installing collected packages: psutil 16:54:25 INFO - Running setup.py install for psutil 16:54:25 INFO - building 'psutil._psutil_osx' extension 16:54:25 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 16:54: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 16:54: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 16:54: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 16:54:26 INFO - building 'psutil._psutil_posix' extension 16:54: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 16:54:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:54:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:54:26 INFO - ^ 16:54:26 INFO - 1 warning generated. 16:54:26 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 16:54:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:54:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:54:26 INFO - Successfully installed psutil 16:54:26 INFO - Cleaning up... 16:54:26 INFO - Return code: 0 16:54:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:54:26 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')]} 16:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:26 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')]} 16:54:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:26 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 0x1099f1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099f84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff860d619e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109896d30>, '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 0x1096b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10988cb20>, '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.RhyHUauhg1/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.wTWuoo0NOl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 16:54:26 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 16:54:26 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 16:54:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RhyHUauhg1/Render', 16:54:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:26 INFO - 'HOME': '/Users/cltbld', 16:54:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:26 INFO - 'LOGNAME': 'cltbld', 16:54:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:26 INFO - 'MOZ_NO_REMOTE': '1', 16:54:26 INFO - 'NO_EM_RESTART': '1', 16:54:26 INFO - 'PAGER': '/bin/cat', 16:54:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:26 INFO - 'PWD': '/builds/slave/test', 16:54:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:26 INFO - 'SHELL': '/bin/bash', 16:54:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTWuoo0NOl/Listeners', 16:54:26 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 16:54:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:26 INFO - 'USER': 'cltbld', 16:54:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:26 INFO - 'XPC_FLAGS': '0x0', 16:54:26 INFO - 'XPC_SERVICE_NAME': '0', 16:54:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:54:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:54: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) 16:54:29 INFO - Installing collected packages: mozsystemmonitor 16:54:29 INFO - Running setup.py install for mozsystemmonitor 16:54:29 INFO - Successfully installed mozsystemmonitor 16:54:29 INFO - Cleaning up... 16:54:29 INFO - Return code: 0 16:54:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:54:29 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')]} 16:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:29 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')]} 16:54:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:29 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 0x1099f1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099f84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff860d619e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109896d30>, '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 0x1096b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10988cb20>, '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.RhyHUauhg1/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.wTWuoo0NOl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 16:54:29 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 16:54:29 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 16:54:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RhyHUauhg1/Render', 16:54:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:29 INFO - 'HOME': '/Users/cltbld', 16:54:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:29 INFO - 'LOGNAME': 'cltbld', 16:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:29 INFO - 'MOZ_NO_REMOTE': '1', 16:54:29 INFO - 'NO_EM_RESTART': '1', 16:54:29 INFO - 'PAGER': '/bin/cat', 16:54:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:29 INFO - 'PWD': '/builds/slave/test', 16:54:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:29 INFO - 'SHELL': '/bin/bash', 16:54:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTWuoo0NOl/Listeners', 16:54:29 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 16:54:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:29 INFO - 'USER': 'cltbld', 16:54:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:29 INFO - 'XPC_FLAGS': '0x0', 16:54:29 INFO - 'XPC_SERVICE_NAME': '0', 16:54:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:29 INFO - Downloading/unpacking blobuploader==1.2.4 16:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:32 INFO - Downloading blobuploader-1.2.4.tar.gz 16:54:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:54:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:54:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54:33 INFO - Downloading docopt-0.6.1.tar.gz 16:54:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:54:33 INFO - Installing collected packages: blobuploader, requests, docopt 16:54:33 INFO - Running setup.py install for blobuploader 16:54:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:54:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:54:33 INFO - Running setup.py install for requests 16:54:33 INFO - Running setup.py install for docopt 16:54:34 INFO - Successfully installed blobuploader requests docopt 16:54:34 INFO - Cleaning up... 16:54:34 INFO - Return code: 0 16:54:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:54: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')]} 16:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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')]} 16:54:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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 0x1099f1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099f84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff860d619e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109896d30>, '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 0x1096b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10988cb20>, '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.RhyHUauhg1/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.wTWuoo0NOl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 16:54: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 16:54: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 16:54:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RhyHUauhg1/Render', 16:54:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:34 INFO - 'HOME': '/Users/cltbld', 16:54:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:34 INFO - 'LOGNAME': 'cltbld', 16:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:34 INFO - 'MOZ_NO_REMOTE': '1', 16:54:34 INFO - 'NO_EM_RESTART': '1', 16:54:34 INFO - 'PAGER': '/bin/cat', 16:54:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:34 INFO - 'PWD': '/builds/slave/test', 16:54:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:34 INFO - 'SHELL': '/bin/bash', 16:54:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTWuoo0NOl/Listeners', 16:54:34 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 16:54:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:34 INFO - 'USER': 'cltbld', 16:54:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:34 INFO - 'XPC_FLAGS': '0x0', 16:54:34 INFO - 'XPC_SERVICE_NAME': '0', 16:54:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:54:34 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-lKKsvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:54:34 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-7Q6o3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:54:34 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-C0E8U2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:54:34 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-4MeplK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:54:34 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-KKBz6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:54:34 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-TXZHRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:54:35 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-jD7zoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:54:35 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-6WWEld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:54:35 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-nvUnnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:54:35 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-uHbcgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:54:35 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-HA6Lua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:54:35 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-QSZ4w4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:54:35 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-CDYrJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:54:35 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-R8oeN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:35 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-gDmubr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:54:36 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-hpK9gC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:54:36 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-klnFJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:54:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:54:36 INFO - Running setup.py install for manifestparser 16:54:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Running setup.py install for mozcrash 16:54:36 INFO - Running setup.py install for mozdebug 16:54:36 INFO - Running setup.py install for mozdevice 16:54:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Running setup.py install for mozfile 16:54:36 INFO - Running setup.py install for mozhttpd 16:54:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:54:37 INFO - Running setup.py install for mozinfo 16:54:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:54:37 INFO - Running setup.py install for mozInstall 16:54:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:54:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:54:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:54:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:54:37 INFO - Running setup.py install for mozleak 16:54:37 INFO - Running setup.py install for mozlog 16:54:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:54:37 INFO - Running setup.py install for moznetwork 16:54:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:54:37 INFO - Running setup.py install for mozprocess 16:54:38 INFO - Running setup.py install for mozprofile 16:54:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:54:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:54:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:54:38 INFO - Running setup.py install for mozrunner 16:54:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:54:38 INFO - Running setup.py install for mozscreenshot 16:54:38 INFO - Running setup.py install for moztest 16:54:38 INFO - Running setup.py install for mozversion 16:54:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:54:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:54:38 INFO - Cleaning up... 16:54:38 INFO - Return code: 0 16:54:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:38 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 0x1099f1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099f84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff860d619e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109896d30>, '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 0x1096b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10988cb20>, '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.RhyHUauhg1/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.wTWuoo0NOl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 16:54:38 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 16:54:38 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 16:54:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RhyHUauhg1/Render', 16:54:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:38 INFO - 'HOME': '/Users/cltbld', 16:54:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:38 INFO - 'LOGNAME': 'cltbld', 16:54:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:38 INFO - 'MOZ_NO_REMOTE': '1', 16:54:38 INFO - 'NO_EM_RESTART': '1', 16:54:38 INFO - 'PAGER': '/bin/cat', 16:54:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:38 INFO - 'PWD': '/builds/slave/test', 16:54:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:38 INFO - 'SHELL': '/bin/bash', 16:54:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTWuoo0NOl/Listeners', 16:54:38 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 16:54:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:38 INFO - 'USER': 'cltbld', 16:54:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:38 INFO - 'XPC_FLAGS': '0x0', 16:54:38 INFO - 'XPC_SERVICE_NAME': '0', 16:54:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:54:39 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-1EKd7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:54: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)) 16:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:54:39 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-qp558j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:54: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)) 16:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:54:39 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-o2Nqt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:54:39 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)) 16:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:54:39 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-dREZYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:54:39 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)) 16:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:54:39 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-o5mW1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:54:39 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)) 16:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:54:39 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-X8DAQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:54:39 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)) 16:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:54:39 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-HOnBoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:54:39 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)) 16:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:54:39 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-OpU_c6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:54:39 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)) 16:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:54:39 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-rxZrJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:54: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)) 16:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:54:40 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-_F_m0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:54: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)) 16:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:54:40 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-6seRup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:54: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)) 16:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:54:40 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-1w8ew2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:54: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)) 16:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:54:40 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-BMLgDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:54:40 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)) 16:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:54:40 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-qShtNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:54:40 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)) 16:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:40 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-84KFBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:40 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)) 16:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:54:40 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-0s03Dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:54:40 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)) 16:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:54:40 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Jsz0BF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:54:40 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)) 16:54:40 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)) 16:54:40 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)) 16:54:40 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)) 16:54:40 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)) 16:54:40 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)) 16:54:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:54:40 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 16:54:40 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 16:54:40 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 16:54:40 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 16:54:40 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 16:54:40 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 16:54:43 INFO - Downloading blessings-1.6.tar.gz 16:54:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:54:43 INFO - Installing collected packages: blessings 16:54:43 INFO - Running setup.py install for blessings 16:54:43 INFO - Successfully installed blessings 16:54:43 INFO - Cleaning up... 16:54:43 INFO - Return code: 0 16:54:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:54:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:54:43 INFO - Reading from file tmpfile_stdout 16:54:43 INFO - Current package versions: 16:54:43 INFO - blessings == 1.6 16:54:43 INFO - blobuploader == 1.2.4 16:54:43 INFO - docopt == 0.6.1 16:54:43 INFO - manifestparser == 1.1 16:54:43 INFO - mozInstall == 1.12 16:54:43 INFO - mozcrash == 0.16 16:54:43 INFO - mozdebug == 0.1 16:54:43 INFO - mozdevice == 0.48 16:54:43 INFO - mozfile == 1.2 16:54:43 INFO - mozhttpd == 0.7 16:54:43 INFO - mozinfo == 0.9 16:54:43 INFO - mozleak == 0.1 16:54:43 INFO - mozlog == 3.1 16:54:43 INFO - moznetwork == 0.27 16:54:43 INFO - mozprocess == 0.22 16:54:43 INFO - mozprofile == 0.28 16:54:43 INFO - mozrunner == 6.11 16:54:43 INFO - mozscreenshot == 0.1 16:54:43 INFO - mozsystemmonitor == 0.0 16:54:43 INFO - moztest == 0.7 16:54:43 INFO - mozversion == 1.4 16:54:43 INFO - psutil == 3.1.1 16:54:43 INFO - requests == 1.2.3 16:54:43 INFO - wsgiref == 0.1.2 16:54:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:43 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 0x1099f1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099f84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff860d619e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109896d30>, '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 0x1096b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10988cb20>, '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.RhyHUauhg1/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.wTWuoo0NOl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 16:54:43 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 16:54:43 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 16:54:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RhyHUauhg1/Render', 16:54:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:43 INFO - 'HOME': '/Users/cltbld', 16:54:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:43 INFO - 'LOGNAME': 'cltbld', 16:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:43 INFO - 'MOZ_NO_REMOTE': '1', 16:54:43 INFO - 'NO_EM_RESTART': '1', 16:54:43 INFO - 'PAGER': '/bin/cat', 16:54:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:43 INFO - 'PWD': '/builds/slave/test', 16:54:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:43 INFO - 'SHELL': '/bin/bash', 16:54:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTWuoo0NOl/Listeners', 16:54:43 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 16:54:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:43 INFO - 'USER': 'cltbld', 16:54:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:43 INFO - 'XPC_FLAGS': '0x0', 16:54:43 INFO - 'XPC_SERVICE_NAME': '0', 16:54:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:43 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)) 16:54:43 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)) 16:54:43 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)) 16:54:43 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)) 16:54:43 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)) 16:54:43 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)) 16:54:43 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)) 16:54:43 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)) 16:54:43 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)) 16:54:43 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)) 16:54:43 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)) 16:54:43 INFO - Cleaning up... 16:54:44 INFO - Return code: 0 16:54:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:54: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')]} 16:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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')]} 16:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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 0x1099f1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099f84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff860d619e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109896d30>, '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 0x1096b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10988cb20>, '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.RhyHUauhg1/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.wTWuoo0NOl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 16:54: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 16:54: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 16:54:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RhyHUauhg1/Render', 16:54:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:44 INFO - 'HOME': '/Users/cltbld', 16:54:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:44 INFO - 'LOGNAME': 'cltbld', 16:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:44 INFO - 'MOZ_NO_REMOTE': '1', 16:54:44 INFO - 'NO_EM_RESTART': '1', 16:54:44 INFO - 'PAGER': '/bin/cat', 16:54:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:44 INFO - 'PWD': '/builds/slave/test', 16:54:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:44 INFO - 'SHELL': '/bin/bash', 16:54:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTWuoo0NOl/Listeners', 16:54:44 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 16:54:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:44 INFO - 'USER': 'cltbld', 16:54:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:44 INFO - 'XPC_FLAGS': '0x0', 16:54:44 INFO - 'XPC_SERVICE_NAME': '0', 16:54:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:44 INFO - Downloading/unpacking jsonschema 16:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:54:46 INFO - Downloading/unpacking functools32 (from jsonschema) 16:54:46 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 16:54:46 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 16:54:46 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 16:54:46 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 16:54:46 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 16:54:46 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 16:54:46 INFO - Downloading functools32-3.2.3-2.tar.gz 16:54:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:54:47 INFO - warning: no files found matching '*.txt' 16:54:47 INFO - no previously-included directories found matching 'build' 16:54:47 INFO - no previously-included directories found matching 'dist' 16:54:47 INFO - no previously-included directories found matching '.git*' 16:54:47 INFO - Installing collected packages: jsonschema, functools32 16:54:47 INFO - Running setup.py install for functools32 16:54:47 INFO - warning: no files found matching '*.txt' 16:54:47 INFO - no previously-included directories found matching 'build' 16:54:47 INFO - no previously-included directories found matching 'dist' 16:54:47 INFO - no previously-included directories found matching '.git*' 16:54:47 INFO - Successfully installed jsonschema functools32 16:54:47 INFO - Cleaning up... 16:54:47 INFO - Return code: 0 16:54:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1099f1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099f84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff860d619e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109896d30>, '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 0x1096b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10988cb20>, '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.RhyHUauhg1/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.wTWuoo0NOl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 16:54:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:54:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:54:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RhyHUauhg1/Render', 16:54:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:47 INFO - 'HOME': '/Users/cltbld', 16:54:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:47 INFO - 'LOGNAME': 'cltbld', 16:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:47 INFO - 'MOZ_NO_REMOTE': '1', 16:54:47 INFO - 'NO_EM_RESTART': '1', 16:54:47 INFO - 'PAGER': '/bin/cat', 16:54:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:47 INFO - 'PWD': '/builds/slave/test', 16:54:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:47 INFO - 'SHELL': '/bin/bash', 16:54:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTWuoo0NOl/Listeners', 16:54:47 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 16:54:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:47 INFO - 'USER': 'cltbld', 16:54:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:47 INFO - 'XPC_FLAGS': '0x0', 16:54:47 INFO - 'XPC_SERVICE_NAME': '0', 16:54:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:47 INFO - Downloading/unpacking flake8 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:54:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:54:49 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 16:54:49 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 16:54:49 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 16:54:49 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 16:54:49 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 16:54:49 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 16:54:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:54:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:54:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:54:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:54:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:54:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:54:51 INFO - no previously-included directories found matching 'docs/_build' 16:54:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:54:51 INFO - Running setup.py install for pep8 16:54:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:54:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:54:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:54:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:54:51 INFO - no previously-included directories found matching 'docs/_build' 16:54:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:54:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:54:51 INFO - Cleaning up... 16:54:51 INFO - Return code: 0 16:54:51 INFO - Running post-action listener: _resource_record_post_action 16:54:51 INFO - Running post-action listener: _start_resource_monitoring 16:54:51 INFO - Starting resource monitoring. 16:54:51 INFO - ##### 16:54:51 INFO - ##### Running install step. 16:54:51 INFO - ##### 16:54:51 INFO - Running pre-action listener: _resource_record_pre_action 16:54:51 INFO - Running main action method: install 16:54:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:54:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:54:51 INFO - Reading from file tmpfile_stdout 16:54:51 INFO - Detecting whether we're running mozinstall >=1.0... 16:54:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:54:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:54:51 INFO - Reading from file tmpfile_stdout 16:54:51 INFO - Output received: 16:54:51 INFO - Usage: mozinstall [options] installer 16:54:51 INFO - Options: 16:54:51 INFO - -h, --help show this help message and exit 16:54:51 INFO - -d DEST, --destination=DEST 16:54:51 INFO - Directory to install application into. [default: 16:54:51 INFO - "/builds/slave/test"] 16:54:51 INFO - --app=APP Application being installed. [default: firefox] 16:54:51 INFO - mkdir: /builds/slave/test/build/application 16:54:51 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'] 16:54:51 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 16:55:25 INFO - Reading from file tmpfile_stdout 16:55:25 INFO - Output received: 16:55:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:55:25 INFO - Running post-action listener: _resource_record_post_action 16:55:25 INFO - ##### 16:55:25 INFO - ##### Running run-tests step. 16:55:25 INFO - ##### 16:55:25 INFO - Running pre-action listener: _resource_record_pre_action 16:55:25 INFO - Running main action method: run_tests 16:55:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:55:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:55:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:55:25 INFO - 2016-02-03 16:55:25.405 screenresolution[1939:11889] starting screenresolution argv=screenresolution get 16:55:25 INFO - 2016-02-03 16:55:25.407 screenresolution[1939:11889] Display 0: 1600x1200x32@60 16:55:25 INFO - 2016-02-03 16:55:25.413 screenresolution[1940:11891] starting screenresolution argv=screenresolution list 16:55:25 INFO - Available Modes on Display 0 16:55:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:55:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:55:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:55:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:55:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:55:25 INFO - Intel Iris: 16:55:25 INFO - Chipset Model: Intel Iris 16:55:25 INFO - Type: GPU 16:55:25 INFO - Bus: Built-In 16:55:25 INFO - VRAM (Dynamic, Max): 1536 MB 16:55:25 INFO - Vendor: Intel (0x8086) 16:55:25 INFO - Device ID: 0x0a2e 16:55:25 INFO - Revision ID: 0x0009 16:55:25 INFO - Displays: 16:55:25 INFO - Display: 16:55:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:55:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:55:25 INFO - Display Serial Number: 1600x1200 60 16:55:25 INFO - Main Display: Yes 16:55:25 INFO - Mirror: Off 16:55:25 INFO - Online: Yes 16:55:25 INFO - Rotation: Supported 16:55:25 INFO - Return code: 0 16:55:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:55:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:55:25 INFO - Python 2.7.3 16:55:25 INFO - Return code: 0 16:55:25 INFO - grabbing minidump binary from tooltool 16:55:25 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')]} 16:55:25 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 0x109896d30>, '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 0x1096b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10988cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:55:25 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 16:55:25 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 16:55:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:55:25 INFO - Return code: 0 16:55:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:55:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:55:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:55:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:55:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:55:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:55:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:55:26 INFO - Return code: 0 16:55:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0103', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:55:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0103 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:55:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RhyHUauhg1/Render', 16:55:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:55:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:55:26 INFO - 'HOME': '/Users/cltbld', 16:55:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:55:26 INFO - 'LOGNAME': 'cltbld', 16:55:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:55:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:55:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:26 INFO - 'MOZ_NO_REMOTE': '1', 16:55:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:55:26 INFO - 'NO_EM_RESTART': '1', 16:55:26 INFO - 'PAGER': '/bin/cat', 16:55:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:55:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:26 INFO - 'PWD': '/builds/slave/test', 16:55:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:55:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:55:26 INFO - 'SHELL': '/bin/bash', 16:55:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTWuoo0NOl/Listeners', 16:55:26 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 16:55:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:55:26 INFO - 'USER': 'cltbld', 16:55:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:55:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:55:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:26 INFO - 'XPC_FLAGS': '0x0', 16:55:26 INFO - 'XPC_SERVICE_NAME': '0', 16:55:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:55:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0103', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:55:27 INFO - mozversion application_buildid: 20160203160127 16:55:27 INFO - mozversion application_changeset: a81960ce939edd6bff30d85fa07350e780901dac 16:55:27 INFO - mozversion application_display_name: Nightly 16:55:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:55:27 INFO - mozversion application_name: Firefox 16:55:27 INFO - mozversion application_remotingname: firefox 16:55:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:55:27 INFO - mozversion application_vendor: Mozilla 16:55:27 INFO - mozversion application_version: 47.0a1 16:55:27 INFO - mozversion platform_buildid: 20160203160127 16:55:27 INFO - mozversion platform_changeset: a81960ce939edd6bff30d85fa07350e780901dac 16:55:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:55:27 INFO - mozversion platform_version: 47.0a1 16:55:27 INFO - using testdate: 1454547327 16:55:27 INFO - actual date: 1454547327 16:55:27 INFO - starting webserver on 'localhost:49703' 16:55:27 INFO - SUITE-START | Running 2 tests 16:55:27 INFO - TEST-START | dromaeo_css 16:55:27 INFO - operating with platform_type : mac_ 16:55:27 INFO - Initialising browser for dromaeo_css test... 16:55:27 INFO - TEST-INFO | started process 1958 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpagSm70/profile http://localhost:49703/getInfo.html) 16:55:27 INFO - PROCESS | 1958 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 16:55:30 INFO - PROCESS | 1958 | __metrics Screen width/height:1600/1200 16:55:30 INFO - PROCESS | 1958 | colorDepth:24 16:55:30 INFO - PROCESS | 1958 | Browser inner width/height: 1024/689 16:55:30 INFO - PROCESS | 1958 | __metrics 16:55:30 INFO - PROCESS | 1958 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:55:30 INFO - PROCESS | 1958 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:55:30 INFO - TEST-INFO | 1958: exit 0 16:55:30 INFO - Browser initialized. 16:55:30 INFO - Running cycle 1/1 for dromaeo_css test... 16:55:30 INFO - TEST-INFO | started process 1961 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpagSm70/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:55:42 INFO - PROCESS | 1961 | RSS: Main: 243785728 16:55:42 INFO - PROCESS | 1961 | 16:56:33 INFO - PROCESS | 1961 | 1454547393436 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] 16:58:43 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:49703/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49703/tests/dromaeo/cssquery-ext.html) 16:58:45 INFO - PROCESS | 1961 | RSS: Main: 433143808 16:58:45 INFO - PROCESS | 1961 | 17:01:48 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:49703/tests/dromaeo/cssquery-ext.html (next: http://localhost:49703/tests/dromaeo/cssquery-jquery.html) 17:01:49 INFO - PROCESS | 1961 | RSS: Main: 377225216 17:01:49 INFO - PROCESS | 1961 | 17:04:51 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:49703/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49703/tests/dromaeo/cssquery-mootools.html) 17:04:51 INFO - PROCESS | 1961 | RSS: Main: 378449920 17:04:51 INFO - PROCESS | 1961 | 17:07:53 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:49703/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49703/tests/dromaeo/cssquery-prototype.html) 17:07:54 INFO - PROCESS | 1961 | RSS: Main: 375341056 17:07:54 INFO - PROCESS | 1961 | 17:10:57 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:49703/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49703/tests/dromaeo/cssquery-yui.html) 17:10:58 INFO - PROCESS | 1961 | RSS: Main: 346746880 17:10:58 INFO - PROCESS | 1961 | 17:14:00 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:49703/tests/dromaeo/cssquery-yui.html (next: http://localhost:49703/tests/dromaeo/cssquery-dojo.html) 17:14:01 INFO - PROCESS | 1961 | RSS: Main: 391475200 17:14:01 INFO - PROCESS | 1961 | 17:14:01 INFO - PROCESS | 1961 | __start_tp_report 17:14:01 INFO - PROCESS | 1961 | _x_x_mozilla_page_load 17:14:01 INFO - PROCESS | 1961 | _x_x_mozilla_page_load_details 17:14:01 INFO - PROCESS | 1961 | |i|pagename|runs| 17:14:01 INFO - PROCESS | 1961 | |0;dojo.html;2992.985035074823;3308.718758905493;3355.0438125134337;3358.865645374185;3427.8628854845806;4944.826931057413;5414.702191379472;5436.483534064262;5466.043442397579;5476.288082549273;5440.238366628665;5450.5367043801325;5459.481349271823;5460.426655201206;5463.3717122530925;4976.626752993531;4986.9251961220425;5031.672941258825;5082.618803589727;5105.5660268877;5049.520295571915;5108.080545501808;5130.461301563338;5140.049090918192;5140.177571588547;5111.207762796773;5113.948860511403;5123.257127716479;5127.897442051157;5131.435542090386;5109.182530795055;5122;5126.077306084903;5134.2812006319145;5138.640295179339;4869.951300486985;5113.309703190096;5121.975604879002;5137.460566640486;5144.9742751286;5479.4520547944885;5501.339839219279;5512.3385193777;5532.446755324476;5553.16702494625;5956.16613674086;5956.463918247336;5971.910421343683;5972.611780234271;6012.6993650317745;5540.335159780852;5650.0959846424785;6001.219841420631;6105.520399749632;6131.172291740602;5563.721813909288;5583.022970980062;5584.748686309126;5599.60802743804;5648.237487939116;6151.5386346024225;6157.230346206724;6162.22972128484;6167.013277875519;6173.043178307369;5729.598928074995;5794.855128621818;5811.331696854916;5848.210491583667;5928.843875444247;6055.848603784941;6097.512199024068;6114.633122012693;6115.755369785248;6153.938460615426;6020.53453717396;6050.971334873082;6062.661466489788;6080.48315893154;6103.6032657877095;4872.6832755870755;5815.040518314515;5990.820275391745;6006.039033754666;6015.308239552507;4753.47711751707;4771.23660214364;4783.880402989953;4807.158747219222;4811.807527698923;4222.155568886235;4234.174336004511;4239.342901850218;4268.509121451011;4279.914401711948;5407.432219616883;5488.890222195534;5496.972515137399;5558.638688485235;5584.301962254718;5933.554983376264;5990;6021.969890150521;6100.762843515285;6114.205153330038;5538.196961440569;5547.805826796123;5564.19319198722;5565.554755619541;5569.10894256917;5132.204508301219;5203.349581302337;5214.582833373321;5229.163333866563;5276.762545685453;6091.725872335755;6160.722767475564;6237.563370564017;6239.78160764362;6264.9976003840075;6085.269767627913;6096.9390306096375;6098.756049758137;6109.633421994695;6109.725062372115;5144.228365745168;6271;6272.372762723691;6274.1843560336865;6279.591826531261;4938.629602779734;5814.970925145347;5875.882482350244;5929.140274660064;5946.286445626552;4503.414556107685;6048.425399587032;6095.603785753912;6118.510519158545;6125.295591007091;5849.151872978309;5851.561132915133;5865.4134586541;5868.119782032559;5873.3832947539895;5727.39862314451;5741.5119714824705;5809.302883653989;5823.7379317931645;5844.211031510692;5657.43425657431;5663.603547751618;5672.14917762339;5681.204631351697;5685.573581981285;5775.566832487496;5777.971110144423;5781.161731548817;5782.363939966516;5787.842431513798;5138.486151384832;5642.463965923231;5699.487046165865;5702.743376548148;5738.770449181986 17:14:01 INFO - PROCESS | 1961 | |1;ext.html;491.0155138946412;508.85497633174543;521.3457111325287;526.7708546782147;549.0501432521737;28775.712242877566;29979;37529.43705844414;37999.050023749354;38021.42967855478;40857.79571102148;41238;41318.79340603293;41328.58671413292;41449.58550414495;9461.195798357148;9685.951570242174;9695.418274903494;9697.515124243795;9698.272629552812;9544.856827147598;9667.90332096677;9681.031896810298;9681.467519286436;9684.612615495407;8269.917300826975;9650.276229282797;9709.271804614647;9741.415515069084;9757.073078057609;9622.56698448568;9690.224782017422;9694.03059694032;9697.757556061155;9699.51502424883;9651.565679544437;9777.657781977596;9788.657396991071;9807.460589667566;9808.705738827846;39399.8030009851;39721.60278397208;39755.403668944986;39784.005399864946;39793.60206397928;3208.4224839528874;3245.6105267368066;3399.201187720884;3564.946525802115;3767.340715374826;28580.714192858013;28956.131316060553;28965.275868103254;29190.832366705305;29200.853995729885;2762.1437354420195;2766.488199683065;2849.800513964023;2970.4950158472893;2973.940521189564;481424;485375;485741;486815.92288539815;487168;56637.43362566404;57947.420525795045;58036.54908627318;59459.51351216254;60768.08847867197;68866.65566672235;70169.64915175493;70378.94431583531;70390;70431.29568704247;15671.843281567266;16053.277602507915;16077.919610401874;16089;16115.113668748098;11298.7175320616;11556.248843825124;12290.938545307215;12357.443915023845;12374.948129409102;17716;20724.378268651966;20935.68596471054;21107.894460527597;21121;8074.555899425471;8190.918090819135;8195.95902020486;8224.794380140544;8281.585920703941;972.8005758819424;981.9361741486781;1023.764534157148;1024.6823484719762;1042.0933787604831;28373.43253134967;29024.723766556675;29452.852735736185;29722.702772971992;29980.70019299823;1073.302353470235;1080.103514083309;1113.2485572238868;1164.1559869094838;1257.0948916779903;13987.510437134855;15270.38918443272;15499;15757.68484630301;15911.681766364607;535011;540125;540278;541764;542150;56620;56864.71567642135;56937.43062569321;56967.430325696216;57046.00338988115;1454.3818876977455;1462.4004158295047;1473.4032716749734;1482.4589025005796;1599.2323684631442;29801;30087.548686770155;30109.849450752605;30226.234392026065;30228.84885575558;51317.7434112827;51736.75685403971;51770.48229517657;51834.481655182964;51850;507887;510728;511382;513043;513203;27938.58092128579;28472.58674905393;30695.693043070176;32937.83531082329;33075.50386744249;33260.00219993404;33383.83308083444;40062;40378.39432408575;41476;31589;32793.01620951375;34997.47503787496;36568.63431365759;37223.441648374755;24383;32413.837930810194;34944.82527587346;35236.82381588076;35780;33186.33627327392;33585.496217557244;34580.308393832485;34582.30835383329;34641.65358346384;29114;30103;31001.534976974912;31952.68047319497;32340.514892277104;23854.880725596955;24212.030090210214;24768.25695229146;24790.50418991646;24827.751722482542 17:14:01 INFO - PROCESS | 1961 | |2;jquery.html;362.82947014902993;364.3350884635541;364.4333062088453;367.1537106968437;371.314923965284;14332.928335358334;15305.770413443808;16597.50207493774;18831.435056948278;19392.418227453163;11626.128040396961;11664.6500604982;11937.701557461069;11944.522219111246;11944.940275298612;3961.6830653547645;5228.529432351097;5371.892562148755;5372.811951581695;5374.086405311106;4085.7344272622186;4111.568285330042;5630.831075067734;5874.70626468677;5885.85285367865;5532.3914369419335;5785.623934444247;5805.7387417566315;5848.824535263949;5855.590108692393;5569.944300556983;5672.773089076452;5741.45456181662;5747.453991870766;5751.424857514257;5578.721063946827;5579.38626751057;5580.218769372291;5592.0773072443;5599.552035837123;13076.738465230737;13092.86907130926;17585.912070439565;22186.112555497763;23243.76756232433;2068.307117115768;2075.56413153238;2082.83337333013;2273.818094552432;2359.775821296974;9430.811383772354;9556.665516706882;9580.90419095807;10104.69685909424;10131.898681013243;1697.8811483196182;1785.1788177438393;1798.7301904714266;1800.8109148539477;1810.7827060752663;89840.5507972456;94104.52947735217;94253;96193;96587;10738.302010369302;10970.725731856608;11029.61396351124;11056.391898445663;11121.888781112248;13240.53658121961;13353.465861365437;13382.531611393555;13428.328583570783;13437.664058398619;8332.750017499484;8336.208060234268;8349.749507514784;8452.61963211657;8462.87305690415;8413;8424.578771061422;8441.240288373952;8506.65973361071;8515.57422128891;3433.776804507699;3963.8216280267457;4171.0823618803815;4335.241332766753;4469.128519938646;1758.7537744715494;1843.988597173225;1866.374764453896;1866.887986720801;1869.2896699254468;881.6276506896369;882.0826340605827;885.7077164535688;889.6708217959397;993.6472552243994;16659.33362665504;19065.90467047656;19210.903945480182;19782.40652780419;20335.288264910658;952.4618590496348;958.8178246133212;975.3562648651856;986.3095832916987;1014.60937539048;8948.552572371356;9367.344285899922;9959.55182016811;10672.94663526693;10704.518296676668;579536;582433;590874;732564;770793;70915.29084709087;94248;113646;117616;120868;1137.0903277378065;1167.3171194851107;1190.2798806721983;1200.2198570928965;1200.8138738495547;18189.09054547241;18287.725684115016;18498.630027399107;18499.445016649523;19097.331593394163;50551.49448505468;51678.708032299495;52268.69328266824;52565.7371713139;52665.47334526606;67431;69749.65125174342;70071.59856802733;70342.02092822167;70822.64588677023;7494.325510704063;7730.729424470116;7783.338416234684;7803.453758236869;7815.491993020435;11495.655130346104;11506.597269095542;11819.231749936227;11901.345426001653;12031;10172.237082218715;10220.080192782685;10234.33476824004;10275.126614237874;10392.58429662805;8247.463914845515;9926.255530835071;10312.535935883054;10363.792724145625;10640.946795265974;8659.696910608098;10167;10485.9475702621;10493.52779124926;10808;7490.962545187239;7510;7605.35354494852;7658.540487570764;7665.961670191613;9628.855567166358;10307.896921030993;10313.690589282334;10514.526846291783;10530.31552949056 17:14:01 INFO - PROCESS | 1961 | |3;mootools.html;1345.7106722054757;1521.0645453046377;1556.922153892305;1795.2908601102565;1939.5345117171864;7915.604219789009;8104.959475202623;8582.656693732244;8792;8794.944606647212;8575.614097365618;8605.913940860604;8716.433431826927;8721.520316382597;8732.476051436919;2174.3694328644674;2237.7314722233355;2466.4943686544216;2497.1384872219055;2499.6375525548783;2227.4431392151964;2236.0720301075116;2452.901883924641;2526.5452218600644;2531.316544532984;2451.6199989001734;2461.7907477864314;2478.3432390416556;2485.030837973192;2487.9875600622063;2437.427204606916;2481.1192026830486;2484.763947424992;2487.3657217409627;2500.6749122614124;2445.376429010591;2481.7642323979194;2485.652008718781;2485.763852434016;2490.9875450622812;8782.64869405223;8876.955615221947;8883;8910.777230569223;8927.241184499326;5387.622866399353;5482.424345443751;5503.807366742145;5543.473370029841;5554.305711786027;3336.899893003214;3383.390989621867;3650.178709790276;3725.5715592706915;3732.9253414931823;1039.2050081687514;1061.9893801061967;1064.3613831700995;1088.1131877519874;1090.6346373964732;12168.695782605417;12218.75562488754;12244.632661020183;12246.020318374509;12255.264684118893;4033.757974521538;4884;4945.653804233669;4948.901021979612;4953.306537084811;9016.909830901606;10331.586736530455;10339.84490232632;10341.37951722884;10367.27429079957;5542.11326187808;5545.528630066409;5551.750171242304;5551.8889622207325;5552.5280351169795;5003.449620541737;5056.241563765465;5057.974710126499;5065.645404821701;5068.695878247317;2993.3863557970562;3678.3562876496508;3769.1142581493327;3958.4062390641634;3982.064214909494;1082.4046774274275;1224.834647322618;1301.7071158989152;1314.5333406640696;1318.6110097521255;1317.5520323090195;1325.9005574581945;1328.1234385305652;1353.5195005773005;1355.1868878672717;8082.9191708083345;8166.142555031755;8168.264856162974;8180.877286840702;8220.219079187467;1170.4849866058908;1173.1553281637207;1180.7874582575218;1192.7137487003056;1218.4760552962312;6104.053871649901;6112.724927378279;6188.350223226496;6200.906986395207;6204;10612.151027917747;10844.078253348396;10854.565817367216;10986.670399888017;10994.175436842268;10319.638812641522;10648.414337211372;10822.18833587484;10829.83755243672;10844.837327440095;8327.084020757711;8327.250547450638;8327.791805204919;8416.53709045996;8419.494830310201;7738.651760670896;7814.960925195338;7897.763067107996;8198.016238051472;8207.507549547046;9253.907460925304;9508.714738557854;9631.133198012212;9634.277429192698;9728.075832795874;9703.854442183232;10060.144887684335;10084.69745907624;10089.29374943747;10100.141487973604;7590.962045189739;7616.3906887449975;7659.234076592296;7702.306792388712;7736.574488403192;7423.109226892808;7601.7719468416035;8219.465734727224;8340.249377556049;8370.958145209235;7082.5396349237135;7440.776776696492;7773.37812974972;7787;7942.483738556975;7677.838150692712;7733.613319333898;7739.574323412041;7763.417743669134;7784.649690764042;7869.724559640385;7887.763367098996;7923.920760792318;7936.968194134725;7942.960285198537;7061.82345441368;7077.5753454792875;7116.715331386894;7177.928220717726;7179.748708795376;7264.782056538313;7339.412846972123;7352.816179595553;7358.374538164102;7360.33756961876 17:14:01 INFO - PROCESS | 1961 | |4;prototype.html;314.5611871439342;322.22344150597064;333.05080520516526;336.8433678339572;338.75609561116005;6542.64015479149;6547.181602299713;6585.769498067574;6602.1417215761885;6603.735850565971;6467.223933128032;6479.838004049901;6496.870062598745;6527.673616319177;6594.472442204624;4864.416270047591;4870.683405578644;4871.635941936263;4874.220124780036;4879.170541008037;4581.67928245023;4727.550882666158;4741.407324084489;4754.595859351959;4764.071006153801;3479.652034796525;3998.2203470323298;4660.6504512161555;4688.5077066908;4692.577668009879;4560.931586026212;4641.234196357597;4660.603848672833;4701.083288758693;4726.669133160697;3974.225026119908;3990.3415936370466;4066.5323487798987;4074.5110586729484;4080.9387859182134;6246.875062498724;6263;6290.402411770874;6292.835825372275;6318.178636777189;5295.179247216687;5396.757145928443;5520.3651580068;5531.170324451325;5550.333959924795;6336.96831515844;6801.557898736616;6801.761938332184;6928.722851086001;6947.5831450113155;4488.438945131858;4493.68544201906;4495.123450927071;4507.827964729161;4509.053098849213;7221.061262035954;7299.854002919912;7310.561366317985;7315.561066336037;7317.195108538057;4443.644508439317;4569.1547063793305;4572.542745725401;4589;4616.28447590624;4653.185692503798;4654.697444666086;4661.370714953506;4667.883302917454;4676.929846052312;5517.806876759374;5526.834194974157;5533.253010843565;5533.584981126432;5536.75084621193;6664.466842652576;6932.202796678345;6938.340857618518;6951.721931122698;6970.198427180838;1598.4804938395068;1613.6369316903604;1616.4665660332298;1618.0857815334298;1621.959451013734;1020.2297265564451;1028.8559601655775;1041.2919214933765;1044.984325235122;1045.743792770776;6544.770933017321;6545.280019197884;6553.639549824806;6555.836104097436;6577.638229897306;7223.819404514929;7228.421726261887;7231.096112985877;7233.674484648203;7249.130104387507;5292.629515933924;6393.776217832354;6520.836979075466;6536.411722944958;6543.836404089936;3695.981520092382;3790.9241815164096;3818.1409182933617;3847.5190601174854;3853.460515527828;7392.815179620553;7443.590602516805;7563.978862853554;7595.354394876387;7613.733519326797;7434.665440055211;7488.101427828696;7495.362894154058;7498.212687667826;7512.098548174254;7292.671829767673;7446.553206807609;7568.772936811904;7593.658285377061;7603.897434871913;5898.941010590011;7282.344588987016;7287.161976372573;7301.671424785791;7312.853742925218;7135.357817796424;7155.141383034069;7159.033530473528;7159.105111861018;7169.892451613126;7264.963675181591;7518.323350898446;7592.164861865301;7595.164531901376;7612;4586.954130458653;4627.5603817637275;4632.328312394617;4634.698744581591;4649.511801260819;7027.543209691558;7241.746538871114;7244.673989670372;7251.456140789356;7268.491205615767;6984;6991.650417479207;6995.615241161785;6997.475189360716;7003.054587630605;6519.282878883414;6953.374196322356;6967.0246165535855;6971.7211311549;6972.6513674315065;5509.338879334506;6575.178102737158;6816.318368163144;6846.623435711083;6853.725850965906;5959.731812068554;6987.196472405535;6994.825129371603;7000.229974702676;7027.894581581382;6848.315168483112;6854.417374523022;6855.725770969305;6864.107666003388;6881.13985751781 17:14:01 INFO - PROCESS | 1961 | |5;yui.html;672.5258692621702;672.8418821576931;728.9271072892711;731.1993367262852;744.3747252308063;14012.439502419904;14107.57677269681;14138.71722565548;14190.432382704705;14199.57401277962;13376.732465350688;13669.863301367008;13714.382852771625;13866.930665346685;13893.374798134082;696.0846486869775;701.295198325682;854.2866706300231;868.3877866104381;872.5113936195751;713.6610110197666;840.920112589303;871.0114020586616;873.6199753107419;873.9082396348388;903.4714691905243;917.0096296000337;923.7505873414174;925.3568769705058;925.5834874306589;733.8202140475591;735.3565630073685;736.5985537881867;916.4867674102491;918.6922381002372;670.2292363781642;674.9696263668146;677.3903486861815;677.7153595489906;680.8059702984675;14744.189069601167;14812;14813.259337033105;14830.70338593233;14853.777193342108;12523.749525009449;12672.303023333805;12771.93614031924;12787.04097192705;12891.226526408353;9930.702078937644;10130.088292053677;10156.542955567018;10275.69172924806;10313.9484302578;3538.31002954424;3563.94654080189;3567;3572.356975744365;3574.0528759878653;57987.42012579862;78395.21604783936;78582.60708696477;78976.60511697405;79038.41923161563;9477.952610236905;9702.417854928726;9761;9917.454540000224;10253.84619230712;21847.890760546095;21879.890600546896;21881.67177492339;21905.890470547547;21909;7439.95109611298;7534.698612055566;7729.343005844454;7763.146053934062;7810.804729881685;4148.688848336326;4189.350650649154;4218.409422680827;4244.151169766059;4284.592963668447;3433.1931995980926;3665.9450108248398;3674.65090816372;3676.761010534307;3682.226732386229;693.5838496901819;696.4254490045732;714.5569746757044;721.2679130682361;728.6720975561019;515.6338999310532;522.6341560907304;536.9838904832861;593.9495142912814;648.8637386148868;8557.529335886586;8660.48037117775;8785.560721963877;8855.025947145808;8886.4668119913;473.7820602522809;532.7815595605861;538.3485981961792;572.2132068405942;635.3360738028771;4011.1548687603445;4131.194417088699;4355.978220108879;4392.736435813861;4424.247877860771;72200.63899680573;91194.87759997218;91945;93128.53435732778;93327.13345733183;78328;79086.60456697679;79183.60408198037;79400;80064.5996770024;66590.0011499828;66906.66546667235;66924;67044.32955670479;68155.31844681589;6903.827404314932;8789.91210087891;8862.64549418016;8871.866921996047;9108.817823643358;34151.65848341584;39869.60456384013;46893.33759131334;48176;48737.75631121822;59537.40462595492;65390.67304663446;67426.32573674397;68467.65766171138;70097.59804803773;10604.416757078434;11137.498812553617;11215.551377945118;11233.775324493628;11308.434578271219;11877.703057423634;12250.816237756262;12327.32829899399;12417.379131043232;12645.430955606837;11054.170937179582;11295.661130166109;11675.649730508097;11733.120015999006;12330.013598912245;11392.715182120513;11588.188826782045;11743.706407339885;11791.233569817934;12440;9069.501177435304;11025.61410350634;11329.660110196708;11431.771364572829;12073.75852482963;8730.17063378978;8949.373543851867;9588.616455341707;9589.136977672042;9691.370060946298;8937.195652391316;9240.491772952551;9254.861177082215;9957.900420995988;9996.150327222267 17:14:01 INFO - PROCESS | 1961 | __end_tp_report 17:14:01 INFO - PROCESS | 1961 | __start_cc_report 17:14:01 INFO - PROCESS | 1961 | _x_x_mozilla_cycle_collect,1793 17:14:01 INFO - PROCESS | 1961 | __end_cc_report 17:14:01 INFO - PROCESS | 1961 | __startTimestamp1454548441159__endTimestamp 17:14:01 INFO - PROCESS | 1961 | 17:14:01 INFO - PROCESS | 1961 | ------- Summary: start ------- 17:14:01 INFO - PROCESS | 1961 | Number of tests: 6 17:14:01 INFO - PROCESS | 1961 | 17:14:01 INFO - PROCESS | 1961 | [#0] dojo.html Cycles:165 Average:5523.95 Median:5650.10 stddev:619.84 (11.0%) stddev-sans-first:589.09 17:14:01 INFO - PROCESS | 1961 | Values: 2993.0 3308.7 3355.0 3358.9 3427.9 4944.8 5414.7 5436.5 5466.0 5476.3 5440.2 5450.5 5459.5 5460.4 5463.4 4976.6 4986.9 5031.7 5082.6 5105.6 5049.5 5108.1 5130.5 5140.0 5140.2 5111.2 5113.9 5123.3 5127.9 5131.4 5109.2 5122.0 5126.1 5134.3 5138.6 4870.0 5113.3 5122.0 5137.5 5145.0 5479.5 5501.3 5512.3 5532.4 5553.2 5956.2 5956.5 5971.9 5972.6 6012.7 5540.3 5650.1 6001.2 6105.5 6131.2 5563.7 5583.0 5584.7 5599.6 5648.2 6151.5 6157.2 6162.2 6167.0 6173.0 5729.6 5794.9 5811.3 5848.2 5928.8 6055.8 6097.5 6114.6 6115.8 6153.9 6020.5 6051.0 6062.7 6080.5 6103.6 4872.7 5815.0 5990.8 6006.0 6015.3 4753.5 4771.2 4783.9 4807.2 4811.8 4222.2 4234.2 4239.3 4268.5 4279.9 5407.4 5488.9 5497.0 5558.6 5584.3 5933.6 5990.0 6022.0 6100.8 6114.2 5538.2 5547.8 5564.2 5565.6 5569.1 5132.2 5203.3 5214.6 5229.2 5276.8 6091.7 6160.7 6237.6 6239.8 6265.0 6085.3 6096.9 6098.8 6109.6 6109.7 5144.2 6271.0 6272.4 6274.2 6279.6 4938.6 5815.0 5875.9 5929.1 5946.3 4503.4 6048.4 6095.6 6118.5 6125.3 5849.2 5851.6 5865.4 5868.1 5873.4 5727.4 5741.5 5809.3 5823.7 5844.2 5657.4 5663.6 5672.1 5681.2 5685.6 5775.6 5778.0 5781.2 5782.4 5787.8 5138.5 5642.5 5699.5 5702.7 5738.8 17:14:01 INFO - PROCESS | 1961 | 17:14:01 INFO - PROCESS | 1961 | [#1] ext.html Cycles:180 Average:64801.06 Median:37376.44 stddev:136549.09 (365.3%) stddev-sans-first:136846.77 17:14:01 INFO - PROCESS | 1961 | Values: 491.0 508.9 521.3 526.8 549.1 28775.7 29979.0 37529.4 37999.1 38021.4 40857.8 41238.0 41318.8 41328.6 41449.6 9461.2 9686.0 9695.4 9697.5 9698.3 9544.9 9667.9 9681.0 9681.5 9684.6 8269.9 9650.3 9709.3 9741.4 9757.1 9622.6 9690.2 9694.0 9697.8 9699.5 9651.6 9777.7 9788.7 9807.5 9808.7 39399.8 39721.6 39755.4 39784.0 39793.6 3208.4 3245.6 3399.2 3564.9 3767.3 28580.7 28956.1 28965.3 29190.8 29200.9 2762.1 2766.5 2849.8 2970.5 2973.9 481424.0 485375.0 485741.0 486815.9 487168.0 56637.4 57947.4 58036.5 59459.5 60768.1 68866.7 70169.6 70378.9 70390.0 70431.3 15671.8 16053.3 16077.9 16089.0 16115.1 11298.7 11556.2 12290.9 12357.4 12374.9 17716.0 20724.4 20935.7 21107.9 21121.0 8074.6 8190.9 8196.0 8224.8 8281.6 972.8 981.9 1023.8 1024.7 1042.1 28373.4 29024.7 29452.9 29722.7 29980.7 1073.3 1080.1 1113.2 1164.2 1257.1 13987.5 15270.4 15499.0 15757.7 15911.7 535011.0 540125.0 540278.0 541764.0 542150.0 56620.0 56864.7 56937.4 56967.4 57046.0 1454.4 1462.4 1473.4 1482.5 1599.2 29801.0 30087.5 30109.8 30226.2 30228.8 51317.7 51736.8 51770.5 51834.5 51850.0 507887.0 510728.0 511382.0 513043.0 513203.0 27938.6 28472.6 30695.7 32937.8 33075.5 33260.0 33383.8 40062.0 40378.4 41476.0 31589.0 32793.0 34997.5 36568.6 37223.4 24383.0 32413.8 34944.8 35236.8 35780.0 33186.3 33585.5 34580.3 34582.3 34641.7 29114.0 30103.0 31001.5 31952.7 32340.5 23854.9 24212.0 24768.3 24790.5 24827.8 17:14:01 INFO - PROCESS | 1961 | 17:14:01 INFO - PROCESS | 1961 | [#2] jquery.html Cycles:180 Average:33989.36 Median:3962.75 stddev:108294.78 (2732.8%) stddev-sans-first:108569.14 17:14:01 INFO - PROCESS | 1961 | Values: 362.8 364.3 364.4 367.2 371.3 14332.9 15305.8 16597.5 18831.4 19392.4 11626.1 11664.7 11937.7 11944.5 11944.9 3961.7 5228.5 5371.9 5372.8 5374.1 4085.7 4111.6 5630.8 5874.7 5885.9 5532.4 5785.6 5805.7 5848.8 5855.6 5569.9 5672.8 5741.5 5747.5 5751.4 5578.7 5579.4 5580.2 5592.1 5599.6 13076.7 13092.9 17585.9 22186.1 23243.8 2068.3 2075.6 2082.8 2273.8 2359.8 9430.8 9556.7 9580.9 10104.7 10131.9 1697.9 1785.2 1798.7 1800.8 1810.8 89840.6 94104.5 94253.0 96193.0 96587.0 10738.3 10970.7 11029.6 11056.4 11121.9 13240.5 13353.5 13382.5 13428.3 13437.7 8332.8 8336.2 8349.7 8452.6 8462.9 8413.0 8424.6 8441.2 8506.7 8515.6 3433.8 3963.8 4171.1 4335.2 4469.1 1758.8 1844.0 1866.4 1866.9 1869.3 881.6 882.1 885.7 889.7 993.6 16659.3 19065.9 19210.9 19782.4 20335.3 952.5 958.8 975.4 986.3 1014.6 8948.6 9367.3 9959.6 10672.9 10704.5 579536.0 582433.0 590874.0 732564.0 770793.0 70915.3 94248.0 113646.0 117616.0 120868.0 1137.1 1167.3 1190.3 1200.2 1200.8 18189.1 18287.7 18498.6 18499.4 19097.3 50551.5 51678.7 52268.7 52565.7 52665.5 67431.0 69749.7 70071.6 70342.0 70822.6 7494.3 7730.7 7783.3 7803.5 7815.5 11495.7 11506.6 11819.2 11901.3 12031.0 10172.2 10220.1 10234.3 10275.1 10392.6 8247.5 9926.3 10312.5 10363.8 10640.9 8659.7 10167.0 10485.9 10493.5 10808.0 7491.0 7510.0 7605.4 7658.5 7666.0 9628.9 10307.9 10313.7 10514.5 10530.3 17:14:01 INFO - PROCESS | 1961 | 17:14:01 INFO - PROCESS | 1961 | [#3] mootools.html Cycles:180 Average:6116.36 Median:5061.81 stddev:3230.10 (63.8%) stddev-sans-first:3219.25 17:14:01 INFO - PROCESS | 1961 | Values: 1345.7 1521.1 1556.9 1795.3 1939.5 7915.6 8105.0 8582.7 8792.0 8794.9 8575.6 8605.9 8716.4 8721.5 8732.5 2174.4 2237.7 2466.5 2497.1 2499.6 2227.4 2236.1 2452.9 2526.5 2531.3 2451.6 2461.8 2478.3 2485.0 2488.0 2437.4 2481.1 2484.8 2487.4 2500.7 2445.4 2481.8 2485.7 2485.8 2491.0 8782.6 8877.0 8883.0 8910.8 8927.2 5387.6 5482.4 5503.8 5543.5 5554.3 3336.9 3383.4 3650.2 3725.6 3732.9 1039.2 1062.0 1064.4 1088.1 1090.6 12168.7 12218.8 12244.6 12246.0 12255.3 4033.8 4884.0 4945.7 4948.9 4953.3 9016.9 10331.6 10339.8 10341.4 10367.3 5542.1 5545.5 5551.8 5551.9 5552.5 5003.4 5056.2 5058.0 5065.6 5068.7 2993.4 3678.4 3769.1 3958.4 3982.1 1082.4 1224.8 1301.7 1314.5 1318.6 1317.6 1325.9 1328.1 1353.5 1355.2 8082.9 8166.1 8168.3 8180.9 8220.2 1170.5 1173.2 1180.8 1192.7 1218.5 6104.1 6112.7 6188.4 6200.9 6204.0 10612.2 10844.1 10854.6 10986.7 10994.2 10319.6 10648.4 10822.2 10829.8 10844.8 8327.1 8327.3 8327.8 8416.5 8419.5 7738.7 7815.0 7897.8 8198.0 8207.5 9253.9 9508.7 9631.1 9634.3 9728.1 9703.9 10060.1 10084.7 10089.3 10100.1 7591.0 7616.4 7659.2 7702.3 7736.6 7423.1 7601.8 8219.5 8340.2 8371.0 7082.5 7440.8 7773.4 7787.0 7942.5 7677.8 7733.6 7739.6 7763.4 7784.6 7869.7 7887.8 7923.9 7937.0 7943.0 7061.8 7077.6 7116.7 7177.9 7179.7 7264.8 7339.4 7352.8 7358.4 7360.3 17:14:01 INFO - PROCESS | 1961 | 17:14:01 INFO - PROCESS | 1961 | [#4] prototype.html Cycles:180 Average:5680.99 Median:6524.26 stddev:1834.72 (28.1%) stddev-sans-first:1795.11 17:14:01 INFO - PROCESS | 1961 | Values: 314.6 322.2 333.1 336.8 338.8 6542.6 6547.2 6585.8 6602.1 6603.7 6467.2 6479.8 6496.9 6527.7 6594.5 4864.4 4870.7 4871.6 4874.2 4879.2 4581.7 4727.6 4741.4 4754.6 4764.1 3479.7 3998.2 4660.7 4688.5 4692.6 4560.9 4641.2 4660.6 4701.1 4726.7 3974.2 3990.3 4066.5 4074.5 4080.9 6246.9 6263.0 6290.4 6292.8 6318.2 5295.2 5396.8 5520.4 5531.2 5550.3 6337.0 6801.6 6801.8 6928.7 6947.6 4488.4 4493.7 4495.1 4507.8 4509.1 7221.1 7299.9 7310.6 7315.6 7317.2 4443.6 4569.2 4572.5 4589.0 4616.3 4653.2 4654.7 4661.4 4667.9 4676.9 5517.8 5526.8 5533.3 5533.6 5536.8 6664.5 6932.2 6938.3 6951.7 6970.2 1598.5 1613.6 1616.5 1618.1 1622.0 1020.2 1028.9 1041.3 1045.0 1045.7 6544.8 6545.3 6553.6 6555.8 6577.6 7223.8 7228.4 7231.1 7233.7 7249.1 5292.6 6393.8 6520.8 6536.4 6543.8 3696.0 3790.9 3818.1 3847.5 3853.5 7392.8 7443.6 7564.0 7595.4 7613.7 7434.7 7488.1 7495.4 7498.2 7512.1 7292.7 7446.6 7568.8 7593.7 7603.9 5898.9 7282.3 7287.2 7301.7 7312.9 7135.4 7155.1 7159.0 7159.1 7169.9 7265.0 7518.3 7592.2 7595.2 7612.0 4587.0 4627.6 4632.3 4634.7 4649.5 7027.5 7241.7 7244.7 7251.5 7268.5 6984.0 6991.7 6995.6 6997.5 7003.1 6519.3 6953.4 6967.0 6971.7 6972.7 5509.3 6575.2 6816.3 6846.6 6853.7 5959.7 6987.2 6994.8 7000.2 7027.9 6848.3 6854.4 6855.7 6864.1 6881.1 17:14:01 INFO - PROCESS | 1961 | 17:14:01 INFO - PROCESS | 1961 | [#5] yui.html Cycles:180 Average:17778.43 Median:33019.77 stddev:24678.54 (74.7%) stddev-sans-first:24714.34 17:14:01 INFO - PROCESS | 1961 | Values: 672.5 672.8 728.9 731.2 744.4 14012.4 14107.6 14138.7 14190.4 14199.6 13376.7 13669.9 13714.4 13866.9 13893.4 696.1 701.3 854.3 868.4 872.5 713.7 840.9 871.0 873.6 873.9 903.5 917.0 923.8 925.4 925.6 733.8 735.4 736.6 916.5 918.7 670.2 675.0 677.4 677.7 680.8 14744.2 14812.0 14813.3 14830.7 14853.8 12523.7 12672.3 12771.9 12787.0 12891.2 9930.7 10130.1 10156.5 10275.7 10313.9 3538.3 3563.9 3567.0 3572.4 3574.1 57987.4 78395.2 78582.6 78976.6 79038.4 9478.0 9702.4 9761.0 9917.5 10253.8 21847.9 21879.9 21881.7 21905.9 21909.0 7440.0 7534.7 7729.3 7763.1 7810.8 4148.7 4189.4 4218.4 4244.2 4284.6 3433.2 3665.9 3674.7 3676.8 3682.2 693.6 696.4 714.6 721.3 728.7 515.6 522.6 537.0 593.9 648.9 8557.5 8660.5 8785.6 8855.0 8886.5 473.8 532.8 538.3 572.2 635.3 4011.2 4131.2 4356.0 4392.7 4424.2 72200.6 91194.9 91945.0 93128.5 93327.1 78328.0 79086.6 79183.6 79400.0 80064.6 66590.0 66906.7 66924.0 67044.3 68155.3 6903.8 8789.9 8862.6 8871.9 9108.8 34151.7 39869.6 46893.3 48176.0 48737.8 59537.4 65390.7 67426.3 68467.7 70097.6 10604.4 11137.5 11215.6 11233.8 11308.4 11877.7 12250.8 12327.3 12417.4 12645.4 11054.2 11295.7 11675.6 11733.1 12330.0 11392.7 11588.2 11743.7 11791.2 12440.0 9069.5 11025.6 11329.7 11431.8 12073.8 8730.2 8949.4 9588.6 9589.1 9691.4 8937.2 9240.5 9254.9 9957.9 9996.2 17:14:01 INFO - PROCESS | 1961 | -------- Summary: end -------- 17:14:01 INFO - PROCESS | 1961 | 17:14:01 INFO - TEST-INFO | 1961: exit 0 17:14:01 INFO - TEST-OK | dromaeo_css | took 1114062ms 17:14:01 INFO - TEST-START | kraken 17:14:01 INFO - operating with platform_type : mac_ 17:14:01 INFO - Initialising browser for kraken test... 17:14:01 INFO - TEST-INFO | started process 1965 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmprqtLkQ/profile http://localhost:49703/getInfo.html) 17:14:01 INFO - PROCESS | 1965 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 17:14:03 INFO - PROCESS | 1965 | __metrics Screen width/height:1600/1200 17:14:03 INFO - PROCESS | 1965 | colorDepth:24 17:14:03 INFO - PROCESS | 1965 | Browser inner width/height: 1024/689 17:14:03 INFO - PROCESS | 1965 | __metrics 17:14:03 INFO - PROCESS | 1965 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:14:03 INFO - PROCESS | 1965 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:14:04 INFO - TEST-INFO | 1965: exit 0 17:14:04 INFO - Browser initialized. 17:14:04 INFO - Running cycle 1/1 for kraken test... 17:14:04 INFO - TEST-INFO | started process 1967 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmprqtLkQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:14:16 INFO - PROCESS | 1967 | RSS: Main: 243474432 17:14:16 INFO - PROCESS | 1967 | 17:14:19 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49703/tests/kraken/driver.html?testName=audio-beat-detection) 17:14:19 INFO - PROCESS | 1967 | RSS: Main: 289755136 17:14:19 INFO - PROCESS | 1967 | 17:14:22 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49703/tests/kraken/driver.html?testName=audio-dft) 17:14:22 INFO - PROCESS | 1967 | RSS: Main: 301445120 17:14:22 INFO - PROCESS | 1967 | 17:14:26 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49703/tests/kraken/driver.html?testName=audio-fft) 17:14:26 INFO - PROCESS | 1967 | RSS: Main: 286642176 17:14:26 INFO - PROCESS | 1967 | 17:14:28 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49703/tests/kraken/driver.html?testName=audio-oscillator) 17:14:29 INFO - PROCESS | 1967 | RSS: Main: 291147776 17:14:29 INFO - PROCESS | 1967 | 17:14:31 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49703/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:14:31 INFO - PROCESS | 1967 | RSS: Main: 291926016 17:14:31 INFO - PROCESS | 1967 | 17:14:34 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49703/tests/kraken/driver.html?testName=imaging-darkroom) 17:14:35 INFO - PROCESS | 1967 | RSS: Main: 292229120 17:14:35 INFO - PROCESS | 1967 | 17:14:37 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49703/tests/kraken/driver.html?testName=imaging-desaturate) 17:14:38 INFO - PROCESS | 1967 | RSS: Main: 290578432 17:14:38 INFO - PROCESS | 1967 | 17:14:41 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49703/tests/kraken/driver.html?testName=json-parse-financial) 17:14:41 INFO - PROCESS | 1967 | RSS: Main: 292098048 17:14:41 INFO - PROCESS | 1967 | 17:14:43 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49703/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:14:43 INFO - PROCESS | 1967 | RSS: Main: 326094848 17:14:43 INFO - PROCESS | 1967 | 17:14:45 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49703/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:14:46 INFO - PROCESS | 1967 | RSS: Main: 326995968 17:14:46 INFO - PROCESS | 1967 | 17:14:48 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49703/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:14:48 INFO - PROCESS | 1967 | RSS: Main: 332668928 17:14:48 INFO - PROCESS | 1967 | 17:14:51 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49703/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:14:52 INFO - PROCESS | 1967 | RSS: Main: 333762560 17:14:52 INFO - PROCESS | 1967 | 17:14:54 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49703/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:14:55 INFO - PROCESS | 1967 | RSS: Main: 334458880 17:14:55 INFO - PROCESS | 1967 | 17:14:56 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49703/tests/kraken/driver.html?testName=ai-astar) 17:14:57 INFO - PROCESS | 1967 | RSS: Main: 394649600 17:14:57 INFO - PROCESS | 1967 | 17:14:57 INFO - PROCESS | 1967 | __start_tp_report 17:14:57 INFO - PROCESS | 1967 | _x_x_mozilla_page_load 17:14:57 INFO - PROCESS | 1967 | _x_x_mozilla_page_load_details 17:14:57 INFO - PROCESS | 1967 | |i|pagename|runs| 17:14:57 INFO - PROCESS | 1967 | |0;ai-astar;110;108;111;111;112;111;116;110;110;110 17:14:57 INFO - PROCESS | 1967 | |1;audio-beat-detection;159;143;172;154;119;142;140;118;161;145 17:14:57 INFO - PROCESS | 1967 | |2;audio-dft;185;185;183;186;187;183;184;183;181;183 17:14:57 INFO - PROCESS | 1967 | |3;audio-fft;73;76;84;76;57;56;56;86;96;80 17:14:57 INFO - PROCESS | 1967 | |4;audio-oscillator;94;93;125;79;79;81;111;76;76;112 17:14:57 INFO - PROCESS | 1967 | |5;imaging-gaussian-blur;84;88;84;90;84;88;83;89;84;90 17:14:57 INFO - PROCESS | 1967 | |6;imaging-darkroom;92;93;93;92;94;93;93;93;91;93 17:14:57 INFO - PROCESS | 1967 | |7;imaging-desaturate;85;84;84;84;84;86;86;87;86;86 17:14:57 INFO - PROCESS | 1967 | |8;json-parse-financial;54;52;54;55;54;53;53;63;51;52 17:14:57 INFO - PROCESS | 1967 | |9;json-stringify-tinderbox;64;62;67;79;68;66;65;66;66;68 17:14:57 INFO - PROCESS | 1967 | |10;stanford-crypto-aes;82;83;82;82;82;82;80;82;82;83 17:14:57 INFO - PROCESS | 1967 | |11;stanford-crypto-ccm;126;122;122;127;128;126;124;124;120;130 17:14:57 INFO - PROCESS | 1967 | |12;stanford-crypto-pbkdf2;138;135;141;138;135;126;139;134;138;135 17:14:57 INFO - PROCESS | 1967 | |13;stanford-crypto-sha256-iterative;67;66;65;66;66;69;87;96;95;98 17:14:57 INFO - PROCESS | 1967 | __end_tp_report 17:14:57 INFO - PROCESS | 1967 | __start_cc_report 17:14:57 INFO - PROCESS | 1967 | _x_x_mozilla_cycle_collect,1118 17:14:57 INFO - PROCESS | 1967 | __end_cc_report 17:14:57 INFO - PROCESS | 1967 | __startTimestamp1454548497179__endTimestamp 17:14:57 INFO - PROCESS | 1967 | 17:14:57 INFO - PROCESS | 1967 | ------- Summary: start ------- 17:14:57 INFO - PROCESS | 1967 | Number of tests: 14 17:14:57 INFO - PROCESS | 1967 | 17:14:57 INFO - PROCESS | 1967 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:2.08 (1.9%) stddev-sans-first:2.18 17:14:57 INFO - PROCESS | 1967 | Values: 110.0 108.0 111.0 111.0 112.0 111.0 116.0 110.0 110.0 110.0 17:14:57 INFO - PROCESS | 1967 | 17:14:57 INFO - PROCESS | 1967 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:149.50 stddev:17.33 (11.6%) stddev-sans-first:17.66 17:14:57 INFO - PROCESS | 1967 | Values: 159.0 143.0 172.0 154.0 119.0 142.0 140.0 118.0 161.0 145.0 17:14:57 INFO - PROCESS | 1967 | 17:14:57 INFO - PROCESS | 1967 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.50 stddev:1.76 (1.0%) stddev-sans-first:1.83 17:14:57 INFO - PROCESS | 1967 | Values: 185.0 185.0 183.0 186.0 187.0 183.0 184.0 183.0 181.0 183.0 17:14:57 INFO - PROCESS | 1967 | 17:14:57 INFO - PROCESS | 1967 | [#3] audio-fft Cycles:10 Average:74.00 Median:78.00 stddev:13.78 (17.7%) stddev-sans-first:14.62 17:14:57 INFO - PROCESS | 1967 | Values: 73.0 76.0 84.0 76.0 57.0 56.0 56.0 86.0 96.0 80.0 17:14:57 INFO - PROCESS | 1967 | 17:14:57 INFO - PROCESS | 1967 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:79.00 stddev:17.71 (22.4%) stddev-sans-first:18.78 17:14:57 INFO - PROCESS | 1967 | Values: 94.0 93.0 125.0 79.0 79.0 81.0 111.0 76.0 76.0 112.0 17:14:57 INFO - PROCESS | 1967 | 17:14:57 INFO - PROCESS | 1967 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:88.00 stddev:2.84 (3.2%) stddev-sans-first:2.87 17:14:57 INFO - PROCESS | 1967 | Values: 84.0 88.0 84.0 90.0 84.0 88.0 83.0 89.0 84.0 90.0 17:14:57 INFO - PROCESS | 1967 | 17:14:57 INFO - PROCESS | 1967 | [#6] imaging-darkroom Cycles:10 Average:92.70 Median:93.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 17:14:57 INFO - PROCESS | 1967 | Values: 92.0 93.0 93.0 92.0 94.0 93.0 93.0 93.0 91.0 93.0 17:14:57 INFO - PROCESS | 1967 | 17:14:57 INFO - PROCESS | 1967 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:86.00 stddev:1.14 (1.3%) stddev-sans-first:1.20 17:14:57 INFO - PROCESS | 1967 | Values: 85.0 84.0 84.0 84.0 84.0 86.0 86.0 87.0 86.0 86.0 17:14:57 INFO - PROCESS | 1967 | 17:14:57 INFO - PROCESS | 1967 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:3.35 (6.2%) stddev-sans-first:3.55 17:14:57 INFO - PROCESS | 1967 | Values: 54.0 52.0 54.0 55.0 54.0 53.0 53.0 63.0 51.0 52.0 17:14:57 INFO - PROCESS | 1967 | 17:14:57 INFO - PROCESS | 1967 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:66.50 stddev:4.56 (6.9%) stddev-sans-first:4.69 17:14:57 INFO - PROCESS | 1967 | Values: 64.0 62.0 67.0 79.0 68.0 66.0 65.0 66.0 66.0 68.0 17:14:57 INFO - PROCESS | 1967 | 17:14:57 INFO - PROCESS | 1967 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 17:14:57 INFO - PROCESS | 1967 | Values: 82.0 83.0 82.0 82.0 82.0 82.0 80.0 82.0 82.0 83.0 17:14:57 INFO - PROCESS | 1967 | 17:14:57 INFO - PROCESS | 1967 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:126.00 stddev:3.07 (2.4%) stddev-sans-first:3.23 17:14:57 INFO - PROCESS | 1967 | Values: 126.0 122.0 122.0 127.0 128.0 126.0 124.0 124.0 120.0 130.0 17:14:57 INFO - PROCESS | 1967 | 17:14:57 INFO - PROCESS | 1967 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.90 Median:138.00 stddev:4.12 (3.0%) stddev-sans-first:4.30 17:14:57 INFO - PROCESS | 1967 | Values: 138.0 135.0 141.0 138.0 135.0 126.0 139.0 134.0 138.0 135.0 17:14:57 INFO - PROCESS | 1967 | 17:14:57 INFO - PROCESS | 1967 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.50 Median:78.00 stddev:14.51 (18.6%) stddev-sans-first:14.88 17:14:57 INFO - PROCESS | 1967 | Values: 67.0 66.0 65.0 66.0 66.0 69.0 87.0 96.0 95.0 98.0 17:14:57 INFO - PROCESS | 1967 | -------- Summary: end -------- 17:14:57 INFO - PROCESS | 1967 | 17:14:57 INFO - TEST-INFO | 1967: exit 0 17:14:57 INFO - TEST-OK | kraken | took 56271ms 17:14:57 INFO - SUITE-END | took 1170s 17:14:58 INFO - Completed test suite (00:19:30) 17:14:58 INFO - Working with test: dromaeo_css 17:14:58 INFO - Generating results file: dromaeo_css 17:14:58 INFO - Working with test: kraken 17:14:58 INFO - Generating results file: kraken 17:14:58 INFO - javascript benchmark 17:14:58 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:14:58 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 17:14:58 INFO - process_Request line: dromaeo_css 7388.05 graph.html#tests=[[72,64,59]] 17:14:58 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:14:58 INFO - process_Request line: kraken 1412.60 graph.html#tests=[[232,64,59]] 17:14:58 INFO - RETURN: dromaeo_css: 7388.05 17:14:58 INFO - RETURN: kraken: 1412.60 17:14:58 INFO - javascript benchmark 17:14:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2992.985035074823, 3308.718758905493, 3355.0438125134337, 3358.865645374185, 3427.8628854845806, 4944.826931057413, 5414.702191379472, 5436.483534064262, 5466.043442397579, 5476.288082549273, 5440.238366628665, 5450.5367043801325, 5459.481349271823, 5460.426655201206, 5463.3717122530925, 4976.626752993531, 4986.9251961220425, 5031.672941258825, 5082.618803589727, 5105.5660268877, 5049.520295571915, 5108.080545501808, 5130.461301563338, 5140.049090918192, 5140.177571588547, 5111.207762796773, 5113.948860511403, 5123.257127716479, 5127.897442051157, 5131.435542090386, 5109.182530795055, 5122.0, 5126.077306084903, 5134.2812006319145, 5138.640295179339, 4869.951300486985, 5113.309703190096, 5121.975604879002, 5137.460566640486, 5144.9742751286, 5479.4520547944885, 5501.339839219279, 5512.3385193777, 5532.446755324476, 5553.16702494625, 5956.16613674086, 5956.463918247336, 5971.910421343683, 5972.611780234271, 6012.6993650317745, 5540.335159780852, 5650.0959846424785, 6001.219841420631, 6105.520399749632, 6131.172291740602, 5563.721813909288, 5583.022970980062, 5584.748686309126, 5599.60802743804, 5648.237487939116, 6151.5386346024225, 6157.230346206724, 6162.22972128484, 6167.013277875519, 6173.043178307369, 5729.598928074995, 5794.855128621818, 5811.331696854916, 5848.210491583667, 5928.843875444247, 6055.848603784941, 6097.512199024068, 6114.633122012693, 6115.755369785248, 6153.938460615426, 6020.53453717396, 6050.971334873082, 6062.661466489788, 6080.48315893154, 6103.6032657877095, 4872.6832755870755, 5815.040518314515, 5990.820275391745, 6006.039033754666, 6015.308239552507, 4753.47711751707, 4771.23660214364, 4783.880402989953, 4807.158747219222, 4811.807527698923, 4222.155568886235, 4234.174336004511, 4239.342901850218, 4268.509121451011, 4279.914401711948, 5407.432219616883, 5488.890222195534, 5496.972515137399, 5558.638688485235, 5584.301962254718, 5933.554983376264, 5990.0, 6021.969890150521, 6100.762843515285, 6114.205153330038, 5538.196961440569, 5547.805826796123, 5564.19319198722, 5565.554755619541, 5569.10894256917, 5132.204508301219, 5203.349581302337, 5214.582833373321, 5229.163333866563, 5276.762545685453, 6091.725872335755, 6160.722767475564, 6237.563370564017, 6239.78160764362, 6264.9976003840075, 6085.269767627913, 6096.9390306096375, 6098.756049758137, 6109.633421994695, 6109.725062372115, 5144.228365745168, 6271.0, 6272.372762723691, 6274.1843560336865, 6279.591826531261, 4938.629602779734, 5814.970925145347, 5875.882482350244, 5929.140274660064, 5946.286445626552, 4503.414556107685, 6048.425399587032, 6095.603785753912, 6118.510519158545, 6125.295591007091, 5849.151872978309, 5851.561132915133, 5865.4134586541, 5868.119782032559, 5873.3832947539895, 5727.39862314451, 5741.5119714824705, 5809.302883653989, 5823.7379317931645, 5844.211031510692, 5657.43425657431, 5663.603547751618, 5672.14917762339, 5681.204631351697, 5685.573581981285, 5775.566832487496, 5777.971110144423, 5781.161731548817, 5782.363939966516, 5787.842431513798, 5138.486151384832, 5642.463965923231, 5699.487046165865, 5702.743376548148, 5738.770449181986], "unit": "score", "name": "dojo.html", "value": 5486.729093354703}, {"lowerIsBetter": false, "replicates": [491.0155138946412, 508.85497633174543, 521.3457111325287, 526.7708546782147, 549.0501432521737, 28775.712242877566, 29979.0, 37529.43705844414, 37999.050023749354, 38021.42967855478, 40857.79571102148, 41238.0, 41318.79340603293, 41328.58671413292, 41449.58550414495, 9461.195798357148, 9685.951570242174, 9695.418274903494, 9697.515124243795, 9698.272629552812, 9544.856827147598, 9667.90332096677, 9681.031896810298, 9681.467519286436, 9684.612615495407, 8269.917300826975, 9650.276229282797, 9709.271804614647, 9741.415515069084, 9757.073078057609, 9622.56698448568, 9690.224782017422, 9694.03059694032, 9697.757556061155, 9699.51502424883, 9651.565679544437, 9777.657781977596, 9788.657396991071, 9807.460589667566, 9808.705738827846, 39399.8030009851, 39721.60278397208, 39755.403668944986, 39784.005399864946, 39793.60206397928, 3208.4224839528874, 3245.6105267368066, 3399.201187720884, 3564.946525802115, 3767.340715374826, 28580.714192858013, 28956.131316060553, 28965.275868103254, 29190.832366705305, 29200.853995729885, 2762.1437354420195, 2766.488199683065, 2849.800513964023, 2970.4950158472893, 2973.940521189564, 481424.0, 485375.0, 485741.0, 486815.92288539815, 487168.0, 56637.43362566404, 57947.420525795045, 58036.54908627318, 59459.51351216254, 60768.08847867197, 68866.65566672235, 70169.64915175493, 70378.94431583531, 70390.0, 70431.29568704247, 15671.843281567266, 16053.277602507915, 16077.919610401874, 16089.0, 16115.113668748098, 11298.7175320616, 11556.248843825124, 12290.938545307215, 12357.443915023845, 12374.948129409102, 17716.0, 20724.378268651966, 20935.68596471054, 21107.894460527597, 21121.0, 8074.555899425471, 8190.918090819135, 8195.95902020486, 8224.794380140544, 8281.585920703941, 972.8005758819424, 981.9361741486781, 1023.764534157148, 1024.6823484719762, 1042.0933787604831, 28373.43253134967, 29024.723766556675, 29452.852735736185, 29722.702772971992, 29980.70019299823, 1073.302353470235, 1080.103514083309, 1113.2485572238868, 1164.1559869094838, 1257.0948916779903, 13987.510437134855, 15270.38918443272, 15499.0, 15757.68484630301, 15911.681766364607, 535011.0, 540125.0, 540278.0, 541764.0, 542150.0, 56620.0, 56864.71567642135, 56937.43062569321, 56967.430325696216, 57046.00338988115, 1454.3818876977455, 1462.4004158295047, 1473.4032716749734, 1482.4589025005796, 1599.2323684631442, 29801.0, 30087.548686770155, 30109.849450752605, 30226.234392026065, 30228.84885575558, 51317.7434112827, 51736.75685403971, 51770.48229517657, 51834.481655182964, 51850.0, 507887.0, 510728.0, 511382.0, 513043.0, 513203.0, 27938.58092128579, 28472.58674905393, 30695.693043070176, 32937.83531082329, 33075.50386744249, 33260.00219993404, 33383.83308083444, 40062.0, 40378.39432408575, 41476.0, 31589.0, 32793.01620951375, 34997.47503787496, 36568.63431365759, 37223.441648374755, 24383.0, 32413.837930810194, 34944.82527587346, 35236.82381588076, 35780.0, 33186.33627327392, 33585.496217557244, 34580.308393832485, 34582.30835383329, 34641.65358346384, 29114.0, 30103.0, 31001.534976974912, 31952.68047319497, 32340.514892277104, 23854.880725596955, 24212.030090210214, 24768.25695229146, 24790.50418991646, 24827.751722482542], "unit": "score", "name": "ext.html", "value": 19506.2223488291}, {"lowerIsBetter": false, "replicates": [362.82947014902993, 364.3350884635541, 364.4333062088453, 367.1537106968437, 371.314923965284, 14332.928335358334, 15305.770413443808, 16597.50207493774, 18831.435056948278, 19392.418227453163, 11626.128040396961, 11664.6500604982, 11937.701557461069, 11944.522219111246, 11944.940275298612, 3961.6830653547645, 5228.529432351097, 5371.892562148755, 5372.811951581695, 5374.086405311106, 4085.7344272622186, 4111.568285330042, 5630.831075067734, 5874.70626468677, 5885.85285367865, 5532.3914369419335, 5785.623934444247, 5805.7387417566315, 5848.824535263949, 5855.590108692393, 5569.944300556983, 5672.773089076452, 5741.45456181662, 5747.453991870766, 5751.424857514257, 5578.721063946827, 5579.38626751057, 5580.218769372291, 5592.0773072443, 5599.552035837123, 13076.738465230737, 13092.86907130926, 17585.912070439565, 22186.112555497763, 23243.76756232433, 2068.307117115768, 2075.56413153238, 2082.83337333013, 2273.818094552432, 2359.775821296974, 9430.811383772354, 9556.665516706882, 9580.90419095807, 10104.69685909424, 10131.898681013243, 1697.8811483196182, 1785.1788177438393, 1798.7301904714266, 1800.8109148539477, 1810.7827060752663, 89840.5507972456, 94104.52947735217, 94253.0, 96193.0, 96587.0, 10738.302010369302, 10970.725731856608, 11029.61396351124, 11056.391898445663, 11121.888781112248, 13240.53658121961, 13353.465861365437, 13382.531611393555, 13428.328583570783, 13437.664058398619, 8332.750017499484, 8336.208060234268, 8349.749507514784, 8452.61963211657, 8462.87305690415, 8413.0, 8424.578771061422, 8441.240288373952, 8506.65973361071, 8515.57422128891, 3433.776804507699, 3963.8216280267457, 4171.0823618803815, 4335.241332766753, 4469.128519938646, 1758.7537744715494, 1843.988597173225, 1866.374764453896, 1866.887986720801, 1869.2896699254468, 881.6276506896369, 882.0826340605827, 885.7077164535688, 889.6708217959397, 993.6472552243994, 16659.33362665504, 19065.90467047656, 19210.903945480182, 19782.40652780419, 20335.288264910658, 952.4618590496348, 958.8178246133212, 975.3562648651856, 986.3095832916987, 1014.60937539048, 8948.552572371356, 9367.344285899922, 9959.55182016811, 10672.94663526693, 10704.518296676668, 579536.0, 582433.0, 590874.0, 732564.0, 770793.0, 70915.29084709087, 94248.0, 113646.0, 117616.0, 120868.0, 1137.0903277378065, 1167.3171194851107, 1190.2798806721983, 1200.2198570928965, 1200.8138738495547, 18189.09054547241, 18287.725684115016, 18498.630027399107, 18499.445016649523, 19097.331593394163, 50551.49448505468, 51678.708032299495, 52268.69328266824, 52565.7371713139, 52665.47334526606, 67431.0, 69749.65125174342, 70071.59856802733, 70342.02092822167, 70822.64588677023, 7494.325510704063, 7730.729424470116, 7783.338416234684, 7803.453758236869, 7815.491993020435, 11495.655130346104, 11506.597269095542, 11819.231749936227, 11901.345426001653, 12031.0, 10172.237082218715, 10220.080192782685, 10234.33476824004, 10275.126614237874, 10392.58429662805, 8247.463914845515, 9926.255530835071, 10312.535935883054, 10363.792724145625, 10640.946795265974, 8659.696910608098, 10167.0, 10485.9475702621, 10493.52779124926, 10808.0, 7490.962545187239, 7510.0, 7605.35354494852, 7658.540487570764, 7665.961670191613, 9628.855567166358, 10307.896921030993, 10313.690589282334, 10514.526846291783, 10530.31552949056], "unit": "score", "name": "jquery.html", "value": 8826.90804800561}, {"lowerIsBetter": false, "replicates": [1345.7106722054757, 1521.0645453046377, 1556.922153892305, 1795.2908601102565, 1939.5345117171864, 7915.604219789009, 8104.959475202623, 8582.656693732244, 8792.0, 8794.944606647212, 8575.614097365618, 8605.913940860604, 8716.433431826927, 8721.520316382597, 8732.476051436919, 2174.3694328644674, 2237.7314722233355, 2466.4943686544216, 2497.1384872219055, 2499.6375525548783, 2227.4431392151964, 2236.0720301075116, 2452.901883924641, 2526.5452218600644, 2531.316544532984, 2451.6199989001734, 2461.7907477864314, 2478.3432390416556, 2485.030837973192, 2487.9875600622063, 2437.427204606916, 2481.1192026830486, 2484.763947424992, 2487.3657217409627, 2500.6749122614124, 2445.376429010591, 2481.7642323979194, 2485.652008718781, 2485.763852434016, 2490.9875450622812, 8782.64869405223, 8876.955615221947, 8883.0, 8910.777230569223, 8927.241184499326, 5387.622866399353, 5482.424345443751, 5503.807366742145, 5543.473370029841, 5554.305711786027, 3336.899893003214, 3383.390989621867, 3650.178709790276, 3725.5715592706915, 3732.9253414931823, 1039.2050081687514, 1061.9893801061967, 1064.3613831700995, 1088.1131877519874, 1090.6346373964732, 12168.695782605417, 12218.75562488754, 12244.632661020183, 12246.020318374509, 12255.264684118893, 4033.757974521538, 4884.0, 4945.653804233669, 4948.901021979612, 4953.306537084811, 9016.909830901606, 10331.586736530455, 10339.84490232632, 10341.37951722884, 10367.27429079957, 5542.11326187808, 5545.528630066409, 5551.750171242304, 5551.8889622207325, 5552.5280351169795, 5003.449620541737, 5056.241563765465, 5057.974710126499, 5065.645404821701, 5068.695878247317, 2993.3863557970562, 3678.3562876496508, 3769.1142581493327, 3958.4062390641634, 3982.064214909494, 1082.4046774274275, 1224.834647322618, 1301.7071158989152, 1314.5333406640696, 1318.6110097521255, 1317.5520323090195, 1325.9005574581945, 1328.1234385305652, 1353.5195005773005, 1355.1868878672717, 8082.9191708083345, 8166.142555031755, 8168.264856162974, 8180.877286840702, 8220.219079187467, 1170.4849866058908, 1173.1553281637207, 1180.7874582575218, 1192.7137487003056, 1218.4760552962312, 6104.053871649901, 6112.724927378279, 6188.350223226496, 6200.906986395207, 6204.0, 10612.151027917747, 10844.078253348396, 10854.565817367216, 10986.670399888017, 10994.175436842268, 10319.638812641522, 10648.414337211372, 10822.18833587484, 10829.83755243672, 10844.837327440095, 8327.084020757711, 8327.250547450638, 8327.791805204919, 8416.53709045996, 8419.494830310201, 7738.651760670896, 7814.960925195338, 7897.763067107996, 8198.016238051472, 8207.507549547046, 9253.907460925304, 9508.714738557854, 9631.133198012212, 9634.277429192698, 9728.075832795874, 9703.854442183232, 10060.144887684335, 10084.69745907624, 10089.29374943747, 10100.141487973604, 7590.962045189739, 7616.3906887449975, 7659.234076592296, 7702.306792388712, 7736.574488403192, 7423.109226892808, 7601.7719468416035, 8219.465734727224, 8340.249377556049, 8370.958145209235, 7082.5396349237135, 7440.776776696492, 7773.37812974972, 7787.0, 7942.483738556975, 7677.838150692712, 7733.613319333898, 7739.574323412041, 7763.417743669134, 7784.649690764042, 7869.724559640385, 7887.763367098996, 7923.920760792318, 7936.968194134725, 7942.960285198537, 7061.82345441368, 7077.5753454792875, 7116.715331386894, 7177.928220717726, 7179.748708795376, 7264.782056538313, 7339.412846972123, 7352.816179595553, 7358.374538164102, 7360.33756961876], "unit": "score", "name": "mootools.html", "value": 4981.456345260294}, {"lowerIsBetter": false, "replicates": [314.5611871439342, 322.22344150597064, 333.05080520516526, 336.8433678339572, 338.75609561116005, 6542.64015479149, 6547.181602299713, 6585.769498067574, 6602.1417215761885, 6603.735850565971, 6467.223933128032, 6479.838004049901, 6496.870062598745, 6527.673616319177, 6594.472442204624, 4864.416270047591, 4870.683405578644, 4871.635941936263, 4874.220124780036, 4879.170541008037, 4581.67928245023, 4727.550882666158, 4741.407324084489, 4754.595859351959, 4764.071006153801, 3479.652034796525, 3998.2203470323298, 4660.6504512161555, 4688.5077066908, 4692.577668009879, 4560.931586026212, 4641.234196357597, 4660.603848672833, 4701.083288758693, 4726.669133160697, 3974.225026119908, 3990.3415936370466, 4066.5323487798987, 4074.5110586729484, 4080.9387859182134, 6246.875062498724, 6263.0, 6290.402411770874, 6292.835825372275, 6318.178636777189, 5295.179247216687, 5396.757145928443, 5520.3651580068, 5531.170324451325, 5550.333959924795, 6336.96831515844, 6801.557898736616, 6801.761938332184, 6928.722851086001, 6947.5831450113155, 4488.438945131858, 4493.68544201906, 4495.123450927071, 4507.827964729161, 4509.053098849213, 7221.061262035954, 7299.854002919912, 7310.561366317985, 7315.561066336037, 7317.195108538057, 4443.644508439317, 4569.1547063793305, 4572.542745725401, 4589.0, 4616.28447590624, 4653.185692503798, 4654.697444666086, 4661.370714953506, 4667.883302917454, 4676.929846052312, 5517.806876759374, 5526.834194974157, 5533.253010843565, 5533.584981126432, 5536.75084621193, 6664.466842652576, 6932.202796678345, 6938.340857618518, 6951.721931122698, 6970.198427180838, 1598.4804938395068, 1613.6369316903604, 1616.4665660332298, 1618.0857815334298, 1621.959451013734, 1020.2297265564451, 1028.8559601655775, 1041.2919214933765, 1044.984325235122, 1045.743792770776, 6544.770933017321, 6545.280019197884, 6553.639549824806, 6555.836104097436, 6577.638229897306, 7223.819404514929, 7228.421726261887, 7231.096112985877, 7233.674484648203, 7249.130104387507, 5292.629515933924, 6393.776217832354, 6520.836979075466, 6536.411722944958, 6543.836404089936, 3695.981520092382, 3790.9241815164096, 3818.1409182933617, 3847.5190601174854, 3853.460515527828, 7392.815179620553, 7443.590602516805, 7563.978862853554, 7595.354394876387, 7613.733519326797, 7434.665440055211, 7488.101427828696, 7495.362894154058, 7498.212687667826, 7512.098548174254, 7292.671829767673, 7446.553206807609, 7568.772936811904, 7593.658285377061, 7603.897434871913, 5898.941010590011, 7282.344588987016, 7287.161976372573, 7301.671424785791, 7312.853742925218, 7135.357817796424, 7155.141383034069, 7159.033530473528, 7159.105111861018, 7169.892451613126, 7264.963675181591, 7518.323350898446, 7592.164861865301, 7595.164531901376, 7612.0, 4586.954130458653, 4627.5603817637275, 4632.328312394617, 4634.698744581591, 4649.511801260819, 7027.543209691558, 7241.746538871114, 7244.673989670372, 7251.456140789356, 7268.491205615767, 6984.0, 6991.650417479207, 6995.615241161785, 6997.475189360716, 7003.054587630605, 6519.282878883414, 6953.374196322356, 6967.0246165535855, 6971.7211311549, 6972.6513674315065, 5509.338879334506, 6575.178102737158, 6816.318368163144, 6846.623435711083, 6853.725850965906, 5959.731812068554, 6987.196472405535, 6994.825129371603, 7000.229974702676, 7027.894581581382, 6848.315168483112, 6854.417374523022, 6855.725770969305, 6864.107666003388, 6881.13985751781], "unit": "score", "name": "prototype.html", "value": 5068.413959148015}, {"lowerIsBetter": false, "replicates": [672.5258692621702, 672.8418821576931, 728.9271072892711, 731.1993367262852, 744.3747252308063, 14012.439502419904, 14107.57677269681, 14138.71722565548, 14190.432382704705, 14199.57401277962, 13376.732465350688, 13669.863301367008, 13714.382852771625, 13866.930665346685, 13893.374798134082, 696.0846486869775, 701.295198325682, 854.2866706300231, 868.3877866104381, 872.5113936195751, 713.6610110197666, 840.920112589303, 871.0114020586616, 873.6199753107419, 873.9082396348388, 903.4714691905243, 917.0096296000337, 923.7505873414174, 925.3568769705058, 925.5834874306589, 733.8202140475591, 735.3565630073685, 736.5985537881867, 916.4867674102491, 918.6922381002372, 670.2292363781642, 674.9696263668146, 677.3903486861815, 677.7153595489906, 680.8059702984675, 14744.189069601167, 14812.0, 14813.259337033105, 14830.70338593233, 14853.777193342108, 12523.749525009449, 12672.303023333805, 12771.93614031924, 12787.04097192705, 12891.226526408353, 9930.702078937644, 10130.088292053677, 10156.542955567018, 10275.69172924806, 10313.9484302578, 3538.31002954424, 3563.94654080189, 3567.0, 3572.356975744365, 3574.0528759878653, 57987.42012579862, 78395.21604783936, 78582.60708696477, 78976.60511697405, 79038.41923161563, 9477.952610236905, 9702.417854928726, 9761.0, 9917.454540000224, 10253.84619230712, 21847.890760546095, 21879.890600546896, 21881.67177492339, 21905.890470547547, 21909.0, 7439.95109611298, 7534.698612055566, 7729.343005844454, 7763.146053934062, 7810.804729881685, 4148.688848336326, 4189.350650649154, 4218.409422680827, 4244.151169766059, 4284.592963668447, 3433.1931995980926, 3665.9450108248398, 3674.65090816372, 3676.761010534307, 3682.226732386229, 693.5838496901819, 696.4254490045732, 714.5569746757044, 721.2679130682361, 728.6720975561019, 515.6338999310532, 522.6341560907304, 536.9838904832861, 593.9495142912814, 648.8637386148868, 8557.529335886586, 8660.48037117775, 8785.560721963877, 8855.025947145808, 8886.4668119913, 473.7820602522809, 532.7815595605861, 538.3485981961792, 572.2132068405942, 635.3360738028771, 4011.1548687603445, 4131.194417088699, 4355.978220108879, 4392.736435813861, 4424.247877860771, 72200.63899680573, 91194.87759997218, 91945.0, 93128.53435732778, 93327.13345733183, 78328.0, 79086.60456697679, 79183.60408198037, 79400.0, 80064.5996770024, 66590.0011499828, 66906.66546667235, 66924.0, 67044.32955670479, 68155.31844681589, 6903.827404314932, 8789.91210087891, 8862.64549418016, 8871.866921996047, 9108.817823643358, 34151.65848341584, 39869.60456384013, 46893.33759131334, 48176.0, 48737.75631121822, 59537.40462595492, 65390.67304663446, 67426.32573674397, 68467.65766171138, 70097.59804803773, 10604.416757078434, 11137.498812553617, 11215.551377945118, 11233.775324493628, 11308.434578271219, 11877.703057423634, 12250.816237756262, 12327.32829899399, 12417.379131043232, 12645.430955606837, 11054.170937179582, 11295.661130166109, 11675.649730508097, 11733.120015999006, 12330.013598912245, 11392.715182120513, 11588.188826782045, 11743.706407339885, 11791.233569817934, 12440.0, 9069.501177435304, 11025.61410350634, 11329.660110196708, 11431.771364572829, 12073.75852482963, 8730.17063378978, 8949.373543851867, 9588.616455341707, 9589.136977672042, 9691.370060946298, 8937.195652391316, 9240.491772952551, 9254.861177082215, 9957.900420995988, 9996.150327222267], "unit": "score", "name": "yui.html", "value": 6817.440679768942}], "name": "dromaeo_css", "value": 7388.051678857469}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 108.0, 111.0, 111.0, 112.0, 111.0, 116.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [159.0, 143.0, 172.0, 154.0, 119.0, 142.0, 140.0, 118.0, 161.0, 145.0], "unit": "score", "name": "audio-beat-detection", "value": 145.3}, {"lowerIsBetter": true, "replicates": [185.0, 185.0, 183.0, 186.0, 187.0, 183.0, 184.0, 183.0, 181.0, 183.0], "unit": "score", "name": "audio-dft", "value": 184.0}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 84.0, 76.0, 57.0, 56.0, 56.0, 86.0, 96.0, 80.0], "unit": "score", "name": "audio-fft", "value": 74.0}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 125.0, 79.0, 79.0, 81.0, 111.0, 76.0, 76.0, 112.0], "unit": "score", "name": "audio-oscillator", "value": 92.6}, {"lowerIsBetter": true, "replicates": [84.0, 88.0, 84.0, 90.0, 84.0, 88.0, 83.0, 89.0, 84.0, 90.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.4}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 93.0, 92.0, 94.0, 93.0, 93.0, 93.0, 91.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 92.7}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 84.0, 84.0, 84.0, 86.0, 86.0, 87.0, 86.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 85.2}, {"lowerIsBetter": true, "replicates": [54.0, 52.0, 54.0, 55.0, 54.0, 53.0, 53.0, 63.0, 51.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.1}, {"lowerIsBetter": true, "replicates": [64.0, 62.0, 67.0, 79.0, 68.0, 66.0, 65.0, 66.0, 66.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 82.0, 82.0, 82.0, 82.0, 80.0, 82.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.0}, {"lowerIsBetter": true, "replicates": [126.0, 122.0, 122.0, 127.0, 128.0, 126.0, 124.0, 124.0, 120.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.9}, {"lowerIsBetter": true, "replicates": [138.0, 135.0, 141.0, 138.0, 135.0, 126.0, 139.0, 134.0, 138.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.9}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 65.0, 66.0, 66.0, 69.0, 87.0, 96.0, 95.0, 98.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 77.5}], "name": "kraken", "value": 1412.6000000000004}]} 17:14:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1412.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7388.05"}}} 17:14:58 INFO - Return code: 0 17:14:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:14:58 INFO - # TBPL SUCCESS # 17:14:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:14:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:14:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:14:58 INFO - 2016-02-03 17:14:58.842 screenresolution[1971:14027] starting screenresolution argv=screenresolution get 17:14:58 INFO - 2016-02-03 17:14:58.845 screenresolution[1971:14027] Display 0: 1600x1200x32@60 17:14:58 INFO - 2016-02-03 17:14:58.851 screenresolution[1972:14030] starting screenresolution argv=screenresolution list 17:14:58 INFO - Available Modes on Display 0 17:14:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:14:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:14:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:14:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:14:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:14:59 INFO - Intel Iris: 17:14:59 INFO - Chipset Model: Intel Iris 17:14:59 INFO - Type: GPU 17:14:59 INFO - Bus: Built-In 17:14:59 INFO - VRAM (Dynamic, Max): 1536 MB 17:14:59 INFO - Vendor: Intel (0x8086) 17:14:59 INFO - Device ID: 0x0a2e 17:14:59 INFO - Revision ID: 0x0009 17:14:59 INFO - Displays: 17:14:59 INFO - Display: 17:14:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:14:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:14:59 INFO - Display Serial Number: 1600x1200 60 17:14:59 INFO - Main Display: Yes 17:14:59 INFO - Mirror: Off 17:14:59 INFO - Online: Yes 17:14:59 INFO - Rotation: Supported 17:14:59 INFO - Return code: 0 17:14:59 INFO - Running post-action listener: _resource_record_post_action 17:14:59 INFO - Running post-run listener: _resource_record_post_run 17:15:00 INFO - Total resource usage - Wall time: 1207s; CPU: 52.0%; Read bytes: 2596864; Write bytes: 708619264; Read time: 40; Write time: 1865 17:15:00 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 382306816; Write bytes: 376743424; Read time: 28629; Write time: 671 17:15:00 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 2596864; Write bytes: 302302720; Read time: 40; Write time: 1135 17:15:00 INFO - Running post-run listener: _upload_blobber_files 17:15:00 INFO - Blob upload gear active. 17:15:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:15:00 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 17:15:00 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'] 17:15:00 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 17:15:00 INFO - (blobuploader) - INFO - Open directory for files ... 17:15:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:15:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:15:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:15:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:15:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:15:01 INFO - (blobuploader) - INFO - Done attempting. 17:15:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:15:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:15:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:15:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:15:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:15:02 INFO - (blobuploader) - INFO - Done attempting. 17:15:02 INFO - (blobuploader) - INFO - Iteration through files over. 17:15:02 INFO - Return code: 0 17:15:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:15:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:15:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/288035b24bb3af571801e9c88a7cc93f2faea1646fe9249c19e0baa09c03b07911b1fb13cdcfa832645a0323414e2a3b1a4502ee5008dff08de61dfa1e364a2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ed27eb82fdefd30b8403286e5168da064c519e113e4304cd1419805d6947d374ddc54f14f077d42a7f0997028ed67880a91cfdc46590cf6e440fb620ebe5fe5"} 17:15:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:15:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:15:02 INFO - Contents: 17:15:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/288035b24bb3af571801e9c88a7cc93f2faea1646fe9249c19e0baa09c03b07911b1fb13cdcfa832645a0323414e2a3b1a4502ee5008dff08de61dfa1e364a2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ed27eb82fdefd30b8403286e5168da064c519e113e4304cd1419805d6947d374ddc54f14f077d42a7f0997028ed67880a91cfdc46590cf6e440fb620ebe5fe5"} 17:15:02 INFO - Running post-run listener: copy_logs_to_upload_dir 17:15:02 INFO - Copying logs to upload dir... 17:15:02 INFO - mkdir: /builds/slave/test/build/upload/logs 17:15:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.146278 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-02-03 17:15:02.928980) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-03 17:15:02.932845) ========= 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.RhyHUauhg1/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.wTWuoo0NOl/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/288035b24bb3af571801e9c88a7cc93f2faea1646fe9249c19e0baa09c03b07911b1fb13cdcfa832645a0323414e2a3b1a4502ee5008dff08de61dfa1e364a2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ed27eb82fdefd30b8403286e5168da064c519e113e4304cd1419805d6947d374ddc54f14f077d42a7f0997028ed67880a91cfdc46590cf6e440fb620ebe5fe5"} build_url:https://queue.taskcluster.net/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010969 build_url: 'https://queue.taskcluster.net/v1/task/QjwPsykcRcufT4NhKFqwZA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/288035b24bb3af571801e9c88a7cc93f2faea1646fe9249c19e0baa09c03b07911b1fb13cdcfa832645a0323414e2a3b1a4502ee5008dff08de61dfa1e364a2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ed27eb82fdefd30b8403286e5168da064c519e113e4304cd1419805d6947d374ddc54f14f077d42a7f0997028ed67880a91cfdc46590cf6e440fb620ebe5fe5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-03 17:15:02.960184) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 17:15:02.960530) ========= 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.RhyHUauhg1/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.wTWuoo0NOl/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.004644 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 17:15:03.008189) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-03 17:15:03.008513) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-03 17:15:03.008908) ========= ========= Total master_lag: 0.49 =========