builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0103 starttime: 1456957957.4 results: success (0) buildid: 20160302130423 builduid: 625f9ef9dd8a4746b8a6f5212d608eb1 revision: d7ec3f281e341700a8b969518d4f6e72ea3a1621 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 14:32:37.397234) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 14:32:37.397715) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 14:32:37.398067) ========= 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.BdQ1sY54uZ/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.XVvohzFcXl/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.005879 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 14:32:37.421858) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 14:32:37.422201) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 14:32:37.438627) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 14:32:37.438993) ========= 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.BdQ1sY54uZ/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.XVvohzFcXl/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.005555 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 14:32:37.486806) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 14:32:37.487163) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 14:32:37.487569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 14:32:37.487897) ========= 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.BdQ1sY54uZ/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.XVvohzFcXl/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-03-02 14:32:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.7M=0.001s 2016-03-02 14:32:37 (16.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.138736 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 14:32:37.642004) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 14:32:37.642372) ========= 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.BdQ1sY54uZ/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.XVvohzFcXl/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.026659 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 14:32:37.691096) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-02 14:32:37.691496) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d7ec3f281e341700a8b969518d4f6e72ea3a1621 --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 d7ec3f281e341700a8b969518d4f6e72ea3a1621 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BdQ1sY54uZ/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.XVvohzFcXl/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-03-02 14:32:37,772 truncating revision to first 12 chars 2016-03-02 14:32:37,772 Setting DEBUG logging. 2016-03-02 14:32:37,773 attempt 1/10 2016-03-02 14:32:37,773 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d7ec3f281e34?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-02 14:32:39,001 unpacking tar archive at: fx-team-d7ec3f281e34/testing/mozharness/ program finished with exit code 0 elapsedTime=1.465933 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-02 14:32:39.174269) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 14:32:39.174676) ========= echo d7ec3f281e341700a8b969518d4f6e72ea3a1621 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd7ec3f281e341700a8b969518d4f6e72ea3a1621'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BdQ1sY54uZ/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.XVvohzFcXl/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 d7ec3f281e341700a8b969518d4f6e72ea3a1621 program finished with exit code 0 elapsedTime=0.005401 script_repo_revision: 'd7ec3f281e341700a8b969518d4f6e72ea3a1621' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 14:32:39.225023) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 14:32:39.225391) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 14:32:39.239242) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-02 14:32:39.239682) ========= /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.BdQ1sY54uZ/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.XVvohzFcXl/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 14:32:39 INFO - MultiFileLogger online at 20160302 14:32:39 in /builds/slave/test 14:32:39 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 14:32:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:32:39 INFO - {'append_to_log': False, 14:32:39 INFO - 'base_work_dir': '/builds/slave/test', 14:32:39 INFO - 'blob_upload_branch': 'Fx-Team', 14:32:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:32:39 INFO - 'branch': 'Fx-Team', 14:32:39 INFO - 'buildbot_json_path': 'buildprops.json', 14:32:39 INFO - 'config_files': ('talos/mac_config.py',), 14:32:39 INFO - 'default_actions': ('clobber', 14:32:39 INFO - 'read-buildbot-config', 14:32:39 INFO - 'download-and-extract', 14:32:39 INFO - 'populate-webroot', 14:32:39 INFO - 'create-virtualenv', 14:32:39 INFO - 'install', 14:32:39 INFO - 'run-tests'), 14:32:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:32:39 INFO - 'download_minidump_stackwalk': True, 14:32:39 INFO - 'download_symbols': 'ondemand', 14:32:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:32:39 INFO - 'tooltool.py': '/tools/tooltool.py', 14:32:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:32:39 INFO - '/tools/misc-python/virtualenv.py')}, 14:32:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:32:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:32:39 INFO - 'installer_path': 'installer.exe', 14:32:39 INFO - 'log_level': 'info', 14:32:39 INFO - 'log_name': 'talos', 14:32:39 INFO - 'log_to_console': True, 14:32:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:32:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:32:39 INFO - 'opt_config_files': (), 14:32:39 INFO - 'pip_index': False, 14:32:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:32:39 INFO - 'cmd': ('bash', 14:32:39 INFO - '-c', 14:32:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:32:39 INFO - 'enabled': True, 14:32:39 INFO - 'halt_on_failure': False, 14:32:39 INFO - 'name': 'check_screen_resolution'},), 14:32:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:32:39 INFO - 'cmd': ('bash', 14:32:39 INFO - '-c', 14:32:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:32:39 INFO - 'enabled': True, 14:32:39 INFO - 'halt_on_failure': False, 14:32:39 INFO - 'name': 'check_screen_resolution'},), 14:32:39 INFO - 'run_cmd_checks_enabled': True, 14:32:39 INFO - 'sps_profile': False, 14:32:39 INFO - 'sps_profile_interval': 0, 14:32:39 INFO - 'suite': 'dromaeojs', 14:32:39 INFO - 'system_bits': '32', 14:32:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:32:39 INFO - 'title': 't-yosemite-r7-0103', 14:32:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:32:39 INFO - 'use_talos_json': True, 14:32:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:32:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:32:39 INFO - 'work_dir': 'build'} 14:32:39 INFO - ##### 14:32:39 INFO - ##### Running clobber step. 14:32:39 INFO - ##### 14:32:39 INFO - Running pre-action listener: _resource_record_pre_action 14:32:39 INFO - Running main action method: clobber 14:32:39 INFO - rmtree: /builds/slave/test/build 14:32:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:32:41 INFO - Running post-action listener: _resource_record_post_action 14:32:41 INFO - ##### 14:32:41 INFO - ##### Running read-buildbot-config step. 14:32:41 INFO - ##### 14:32:41 INFO - Running pre-action listener: _resource_record_pre_action 14:32:41 INFO - Running main action method: read_buildbot_config 14:32:41 INFO - Using buildbot properties: 14:32:41 INFO - { 14:32:41 INFO - "project": "", 14:32:41 INFO - "product": "firefox", 14:32:41 INFO - "script_repo_revision": "production", 14:32:41 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 14:32:41 INFO - "repository": "", 14:32:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 14:32:41 INFO - "buildid": "20160302130423", 14:32:41 INFO - "pgo_build": "False", 14:32:41 INFO - "basedir": "/builds/slave/test", 14:32:41 INFO - "buildnumber": 439, 14:32:41 INFO - "slavename": "t-yosemite-r7-0103", 14:32:41 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:32:41 INFO - "platform": "yosemite_r7", 14:32:41 INFO - "scheduler": "tests-fx-team-macosx64-talos", 14:32:41 INFO - "branch": "fx-team", 14:32:41 INFO - "repo_path": "integration/fx-team", 14:32:41 INFO - "revision": "d7ec3f281e341700a8b969518d4f6e72ea3a1621", 14:32:41 INFO - "stage_platform": "macosx64", 14:32:41 INFO - "builduid": "625f9ef9dd8a4746b8a6f5212d608eb1", 14:32:41 INFO - "slavebuilddir": "test" 14:32:41 INFO - } 14:32:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/HRiIyCHORruAyrI7g5r3fA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 14:32:41 INFO - Running post-action listener: _resource_record_post_action 14:32:41 INFO - ##### 14:32:41 INFO - ##### Running download-and-extract step. 14:32:41 INFO - ##### 14:32:41 INFO - Running pre-action listener: _resource_record_pre_action 14:32:41 INFO - Running main action method: download_and_extract 14:32:41 INFO - mkdir: /builds/slave/test/build/tests 14:32:41 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')]} 14:32:41 INFO - https://queue.taskcluster.net/v1/task/HRiIyCHORruAyrI7g5r3fA/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:32:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRiIyCHORruAyrI7g5r3fA/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 14:32:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRiIyCHORruAyrI7g5r3fA/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 14:32:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRiIyCHORruAyrI7g5r3fA/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 14:32:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRiIyCHORruAyrI7g5r3fA/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 14:32:41 INFO - Downloaded 1277 bytes. 14:32:41 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 14:32:41 INFO - Using the following test package requirements: 14:32:41 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:32:41 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:32:41 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 14:32:41 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:32:41 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 14:32:41 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:32:41 INFO - u'jsshell-mac.zip'], 14:32:41 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:32:41 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 14:32:41 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:32:41 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:32:41 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 14:32:41 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:32:41 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 14:32:41 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:32:41 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 14:32:41 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:32:41 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:32:41 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 14:32:41 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:32:41 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')]} 14:32:41 INFO - https://queue.taskcluster.net/v1/task/HRiIyCHORruAyrI7g5r3fA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:32:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRiIyCHORruAyrI7g5r3fA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:32:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRiIyCHORruAyrI7g5r3fA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:32:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRiIyCHORruAyrI7g5r3fA/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 14:32:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRiIyCHORruAyrI7g5r3fA/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 14:32:42 INFO - Downloaded 17854983 bytes. 14:32:42 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'] 14:32:42 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 14:32:45 INFO - Return code: 0 14:32:45 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 14:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:45 INFO - https://queue.taskcluster.net/v1/task/HRiIyCHORruAyrI7g5r3fA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:32:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRiIyCHORruAyrI7g5r3fA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:32:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRiIyCHORruAyrI7g5r3fA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:32:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRiIyCHORruAyrI7g5r3fA/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 14:32:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRiIyCHORruAyrI7g5r3fA/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 14:32:46 INFO - Downloaded 17854983 bytes. 14:32:46 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'] 14:32:46 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 14:32:50 INFO - Return code: 0 14:32: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')]} 14:32:50 INFO - https://queue.taskcluster.net/v1/task/HRiIyCHORruAyrI7g5r3fA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:32:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRiIyCHORruAyrI7g5r3fA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 14:32:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRiIyCHORruAyrI7g5r3fA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 14:32:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRiIyCHORruAyrI7g5r3fA/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 14:32:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRiIyCHORruAyrI7g5r3fA/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 14:32:51 INFO - Downloaded 10808263 bytes. 14:32:51 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'] 14:32:51 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 14:32:51 INFO - Return code: 0 14:32:51 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')]} 14:32:51 INFO - https://queue.taskcluster.net/v1/task/HRiIyCHORruAyrI7g5r3fA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:32:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRiIyCHORruAyrI7g5r3fA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:32:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRiIyCHORruAyrI7g5r3fA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:32:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRiIyCHORruAyrI7g5r3fA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 14:32:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRiIyCHORruAyrI7g5r3fA/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 14:32:55 INFO - Downloaded 110961980 bytes. 14:32:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HRiIyCHORruAyrI7g5r3fA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:32:55 INFO - mkdir: /builds/slave/test/properties 14:32:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:32:55 INFO - Writing to file /builds/slave/test/properties/build_url 14:32:55 INFO - Contents: 14:32:55 INFO - build_url:https://queue.taskcluster.net/v1/task/HRiIyCHORruAyrI7g5r3fA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:32:56 INFO - Running post-action listener: _resource_record_post_action 14:32:56 INFO - Running post-action listener: set_extra_try_arguments 14:32:56 INFO - ##### 14:32:56 INFO - ##### Running populate-webroot step. 14:32:56 INFO - ##### 14:32:56 INFO - Running pre-action listener: _resource_record_pre_action 14:32:56 INFO - Running main action method: populate_webroot 14:32:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:32:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:32:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:32:56 INFO - '--tppagecycles', 14:32:56 INFO - '7'], 14:32:56 INFO - 'tests': ['tsvgm']}}, 14:32:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:32:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:32:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:32:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:32:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:32:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:32:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:32:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:56 INFO - 'talos_options': ['--e10s'], 14:32:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:32:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:56 INFO - 'tests': ['damp', 'tps']}, 14:32:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:56 INFO - 'talos_options': ['--e10s'], 14:32:56 INFO - 'tests': ['damp', 'tps']}, 14:32:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:32:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:32:56 INFO - 'other': {'tests': ['a11yr', 14:32:56 INFO - 'ts_paint', 14:32:56 INFO - 'tpaint', 14:32:56 INFO - 'sessionrestore', 14:32:56 INFO - 'sessionrestore_no_auto_restore']}, 14:32:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:32:56 INFO - 'tests': ['a11yr', 14:32:56 INFO - 'ts_paint', 14:32:56 INFO - 'tpaint', 14:32:56 INFO - 'sessionrestore', 14:32:56 INFO - 'sessionrestore_no_auto_restore']}, 14:32:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:32:56 INFO - 'tests': ['a11yr', 14:32:56 INFO - 'ts_paint', 14:32:56 INFO - 'tpaint', 14:32:56 INFO - 'sessionrestore', 14:32:56 INFO - 'sessionrestore_no_auto_restore']}, 14:32:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:32:56 INFO - 'tests': ['a11yr', 14:32:56 INFO - 'ts_paint', 14:32:56 INFO - 'tpaint', 14:32:56 INFO - 'sessionrestore', 14:32:56 INFO - 'sessionrestore_no_auto_restore']}, 14:32:56 INFO - 'other_l64': {'tests': ['a11yr', 14:32:56 INFO - 'ts_paint', 14:32:56 INFO - 'tpaint', 14:32:56 INFO - 'sessionrestore', 14:32:56 INFO - 'sessionrestore_no_auto_restore']}, 14:32:56 INFO - 'other_nol64': {'tests': ['a11yr', 14:32:56 INFO - 'ts_paint', 14:32:56 INFO - 'tpaint', 14:32:56 INFO - 'sessionrestore', 14:32:56 INFO - 'sessionrestore_no_auto_restore']}, 14:32:56 INFO - 'svgr': {'tests': ['tsvgx', 14:32:56 INFO - 'tsvgr_opacity', 14:32:56 INFO - 'tart', 14:32:56 INFO - 'tscrollx', 14:32:56 INFO - 'cart']}, 14:32:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:32:56 INFO - 'tests': ['tsvgx', 14:32:56 INFO - 'tsvgr_opacity', 14:32:56 INFO - 'tart', 14:32:56 INFO - 'tscrollx', 14:32:56 INFO - 'cart']}, 14:32:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:56 INFO - 'tests': ['tp5o']}, 14:32:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:56 INFO - 'talos_options': ['--e10s'], 14:32:56 INFO - 'tests': ['tp5o']}, 14:32:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:56 INFO - 'talos_options': ['--xperf_path', 14:32:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:32:56 INFO - 'tests': ['tp5n']}, 14:32:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:56 INFO - 'talos_options': ['--e10s', 14:32:56 INFO - '--xperf_path', 14:32:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:32:56 INFO - 'tests': ['tp5n']}}, 14:32:56 INFO - 'talos.zip': {'path': '', 14:32:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:32:56 INFO - Running post-action listener: _resource_record_post_action 14:32:56 INFO - ##### 14:32:56 INFO - ##### Running create-virtualenv step. 14:32:56 INFO - ##### 14:32:56 INFO - Running pre-action listener: _resource_record_pre_action 14:32:56 INFO - Running main action method: create_virtualenv 14:32:56 INFO - Creating virtualenv /builds/slave/test/build/venv 14:32:56 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 14:32:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:32:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:32:57 INFO - Using real prefix '/tools/python27' 14:32:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:32:57 INFO - Installing distribute.............................................................................................................................................................................................done. 14:33:00 INFO - Installing pip.................done. 14:33:00 INFO - Return code: 0 14:33:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103453a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3bad6be40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f7d30>, '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 0x10311bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032eeb20>, '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.BdQ1sY54uZ/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.XVvohzFcXl/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 14:33:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:33:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BdQ1sY54uZ/Render', 14:33:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:00 INFO - 'HOME': '/Users/cltbld', 14:33:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:00 INFO - 'LOGNAME': 'cltbld', 14:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:00 INFO - 'MOZ_NO_REMOTE': '1', 14:33:00 INFO - 'NO_EM_RESTART': '1', 14:33:00 INFO - 'PAGER': '/bin/cat', 14:33:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:00 INFO - 'PWD': '/builds/slave/test', 14:33:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:00 INFO - 'SHELL': '/bin/bash', 14:33:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVvohzFcXl/Listeners', 14:33:00 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 14:33:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:00 INFO - 'USER': 'cltbld', 14:33:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:00 INFO - 'XPC_FLAGS': '0x0', 14:33:00 INFO - 'XPC_SERVICE_NAME': '0', 14:33:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:00 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 14:33:00 INFO - Cleaning up... 14:33:00 INFO - Return code: 0 14:33:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103453a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3bad6be40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f7d30>, '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 0x10311bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032eeb20>, '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.BdQ1sY54uZ/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.XVvohzFcXl/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 14:33:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:33:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BdQ1sY54uZ/Render', 14:33:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:00 INFO - 'HOME': '/Users/cltbld', 14:33:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:00 INFO - 'LOGNAME': 'cltbld', 14:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:00 INFO - 'MOZ_NO_REMOTE': '1', 14:33:00 INFO - 'NO_EM_RESTART': '1', 14:33:00 INFO - 'PAGER': '/bin/cat', 14:33:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:00 INFO - 'PWD': '/builds/slave/test', 14:33:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:00 INFO - 'SHELL': '/bin/bash', 14:33:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVvohzFcXl/Listeners', 14:33:00 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 14:33:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:00 INFO - 'USER': 'cltbld', 14:33:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:00 INFO - 'XPC_FLAGS': '0x0', 14:33:00 INFO - 'XPC_SERVICE_NAME': '0', 14:33:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:01 INFO - Downloading/unpacking psutil>=0.7.1 14:33:01 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 14:33:01 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 14:33:01 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 14:33:01 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 14:33:01 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 14:33:01 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 14:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:33:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:33:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:33:03 INFO - Installing collected packages: psutil 14:33:03 INFO - Running setup.py install for psutil 14:33:04 INFO - building 'psutil._psutil_osx' extension 14:33:04 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 14:33:04 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 14:33:04 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 14:33:04 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 14:33:04 INFO - building 'psutil._psutil_posix' extension 14:33:04 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 14:33:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:33:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:33:05 INFO - ^ 14:33:05 INFO - 1 warning generated. 14:33:05 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:33:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:33:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:33:05 INFO - Successfully installed psutil 14:33:05 INFO - Cleaning up... 14:33:05 INFO - Return code: 0 14:33:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:33: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')]} 14:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33: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')]} 14:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:05 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 0x103453a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3bad6be40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f7d30>, '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 0x10311bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032eeb20>, '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.BdQ1sY54uZ/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.XVvohzFcXl/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 14:33:05 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 14:33:05 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 14:33:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BdQ1sY54uZ/Render', 14:33:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:05 INFO - 'HOME': '/Users/cltbld', 14:33:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:05 INFO - 'LOGNAME': 'cltbld', 14:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:05 INFO - 'MOZ_NO_REMOTE': '1', 14:33:05 INFO - 'NO_EM_RESTART': '1', 14:33:05 INFO - 'PAGER': '/bin/cat', 14:33:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:05 INFO - 'PWD': '/builds/slave/test', 14:33:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:05 INFO - 'SHELL': '/bin/bash', 14:33:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVvohzFcXl/Listeners', 14:33:05 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 14:33:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:05 INFO - 'USER': 'cltbld', 14:33:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:05 INFO - 'XPC_FLAGS': '0x0', 14:33:05 INFO - 'XPC_SERVICE_NAME': '0', 14:33:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:33:07 INFO - Installing collected packages: mozsystemmonitor 14:33:07 INFO - Running setup.py install for mozsystemmonitor 14:33:08 INFO - Successfully installed mozsystemmonitor 14:33:08 INFO - Cleaning up... 14:33:08 INFO - Return code: 0 14:33:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:33:08 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')]} 14:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:08 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')]} 14:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:08 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 0x103453a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3bad6be40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f7d30>, '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 0x10311bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032eeb20>, '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.BdQ1sY54uZ/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.XVvohzFcXl/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 14:33:08 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 14:33:08 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 14:33:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BdQ1sY54uZ/Render', 14:33:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:08 INFO - 'HOME': '/Users/cltbld', 14:33:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:08 INFO - 'LOGNAME': 'cltbld', 14:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:08 INFO - 'MOZ_NO_REMOTE': '1', 14:33:08 INFO - 'NO_EM_RESTART': '1', 14:33:08 INFO - 'PAGER': '/bin/cat', 14:33:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:08 INFO - 'PWD': '/builds/slave/test', 14:33:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:08 INFO - 'SHELL': '/bin/bash', 14:33:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVvohzFcXl/Listeners', 14:33:08 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 14:33:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:08 INFO - 'USER': 'cltbld', 14:33:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:08 INFO - 'XPC_FLAGS': '0x0', 14:33:08 INFO - 'XPC_SERVICE_NAME': '0', 14:33:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:08 INFO - Downloading/unpacking blobuploader==1.2.4 14:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:10 INFO - Downloading blobuploader-1.2.4.tar.gz 14:33:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:33:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:33:10 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 14:33:10 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 14:33:10 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 14:33:10 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 14:33:10 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 14:33:10 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 14:33:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:33:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:11 INFO - Downloading docopt-0.6.1.tar.gz 14:33:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:33:11 INFO - Installing collected packages: blobuploader, requests, docopt 14:33:11 INFO - Running setup.py install for blobuploader 14:33:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:33:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:33:12 INFO - Running setup.py install for requests 14:33:12 INFO - Running setup.py install for docopt 14:33:12 INFO - Successfully installed blobuploader requests docopt 14:33:12 INFO - Cleaning up... 14:33:12 INFO - Return code: 0 14:33:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:33: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')]} 14:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33: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')]} 14:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:12 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 0x103453a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3bad6be40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f7d30>, '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 0x10311bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032eeb20>, '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.BdQ1sY54uZ/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.XVvohzFcXl/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 14:33:12 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 14:33:12 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 14:33:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BdQ1sY54uZ/Render', 14:33:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:12 INFO - 'HOME': '/Users/cltbld', 14:33:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:12 INFO - 'LOGNAME': 'cltbld', 14:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:12 INFO - 'MOZ_NO_REMOTE': '1', 14:33:12 INFO - 'NO_EM_RESTART': '1', 14:33:12 INFO - 'PAGER': '/bin/cat', 14:33:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:12 INFO - 'PWD': '/builds/slave/test', 14:33:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:12 INFO - 'SHELL': '/bin/bash', 14:33:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVvohzFcXl/Listeners', 14:33:12 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 14:33:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:12 INFO - 'USER': 'cltbld', 14:33:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:12 INFO - 'XPC_FLAGS': '0x0', 14:33:12 INFO - 'XPC_SERVICE_NAME': '0', 14:33:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:33:13 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-6towaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:33:13 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-NKl2xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:33:13 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-dhU7Md-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:33:13 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-WDHpQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:33:13 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-VdwRtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:33:13 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-NZWYFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:33:13 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-PqVkcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:33:13 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-_bUnEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:33:13 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Jl_MbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:33:14 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-YIFZzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:33:14 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-HJkCWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:33:14 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-cPr_VO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:33:14 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-NtKGc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:33:14 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-pc_4gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:33:14 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-kVScw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:33:14 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-UT7oSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:33:14 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-r2QRnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:33:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:33:14 INFO - Running setup.py install for manifestparser 14:33:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:33:15 INFO - Running setup.py install for mozcrash 14:33:15 INFO - Running setup.py install for mozdebug 14:33:15 INFO - Running setup.py install for mozdevice 14:33:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:33:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:33:15 INFO - Running setup.py install for mozfile 14:33:15 INFO - Running setup.py install for mozhttpd 14:33:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:33:15 INFO - Running setup.py install for mozinfo 14:33:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:33:15 INFO - Running setup.py install for mozInstall 14:33:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:33:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:33:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:33:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:33:16 INFO - Running setup.py install for mozleak 14:33:16 INFO - Running setup.py install for mozlog 14:33:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:33:16 INFO - Running setup.py install for moznetwork 14:33:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:33:16 INFO - Running setup.py install for mozprocess 14:33:16 INFO - Running setup.py install for mozprofile 14:33:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:33:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:33:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:33:16 INFO - Running setup.py install for mozrunner 14:33:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:33:16 INFO - Running setup.py install for mozscreenshot 14:33:17 INFO - Running setup.py install for moztest 14:33:17 INFO - Running setup.py install for mozversion 14:33:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:33:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:33:17 INFO - Cleaning up... 14:33:17 INFO - Return code: 0 14:33:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:17 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 0x103453a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3bad6be40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f7d30>, '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 0x10311bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032eeb20>, '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.BdQ1sY54uZ/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.XVvohzFcXl/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 14:33:17 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 14:33:17 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 14:33:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BdQ1sY54uZ/Render', 14:33:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:17 INFO - 'HOME': '/Users/cltbld', 14:33:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:17 INFO - 'LOGNAME': 'cltbld', 14:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:17 INFO - 'MOZ_NO_REMOTE': '1', 14:33:17 INFO - 'NO_EM_RESTART': '1', 14:33:17 INFO - 'PAGER': '/bin/cat', 14:33:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:17 INFO - 'PWD': '/builds/slave/test', 14:33:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:17 INFO - 'SHELL': '/bin/bash', 14:33:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVvohzFcXl/Listeners', 14:33:17 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 14:33:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:17 INFO - 'USER': 'cltbld', 14:33:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:17 INFO - 'XPC_FLAGS': '0x0', 14:33:17 INFO - 'XPC_SERVICE_NAME': '0', 14:33:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:33:17 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-_cAXAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:33:17 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)) 14:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:33:17 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Z48ji9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:33:17 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)) 14:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:33:17 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-PgVmq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:33:18 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-bS6F4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:33:18 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)) 14:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:33:18 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-atwz4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:33:18 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)) 14:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:33:18 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-jHvgSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:33:18 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)) 14:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:33:18 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-ULSx7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:33:18 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)) 14:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:33:18 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-pOcoHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:33:18 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)) 14:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:33:18 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-O8OOSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:33:18 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)) 14:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:33:18 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-3isgdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:33:18 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)) 14:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:33:18 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-EzdymP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:33:18 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)) 14:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:33:18 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-wF7nMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:33:19 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-7vmKlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:33:19 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)) 14:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:33:19 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-ASr9lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:33:19 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)) 14:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:33:19 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-fVcjUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:33:19 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)) 14:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:33:19 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-mFrR4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:33:19 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)) 14:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:33:19 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-pujQwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:33:19 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)) 14:33:19 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)) 14:33:19 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)) 14:33:19 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)) 14:33:19 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)) 14:33:19 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)) 14:33:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:33:19 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 14:33:19 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 14:33:19 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 14:33:19 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 14:33:19 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 14:33:19 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 14:33:21 INFO - Downloading blessings-1.6.tar.gz 14:33:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:33:21 INFO - Installing collected packages: blessings 14:33:21 INFO - Running setup.py install for blessings 14:33:22 INFO - Successfully installed blessings 14:33:22 INFO - Cleaning up... 14:33:22 INFO - Return code: 0 14:33:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:33:22 INFO - Reading from file tmpfile_stdout 14:33:22 INFO - Current package versions: 14:33:22 INFO - blessings == 1.6 14:33:22 INFO - blobuploader == 1.2.4 14:33:22 INFO - docopt == 0.6.1 14:33:22 INFO - manifestparser == 1.1 14:33:22 INFO - mozInstall == 1.12 14:33:22 INFO - mozcrash == 0.16 14:33:22 INFO - mozdebug == 0.1 14:33:22 INFO - mozdevice == 0.48 14:33:22 INFO - mozfile == 1.2 14:33:22 INFO - mozhttpd == 0.7 14:33:22 INFO - mozinfo == 0.9 14:33:22 INFO - mozleak == 0.1 14:33:22 INFO - mozlog == 3.1 14:33:22 INFO - moznetwork == 0.27 14:33:22 INFO - mozprocess == 0.22 14:33:22 INFO - mozprofile == 0.28 14:33:22 INFO - mozrunner == 6.11 14:33:22 INFO - mozscreenshot == 0.1 14:33:22 INFO - mozsystemmonitor == 0.0 14:33:22 INFO - moztest == 0.7 14:33:22 INFO - mozversion == 1.4 14:33:22 INFO - psutil == 3.1.1 14:33:22 INFO - requests == 1.2.3 14:33:22 INFO - wsgiref == 0.1.2 14:33:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:33: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')]} 14:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33: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')]} 14:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:22 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 0x103453a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3bad6be40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f7d30>, '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 0x10311bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032eeb20>, '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.BdQ1sY54uZ/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.XVvohzFcXl/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 14:33:22 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 14:33:22 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 14:33:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BdQ1sY54uZ/Render', 14:33:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:22 INFO - 'HOME': '/Users/cltbld', 14:33:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:22 INFO - 'LOGNAME': 'cltbld', 14:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:22 INFO - 'MOZ_NO_REMOTE': '1', 14:33:22 INFO - 'NO_EM_RESTART': '1', 14:33:22 INFO - 'PAGER': '/bin/cat', 14:33:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:22 INFO - 'PWD': '/builds/slave/test', 14:33:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:22 INFO - 'SHELL': '/bin/bash', 14:33:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVvohzFcXl/Listeners', 14:33:22 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 14:33:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:22 INFO - 'USER': 'cltbld', 14:33:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:22 INFO - 'XPC_FLAGS': '0x0', 14:33:22 INFO - 'XPC_SERVICE_NAME': '0', 14:33:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:22 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)) 14:33:22 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)) 14:33:22 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)) 14:33:22 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)) 14:33:22 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)) 14:33:22 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)) 14:33:22 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)) 14:33:22 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)) 14:33:22 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)) 14:33:22 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)) 14:33:22 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)) 14:33:22 INFO - Cleaning up... 14:33:22 INFO - Return code: 0 14:33:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:33: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')]} 14:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33: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')]} 14:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103453a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3bad6be40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f7d30>, '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 0x10311bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032eeb20>, '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.BdQ1sY54uZ/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.XVvohzFcXl/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 14:33: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', 'jsonschema'] in /builds/slave/test/build 14:33: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 jsonschema 14:33:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BdQ1sY54uZ/Render', 14:33:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:22 INFO - 'HOME': '/Users/cltbld', 14:33:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:22 INFO - 'LOGNAME': 'cltbld', 14:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:22 INFO - 'MOZ_NO_REMOTE': '1', 14:33:22 INFO - 'NO_EM_RESTART': '1', 14:33:22 INFO - 'PAGER': '/bin/cat', 14:33:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:22 INFO - 'PWD': '/builds/slave/test', 14:33:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:22 INFO - 'SHELL': '/bin/bash', 14:33:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVvohzFcXl/Listeners', 14:33:22 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 14:33:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:22 INFO - 'USER': 'cltbld', 14:33:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:22 INFO - 'XPC_FLAGS': '0x0', 14:33:22 INFO - 'XPC_SERVICE_NAME': '0', 14:33:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:23 INFO - Downloading/unpacking jsonschema 14:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:33:25 INFO - Downloading/unpacking functools32 (from jsonschema) 14:33:25 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 14:33:25 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 14:33:25 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 14:33:25 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 14:33:25 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 14:33:25 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 14:33:25 INFO - Downloading functools32-3.2.3-2.tar.gz 14:33:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:33:25 INFO - warning: no files found matching '*.txt' 14:33:25 INFO - no previously-included directories found matching 'build' 14:33:25 INFO - no previously-included directories found matching 'dist' 14:33:25 INFO - no previously-included directories found matching '.git*' 14:33:25 INFO - Installing collected packages: jsonschema, functools32 14:33:26 INFO - Running setup.py install for functools32 14:33:26 INFO - warning: no files found matching '*.txt' 14:33:26 INFO - no previously-included directories found matching 'build' 14:33:26 INFO - no previously-included directories found matching 'dist' 14:33:26 INFO - no previously-included directories found matching '.git*' 14:33:26 INFO - Successfully installed jsonschema functools32 14:33:26 INFO - Cleaning up... 14:33:26 INFO - Return code: 0 14:33:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:33: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')]} 14:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33: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')]} 14:33:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103453a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3bad6be40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f7d30>, '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 0x10311bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032eeb20>, '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.BdQ1sY54uZ/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.XVvohzFcXl/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 14:33: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', 'flake8'] in /builds/slave/test/build 14:33: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 flake8 14:33:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BdQ1sY54uZ/Render', 14:33:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:26 INFO - 'HOME': '/Users/cltbld', 14:33:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:26 INFO - 'LOGNAME': 'cltbld', 14:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:26 INFO - 'MOZ_NO_REMOTE': '1', 14:33:26 INFO - 'NO_EM_RESTART': '1', 14:33:26 INFO - 'PAGER': '/bin/cat', 14:33:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:26 INFO - 'PWD': '/builds/slave/test', 14:33:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:26 INFO - 'SHELL': '/bin/bash', 14:33:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVvohzFcXl/Listeners', 14:33:26 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 14:33:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:26 INFO - 'USER': 'cltbld', 14:33:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:26 INFO - 'XPC_FLAGS': '0x0', 14:33:26 INFO - 'XPC_SERVICE_NAME': '0', 14:33:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:26 INFO - Downloading/unpacking flake8 14:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:33:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:33:28 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 14:33:28 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 14:33:28 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 14:33:28 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 14:33:28 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 14:33:28 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 14:33:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:33:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:33: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 14:33: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 14:33: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 14:33: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 14:33: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 14:33: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 14:33:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:33: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 14:33: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 14:33: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 14:33: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 14:33: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 14:33: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 14:33:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:33:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:33:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:33:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:33:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:33:30 INFO - no previously-included directories found matching 'docs/_build' 14:33:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:33:30 INFO - Running setup.py install for pep8 14:33:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:33:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:33:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:33:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:33:30 INFO - no previously-included directories found matching 'docs/_build' 14:33:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:33:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:33:30 INFO - Cleaning up... 14:33:30 INFO - Return code: 0 14:33:30 INFO - Running post-action listener: _resource_record_post_action 14:33:30 INFO - Running post-action listener: _start_resource_monitoring 14:33:30 INFO - Starting resource monitoring. 14:33:30 INFO - ##### 14:33:30 INFO - ##### Running install step. 14:33:30 INFO - ##### 14:33:30 INFO - Running pre-action listener: _resource_record_pre_action 14:33:30 INFO - Running main action method: install 14:33:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:33:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:33:30 INFO - Reading from file tmpfile_stdout 14:33:30 INFO - Detecting whether we're running mozinstall >=1.0... 14:33:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:33:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:33:30 INFO - Reading from file tmpfile_stdout 14:33:30 INFO - Output received: 14:33:30 INFO - Usage: mozinstall [options] installer 14:33:30 INFO - Options: 14:33:30 INFO - -h, --help show this help message and exit 14:33:30 INFO - -d DEST, --destination=DEST 14:33:30 INFO - Directory to install application into. [default: 14:33:30 INFO - "/builds/slave/test"] 14:33:30 INFO - --app=APP Application being installed. [default: firefox] 14:33:30 INFO - mkdir: /builds/slave/test/build/application 14:33:30 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'] 14:33:30 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 14:34:04 INFO - Reading from file tmpfile_stdout 14:34:04 INFO - Output received: 14:34:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:34:04 INFO - Running post-action listener: _resource_record_post_action 14:34:04 INFO - ##### 14:34:04 INFO - ##### Running run-tests step. 14:34:04 INFO - ##### 14:34:04 INFO - Running pre-action listener: _resource_record_pre_action 14:34:04 INFO - Running main action method: run_tests 14:34:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:34:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:34:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:34:04 INFO - 2016-03-02 14:34:04.582 screenresolution[1645:7505] starting screenresolution argv=screenresolution get 14:34:04 INFO - 2016-03-02 14:34:04.585 screenresolution[1645:7505] Display 0: 1600x1200x32@60 14:34:04 INFO - 2016-03-02 14:34:04.590 screenresolution[1646:7507] starting screenresolution argv=screenresolution list 14:34:04 INFO - Available Modes on Display 0 14:34:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:34:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:34:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:34:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:34:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:34:04 INFO - Intel Iris: 14:34:04 INFO - Chipset Model: Intel Iris 14:34:04 INFO - Type: GPU 14:34:04 INFO - Bus: Built-In 14:34:04 INFO - VRAM (Dynamic, Max): 1536 MB 14:34:04 INFO - Vendor: Intel (0x8086) 14:34:04 INFO - Device ID: 0x0a2e 14:34:04 INFO - Revision ID: 0x0009 14:34:04 INFO - Displays: 14:34:04 INFO - Display: 14:34:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:34:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:34:04 INFO - Display Serial Number: 1600x1200 60 14:34:04 INFO - Main Display: Yes 14:34:04 INFO - Mirror: Off 14:34:04 INFO - Online: Yes 14:34:04 INFO - Rotation: Supported 14:34:04 INFO - Return code: 0 14:34:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:34:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:34:04 INFO - Python 2.7.3 14:34:04 INFO - Return code: 0 14:34:04 INFO - grabbing minidump binary from tooltool 14:34:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:04 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 0x1032f7d30>, '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 0x10311bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032eeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:34:04 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 14:34:04 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 14:34:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:34:04 INFO - Return code: 0 14:34:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:34:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:34:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:34:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:34:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:34:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:34:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:34:06 INFO - Return code: 0 14:34:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HRiIyCHORruAyrI7g5r3fA/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 14:34:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HRiIyCHORruAyrI7g5r3fA/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 14:34:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BdQ1sY54uZ/Render', 14:34:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:06 INFO - 'HOME': '/Users/cltbld', 14:34:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:06 INFO - 'LOGNAME': 'cltbld', 14:34:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:34:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:06 INFO - 'MOZ_NO_REMOTE': '1', 14:34:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:34:06 INFO - 'NO_EM_RESTART': '1', 14:34:06 INFO - 'PAGER': '/bin/cat', 14:34:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:06 INFO - 'PWD': '/builds/slave/test', 14:34:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:34:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:06 INFO - 'SHELL': '/bin/bash', 14:34:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVvohzFcXl/Listeners', 14:34:06 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 14:34:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:06 INFO - 'USER': 'cltbld', 14:34:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:06 INFO - 'XPC_FLAGS': '0x0', 14:34:06 INFO - 'XPC_SERVICE_NAME': '0', 14:34:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HRiIyCHORruAyrI7g5r3fA/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 14:34:06 INFO - mozversion application_buildid: 20160302130423 14:34:06 INFO - mozversion application_changeset: d7ec3f281e341700a8b969518d4f6e72ea3a1621 14:34:06 INFO - mozversion application_display_name: Nightly 14:34:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:34:06 INFO - mozversion application_name: Firefox 14:34:06 INFO - mozversion application_remotingname: firefox 14:34:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:34:06 INFO - mozversion application_vendor: Mozilla 14:34:06 INFO - mozversion application_version: 47.0a1 14:34:06 INFO - mozversion platform_buildid: 20160302130423 14:34:06 INFO - mozversion platform_changeset: d7ec3f281e341700a8b969518d4f6e72ea3a1621 14:34:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:34:06 INFO - mozversion platform_version: 47.0a1 14:34:06 INFO - using testdate: 1456958046 14:34:06 INFO - actual date: 1456958046 14:34:06 INFO - starting webserver on 'localhost:49279' 14:34:06 INFO - SUITE-START | Running 2 tests 14:34:06 INFO - TEST-START | dromaeo_css 14:34:06 INFO - operating with platform_type : mac_ 14:34:06 INFO - Initialising browser for dromaeo_css test... 14:34:06 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpie3Xga/profile http://localhost:49279/getInfo.html) 14:34:09 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 14:34:09 INFO - PROCESS | 1664 | colorDepth:24 14:34:09 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 14:34:09 INFO - PROCESS | 1664 | __metrics 14:34:09 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:34:09 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:34:09 INFO - TEST-INFO | 1664: exit 0 14:34:09 INFO - Browser initialized. 14:34:09 INFO - Running cycle 1/1 for dromaeo_css test... 14:34:09 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpie3Xga/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:34:21 INFO - PROCESS | 1667 | RSS: Main: 242794496 14:34:21 INFO - PROCESS | 1667 | 14:35:12 INFO - PROCESS | 1667 | 1456958112807 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] 14:37:23 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 14:37:24 INFO - PROCESS | 1667 | RSS: Main: 343707648 14:37:24 INFO - PROCESS | 1667 | 14:40:26 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 14:40:27 INFO - PROCESS | 1667 | RSS: Main: 370647040 14:40:27 INFO - PROCESS | 1667 | 14:43:29 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 14:43:29 INFO - PROCESS | 1667 | RSS: Main: 373161984 14:43:29 INFO - PROCESS | 1667 | 14:46:31 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 14:46:32 INFO - PROCESS | 1667 | RSS: Main: 334315520 14:46:32 INFO - PROCESS | 1667 | 14:49:35 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 14:49:35 INFO - PROCESS | 1667 | RSS: Main: 332410880 14:49:35 INFO - PROCESS | 1667 | 14:52:38 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 14:52:39 INFO - PROCESS | 1667 | RSS: Main: 403972096 14:52:39 INFO - PROCESS | 1667 | 14:52:39 INFO - PROCESS | 1667 | __start_tp_report 14:52:39 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 14:52:39 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 14:52:39 INFO - PROCESS | 1667 | |i|pagename|runs| 14:52:39 INFO - PROCESS | 1667 | |0;dojo.html;3338.0987133473964;3428.6057103433113;3443.2596991646797;3449.4480883058714;3506.807125608092;5470.905818836239;5550.472705093015;5568.220449137124;5586.944130558693;5594.692291923948;5519.613627046108;5551.8889622207535;5603.971980140093;5612.045952188128;5617.550595952324;5043.773030213631;5092.567131793783;5098.464661210575;5101.770420331094;5166.095933211692;5173.224016397533;5177.223416487538;5184.974075129638;5185.196294574347;5196.76614552346;5055.646104772667;5093.516115968995;5099.923501147486;5111.258867464216;5146.176611742122;5117.2068329409;5171;5177.663451875616;5197.714125723083;5225.6603320784025;4943.456219815817;5010.824621138243;5043.470435604282;5084.669496482717;5145.691258524501;5107.61692873036;5463.934532766112;5476.096444086721;5501.889962200774;5545.029619816516;5352.625316227865;6118.326984031797;6141.170941922828;6145.539084568675;6172.475339596095;6043.129761520691;6059.969700151515;6215.067739839015;6226.968865155645;6233.781817636361;4752.6910750801435;5666.093425052013;5684.261046063985;5685.545156387479;5687.630304030225;6252.124702541648;6298.464630506458;6301.842453938597;6317.5893566918;6335.429811316912;5825.155352473952;5956.940430595725;6022.682053322739;6030.30651475086;6051.425114614105;6123;6134.815955521252;6140.846478838065;6144.477719393902;6149.200603921461;6068.241469816273;6107.938920610826;6111.908321375183;6128.387161283836;6147.938520614736;6001.279846418458;6034.306054803666;6098.14625952367;6112.358202388774;6134.478569321657;3952.8931899067734;4819.95180048202;4825.758712064383;4848.927266091011;4852.927206091911;4220.155968806251;4300.677449191323;4324.805383757738;4335.674824388184;4363.52001279859;5527.806526771544;5534.806281780199;5537.335519737658;5549.223108764776;5607.943920560742;6084.574079814371;6135.355787642323;6170.167027451326;6189.442950134419;6199.783007594712;5427.0773968425465;5498.230247765316;5543.805966791143;5560.249366335493;5565.332160140809;5275.4460781618145;5290.761915713802;5295.629305948547;5300.681959082467;5314.016906872241;6226.315105338409;6277.183966084471;6289.339619339903;6293.465055470245;6309.905351419824;4959.355283813081;6097.76666567467;6114.877702445837;6127.172831667668;6133.478654314434;6222.346653601307;6259.436650701458;6304.779332723333;6309.085182648582;6320.5575609706875;6052.364501727256;6073.423024812636;6074.058520929263;6078.331383547895;6078.635281883101;6060.454559089703;6106.297775755845;6148.4773794227995;6184.412480814315;6208.72060757258;5947.256592925884;6001.279846418283;6003.729832157476;6021.036634138517;6055.031195008954;5957.970210148921;5967.6419414835245;5967.850803729942;5971.611845230046;5984.700764961647;4838.274258861199;5715.714214289352;5749.568782341257;5773.913391299218;5835.299764028344;5208.661437006583;5774.48029677331;5933.436323549428;5996;6021.578489505692;5783.190353350618;5872.941270587239;5874.206982057368;5874.236349274567;5875.471207591338 14:52:39 INFO - PROCESS | 1667 | |1;ext.html;505.79768092762913;521.5749164430986;594.5243804956034;633.5660072850096;639.651389992454;39222.41166382506;39565.80217098918;39642.40536391949;39681.40477892827;39880.40179397308;41878.790606047005;42493.93765155865;42497.78751106248;42510.93722656935;42924.35613465793;9472.952635236832;9716.95141524295;9717.562709678046;9732.367396119265;9741.756456088619;9510.857337139949;9674.177694895941;9686.46724430156;9791.804163916717;9801.852972205423;9726.416415015086;9795.706128816148;9803.166730827888;9804.068613481708;9822.607095716163;9748.75628109296;9802.117809397118;9804.31369804114;9805.264605154607;9809.362391444532;8211.384146189;9740.4642744649;9762.023797620252;9776.951115244377;9778.315517913748;40598.59401406007;41086.794566026976;41182.794086029375;41191;41427;2973.6431628204755;2975.7321841034195;3183.1246407237963;3231.806091634486;3395.2021275000357;28613.713862861314;29118.157233050217;29424.411511769646;29716.55425168624;30490.237744056354;2752.2431331384028;2775.736305051037;2788.470190663788;2793.427347393779;2853.8287702737903;473304;473681;474648;475975;476380;64815;65128;65377.34622653808;65453;65714.67142664256;69798.65100674464;71703.2829671707;73247.26752732405;73254;73387.63306183435;16313.184340782913;16365.672686546202;16447.424340148038;16479.752803707954;16490.917545412438;12735;12807.487700492062;12817.423215955305;12822.80765788514;12824.743505129845;21159.68260476094;21571.13715451396;21950.707393891043;21954.34136975893;22018.009189586508;8523.531205783618;8554.957225213833;8986.281097512183;9240.260779137652;9263.907360926305;816.3632366753941;947.230024502484;959.9040095990345;1006.8993100689872;1065.2969040433277;29316.82732690711;29422.85288573586;29980;30094.84952575267;30881;1026.7997740440692;1046.0951277145366;1060.4326685223368;1145.3185354713933;1146.6044214746066;14822.629434264014;14946.40214391434;15074.397024118913;15128.943258979165;15186.356280343583;487465;514643;516520;517235;521177;59155.11267330994;59309.11036334458;59567.70216148978;59584.40415595875;59648;1300.219868079145;1409.3094383751888;1421.9075760075768;1439.438618938594;1449.8550144985627;29600.555991660574;29628.40743185081;29919.252018699706;30422.847885760428;30673.53989690112;49414.75292623514;49847;49916.25125623191;49960.75019624879;50002.74998624984;291043;291672;291709;291739;291983;32574.837125814218;34105.65894341124;34155.65844341525;34165;34195.82902085573;36975.81512092422;44938.55061449474;45684.62946111622;46057.539424605326;46725;37589.624103758615;37644.62355376411;37719;38364.84905452841;38887;36094;36783.81608092049;37517.87446376613;37718;37761.62238377581;30530.542041869834;36500.63499365078;36943.630563694016;37976;38053.23893522169;32149;32474.60738730439;32786;32954;32958;23825;25045.87477062603;25200.243992680247;25211.74788252094;25318.24045278571 14:52:39 INFO - PROCESS | 1667 | |2;jquery.html;301.8385163937294;307.2165976759265;310.17493467376767;350.98771542996;352.57162547504777;18323.54191145222;19699.803001969995;20173.184413402792;20204.090815913318;20324.39026829194;19267.614647707036;19298.324558640452;20192.8990355048;20212.898935505338;20219.494512637193;5159.277701121855;5433.565314774828;5436.755346009439;5445.047116754572;5448.318960129984;5291.074062039128;5392.272043274147;5392.406835248139;5394.1908713692865;5396.379416367129;5371.973140134294;5809.651420914737;5886.911696324559;6010.489108425767;6017.939820601781;5896.469317761401;5974.61165024272;5986.281646202462;6007.7596896124105;6053.848653783691;5136.922946155811;5224.059669259532;5314.495122963351;5315.0432922074015;5317.707526086064;9993.80012399748;13824.654383640389;13863.098898571561;17457.65084698299;25011.24966250997;2030.8375329973567;2109.641360968639;2114.12263910477;2348.954715151741;2476.418041760185;9850.556724947322;9857.802843943153;10058.647947321808;10143.391396516232;10239.795204095877;1680.9747853782203;1692.9492115236562;1747.7028905086165;1768.3368736723728;1821.954451138719;86047;103747.00299205532;105283.94716052819;111342;114317;10305.227107966783;10654.254202205771;11104.944475277573;11243.437828108561;11413.942930285462;13089.345532723517;13416.597502074954;13576;13589.45642174302;13600.455981760619;7062.611556364346;8437.198466145706;8510.446820956618;8609.311255099577;8612.827743445221;8657.783555411164;8681.30549556034;8732.607032683545;8823.205911467998;8824.735257942271;4369.104333611665;4460.821567137278;4494.056248187851;4497.572730590588;4548.7725613719185;1508.8264849542225;1860.9534761630796;1889.4992826900882;1901.2775145444919;1903.2672421117693;863.6761214544546;867.4491697771834;893.7318804358666;908.5820522559696;996.8255555277798;19453.221871124995;20043.09806058731;20089.799102009085;20142.295019674242;20304.89847550753;912.3567884641312;918.7519369770125;919.0350132360994;933.7852293972425;938.9389689670286;10360.844587331196;10748.677539673823;10755.247132700792;10809.135269178447;10819.404932728617;559268;561273;580583.1941680614;626144.0849570243;633448;116990.41504792421;117374;121088;121678.17482737766;123294.38352808179;876.9564218579997;1003.0771690045176;1012.2863381316155;1017.29298137795;1025.7179275699093;17639;17721.202545885724;17767.644647107245;18324.72512912334;18471.90764046171;52143.47856521386;52652.94694106173;52859;53951;55722;75414.24585754072;75845.62077189579;77194.45611087634;77471.61264193643;78689.60655196688;7859.882101768592;7940.404469664913;8109.8378032440205;8136.87794683092;8352.290055345364;10886.98699640125;11611.838816118321;12842.743145137232;12967.870321297043;13217.405216765077;10589.788204236027;11403.657890263305;11418.942905285752;11481.196316257781;11670.241434307083;10924;11032.558697652004;11170.553177872795;11357.716057098309;11387.259828111146;11316.717082073013;11474.942625287154;11594.768104637691;11671.183017188716;11869.821952670889;7974.043114826258;7975.521468711896;8174.059983101782;8191.098979112412;8419.410641255054;10089.697309080739;10377.896221037994;10843.349399036084;11749.706257343634;11779.352135632622 14:52:39 INFO - PROCESS | 1667 | |3;mootools.html;1402.57221547428;1428.357239242341;1505.2849896299253;1547.7987861577997;1941.941741747747;7817.179196184404;8436.240738333556;8587.656493740244;8594.269487093588;8621.267192288664;8307.127751586087;8546.91453085469;8559.914400856005;8564.571771411436;8584.313254939605;2409.927702168929;2439.4145405102736;2441.182203961675;2441.9389515262174;2444.8899799509063;2332.696749422573;2363.657269695893;2393.6050551658955;2396.269137912936;2403.399150212447;2447.253587655773;2451.7915977141874;2457.1400009996537;2490.86300253486;2493.9127130550432;2423.1155628195756;2445.5231229910173;2448.8775561222046;2449.301948944551;2456.680631517909;2424.3333083402204;2442.438239204993;2452.7424620414777;2456.8894399752053;2460.852348859074;8598.484090954562;8637.136286371375;8640.827183456358;8643.092475290066;8662.913370866274;5217.947820521822;5356.35723713153;5399.325084364455;5410.053240682865;5440.510354068113;3154.2429816844024;3537.734669899742;3593.658602432765;3662.029562166028;3667.449882517617;1033.8707661542308;1060.3266925502362;1072.9356238625708;1076.3918386111823;1080.027974822658;11616.954474097287;11661.067114630809;11670.591529296518;11679;11679.299242045505;4709.105269998689;4725.149473094807;4806.255030470283;4858.319835223072;4865.367502224759;9955.452450115314;9966.053224943618;9973.850392244121;9975.451350175665;9982.201423886072;5236.711980841014;5267.841964741064;5282.735863206824;5294.470552944752;5294.576433885357;3689.6863766579604;4467.5755803198645;4599.862004139814;4689.132510485503;4726.480087190406;3823.025128592247;3874.9225015500097;3882.689384849262;3913.491246138041;3921.588233235469;1266.7529831682918;1270.371166272701;1274.4010315151863;1284.2679672586537;1286.4018231522386;932.7901222224945;990.1237404896574;1006.8036732837027;1160.3618010094415;1366.4261010375667;7810.726624568113;7814.4529882907655;7876.527408355517;7930.365570754326;7930.801729956682;1164.121088578135;1179.2511755035614;1181.6159748081907;1195.3425615911215;1197.7424853656505;6127.019676851772;6139.96930015356;6181.474574661114;6213.937860621336;6236.563440559117;10086;10584.576616935236;10607.41659208751;10608.363498190134;10613.044825965546;10235.283530152967;10290;10426.478676066166;10487.37075775456;10493.527791249413;8226.465279756796;8279.379046571532;8325.167483251747;8334.12491688364;8341.082480927093;7621.085469743666;7809.765707028798;7812.1797211292;7813.765587032398;7822.765317040498;9225.49259790718;9459.243260539279;9496.667616633385;9561.043895610383;9625.855612165684;9611.471369074769;9677.274204434554;9708.951455242961;9771.560279787285;9772.462514561483;7187.676554554953;7227.891581626385;7241.963790181016;7287.380572651384;7297.233790451926;8044.839103217786;8098.635561399633;8106.675732970615;8120.5533695644945;8137.186281371815;6003.2796064470795;6302.527310451826;7164.996900433839;7249.891251631124;7394.112706475257;6933.2720064392515;6974.895376569457;7065.222825489295;7127.073480447509;7162.176349719641;7407.66665500043;7559.735409260649;7560.243975602396;7565.319121279112;7570.9242907570215;6781.152355955505;6882.277360877036;6884.242733299233;6896.344847239504;6898.8620227596175;6848.041274221513;6969.895451568332;6972.233054364117;6974.37230649244;6975.476839237179 14:52:39 INFO - PROCESS | 1667 | |4;prototype.html;315.88470208373946;316.50783032384663;317.50929386530237;319.0858191281978;326.5656676620095;6398.456131228845;6565.244996825367;6619.371159739823;6650.168728908887;6737.663116844163;6487.221533415996;6605.636689982049;6628.73485060597;6639.236487803892;6643.667816609162;4570.520095389986;4611.6395663279245;4672.836450724225;4823.782929768169;4844.61243100552;3949.526056873179;4800.783964721579;4809.470958194614;4810.725157833177;4813.470518242991;3842.615738426149;4655.324977878206;4713.528647135293;4718.174319494092;4728.645351598627;4518.299663552155;4596.218642830727;4616.33063205835;4637.791299391535;4664.86005419838;3939.428782826474;3961.861334853295;3962.3660214365564;3964.524257089168;3965.4844870166694;6137.754489820401;6196.1944947157035;6205.503559715212;6227.532935029891;6244.438000579924;5449.618526703132;5452.991196628636;5454.154606036071;5457.727113644302;5460.890782184374;6893.4140598049225;6899.827504312382;6900.861982760317;6904.792856214322;6914;4283.614474697292;4425.380446737459;4469.508354081048;4483.753393563353;4495.842645507391;7269.636518174123;7333.62653179538;7344.522606030644;7350.117985841734;7362.742304019387;4530.139273538017;4530.614897733663;4532.116237333754;4532.6827122101795;4537.77311134442;4595.264757638829;4597.4712908015335;4601.861944141681;4617.630589552828;4618.95381046192;5480.369757477941;5486.807961721321;5503.3120859892515;5504.972475137679;5506.779728810803;6691.197056353269;6952.443804495628;7008.474364422688;7021.157461104598;7046.365827075588;1585.888987770845;1596.5689263898682;1604.0776553481794;1604.8395160484092;1606.092557704893;1016.6848277034143;1019.551397385163;1033.338663255517;1037.6731329631293;1040.7502199472071;6283.560150789401;6399.520035997319;6440.355964403522;6488.0916671666;6567.573107747981;7309.195988441267;7322.890156647654;7324.523905946096;7325.926740732631;7330.816729581697;4989.950100499022;5663.433656634304;6501.577397469149;6510.18622672166;6538.901916471256;3802.524684414448;3848.114933565296;3848.730588858809;3858.1897801461446;3862.9613703863165;7281.781546553612;7543.886841697379;7557.05536807899;7625.504342217738;7638.465307428538;6689.76585819494;7498.400127989857;7531.623418829036;7539.246075392417;7545.471816972759;7623;7637.601267435938;7640.121386040676;7640.579768112807;7641.694332226649;7272.272772722686;7301.963490182515;7305.926940730525;7318.853622927618;7326.04761381017;6918.584884906922;7180.7845764627145;7191.460640452092;7227.927720722725;7245.384142347749;6139.447449729546;6159.6612186330185;7607.619619018917;7657.770266892002;7681.731139410093;4556.931646025246;4586.633069354511;4602.355670206107;4604.861854144381;4610.40064791575;7261.927380726336;7280.381167600814;7299.452541059336;7301.196868344584;7324.560526368435;5663.32040155184;6730.6634668265415;7013.158420989514;7030.121234845645;7060.82347941285;5705.62913410627;5920.934231838311;6736.3159210197455;6958.965205174144;6984.3364880336285;6824.931750682628;6844.520883538304;6858.485613578901;6868.210155832143;6868.965655171693;7026;7036.5074444790425;7036.718531258897;7036.788896333118;7046.859062818818;6611.603303801788;6613.371729685672;6796.116504854337;6879.58722476633;6881.724731010703 14:52:39 INFO - PROCESS | 1667 | |5;yui.html;659.8053574195612;695.7182341151829;738.3871386748999;746.5744525620395;749.995006691034;14771.63070923226;14995.850041499581;15003.774943375858;15009.849901500982;15019.17394543301;11609.78097299784;13546.9839762018;13638.590842274723;14091.859081409182;14096.506622268224;712.1845486917476;723.2297603052758;766.7239793674273;874.4097734029536;896.919277265046;895.404555970279;895.6238379880466;896.708569714842;897.2866571075978;898.2275243290765;936.1060187520935;937.5968333616543;940.731891410948;940.7789169545151;943.6555657185147;753.9962300188519;918.3892711347013;934.2619330728717;938.7043081429396;943.3726571829725;691.778630838132;692.3630260160664;692.8995295682098;693.3101563943858;693.5180049865346;14673.559793206114;14691.485797997126;14721.631959201106;14732.116073035544;14734.115953042745;12609.432575534123;12676.049296302814;12681.746365072648;12754.553590624377;12998.870011299956;9813.460259685715;10018.148457381132;10018.89981100187;10065.647702330456;10319.43243121628;3453.706434953032;3487.808170550619;3523.418635925095;3537.610862805115;3601.8919432416806;86043;86192.70710939403;86268.56865715694;88213;88261.55869220677;9275.350725449154;9329.346945713734;9336.719898403058;9557.283203759745;9619.56711947964;21826.162598862364;21898.058349496925;21933.451663708216;21938.903054847193;21954.560908781736;7176.641167941686;7321.121465424077;7358.77923662291;7501.437392195498;7579.583122928181;4008.4187792769885;4035.878923632296;4091.631753142172;4193.077522944947;4320.870373888788;3518.0852978225334;3558.733095017884;3576.123849656851;3581.3732596795458;3584.372734771405;548.1941545927481;644.4103645164715;647.2718192033961;655.4134050025201;659.5778701630865;539.7705974960626;566.2157911292807;579.7738881836087;582.0948425198857;613.1538476901846;8024.919750802534;8118.594070296462;8165.1426600207315;8174.9182508175345;8205.392852535118;555.1201345866847;565.6040771459994;587.166223961975;588.8204097750228;606.9393060693895;3631.2737452509605;3810.77135371873;3837;3839.9808000959815;3866.2074274773604;93287;93873.5306323464;93968.06031939593;94389.05610943802;95615;78403.60798196087;78628;80089.19910800934;80464.59767701241;82939.58530207431;70663.58672826515;70754;71524.2847571528;72317;72463.27536724671;6333.36666333363;7378.966944627864;7703.576303303372;7854.3323817473865;7916.84166316682;49719.751401242764;49740.50259497359;49818.75090624524;50282.748586256836;50734;48569.5143048565;66474;67995.30011749548;68087;68952;9408.247340212904;9655.662051828152;9797.951010244904;9801.50992450389;9971.05274998874;10663.4135122569;10733.570657173626;10737.194710396907;10742.624008159677;11091.025253700966;9164.312676549418;9893;10333.844992325272;10375.636852710119;10389.324693894872;9730.075642813921;9896.307258491837;10314.123299519624;10339.172866170538;10385.273030887765;8196.67213311461;10279.537420815932;10299.897001029894;10655.326421215193;11000.559977601126;9164.266858651425;9251.491167985825;9266.675666351646;9438.150566449052;9447.14975652167;8671.783205419915;9376.812463750823;9424.481653508848;9436.575354108943;9554.044595540669 14:52:39 INFO - PROCESS | 1667 | __end_tp_report 14:52:39 INFO - PROCESS | 1667 | __start_cc_report 14:52:39 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,962 14:52:39 INFO - PROCESS | 1667 | __end_cc_report 14:52:39 INFO - PROCESS | 1667 | __startTimestamp1456959159058__endTimestamp 14:52:39 INFO - PROCESS | 1667 | 14:52:39 INFO - PROCESS | 1667 | ------- Summary: start ------- 14:52:39 INFO - PROCESS | 1667 | Number of tests: 6 14:52:39 INFO - PROCESS | 1667 | 14:52:39 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5611.90 Median:5774.48 stddev:642.43 (11.1%) stddev-sans-first:619.15 14:52:39 INFO - PROCESS | 1667 | Values: 3338.1 3428.6 3443.3 3449.4 3506.8 5470.9 5550.5 5568.2 5586.9 5594.7 5519.6 5551.9 5604.0 5612.0 5617.6 5043.8 5092.6 5098.5 5101.8 5166.1 5173.2 5177.2 5185.0 5185.2 5196.8 5055.6 5093.5 5099.9 5111.3 5146.2 5117.2 5171.0 5177.7 5197.7 5225.7 4943.5 5010.8 5043.5 5084.7 5145.7 5107.6 5463.9 5476.1 5501.9 5545.0 5352.6 6118.3 6141.2 6145.5 6172.5 6043.1 6060.0 6215.1 6227.0 6233.8 4752.7 5666.1 5684.3 5685.5 5687.6 6252.1 6298.5 6301.8 6317.6 6335.4 5825.2 5956.9 6022.7 6030.3 6051.4 6123.0 6134.8 6140.8 6144.5 6149.2 6068.2 6107.9 6111.9 6128.4 6147.9 6001.3 6034.3 6098.1 6112.4 6134.5 3952.9 4820.0 4825.8 4848.9 4852.9 4220.2 4300.7 4324.8 4335.7 4363.5 5527.8 5534.8 5537.3 5549.2 5607.9 6084.6 6135.4 6170.2 6189.4 6199.8 5427.1 5498.2 5543.8 5560.2 5565.3 5275.4 5290.8 5295.6 5300.7 5314.0 6226.3 6277.2 6289.3 6293.5 6309.9 4959.4 6097.8 6114.9 6127.2 6133.5 6222.3 6259.4 6304.8 6309.1 6320.6 6052.4 6073.4 6074.1 6078.3 6078.6 6060.5 6106.3 6148.5 6184.4 6208.7 5947.3 6001.3 6003.7 6021.0 6055.0 5958.0 5967.6 5967.9 5971.6 5984.7 4838.3 5715.7 5749.6 5773.9 5835.3 5208.7 5774.5 5933.4 5996.0 6021.6 5783.2 5872.9 5874.2 5874.2 5875.5 14:52:39 INFO - PROCESS | 1667 | 14:52:39 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:58813.98 Median:38209.04 stddev:115973.33 (303.5%) stddev-sans-first:116216.04 14:52:39 INFO - PROCESS | 1667 | Values: 505.8 521.6 594.5 633.6 639.7 39222.4 39565.8 39642.4 39681.4 39880.4 41878.8 42493.9 42497.8 42510.9 42924.4 9473.0 9717.0 9717.6 9732.4 9741.8 9510.9 9674.2 9686.5 9791.8 9801.9 9726.4 9795.7 9803.2 9804.1 9822.6 9748.8 9802.1 9804.3 9805.3 9809.4 8211.4 9740.5 9762.0 9777.0 9778.3 40598.6 41086.8 41182.8 41191.0 41427.0 2973.6 2975.7 3183.1 3231.8 3395.2 28613.7 29118.2 29424.4 29716.6 30490.2 2752.2 2775.7 2788.5 2793.4 2853.8 473304.0 473681.0 474648.0 475975.0 476380.0 64815.0 65128.0 65377.3 65453.0 65714.7 69798.7 71703.3 73247.3 73254.0 73387.6 16313.2 16365.7 16447.4 16479.8 16490.9 12735.0 12807.5 12817.4 12822.8 12824.7 21159.7 21571.1 21950.7 21954.3 22018.0 8523.5 8555.0 8986.3 9240.3 9263.9 816.4 947.2 959.9 1006.9 1065.3 29316.8 29422.9 29980.0 30094.8 30881.0 1026.8 1046.1 1060.4 1145.3 1146.6 14822.6 14946.4 15074.4 15128.9 15186.4 487465.0 514643.0 516520.0 517235.0 521177.0 59155.1 59309.1 59567.7 59584.4 59648.0 1300.2 1409.3 1421.9 1439.4 1449.9 29600.6 29628.4 29919.3 30422.8 30673.5 49414.8 49847.0 49916.3 49960.8 50002.7 291043.0 291672.0 291709.0 291739.0 291983.0 32574.8 34105.7 34155.7 34165.0 34195.8 36975.8 44938.6 45684.6 46057.5 46725.0 37589.6 37644.6 37719.0 38364.8 38887.0 36094.0 36783.8 37517.9 37718.0 37761.6 30530.5 36500.6 36943.6 37976.0 38053.2 32149.0 32474.6 32786.0 32954.0 32958.0 23825.0 25045.9 25200.2 25211.7 25318.2 14:52:39 INFO - PROCESS | 1667 | 14:52:39 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:33813.06 Median:2111.88 stddev:98602.22 (4668.9%) stddev-sans-first:98846.72 14:52:39 INFO - PROCESS | 1667 | Values: 301.8 307.2 310.2 351.0 352.6 18323.5 19699.8 20173.2 20204.1 20324.4 19267.6 19298.3 20192.9 20212.9 20219.5 5159.3 5433.6 5436.8 5445.0 5448.3 5291.1 5392.3 5392.4 5394.2 5396.4 5372.0 5809.7 5886.9 6010.5 6017.9 5896.5 5974.6 5986.3 6007.8 6053.8 5136.9 5224.1 5314.5 5315.0 5317.7 9993.8 13824.7 13863.1 17457.7 25011.2 2030.8 2109.6 2114.1 2349.0 2476.4 9850.6 9857.8 10058.6 10143.4 10239.8 1681.0 1692.9 1747.7 1768.3 1822.0 86047.0 103747.0 105283.9 111342.0 114317.0 10305.2 10654.3 11104.9 11243.4 11413.9 13089.3 13416.6 13576.0 13589.5 13600.5 7062.6 8437.2 8510.4 8609.3 8612.8 8657.8 8681.3 8732.6 8823.2 8824.7 4369.1 4460.8 4494.1 4497.6 4548.8 1508.8 1861.0 1889.5 1901.3 1903.3 863.7 867.4 893.7 908.6 996.8 19453.2 20043.1 20089.8 20142.3 20304.9 912.4 918.8 919.0 933.8 938.9 10360.8 10748.7 10755.2 10809.1 10819.4 559268.0 561273.0 580583.2 626144.1 633448.0 116990.4 117374.0 121088.0 121678.2 123294.4 877.0 1003.1 1012.3 1017.3 1025.7 17639.0 17721.2 17767.6 18324.7 18471.9 52143.5 52652.9 52859.0 53951.0 55722.0 75414.2 75845.6 77194.5 77471.6 78689.6 7859.9 7940.4 8109.8 8136.9 8352.3 10887.0 11611.8 12842.7 12967.9 13217.4 10589.8 11403.7 11418.9 11481.2 11670.2 10924.0 11032.6 11170.6 11357.7 11387.3 11316.7 11474.9 11594.8 11671.2 11869.8 7974.0 7975.5 8174.1 8191.1 8419.4 10089.7 10377.9 10843.3 11749.7 11779.4 14:52:39 INFO - PROCESS | 1667 | 14:52:39 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:5933.16 Median:5404.69 stddev:3123.27 (57.8%) stddev-sans-first:3113.46 14:52:39 INFO - PROCESS | 1667 | Values: 1402.6 1428.4 1505.3 1547.8 1941.9 7817.2 8436.2 8587.7 8594.3 8621.3 8307.1 8546.9 8559.9 8564.6 8584.3 2409.9 2439.4 2441.2 2441.9 2444.9 2332.7 2363.7 2393.6 2396.3 2403.4 2447.3 2451.8 2457.1 2490.9 2493.9 2423.1 2445.5 2448.9 2449.3 2456.7 2424.3 2442.4 2452.7 2456.9 2460.9 8598.5 8637.1 8640.8 8643.1 8662.9 5217.9 5356.4 5399.3 5410.1 5440.5 3154.2 3537.7 3593.7 3662.0 3667.4 1033.9 1060.3 1072.9 1076.4 1080.0 11617.0 11661.1 11670.6 11679.0 11679.3 4709.1 4725.1 4806.3 4858.3 4865.4 9955.5 9966.1 9973.9 9975.5 9982.2 5236.7 5267.8 5282.7 5294.5 5294.6 3689.7 4467.6 4599.9 4689.1 4726.5 3823.0 3874.9 3882.7 3913.5 3921.6 1266.8 1270.4 1274.4 1284.3 1286.4 932.8 990.1 1006.8 1160.4 1366.4 7810.7 7814.5 7876.5 7930.4 7930.8 1164.1 1179.3 1181.6 1195.3 1197.7 6127.0 6140.0 6181.5 6213.9 6236.6 10086.0 10584.6 10607.4 10608.4 10613.0 10235.3 10290.0 10426.5 10487.4 10493.5 8226.5 8279.4 8325.2 8334.1 8341.1 7621.1 7809.8 7812.2 7813.8 7822.8 9225.5 9459.2 9496.7 9561.0 9625.9 9611.5 9677.3 9709.0 9771.6 9772.5 7187.7 7227.9 7242.0 7287.4 7297.2 8044.8 8098.6 8106.7 8120.6 8137.2 6003.3 6302.5 7165.0 7249.9 7394.1 6933.3 6974.9 7065.2 7127.1 7162.2 7407.7 7559.7 7560.2 7565.3 7570.9 6781.2 6882.3 6884.2 6896.3 6898.9 6848.0 6969.9 6972.2 6974.4 6975.5 14:52:39 INFO - PROCESS | 1667 | 14:52:39 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:5662.63 Median:6463.79 stddev:1843.55 (28.5%) stddev-sans-first:1804.52 14:52:39 INFO - PROCESS | 1667 | Values: 315.9 316.5 317.5 319.1 326.6 6398.5 6565.2 6619.4 6650.2 6737.7 6487.2 6605.6 6628.7 6639.2 6643.7 4570.5 4611.6 4672.8 4823.8 4844.6 3949.5 4800.8 4809.5 4810.7 4813.5 3842.6 4655.3 4713.5 4718.2 4728.6 4518.3 4596.2 4616.3 4637.8 4664.9 3939.4 3961.9 3962.4 3964.5 3965.5 6137.8 6196.2 6205.5 6227.5 6244.4 5449.6 5453.0 5454.2 5457.7 5460.9 6893.4 6899.8 6900.9 6904.8 6914.0 4283.6 4425.4 4469.5 4483.8 4495.8 7269.6 7333.6 7344.5 7350.1 7362.7 4530.1 4530.6 4532.1 4532.7 4537.8 4595.3 4597.5 4601.9 4617.6 4619.0 5480.4 5486.8 5503.3 5505.0 5506.8 6691.2 6952.4 7008.5 7021.2 7046.4 1585.9 1596.6 1604.1 1604.8 1606.1 1016.7 1019.6 1033.3 1037.7 1040.8 6283.6 6399.5 6440.4 6488.1 6567.6 7309.2 7322.9 7324.5 7325.9 7330.8 4990.0 5663.4 6501.6 6510.2 6538.9 3802.5 3848.1 3848.7 3858.2 3863.0 7281.8 7543.9 7557.1 7625.5 7638.5 6689.8 7498.4 7531.6 7539.2 7545.5 7623.0 7637.6 7640.1 7640.6 7641.7 7272.3 7302.0 7305.9 7318.9 7326.0 6918.6 7180.8 7191.5 7227.9 7245.4 6139.4 6159.7 7607.6 7657.8 7681.7 4556.9 4586.6 4602.4 4604.9 4610.4 7261.9 7280.4 7299.5 7301.2 7324.6 5663.3 6730.7 7013.2 7030.1 7060.8 5705.6 5920.9 6736.3 6959.0 6984.3 6824.9 6844.5 6858.5 6868.2 6869.0 7026.0 7036.5 7036.7 7036.8 7046.9 6611.6 6613.4 6796.1 6879.6 6881.7 14:52:39 INFO - PROCESS | 1667 | 14:52:39 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:18283.84 Median:34821.89 stddev:26425.05 (75.9%) stddev-sans-first:26466.04 14:52:39 INFO - PROCESS | 1667 | Values: 659.8 695.7 738.4 746.6 750.0 14771.6 14995.9 15003.8 15009.8 15019.2 11609.8 13547.0 13638.6 14091.9 14096.5 712.2 723.2 766.7 874.4 896.9 895.4 895.6 896.7 897.3 898.2 936.1 937.6 940.7 940.8 943.7 754.0 918.4 934.3 938.7 943.4 691.8 692.4 692.9 693.3 693.5 14673.6 14691.5 14721.6 14732.1 14734.1 12609.4 12676.0 12681.7 12754.6 12998.9 9813.5 10018.1 10018.9 10065.6 10319.4 3453.7 3487.8 3523.4 3537.6 3601.9 86043.0 86192.7 86268.6 88213.0 88261.6 9275.4 9329.3 9336.7 9557.3 9619.6 21826.2 21898.1 21933.5 21938.9 21954.6 7176.6 7321.1 7358.8 7501.4 7579.6 4008.4 4035.9 4091.6 4193.1 4320.9 3518.1 3558.7 3576.1 3581.4 3584.4 548.2 644.4 647.3 655.4 659.6 539.8 566.2 579.8 582.1 613.2 8024.9 8118.6 8165.1 8174.9 8205.4 555.1 565.6 587.2 588.8 606.9 3631.3 3810.8 3837.0 3840.0 3866.2 93287.0 93873.5 93968.1 94389.1 95615.0 78403.6 78628.0 80089.2 80464.6 82939.6 70663.6 70754.0 71524.3 72317.0 72463.3 6333.4 7379.0 7703.6 7854.3 7916.8 49719.8 49740.5 49818.8 50282.7 50734.0 48569.5 66474.0 67995.3 68087.0 68952.0 9408.2 9655.7 9798.0 9801.5 9971.1 10663.4 10733.6 10737.2 10742.6 11091.0 9164.3 9893.0 10333.8 10375.6 10389.3 9730.1 9896.3 10314.1 10339.2 10385.3 8196.7 10279.5 10299.9 10655.3 11000.6 9164.3 9251.5 9266.7 9438.2 9447.1 8671.8 9376.8 9424.5 9436.6 9554.0 14:52:39 INFO - PROCESS | 1667 | -------- Summary: end -------- 14:52:39 INFO - PROCESS | 1667 | 14:52:39 INFO - TEST-INFO | 1667: exit 0 14:52:39 INFO - TEST-OK | dromaeo_css | took 1112699ms 14:52:39 INFO - TEST-START | kraken 14:52:39 INFO - operating with platform_type : mac_ 14:52:39 INFO - Initialising browser for kraken test... 14:52:39 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmp27CHgZ/profile http://localhost:49279/getInfo.html) 14:52:41 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 14:52:41 INFO - PROCESS | 1677 | colorDepth:24 14:52:41 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 14:52:41 INFO - PROCESS | 1677 | __metrics 14:52:41 INFO - PROCESS | 1677 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:52:41 INFO - PROCESS | 1677 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:52:42 INFO - TEST-INFO | 1677: exit 0 14:52:42 INFO - Browser initialized. 14:52:42 INFO - Running cycle 1/1 for kraken test... 14:52:42 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmp27CHgZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:52:54 INFO - PROCESS | 1679 | RSS: Main: 243949568 14:52:54 INFO - PROCESS | 1679 | 14:52:56 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 14:52:57 INFO - PROCESS | 1679 | RSS: Main: 289632256 14:52:57 INFO - PROCESS | 1679 | 14:53:00 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 14:53:00 INFO - PROCESS | 1679 | RSS: Main: 299143168 14:53:00 INFO - PROCESS | 1679 | 14:53:04 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 14:53:04 INFO - PROCESS | 1679 | RSS: Main: 283791360 14:53:04 INFO - PROCESS | 1679 | 14:53:06 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 14:53:07 INFO - PROCESS | 1679 | RSS: Main: 286019584 14:53:07 INFO - PROCESS | 1679 | 14:53:09 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:53:10 INFO - PROCESS | 1679 | RSS: Main: 286408704 14:53:10 INFO - PROCESS | 1679 | 14:53:12 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 14:53:13 INFO - PROCESS | 1679 | RSS: Main: 289394688 14:53:13 INFO - PROCESS | 1679 | 14:53:16 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 14:53:16 INFO - PROCESS | 1679 | RSS: Main: 289648640 14:53:16 INFO - PROCESS | 1679 | 14:53:19 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 14:53:20 INFO - PROCESS | 1679 | RSS: Main: 288182272 14:53:20 INFO - PROCESS | 1679 | 14:53:21 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:53:22 INFO - PROCESS | 1679 | RSS: Main: 323555328 14:53:22 INFO - PROCESS | 1679 | 14:53:24 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:53:24 INFO - PROCESS | 1679 | RSS: Main: 325226496 14:53:24 INFO - PROCESS | 1679 | 14:53:26 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:53:27 INFO - PROCESS | 1679 | RSS: Main: 331517952 14:53:27 INFO - PROCESS | 1679 | 14:53:29 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:53:30 INFO - PROCESS | 1679 | RSS: Main: 333508608 14:53:30 INFO - PROCESS | 1679 | 14:53:33 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:53:33 INFO - PROCESS | 1679 | RSS: Main: 333705216 14:53:33 INFO - PROCESS | 1679 | 14:53:35 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 14:53:35 INFO - PROCESS | 1679 | RSS: Main: 393129984 14:53:35 INFO - PROCESS | 1679 | 14:53:35 INFO - PROCESS | 1679 | __start_tp_report 14:53:35 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 14:53:35 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 14:53:35 INFO - PROCESS | 1679 | |i|pagename|runs| 14:53:35 INFO - PROCESS | 1679 | |0;ai-astar;109;107;111;111;112;110;115;112;111;110 14:53:35 INFO - PROCESS | 1679 | |1;audio-beat-detection;159;123;141;161;121;152;122;140;190;149 14:53:35 INFO - PROCESS | 1679 | |2;audio-dft;185;187;257;199;185;185;186;186;181;220 14:53:35 INFO - PROCESS | 1679 | |3;audio-fft;79;75;76;116;55;58;57;58;117;55 14:53:35 INFO - PROCESS | 1679 | |4;audio-oscillator;91;92;128;80;79;80;101;104;107;157 14:53:35 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;87;83;87;84;88;83;87;84;86;83 14:53:35 INFO - PROCESS | 1679 | |6;imaging-darkroom;93;93;93;93;93;93;93;93;94;93 14:53:35 INFO - PROCESS | 1679 | |7;imaging-desaturate;84;85;85;105;141;86;87;85;85;84 14:53:35 INFO - PROCESS | 1679 | |8;json-parse-financial;56;55;52;52;52;54;52;64;53;50 14:53:35 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;64;65;75;74;71;71;68;67;68;67 14:53:35 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;83;82;82;83;84;80;82;79;71;97 14:53:35 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;132;119;133;131;109;127;129;125;122;117 14:53:35 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;142;127;135;171;147;139;139;139;136;124 14:53:35 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;67;67;67;66;67;66;65;67;67;66 14:53:35 INFO - PROCESS | 1679 | __end_tp_report 14:53:35 INFO - PROCESS | 1679 | __start_cc_report 14:53:35 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,1291 14:53:35 INFO - PROCESS | 1679 | __end_cc_report 14:53:35 INFO - PROCESS | 1679 | __startTimestamp1456959215732__endTimestamp 14:53:35 INFO - PROCESS | 1679 | 14:53:35 INFO - PROCESS | 1679 | ------- Summary: start ------- 14:53:35 INFO - PROCESS | 1679 | Number of tests: 14 14:53:35 INFO - PROCESS | 1679 | 14:53:35 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:2.10 (1.9%) stddev-sans-first:2.12 14:53:35 INFO - PROCESS | 1679 | Values: 109.0 107.0 111.0 111.0 112.0 110.0 115.0 112.0 111.0 110.0 14:53:35 INFO - PROCESS | 1679 | 14:53:35 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:150.50 stddev:21.51 (14.3%) stddev-sans-first:22.28 14:53:35 INFO - PROCESS | 1679 | Values: 159.0 123.0 141.0 161.0 121.0 152.0 122.0 140.0 190.0 149.0 14:53:35 INFO - PROCESS | 1679 | 14:53:35 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:197.10 Median:186.50 stddev:23.95 (12.8%) stddev-sans-first:25.00 14:53:35 INFO - PROCESS | 1679 | Values: 185.0 187.0 257.0 199.0 185.0 185.0 186.0 186.0 181.0 220.0 14:53:35 INFO - PROCESS | 1679 | 14:53:35 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:74.60 Median:58.00 stddev:23.95 (41.3%) stddev-sans-first:25.35 14:53:35 INFO - PROCESS | 1679 | Values: 79.0 75.0 76.0 116.0 55.0 58.0 57.0 58.0 117.0 55.0 14:53:35 INFO - PROCESS | 1679 | 14:53:35 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:101.90 Median:79.50 stddev:24.61 (31.0%) stddev-sans-first:25.78 14:53:35 INFO - PROCESS | 1679 | Values: 91.0 92.0 128.0 80.0 79.0 80.0 101.0 104.0 107.0 157.0 14:53:35 INFO - PROCESS | 1679 | 14:53:35 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:85.20 Median:86.50 stddev:1.99 (2.3%) stddev-sans-first:2.00 14:53:35 INFO - PROCESS | 1679 | Values: 87.0 83.0 87.0 84.0 88.0 83.0 87.0 84.0 86.0 83.0 14:53:35 INFO - PROCESS | 1679 | 14:53:35 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:93.10 Median:93.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:53:35 INFO - PROCESS | 1679 | Values: 93.0 93.0 93.0 93.0 93.0 93.0 93.0 93.0 94.0 93.0 14:53:35 INFO - PROCESS | 1679 | 14:53:35 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:92.70 Median:85.00 stddev:18.10 (21.3%) stddev-sans-first:18.93 14:53:35 INFO - PROCESS | 1679 | Values: 84.0 85.0 85.0 105.0 141.0 86.0 87.0 85.0 85.0 84.0 14:53:35 INFO - PROCESS | 1679 | 14:53:35 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:53.50 stddev:3.92 (7.3%) stddev-sans-first:4.09 14:53:35 INFO - PROCESS | 1679 | Values: 56.0 55.0 52.0 52.0 52.0 54.0 52.0 64.0 53.0 50.0 14:53:35 INFO - PROCESS | 1679 | 14:53:35 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.50 stddev:3.65 (5.3%) stddev-sans-first:3.40 14:53:35 INFO - PROCESS | 1679 | Values: 64.0 65.0 75.0 74.0 71.0 71.0 68.0 67.0 68.0 67.0 14:53:35 INFO - PROCESS | 1679 | 14:53:35 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.50 stddev:6.36 (7.7%) stddev-sans-first:6.74 14:53:35 INFO - PROCESS | 1679 | Values: 83.0 82.0 82.0 83.0 84.0 80.0 82.0 79.0 71.0 97.0 14:53:35 INFO - PROCESS | 1679 | 14:53:35 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:128.00 stddev:7.68 (6.0%) stddev-sans-first:7.63 14:53:35 INFO - PROCESS | 1679 | Values: 132.0 119.0 133.0 131.0 109.0 127.0 129.0 125.0 122.0 117.0 14:53:35 INFO - PROCESS | 1679 | 14:53:35 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.90 Median:139.00 stddev:12.84 (9.2%) stddev-sans-first:13.59 14:53:35 INFO - PROCESS | 1679 | Values: 142.0 127.0 135.0 171.0 147.0 139.0 139.0 139.0 136.0 124.0 14:53:35 INFO - PROCESS | 1679 | 14:53:35 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:0.71 (1.1%) stddev-sans-first:0.73 14:53:35 INFO - PROCESS | 1679 | Values: 67.0 67.0 67.0 66.0 67.0 66.0 65.0 67.0 67.0 66.0 14:53:35 INFO - PROCESS | 1679 | -------- Summary: end -------- 14:53:35 INFO - PROCESS | 1679 | 14:53:36 INFO - TEST-INFO | 1679: exit 0 14:53:36 INFO - TEST-OK | kraken | took 56899ms 14:53:36 INFO - SUITE-END | took 1169s 14:53:36 INFO - Completed test suite (00:19:30) 14:53:36 INFO - Working with test: dromaeo_css 14:53:36 INFO - Generating results file: dromaeo_css 14:53:36 INFO - Working with test: kraken 14:53:36 INFO - Generating results file: kraken 14:53:36 INFO - javascript benchmark 14:53:36 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:53:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 14:53:36 INFO - process_Request line: dromaeo_css 7411.59 graph.html#tests=[[72,64,59]] 14:53:36 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:53:36 INFO - process_Request line: kraken 1437.30 graph.html#tests=[[232,64,59]] 14:53:36 INFO - RETURN: dromaeo_css: 7411.59 14:53:36 INFO - RETURN: kraken: 1437.30 14:53:36 INFO - javascript benchmark 14:53:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3338.0987133473964, 3428.6057103433113, 3443.2596991646797, 3449.4480883058714, 3506.807125608092, 5470.905818836239, 5550.472705093015, 5568.220449137124, 5586.944130558693, 5594.692291923948, 5519.613627046108, 5551.8889622207535, 5603.971980140093, 5612.045952188128, 5617.550595952324, 5043.773030213631, 5092.567131793783, 5098.464661210575, 5101.770420331094, 5166.095933211692, 5173.224016397533, 5177.223416487538, 5184.974075129638, 5185.196294574347, 5196.76614552346, 5055.646104772667, 5093.516115968995, 5099.923501147486, 5111.258867464216, 5146.176611742122, 5117.2068329409, 5171.0, 5177.663451875616, 5197.714125723083, 5225.6603320784025, 4943.456219815817, 5010.824621138243, 5043.470435604282, 5084.669496482717, 5145.691258524501, 5107.61692873036, 5463.934532766112, 5476.096444086721, 5501.889962200774, 5545.029619816516, 5352.625316227865, 6118.326984031797, 6141.170941922828, 6145.539084568675, 6172.475339596095, 6043.129761520691, 6059.969700151515, 6215.067739839015, 6226.968865155645, 6233.781817636361, 4752.6910750801435, 5666.093425052013, 5684.261046063985, 5685.545156387479, 5687.630304030225, 6252.124702541648, 6298.464630506458, 6301.842453938597, 6317.5893566918, 6335.429811316912, 5825.155352473952, 5956.940430595725, 6022.682053322739, 6030.30651475086, 6051.425114614105, 6123.0, 6134.815955521252, 6140.846478838065, 6144.477719393902, 6149.200603921461, 6068.241469816273, 6107.938920610826, 6111.908321375183, 6128.387161283836, 6147.938520614736, 6001.279846418458, 6034.306054803666, 6098.14625952367, 6112.358202388774, 6134.478569321657, 3952.8931899067734, 4819.95180048202, 4825.758712064383, 4848.927266091011, 4852.927206091911, 4220.155968806251, 4300.677449191323, 4324.805383757738, 4335.674824388184, 4363.52001279859, 5527.806526771544, 5534.806281780199, 5537.335519737658, 5549.223108764776, 5607.943920560742, 6084.574079814371, 6135.355787642323, 6170.167027451326, 6189.442950134419, 6199.783007594712, 5427.0773968425465, 5498.230247765316, 5543.805966791143, 5560.249366335493, 5565.332160140809, 5275.4460781618145, 5290.761915713802, 5295.629305948547, 5300.681959082467, 5314.016906872241, 6226.315105338409, 6277.183966084471, 6289.339619339903, 6293.465055470245, 6309.905351419824, 4959.355283813081, 6097.76666567467, 6114.877702445837, 6127.172831667668, 6133.478654314434, 6222.346653601307, 6259.436650701458, 6304.779332723333, 6309.085182648582, 6320.5575609706875, 6052.364501727256, 6073.423024812636, 6074.058520929263, 6078.331383547895, 6078.635281883101, 6060.454559089703, 6106.297775755845, 6148.4773794227995, 6184.412480814315, 6208.72060757258, 5947.256592925884, 6001.279846418283, 6003.729832157476, 6021.036634138517, 6055.031195008954, 5957.970210148921, 5967.6419414835245, 5967.850803729942, 5971.611845230046, 5984.700764961647, 4838.274258861199, 5715.714214289352, 5749.568782341257, 5773.913391299218, 5835.299764028344, 5208.661437006583, 5774.48029677331, 5933.436323549428, 5996.0, 6021.578489505692, 5783.190353350618, 5872.941270587239, 5874.206982057368, 5874.236349274567, 5875.471207591338], "unit": "score", "name": "dojo.html", "value": 5572.386073852141}, {"lowerIsBetter": false, "replicates": [505.79768092762913, 521.5749164430986, 594.5243804956034, 633.5660072850096, 639.651389992454, 39222.41166382506, 39565.80217098918, 39642.40536391949, 39681.40477892827, 39880.40179397308, 41878.790606047005, 42493.93765155865, 42497.78751106248, 42510.93722656935, 42924.35613465793, 9472.952635236832, 9716.95141524295, 9717.562709678046, 9732.367396119265, 9741.756456088619, 9510.857337139949, 9674.177694895941, 9686.46724430156, 9791.804163916717, 9801.852972205423, 9726.416415015086, 9795.706128816148, 9803.166730827888, 9804.068613481708, 9822.607095716163, 9748.75628109296, 9802.117809397118, 9804.31369804114, 9805.264605154607, 9809.362391444532, 8211.384146189, 9740.4642744649, 9762.023797620252, 9776.951115244377, 9778.315517913748, 40598.59401406007, 41086.794566026976, 41182.794086029375, 41191.0, 41427.0, 2973.6431628204755, 2975.7321841034195, 3183.1246407237963, 3231.806091634486, 3395.2021275000357, 28613.713862861314, 29118.157233050217, 29424.411511769646, 29716.55425168624, 30490.237744056354, 2752.2431331384028, 2775.736305051037, 2788.470190663788, 2793.427347393779, 2853.8287702737903, 473304.0, 473681.0, 474648.0, 475975.0, 476380.0, 64815.0, 65128.0, 65377.34622653808, 65453.0, 65714.67142664256, 69798.65100674464, 71703.2829671707, 73247.26752732405, 73254.0, 73387.63306183435, 16313.184340782913, 16365.672686546202, 16447.424340148038, 16479.752803707954, 16490.917545412438, 12735.0, 12807.487700492062, 12817.423215955305, 12822.80765788514, 12824.743505129845, 21159.68260476094, 21571.13715451396, 21950.707393891043, 21954.34136975893, 22018.009189586508, 8523.531205783618, 8554.957225213833, 8986.281097512183, 9240.260779137652, 9263.907360926305, 816.3632366753941, 947.230024502484, 959.9040095990345, 1006.8993100689872, 1065.2969040433277, 29316.82732690711, 29422.85288573586, 29980.0, 30094.84952575267, 30881.0, 1026.7997740440692, 1046.0951277145366, 1060.4326685223368, 1145.3185354713933, 1146.6044214746066, 14822.629434264014, 14946.40214391434, 15074.397024118913, 15128.943258979165, 15186.356280343583, 487465.0, 514643.0, 516520.0, 517235.0, 521177.0, 59155.11267330994, 59309.11036334458, 59567.70216148978, 59584.40415595875, 59648.0, 1300.219868079145, 1409.3094383751888, 1421.9075760075768, 1439.438618938594, 1449.8550144985627, 29600.555991660574, 29628.40743185081, 29919.252018699706, 30422.847885760428, 30673.53989690112, 49414.75292623514, 49847.0, 49916.25125623191, 49960.75019624879, 50002.74998624984, 291043.0, 291672.0, 291709.0, 291739.0, 291983.0, 32574.837125814218, 34105.65894341124, 34155.65844341525, 34165.0, 34195.82902085573, 36975.81512092422, 44938.55061449474, 45684.62946111622, 46057.539424605326, 46725.0, 37589.624103758615, 37644.62355376411, 37719.0, 38364.84905452841, 38887.0, 36094.0, 36783.81608092049, 37517.87446376613, 37718.0, 37761.62238377581, 30530.542041869834, 36500.63499365078, 36943.630563694016, 37976.0, 38053.23893522169, 32149.0, 32474.60738730439, 32786.0, 32954.0, 32958.0, 23825.0, 25045.87477062603, 25200.243992680247, 25211.74788252094, 25318.24045278571], "unit": "score", "name": "ext.html", "value": 19749.517250988196}, {"lowerIsBetter": false, "replicates": [301.8385163937294, 307.2165976759265, 310.17493467376767, 350.98771542996, 352.57162547504777, 18323.54191145222, 19699.803001969995, 20173.184413402792, 20204.090815913318, 20324.39026829194, 19267.614647707036, 19298.324558640452, 20192.8990355048, 20212.898935505338, 20219.494512637193, 5159.277701121855, 5433.565314774828, 5436.755346009439, 5445.047116754572, 5448.318960129984, 5291.074062039128, 5392.272043274147, 5392.406835248139, 5394.1908713692865, 5396.379416367129, 5371.973140134294, 5809.651420914737, 5886.911696324559, 6010.489108425767, 6017.939820601781, 5896.469317761401, 5974.61165024272, 5986.281646202462, 6007.7596896124105, 6053.848653783691, 5136.922946155811, 5224.059669259532, 5314.495122963351, 5315.0432922074015, 5317.707526086064, 9993.80012399748, 13824.654383640389, 13863.098898571561, 17457.65084698299, 25011.24966250997, 2030.8375329973567, 2109.641360968639, 2114.12263910477, 2348.954715151741, 2476.418041760185, 9850.556724947322, 9857.802843943153, 10058.647947321808, 10143.391396516232, 10239.795204095877, 1680.9747853782203, 1692.9492115236562, 1747.7028905086165, 1768.3368736723728, 1821.954451138719, 86047.0, 103747.00299205532, 105283.94716052819, 111342.0, 114317.0, 10305.227107966783, 10654.254202205771, 11104.944475277573, 11243.437828108561, 11413.942930285462, 13089.345532723517, 13416.597502074954, 13576.0, 13589.45642174302, 13600.455981760619, 7062.611556364346, 8437.198466145706, 8510.446820956618, 8609.311255099577, 8612.827743445221, 8657.783555411164, 8681.30549556034, 8732.607032683545, 8823.205911467998, 8824.735257942271, 4369.104333611665, 4460.821567137278, 4494.056248187851, 4497.572730590588, 4548.7725613719185, 1508.8264849542225, 1860.9534761630796, 1889.4992826900882, 1901.2775145444919, 1903.2672421117693, 863.6761214544546, 867.4491697771834, 893.7318804358666, 908.5820522559696, 996.8255555277798, 19453.221871124995, 20043.09806058731, 20089.799102009085, 20142.295019674242, 20304.89847550753, 912.3567884641312, 918.7519369770125, 919.0350132360994, 933.7852293972425, 938.9389689670286, 10360.844587331196, 10748.677539673823, 10755.247132700792, 10809.135269178447, 10819.404932728617, 559268.0, 561273.0, 580583.1941680614, 626144.0849570243, 633448.0, 116990.41504792421, 117374.0, 121088.0, 121678.17482737766, 123294.38352808179, 876.9564218579997, 1003.0771690045176, 1012.2863381316155, 1017.29298137795, 1025.7179275699093, 17639.0, 17721.202545885724, 17767.644647107245, 18324.72512912334, 18471.90764046171, 52143.47856521386, 52652.94694106173, 52859.0, 53951.0, 55722.0, 75414.24585754072, 75845.62077189579, 77194.45611087634, 77471.61264193643, 78689.60655196688, 7859.882101768592, 7940.404469664913, 8109.8378032440205, 8136.87794683092, 8352.290055345364, 10886.98699640125, 11611.838816118321, 12842.743145137232, 12967.870321297043, 13217.405216765077, 10589.788204236027, 11403.657890263305, 11418.942905285752, 11481.196316257781, 11670.241434307083, 10924.0, 11032.558697652004, 11170.553177872795, 11357.716057098309, 11387.259828111146, 11316.717082073013, 11474.942625287154, 11594.768104637691, 11671.183017188716, 11869.821952670889, 7974.043114826258, 7975.521468711896, 8174.059983101782, 8191.098979112412, 8419.410641255054, 10089.697309080739, 10377.896221037994, 10843.349399036084, 11749.706257343634, 11779.352135632622], "unit": "score", "name": "jquery.html", "value": 9178.864795142757}, {"lowerIsBetter": false, "replicates": [1402.57221547428, 1428.357239242341, 1505.2849896299253, 1547.7987861577997, 1941.941741747747, 7817.179196184404, 8436.240738333556, 8587.656493740244, 8594.269487093588, 8621.267192288664, 8307.127751586087, 8546.91453085469, 8559.914400856005, 8564.571771411436, 8584.313254939605, 2409.927702168929, 2439.4145405102736, 2441.182203961675, 2441.9389515262174, 2444.8899799509063, 2332.696749422573, 2363.657269695893, 2393.6050551658955, 2396.269137912936, 2403.399150212447, 2447.253587655773, 2451.7915977141874, 2457.1400009996537, 2490.86300253486, 2493.9127130550432, 2423.1155628195756, 2445.5231229910173, 2448.8775561222046, 2449.301948944551, 2456.680631517909, 2424.3333083402204, 2442.438239204993, 2452.7424620414777, 2456.8894399752053, 2460.852348859074, 8598.484090954562, 8637.136286371375, 8640.827183456358, 8643.092475290066, 8662.913370866274, 5217.947820521822, 5356.35723713153, 5399.325084364455, 5410.053240682865, 5440.510354068113, 3154.2429816844024, 3537.734669899742, 3593.658602432765, 3662.029562166028, 3667.449882517617, 1033.8707661542308, 1060.3266925502362, 1072.9356238625708, 1076.3918386111823, 1080.027974822658, 11616.954474097287, 11661.067114630809, 11670.591529296518, 11679.0, 11679.299242045505, 4709.105269998689, 4725.149473094807, 4806.255030470283, 4858.319835223072, 4865.367502224759, 9955.452450115314, 9966.053224943618, 9973.850392244121, 9975.451350175665, 9982.201423886072, 5236.711980841014, 5267.841964741064, 5282.735863206824, 5294.470552944752, 5294.576433885357, 3689.6863766579604, 4467.5755803198645, 4599.862004139814, 4689.132510485503, 4726.480087190406, 3823.025128592247, 3874.9225015500097, 3882.689384849262, 3913.491246138041, 3921.588233235469, 1266.7529831682918, 1270.371166272701, 1274.4010315151863, 1284.2679672586537, 1286.4018231522386, 932.7901222224945, 990.1237404896574, 1006.8036732837027, 1160.3618010094415, 1366.4261010375667, 7810.726624568113, 7814.4529882907655, 7876.527408355517, 7930.365570754326, 7930.801729956682, 1164.121088578135, 1179.2511755035614, 1181.6159748081907, 1195.3425615911215, 1197.7424853656505, 6127.019676851772, 6139.96930015356, 6181.474574661114, 6213.937860621336, 6236.563440559117, 10086.0, 10584.576616935236, 10607.41659208751, 10608.363498190134, 10613.044825965546, 10235.283530152967, 10290.0, 10426.478676066166, 10487.37075775456, 10493.527791249413, 8226.465279756796, 8279.379046571532, 8325.167483251747, 8334.12491688364, 8341.082480927093, 7621.085469743666, 7809.765707028798, 7812.1797211292, 7813.765587032398, 7822.765317040498, 9225.49259790718, 9459.243260539279, 9496.667616633385, 9561.043895610383, 9625.855612165684, 9611.471369074769, 9677.274204434554, 9708.951455242961, 9771.560279787285, 9772.462514561483, 7187.676554554953, 7227.891581626385, 7241.963790181016, 7287.380572651384, 7297.233790451926, 8044.839103217786, 8098.635561399633, 8106.675732970615, 8120.5533695644945, 8137.186281371815, 6003.2796064470795, 6302.527310451826, 7164.996900433839, 7249.891251631124, 7394.112706475257, 6933.2720064392515, 6974.895376569457, 7065.222825489295, 7127.073480447509, 7162.176349719641, 7407.66665500043, 7559.735409260649, 7560.243975602396, 7565.319121279112, 7570.9242907570215, 6781.152355955505, 6882.277360877036, 6884.242733299233, 6896.344847239504, 6898.8620227596175, 6848.041274221513, 6969.895451568332, 6972.233054364117, 6974.37230649244, 6975.476839237179], "unit": "score", "name": "mootools.html", "value": 4838.425579691472}, {"lowerIsBetter": false, "replicates": [315.88470208373946, 316.50783032384663, 317.50929386530237, 319.0858191281978, 326.5656676620095, 6398.456131228845, 6565.244996825367, 6619.371159739823, 6650.168728908887, 6737.663116844163, 6487.221533415996, 6605.636689982049, 6628.73485060597, 6639.236487803892, 6643.667816609162, 4570.520095389986, 4611.6395663279245, 4672.836450724225, 4823.782929768169, 4844.61243100552, 3949.526056873179, 4800.783964721579, 4809.470958194614, 4810.725157833177, 4813.470518242991, 3842.615738426149, 4655.324977878206, 4713.528647135293, 4718.174319494092, 4728.645351598627, 4518.299663552155, 4596.218642830727, 4616.33063205835, 4637.791299391535, 4664.86005419838, 3939.428782826474, 3961.861334853295, 3962.3660214365564, 3964.524257089168, 3965.4844870166694, 6137.754489820401, 6196.1944947157035, 6205.503559715212, 6227.532935029891, 6244.438000579924, 5449.618526703132, 5452.991196628636, 5454.154606036071, 5457.727113644302, 5460.890782184374, 6893.4140598049225, 6899.827504312382, 6900.861982760317, 6904.792856214322, 6914.0, 4283.614474697292, 4425.380446737459, 4469.508354081048, 4483.753393563353, 4495.842645507391, 7269.636518174123, 7333.62653179538, 7344.522606030644, 7350.117985841734, 7362.742304019387, 4530.139273538017, 4530.614897733663, 4532.116237333754, 4532.6827122101795, 4537.77311134442, 4595.264757638829, 4597.4712908015335, 4601.861944141681, 4617.630589552828, 4618.95381046192, 5480.369757477941, 5486.807961721321, 5503.3120859892515, 5504.972475137679, 5506.779728810803, 6691.197056353269, 6952.443804495628, 7008.474364422688, 7021.157461104598, 7046.365827075588, 1585.888987770845, 1596.5689263898682, 1604.0776553481794, 1604.8395160484092, 1606.092557704893, 1016.6848277034143, 1019.551397385163, 1033.338663255517, 1037.6731329631293, 1040.7502199472071, 6283.560150789401, 6399.520035997319, 6440.355964403522, 6488.0916671666, 6567.573107747981, 7309.195988441267, 7322.890156647654, 7324.523905946096, 7325.926740732631, 7330.816729581697, 4989.950100499022, 5663.433656634304, 6501.577397469149, 6510.18622672166, 6538.901916471256, 3802.524684414448, 3848.114933565296, 3848.730588858809, 3858.1897801461446, 3862.9613703863165, 7281.781546553612, 7543.886841697379, 7557.05536807899, 7625.504342217738, 7638.465307428538, 6689.76585819494, 7498.400127989857, 7531.623418829036, 7539.246075392417, 7545.471816972759, 7623.0, 7637.601267435938, 7640.121386040676, 7640.579768112807, 7641.694332226649, 7272.272772722686, 7301.963490182515, 7305.926940730525, 7318.853622927618, 7326.04761381017, 6918.584884906922, 7180.7845764627145, 7191.460640452092, 7227.927720722725, 7245.384142347749, 6139.447449729546, 6159.6612186330185, 7607.619619018917, 7657.770266892002, 7681.731139410093, 4556.931646025246, 4586.633069354511, 4602.355670206107, 4604.861854144381, 4610.40064791575, 7261.927380726336, 7280.381167600814, 7299.452541059336, 7301.196868344584, 7324.560526368435, 5663.32040155184, 6730.6634668265415, 7013.158420989514, 7030.121234845645, 7060.82347941285, 5705.62913410627, 5920.934231838311, 6736.3159210197455, 6958.965205174144, 6984.3364880336285, 6824.931750682628, 6844.520883538304, 6858.485613578901, 6868.210155832143, 6868.965655171693, 7026.0, 7036.5074444790425, 7036.718531258897, 7036.788896333118, 7046.859062818818, 6611.603303801788, 6613.371729685672, 6796.116504854337, 6879.58722476633, 6881.724731010703], "unit": "score", "name": "prototype.html", "value": 5045.499103527809}, {"lowerIsBetter": false, "replicates": [659.8053574195612, 695.7182341151829, 738.3871386748999, 746.5744525620395, 749.995006691034, 14771.63070923226, 14995.850041499581, 15003.774943375858, 15009.849901500982, 15019.17394543301, 11609.78097299784, 13546.9839762018, 13638.590842274723, 14091.859081409182, 14096.506622268224, 712.1845486917476, 723.2297603052758, 766.7239793674273, 874.4097734029536, 896.919277265046, 895.404555970279, 895.6238379880466, 896.708569714842, 897.2866571075978, 898.2275243290765, 936.1060187520935, 937.5968333616543, 940.731891410948, 940.7789169545151, 943.6555657185147, 753.9962300188519, 918.3892711347013, 934.2619330728717, 938.7043081429396, 943.3726571829725, 691.778630838132, 692.3630260160664, 692.8995295682098, 693.3101563943858, 693.5180049865346, 14673.559793206114, 14691.485797997126, 14721.631959201106, 14732.116073035544, 14734.115953042745, 12609.432575534123, 12676.049296302814, 12681.746365072648, 12754.553590624377, 12998.870011299956, 9813.460259685715, 10018.148457381132, 10018.89981100187, 10065.647702330456, 10319.43243121628, 3453.706434953032, 3487.808170550619, 3523.418635925095, 3537.610862805115, 3601.8919432416806, 86043.0, 86192.70710939403, 86268.56865715694, 88213.0, 88261.55869220677, 9275.350725449154, 9329.346945713734, 9336.719898403058, 9557.283203759745, 9619.56711947964, 21826.162598862364, 21898.058349496925, 21933.451663708216, 21938.903054847193, 21954.560908781736, 7176.641167941686, 7321.121465424077, 7358.77923662291, 7501.437392195498, 7579.583122928181, 4008.4187792769885, 4035.878923632296, 4091.631753142172, 4193.077522944947, 4320.870373888788, 3518.0852978225334, 3558.733095017884, 3576.123849656851, 3581.3732596795458, 3584.372734771405, 548.1941545927481, 644.4103645164715, 647.2718192033961, 655.4134050025201, 659.5778701630865, 539.7705974960626, 566.2157911292807, 579.7738881836087, 582.0948425198857, 613.1538476901846, 8024.919750802534, 8118.594070296462, 8165.1426600207315, 8174.9182508175345, 8205.392852535118, 555.1201345866847, 565.6040771459994, 587.166223961975, 588.8204097750228, 606.9393060693895, 3631.2737452509605, 3810.77135371873, 3837.0, 3839.9808000959815, 3866.2074274773604, 93287.0, 93873.5306323464, 93968.06031939593, 94389.05610943802, 95615.0, 78403.60798196087, 78628.0, 80089.19910800934, 80464.59767701241, 82939.58530207431, 70663.58672826515, 70754.0, 71524.2847571528, 72317.0, 72463.27536724671, 6333.36666333363, 7378.966944627864, 7703.576303303372, 7854.3323817473865, 7916.84166316682, 49719.751401242764, 49740.50259497359, 49818.75090624524, 50282.748586256836, 50734.0, 48569.5143048565, 66474.0, 67995.30011749548, 68087.0, 68952.0, 9408.247340212904, 9655.662051828152, 9797.951010244904, 9801.50992450389, 9971.05274998874, 10663.4135122569, 10733.570657173626, 10737.194710396907, 10742.624008159677, 11091.025253700966, 9164.312676549418, 9893.0, 10333.844992325272, 10375.636852710119, 10389.324693894872, 9730.075642813921, 9896.307258491837, 10314.123299519624, 10339.172866170538, 10385.273030887765, 8196.67213311461, 10279.537420815932, 10299.897001029894, 10655.326421215193, 11000.559977601126, 9164.266858651425, 9251.491167985825, 9266.675666351646, 9438.150566449052, 9447.14975652167, 8671.783205419915, 9376.812463750823, 9424.481653508848, 9436.575354108943, 9554.044595540669], "unit": "score", "name": "yui.html", "value": 6721.023262935292}], "name": "dromaeo_css", "value": 7411.584417906209}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 107.0, 111.0, 111.0, 112.0, 110.0, 115.0, 112.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [159.0, 123.0, 141.0, 161.0, 121.0, 152.0, 122.0, 140.0, 190.0, 149.0], "unit": "score", "name": "audio-beat-detection", "value": 145.8}, {"lowerIsBetter": true, "replicates": [185.0, 187.0, 257.0, 199.0, 185.0, 185.0, 186.0, 186.0, 181.0, 220.0], "unit": "score", "name": "audio-dft", "value": 197.1}, {"lowerIsBetter": true, "replicates": [79.0, 75.0, 76.0, 116.0, 55.0, 58.0, 57.0, 58.0, 117.0, 55.0], "unit": "score", "name": "audio-fft", "value": 74.6}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 128.0, 80.0, 79.0, 80.0, 101.0, 104.0, 107.0, 157.0], "unit": "score", "name": "audio-oscillator", "value": 101.9}, {"lowerIsBetter": true, "replicates": [87.0, 83.0, 87.0, 84.0, 88.0, 83.0, 87.0, 84.0, 86.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.2}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 94.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.1}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 85.0, 105.0, 141.0, 86.0, 87.0, 85.0, 85.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 92.7}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 52.0, 52.0, 52.0, 54.0, 52.0, 64.0, 53.0, 50.0], "unit": "score", "name": "json-parse-financial", "value": 54.0}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 75.0, 74.0, 71.0, 71.0, 68.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 82.0, 83.0, 84.0, 80.0, 82.0, 79.0, 71.0, 97.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.3}, {"lowerIsBetter": true, "replicates": [132.0, 119.0, 133.0, 131.0, 109.0, 127.0, 129.0, 125.0, 122.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.4}, {"lowerIsBetter": true, "replicates": [142.0, 127.0, 135.0, 171.0, 147.0, 139.0, 139.0, 139.0, 136.0, 124.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.9}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 66.0, 67.0, 66.0, 65.0, 67.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1437.3000000000004}]} 14:53:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1437.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7411.59"}}} 14:53:37 INFO - Return code: 0 14:53:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:53:37 INFO - # TBPL SUCCESS # 14:53:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:53:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:53:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:53:37 INFO - 2016-03-02 14:53:37.096 screenresolution[1683:9927] starting screenresolution argv=screenresolution get 14:53:37 INFO - 2016-03-02 14:53:37.099 screenresolution[1683:9927] Display 0: 1600x1200x32@60 14:53:37 INFO - 2016-03-02 14:53:37.105 screenresolution[1684:9930] starting screenresolution argv=screenresolution list 14:53:37 INFO - Available Modes on Display 0 14:53:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:53:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:53:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:53:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:53:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:53:37 INFO - Intel Iris: 14:53:37 INFO - Chipset Model: Intel Iris 14:53:37 INFO - Type: GPU 14:53:37 INFO - Bus: Built-In 14:53:37 INFO - VRAM (Dynamic, Max): 1536 MB 14:53:37 INFO - Vendor: Intel (0x8086) 14:53:37 INFO - Device ID: 0x0a2e 14:53:37 INFO - Revision ID: 0x0009 14:53:37 INFO - Displays: 14:53:37 INFO - Display: 14:53:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:53:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:53:37 INFO - Display Serial Number: 1600x1200 60 14:53:37 INFO - Main Display: Yes 14:53:37 INFO - Mirror: Off 14:53:37 INFO - Online: Yes 14:53:37 INFO - Rotation: Supported 14:53:37 INFO - Return code: 0 14:53:37 INFO - Running post-action listener: _resource_record_post_action 14:53:37 INFO - Running post-run listener: _resource_record_post_run 14:53:38 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 39388672; Write bytes: 707026432; Read time: 444; Write time: 2349 14:53:38 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 382044672; Write bytes: 375571968; Read time: 28391; Write time: 1033 14:53:38 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 38467072; Write bytes: 301824000; Read time: 431; Write time: 1257 14:53:38 INFO - Running post-run listener: _upload_blobber_files 14:53:38 INFO - Blob upload gear active. 14:53:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:53:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:53:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:53:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:53:38 INFO - (blobuploader) - INFO - Open directory for files ... 14:53:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:53:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:53:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:40 INFO - (blobuploader) - INFO - Done attempting. 14:53:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:53:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:53:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:41 INFO - (blobuploader) - INFO - Done attempting. 14:53:41 INFO - (blobuploader) - INFO - Iteration through files over. 14:53:41 INFO - Return code: 0 14:53:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:53:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:53:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aec8d1d1ad29625397db883324d883a1c4257f467735a65514027a682eee8729aa291f449406b1c55cc4b694732c77ab33bc51dd10f44058c1d0be8365ec76cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17bc99fa8a67e35e651a31efd276a8c2f47c6de3791c7412c9aef5492ee6dca7b62cd8ec515f574a2faef613ff67222b5386c91fc7fe7db56c9790a04ca2e752"} 14:53:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:53:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:53:41 INFO - Contents: 14:53:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aec8d1d1ad29625397db883324d883a1c4257f467735a65514027a682eee8729aa291f449406b1c55cc4b694732c77ab33bc51dd10f44058c1d0be8365ec76cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17bc99fa8a67e35e651a31efd276a8c2f47c6de3791c7412c9aef5492ee6dca7b62cd8ec515f574a2faef613ff67222b5386c91fc7fe7db56c9790a04ca2e752"} 14:53:41 INFO - Running post-run listener: copy_logs_to_upload_dir 14:53:41 INFO - Copying logs to upload dir... 14:53:41 INFO - mkdir: /builds/slave/test/build/upload/logs 14:53:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.812336 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-02 14:53:41.091499) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 14:53:41.095262) ========= 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.BdQ1sY54uZ/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.XVvohzFcXl/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/aec8d1d1ad29625397db883324d883a1c4257f467735a65514027a682eee8729aa291f449406b1c55cc4b694732c77ab33bc51dd10f44058c1d0be8365ec76cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17bc99fa8a67e35e651a31efd276a8c2f47c6de3791c7412c9aef5492ee6dca7b62cd8ec515f574a2faef613ff67222b5386c91fc7fe7db56c9790a04ca2e752"} build_url:https://queue.taskcluster.net/v1/task/HRiIyCHORruAyrI7g5r3fA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/HRiIyCHORruAyrI7g5r3fA/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/aec8d1d1ad29625397db883324d883a1c4257f467735a65514027a682eee8729aa291f449406b1c55cc4b694732c77ab33bc51dd10f44058c1d0be8365ec76cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17bc99fa8a67e35e651a31efd276a8c2f47c6de3791c7412c9aef5492ee6dca7b62cd8ec515f574a2faef613ff67222b5386c91fc7fe7db56c9790a04ca2e752"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 14:53:41.123701) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 14:53:41.124051) ========= 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.BdQ1sY54uZ/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.XVvohzFcXl/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.005317 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 14:53:41.174714) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 14:53:41.175338) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 14:53:41.176142) ========= ========= Total master_lag: 0.26 =========