builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0146 starttime: 1455845869.31 results: success (0) buildid: 20160218155126 builduid: 8c674a8462d74501b228671f505fcd66 revision: c34fe673bb97d511920d2986cb84057f62e0c4a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 17:37:49.309286) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 17:37:49.309690) ========= ========= Started set props: basedir (results: 0, elapsed: 6 secs) (at 2016-02-18 17:37:49.309975) ========= 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.rEm6N21p8q/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.0HqlvT40vD/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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.005507 basedir: '/builds/slave/test' ========= master_lag: 6.53 ========= ========= Finished set props: basedir (results: 0, elapsed: 6 secs) (at 2016-02-18 17:37:55.840771) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 6 secs) (at 2016-02-18 17:37:55.841093) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 6 secs) (at 2016-02-18 17:38:02.072356) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 17:38:02.072799) ========= 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.rEm6N21p8q/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.0HqlvT40vD/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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.005624 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 17:38:02.190306) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 17:38:02.190599) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 17:38:02.190936) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-18 17:38:02.191206) ========= 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.rEm6N21p8q/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.0HqlvT40vD/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-18 17:38:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.6M=0.001s 2016-02-18 17:38:02 (13.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.538276 ========= master_lag: 0.82 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-18 17:38:03.549795) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 17:38:03.550082) ========= 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.rEm6N21p8q/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.0HqlvT40vD/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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.026388 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 17:38:03.604587) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-18 17:38:03.604887) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c34fe673bb97d511920d2986cb84057f62e0c4a0 --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 c34fe673bb97d511920d2986cb84057f62e0c4a0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rEm6N21p8q/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.0HqlvT40vD/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-18 17:38:03,687 truncating revision to first 12 chars 2016-02-18 17:38:03,687 Setting DEBUG logging. 2016-02-18 17:38:03,687 attempt 1/10 2016-02-18 17:38:03,687 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c34fe673bb97?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-18 17:38:04,629 unpacking tar archive at: fx-team-c34fe673bb97/testing/mozharness/ program finished with exit code 0 elapsedTime=1.187920 ========= master_lag: 0.60 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-18 17:38:05.395813) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-18 17:38:05.396219) ========= echo c34fe673bb97d511920d2986cb84057f62e0c4a0 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c34fe673bb97d511920d2986cb84057f62e0c4a0'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rEm6N21p8q/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.0HqlvT40vD/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 c34fe673bb97d511920d2986cb84057f62e0c4a0 program finished with exit code 0 elapsedTime=0.005785 script_repo_revision: 'c34fe673bb97d511920d2986cb84057f62e0c4a0' ========= master_lag: 0.80 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-18 17:38:06.198662) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-18 17:38:06.198978) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-18 17:38:06.419930) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-02-18 17:38:06.420290) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rEm6N21p8q/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.0HqlvT40vD/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 17:38:06 INFO - MultiFileLogger online at 20160218 17:38:06 in /builds/slave/test 17:38:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:38:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:38:06 INFO - {'append_to_log': False, 17:38:06 INFO - 'base_work_dir': '/builds/slave/test', 17:38:06 INFO - 'blob_upload_branch': 'Fx-Team', 17:38:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:38:06 INFO - 'branch': 'Fx-Team', 17:38:06 INFO - 'buildbot_json_path': 'buildprops.json', 17:38:06 INFO - 'config_files': ('talos/mac_config.py',), 17:38:06 INFO - 'default_actions': ('clobber', 17:38:06 INFO - 'read-buildbot-config', 17:38:06 INFO - 'download-and-extract', 17:38:06 INFO - 'populate-webroot', 17:38:06 INFO - 'create-virtualenv', 17:38:06 INFO - 'install', 17:38:06 INFO - 'run-tests'), 17:38:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:38:06 INFO - 'download_minidump_stackwalk': True, 17:38:06 INFO - 'download_symbols': 'ondemand', 17:38:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:38:06 INFO - 'tooltool.py': '/tools/tooltool.py', 17:38:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:38:06 INFO - '/tools/misc-python/virtualenv.py')}, 17:38:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:38:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:38:06 INFO - 'installer_path': 'installer.exe', 17:38:06 INFO - 'log_level': 'info', 17:38:06 INFO - 'log_name': 'talos', 17:38:06 INFO - 'log_to_console': True, 17:38:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:38:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:38:06 INFO - 'opt_config_files': (), 17:38:06 INFO - 'pip_index': False, 17:38:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:38:06 INFO - 'cmd': ('bash', 17:38:06 INFO - '-c', 17:38:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:38:06 INFO - 'enabled': True, 17:38:06 INFO - 'halt_on_failure': False, 17:38:06 INFO - 'name': 'check_screen_resolution'},), 17:38:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:38:06 INFO - 'cmd': ('bash', 17:38:06 INFO - '-c', 17:38:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:38:06 INFO - 'enabled': True, 17:38:06 INFO - 'halt_on_failure': False, 17:38:06 INFO - 'name': 'check_screen_resolution'},), 17:38:06 INFO - 'run_cmd_checks_enabled': True, 17:38:06 INFO - 'sps_profile': False, 17:38:06 INFO - 'sps_profile_interval': 0, 17:38:06 INFO - 'suite': 'dromaeojs-e10s', 17:38:06 INFO - 'system_bits': '32', 17:38:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:38:06 INFO - 'title': 't-yosemite-r7-0146', 17:38:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:38:06 INFO - 'use_talos_json': True, 17:38:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:38:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:38:06 INFO - 'work_dir': 'build'} 17:38:06 INFO - ##### 17:38:06 INFO - ##### Running clobber step. 17:38:06 INFO - ##### 17:38:06 INFO - Running pre-action listener: _resource_record_pre_action 17:38:06 INFO - Running main action method: clobber 17:38:06 INFO - rmtree: /builds/slave/test/build 17:38:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:38:08 INFO - Running post-action listener: _resource_record_post_action 17:38:08 INFO - ##### 17:38:08 INFO - ##### Running read-buildbot-config step. 17:38:08 INFO - ##### 17:38:08 INFO - Running pre-action listener: _resource_record_pre_action 17:38:08 INFO - Running main action method: read_buildbot_config 17:38:08 INFO - Using buildbot properties: 17:38:08 INFO - { 17:38:08 INFO - "project": "", 17:38:08 INFO - "product": "firefox", 17:38:08 INFO - "script_repo_revision": "production", 17:38:08 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 17:38:08 INFO - "repository": "", 17:38:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 17:38:08 INFO - "buildid": "20160218155126", 17:38:08 INFO - "pgo_build": "False", 17:38:08 INFO - "basedir": "/builds/slave/test", 17:38:08 INFO - "buildnumber": 379, 17:38:08 INFO - "slavename": "t-yosemite-r7-0146", 17:38:08 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 17:38:08 INFO - "platform": "yosemite_r7", 17:38:08 INFO - "scheduler": "tests-fx-team-macosx64-talos", 17:38:08 INFO - "branch": "fx-team", 17:38:08 INFO - "repo_path": "integration/fx-team", 17:38:08 INFO - "revision": "c34fe673bb97d511920d2986cb84057f62e0c4a0", 17:38:08 INFO - "stage_platform": "macosx64", 17:38:08 INFO - "builduid": "8c674a8462d74501b228671f505fcd66", 17:38:08 INFO - "slavebuilddir": "test" 17:38:08 INFO - } 17:38:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 17:38:08 INFO - Running post-action listener: _resource_record_post_action 17:38:08 INFO - ##### 17:38:08 INFO - ##### Running download-and-extract step. 17:38:08 INFO - ##### 17:38:08 INFO - Running pre-action listener: _resource_record_pre_action 17:38:08 INFO - Running main action method: download_and_extract 17:38:08 INFO - mkdir: /builds/slave/test/build/tests 17:38: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')]} 17:38:08 INFO - https://queue.taskcluster.net/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:38:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/test_packages.json 17:38:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/test_packages.json 17:38:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:38:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:38:10 INFO - Downloaded 1277 bytes. 17:38:10 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:38:10 INFO - Using the following test package requirements: 17:38:10 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 17:38:10 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:38:10 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 17:38:10 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:38:10 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 17:38:10 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:38:10 INFO - u'jsshell-mac.zip'], 17:38:10 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:38:10 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 17:38:10 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 17:38:10 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:38:10 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 17:38:10 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:38:10 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 17:38:10 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:38:10 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 17:38:10 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 17:38:10 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:38:10 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 17:38:10 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:38:10 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')]} 17:38:10 INFO - https://queue.taskcluster.net/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:38:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:38:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:38:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/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 17:38:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/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 17:38:11 INFO - Downloaded 17807208 bytes. 17:38:11 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'] 17:38:11 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 17:38:14 INFO - Return code: 0 17:38:14 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 17:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:38:14 INFO - https://queue.taskcluster.net/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:38:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:38:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:38:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/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 17:38:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/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 17:38:15 INFO - Downloaded 17807208 bytes. 17:38:15 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'] 17:38:15 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 17:38:19 INFO - Return code: 0 17:38:19 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')]} 17:38:19 INFO - https://queue.taskcluster.net/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:38:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 17:38:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 17:38:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/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 17:38:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/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 17:38:20 INFO - Downloaded 10707015 bytes. 17:38:20 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'] 17:38:20 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 17:38:20 INFO - Return code: 0 17:38:20 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')]} 17:38:20 INFO - https://queue.taskcluster.net/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:38:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:38:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:38:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 17:38:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/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 17:38:23 INFO - Downloaded 111327577 bytes. 17:38:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:38:23 INFO - mkdir: /builds/slave/test/properties 17:38:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:38:23 INFO - Writing to file /builds/slave/test/properties/build_url 17:38:23 INFO - Contents: 17:38:23 INFO - build_url:https://queue.taskcluster.net/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:38:24 INFO - Running post-action listener: _resource_record_post_action 17:38:24 INFO - Running post-action listener: set_extra_try_arguments 17:38:24 INFO - ##### 17:38:24 INFO - ##### Running populate-webroot step. 17:38:24 INFO - ##### 17:38:24 INFO - Running pre-action listener: _resource_record_pre_action 17:38:24 INFO - Running main action method: populate_webroot 17:38:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:38:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:38:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:38:24 INFO - '--tppagecycles', 17:38:24 INFO - '7'], 17:38:24 INFO - 'tests': ['tsvgm']}}, 17:38:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:38:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:38:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:38:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:38:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:38:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:38:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:38:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:24 INFO - 'talos_options': ['--e10s'], 17:38:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:38:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:24 INFO - 'tests': ['damp', 'tps']}, 17:38:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:24 INFO - 'talos_options': ['--e10s'], 17:38:24 INFO - 'tests': ['damp', 'tps']}, 17:38:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:38:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:38:24 INFO - 'other': {'tests': ['a11yr', 17:38:24 INFO - 'ts_paint', 17:38:24 INFO - 'tpaint', 17:38:24 INFO - 'sessionrestore', 17:38:24 INFO - 'sessionrestore_no_auto_restore']}, 17:38:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:38:24 INFO - 'tests': ['a11yr', 17:38:24 INFO - 'ts_paint', 17:38:24 INFO - 'tpaint', 17:38:24 INFO - 'sessionrestore', 17:38:24 INFO - 'sessionrestore_no_auto_restore']}, 17:38:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:38:24 INFO - 'tests': ['a11yr', 17:38:24 INFO - 'ts_paint', 17:38:24 INFO - 'tpaint', 17:38:24 INFO - 'sessionrestore', 17:38:24 INFO - 'sessionrestore_no_auto_restore']}, 17:38:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:38:24 INFO - 'tests': ['a11yr', 17:38:24 INFO - 'ts_paint', 17:38:24 INFO - 'tpaint', 17:38:24 INFO - 'sessionrestore', 17:38:24 INFO - 'sessionrestore_no_auto_restore']}, 17:38:24 INFO - 'other_l64': {'tests': ['a11yr', 17:38:24 INFO - 'ts_paint', 17:38:24 INFO - 'tpaint', 17:38:24 INFO - 'sessionrestore', 17:38:24 INFO - 'sessionrestore_no_auto_restore']}, 17:38:24 INFO - 'other_nol64': {'tests': ['a11yr', 17:38:24 INFO - 'ts_paint', 17:38:24 INFO - 'tpaint', 17:38:24 INFO - 'sessionrestore', 17:38:24 INFO - 'sessionrestore_no_auto_restore']}, 17:38:24 INFO - 'svgr': {'tests': ['tsvgx', 17:38:24 INFO - 'tsvgr_opacity', 17:38:24 INFO - 'tart', 17:38:24 INFO - 'tscrollx', 17:38:24 INFO - 'cart']}, 17:38:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:38:24 INFO - 'tests': ['tsvgx', 17:38:24 INFO - 'tsvgr_opacity', 17:38:24 INFO - 'tart', 17:38:24 INFO - 'tscrollx', 17:38:24 INFO - 'cart']}, 17:38:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:24 INFO - 'tests': ['tp5o']}, 17:38:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:24 INFO - 'talos_options': ['--e10s'], 17:38:24 INFO - 'tests': ['tp5o']}, 17:38:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:24 INFO - 'talos_options': ['--xperf_path', 17:38:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:38:24 INFO - 'tests': ['tp5n']}, 17:38:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:24 INFO - 'talos_options': ['--e10s', 17:38:24 INFO - '--xperf_path', 17:38:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:38:24 INFO - 'tests': ['tp5n']}}, 17:38:24 INFO - 'talos.zip': {'path': '', 17:38:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:38:24 INFO - Running post-action listener: _resource_record_post_action 17:38:24 INFO - ##### 17:38:24 INFO - ##### Running create-virtualenv step. 17:38:24 INFO - ##### 17:38:24 INFO - Running pre-action listener: _resource_record_pre_action 17:38:24 INFO - Running main action method: create_virtualenv 17:38:24 INFO - Creating virtualenv /builds/slave/test/build/venv 17:38:24 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 17:38:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:38:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:38:24 INFO - Using real prefix '/tools/python27' 17:38:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:38:25 INFO - Installing distribute.............................................................................................................................................................................................done. 17:38:28 INFO - Installing pip.................done. 17:38:28 INFO - Return code: 0 17:38:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:38:28 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')]} 17:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:28 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')]} 17:38:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:28 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 0x1006c4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006cb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3115d4d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100568d30>, '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 0x10038cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10055fb20>, '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.rEm6N21p8q/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.0HqlvT40vD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 17:38:28 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 17:38:28 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 17:38:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rEm6N21p8q/Render', 17:38:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:28 INFO - 'HOME': '/Users/cltbld', 17:38:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:28 INFO - 'LOGNAME': 'cltbld', 17:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:28 INFO - 'MOZ_NO_REMOTE': '1', 17:38:28 INFO - 'NO_EM_RESTART': '1', 17:38:28 INFO - 'PAGER': '/bin/cat', 17:38:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:28 INFO - 'PWD': '/builds/slave/test', 17:38:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:28 INFO - 'SHELL': '/bin/bash', 17:38:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0HqlvT40vD/Listeners', 17:38:28 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 17:38:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:28 INFO - 'USER': 'cltbld', 17:38:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:28 INFO - 'XPC_FLAGS': '0x0', 17:38:28 INFO - 'XPC_SERVICE_NAME': '0', 17:38:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:28 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 17:38:28 INFO - Cleaning up... 17:38:28 INFO - Return code: 0 17:38:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:38:28 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')]} 17:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:28 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')]} 17:38:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:28 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 0x1006c4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006cb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3115d4d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100568d30>, '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 0x10038cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10055fb20>, '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.rEm6N21p8q/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.0HqlvT40vD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 17:38:28 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 17:38:28 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 17:38:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rEm6N21p8q/Render', 17:38:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:28 INFO - 'HOME': '/Users/cltbld', 17:38:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:28 INFO - 'LOGNAME': 'cltbld', 17:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:28 INFO - 'MOZ_NO_REMOTE': '1', 17:38:28 INFO - 'NO_EM_RESTART': '1', 17:38:28 INFO - 'PAGER': '/bin/cat', 17:38:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:28 INFO - 'PWD': '/builds/slave/test', 17:38:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:28 INFO - 'SHELL': '/bin/bash', 17:38:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0HqlvT40vD/Listeners', 17:38:28 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 17:38:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:28 INFO - 'USER': 'cltbld', 17:38:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:28 INFO - 'XPC_FLAGS': '0x0', 17:38:28 INFO - 'XPC_SERVICE_NAME': '0', 17:38:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:28 INFO - Downloading/unpacking psutil>=0.7.1 17:38: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 17:38: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 17:38: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 17:38: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 17:38: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 17:38: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 17:38:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:38:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:38:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:38:31 INFO - Installing collected packages: psutil 17:38:31 INFO - Running setup.py install for psutil 17:38:31 INFO - building 'psutil._psutil_osx' extension 17:38:31 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 17:38:32 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 17:38:32 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 17:38:32 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 17:38:32 INFO - building 'psutil._psutil_posix' extension 17:38:32 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 17:38:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:38:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:38:32 INFO - ^ 17:38:32 INFO - 1 warning generated. 17:38:32 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 17:38:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:38:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:38:32 INFO - Successfully installed psutil 17:38:32 INFO - Cleaning up... 17:38:32 INFO - Return code: 0 17:38:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:38:32 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')]} 17:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:32 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')]} 17:38:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:32 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 0x1006c4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006cb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3115d4d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100568d30>, '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 0x10038cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10055fb20>, '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.rEm6N21p8q/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.0HqlvT40vD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 17:38:32 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 17:38:32 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 17:38:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rEm6N21p8q/Render', 17:38:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:32 INFO - 'HOME': '/Users/cltbld', 17:38:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:32 INFO - 'LOGNAME': 'cltbld', 17:38:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:32 INFO - 'MOZ_NO_REMOTE': '1', 17:38:32 INFO - 'NO_EM_RESTART': '1', 17:38:32 INFO - 'PAGER': '/bin/cat', 17:38:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:32 INFO - 'PWD': '/builds/slave/test', 17:38:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:32 INFO - 'SHELL': '/bin/bash', 17:38:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0HqlvT40vD/Listeners', 17:38:32 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 17:38:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:32 INFO - 'USER': 'cltbld', 17:38:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:32 INFO - 'XPC_FLAGS': '0x0', 17:38:32 INFO - 'XPC_SERVICE_NAME': '0', 17:38:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:38:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:38:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:38:35 INFO - Installing collected packages: mozsystemmonitor 17:38:35 INFO - Running setup.py install for mozsystemmonitor 17:38:35 INFO - Successfully installed mozsystemmonitor 17:38:35 INFO - Cleaning up... 17:38:35 INFO - Return code: 0 17:38:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:38:35 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')]} 17:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:35 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')]} 17:38:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:35 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 0x1006c4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006cb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3115d4d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100568d30>, '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 0x10038cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10055fb20>, '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.rEm6N21p8q/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.0HqlvT40vD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 17:38:35 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 17:38:35 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 17:38:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rEm6N21p8q/Render', 17:38:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:35 INFO - 'HOME': '/Users/cltbld', 17:38:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:35 INFO - 'LOGNAME': 'cltbld', 17:38:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:35 INFO - 'MOZ_NO_REMOTE': '1', 17:38:35 INFO - 'NO_EM_RESTART': '1', 17:38:35 INFO - 'PAGER': '/bin/cat', 17:38:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:35 INFO - 'PWD': '/builds/slave/test', 17:38:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:35 INFO - 'SHELL': '/bin/bash', 17:38:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0HqlvT40vD/Listeners', 17:38:35 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 17:38:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:35 INFO - 'USER': 'cltbld', 17:38:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:35 INFO - 'XPC_FLAGS': '0x0', 17:38:35 INFO - 'XPC_SERVICE_NAME': '0', 17:38:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:36 INFO - Downloading/unpacking blobuploader==1.2.4 17:38:36 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 17:38:36 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 17:38:36 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 17:38:36 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 17:38:36 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 17:38:36 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 17:38:38 INFO - Downloading blobuploader-1.2.4.tar.gz 17:38:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:38:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:38:38 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 17:38:38 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 17:38:38 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 17:38:38 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 17:38:38 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 17:38:38 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 17:38:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:38:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:38:39 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 17:38:39 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 17:38:39 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 17:38:39 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 17:38:39 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 17:38:39 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 17:38:39 INFO - Downloading docopt-0.6.1.tar.gz 17:38:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:38:39 INFO - Installing collected packages: blobuploader, requests, docopt 17:38:39 INFO - Running setup.py install for blobuploader 17:38:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:38:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:38:39 INFO - Running setup.py install for requests 17:38:40 INFO - Running setup.py install for docopt 17:38:40 INFO - Successfully installed blobuploader requests docopt 17:38:40 INFO - Cleaning up... 17:38:40 INFO - Return code: 0 17:38:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:38:40 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')]} 17:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:40 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')]} 17:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:40 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 0x1006c4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006cb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3115d4d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100568d30>, '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 0x10038cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10055fb20>, '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.rEm6N21p8q/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.0HqlvT40vD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 17:38:40 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 17:38:40 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 17:38:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rEm6N21p8q/Render', 17:38:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:40 INFO - 'HOME': '/Users/cltbld', 17:38:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:40 INFO - 'LOGNAME': 'cltbld', 17:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:40 INFO - 'MOZ_NO_REMOTE': '1', 17:38:40 INFO - 'NO_EM_RESTART': '1', 17:38:40 INFO - 'PAGER': '/bin/cat', 17:38:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:40 INFO - 'PWD': '/builds/slave/test', 17:38:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:40 INFO - 'SHELL': '/bin/bash', 17:38:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0HqlvT40vD/Listeners', 17:38:40 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 17:38:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:40 INFO - 'USER': 'cltbld', 17:38:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:40 INFO - 'XPC_FLAGS': '0x0', 17:38:40 INFO - 'XPC_SERVICE_NAME': '0', 17:38:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:38:40 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-BUCVev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:38:40 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-hW12Gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:38:41 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-yBlzAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:38:41 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-jCJVvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:38:41 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-1qvz4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:38:41 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-izzufx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:38:41 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-xCJXBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:38:41 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-jV5B7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:38:41 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-lS4i_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:38:41 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-bBaYVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:38:41 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-z9SkAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:38:41 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-KAhpaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:38:42 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-naCtV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:38:42 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-u40DO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:38:42 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-dHp69H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:38:42 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-ejiJHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:38:42 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-LZgQ9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:38:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:38:42 INFO - Running setup.py install for manifestparser 17:38:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:38:42 INFO - Running setup.py install for mozcrash 17:38:42 INFO - Running setup.py install for mozdebug 17:38:43 INFO - Running setup.py install for mozdevice 17:38:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:38:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:38:43 INFO - Running setup.py install for mozfile 17:38:43 INFO - Running setup.py install for mozhttpd 17:38:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:38:43 INFO - Running setup.py install for mozinfo 17:38:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:38:43 INFO - Running setup.py install for mozInstall 17:38:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:38:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:38:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:38:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:38:43 INFO - Running setup.py install for mozleak 17:38:43 INFO - Running setup.py install for mozlog 17:38:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:38:44 INFO - Running setup.py install for moznetwork 17:38:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:38:44 INFO - Running setup.py install for mozprocess 17:38:44 INFO - Running setup.py install for mozprofile 17:38:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:38:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:38:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:38:44 INFO - Running setup.py install for mozrunner 17:38:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:38:44 INFO - Running setup.py install for mozscreenshot 17:38:44 INFO - Running setup.py install for moztest 17:38:45 INFO - Running setup.py install for mozversion 17:38:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:38:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:38:45 INFO - Cleaning up... 17:38:45 INFO - Return code: 0 17:38:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:38: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')]} 17:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38: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')]} 17:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:45 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 0x1006c4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006cb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3115d4d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100568d30>, '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 0x10038cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10055fb20>, '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.rEm6N21p8q/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.0HqlvT40vD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 17:38:45 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 17:38:45 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 17:38:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rEm6N21p8q/Render', 17:38:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:45 INFO - 'HOME': '/Users/cltbld', 17:38:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:45 INFO - 'LOGNAME': 'cltbld', 17:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:45 INFO - 'MOZ_NO_REMOTE': '1', 17:38:45 INFO - 'NO_EM_RESTART': '1', 17:38:45 INFO - 'PAGER': '/bin/cat', 17:38:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:45 INFO - 'PWD': '/builds/slave/test', 17:38:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:45 INFO - 'SHELL': '/bin/bash', 17:38:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0HqlvT40vD/Listeners', 17:38:45 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 17:38:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:45 INFO - 'USER': 'cltbld', 17:38:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:45 INFO - 'XPC_FLAGS': '0x0', 17:38:45 INFO - 'XPC_SERVICE_NAME': '0', 17:38:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:38:45 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-JIa54v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:38:45 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)) 17:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:38:45 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-ofLxtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:38:45 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)) 17:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:38:45 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-mNGl9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:38:45 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)) 17:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:38:45 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-yAIDIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:38:45 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)) 17:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:38:45 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-OwDKTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:38:45 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)) 17:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:38:45 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-F8vtU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:38:46 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)) 17:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:38:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-sV7alL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:38:46 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)) 17:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:38:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-WVWEQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:38:46 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)) 17:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:38:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-2vWMwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:38:46 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)) 17:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:38:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-srMlV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:38:46 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)) 17:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:38:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-8trWu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:38:46 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)) 17:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:38:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-c2yT6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:38:46 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)) 17:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:38:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-J_2Yq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:38:46 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)) 17:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:38:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-KT307g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:38:46 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)) 17:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:38:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-DrbRTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:38:47 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)) 17:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:38:47 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-MVN7IH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:38:47 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)) 17:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:38:47 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-n6HSr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:38:47 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)) 17:38:47 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)) 17:38:47 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)) 17:38:47 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)) 17:38:47 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)) 17:38:47 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)) 17:38:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:49 INFO - Downloading blessings-1.6.tar.gz 17:38:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:38:49 INFO - Installing collected packages: blessings 17:38:49 INFO - Running setup.py install for blessings 17:38:49 INFO - Successfully installed blessings 17:38:49 INFO - Cleaning up... 17:38:49 INFO - Return code: 0 17:38:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:38:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:38:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:38:50 INFO - Reading from file tmpfile_stdout 17:38:50 INFO - Current package versions: 17:38:50 INFO - blessings == 1.6 17:38:50 INFO - blobuploader == 1.2.4 17:38:50 INFO - docopt == 0.6.1 17:38:50 INFO - manifestparser == 1.1 17:38:50 INFO - mozInstall == 1.12 17:38:50 INFO - mozcrash == 0.16 17:38:50 INFO - mozdebug == 0.1 17:38:50 INFO - mozdevice == 0.48 17:38:50 INFO - mozfile == 1.2 17:38:50 INFO - mozhttpd == 0.7 17:38:50 INFO - mozinfo == 0.9 17:38:50 INFO - mozleak == 0.1 17:38:50 INFO - mozlog == 3.1 17:38:50 INFO - moznetwork == 0.27 17:38:50 INFO - mozprocess == 0.22 17:38:50 INFO - mozprofile == 0.28 17:38:50 INFO - mozrunner == 6.11 17:38:50 INFO - mozscreenshot == 0.1 17:38:50 INFO - mozsystemmonitor == 0.0 17:38:50 INFO - moztest == 0.7 17:38:50 INFO - mozversion == 1.4 17:38:50 INFO - psutil == 3.1.1 17:38:50 INFO - requests == 1.2.3 17:38:50 INFO - wsgiref == 0.1.2 17:38:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:38: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')]} 17:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38: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')]} 17:38:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:50 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 0x1006c4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006cb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3115d4d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100568d30>, '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 0x10038cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10055fb20>, '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.rEm6N21p8q/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.0HqlvT40vD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 17:38:50 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 17:38:50 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 17:38:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rEm6N21p8q/Render', 17:38:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:50 INFO - 'HOME': '/Users/cltbld', 17:38:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:50 INFO - 'LOGNAME': 'cltbld', 17:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:50 INFO - 'MOZ_NO_REMOTE': '1', 17:38:50 INFO - 'NO_EM_RESTART': '1', 17:38:50 INFO - 'PAGER': '/bin/cat', 17:38:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:50 INFO - 'PWD': '/builds/slave/test', 17:38:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:50 INFO - 'SHELL': '/bin/bash', 17:38:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0HqlvT40vD/Listeners', 17:38:50 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 17:38:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:50 INFO - 'USER': 'cltbld', 17:38:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:50 INFO - 'XPC_FLAGS': '0x0', 17:38:50 INFO - 'XPC_SERVICE_NAME': '0', 17:38:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:50 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)) 17:38:50 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)) 17:38:50 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)) 17:38:50 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)) 17:38:50 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)) 17:38:50 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)) 17:38:50 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)) 17:38:50 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)) 17:38:50 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)) 17:38:50 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)) 17:38:50 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)) 17:38:50 INFO - Cleaning up... 17:38:50 INFO - Return code: 0 17:38:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:38: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')]} 17:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38: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')]} 17:38:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1006c4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006cb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3115d4d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100568d30>, '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 0x10038cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10055fb20>, '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.rEm6N21p8q/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.0HqlvT40vD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 17:38:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:38:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:38:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rEm6N21p8q/Render', 17:38:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:50 INFO - 'HOME': '/Users/cltbld', 17:38:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:50 INFO - 'LOGNAME': 'cltbld', 17:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:50 INFO - 'MOZ_NO_REMOTE': '1', 17:38:50 INFO - 'NO_EM_RESTART': '1', 17:38:50 INFO - 'PAGER': '/bin/cat', 17:38:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:50 INFO - 'PWD': '/builds/slave/test', 17:38:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:50 INFO - 'SHELL': '/bin/bash', 17:38:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0HqlvT40vD/Listeners', 17:38:50 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 17:38:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:50 INFO - 'USER': 'cltbld', 17:38:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:50 INFO - 'XPC_FLAGS': '0x0', 17:38:50 INFO - 'XPC_SERVICE_NAME': '0', 17:38:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:50 INFO - Downloading/unpacking jsonschema 17:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:38:52 INFO - Downloading/unpacking functools32 (from jsonschema) 17:38:52 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 17:38:52 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 17:38:52 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 17:38:52 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 17:38:52 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 17:38:52 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 17:38:53 INFO - Downloading functools32-3.2.3-2.tar.gz 17:38:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:38:53 INFO - warning: no files found matching '*.txt' 17:38:53 INFO - no previously-included directories found matching 'build' 17:38:53 INFO - no previously-included directories found matching 'dist' 17:38:53 INFO - no previously-included directories found matching '.git*' 17:38:53 INFO - Installing collected packages: jsonschema, functools32 17:38:53 INFO - Running setup.py install for functools32 17:38:53 INFO - warning: no files found matching '*.txt' 17:38:53 INFO - no previously-included directories found matching 'build' 17:38:53 INFO - no previously-included directories found matching 'dist' 17:38:53 INFO - no previously-included directories found matching '.git*' 17:38:53 INFO - Successfully installed jsonschema functools32 17:38:53 INFO - Cleaning up... 17:38:53 INFO - Return code: 0 17:38:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:38:53 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')]} 17:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:53 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')]} 17:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:53 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 0x1006c4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006cb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3115d4d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100568d30>, '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 0x10038cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10055fb20>, '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.rEm6N21p8q/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.0HqlvT40vD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 17:38:53 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 17:38:53 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 17:38:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rEm6N21p8q/Render', 17:38:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:53 INFO - 'HOME': '/Users/cltbld', 17:38:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:53 INFO - 'LOGNAME': 'cltbld', 17:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:53 INFO - 'MOZ_NO_REMOTE': '1', 17:38:53 INFO - 'NO_EM_RESTART': '1', 17:38:53 INFO - 'PAGER': '/bin/cat', 17:38:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:53 INFO - 'PWD': '/builds/slave/test', 17:38:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:53 INFO - 'SHELL': '/bin/bash', 17:38:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0HqlvT40vD/Listeners', 17:38:53 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 17:38:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:53 INFO - 'USER': 'cltbld', 17:38:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:53 INFO - 'XPC_FLAGS': '0x0', 17:38:53 INFO - 'XPC_SERVICE_NAME': '0', 17:38:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:54 INFO - Downloading/unpacking flake8 17:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:38:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:38:56 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 17:38:56 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 17:38:56 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 17:38:56 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 17:38:56 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 17:38:56 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 17:38:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:38:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:38:56 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 17:38:56 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 17:38:56 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 17:38:56 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 17:38:56 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 17:38:56 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 17:38:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:38:57 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 17:38:57 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 17:38:57 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 17:38:57 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 17:38:57 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 17:38:57 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 17:38:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:38:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:38:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:38:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:38:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:38:57 INFO - no previously-included directories found matching 'docs/_build' 17:38:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:38:57 INFO - Running setup.py install for pep8 17:38:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:38:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:38:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:38:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:38:57 INFO - no previously-included directories found matching 'docs/_build' 17:38:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:38:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:38:57 INFO - Cleaning up... 17:38:57 INFO - Return code: 0 17:38:57 INFO - Running post-action listener: _resource_record_post_action 17:38:57 INFO - Running post-action listener: _start_resource_monitoring 17:38:57 INFO - Starting resource monitoring. 17:38:57 INFO - ##### 17:38:57 INFO - ##### Running install step. 17:38:57 INFO - ##### 17:38:57 INFO - Running pre-action listener: _resource_record_pre_action 17:38:57 INFO - Running main action method: install 17:38:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:38:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:38:58 INFO - Reading from file tmpfile_stdout 17:38:58 INFO - Detecting whether we're running mozinstall >=1.0... 17:38:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:38:58 INFO - Reading from file tmpfile_stdout 17:38:58 INFO - Output received: 17:38:58 INFO - Usage: mozinstall [options] installer 17:38:58 INFO - Options: 17:38:58 INFO - -h, --help show this help message and exit 17:38:58 INFO - -d DEST, --destination=DEST 17:38:58 INFO - Directory to install application into. [default: 17:38:58 INFO - "/builds/slave/test"] 17:38:58 INFO - --app=APP Application being installed. [default: firefox] 17:38:58 INFO - mkdir: /builds/slave/test/build/application 17:38:58 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'] 17:38:58 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 17:39:33 INFO - Reading from file tmpfile_stdout 17:39:33 INFO - Output received: 17:39:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:39:33 INFO - Running post-action listener: _resource_record_post_action 17:39:33 INFO - ##### 17:39:33 INFO - ##### Running run-tests step. 17:39:33 INFO - ##### 17:39:33 INFO - Running pre-action listener: _resource_record_pre_action 17:39:33 INFO - Running main action method: run_tests 17:39:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:39:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:39:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:39:33 INFO - 2016-02-18 17:39:33.698 screenresolution[1653:7577] starting screenresolution argv=screenresolution get 17:39:33 INFO - 2016-02-18 17:39:33.701 screenresolution[1653:7577] Display 0: 1600x1200x32@60 17:39:33 INFO - 2016-02-18 17:39:33.706 screenresolution[1654:7580] starting screenresolution argv=screenresolution list 17:39:33 INFO - Available Modes on Display 0 17:39:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:39:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:39:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:39:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:39:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:39:33 INFO - Intel Iris: 17:39:33 INFO - Chipset Model: Intel Iris 17:39:33 INFO - Type: GPU 17:39:33 INFO - Bus: Built-In 17:39:33 INFO - VRAM (Dynamic, Max): 1536 MB 17:39:33 INFO - Vendor: Intel (0x8086) 17:39:33 INFO - Device ID: 0x0a2e 17:39:33 INFO - Revision ID: 0x0009 17:39:33 INFO - Displays: 17:39:33 INFO - Display: 17:39:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:39:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:39:33 INFO - Display Serial Number: 1600x1200 60 17:39:33 INFO - Main Display: Yes 17:39:33 INFO - Mirror: Off 17:39:33 INFO - Online: Yes 17:39:33 INFO - Rotation: Supported 17:39:33 INFO - Return code: 0 17:39:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:39:33 INFO - Python 2.7.3 17:39:33 INFO - Return code: 0 17:39:33 INFO - grabbing minidump binary from tooltool 17:39:33 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')]} 17:39:33 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 0x100568d30>, '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 0x10038cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10055fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:39:33 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 17:39:33 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 17:39:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:39:34 INFO - Return code: 0 17:39:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:39:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:39:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:39:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:39:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:39:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:39:35 INFO - Return code: 0 17:39:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0146', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:39:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0146 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:39:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rEm6N21p8q/Render', 17:39:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:35 INFO - 'HOME': '/Users/cltbld', 17:39:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:35 INFO - 'LOGNAME': 'cltbld', 17:39:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:39:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:35 INFO - 'MOZ_NO_REMOTE': '1', 17:39:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:39:35 INFO - 'NO_EM_RESTART': '1', 17:39:35 INFO - 'PAGER': '/bin/cat', 17:39:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:35 INFO - 'PWD': '/builds/slave/test', 17:39:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:39:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:35 INFO - 'SHELL': '/bin/bash', 17:39:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0HqlvT40vD/Listeners', 17:39:35 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 17:39:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:35 INFO - 'USER': 'cltbld', 17:39:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:35 INFO - 'XPC_FLAGS': '0x0', 17:39:35 INFO - 'XPC_SERVICE_NAME': '0', 17:39:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0146', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:39:35 INFO - mozversion application_buildid: 20160218155126 17:39:35 INFO - mozversion application_changeset: c34fe673bb97d511920d2986cb84057f62e0c4a0 17:39:35 INFO - mozversion application_display_name: Nightly 17:39:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:39:35 INFO - mozversion application_name: Firefox 17:39:35 INFO - mozversion application_remotingname: firefox 17:39:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:39:35 INFO - mozversion application_vendor: Mozilla 17:39:35 INFO - mozversion application_version: 47.0a1 17:39:35 INFO - mozversion platform_buildid: 20160218155126 17:39:35 INFO - mozversion platform_changeset: c34fe673bb97d511920d2986cb84057f62e0c4a0 17:39:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:39:35 INFO - mozversion platform_version: 47.0a1 17:39:35 INFO - using testdate: 1455845975 17:39:35 INFO - actual date: 1455845975 17:39:35 INFO - starting webserver on 'localhost:49274' 17:39:35 INFO - SUITE-START | Running 2 tests 17:39:35 INFO - TEST-START | dromaeo_css 17:39:35 INFO - operating with platform_type : mac_ 17:39:35 INFO - Initialising browser for dromaeo_css test... 17:39:35 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmp56s6rV/profile http://localhost:49274/getInfo.html) 17:39:38 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 17:39:38 INFO - PROCESS | 1672 | colorDepth:24 17:39:38 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 17:39:38 INFO - PROCESS | 1672 | __metrics 17:39:38 ERROR - PROCESS | 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 17:39:39 INFO - TEST-INFO | 1672: exit 0 17:39:39 INFO - Browser initialized. 17:39:39 INFO - Running cycle 1/1 for dromaeo_css test... 17:39:39 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmp56s6rV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:39:51 INFO - PROCESS | 1676 | RSS: Main: 257097728 17:39:51 INFO - PROCESS | 1676 | 17:40:40 INFO - PROCESS | 1676 | 1455846040825 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] 17:42:51 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 17:42:52 INFO - PROCESS | 1676 | RSS: Main: 269590528 17:42:52 INFO - PROCESS | 1676 | 17:45:54 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 17:45:55 INFO - PROCESS | 1676 | RSS: Main: 279744512 17:45:55 INFO - PROCESS | 1676 | 17:48:57 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 17:48:57 INFO - PROCESS | 1676 | RSS: Main: 281673728 17:48:57 INFO - PROCESS | 1676 | 17:51:59 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 17:51:59 INFO - PROCESS | 1676 | RSS: Main: 284622848 17:51:59 INFO - PROCESS | 1676 | 17:55:02 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 17:55:03 INFO - PROCESS | 1676 | RSS: Main: 287236096 17:55:03 INFO - PROCESS | 1676 | 17:58:05 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 17:58:05 INFO - PROCESS | 1676 | RSS: Main: 288616448 17:58:05 INFO - PROCESS | 1676 | 17:58:05 INFO - PROCESS | 1676 | __start_tp_report 17:58:05 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 17:58:05 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 17:58:05 INFO - PROCESS | 1676 | |i|pagename|runs| 17:58:05 INFO - PROCESS | 1676 | |0;dojo.html;3479.582450105988;3511.420615598425;3528.047427194659;3586.3903136466797;3589.2462582857597;5582.720863956801;5787.189793428924;5788.016037273663;5797.333306669734;5856.6193197442135;4884.706917584947;5640.210370548116;5803.970980145104;5884.588078834483;6014.218151640292;5202.999999999991;5257.842264732064;5286.550643195333;5303.390110137326;5327.254184414166;5313.415524292344;5318.175682769177;5361.892762144755;5363.758630861621;5366.570674346062;5160.458151894053;5172.405173405069;5332.093544097513;5342.626016178869;5393.6763794172475;4349.73857581301;5224.268602395668;5285.577153827685;5298.96670149321;5307.203919412081;5163.199704045841;5214.035403450373;5250.081235783722;5278.5249327560705;5287.074761916688;5623;5698.94569504643;5726.284214473191;5759.740811663443;5763.1355296705415;5204.9739751301;6300.432961033529;6307.211598550181;6311.589746666498;6334.619922804646;5725.599208055438;6244.032175012835;6290.779822706183;6318.083877837734;6325.9051114233325;5282.679330167458;5915.08316210988;5917.349091599921;5937.881242375129;6004.369541198199;6180.752769889244;6214.627122372672;6331.525135614847;6347.016212487072;6384.585001974857;6131.356207598227;6202.751889924442;6207.472364848948;6216.098665693539;6219.036049412348;5317.41508434072;6245.000799871998;6267.19672808152;6287.874242515124;6312;5146.330976973044;6136.355682653347;6168.753249870045;6244.875102497925;6288.088227207029;6279.246490421178;6285.96857015712;6290.119383286344;6308.747650093945;6325.715342809584;4705.388299521109;4905.068037072945;4928.556429921325;4931.235658472942;4977.552020318189;4325.5674432557125;4375.124975004948;4386.342048692658;4420.7126536775;4465.575770301816;5559;5704.258446402024;5770.942290577124;5838.795642152504;5848.444397782204;6191.25704915404;6229.50163986889;6292.244930608356;6299.433051025429;6306;5773.8556536086935;5809.8547536311935;5823.4467725566;5838.970805145947;5855.795047173328;5424.728763561806;5445.700486473203;5449.373322068013;5450.509454149145;5452.236686863842;6229.159063526366;6363.109164716943;6417.26201486835;6439.356064393523;6449.5485316027425;6265.937340626535;6280.246370435577;6299.67706781581;6301.086342480223;6309.4952403806665;6237.75048998035;6422.325655806073;6432.710528026157;6433.903491447726;6439.484841212598;6113.172264937315;6162.691865406622;6192.907106393318;6206.10011548332;6219.471344935731;6243.37566243372;6266.624002559861;6288.591241569284;6292;6294.433500984934;6054.939450605438;6152.230971128609;6152.354002829638;6178.980468222872;6212.912740270525;6153.600015998945;6183.297725586132;6212.347703491068;6236.18929539157;6237.157983672146;5986.981795398468;6027;6032.547558933185;6064.727087281171;6139.416755408229;5279.419263880894;6042.640405908811;6055.545834062551;6186;6204.689765511796;6024.186734790923;6063.029915213545;6071.605345652519;6073.423024812636;6086.6652334122045 17:58:05 INFO - PROCESS | 1676 | |1;ext.html;414.61647975622543;467.411062061802;489.95883747037533;513.1328055586059;518.8843985431323;36881.815590922044;37075.443868341994;37343.4398484023;37346.25307493852;37606.4359034614;38608.613913860856;39106;39163;39196;39344;7464.77605671828;8016.719414820483;8077.374853172713;9211.539423028838;9308.208802251816;8206.343492520615;9544.904550954505;9705.514724263794;9721.368111072794;9772.609095636166;9508;9646.61413543461;9722.659706910259;9761;9769.804603907918;8409.285210757092;9658.855117173249;9714.90285097147;9721.125098741077;9726.17327527161;9575.377600455948;9679;9733.56198971048;9748;9754.122129008423;37669;37985.620143798486;38140.23719525622;38529;38573.614263857286;3092.8453577321043;3189.6969787870116;3198.4722520784044;3200.3279311344645;3207.631122420928;28498.145055648365;28529;29081.709182908322;30024;30265.848670756506;2768.2525718056013;2814.4652516021893;2830;2856.5286727689904;2939.6766355700856;508757;508820;510824;512729;512764;57501.13748293779;57799.422005780245;64621.03068453977;65156;65223;62471.375286247465;62708;62709.68645156745;62816;62968.370316297165;16027.759583606256;16247.756283655755;16264.593385165466;16279.755803662954;16292.940958837638;12079.51681932713;12273.202241854251;12358.196717213352;12370.876291236973;12381.00951923844;16479.588010299838;20578.794212057688;20710.17159313641;21265.68101478479;21268.680969785466;7788.688452461952;7979.760607181794;8895.28837692983;8902.332325075646;8933.330000250007;964.5002021856081;978.7650963768787;1002.6791426743519;1065.6909496246158;1132.4620805117504;29803.85098074496;29815.254618634273;29885.551716724265;29948;31344;928.4614923344444;1062.9574817007388;1070.3363914372983;1133.3369978562469;1168.0772189969828;14524.419023238952;14540.636484087983;14686;14747.41010359595;14849.554513364616;614537;619642;623993;627385;627818;55680.886382272125;57137.14294285589;57668.134977975365;58417;58599.70700146472;1424.2309153057233;1432.9856701432852;1453.4186325469684;1454.5999850041112;1540.2914659256644;22050.779492204874;27920;28995.550222488368;29560.5964467001;29842.850785745934;50280.49719502904;50447.991040179724;50931.745341273054;51034.97930041304;51082.23376649279;503353;508082;508139;508603;509579;26474.338141546614;44874;45694.771526142154;46785.830354241414;47013.76493117512;43316;43413.91465213395;43820.78089609532;43908.78045609751;43990.90022749457;36876.446853297755;37438.251234975694;38204.80897595494;38395.80802096083;39252;34520.30959380849;34746.47880281747;34913.47629785504;35199;35275;34056;34243.972680819614;34864;34991;35052.12369690778;31551.684483154873;31956.881509147068;32242.193945151557;33736.49395259024;34412.24702023882;19643.60712785765;21128.471788204803;21560.490765646253;23832.761672383054;23878.283651490485 17:58:05 INFO - PROCESS | 1676 | |2;jquery.html;349.577011815703;351.7748640869843;355.1069061310804;358.60016082068483;359.91126841305066;15915.363385464567;19564.413067607977;20017.899015554176;20214.89892550537;21333.466663333405;20107.59784804303;20299.289524866632;20539.486512837186;20795;20881.26915557952;5598.216249725052;5658.179563963223;5883.705814709268;5914.556408269375;5924.585279030448;5759.395263497336;5768;5849.561282903799;5886.117082437647;5893.292804863422;4118.485189351331;5639.182318563806;5779.884402311972;5823.0391985322585;6134.969325153368;6186.721597528122;6307.463865571432;6378.425941665249;6379.075034120026;6382.234131904178;5402.243685883979;5456.809011684572;5463.672179669233;5484.040292948718;5492.148716948879;12425.875741242562;12968.935155324163;25085.12202072937;25575;25587.104451344112;2091.8640288381207;2132.6694362373855;2219.8002179803893;2453.55835949529;2505.9749402506104;9458.479783611898;9744.31789774716;9983.00169983003;11466.885331146665;14669.92665036668;1690;1717.9692184689086;1791.2655811117509;1799.8920064796155;1850.7964123946356;96261;104067;106117.46941265321;106489;107395;9322;11360.659180224606;11425.428728563538;11476.4835582399;11537.250078745023;13323.666908327175;13539;13553.525626603021;13559.25424101664;13611.727765444833;8399.286060684788;8409.41134120618;8472.872906906401;8483.27892129176;8510.191531804468;8602.35482338827;8687.695930642398;8691.870056892563;8754.824903501894;8767.12328767131;4357.912841743211;4449.1101779644205;4463.933041004388;4470.173017991682;4505.414296141546;1867.8785878917827;1887.2828325236596;1917.4822797844504;1920.846332293413;1926.80731926809;385.6875930496307;394.5778017521282;407.1246819338446;412.70285394516503;414.32671908149257;8838.248748856291;11699.23954942926;11805.586804461802;11932.761344773056;11949.761004779855;419.0759375576846;421.0778395314252;434.20540411047705;437.7417323778922;442.57512787723505;4670.392848929685;5653.614864358258;5804.564657650693;6139.754409823647;6223.62658240498;631019;632767;649124;651255;653181;111337.44331278291;118231.40884295524;119880.80119198696;120099.39950300193;124380;454.1711376737467;458.16385097197747;981.215027977615;1025.8563801067708;1038.3977293169944;14239.928800355932;16906;17292.913535432242;17607.735883962006;17824.732629010836;27687;43785.90535236645;44156;44171.674849754556;45053;45838.77080614575;49376.753116235624;64884.675576623704;66842.66578667075;67676;6307.873842523216;7515.8872616911885;7674.462787605037;7682.923170768221;7794.766157015299;9159.816803663756;10444.947775261075;11935.582254621047;12369;12452.875471245172;10493.422861742372;10771.246012779031;10819.296745711503;10859.294145880809;11043.613473528389;10497.895021049691;10590.89409105899;10806.027457528546;11034.779304414027;11073.944630276797;8045.477043992122;10727.034566889017;11058.557657693602;11410;11487.712807179552;7804.517141743051;7888.566128862968;7997.160298168841;8006.759797206093;8026.83946321082;7643.923560764321;11098.722531936766;11110.333379997226;11197.776044478902;11206.719832004264 17:58:05 INFO - PROCESS | 1676 | |3;mootools.html;1509.8112735908012;1530.0513681517457;1682.4363838114223;1747.2312182639637;1766.1875537252863;7813.101493328269;8378.95810520948;8575.099614540477;8741.038485766569;8753.562321883895;8471.195236452542;8511.574421278941;8546.658133674646;8566.35752318577;8583.141685831413;2130.435434609822;2410.7589241075884;2424.284835973392;2426.5874801283735;2476.4675594747127;2451.154351748653;2472.8887200076038;2477.541654793869;2494.638277449769;2500.8871052381696;2157.9568408631817;2379.4765151666606;2457.7050753909466;2481.888315025828;2489.166129346671;2393.7845593896545;2398.70016247969;2402.087206861399;2434.7443518430578;2434.8782560871973;2035.460602940222;2417.468157005456;2422.551827911842;2428.7085549734147;2431.209856796548;8466.111058338909;8504.362172837062;8537.445066070686;8538.61576229065;8595.613197406132;5297.735113244323;5416.593755468316;5439.156930675752;5461.644993075437;5474.835754927359;2641.603759436081;3557.1640664443835;3615.728820338485;3669.743117981742;3680.7975561344115;1045.3257648816548;1051.2431049644244;1078.309881675728;1085.9728506787314;1086.2830531848942;11453.911878371542;11536.307821530734;11661.416929153593;11680.649580512598;11701.2979221247;4825.662203645781;4849.684770489906;4886.877828054256;4928.310036594879;4961.751912404366;10088.394696318244;10214.438205898747;10229.488525573692;10232.283740138268;10233.181345492343;5399.4600539945695;5446.128619420873;5451.591130665216;5468.808591699271;5511.090670039399;4904.362432883702;4944.826931057396;4987.551120399182;4993.725345105981;4996.125678006334;3984.442178095069;3993.381025940984;4003.979980100081;4020.8994775130855;4034.253663072341;1213.0962432987305;1294.4175121195312;1320.1880843281313;1338.3375229261578;1355.2207480698637;1090.9181811364178;1107.4905543450104;1132.7960967026015;1247.1706315300405;1328.7209685965863;6435.195600549931;7857.528548287121;7929.960350198212;8003.119656837744;8046.637901294456;1162.436218434059;1164.7437563735964;1176.1179115663253;1176.8293597428326;1190.0301254477572;5488.451154884479;6185.876282474415;6257.68711564429;6279.529035322278;6289.119523266746;10097.343672661253;10731.141508679288;10731.463426828628;10809.621663241749;10835.404052777016;10330.535125919201;10487.108595769292;10547.947260263649;10645.78708425827;10691.198160138021;8160.836783264302;8201.22088401601;8286.337093032544;8309.961254843145;8323.750287491384;7794.376449884109;7833.764987050397;7845.097813751491;7878.606069696607;8044.235797599219;9215.216706580015;9275.07249275094;9286.860697089414;9375.85936210971;9471.810563788547;9502.429854208769;9538.570764315484;9724.9027509724;9738.464384458923;9756.512174391393;7476.5514069156025;7522.134954480305;7639.274268944441;7647.579383133981;7656.73201437947;6864.965675171592;6899.930510770839;8161.571724947991;8189.959050204711;8240.381971352053;6699;7412.4070074394995;7544.358729508053;7659.348955338859;7670.961645191738;7246.818829529304;7251.419886408969;7261.092363454568;7288.927110728825;7372.48392612512;7532.5857077859055;7572.8485430292185;7645.5794931279315;7683.500572462772;7704.229577042251;6846.554973926679;6968.268331825086;6977.162740471176;6986.510944233854;6999.895001574879;7034.191068027242;7089.468289878383;7120.216776154515;7120.679569419285;7132.108486439195 17:58:05 INFO - PROCESS | 1676 | |4;prototype.html;323.55672728362146;327.6903326356593;332.5560376896843;332.6955835410599;338;6866.073080134181;6949.895751563718;6976.686049127782;6984.406325462335;7031.4374850012;7029.297070292968;7029.718811247557;7034.788956331318;7046.894296585555;7054.57672539648;4182.665386769067;4924.827631032915;5189.922151167735;5191.714455704935;5198.662086964354;4218.346156345771;4861.756912154396;5192.169252919533;5193.63644544882;5195.064888320101;4960.553550180483;4965.975170124162;4966.478519755427;4969.701817890938;4977.402711674586;4943.233798761198;4951.777170027357;4954.7522623868845;4978.751062446863;4980.153373926441;4026.6577340926056;4129.834806607732;4202.789860506993;4214.789260536961;4225.239456897757;6514.93485065148;6557.213134423852;6650.634215118166;6673.0991316172185;6675.532712710112;5919.940800591982;5926.348101708809;5932.169496270526;5935.49548288396;5939.2575928009;5868.708884045546;7094.929050709478;7356.264373562654;7389.630518474055;7406.777796666055;4549.363089167519;4692.95307046932;4694.718316900997;4705.623550115983;4708.387909571734;7766.262205090507;7835.255650713173;7839.059312882434;7849.215078492162;7867.055953285585;4624.884377890579;4751.287306903923;4751.3348131261655;4759.928601070987;4808.158572249912;4874.707517548958;4887.36464259644;4893.314935908976;4894.632902532253;4903.558679718771;5886.411358864079;5889.087191485327;5905.4685078343155;5909.202257695156;5913.29040515141;5994.790182343597;6935.375816176568;7456.701731930662;7473.215312392121;7478.252174782587;1419.771897308841;1451.252604908473;1726.3094762095263;1727.2313820350075;1730.5846596816673;1073.8711354637337;1076.1229597877705;1082.9891701083045;1089.6839916424308;1091.737982884118;6313.905291420632;6758.357955994173;7123.928760712327;7147.53541019832;7171.462140339391;6576.736930522821;8014.879776803353;8018.158093400226;8026.638801253957;8074.192580741878;5101.923471147936;5909.704514774244;6780.7287708492095;7041.260667629927;7158.749443769443;3353.3628610563915;3388.4917262410836;4081.0613558881623;4229.259879521133;4276.123394704078;8364.330853531703;8367.414281000272;8388.8741668875;8424.663013479514;8424.83150337002;8166.959165204136;8369.623366948503;8431.325493960469;8442.662293508314;8471.872921906177;8554.18735220153;8568.10034946334;8572.014218364842;8583.141685831491;8595.52724600153;8113.6754529818145;8122.5126492410645;8123.147069557612;8127.024757029194;8134.593270336341;7425.294597013275;7730.613469326624;7732.768016959275;7736.651850666621;7961.8407631848195;8196.508209507449;8205.179482051746;8217.95891020541;8228.917710822816;8247.711330103417;4789.592884604708;4840.152973229741;4847.951520484891;4848.466668666514;4856.854294371175;7493.662785174572;7830.960845195737;7835.725749598737;7852.390259996801;7856.45004849655;7449.217832127549;7484.101907771103;7501.1373692023935;7520.8495830082;7524.887126693214;6153.84615384619;6432.742690292524;7249.238829922993;7522.736704215326;7535.321821036133;6343.779677113158;7268.709251630087;7321.78034658961;7337.266273372834;7347.08161479815;6956.782563051547;7491.850162996819;7509.324160825552;7518.548887066575;7522.548647080974;6297.52768542352;7362.263773622595;7366.079240094989;7373.677291653112;7383.446241532014 17:58:05 INFO - PROCESS | 1676 | |5;yui.html;669.6116252573506;670.966451677416;696.4289282788116;728.8105092675909;731.1701219116304;13631.454741810328;13772.035957482967;13835.654108647288;13920.860791392082;13931.164130152185;13733.862661373383;15509.612259693513;15737.763933540977;15753.133577653225;15790.210489475508;698.1308271202334;851.4508142248246;854.5855260198798;873.5413907698477;878.6265837019241;869.6825658634584;869.8042940338437;877.368294827723;879.3404946290283;881.8192270584515;815.6615004773012;880.6521424037502;901.2744740483907;908.68650315641;923.2890674180877;904.5386852705102;910.5902343945252;915.7069737683944;917.7705573606565;919.3013309884469;661.8841702702008;669;671.7078071039114;672.8755180291662;676.4419354032942;12597.811032834516;14973.550793476214;15029.94790364675;15193.924030379889;15252.161131137784;12333.62999110028;12405.387299650987;12480.687982800411;12574.43415046325;12674.239545627292;8152.470089444227;9245.72262832116;9387.953060234655;10095.091441770275;10132.898671013343;2960.555916612504;3412.5904891412943;3461.100113970386;3514.332276867387;3515.5781306243416;65534.01698974519;77565;80303;81491.7776233357;82181;7177.9641101795205;7740.922590774133;8111.756647300473;9556.58939440733;9592.376495527908;19556.119974601177;20075.799242007684;20096;20137.19451221964;20173;6597.60414375139;7273.818154546073;7427.554346739213;7470.626468676544;7629.771106866803;3685.5761587417255;4098.241825262336;4132.152908653718;4136.358864376027;4208.179405015992;3475.652434756504;3511.701505372072;3517.278957813642;3521.137321356233;3527.1182204448887;639.4979940746491;644.7936660268668;647.1069923505532;671.7783131566669;673.989016475287;487.3469550801942;528.2129626855957;587.4712758517369;610.6580315023601;616.4113271825396;8119.634616442156;8674.86987695185;9043.959944606322;9102.544872756336;9239.445633262027;481.8217259613895;514.9433562308143;539.2854467830141;539.7301349325337;558.8435238133247;3807.5621303550447;3992.3660698713566;4003.3394489908837;4040.3535434330365;4150.232207041707;97012.51493742627;97947;99530.50704239443;100092.49953750185;100978.98042039118;61644;79740;80176.99557511108;80401.59799201084;81033.59483202547;68809;69997.30002700009;70655.64672176607;71740;73511.89732154022;6302.779402720883;8011.278984891388;8314.958425207835;8330.798118787821;8381.916180838358;49296.26055609097;50952.471425857286;51246.74376628093;51475.48524514707;51521;52562.474375255755;68061;71585.6420717893;73369.89945150934;76814;10883.367494875833;11216.158788091088;11327.603533876274;11436.1422893285;11802.52789888395;12120.636380908587;12218.20581662189;12320.075994300285;12399.504019839105;12713.11008229415;11026.558937642405;11417.828732569184;11617.941910290394;11658.95069443754;11777.293362398283;9351.812963740551;10633.787324253626;10974.640452302794;11217.383043932661;11577.073834093084;11155.609553665583;11485.081193504666;11505.367204803817;11538.538458461568;11761;8276.337892968668;9216.539173041187;9609.807803844024;9802.950985245314;9853.359531630422;9627.855582166414;9985.400875947467;9997.250206234416;9999.55002024896;10019.298649094493 17:58:05 INFO - PROCESS | 1676 | __end_tp_report 17:58:05 INFO - PROCESS | 1676 | __start_cc_report 17:58:05 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,359 17:58:05 INFO - PROCESS | 1676 | __end_cc_report 17:58:05 INFO - PROCESS | 1676 | __startTimestamp1455847085835__endTimestamp 17:58:05 INFO - PROCESS | 1676 | 17:58:05 INFO - PROCESS | 1676 | ------- Summary: start ------- 17:58:05 INFO - PROCESS | 1676 | Number of tests: 6 17:58:05 INFO - PROCESS | 1676 | 17:58:05 INFO - PROCESS | 1676 | [#0] dojo.html Cycles:165 Average:5768.03 Median:6027.00 stddev:646.68 (10.7%) stddev-sans-first:623.24 17:58:05 INFO - PROCESS | 1676 | Values: 3479.6 3511.4 3528.0 3586.4 3589.2 5582.7 5787.2 5788.0 5797.3 5856.6 4884.7 5640.2 5804.0 5884.6 6014.2 5203.0 5257.8 5286.6 5303.4 5327.3 5313.4 5318.2 5361.9 5363.8 5366.6 5160.5 5172.4 5332.1 5342.6 5393.7 4349.7 5224.3 5285.6 5299.0 5307.2 5163.2 5214.0 5250.1 5278.5 5287.1 5623.0 5698.9 5726.3 5759.7 5763.1 5205.0 6300.4 6307.2 6311.6 6334.6 5725.6 6244.0 6290.8 6318.1 6325.9 5282.7 5915.1 5917.3 5937.9 6004.4 6180.8 6214.6 6331.5 6347.0 6384.6 6131.4 6202.8 6207.5 6216.1 6219.0 5317.4 6245.0 6267.2 6287.9 6312.0 5146.3 6136.4 6168.8 6244.9 6288.1 6279.2 6286.0 6290.1 6308.7 6325.7 4705.4 4905.1 4928.6 4931.2 4977.6 4325.6 4375.1 4386.3 4420.7 4465.6 5559.0 5704.3 5770.9 5838.8 5848.4 6191.3 6229.5 6292.2 6299.4 6306.0 5773.9 5809.9 5823.4 5839.0 5855.8 5424.7 5445.7 5449.4 5450.5 5452.2 6229.2 6363.1 6417.3 6439.4 6449.5 6265.9 6280.2 6299.7 6301.1 6309.5 6237.8 6422.3 6432.7 6433.9 6439.5 6113.2 6162.7 6192.9 6206.1 6219.5 6243.4 6266.6 6288.6 6292.0 6294.4 6054.9 6152.2 6152.4 6179.0 6212.9 6153.6 6183.3 6212.3 6236.2 6237.2 5987.0 6027.0 6032.5 6064.7 6139.4 5279.4 6042.6 6055.5 6186.0 6204.7 6024.2 6063.0 6071.6 6073.4 6086.7 17:58:05 INFO - PROCESS | 1676 | 17:58:05 INFO - PROCESS | 1676 | [#1] ext.html Cycles:180 Average:68121.54 Median:38551.31 stddev:146709.43 (380.6%) stddev-sans-first:147032.92 17:58:05 INFO - PROCESS | 1676 | Values: 414.6 467.4 490.0 513.1 518.9 36881.8 37075.4 37343.4 37346.3 37606.4 38608.6 39106.0 39163.0 39196.0 39344.0 7464.8 8016.7 8077.4 9211.5 9308.2 8206.3 9544.9 9705.5 9721.4 9772.6 9508.0 9646.6 9722.7 9761.0 9769.8 8409.3 9658.9 9714.9 9721.1 9726.2 9575.4 9679.0 9733.6 9748.0 9754.1 37669.0 37985.6 38140.2 38529.0 38573.6 3092.8 3189.7 3198.5 3200.3 3207.6 28498.1 28529.0 29081.7 30024.0 30265.8 2768.3 2814.5 2830.0 2856.5 2939.7 508757.0 508820.0 510824.0 512729.0 512764.0 57501.1 57799.4 64621.0 65156.0 65223.0 62471.4 62708.0 62709.7 62816.0 62968.4 16027.8 16247.8 16264.6 16279.8 16292.9 12079.5 12273.2 12358.2 12370.9 12381.0 16479.6 20578.8 20710.2 21265.7 21268.7 7788.7 7979.8 8895.3 8902.3 8933.3 964.5 978.8 1002.7 1065.7 1132.5 29803.9 29815.3 29885.6 29948.0 31344.0 928.5 1063.0 1070.3 1133.3 1168.1 14524.4 14540.6 14686.0 14747.4 14849.6 614537.0 619642.0 623993.0 627385.0 627818.0 55680.9 57137.1 57668.1 58417.0 58599.7 1424.2 1433.0 1453.4 1454.6 1540.3 22050.8 27920.0 28995.6 29560.6 29842.9 50280.5 50448.0 50931.7 51035.0 51082.2 503353.0 508082.0 508139.0 508603.0 509579.0 26474.3 44874.0 45694.8 46785.8 47013.8 43316.0 43413.9 43820.8 43908.8 43990.9 36876.4 37438.3 38204.8 38395.8 39252.0 34520.3 34746.5 34913.5 35199.0 35275.0 34056.0 34244.0 34864.0 34991.0 35052.1 31551.7 31956.9 32242.2 33736.5 34412.2 19643.6 21128.5 21560.5 23832.8 23878.3 17:58:05 INFO - PROCESS | 1676 | 17:58:05 INFO - PROCESS | 1676 | [#2] jquery.html Cycles:180 Average:33985.07 Median:400.85 stddev:106493.38 (26566.8%) stddev-sans-first:106762.17 17:58:05 INFO - PROCESS | 1676 | Values: 349.6 351.8 355.1 358.6 359.9 15915.4 19564.4 20017.9 20214.9 21333.5 20107.6 20299.3 20539.5 20795.0 20881.3 5598.2 5658.2 5883.7 5914.6 5924.6 5759.4 5768.0 5849.6 5886.1 5893.3 4118.5 5639.2 5779.9 5823.0 6135.0 6186.7 6307.5 6378.4 6379.1 6382.2 5402.2 5456.8 5463.7 5484.0 5492.1 12425.9 12968.9 25085.1 25575.0 25587.1 2091.9 2132.7 2219.8 2453.6 2506.0 9458.5 9744.3 9983.0 11466.9 14669.9 1690.0 1718.0 1791.3 1799.9 1850.8 96261.0 104067.0 106117.5 106489.0 107395.0 9322.0 11360.7 11425.4 11476.5 11537.3 13323.7 13539.0 13553.5 13559.3 13611.7 8399.3 8409.4 8472.9 8483.3 8510.2 8602.4 8687.7 8691.9 8754.8 8767.1 4357.9 4449.1 4463.9 4470.2 4505.4 1867.9 1887.3 1917.5 1920.8 1926.8 385.7 394.6 407.1 412.7 414.3 8838.2 11699.2 11805.6 11932.8 11949.8 419.1 421.1 434.2 437.7 442.6 4670.4 5653.6 5804.6 6139.8 6223.6 631019.0 632767.0 649124.0 651255.0 653181.0 111337.4 118231.4 119880.8 120099.4 124380.0 454.2 458.2 981.2 1025.9 1038.4 14239.9 16906.0 17292.9 17607.7 17824.7 27687.0 43785.9 44156.0 44171.7 45053.0 45838.8 49376.8 64884.7 66842.7 67676.0 6307.9 7515.9 7674.5 7682.9 7794.8 9159.8 10444.9 11935.6 12369.0 12452.9 10493.4 10771.2 10819.3 10859.3 11043.6 10497.9 10590.9 10806.0 11034.8 11073.9 8045.5 10727.0 11058.6 11410.0 11487.7 7804.5 7888.6 7997.2 8006.8 8026.8 7643.9 11098.7 11110.3 11197.8 11206.7 17:58:05 INFO - PROCESS | 1676 | 17:58:05 INFO - PROCESS | 1676 | [#3] mootools.html Cycles:180 Average:5987.44 Median:5348.60 stddev:3131.78 (58.6%) stddev-sans-first:3122.48 17:58:05 INFO - PROCESS | 1676 | Values: 1509.8 1530.1 1682.4 1747.2 1766.2 7813.1 8379.0 8575.1 8741.0 8753.6 8471.2 8511.6 8546.7 8566.4 8583.1 2130.4 2410.8 2424.3 2426.6 2476.5 2451.2 2472.9 2477.5 2494.6 2500.9 2158.0 2379.5 2457.7 2481.9 2489.2 2393.8 2398.7 2402.1 2434.7 2434.9 2035.5 2417.5 2422.6 2428.7 2431.2 8466.1 8504.4 8537.4 8538.6 8595.6 5297.7 5416.6 5439.2 5461.6 5474.8 2641.6 3557.2 3615.7 3669.7 3680.8 1045.3 1051.2 1078.3 1086.0 1086.3 11453.9 11536.3 11661.4 11680.6 11701.3 4825.7 4849.7 4886.9 4928.3 4961.8 10088.4 10214.4 10229.5 10232.3 10233.2 5399.5 5446.1 5451.6 5468.8 5511.1 4904.4 4944.8 4987.6 4993.7 4996.1 3984.4 3993.4 4004.0 4020.9 4034.3 1213.1 1294.4 1320.2 1338.3 1355.2 1090.9 1107.5 1132.8 1247.2 1328.7 6435.2 7857.5 7930.0 8003.1 8046.6 1162.4 1164.7 1176.1 1176.8 1190.0 5488.5 6185.9 6257.7 6279.5 6289.1 10097.3 10731.1 10731.5 10809.6 10835.4 10330.5 10487.1 10547.9 10645.8 10691.2 8160.8 8201.2 8286.3 8310.0 8323.8 7794.4 7833.8 7845.1 7878.6 8044.2 9215.2 9275.1 9286.9 9375.9 9471.8 9502.4 9538.6 9724.9 9738.5 9756.5 7476.6 7522.1 7639.3 7647.6 7656.7 6865.0 6899.9 8161.6 8190.0 8240.4 6699.0 7412.4 7544.4 7659.3 7671.0 7246.8 7251.4 7261.1 7288.9 7372.5 7532.6 7572.8 7645.6 7683.5 7704.2 6846.6 6968.3 6977.2 6986.5 6999.9 7034.2 7089.5 7120.2 7120.7 7132.1 17:58:05 INFO - PROCESS | 1676 | 17:58:05 INFO - PROCESS | 1676 | [#4] prototype.html Cycles:180 Average:6075.93 Median:6769.54 stddev:2046.52 (30.2%) stddev-sans-first:2006.19 17:58:05 INFO - PROCESS | 1676 | Values: 323.6 327.7 332.6 332.7 338.0 6866.1 6949.9 6976.7 6984.4 7031.4 7029.3 7029.7 7034.8 7046.9 7054.6 4182.7 4924.8 5189.9 5191.7 5198.7 4218.3 4861.8 5192.2 5193.6 5195.1 4960.6 4966.0 4966.5 4969.7 4977.4 4943.2 4951.8 4954.8 4978.8 4980.2 4026.7 4129.8 4202.8 4214.8 4225.2 6514.9 6557.2 6650.6 6673.1 6675.5 5919.9 5926.3 5932.2 5935.5 5939.3 5868.7 7094.9 7356.3 7389.6 7406.8 4549.4 4693.0 4694.7 4705.6 4708.4 7766.3 7835.3 7839.1 7849.2 7867.1 4624.9 4751.3 4751.3 4759.9 4808.2 4874.7 4887.4 4893.3 4894.6 4903.6 5886.4 5889.1 5905.5 5909.2 5913.3 5994.8 6935.4 7456.7 7473.2 7478.3 1419.8 1451.3 1726.3 1727.2 1730.6 1073.9 1076.1 1083.0 1089.7 1091.7 6313.9 6758.4 7123.9 7147.5 7171.5 6576.7 8014.9 8018.2 8026.6 8074.2 5101.9 5909.7 6780.7 7041.3 7158.7 3353.4 3388.5 4081.1 4229.3 4276.1 8364.3 8367.4 8388.9 8424.7 8424.8 8167.0 8369.6 8431.3 8442.7 8471.9 8554.2 8568.1 8572.0 8583.1 8595.5 8113.7 8122.5 8123.1 8127.0 8134.6 7425.3 7730.6 7732.8 7736.7 7961.8 8196.5 8205.2 8218.0 8228.9 8247.7 4789.6 4840.2 4848.0 4848.5 4856.9 7493.7 7831.0 7835.7 7852.4 7856.5 7449.2 7484.1 7501.1 7520.8 7524.9 6153.8 6432.7 7249.2 7522.7 7535.3 6343.8 7268.7 7321.8 7337.3 7347.1 6956.8 7491.9 7509.3 7518.5 7522.5 6297.5 7362.3 7366.1 7373.7 7383.4 17:58:05 INFO - PROCESS | 1676 | 17:58:05 INFO - PROCESS | 1676 | [#5] yui.html Cycles:180 Average:18326.86 Median:33973.39 stddev:26179.79 (77.1%) stddev-sans-first:26219.66 17:58:05 INFO - PROCESS | 1676 | Values: 669.6 671.0 696.4 728.8 731.2 13631.5 13772.0 13835.7 13920.9 13931.2 13733.9 15509.6 15737.8 15753.1 15790.2 698.1 851.5 854.6 873.5 878.6 869.7 869.8 877.4 879.3 881.8 815.7 880.7 901.3 908.7 923.3 904.5 910.6 915.7 917.8 919.3 661.9 669.0 671.7 672.9 676.4 12597.8 14973.6 15029.9 15193.9 15252.2 12333.6 12405.4 12480.7 12574.4 12674.2 8152.5 9245.7 9388.0 10095.1 10132.9 2960.6 3412.6 3461.1 3514.3 3515.6 65534.0 77565.0 80303.0 81491.8 82181.0 7178.0 7740.9 8111.8 9556.6 9592.4 19556.1 20075.8 20096.0 20137.2 20173.0 6597.6 7273.8 7427.6 7470.6 7629.8 3685.6 4098.2 4132.2 4136.4 4208.2 3475.7 3511.7 3517.3 3521.1 3527.1 639.5 644.8 647.1 671.8 674.0 487.3 528.2 587.5 610.7 616.4 8119.6 8674.9 9044.0 9102.5 9239.4 481.8 514.9 539.3 539.7 558.8 3807.6 3992.4 4003.3 4040.4 4150.2 97012.5 97947.0 99530.5 100092.5 100979.0 61644.0 79740.0 80177.0 80401.6 81033.6 68809.0 69997.3 70655.6 71740.0 73511.9 6302.8 8011.3 8315.0 8330.8 8381.9 49296.3 50952.5 51246.7 51475.5 51521.0 52562.5 68061.0 71585.6 73369.9 76814.0 10883.4 11216.2 11327.6 11436.1 11802.5 12120.6 12218.2 12320.1 12399.5 12713.1 11026.6 11417.8 11617.9 11659.0 11777.3 9351.8 10633.8 10974.6 11217.4 11577.1 11155.6 11485.1 11505.4 11538.5 11761.0 8276.3 9216.5 9609.8 9803.0 9853.4 9627.9 9985.4 9997.3 9999.6 10019.3 17:58:05 INFO - PROCESS | 1676 | -------- Summary: end -------- 17:58:05 INFO - PROCESS | 1676 | 17:58:06 INFO - TEST-INFO | 1676: exit 0 17:58:06 INFO - TEST-OK | dromaeo_css | took 1110869ms 17:58:06 INFO - TEST-START | kraken 17:58:06 INFO - operating with platform_type : mac_ 17:58:06 INFO - Initialising browser for kraken test... 17:58:06 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpCKxbSC/profile http://localhost:49274/getInfo.html) 17:58:09 INFO - PROCESS | 1685 | __metrics Screen width/height:1600/1200 17:58:09 INFO - PROCESS | 1685 | colorDepth:24 17:58:09 INFO - PROCESS | 1685 | Browser inner width/height: 1024/689 17:58:09 INFO - PROCESS | 1685 | __metrics 17:58:09 ERROR - PROCESS | 1685 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 17:58:09 INFO - TEST-INFO | 1685: exit 0 17:58:09 INFO - Browser initialized. 17:58:09 INFO - Running cycle 1/1 for kraken test... 17:58:09 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpCKxbSC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:58:22 INFO - PROCESS | 1688 | RSS: Main: 256425984 17:58:22 INFO - PROCESS | 1688 | 17:58:24 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 17:58:25 INFO - PROCESS | 1688 | RSS: Main: 267816960 17:58:25 INFO - PROCESS | 1688 | 17:58:28 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 17:58:28 INFO - PROCESS | 1688 | RSS: Main: 276508672 17:58:28 INFO - PROCESS | 1688 | 17:58:32 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 17:58:32 INFO - PROCESS | 1688 | RSS: Main: 280895488 17:58:32 INFO - PROCESS | 1688 | 17:58:34 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 17:58:35 INFO - PROCESS | 1688 | RSS: Main: 281993216 17:58:35 INFO - PROCESS | 1688 | 17:58:37 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:58:37 INFO - PROCESS | 1688 | RSS: Main: 282935296 17:58:37 INFO - PROCESS | 1688 | 17:58:40 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 17:58:41 INFO - PROCESS | 1688 | RSS: Main: 282750976 17:58:41 INFO - PROCESS | 1688 | 17:58:44 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 17:58:44 INFO - PROCESS | 1688 | RSS: Main: 282644480 17:58:44 INFO - PROCESS | 1688 | 17:58:47 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 17:58:48 INFO - PROCESS | 1688 | RSS: Main: 282988544 17:58:48 INFO - PROCESS | 1688 | 17:58:49 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:58:50 INFO - PROCESS | 1688 | RSS: Main: 284180480 17:58:50 INFO - PROCESS | 1688 | 17:58:52 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:58:52 INFO - PROCESS | 1688 | RSS: Main: 284024832 17:58:52 INFO - PROCESS | 1688 | 17:58:54 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:58:55 INFO - PROCESS | 1688 | RSS: Main: 284286976 17:58:55 INFO - PROCESS | 1688 | 17:58:58 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:58:58 INFO - PROCESS | 1688 | RSS: Main: 283090944 17:58:58 INFO - PROCESS | 1688 | 17:59:01 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:59:01 INFO - PROCESS | 1688 | RSS: Main: 284565504 17:59:01 INFO - PROCESS | 1688 | 17:59:03 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 17:59:03 INFO - PROCESS | 1688 | RSS: Main: 285122560 17:59:03 INFO - PROCESS | 1688 | 17:59:03 INFO - PROCESS | 1688 | __start_tp_report 17:59:03 INFO - PROCESS | 1688 | _x_x_mozilla_page_load 17:59:03 INFO - PROCESS | 1688 | _x_x_mozilla_page_load_details 17:59:03 INFO - PROCESS | 1688 | |i|pagename|runs| 17:59:03 INFO - PROCESS | 1688 | |0;ai-astar;115;109;116;115;117;128;139;165;163;114 17:59:03 INFO - PROCESS | 1688 | |1;audio-beat-detection;161;124;151;161;121;140;138;125;154;120 17:59:03 INFO - PROCESS | 1688 | |2;audio-dft;196;218;273;241;210;198;197;196;198;200 17:59:03 INFO - PROCESS | 1688 | |3;audio-fft;71;107;100;146;51;86;47;65;125;65 17:59:03 INFO - PROCESS | 1688 | |4;audio-oscillator;82;87;113;79;83;83;113;102;121;150 17:59:03 INFO - PROCESS | 1688 | |5;imaging-gaussian-blur;89;96;90;95;89;95;89;95;90;95 17:59:03 INFO - PROCESS | 1688 | |6;imaging-darkroom;119;97;97;96;99;97;97;106;129;97 17:59:03 INFO - PROCESS | 1688 | |7;imaging-desaturate;93;93;93;96;94;91;96;95;101;128 17:59:03 INFO - PROCESS | 1688 | |8;json-parse-financial;57;60;54;55;54;56;58;63;56;56 17:59:03 INFO - PROCESS | 1688 | |9;json-stringify-tinderbox;66;65;74;73;78;74;67;65;66;68 17:59:03 INFO - PROCESS | 1688 | |10;stanford-crypto-aes;86;84;85;87;97;109;83;86;89;85 17:59:03 INFO - PROCESS | 1688 | |11;stanford-crypto-ccm;127;143;135;143;133;126;133;137;131;133 17:59:03 INFO - PROCESS | 1688 | |12;stanford-crypto-pbkdf2;143;146;144;142;150;188;181;142;141;139 17:59:03 INFO - PROCESS | 1688 | |13;stanford-crypto-sha256-iterative;76;99;96;98;100;81;68;66;71;68 17:59:03 INFO - PROCESS | 1688 | __end_tp_report 17:59:03 INFO - PROCESS | 1688 | __start_cc_report 17:59:03 INFO - PROCESS | 1688 | _x_x_mozilla_cycle_collect,892 17:59:03 INFO - PROCESS | 1688 | __end_cc_report 17:59:03 INFO - PROCESS | 1688 | __startTimestamp1455847143959__endTimestamp 17:59:03 INFO - PROCESS | 1688 | 17:59:03 INFO - PROCESS | 1688 | ------- Summary: start ------- 17:59:03 INFO - PROCESS | 1688 | Number of tests: 14 17:59:03 INFO - PROCESS | 1688 | 17:59:03 INFO - PROCESS | 1688 | [#0] ai-astar Cycles:10 Average:128.10 Median:122.50 stddev:20.75 (16.9%) stddev-sans-first:21.46 17:59:03 INFO - PROCESS | 1688 | Values: 115.0 109.0 116.0 115.0 117.0 128.0 139.0 165.0 163.0 114.0 17:59:03 INFO - PROCESS | 1688 | 17:59:03 INFO - PROCESS | 1688 | [#1] audio-beat-detection Cycles:10 Average:139.50 Median:145.50 stddev:16.47 (11.3%) stddev-sans-first:15.53 17:59:03 INFO - PROCESS | 1688 | Values: 161.0 124.0 151.0 161.0 121.0 140.0 138.0 125.0 154.0 120.0 17:59:03 INFO - PROCESS | 1688 | 17:59:03 INFO - PROCESS | 1688 | [#2] audio-dft Cycles:10 Average:212.70 Median:205.00 stddev:25.54 (12.5%) stddev-sans-first:26.36 17:59:03 INFO - PROCESS | 1688 | Values: 196.0 218.0 273.0 241.0 210.0 198.0 197.0 196.0 198.0 200.0 17:59:03 INFO - PROCESS | 1688 | 17:59:03 INFO - PROCESS | 1688 | [#3] audio-fft Cycles:10 Average:86.30 Median:58.00 stddev:32.68 (56.3%) stddev-sans-first:34.19 17:59:03 INFO - PROCESS | 1688 | Values: 71.0 107.0 100.0 146.0 51.0 86.0 47.0 65.0 125.0 65.0 17:59:03 INFO - PROCESS | 1688 | 17:59:03 INFO - PROCESS | 1688 | [#4] audio-oscillator Cycles:10 Average:101.30 Median:80.50 stddev:23.04 (28.6%) stddev-sans-first:23.36 17:59:03 INFO - PROCESS | 1688 | Values: 82.0 87.0 113.0 79.0 83.0 83.0 113.0 102.0 121.0 150.0 17:59:03 INFO - PROCESS | 1688 | 17:59:03 INFO - PROCESS | 1688 | [#5] imaging-gaussian-blur Cycles:10 Average:92.30 Median:95.00 stddev:3.09 (3.3%) stddev-sans-first:3.04 17:59:03 INFO - PROCESS | 1688 | Values: 89.0 96.0 90.0 95.0 89.0 95.0 89.0 95.0 90.0 95.0 17:59:03 INFO - PROCESS | 1688 | 17:59:03 INFO - PROCESS | 1688 | [#6] imaging-darkroom Cycles:10 Average:103.40 Median:97.00 stddev:11.47 (11.8%) stddev-sans-first:10.69 17:59:03 INFO - PROCESS | 1688 | Values: 119.0 97.0 97.0 96.0 99.0 97.0 97.0 106.0 129.0 97.0 17:59:03 INFO - PROCESS | 1688 | 17:59:03 INFO - PROCESS | 1688 | [#7] imaging-desaturate Cycles:10 Average:98.00 Median:93.50 stddev:10.88 (11.6%) stddev-sans-first:11.39 17:59:03 INFO - PROCESS | 1688 | Values: 93.0 93.0 93.0 96.0 94.0 91.0 96.0 95.0 101.0 128.0 17:59:03 INFO - PROCESS | 1688 | 17:59:03 INFO - PROCESS | 1688 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:56.50 stddev:2.81 (5.0%) stddev-sans-first:2.98 17:59:03 INFO - PROCESS | 1688 | Values: 57.0 60.0 54.0 55.0 54.0 56.0 58.0 63.0 56.0 56.0 17:59:03 INFO - PROCESS | 1688 | 17:59:03 INFO - PROCESS | 1688 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.50 stddev:4.70 (6.7%) stddev-sans-first:4.80 17:59:03 INFO - PROCESS | 1688 | Values: 66.0 65.0 74.0 73.0 78.0 74.0 67.0 65.0 66.0 68.0 17:59:03 INFO - PROCESS | 1688 | 17:59:03 INFO - PROCESS | 1688 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:86.00 stddev:8.02 (9.3%) stddev-sans-first:8.43 17:59:03 INFO - PROCESS | 1688 | Values: 86.0 84.0 85.0 87.0 97.0 109.0 83.0 86.0 89.0 85.0 17:59:03 INFO - PROCESS | 1688 | 17:59:03 INFO - PROCESS | 1688 | [#11] stanford-crypto-ccm Cycles:10 Average:134.10 Median:134.00 stddev:5.74 (4.3%) stddev-sans-first:5.49 17:59:03 INFO - PROCESS | 1688 | Values: 127.0 143.0 135.0 143.0 133.0 126.0 133.0 137.0 131.0 133.0 17:59:03 INFO - PROCESS | 1688 | 17:59:03 INFO - PROCESS | 1688 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.60 Median:145.00 stddev:17.67 (12.2%) stddev-sans-first:18.47 17:59:03 INFO - PROCESS | 1688 | Values: 143.0 146.0 144.0 142.0 150.0 188.0 181.0 142.0 141.0 139.0 17:59:03 INFO - PROCESS | 1688 | 17:59:03 INFO - PROCESS | 1688 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.30 Median:78.50 stddev:14.41 (18.4%) stddev-sans-first:15.11 17:59:03 INFO - PROCESS | 1688 | Values: 76.0 99.0 96.0 98.0 100.0 81.0 68.0 66.0 71.0 68.0 17:59:03 INFO - PROCESS | 1688 | -------- Summary: end -------- 17:59:03 INFO - PROCESS | 1688 | 17:59:04 INFO - TEST-INFO | 1688: exit 0 17:59:04 INFO - TEST-OK | kraken | took 58249ms 17:59:04 INFO - SUITE-END | took 1169s 17:59:05 INFO - Completed test suite (00:19:29) 17:59:05 INFO - Working with test: dromaeo_css 17:59:05 INFO - Generating results file: dromaeo_css 17:59:05 INFO - Working with test: kraken 17:59:05 INFO - Generating results file: kraken 17:59:05 INFO - javascript benchmark 17:59:05 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:59:05 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 17:59:05 INFO - process_Request line: dromaeo_css 7437.06 graph.html#tests=[[72,64,61]] 17:59:05 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:59:05 INFO - process_Request line: kraken 1545.20 graph.html#tests=[[232,64,61]] 17:59:05 INFO - RETURN: dromaeo_css: 7437.06 17:59:05 INFO - RETURN: kraken: 1545.20 17:59:05 INFO - javascript benchmark 17:59:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3479.582450105988, 3511.420615598425, 3528.047427194659, 3586.3903136466797, 3589.2462582857597, 5582.720863956801, 5787.189793428924, 5788.016037273663, 5797.333306669734, 5856.6193197442135, 4884.706917584947, 5640.210370548116, 5803.970980145104, 5884.588078834483, 6014.218151640292, 5202.999999999991, 5257.842264732064, 5286.550643195333, 5303.390110137326, 5327.254184414166, 5313.415524292344, 5318.175682769177, 5361.892762144755, 5363.758630861621, 5366.570674346062, 5160.458151894053, 5172.405173405069, 5332.093544097513, 5342.626016178869, 5393.6763794172475, 4349.73857581301, 5224.268602395668, 5285.577153827685, 5298.96670149321, 5307.203919412081, 5163.199704045841, 5214.035403450373, 5250.081235783722, 5278.5249327560705, 5287.074761916688, 5623.0, 5698.94569504643, 5726.284214473191, 5759.740811663443, 5763.1355296705415, 5204.9739751301, 6300.432961033529, 6307.211598550181, 6311.589746666498, 6334.619922804646, 5725.599208055438, 6244.032175012835, 6290.779822706183, 6318.083877837734, 6325.9051114233325, 5282.679330167458, 5915.08316210988, 5917.349091599921, 5937.881242375129, 6004.369541198199, 6180.752769889244, 6214.627122372672, 6331.525135614847, 6347.016212487072, 6384.585001974857, 6131.356207598227, 6202.751889924442, 6207.472364848948, 6216.098665693539, 6219.036049412348, 5317.41508434072, 6245.000799871998, 6267.19672808152, 6287.874242515124, 6312.0, 5146.330976973044, 6136.355682653347, 6168.753249870045, 6244.875102497925, 6288.088227207029, 6279.246490421178, 6285.96857015712, 6290.119383286344, 6308.747650093945, 6325.715342809584, 4705.388299521109, 4905.068037072945, 4928.556429921325, 4931.235658472942, 4977.552020318189, 4325.5674432557125, 4375.124975004948, 4386.342048692658, 4420.7126536775, 4465.575770301816, 5559.0, 5704.258446402024, 5770.942290577124, 5838.795642152504, 5848.444397782204, 6191.25704915404, 6229.50163986889, 6292.244930608356, 6299.433051025429, 6306.0, 5773.8556536086935, 5809.8547536311935, 5823.4467725566, 5838.970805145947, 5855.795047173328, 5424.728763561806, 5445.700486473203, 5449.373322068013, 5450.509454149145, 5452.236686863842, 6229.159063526366, 6363.109164716943, 6417.26201486835, 6439.356064393523, 6449.5485316027425, 6265.937340626535, 6280.246370435577, 6299.67706781581, 6301.086342480223, 6309.4952403806665, 6237.75048998035, 6422.325655806073, 6432.710528026157, 6433.903491447726, 6439.484841212598, 6113.172264937315, 6162.691865406622, 6192.907106393318, 6206.10011548332, 6219.471344935731, 6243.37566243372, 6266.624002559861, 6288.591241569284, 6292.0, 6294.433500984934, 6054.939450605438, 6152.230971128609, 6152.354002829638, 6178.980468222872, 6212.912740270525, 6153.600015998945, 6183.297725586132, 6212.347703491068, 6236.18929539157, 6237.157983672146, 5986.981795398468, 6027.0, 6032.547558933185, 6064.727087281171, 6139.416755408229, 5279.419263880894, 6042.640405908811, 6055.545834062551, 6186.0, 6204.689765511796, 6024.186734790923, 6063.029915213545, 6071.605345652519, 6073.423024812636, 6086.6652334122045], "unit": "score", "name": "dojo.html", "value": 5729.38538252868}, {"lowerIsBetter": false, "replicates": [414.61647975622543, 467.411062061802, 489.95883747037533, 513.1328055586059, 518.8843985431323, 36881.815590922044, 37075.443868341994, 37343.4398484023, 37346.25307493852, 37606.4359034614, 38608.613913860856, 39106.0, 39163.0, 39196.0, 39344.0, 7464.77605671828, 8016.719414820483, 8077.374853172713, 9211.539423028838, 9308.208802251816, 8206.343492520615, 9544.904550954505, 9705.514724263794, 9721.368111072794, 9772.609095636166, 9508.0, 9646.61413543461, 9722.659706910259, 9761.0, 9769.804603907918, 8409.285210757092, 9658.855117173249, 9714.90285097147, 9721.125098741077, 9726.17327527161, 9575.377600455948, 9679.0, 9733.56198971048, 9748.0, 9754.122129008423, 37669.0, 37985.620143798486, 38140.23719525622, 38529.0, 38573.614263857286, 3092.8453577321043, 3189.6969787870116, 3198.4722520784044, 3200.3279311344645, 3207.631122420928, 28498.145055648365, 28529.0, 29081.709182908322, 30024.0, 30265.848670756506, 2768.2525718056013, 2814.4652516021893, 2830.0, 2856.5286727689904, 2939.6766355700856, 508757.0, 508820.0, 510824.0, 512729.0, 512764.0, 57501.13748293779, 57799.422005780245, 64621.03068453977, 65156.0, 65223.0, 62471.375286247465, 62708.0, 62709.68645156745, 62816.0, 62968.370316297165, 16027.759583606256, 16247.756283655755, 16264.593385165466, 16279.755803662954, 16292.940958837638, 12079.51681932713, 12273.202241854251, 12358.196717213352, 12370.876291236973, 12381.00951923844, 16479.588010299838, 20578.794212057688, 20710.17159313641, 21265.68101478479, 21268.680969785466, 7788.688452461952, 7979.760607181794, 8895.28837692983, 8902.332325075646, 8933.330000250007, 964.5002021856081, 978.7650963768787, 1002.6791426743519, 1065.6909496246158, 1132.4620805117504, 29803.85098074496, 29815.254618634273, 29885.551716724265, 29948.0, 31344.0, 928.4614923344444, 1062.9574817007388, 1070.3363914372983, 1133.3369978562469, 1168.0772189969828, 14524.419023238952, 14540.636484087983, 14686.0, 14747.41010359595, 14849.554513364616, 614537.0, 619642.0, 623993.0, 627385.0, 627818.0, 55680.886382272125, 57137.14294285589, 57668.134977975365, 58417.0, 58599.70700146472, 1424.2309153057233, 1432.9856701432852, 1453.4186325469684, 1454.5999850041112, 1540.2914659256644, 22050.779492204874, 27920.0, 28995.550222488368, 29560.5964467001, 29842.850785745934, 50280.49719502904, 50447.991040179724, 50931.745341273054, 51034.97930041304, 51082.23376649279, 503353.0, 508082.0, 508139.0, 508603.0, 509579.0, 26474.338141546614, 44874.0, 45694.771526142154, 46785.830354241414, 47013.76493117512, 43316.0, 43413.91465213395, 43820.78089609532, 43908.78045609751, 43990.90022749457, 36876.446853297755, 37438.251234975694, 38204.80897595494, 38395.80802096083, 39252.0, 34520.30959380849, 34746.47880281747, 34913.47629785504, 35199.0, 35275.0, 34056.0, 34243.972680819614, 34864.0, 34991.0, 35052.12369690778, 31551.684483154873, 31956.881509147068, 32242.193945151557, 33736.49395259024, 34412.24702023882, 19643.60712785765, 21128.471788204803, 21560.490765646253, 23832.761672383054, 23878.283651490485], "unit": "score", "name": "ext.html", "value": 19666.114717696753}, {"lowerIsBetter": false, "replicates": [349.577011815703, 351.7748640869843, 355.1069061310804, 358.60016082068483, 359.91126841305066, 15915.363385464567, 19564.413067607977, 20017.899015554176, 20214.89892550537, 21333.466663333405, 20107.59784804303, 20299.289524866632, 20539.486512837186, 20795.0, 20881.26915557952, 5598.216249725052, 5658.179563963223, 5883.705814709268, 5914.556408269375, 5924.585279030448, 5759.395263497336, 5768.0, 5849.561282903799, 5886.117082437647, 5893.292804863422, 4118.485189351331, 5639.182318563806, 5779.884402311972, 5823.0391985322585, 6134.969325153368, 6186.721597528122, 6307.463865571432, 6378.425941665249, 6379.075034120026, 6382.234131904178, 5402.243685883979, 5456.809011684572, 5463.672179669233, 5484.040292948718, 5492.148716948879, 12425.875741242562, 12968.935155324163, 25085.12202072937, 25575.0, 25587.104451344112, 2091.8640288381207, 2132.6694362373855, 2219.8002179803893, 2453.55835949529, 2505.9749402506104, 9458.479783611898, 9744.31789774716, 9983.00169983003, 11466.885331146665, 14669.92665036668, 1690.0, 1717.9692184689086, 1791.2655811117509, 1799.8920064796155, 1850.7964123946356, 96261.0, 104067.0, 106117.46941265321, 106489.0, 107395.0, 9322.0, 11360.659180224606, 11425.428728563538, 11476.4835582399, 11537.250078745023, 13323.666908327175, 13539.0, 13553.525626603021, 13559.25424101664, 13611.727765444833, 8399.286060684788, 8409.41134120618, 8472.872906906401, 8483.27892129176, 8510.191531804468, 8602.35482338827, 8687.695930642398, 8691.870056892563, 8754.824903501894, 8767.12328767131, 4357.912841743211, 4449.1101779644205, 4463.933041004388, 4470.173017991682, 4505.414296141546, 1867.8785878917827, 1887.2828325236596, 1917.4822797844504, 1920.846332293413, 1926.80731926809, 385.6875930496307, 394.5778017521282, 407.1246819338446, 412.70285394516503, 414.32671908149257, 8838.248748856291, 11699.23954942926, 11805.586804461802, 11932.761344773056, 11949.761004779855, 419.0759375576846, 421.0778395314252, 434.20540411047705, 437.7417323778922, 442.57512787723505, 4670.392848929685, 5653.614864358258, 5804.564657650693, 6139.754409823647, 6223.62658240498, 631019.0, 632767.0, 649124.0, 651255.0, 653181.0, 111337.44331278291, 118231.40884295524, 119880.80119198696, 120099.39950300193, 124380.0, 454.1711376737467, 458.16385097197747, 981.215027977615, 1025.8563801067708, 1038.3977293169944, 14239.928800355932, 16906.0, 17292.913535432242, 17607.735883962006, 17824.732629010836, 27687.0, 43785.90535236645, 44156.0, 44171.674849754556, 45053.0, 45838.77080614575, 49376.753116235624, 64884.675576623704, 66842.66578667075, 67676.0, 6307.873842523216, 7515.8872616911885, 7674.462787605037, 7682.923170768221, 7794.766157015299, 9159.816803663756, 10444.947775261075, 11935.582254621047, 12369.0, 12452.875471245172, 10493.422861742372, 10771.246012779031, 10819.296745711503, 10859.294145880809, 11043.613473528389, 10497.895021049691, 10590.89409105899, 10806.027457528546, 11034.779304414027, 11073.944630276797, 8045.477043992122, 10727.034566889017, 11058.557657693602, 11410.0, 11487.712807179552, 7804.517141743051, 7888.566128862968, 7997.160298168841, 8006.759797206093, 8026.83946321082, 7643.923560764321, 11098.722531936766, 11110.333379997226, 11197.776044478902, 11206.719832004264], "unit": "score", "name": "jquery.html", "value": 8398.240061322977}, {"lowerIsBetter": false, "replicates": [1509.8112735908012, 1530.0513681517457, 1682.4363838114223, 1747.2312182639637, 1766.1875537252863, 7813.101493328269, 8378.95810520948, 8575.099614540477, 8741.038485766569, 8753.562321883895, 8471.195236452542, 8511.574421278941, 8546.658133674646, 8566.35752318577, 8583.141685831413, 2130.435434609822, 2410.7589241075884, 2424.284835973392, 2426.5874801283735, 2476.4675594747127, 2451.154351748653, 2472.8887200076038, 2477.541654793869, 2494.638277449769, 2500.8871052381696, 2157.9568408631817, 2379.4765151666606, 2457.7050753909466, 2481.888315025828, 2489.166129346671, 2393.7845593896545, 2398.70016247969, 2402.087206861399, 2434.7443518430578, 2434.8782560871973, 2035.460602940222, 2417.468157005456, 2422.551827911842, 2428.7085549734147, 2431.209856796548, 8466.111058338909, 8504.362172837062, 8537.445066070686, 8538.61576229065, 8595.613197406132, 5297.735113244323, 5416.593755468316, 5439.156930675752, 5461.644993075437, 5474.835754927359, 2641.603759436081, 3557.1640664443835, 3615.728820338485, 3669.743117981742, 3680.7975561344115, 1045.3257648816548, 1051.2431049644244, 1078.309881675728, 1085.9728506787314, 1086.2830531848942, 11453.911878371542, 11536.307821530734, 11661.416929153593, 11680.649580512598, 11701.2979221247, 4825.662203645781, 4849.684770489906, 4886.877828054256, 4928.310036594879, 4961.751912404366, 10088.394696318244, 10214.438205898747, 10229.488525573692, 10232.283740138268, 10233.181345492343, 5399.4600539945695, 5446.128619420873, 5451.591130665216, 5468.808591699271, 5511.090670039399, 4904.362432883702, 4944.826931057396, 4987.551120399182, 4993.725345105981, 4996.125678006334, 3984.442178095069, 3993.381025940984, 4003.979980100081, 4020.8994775130855, 4034.253663072341, 1213.0962432987305, 1294.4175121195312, 1320.1880843281313, 1338.3375229261578, 1355.2207480698637, 1090.9181811364178, 1107.4905543450104, 1132.7960967026015, 1247.1706315300405, 1328.7209685965863, 6435.195600549931, 7857.528548287121, 7929.960350198212, 8003.119656837744, 8046.637901294456, 1162.436218434059, 1164.7437563735964, 1176.1179115663253, 1176.8293597428326, 1190.0301254477572, 5488.451154884479, 6185.876282474415, 6257.68711564429, 6279.529035322278, 6289.119523266746, 10097.343672661253, 10731.141508679288, 10731.463426828628, 10809.621663241749, 10835.404052777016, 10330.535125919201, 10487.108595769292, 10547.947260263649, 10645.78708425827, 10691.198160138021, 8160.836783264302, 8201.22088401601, 8286.337093032544, 8309.961254843145, 8323.750287491384, 7794.376449884109, 7833.764987050397, 7845.097813751491, 7878.606069696607, 8044.235797599219, 9215.216706580015, 9275.07249275094, 9286.860697089414, 9375.85936210971, 9471.810563788547, 9502.429854208769, 9538.570764315484, 9724.9027509724, 9738.464384458923, 9756.512174391393, 7476.5514069156025, 7522.134954480305, 7639.274268944441, 7647.579383133981, 7656.73201437947, 6864.965675171592, 6899.930510770839, 8161.571724947991, 8189.959050204711, 8240.381971352053, 6699.0, 7412.4070074394995, 7544.358729508053, 7659.348955338859, 7670.961645191738, 7246.818829529304, 7251.419886408969, 7261.092363454568, 7288.927110728825, 7372.48392612512, 7532.5857077859055, 7572.8485430292185, 7645.5794931279315, 7683.500572462772, 7704.229577042251, 6846.554973926679, 6968.268331825086, 6977.162740471176, 6986.510944233854, 6999.895001574879, 7034.191068027242, 7089.468289878383, 7120.216776154515, 7120.679569419285, 7132.108486439195], "unit": "score", "name": "mootools.html", "value": 4892.207494585425}, {"lowerIsBetter": false, "replicates": [323.55672728362146, 327.6903326356593, 332.5560376896843, 332.6955835410599, 338.0, 6866.073080134181, 6949.895751563718, 6976.686049127782, 6984.406325462335, 7031.4374850012, 7029.297070292968, 7029.718811247557, 7034.788956331318, 7046.894296585555, 7054.57672539648, 4182.665386769067, 4924.827631032915, 5189.922151167735, 5191.714455704935, 5198.662086964354, 4218.346156345771, 4861.756912154396, 5192.169252919533, 5193.63644544882, 5195.064888320101, 4960.553550180483, 4965.975170124162, 4966.478519755427, 4969.701817890938, 4977.402711674586, 4943.233798761198, 4951.777170027357, 4954.7522623868845, 4978.751062446863, 4980.153373926441, 4026.6577340926056, 4129.834806607732, 4202.789860506993, 4214.789260536961, 4225.239456897757, 6514.93485065148, 6557.213134423852, 6650.634215118166, 6673.0991316172185, 6675.532712710112, 5919.940800591982, 5926.348101708809, 5932.169496270526, 5935.49548288396, 5939.2575928009, 5868.708884045546, 7094.929050709478, 7356.264373562654, 7389.630518474055, 7406.777796666055, 4549.363089167519, 4692.95307046932, 4694.718316900997, 4705.623550115983, 4708.387909571734, 7766.262205090507, 7835.255650713173, 7839.059312882434, 7849.215078492162, 7867.055953285585, 4624.884377890579, 4751.287306903923, 4751.3348131261655, 4759.928601070987, 4808.158572249912, 4874.707517548958, 4887.36464259644, 4893.314935908976, 4894.632902532253, 4903.558679718771, 5886.411358864079, 5889.087191485327, 5905.4685078343155, 5909.202257695156, 5913.29040515141, 5994.790182343597, 6935.375816176568, 7456.701731930662, 7473.215312392121, 7478.252174782587, 1419.771897308841, 1451.252604908473, 1726.3094762095263, 1727.2313820350075, 1730.5846596816673, 1073.8711354637337, 1076.1229597877705, 1082.9891701083045, 1089.6839916424308, 1091.737982884118, 6313.905291420632, 6758.357955994173, 7123.928760712327, 7147.53541019832, 7171.462140339391, 6576.736930522821, 8014.879776803353, 8018.158093400226, 8026.638801253957, 8074.192580741878, 5101.923471147936, 5909.704514774244, 6780.7287708492095, 7041.260667629927, 7158.749443769443, 3353.3628610563915, 3388.4917262410836, 4081.0613558881623, 4229.259879521133, 4276.123394704078, 8364.330853531703, 8367.414281000272, 8388.8741668875, 8424.663013479514, 8424.83150337002, 8166.959165204136, 8369.623366948503, 8431.325493960469, 8442.662293508314, 8471.872921906177, 8554.18735220153, 8568.10034946334, 8572.014218364842, 8583.141685831491, 8595.52724600153, 8113.6754529818145, 8122.5126492410645, 8123.147069557612, 8127.024757029194, 8134.593270336341, 7425.294597013275, 7730.613469326624, 7732.768016959275, 7736.651850666621, 7961.8407631848195, 8196.508209507449, 8205.179482051746, 8217.95891020541, 8228.917710822816, 8247.711330103417, 4789.592884604708, 4840.152973229741, 4847.951520484891, 4848.466668666514, 4856.854294371175, 7493.662785174572, 7830.960845195737, 7835.725749598737, 7852.390259996801, 7856.45004849655, 7449.217832127549, 7484.101907771103, 7501.1373692023935, 7520.8495830082, 7524.887126693214, 6153.84615384619, 6432.742690292524, 7249.238829922993, 7522.736704215326, 7535.321821036133, 6343.779677113158, 7268.709251630087, 7321.78034658961, 7337.266273372834, 7347.08161479815, 6956.782563051547, 7491.850162996819, 7509.324160825552, 7518.548887066575, 7522.548647080974, 6297.52768542352, 7362.263773622595, 7366.079240094989, 7373.677291653112, 7383.446241532014], "unit": "score", "name": "prototype.html", "value": 5385.08839851672}, {"lowerIsBetter": false, "replicates": [669.6116252573506, 670.966451677416, 696.4289282788116, 728.8105092675909, 731.1701219116304, 13631.454741810328, 13772.035957482967, 13835.654108647288, 13920.860791392082, 13931.164130152185, 13733.862661373383, 15509.612259693513, 15737.763933540977, 15753.133577653225, 15790.210489475508, 698.1308271202334, 851.4508142248246, 854.5855260198798, 873.5413907698477, 878.6265837019241, 869.6825658634584, 869.8042940338437, 877.368294827723, 879.3404946290283, 881.8192270584515, 815.6615004773012, 880.6521424037502, 901.2744740483907, 908.68650315641, 923.2890674180877, 904.5386852705102, 910.5902343945252, 915.7069737683944, 917.7705573606565, 919.3013309884469, 661.8841702702008, 669.0, 671.7078071039114, 672.8755180291662, 676.4419354032942, 12597.811032834516, 14973.550793476214, 15029.94790364675, 15193.924030379889, 15252.161131137784, 12333.62999110028, 12405.387299650987, 12480.687982800411, 12574.43415046325, 12674.239545627292, 8152.470089444227, 9245.72262832116, 9387.953060234655, 10095.091441770275, 10132.898671013343, 2960.555916612504, 3412.5904891412943, 3461.100113970386, 3514.332276867387, 3515.5781306243416, 65534.01698974519, 77565.0, 80303.0, 81491.7776233357, 82181.0, 7177.9641101795205, 7740.922590774133, 8111.756647300473, 9556.58939440733, 9592.376495527908, 19556.119974601177, 20075.799242007684, 20096.0, 20137.19451221964, 20173.0, 6597.60414375139, 7273.818154546073, 7427.554346739213, 7470.626468676544, 7629.771106866803, 3685.5761587417255, 4098.241825262336, 4132.152908653718, 4136.358864376027, 4208.179405015992, 3475.652434756504, 3511.701505372072, 3517.278957813642, 3521.137321356233, 3527.1182204448887, 639.4979940746491, 644.7936660268668, 647.1069923505532, 671.7783131566669, 673.989016475287, 487.3469550801942, 528.2129626855957, 587.4712758517369, 610.6580315023601, 616.4113271825396, 8119.634616442156, 8674.86987695185, 9043.959944606322, 9102.544872756336, 9239.445633262027, 481.8217259613895, 514.9433562308143, 539.2854467830141, 539.7301349325337, 558.8435238133247, 3807.5621303550447, 3992.3660698713566, 4003.3394489908837, 4040.3535434330365, 4150.232207041707, 97012.51493742627, 97947.0, 99530.50704239443, 100092.49953750185, 100978.98042039118, 61644.0, 79740.0, 80176.99557511108, 80401.59799201084, 81033.59483202547, 68809.0, 69997.30002700009, 70655.64672176607, 71740.0, 73511.89732154022, 6302.779402720883, 8011.278984891388, 8314.958425207835, 8330.798118787821, 8381.916180838358, 49296.26055609097, 50952.471425857286, 51246.74376628093, 51475.48524514707, 51521.0, 52562.474375255755, 68061.0, 71585.6420717893, 73369.89945150934, 76814.0, 10883.367494875833, 11216.158788091088, 11327.603533876274, 11436.1422893285, 11802.52789888395, 12120.636380908587, 12218.20581662189, 12320.075994300285, 12399.504019839105, 12713.11008229415, 11026.558937642405, 11417.828732569184, 11617.941910290394, 11658.95069443754, 11777.293362398283, 9351.812963740551, 10633.787324253626, 10974.640452302794, 11217.383043932661, 11577.073834093084, 11155.609553665583, 11485.081193504666, 11505.367204803817, 11538.538458461568, 11761.0, 8276.337892968668, 9216.539173041187, 9609.807803844024, 9802.950985245314, 9853.359531630422, 9627.855582166414, 9985.400875947467, 9997.250206234416, 9999.55002024896, 10019.298649094493], "unit": "score", "name": "yui.html", "value": 6786.726638355747}], "name": "dromaeo_css", "value": 7437.053904013773}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 116.0, 115.0, 117.0, 128.0, 139.0, 165.0, 163.0, 114.0], "unit": "score", "name": "ai-astar", "value": 128.1}, {"lowerIsBetter": true, "replicates": [161.0, 124.0, 151.0, 161.0, 121.0, 140.0, 138.0, 125.0, 154.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 139.5}, {"lowerIsBetter": true, "replicates": [196.0, 218.0, 273.0, 241.0, 210.0, 198.0, 197.0, 196.0, 198.0, 200.0], "unit": "score", "name": "audio-dft", "value": 212.7}, {"lowerIsBetter": true, "replicates": [71.0, 107.0, 100.0, 146.0, 51.0, 86.0, 47.0, 65.0, 125.0, 65.0], "unit": "score", "name": "audio-fft", "value": 86.3}, {"lowerIsBetter": true, "replicates": [82.0, 87.0, 113.0, 79.0, 83.0, 83.0, 113.0, 102.0, 121.0, 150.0], "unit": "score", "name": "audio-oscillator", "value": 101.3}, {"lowerIsBetter": true, "replicates": [89.0, 96.0, 90.0, 95.0, 89.0, 95.0, 89.0, 95.0, 90.0, 95.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.3}, {"lowerIsBetter": true, "replicates": [119.0, 97.0, 97.0, 96.0, 99.0, 97.0, 97.0, 106.0, 129.0, 97.0], "unit": "score", "name": "imaging-darkroom", "value": 103.4}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 93.0, 96.0, 94.0, 91.0, 96.0, 95.0, 101.0, 128.0], "unit": "score", "name": "imaging-desaturate", "value": 98.0}, {"lowerIsBetter": true, "replicates": [57.0, 60.0, 54.0, 55.0, 54.0, 56.0, 58.0, 63.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 56.9}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 74.0, 73.0, 78.0, 74.0, 67.0, 65.0, 66.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.6}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 85.0, 87.0, 97.0, 109.0, 83.0, 86.0, 89.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.1}, {"lowerIsBetter": true, "replicates": [127.0, 143.0, 135.0, 143.0, 133.0, 126.0, 133.0, 137.0, 131.0, 133.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 134.1}, {"lowerIsBetter": true, "replicates": [143.0, 146.0, 144.0, 142.0, 150.0, 188.0, 181.0, 142.0, 141.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.6}, {"lowerIsBetter": true, "replicates": [76.0, 99.0, 96.0, 98.0, 100.0, 81.0, 68.0, 66.0, 71.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 82.3}], "name": "kraken", "value": 1545.1999999999996}]} 17:59:05 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1545.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7437.06"}}} 17:59:05 INFO - Return code: 0 17:59:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:59:05 ERROR - # TBPL SUCCESS # 17:59:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:59:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:59:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:59:05 INFO - 2016-02-18 17:59:05.791 screenresolution[1693:10343] starting screenresolution argv=screenresolution get 17:59:05 INFO - 2016-02-18 17:59:05.794 screenresolution[1693:10343] Display 0: 1600x1200x32@60 17:59:05 INFO - 2016-02-18 17:59:05.799 screenresolution[1694:10346] starting screenresolution argv=screenresolution list 17:59:05 INFO - Available Modes on Display 0 17:59:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:59:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:59:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:59:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:59:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:59:06 INFO - Intel Iris: 17:59:06 INFO - Chipset Model: Intel Iris 17:59:06 INFO - Type: GPU 17:59:06 INFO - Bus: Built-In 17:59:06 INFO - VRAM (Dynamic, Max): 1536 MB 17:59:06 INFO - Vendor: Intel (0x8086) 17:59:06 INFO - Device ID: 0x0a2e 17:59:06 INFO - Revision ID: 0x0009 17:59:06 INFO - Displays: 17:59:06 INFO - Display: 17:59:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:59:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:59:06 INFO - Display Serial Number: 1600x1200 60 17:59:06 INFO - Main Display: Yes 17:59:06 INFO - Mirror: Off 17:59:06 INFO - Online: Yes 17:59:06 INFO - Rotation: Supported 17:59:06 INFO - Return code: 0 17:59:06 INFO - Running post-action listener: _resource_record_post_action 17:59:06 INFO - Running post-run listener: _resource_record_post_run 17:59:07 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39147008; Write bytes: 710030336; Read time: 471; Write time: 1885 17:59:07 INFO - install - Wall time: 36s; CPU: 55.0%; Read bytes: 394768896; Write bytes: 384088064; Read time: 31044; Write time: 675 17:59:07 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 32902656; Write bytes: 302627840; Read time: 391; Write time: 1164 17:59:07 INFO - Running post-run listener: _upload_blobber_files 17:59:07 INFO - Blob upload gear active. 17:59:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:59:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:59:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:59:07 INFO - (blobuploader) - INFO - Open directory for files ... 17:59:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:59:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:59:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:08 INFO - (blobuploader) - INFO - Done attempting. 17:59:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:59:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:59:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:10 INFO - (blobuploader) - INFO - Done attempting. 17:59:10 INFO - (blobuploader) - INFO - Iteration through files over. 17:59:10 INFO - Return code: 0 17:59:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:59:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:59:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6499eb6e67413b1ce584e6eec93093fa63aea82a0d2881c0f5929000855a7bd28178145468604cdde75c6ce8f28148b7b0e29d6e33b2880d019a989fbf66cd71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d469fd61d492f0c3343768fe18cf73ad96d16b147e2924b060489d5331fcda7009ca4de2009ec43413d1de0e3ebba616bd8afba4649700b636a4bd99ebcdc3f"} 17:59:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:59:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:59:10 INFO - Contents: 17:59:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6499eb6e67413b1ce584e6eec93093fa63aea82a0d2881c0f5929000855a7bd28178145468604cdde75c6ce8f28148b7b0e29d6e33b2880d019a989fbf66cd71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d469fd61d492f0c3343768fe18cf73ad96d16b147e2924b060489d5331fcda7009ca4de2009ec43413d1de0e3ebba616bd8afba4649700b636a4bd99ebcdc3f"} 17:59:10 INFO - Running post-run listener: copy_logs_to_upload_dir 17:59:10 INFO - Copying logs to upload dir... 17:59:10 INFO - mkdir: /builds/slave/test/build/upload/logs 17:59:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.487226 ========= master_lag: 3.95 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-02-18 17:59:13.852818) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-18 17:59:13.856987) ========= 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.rEm6N21p8q/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.0HqlvT40vD/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6499eb6e67413b1ce584e6eec93093fa63aea82a0d2881c0f5929000855a7bd28178145468604cdde75c6ce8f28148b7b0e29d6e33b2880d019a989fbf66cd71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d469fd61d492f0c3343768fe18cf73ad96d16b147e2924b060489d5331fcda7009ca4de2009ec43413d1de0e3ebba616bd8afba4649700b636a4bd99ebcdc3f"} build_url:https://queue.taskcluster.net/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011052 build_url: 'https://queue.taskcluster.net/v1/task/WUhp_C1RQsahaa0HH9ZQ5A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6499eb6e67413b1ce584e6eec93093fa63aea82a0d2881c0f5929000855a7bd28178145468604cdde75c6ce8f28148b7b0e29d6e33b2880d019a989fbf66cd71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d469fd61d492f0c3343768fe18cf73ad96d16b147e2924b060489d5331fcda7009ca4de2009ec43413d1de0e3ebba616bd8afba4649700b636a4bd99ebcdc3f"}' ========= master_lag: 0.83 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-18 17:59:14.702070) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-02-18 17:59:14.702363) ========= 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.rEm6N21p8q/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.0HqlvT40vD/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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.005165 ========= master_lag: 5.76 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-02-18 17:59:20.467748) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-18 17:59:20.468073) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-18 17:59:20.486649) ========= ========= Total master_lag: 19.42 =========