builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0051 starttime: 1455714629.68 results: success (0) buildid: 20160217030229 builduid: 70a81bd2d575445ab0b6bc647acf023a revision: 15621f98b53b1994c7ae2e2703a6e50203c5304c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 05:10:29.678836) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 05:10:29.679256) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 05:10:29.679535) ========= 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.ti1b1HHkxn/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.CqgYvUt9VW/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.005455 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 05:10:29.700519) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 05:10:29.700789) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 05:10:29.720959) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:10:29.721219) ========= 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.ti1b1HHkxn/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.CqgYvUt9VW/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.005336 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:10:29.769436) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 05:10:29.769717) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 05:10:29.771739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:10:29.772038) ========= 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.ti1b1HHkxn/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.CqgYvUt9VW/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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-17 05:10:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.28M=0.001s 2016-02-17 05:10:29 (8.28 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113986 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:10:29.900658) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:10:29.903959) ========= 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.ti1b1HHkxn/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.CqgYvUt9VW/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.020425 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:10:29.952233) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-17 05:10:29.952578) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 15621f98b53b1994c7ae2e2703a6e50203c5304c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 15621f98b53b1994c7ae2e2703a6e50203c5304c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ti1b1HHkxn/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.CqgYvUt9VW/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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-17 05:10:29,959 truncating revision to first 12 chars 2016-02-17 05:10:29,959 Setting DEBUG logging. 2016-02-17 05:10:29,960 attempt 1/10 2016-02-17 05:10:29,960 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/15621f98b53b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-17 05:10:31,070 unpacking tar archive at: mozilla-central-15621f98b53b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.367695 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-17 05:10:31.338753) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 05:10:31.342130) ========= echo 15621f98b53b1994c7ae2e2703a6e50203c5304c in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'15621f98b53b1994c7ae2e2703a6e50203c5304c'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ti1b1HHkxn/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.CqgYvUt9VW/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 15621f98b53b1994c7ae2e2703a6e50203c5304c program finished with exit code 0 elapsedTime=0.005219 script_repo_revision: '15621f98b53b1994c7ae2e2703a6e50203c5304c' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 05:10:31.391342) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 05:10:31.391640) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 05:10:31.411646) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-02-17 05:10:31.411962) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ti1b1HHkxn/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.CqgYvUt9VW/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 05:10:31 INFO - MultiFileLogger online at 20160217 05:10:31 in /builds/slave/test 05:10:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:10:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:10:31 INFO - {'append_to_log': False, 05:10:31 INFO - 'base_work_dir': '/builds/slave/test', 05:10:31 INFO - 'blob_upload_branch': 'Firefox', 05:10:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:10:31 INFO - 'branch': 'Firefox', 05:10:31 INFO - 'buildbot_json_path': 'buildprops.json', 05:10:31 INFO - 'config_files': ('talos/mac_config.py',), 05:10:31 INFO - 'default_actions': ('clobber', 05:10:31 INFO - 'read-buildbot-config', 05:10:31 INFO - 'download-and-extract', 05:10:31 INFO - 'populate-webroot', 05:10:31 INFO - 'create-virtualenv', 05:10:31 INFO - 'install', 05:10:31 INFO - 'run-tests'), 05:10:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:10:31 INFO - 'download_minidump_stackwalk': True, 05:10:31 INFO - 'download_symbols': 'ondemand', 05:10:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:10:31 INFO - 'tooltool.py': '/tools/tooltool.py', 05:10:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:10:31 INFO - '/tools/misc-python/virtualenv.py')}, 05:10:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:10:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:10:31 INFO - 'installer_path': 'installer.exe', 05:10:31 INFO - 'log_level': 'info', 05:10:31 INFO - 'log_name': 'talos', 05:10:31 INFO - 'log_to_console': True, 05:10:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:10:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:10:31 INFO - 'opt_config_files': (), 05:10:31 INFO - 'pip_index': False, 05:10:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:10:31 INFO - 'cmd': ('bash', 05:10:31 INFO - '-c', 05:10:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:10:31 INFO - 'enabled': True, 05:10:31 INFO - 'halt_on_failure': False, 05:10:31 INFO - 'name': 'check_screen_resolution'},), 05:10:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:10:31 INFO - 'cmd': ('bash', 05:10:31 INFO - '-c', 05:10:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:10:31 INFO - 'enabled': True, 05:10:31 INFO - 'halt_on_failure': False, 05:10:31 INFO - 'name': 'check_screen_resolution'},), 05:10:31 INFO - 'run_cmd_checks_enabled': True, 05:10:31 INFO - 'sps_profile': False, 05:10:31 INFO - 'sps_profile_interval': 0, 05:10:31 INFO - 'suite': 'dromaeojs-e10s', 05:10:31 INFO - 'system_bits': '32', 05:10:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:10:31 INFO - 'title': 't-yosemite-r7-0051', 05:10:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:10:31 INFO - 'use_talos_json': True, 05:10:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:10:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:10:31 INFO - 'work_dir': 'build'} 05:10:31 INFO - ##### 05:10:31 INFO - ##### Running clobber step. 05:10:31 INFO - ##### 05:10:31 INFO - Running pre-action listener: _resource_record_pre_action 05:10:31 INFO - Running main action method: clobber 05:10:31 INFO - rmtree: /builds/slave/test/build 05:10:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:10:32 INFO - Running post-action listener: _resource_record_post_action 05:10:32 INFO - ##### 05:10:32 INFO - ##### Running read-buildbot-config step. 05:10:32 INFO - ##### 05:10:32 INFO - Running pre-action listener: _resource_record_pre_action 05:10:32 INFO - Running main action method: read_buildbot_config 05:10:32 INFO - Using buildbot properties: 05:10:32 INFO - { 05:10:32 INFO - "project": "", 05:10:32 INFO - "product": "firefox", 05:10:32 INFO - "script_repo_revision": "production", 05:10:32 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:10:32 INFO - "repository": "", 05:10:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:10:32 INFO - "buildid": "20160217030229", 05:10:32 INFO - "stage_platform": "macosx64", 05:10:32 INFO - "basedir": "/builds/slave/test", 05:10:32 INFO - "nightly_build": "True", 05:10:32 INFO - "buildnumber": 133, 05:10:32 INFO - "slavename": "t-yosemite-r7-0051", 05:10:32 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:10:32 INFO - "platform": "yosemite_r7", 05:10:32 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:10:32 INFO - "branch": "mozilla-central", 05:10:32 INFO - "repo_path": "mozilla-central", 05:10:32 INFO - "revision": "15621f98b53b1994c7ae2e2703a6e50203c5304c", 05:10:32 INFO - "pgo_build": "False", 05:10:32 INFO - "builduid": "70a81bd2d575445ab0b6bc647acf023a", 05:10:32 INFO - "slavebuilddir": "test" 05:10:32 INFO - } 05:10:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 05:10:32 INFO - Running post-action listener: _resource_record_post_action 05:10:32 INFO - ##### 05:10:32 INFO - ##### Running download-and-extract step. 05:10:32 INFO - ##### 05:10:32 INFO - Running pre-action listener: _resource_record_pre_action 05:10:32 INFO - Running main action method: download_and_extract 05:10:32 INFO - mkdir: /builds/slave/test/build/tests 05:10: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')]} 05:10:32 INFO - https://queue.taskcluster.net/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:10:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/test_packages.json 05:10:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/test_packages.json 05:10:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:10:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:10:33 INFO - Downloaded 1277 bytes. 05:10:33 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:10:33 INFO - Using the following test package requirements: 05:10:33 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:10:33 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:10:33 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 05:10:33 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:10:33 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 05:10:33 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:10:33 INFO - u'jsshell-mac.zip'], 05:10:33 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:10:33 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 05:10:33 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:10:33 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:10:33 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 05:10:33 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:10:33 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 05:10:33 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:10:33 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 05:10:33 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:10:33 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:10:33 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 05:10:33 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:10: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')]} 05:10:33 INFO - https://queue.taskcluster.net/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:10:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:10:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:10:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNUX_J81QKaXi0zm50xMGg/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 05:10:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNUX_J81QKaXi0zm50xMGg/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 05:10:35 INFO - Downloaded 17805993 bytes. 05:10:35 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'] 05:10:35 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 05:10:38 INFO - Return code: 0 05:10:38 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 05:10:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:38 INFO - https://queue.taskcluster.net/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:10:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:10:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:10:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNUX_J81QKaXi0zm50xMGg/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 05:10:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNUX_J81QKaXi0zm50xMGg/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 05:10:39 INFO - Downloaded 17805993 bytes. 05:10:39 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'] 05:10:39 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 05:10:42 INFO - Return code: 0 05:10:42 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')]} 05:10:42 INFO - https://queue.taskcluster.net/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:10:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:10:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:10:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNUX_J81QKaXi0zm50xMGg/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 05:10:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNUX_J81QKaXi0zm50xMGg/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 05:10:43 INFO - Downloaded 10707071 bytes. 05:10:43 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'] 05:10:43 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 05:10:44 INFO - Return code: 0 05:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:44 INFO - https://queue.taskcluster.net/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:10:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:10:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:10:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 05:10:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNUX_J81QKaXi0zm50xMGg/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 05:10:51 INFO - Downloaded 111352080 bytes. 05:10:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:10:51 INFO - mkdir: /builds/slave/test/properties 05:10:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:10:51 INFO - Writing to file /builds/slave/test/properties/build_url 05:10:51 INFO - Contents: 05:10:51 INFO - build_url:https://queue.taskcluster.net/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:10:52 INFO - Running post-action listener: _resource_record_post_action 05:10:52 INFO - Running post-action listener: set_extra_try_arguments 05:10:52 INFO - ##### 05:10:52 INFO - ##### Running populate-webroot step. 05:10:52 INFO - ##### 05:10:52 INFO - Running pre-action listener: _resource_record_pre_action 05:10:52 INFO - Running main action method: populate_webroot 05:10:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:10:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:10:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:10:52 INFO - '--tppagecycles', 05:10:52 INFO - '7'], 05:10:52 INFO - 'tests': ['tsvgm']}}, 05:10:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:10:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:10:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:10:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:10:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:10:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:10:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:52 INFO - 'talos_options': ['--e10s'], 05:10:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:52 INFO - 'tests': ['damp', 'tps']}, 05:10:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:52 INFO - 'talos_options': ['--e10s'], 05:10:52 INFO - 'tests': ['damp', 'tps']}, 05:10:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:10:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:10:52 INFO - 'other': {'tests': ['a11yr', 05:10:52 INFO - 'ts_paint', 05:10:52 INFO - 'tpaint', 05:10:52 INFO - 'sessionrestore', 05:10:52 INFO - 'sessionrestore_no_auto_restore']}, 05:10:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:10:52 INFO - 'tests': ['a11yr', 05:10:52 INFO - 'ts_paint', 05:10:52 INFO - 'tpaint', 05:10:52 INFO - 'sessionrestore', 05:10:52 INFO - 'sessionrestore_no_auto_restore']}, 05:10:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:10:52 INFO - 'tests': ['a11yr', 05:10:52 INFO - 'ts_paint', 05:10:52 INFO - 'tpaint', 05:10:52 INFO - 'sessionrestore', 05:10:52 INFO - 'sessionrestore_no_auto_restore']}, 05:10:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:10:52 INFO - 'tests': ['a11yr', 05:10:52 INFO - 'ts_paint', 05:10:52 INFO - 'tpaint', 05:10:52 INFO - 'sessionrestore', 05:10:52 INFO - 'sessionrestore_no_auto_restore']}, 05:10:52 INFO - 'other_l64': {'tests': ['a11yr', 05:10:52 INFO - 'ts_paint', 05:10:52 INFO - 'tpaint', 05:10:52 INFO - 'sessionrestore', 05:10:52 INFO - 'sessionrestore_no_auto_restore']}, 05:10:52 INFO - 'other_nol64': {'tests': ['a11yr', 05:10:52 INFO - 'ts_paint', 05:10:52 INFO - 'tpaint', 05:10:52 INFO - 'sessionrestore', 05:10:52 INFO - 'sessionrestore_no_auto_restore']}, 05:10:52 INFO - 'svgr': {'tests': ['tsvgx', 05:10:52 INFO - 'tsvgr_opacity', 05:10:52 INFO - 'tart', 05:10:52 INFO - 'tscrollx', 05:10:52 INFO - 'cart']}, 05:10:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:10:52 INFO - 'tests': ['tsvgx', 05:10:52 INFO - 'tsvgr_opacity', 05:10:52 INFO - 'tart', 05:10:52 INFO - 'tscrollx', 05:10:52 INFO - 'cart']}, 05:10:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:52 INFO - 'tests': ['tp5o']}, 05:10:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:52 INFO - 'talos_options': ['--e10s'], 05:10:52 INFO - 'tests': ['tp5o']}, 05:10:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:52 INFO - 'talos_options': ['--xperf_path', 05:10:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:52 INFO - 'tests': ['tp5n']}, 05:10:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:52 INFO - 'talos_options': ['--e10s', 05:10:52 INFO - '--xperf_path', 05:10:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:52 INFO - 'tests': ['tp5n']}}, 05:10:52 INFO - 'talos.zip': {'path': '', 05:10:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:10:52 INFO - Running post-action listener: _resource_record_post_action 05:10:52 INFO - ##### 05:10:52 INFO - ##### Running create-virtualenv step. 05:10:52 INFO - ##### 05:10:52 INFO - Running pre-action listener: _resource_record_pre_action 05:10:52 INFO - Running main action method: create_virtualenv 05:10:52 INFO - Creating virtualenv /builds/slave/test/build/venv 05:10:52 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 05:10:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:10:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:10:52 INFO - Using real prefix '/tools/python27' 05:10:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:10:53 INFO - Installing distribute.............................................................................................................................................................................................done. 05:10:56 INFO - Installing pip.................done. 05:10:56 INFO - Return code: 0 05:10:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:10:56 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')]} 05:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:56 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')]} 05:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:56 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 0x10d7fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8034c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f949b58de10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6a0d30>, '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 0x10d4c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d697b20>, '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.ti1b1HHkxn/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.CqgYvUt9VW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 05:10:56 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 05:10:56 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 05:10:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ti1b1HHkxn/Render', 05:10:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:56 INFO - 'HOME': '/Users/cltbld', 05:10:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:56 INFO - 'LOGNAME': 'cltbld', 05:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:56 INFO - 'MOZ_NO_REMOTE': '1', 05:10:56 INFO - 'NO_EM_RESTART': '1', 05:10:56 INFO - 'PAGER': '/bin/cat', 05:10:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:56 INFO - 'PWD': '/builds/slave/test', 05:10:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:56 INFO - 'SHELL': '/bin/bash', 05:10:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqgYvUt9VW/Listeners', 05:10:56 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 05:10:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:56 INFO - 'USER': 'cltbld', 05:10:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:56 INFO - 'XPC_FLAGS': '0x0', 05:10:56 INFO - 'XPC_SERVICE_NAME': '0', 05:10:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:56 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 05:10:56 INFO - Cleaning up... 05:10:56 INFO - Return code: 0 05:10:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:10:56 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')]} 05:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:56 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')]} 05:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:56 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 0x10d7fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8034c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f949b58de10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6a0d30>, '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 0x10d4c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d697b20>, '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.ti1b1HHkxn/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.CqgYvUt9VW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 05:10:56 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 05:10:56 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 05:10:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ti1b1HHkxn/Render', 05:10:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:56 INFO - 'HOME': '/Users/cltbld', 05:10:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:56 INFO - 'LOGNAME': 'cltbld', 05:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:56 INFO - 'MOZ_NO_REMOTE': '1', 05:10:56 INFO - 'NO_EM_RESTART': '1', 05:10:56 INFO - 'PAGER': '/bin/cat', 05:10:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:56 INFO - 'PWD': '/builds/slave/test', 05:10:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:56 INFO - 'SHELL': '/bin/bash', 05:10:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqgYvUt9VW/Listeners', 05:10:56 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 05:10:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:56 INFO - 'USER': 'cltbld', 05:10:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:56 INFO - 'XPC_FLAGS': '0x0', 05:10:56 INFO - 'XPC_SERVICE_NAME': '0', 05:10:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:57 INFO - Downloading/unpacking psutil>=0.7.1 05:10: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 05:10: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 05:10: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 05:10: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 05:10: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 05:10: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 05:10:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:10:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:59 INFO - Installing collected packages: psutil 05:10:59 INFO - Running setup.py install for psutil 05:10:59 INFO - building 'psutil._psutil_osx' extension 05:10:59 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 05:11:00 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 05:11:00 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 05:11:00 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 05:11:00 INFO - building 'psutil._psutil_posix' extension 05:11:00 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 05:11:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:11:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:11:00 INFO - ^ 05:11:00 INFO - 1 warning generated. 05:11:00 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 05:11:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:00 INFO - Successfully installed psutil 05:11:00 INFO - Cleaning up... 05:11:00 INFO - Return code: 0 05:11:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d7fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8034c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f949b58de10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6a0d30>, '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 0x10d4c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d697b20>, '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.ti1b1HHkxn/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.CqgYvUt9VW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 05:11:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:11:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:11:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ti1b1HHkxn/Render', 05:11:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:00 INFO - 'HOME': '/Users/cltbld', 05:11:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:00 INFO - 'LOGNAME': 'cltbld', 05:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:00 INFO - 'MOZ_NO_REMOTE': '1', 05:11:00 INFO - 'NO_EM_RESTART': '1', 05:11:00 INFO - 'PAGER': '/bin/cat', 05:11:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:00 INFO - 'PWD': '/builds/slave/test', 05:11:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:00 INFO - 'SHELL': '/bin/bash', 05:11:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqgYvUt9VW/Listeners', 05:11:00 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 05:11:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:00 INFO - 'USER': 'cltbld', 05:11:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:00 INFO - 'XPC_FLAGS': '0x0', 05:11:00 INFO - 'XPC_SERVICE_NAME': '0', 05:11:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:11:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:11:03 INFO - Installing collected packages: mozsystemmonitor 05:11:03 INFO - Running setup.py install for mozsystemmonitor 05:11:03 INFO - Successfully installed mozsystemmonitor 05:11:03 INFO - Cleaning up... 05:11:03 INFO - Return code: 0 05:11:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:11:03 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')]} 05:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:03 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')]} 05:11:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:03 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 0x10d7fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8034c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f949b58de10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6a0d30>, '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 0x10d4c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d697b20>, '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.ti1b1HHkxn/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.CqgYvUt9VW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 05:11:03 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 05:11:03 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 05:11:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ti1b1HHkxn/Render', 05:11:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:03 INFO - 'HOME': '/Users/cltbld', 05:11:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:03 INFO - 'LOGNAME': 'cltbld', 05:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:03 INFO - 'MOZ_NO_REMOTE': '1', 05:11:03 INFO - 'NO_EM_RESTART': '1', 05:11:03 INFO - 'PAGER': '/bin/cat', 05:11:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:03 INFO - 'PWD': '/builds/slave/test', 05:11:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:03 INFO - 'SHELL': '/bin/bash', 05:11:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqgYvUt9VW/Listeners', 05:11:03 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 05:11:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:03 INFO - 'USER': 'cltbld', 05:11:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:03 INFO - 'XPC_FLAGS': '0x0', 05:11:03 INFO - 'XPC_SERVICE_NAME': '0', 05:11:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:03 INFO - Downloading/unpacking blobuploader==1.2.4 05:11:03 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 05:11:03 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 05:11:03 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 05:11:03 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 05:11:03 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 05:11:03 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 05:11:06 INFO - Downloading blobuploader-1.2.4.tar.gz 05:11:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:11:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:11:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:07 INFO - Downloading docopt-0.6.1.tar.gz 05:11:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:11:07 INFO - Installing collected packages: blobuploader, requests, docopt 05:11:07 INFO - Running setup.py install for blobuploader 05:11:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:11:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:11:07 INFO - Running setup.py install for requests 05:11:08 INFO - Running setup.py install for docopt 05:11:08 INFO - Successfully installed blobuploader requests docopt 05:11:08 INFO - Cleaning up... 05:11:08 INFO - Return code: 0 05:11:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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')]} 05:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:08 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 0x10d7fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8034c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f949b58de10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6a0d30>, '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 0x10d4c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d697b20>, '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.ti1b1HHkxn/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.CqgYvUt9VW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 05:11:08 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 05:11:08 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 05:11:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ti1b1HHkxn/Render', 05:11:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:08 INFO - 'HOME': '/Users/cltbld', 05:11:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:08 INFO - 'LOGNAME': 'cltbld', 05:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:08 INFO - 'MOZ_NO_REMOTE': '1', 05:11:08 INFO - 'NO_EM_RESTART': '1', 05:11:08 INFO - 'PAGER': '/bin/cat', 05:11:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:08 INFO - 'PWD': '/builds/slave/test', 05:11:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:08 INFO - 'SHELL': '/bin/bash', 05:11:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqgYvUt9VW/Listeners', 05:11:08 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 05:11:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:08 INFO - 'USER': 'cltbld', 05:11:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:08 INFO - 'XPC_FLAGS': '0x0', 05:11:08 INFO - 'XPC_SERVICE_NAME': '0', 05:11:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:08 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-_vnyyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:08 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-5zUfeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:08 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-a3LVUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:08 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-gWfajZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:09 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-usgiz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:09 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-nVgoT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:09 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-yWDFay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:09 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-PkAVYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:09 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-KKCdKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:09 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-4_PCjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:09 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-tyXwxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:09 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-dsnEr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:09 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-kvgqmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:09 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-ft5SQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:10 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-9iKegk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:10 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-7mRnga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:10 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-XyC8Hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:11:10 INFO - Running setup.py install for manifestparser 05:11:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:11:10 INFO - Running setup.py install for mozcrash 05:11:10 INFO - Running setup.py install for mozdebug 05:11:10 INFO - Running setup.py install for mozdevice 05:11:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:11:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:11:11 INFO - Running setup.py install for mozfile 05:11:11 INFO - Running setup.py install for mozhttpd 05:11:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:11:11 INFO - Running setup.py install for mozinfo 05:11:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:11:11 INFO - Running setup.py install for mozInstall 05:11:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:11:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:11:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:11:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:11:11 INFO - Running setup.py install for mozleak 05:11:11 INFO - Running setup.py install for mozlog 05:11:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:11:11 INFO - Running setup.py install for moznetwork 05:11:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:11:12 INFO - Running setup.py install for mozprocess 05:11:12 INFO - Running setup.py install for mozprofile 05:11:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:11:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:11:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:11:12 INFO - Running setup.py install for mozrunner 05:11:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:11:12 INFO - Running setup.py install for mozscreenshot 05:11:12 INFO - Running setup.py install for moztest 05:11:12 INFO - Running setup.py install for mozversion 05:11:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:11:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:11:12 INFO - Cleaning up... 05:11:13 INFO - Return code: 0 05:11:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:13 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 0x10d7fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8034c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f949b58de10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6a0d30>, '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 0x10d4c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d697b20>, '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.ti1b1HHkxn/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.CqgYvUt9VW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 05:11:13 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 05:11:13 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 05:11:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ti1b1HHkxn/Render', 05:11:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:13 INFO - 'HOME': '/Users/cltbld', 05:11:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:13 INFO - 'LOGNAME': 'cltbld', 05:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:13 INFO - 'MOZ_NO_REMOTE': '1', 05:11:13 INFO - 'NO_EM_RESTART': '1', 05:11:13 INFO - 'PAGER': '/bin/cat', 05:11:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:13 INFO - 'PWD': '/builds/slave/test', 05:11:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:13 INFO - 'SHELL': '/bin/bash', 05:11:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqgYvUt9VW/Listeners', 05:11:13 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 05:11:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:13 INFO - 'USER': 'cltbld', 05:11:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:13 INFO - 'XPC_FLAGS': '0x0', 05:11:13 INFO - 'XPC_SERVICE_NAME': '0', 05:11:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:13 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-2HZ0L7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:13 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)) 05:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:13 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-NXLjFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:13 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)) 05:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:13 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-aKDQNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:13 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)) 05:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:13 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-pljyhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:13 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)) 05:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:13 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-rfU4H4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:13 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)) 05:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:13 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-QVAbvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:13 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)) 05:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:13 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-KChHzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:14 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)) 05:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:14 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Vl4xNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:14 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)) 05:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:14 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-24mrLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:14 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)) 05:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:14 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-aNgkZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:14 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)) 05:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:14 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-yrshDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:14 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)) 05:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:14 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-nAtdKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:14 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)) 05:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:14 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-ET7kbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:14 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)) 05:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:14 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-bbeSvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:14 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)) 05:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:14 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-eWZG9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:14 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)) 05:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:14 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-1ecErG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:15 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)) 05:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:15 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-G7H498-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:15 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)) 05:11:15 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)) 05:11:15 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)) 05:11:15 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)) 05:11:15 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)) 05:11:15 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)) 05:11:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:11:15 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 05:11:15 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 05:11:15 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 05:11:15 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 05:11:15 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 05:11:15 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 05:11:17 INFO - Downloading blessings-1.6.tar.gz 05:11:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:11:17 INFO - Installing collected packages: blessings 05:11:17 INFO - Running setup.py install for blessings 05:11:17 INFO - Successfully installed blessings 05:11:17 INFO - Cleaning up... 05:11:17 INFO - Return code: 0 05:11:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:11:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:18 INFO - Reading from file tmpfile_stdout 05:11:18 INFO - Current package versions: 05:11:18 INFO - blessings == 1.6 05:11:18 INFO - blobuploader == 1.2.4 05:11:18 INFO - docopt == 0.6.1 05:11:18 INFO - manifestparser == 1.1 05:11:18 INFO - mozInstall == 1.12 05:11:18 INFO - mozcrash == 0.16 05:11:18 INFO - mozdebug == 0.1 05:11:18 INFO - mozdevice == 0.48 05:11:18 INFO - mozfile == 1.2 05:11:18 INFO - mozhttpd == 0.7 05:11:18 INFO - mozinfo == 0.9 05:11:18 INFO - mozleak == 0.1 05:11:18 INFO - mozlog == 3.1 05:11:18 INFO - moznetwork == 0.27 05:11:18 INFO - mozprocess == 0.22 05:11:18 INFO - mozprofile == 0.28 05:11:18 INFO - mozrunner == 6.11 05:11:18 INFO - mozscreenshot == 0.1 05:11:18 INFO - mozsystemmonitor == 0.0 05:11:18 INFO - moztest == 0.7 05:11:18 INFO - mozversion == 1.4 05:11:18 INFO - psutil == 3.1.1 05:11:18 INFO - requests == 1.2.3 05:11:18 INFO - wsgiref == 0.1.2 05:11:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:18 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 0x10d7fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8034c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f949b58de10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6a0d30>, '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 0x10d4c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d697b20>, '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.ti1b1HHkxn/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.CqgYvUt9VW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 05:11:18 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 05:11:18 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 05:11:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ti1b1HHkxn/Render', 05:11:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:18 INFO - 'HOME': '/Users/cltbld', 05:11:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:18 INFO - 'LOGNAME': 'cltbld', 05:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:18 INFO - 'MOZ_NO_REMOTE': '1', 05:11:18 INFO - 'NO_EM_RESTART': '1', 05:11:18 INFO - 'PAGER': '/bin/cat', 05:11:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:18 INFO - 'PWD': '/builds/slave/test', 05:11:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:18 INFO - 'SHELL': '/bin/bash', 05:11:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqgYvUt9VW/Listeners', 05:11:18 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 05:11:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:18 INFO - 'USER': 'cltbld', 05:11:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:18 INFO - 'XPC_FLAGS': '0x0', 05:11:18 INFO - 'XPC_SERVICE_NAME': '0', 05:11:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:18 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)) 05:11:18 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)) 05:11:18 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)) 05:11:18 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)) 05:11:18 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)) 05:11:18 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)) 05:11:18 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)) 05:11:18 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)) 05:11:18 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)) 05:11:18 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)) 05:11:18 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)) 05:11:18 INFO - Cleaning up... 05:11:18 INFO - Return code: 0 05:11:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:18 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 0x10d7fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8034c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f949b58de10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6a0d30>, '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 0x10d4c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d697b20>, '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.ti1b1HHkxn/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.CqgYvUt9VW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 05:11:18 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 05:11:18 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 05:11:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ti1b1HHkxn/Render', 05:11:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:18 INFO - 'HOME': '/Users/cltbld', 05:11:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:18 INFO - 'LOGNAME': 'cltbld', 05:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:18 INFO - 'MOZ_NO_REMOTE': '1', 05:11:18 INFO - 'NO_EM_RESTART': '1', 05:11:18 INFO - 'PAGER': '/bin/cat', 05:11:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:18 INFO - 'PWD': '/builds/slave/test', 05:11:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:18 INFO - 'SHELL': '/bin/bash', 05:11:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqgYvUt9VW/Listeners', 05:11:18 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 05:11:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:18 INFO - 'USER': 'cltbld', 05:11:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:18 INFO - 'XPC_FLAGS': '0x0', 05:11:18 INFO - 'XPC_SERVICE_NAME': '0', 05:11:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:18 INFO - Downloading/unpacking jsonschema 05:11:18 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 05:11:18 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 05:11:18 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 05:11:18 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 05:11:18 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 05:11:18 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 05:11:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:11:20 INFO - Downloading/unpacking functools32 (from jsonschema) 05:11:20 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 05:11:20 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 05:11:20 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 05:11:20 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 05:11:20 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 05:11:20 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 05:11:21 INFO - Downloading functools32-3.2.3-2.tar.gz 05:11:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:11:21 INFO - warning: no files found matching '*.txt' 05:11:21 INFO - no previously-included directories found matching 'build' 05:11:21 INFO - no previously-included directories found matching 'dist' 05:11:21 INFO - no previously-included directories found matching '.git*' 05:11:21 INFO - Installing collected packages: jsonschema, functools32 05:11:21 INFO - Running setup.py install for functools32 05:11:21 INFO - warning: no files found matching '*.txt' 05:11:21 INFO - no previously-included directories found matching 'build' 05:11:21 INFO - no previously-included directories found matching 'dist' 05:11:21 INFO - no previously-included directories found matching '.git*' 05:11:21 INFO - Successfully installed jsonschema functools32 05:11:21 INFO - Cleaning up... 05:11:21 INFO - Return code: 0 05:11:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:11:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d7fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8034c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f949b58de10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6a0d30>, '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 0x10d4c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d697b20>, '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.ti1b1HHkxn/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.CqgYvUt9VW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 05:11:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:11:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ti1b1HHkxn/Render', 05:11:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:21 INFO - 'HOME': '/Users/cltbld', 05:11:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:21 INFO - 'LOGNAME': 'cltbld', 05:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:21 INFO - 'MOZ_NO_REMOTE': '1', 05:11:21 INFO - 'NO_EM_RESTART': '1', 05:11:21 INFO - 'PAGER': '/bin/cat', 05:11:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:21 INFO - 'PWD': '/builds/slave/test', 05:11:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:21 INFO - 'SHELL': '/bin/bash', 05:11:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqgYvUt9VW/Listeners', 05:11:21 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 05:11:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:21 INFO - 'USER': 'cltbld', 05:11:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:21 INFO - 'XPC_FLAGS': '0x0', 05:11:21 INFO - 'XPC_SERVICE_NAME': '0', 05:11:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:21 INFO - Downloading/unpacking flake8 05:11:21 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 05:11:21 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 05:11:21 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 05:11:21 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 05:11:21 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 05:11:21 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 05:11:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:11:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:11:24 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 05:11:24 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 05:11:24 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 05:11:24 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 05:11:24 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 05:11:24 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 05:11:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:11:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:11:24 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 05:11:24 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 05:11:24 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 05:11:24 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 05:11:24 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 05:11:24 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 05:11:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:11:24 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 05:11:24 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 05:11:24 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 05:11:24 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 05:11:24 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 05:11:24 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 05:11:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:11:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:11:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:11:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:11:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:11:25 INFO - no previously-included directories found matching 'docs/_build' 05:11:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:11:25 INFO - Running setup.py install for pep8 05:11:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:11:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:11:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:11:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:11:25 INFO - no previously-included directories found matching 'docs/_build' 05:11:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:11:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:11:25 INFO - Cleaning up... 05:11:25 INFO - Return code: 0 05:11:25 INFO - Running post-action listener: _resource_record_post_action 05:11:25 INFO - Running post-action listener: _start_resource_monitoring 05:11:25 INFO - Starting resource monitoring. 05:11:25 INFO - ##### 05:11:25 INFO - ##### Running install step. 05:11:25 INFO - ##### 05:11:25 INFO - Running pre-action listener: _resource_record_pre_action 05:11:25 INFO - Running main action method: install 05:11:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:26 INFO - Reading from file tmpfile_stdout 05:11:26 INFO - Detecting whether we're running mozinstall >=1.0... 05:11:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:11:26 INFO - Reading from file tmpfile_stdout 05:11:26 INFO - Output received: 05:11:26 INFO - Usage: mozinstall [options] installer 05:11:26 INFO - Options: 05:11:26 INFO - -h, --help show this help message and exit 05:11:26 INFO - -d DEST, --destination=DEST 05:11:26 INFO - Directory to install application into. [default: 05:11:26 INFO - "/builds/slave/test"] 05:11:26 INFO - --app=APP Application being installed. [default: firefox] 05:11:26 INFO - mkdir: /builds/slave/test/build/application 05:11:26 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'] 05:11:26 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 05:12:00 INFO - Reading from file tmpfile_stdout 05:12:00 INFO - Output received: 05:12:00 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:12:00 INFO - Running post-action listener: _resource_record_post_action 05:12:00 INFO - ##### 05:12:00 INFO - ##### Running run-tests step. 05:12:00 INFO - ##### 05:12:00 INFO - Running pre-action listener: _resource_record_pre_action 05:12:00 INFO - Running main action method: run_tests 05:12:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:12:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:12:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:12:00 INFO - 2016-02-17 05:12:00.117 screenresolution[2941:82597] starting screenresolution argv=screenresolution get 05:12:00 INFO - 2016-02-17 05:12:00.120 screenresolution[2941:82597] Display 0: 1600x1200x32@60 05:12:00 INFO - 2016-02-17 05:12:00.126 screenresolution[2942:82599] starting screenresolution argv=screenresolution list 05:12:00 INFO - Available Modes on Display 0 05:12:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:12:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:12:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:12:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:12:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:12:00 INFO - Intel Iris: 05:12:00 INFO - Chipset Model: Intel Iris 05:12:00 INFO - Type: GPU 05:12:00 INFO - Bus: Built-In 05:12:00 INFO - VRAM (Dynamic, Max): 1536 MB 05:12:00 INFO - Vendor: Intel (0x8086) 05:12:00 INFO - Device ID: 0x0a2e 05:12:00 INFO - Revision ID: 0x0009 05:12:00 INFO - Displays: 05:12:00 INFO - Display: 05:12:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:12:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:12:00 INFO - Display Serial Number: 1600x1200 60 05:12:00 INFO - Main Display: Yes 05:12:00 INFO - Mirror: Off 05:12:00 INFO - Online: Yes 05:12:00 INFO - Rotation: Supported 05:12:00 INFO - Return code: 0 05:12:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:12:00 INFO - Python 2.7.3 05:12:00 INFO - Return code: 0 05:12:00 INFO - grabbing minidump binary from tooltool 05:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:00 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 0x10d6a0d30>, '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 0x10d4c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d697b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:12:00 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 05:12:00 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 05:12:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:12:00 INFO - Return code: 0 05:12:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:12:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:12:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:12:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:12:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:12:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:12:01 INFO - Return code: 0 05:12:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--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 05:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0051 --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 05:12:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ti1b1HHkxn/Render', 05:12:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:12:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:12:01 INFO - 'HOME': '/Users/cltbld', 05:12:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:12:01 INFO - 'LOGNAME': 'cltbld', 05:12:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:12:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:01 INFO - 'MOZ_NO_REMOTE': '1', 05:12:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:12:01 INFO - 'NO_EM_RESTART': '1', 05:12:01 INFO - 'PAGER': '/bin/cat', 05:12:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:01 INFO - 'PWD': '/builds/slave/test', 05:12:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:12:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:12:01 INFO - 'SHELL': '/bin/bash', 05:12:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqgYvUt9VW/Listeners', 05:12:01 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 05:12:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:12:01 INFO - 'USER': 'cltbld', 05:12:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:12:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:01 INFO - 'XPC_FLAGS': '0x0', 05:12:01 INFO - 'XPC_SERVICE_NAME': '0', 05:12:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:12:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--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 05:12:01 INFO - mozversion application_buildid: 20160217030229 05:12:01 INFO - mozversion application_changeset: 15621f98b53b1994c7ae2e2703a6e50203c5304c 05:12:01 INFO - mozversion application_display_name: Nightly 05:12:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:12:01 INFO - mozversion application_name: Firefox 05:12:01 INFO - mozversion application_remotingname: firefox 05:12:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:12:01 INFO - mozversion application_vendor: Mozilla 05:12:01 INFO - mozversion application_version: 47.0a1 05:12:01 INFO - mozversion platform_buildid: 20160217030229 05:12:01 INFO - mozversion platform_changeset: 15621f98b53b1994c7ae2e2703a6e50203c5304c 05:12:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:12:01 INFO - mozversion platform_version: 47.0a1 05:12:01 INFO - using testdate: 1455714721 05:12:01 INFO - actual date: 1455714721 05:12:02 INFO - starting webserver on 'localhost:59273' 05:12:02 INFO - SUITE-START | Running 2 tests 05:12:02 INFO - TEST-START | dromaeo_css 05:12:02 INFO - operating with platform_type : mac_ 05:12:02 INFO - Initialising browser for dromaeo_css test... 05:12:02 INFO - TEST-INFO | started process 2960 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpjHi8JK/profile http://localhost:59273/getInfo.html) 05:12:05 INFO - PROCESS | 2960 | __metrics Screen width/height:1600/1200 05:12:05 INFO - PROCESS | 2960 | colorDepth:24 05:12:05 INFO - PROCESS | 2960 | Browser inner width/height: 1024/689 05:12:05 INFO - PROCESS | 2960 | __metrics 05:12:06 INFO - TEST-INFO | 2960: exit 0 05:12:06 INFO - Browser initialized. 05:12:06 INFO - Running cycle 1/1 for dromaeo_css test... 05:12:06 INFO - TEST-INFO | started process 2965 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpjHi8JK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:18 INFO - PROCESS | 2965 | RSS: Main: 256024576 05:12:18 INFO - PROCESS | 2965 | 05:13:07 INFO - PROCESS | 2965 | 1455714787946 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] 05:15:17 INFO - PROCESS | 2965 | Cycle 1(1): loaded http://localhost:59273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59273/tests/dromaeo/cssquery-ext.html) 05:15:19 INFO - PROCESS | 2965 | RSS: Main: 270065664 05:15:19 INFO - PROCESS | 2965 | 05:18:21 INFO - PROCESS | 2965 | Cycle 1(1): loaded http://localhost:59273/tests/dromaeo/cssquery-ext.html (next: http://localhost:59273/tests/dromaeo/cssquery-jquery.html) 05:18:22 INFO - PROCESS | 2965 | RSS: Main: 281612288 05:18:22 INFO - PROCESS | 2965 | 05:21:24 INFO - PROCESS | 2965 | Cycle 1(1): loaded http://localhost:59273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59273/tests/dromaeo/cssquery-mootools.html) 05:21:24 INFO - PROCESS | 2965 | RSS: Main: 283967488 05:21:24 INFO - PROCESS | 2965 | 05:24:26 INFO - PROCESS | 2965 | Cycle 1(1): loaded http://localhost:59273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59273/tests/dromaeo/cssquery-prototype.html) 05:24:27 INFO - PROCESS | 2965 | RSS: Main: 285241344 05:24:27 INFO - PROCESS | 2965 | 05:27:29 INFO - PROCESS | 2965 | Cycle 1(1): loaded http://localhost:59273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59273/tests/dromaeo/cssquery-yui.html) 05:27:30 INFO - PROCESS | 2965 | RSS: Main: 288792576 05:27:30 INFO - PROCESS | 2965 | 05:30:32 INFO - PROCESS | 2965 | Cycle 1(1): loaded http://localhost:59273/tests/dromaeo/cssquery-yui.html (next: http://localhost:59273/tests/dromaeo/cssquery-dojo.html) 05:30:33 INFO - PROCESS | 2965 | RSS: Main: 289607680 05:30:33 INFO - PROCESS | 2965 | 05:30:33 INFO - PROCESS | 2965 | __start_tp_report 05:30:33 INFO - PROCESS | 2965 | _x_x_mozilla_page_load 05:30:33 INFO - PROCESS | 2965 | _x_x_mozilla_page_load_details 05:30:33 INFO - PROCESS | 2965 | |i|pagename|runs| 05:30:33 INFO - PROCESS | 2965 | |0;dojo.html;2872.597836302917;2963.170312312553;3186.4264432402174;3190.5214217867324;3356.942563092624;5205.453427390122;5666.433356664336;5706.885862282752;5715.457031581993;5715.714214289284;4673.228917228653;5525.11598144297;5558.888822223553;5705.543556515479;5885.146653735206;4308.418363520932;5112.795488180478;5190.06578815813;5220.634555581092;5244.606654500928;5122.385313762354;5135.922961155586;5224.63427560071;5230.372355317349;5248.606354523426;4462.709923854939;4480.865574032784;5058.988202359506;5064.366954130734;5185.792568297264;5065.11360511909;5090.872728181788;5111.718855462948;5114.28400023997;5161.200013997836;4523.864284071483;5044.495550444963;5050.797968081272;5065.189569668835;5086.287919691246;5439.292891924064;5619.803306884281;5622.662640241599;5629.4652008059575;5633.492985631272;6175.2589689237575;6211.503079753609;6232.127502149703;6238.814625221239;6243.157173781527;6147.108669242934;6149.938500614981;6218.191635087455;6237.157983672191;6238.532110091716;4576.153411618861;5471.452854714536;5627.915581266284;5653.547716182655;5713.74288157034;6154.323024467305;6209.0996805462955;6211.720472578745;6228.532860035515;6240.719167637467;6084.60450070744;6097.222222222223;6101.298350689639;6115.082737589309;6117.418845209698;6153.892299386064;6259.96870015647;6272.2159730033745;6281.434670879643;6340.985442329205;6187.504999600022;6193.318734939153;6206.689665516707;6226.470749986302;6239.937600624026;6090.939090609126;6115.296740874767;6152.230971128609;6210.844728881814;6251.9687401562705;4860.684055536379;4868.756562171948;4883.877903052452;4906.1414252505665;4927.457979622239;4331.696781225347;4346.847860324873;4386;4421.801018954155;4422.7346359218545;4605.723656580616;5695.487406133468;5711.571632127607;5763.366029736726;5783.768649253982;4751.311059896296;5147.871303217449;6140.355262697352;6180.351063138396;6193.349698281706;4791.784369703371;5520.641158324696;5634.408387119293;5640.802571909963;5679.716014199274;4536.637069034469;4544.363789069533;5051.015052064886;5308.973455132699;5400.972995135077;6286.622802631857;6315.084312774622;6315.431611155018;6316.62100273985;6333.493320534346;5189.481051894781;6109.890546868166;6113.962834745988;6237.126802247598;6279.623222606659;6252.5935814171935;6269.968650156902;6280.7487700491465;6304.873902521832;6315.652639104894;6105.084237364431;6110.114033465212;6181.474574661204;6189.164462797645;6199.628022318675;6126.5098792097415;6152.861720581706;6153.169322141633;6187.071939209155;6199.938000619936;5978.252718410199;6047.637141771508;6073.362296958756;6074.908876366946;6090.634561926298;5992.43071908168;6027.78902738402;6029.758809647565;6031.457168854824;6047.274327080779;5710.8001219957105;5804.419558044162;5886.234789477512;5897;5946.316173639913;5842.802225543668;5995.940040599538;6035.6076855004285;6081.513478921587;6116.510679145568;5904.852378690567;5936.198613187337;5959.374265702038;5964.343922168645;5967.731452084753 05:30:33 INFO - PROCESS | 2965 | |1;ext.html;442.49997502821805;450.8286850996621;456.9543045695429;498.6085922550797;559.7928766356449;27377.72622273779;29134;35168.99999999997;35363.646363536354;35453.936381908585;36825.263494730156;37283.4407483888;37296.44055339172;37337.626623733755;37516.81241593795;8144.877826832602;9238.214751746109;9424.575894084783;9454.243660507143;9529.666461673844;9397.013313602076;9625.37435066722;9626.181774549172;9668.854967175497;9670.468124253162;8307.210814972597;9583.377080489781;9646.324757266993;9651.227901767841;9704.854427183598;9579.425234485952;9603.423794572278;9605.519724013771;9687.951560242189;9714.028597140301;9449.196818270455;9572.234221262283;9598.568064437117;9609.13517783396;9613.855792163124;35404.468932966025;35435.645643543496;35842.46236306457;36005;36145.81927090348;2845.47358738634;3240.902772916816;3274.2469232076755;3361.798292102482;3413.3343997920415;26459.603105953425;27237.727622723716;27291.727082729118;27321.590176147176;27617;2751.7523422892036;2827.7313655202724;2850.0594803714725;2866.985665071682;2885.75471084958;399482;400064.99967500265;400974;401275;402693;54244.72877635666;60303;64773.676131619985;65706.0144097839;65760.34239657542;61281;61454.69272653608;61747.691261543405;62146;62157;15950.76073858893;15963.600909977344;15988.520344389686;16091.436799711953;16124.919375403048;12186.512539498499;12226.755464890652;12310.876891230973;12352.949999249984;12525.060620453502;17709.20308586117;19560;19580.412587622395;19679.508012299808;19693.40919772409;8898;9130.680426185052;9156.130167634064;9164.776077635817;9198.4480931143;916.9495677737789;950.7100334398075;1067.8771941226703;1090.5419723716059;1092.208149091902;27482.587761183597;28507.714922850508;28689.85655071711;29002;29256.85371573171;1011.8967586437068;1047.272145858621;1117.5306371324064;1137.056243318044;1159.9884001160049;14651;14756.409743610135;14837;15032.774508382383;15037.699246015018;553957;555246.2237688786;561030;561654;563305;55256;55509;55769.884602308535;56133.43866561282;56243;1273.4778740716263;1388.8333399992066;1428.9425824889715;1429.5068201470683;1434.4907557817032;24693;28603;28992.42015159727;29184.27039324034;29312.41375172527;39532.22105005224;44546.55453445424;47469.762651186524;47762;48010.03979920452;485886;489153;491543;494174;520707;29489;41354.79322603488;42815.9296017602;43026.78486607547;43188.784056080774;44266;44384.77807610941;44919.65241042643;45378.54621453743;45408.786834214894;33818;34339.11696282213;34699.65300346964;34932.30135397227;35113.29773404467;34217;34262.80080197281;34387.31225375429;34534.75524090926;34905.9528214154;35172.47241291332;35908.73218049736;35915.820420897726;36210.8189459051;36297.27405451929;31871.68128318687;32061.519077213394;32080.91474054179;32176.873809416556;33026.33947321088;23638.29085127449;23655.881720591286;23825.761742382354;23888.819456595375;23899.880500598083 05:30:33 INFO - PROCESS | 2965 | |2;jquery.html;356.1363693044368;361.6166863125087;362.9891103266903;363.3876917394191;375.7013174526251;13573.592792216237;14846.851531484683;18478.445646630607;18839.905800470977;19053.333133340355;11304.039156671672;18462.44612661619;19057.52356191096;19173.233070677157;19289.13198906049;5142.07442660321;5339.679619222839;5340.305760251162;5344.572434205274;5360.571154307646;5045.369328833895;5229.7385130743505;5252.290940722992;5258.92111618326;5281.5774738021055;3871;4911.5088491150955;5252;5261.973690131544;5264.499872512124;5818.883622327572;5854.88290234195;5861.912071318934;5873.67694776785;5879.647221166722;5431.83704488866;5673.489385955242;5735.799247026376;5737.311522617271;5743.4543718346695;23846.403839904142;23907.28278151641;24234.515309693707;24466;24519.632205516933;2280.521090570982;2409.289259668402;2517.282574466268;2771.4457108578163;2854.0866922584783;9646;9849.655262065793;9976.600935962553;10036.29745917786;10039.648612298535;1728.7752592162938;1849.3897013985352;1860.6464771693336;1863.9347622833272;1873.1477177884167;92491.53754231254;101768;101941.47087793615;102057.48971255096;102584;11006.944965275123;11212.66362009141;11258.66224013281;11262;11394.715132121597;12072.396380181131;13389;13441.596752097452;13476.05667603278;13509.86490135086;7043.577385356895;8079.5960201989665;8399.748007559783;8458.534780587004;8467.280281176169;8288.958555207306;8626.741197764077;8627.654893804303;8676.826463470821;8740;3689.612590677994;4286.7856607169515;4344.326629372389;4384.649228061748;4439.866803995886;1644.2929540297787;1845.4648152036027;1881.5766452548066;1907;1923.836473899706;388.42707007164205;396.02972716843846;417.4614746976427;424.5670860844649;428.15653163268314;14917.328720207617;16686.66626667484;18892.622147556973;20763;20862.26982055621;908.5230254116642;920.8066306075799;977.9755506112405;1040.939637465848;1045.1012129568717;8650.653973841101;10888.1236326305;10912.781744365067;11409.657710268706;11485.885141148648;748117;770276;773491;775765;785059;84628;106884;108390.91609083966;116331.8366816338;120468;1169.4678921090883;1192.3799624195544;1199.9580014699443;1202.7474230411713;1203.6879801016933;15758.606034849221;18363.632727345645;18680.34618788336;18716.438506844817;18790.53023674419;50001.249981251036;50687.23969140392;50866.491335086175;51499.48500514947;52579.737101315775;60745;74630.62684686542;74933.62533187299;75021.87467188106;75401.11497212613;7599;7894.052713674396;7910.367170626451;7934.603269836601;7961.402894782798;11451.885481145082;12281.87718122843;12294.815577766161;12405.379731013594;12667.746645067231;9989.200863930722;10604.045635892806;10655.467226638482;10702.411367374869;10799.838002429813;10384.273100882865;10499.580016799242;10616.681499555025;10635.042846143884;10948.726281843017;7927.762167134995;10941.945290273497;10998.780024399308;11153.051990580567;11190.216684831983;6548.639824809681;7634.580098094436;7695;7711.614419279126;7776.455648104805;9619.230461563198;10769.730756731144;10793.190510711886;10932.453377330943;11011.779764404828 05:30:33 INFO - PROCESS | 2965 | |3;mootools.html;1437.482506297733;1544.8377920318367;1758.1648716859493;1877.7371168036468;1883.1243471785626;7932.801679958004;8511.489310641366;8770.210681038714;8788.648454061846;8947.642094316228;8655.091215422384;8673.91326086739;8794.208521233088;8803.691870784523;8817.779555511115;2412.5657381671294;2428.854268743881;2452.337868775434;2470.765277298654;2471.938201544958;2423.5074255949435;2483.962740558893;2486.9057614649496;2493.451440683056;2495.6506089147533;2168.30614203455;2398.6641870138196;2400.95198096038;2418.3591348292716;2457.4716435966266;2411.8794060296914;2428.113738485458;2435.1598698449006;2469.444375015625;2481.702195736514;2452.0069371904406;2457.8648174350405;2459.1761759810483;2466.4943686544216;2474.183519438581;7892.447528672995;8352;8604.612792424294;8767.473951562926;8810.955945220298;4076.4496792932873;4583.2666773316105;4677.929831052537;5443.646162999393;5446.183072539111;3667.7065834733426;3706.4440333949856;3736.17804083104;3740.812959352049;3759.3045286622064;1048.6329784575414;1060.6870973062964;1063.292910214714;1094.7372630568686;1097.319661809683;12002.819957700642;12090.455929483194;12097.2136811107;12098.697532561668;12161.756764864653;4245.724027938174;4796.088743138793;4876.414830220397;4958.479359667255;4959.528844759742;10205.795884082425;10218.591256349662;10222.437765922798;10223.437710925822;10241.795164096677;5450.345958484928;5451.291332126877;5464.836054918359;5494.36814766299;5505.807296744595;4916.317991631785;4940.407151141886;4993.675411098267;5011.223260394645;5013.248012798036;3916.804159791999;3965.048388386824;3971.860984865516;3989.1423343980605;4027.9597204027586;1068.2041878800344;1281.1096288079882;1290.6579756364572;1306.758249723804;1321.1346567997978;1100.2463312630873;1111.1055600241882;1146.0487795130023;1246.2211118051218;1351.108268542757;7934.20657934202;8007.83984320322;8056.959715201387;8249.340052795762;8447.95776021116;1097.0948967102172;1138.3909608359488;1192.1773975956562;1199.1006744941294;1213.0538180219444;6303.6532990685955;6305.022721478178;6347.174867267318;6360.109584658151;6397.200349956255;10517.9474102629;10571.418571978462;10877.891221087846;10886.72783180411;10910.290831095954;10514.579416823395;10699.786004279871;10749.516271767789;10802.189835762349;10946.233763636468;8309.667613295522;8318.958405207935;8348.457350272212;8390.37072219586;8406.663733450594;7754.844903102019;7858.371330293677;7870.921290787248;7922.207779222032;7975.84048319042;9574.234061274941;9649.855252171363;9696.272779541703;9728.708138755848;9766.316357854881;9736.610535578497;10002.149817265614;10057.446840423847;10078.445685487368;10105.242106842163;6066.998945173997;7076.787696369117;7096.077509923677;7219.386352160125;7235.421166306577;8234.300084492885;8236.546989915372;8298.626561804855;8316.501009939422;8352.540610266493;6875;7155.677994490156;7757.301842834172;7792.220777922163;8015.879761803461;6905;7340.816479588053;7527.134379546423;7615.847683046197;7676.193999630182;7722.613869306625;7764.262395072459;7789.8831517528415;7822.882656760039;7842.882356764539;6867.622280774605;6999.860002800017;7037.577745335297;7052.18899826506;7061.152661680631;7056.6471676417;7067.328603782633;7087.645617719197;7126.144862616519;7185.497015208885 05:30:33 INFO - PROCESS | 2965 | |4;prototype.html;270.2190668966686;297.56258300298566;322.9580154579904;329.38240798502807;330.86765293882456;5494.313210848644;5496.422875598065;5966.254218222723;6819.693113809878;6876.381125698686;5871.737576421068;6625.469962403008;6756.12170417845;6875.6562171891455;6881.621510816903;5070.822521211759;5075.898482030358;5078.619103567238;5086.949130508703;5100.183970564711;4934.1611925972675;5070.416902056256;5092.84721458355;5098.872528186788;5120.820771273006;4958.8512344629535;5002.774875130628;5004.424491183524;5014.473480284572;5014.52362025607;4992.725400102993;4998.525140111684;4999.825006124786;5003.549680528734;5005.324281222025;3905.453236546886;3972.940405893914;4083.122128742305;4150.979245103786;4241.660667146652;5375.6774593524515;6397.976323788172;6515.3484651534945;6520.836979075513;6546.803595892084;4835.492273311322;5935.287765468128;5936.079907614327;5937.287525496925;5940.34656187819;5951.642901425885;7131.322524360177;7240;7329.303716146957;7331.486795924287;4766.903612169221;4795.784189711471;4797.856064318041;4799.544043315879;4822.686525375874;7770.378369730408;7790.571518566477;7794.064712234512;7809.609519524001;7840.843183136362;4723.787429565609;4864.562189402971;4881.170201065756;4892.290617860391;4916.262560615936;4136.296829538986;4164.250434921743;4965.478624744422;4968.975155124202;4988.401391832931;5905.202797622352;5922.170896074553;5925.466707996301;5930.584859059824;5937.910931336033;7367.447441441806;7398.96300518494;7411.59236242001;7417.776066949001;7424.071991001125;1607.9598010049842;1669.2988944643037;1673.4393978017501;1677.9916100419664;1709.7178965470807;906.7461110888962;1042.83314669654;1053.6154303679102;1054.4411461925192;1057.1014637558014;6839.2818754031105;6900.309969003059;6906.205786334636;6907.758228461979;6915.343042410963;7586.62066896653;7625.809354766176;7628.160902300742;7665.731699390494;7667.079950405875;6734.797956061228;6862.451003919675;6864.347886950732;6900.861982760417;7000.229974702778;3330.833458327074;3946.467226924386;4004.0990777074926;4119.299719047709;4125.29869922114;6955.269696681877;8062.274395304451;8137.104918458965;8139.633716482773;8160.4287699861625;7981.760547183594;7994.2405471480115;8003.679852805939;8016.959915200387;8027.839443211103;6465.900796864545;7236.276372362721;8109.959450202711;8128.471649342774;8138.104808471064;5867.413258674099;7338.752412089851;7691.653875575725;7711.652975615999;7731.613419328898;7366.742164024234;7552.962235188789;7587.430942679432;7592.278733520307;7608.087029556488;6603.537752357289;8084.959575202086;8118.75643730689;8131.390145738975;8135.430519863553;4737.9052418952115;4786.473487916257;4786.473487916396;4793.640476964311;4808.2547205183255;7499.700011999459;7745.186755390603;7750.844983100419;7755.961220193863;7766.339861111869;7433.25667433274;7459.515131516434;7467.663955121924;7497.9250207497225;7499.550026998179;7430.919342584085;7438.404927605887;7441.702331906663;7459.850802984019;7476.5514069156025;7027.543209691354;7227.434260837327;7236.855262894818;7254.927450725425;7312.890306645299;6677.998300254806;7162.498625096193;7442.96278518604;7453.888191677238;7459.627018649155;7122.928770712227;7330.266973302627;7336.669849856663;7341.74303899361;7351.228121047427 05:30:33 INFO - PROCESS | 2965 | |5;yui.html;659.5086660437975;665.6106177885937;729.0704351951262;734.8456824066946;742.8477162181754;14518.346674399678;14591.562253132397;14793.999999999987;14860.182689952047;14917.477888273912;13985.440582376717;15517.844821551782;15712.764308535352;15736.134512601802;15802;686.7527690031585;853.3685073045932;858.3176374782063;858.4034096303056;867.5445391169624;761.7067429039804;835.9665613375457;843.9915600844005;870.9651613935466;873.0963452826326;914.9725508234731;922.0733163171037;923.4736200365761;923.5705396990398;923.9168474837263;914.2548822709471;915.6474757218452;917.499962520428;918.3158546882548;919.8620206968975;648.9415952564292;677.6679427080695;679.1171477079777;680.2143524229523;681.4344094401634;9994.00059994002;15014.849851501454;15237.238138093162;15519.068855868683;15614.45349412765;11769.88230117705;12002.939985300105;12236.143469957107;12632;12652.177608455513;10840.078593319577;11056.060234880046;11114.833277500844;11541.480633371519;11913;3442.4147894857933;3471.340445315382;3483.6690514401093;3529.0118766745095;3540.044188069207;66859.3314066858;78419;80446.59776701138;81187.97030074237;90616.09383906209;9498.675483498322;9500.762480938032;9580.281478888972;9725.513724313756;9866.358686685342;20471;20615.175392984413;20765.79234207669;20777.168913243302;20792;6283.7800676977;7400.740974065882;7592.772216833504;7645.961770191114;7809.9456573363;4211.578842115825;4214.873553793391;4215.557366476476;4244.427002354704;4263.339182426729;3525.383057964846;3531.823408829548;3540.3804334241404;3554.982225088858;3563.6970857476886;649.8505343770959;651.4625434016955;660.0890770736353;678.3386198456564;690.6822861483773;532.3452153850708;598.7604958016741;605.3250625552478;606.4602503771647;617.3332800575367;7631.427642926803;8456.323494120456;8468.195521425578;8524.74425767228;8698.21716045559;503.2099603622278;594.4560726934893;613.4049971527611;621.2327775197627;635.9491240700733;3885.611438856148;4083.775392353449;4112.259793237186;4124.1133156371525;4239.788010599457;93167.06832931584;93255.53372233095;93311.5334423337;93857;95168;74802.25197748061;75402;76015.61992190004;77441;78419.60790196013;68342.65828670825;68360;69235.65382173056;69763;69822.95265570919;8758.99271583776;8835.425697329652;8889.73330800077;9031.774205644648;9163;49767.75116124396;51030.97938041144;53721.462785371645;54123.72938135442;54544;64467.8755518225;67958.66020669865;68453.3154668447;69160.65419672869;69198;10990.340579565252;11052.889471105185;11719.707007324885;11740.00209982127;12049.457774400349;10241.897581024094;11984.340861252715;12409.813852792035;12492.687682808002;12552.372381381078;11650.475728592064;11672.299662020307;11698.35659038761;11735.706607334885;11748.353840538852;10116.544755485873;11639.53441862316;11860.94069529647;11884.168108232687;12037.939810301243;11389.316641001566;11595.420228988685;11661.883381166419;11732;11820.172587918763;7867.527948323119;9631.951840240754;9797.890600970408;10038.49807509607;10183.643572474928;9643.373180743229;9830.213582913493;9846.901530984598;9864.506774661095;9910.504474776088 05:30:33 INFO - PROCESS | 2965 | __end_tp_report 05:30:33 INFO - PROCESS | 2965 | __start_cc_report 05:30:33 INFO - PROCESS | 2965 | _x_x_mozilla_cycle_collect,359 05:30:33 INFO - PROCESS | 2965 | __end_cc_report 05:30:33 INFO - PROCESS | 2965 | __startTimestamp1455715833040__endTimestamp 05:30:33 INFO - PROCESS | 2965 | 05:30:33 INFO - PROCESS | 2965 | ------- Summary: start ------- 05:30:33 INFO - PROCESS | 2965 | Number of tests: 6 05:30:33 INFO - PROCESS | 2965 | 05:30:33 INFO - PROCESS | 2965 | [#0] dojo.html Cycles:165 Average:5616.75 Median:5897.00 stddev:722.01 (12.2%) stddev-sans-first:691.39 05:30:33 INFO - PROCESS | 2965 | Values: 2872.6 2963.2 3186.4 3190.5 3356.9 5205.5 5666.4 5706.9 5715.5 5715.7 4673.2 5525.1 5558.9 5705.5 5885.1 4308.4 5112.8 5190.1 5220.6 5244.6 5122.4 5135.9 5224.6 5230.4 5248.6 4462.7 4480.9 5059.0 5064.4 5185.8 5065.1 5090.9 5111.7 5114.3 5161.2 4523.9 5044.5 5050.8 5065.2 5086.3 5439.3 5619.8 5622.7 5629.5 5633.5 6175.3 6211.5 6232.1 6238.8 6243.2 6147.1 6149.9 6218.2 6237.2 6238.5 4576.2 5471.5 5627.9 5653.5 5713.7 6154.3 6209.1 6211.7 6228.5 6240.7 6084.6 6097.2 6101.3 6115.1 6117.4 6153.9 6260.0 6272.2 6281.4 6341.0 6187.5 6193.3 6206.7 6226.5 6239.9 6090.9 6115.3 6152.2 6210.8 6252.0 4860.7 4868.8 4883.9 4906.1 4927.5 4331.7 4346.8 4386.0 4421.8 4422.7 4605.7 5695.5 5711.6 5763.4 5783.8 4751.3 5147.9 6140.4 6180.4 6193.3 4791.8 5520.6 5634.4 5640.8 5679.7 4536.6 4544.4 5051.0 5309.0 5401.0 6286.6 6315.1 6315.4 6316.6 6333.5 5189.5 6109.9 6114.0 6237.1 6279.6 6252.6 6270.0 6280.7 6304.9 6315.7 6105.1 6110.1 6181.5 6189.2 6199.6 6126.5 6152.9 6153.2 6187.1 6199.9 5978.3 6047.6 6073.4 6074.9 6090.6 5992.4 6027.8 6029.8 6031.5 6047.3 5710.8 5804.4 5886.2 5897.0 5946.3 5842.8 5995.9 6035.6 6081.5 6116.5 5904.9 5936.2 5959.4 5964.3 5967.7 05:30:33 INFO - PROCESS | 2965 | 05:30:33 INFO - PROCESS | 2965 | [#1] ext.html Cycles:180 Average:62378.08 Median:36075.41 stddev:130436.73 (361.6%) stddev-sans-first:130719.75 05:30:33 INFO - PROCESS | 2965 | Values: 442.5 450.8 457.0 498.6 559.8 27377.7 29134.0 35169.0 35363.6 35453.9 36825.3 37283.4 37296.4 37337.6 37516.8 8144.9 9238.2 9424.6 9454.2 9529.7 9397.0 9625.4 9626.2 9668.9 9670.5 8307.2 9583.4 9646.3 9651.2 9704.9 9579.4 9603.4 9605.5 9688.0 9714.0 9449.2 9572.2 9598.6 9609.1 9613.9 35404.5 35435.6 35842.5 36005.0 36145.8 2845.5 3240.9 3274.2 3361.8 3413.3 26459.6 27237.7 27291.7 27321.6 27617.0 2751.8 2827.7 2850.1 2867.0 2885.8 399482.0 400065.0 400974.0 401275.0 402693.0 54244.7 60303.0 64773.7 65706.0 65760.3 61281.0 61454.7 61747.7 62146.0 62157.0 15950.8 15963.6 15988.5 16091.4 16124.9 12186.5 12226.8 12310.9 12352.9 12525.1 17709.2 19560.0 19580.4 19679.5 19693.4 8898.0 9130.7 9156.1 9164.8 9198.4 916.9 950.7 1067.9 1090.5 1092.2 27482.6 28507.7 28689.9 29002.0 29256.9 1011.9 1047.3 1117.5 1137.1 1160.0 14651.0 14756.4 14837.0 15032.8 15037.7 553957.0 555246.2 561030.0 561654.0 563305.0 55256.0 55509.0 55769.9 56133.4 56243.0 1273.5 1388.8 1428.9 1429.5 1434.5 24693.0 28603.0 28992.4 29184.3 29312.4 39532.2 44546.6 47469.8 47762.0 48010.0 485886.0 489153.0 491543.0 494174.0 520707.0 29489.0 41354.8 42815.9 43026.8 43188.8 44266.0 44384.8 44919.7 45378.5 45408.8 33818.0 34339.1 34699.7 34932.3 35113.3 34217.0 34262.8 34387.3 34534.8 34906.0 35172.5 35908.7 35915.8 36210.8 36297.3 31871.7 32061.5 32080.9 32176.9 33026.3 23638.3 23655.9 23825.8 23888.8 23899.9 05:30:33 INFO - PROCESS | 2965 | 05:30:33 INFO - PROCESS | 2965 | [#2] jquery.html Cycles:180 Average:38006.84 Median:2644.36 stddev:126719.66 (4792.1%) stddev-sans-first:127043.60 05:30:33 INFO - PROCESS | 2965 | Values: 356.1 361.6 363.0 363.4 375.7 13573.6 14846.9 18478.4 18839.9 19053.3 11304.0 18462.4 19057.5 19173.2 19289.1 5142.1 5339.7 5340.3 5344.6 5360.6 5045.4 5229.7 5252.3 5258.9 5281.6 3871.0 4911.5 5252.0 5262.0 5264.5 5818.9 5854.9 5861.9 5873.7 5879.6 5431.8 5673.5 5735.8 5737.3 5743.5 23846.4 23907.3 24234.5 24466.0 24519.6 2280.5 2409.3 2517.3 2771.4 2854.1 9646.0 9849.7 9976.6 10036.3 10039.6 1728.8 1849.4 1860.6 1863.9 1873.1 92491.5 101768.0 101941.5 102057.5 102584.0 11006.9 11212.7 11258.7 11262.0 11394.7 12072.4 13389.0 13441.6 13476.1 13509.9 7043.6 8079.6 8399.7 8458.5 8467.3 8289.0 8626.7 8627.7 8676.8 8740.0 3689.6 4286.8 4344.3 4384.6 4439.9 1644.3 1845.5 1881.6 1907.0 1923.8 388.4 396.0 417.5 424.6 428.2 14917.3 16686.7 18892.6 20763.0 20862.3 908.5 920.8 978.0 1040.9 1045.1 8650.7 10888.1 10912.8 11409.7 11485.9 748117.0 770276.0 773491.0 775765.0 785059.0 84628.0 106884.0 108390.9 116331.8 120468.0 1169.5 1192.4 1200.0 1202.7 1203.7 15758.6 18363.6 18680.3 18716.4 18790.5 50001.2 50687.2 50866.5 51499.5 52579.7 60745.0 74630.6 74933.6 75021.9 75401.1 7599.0 7894.1 7910.4 7934.6 7961.4 11451.9 12281.9 12294.8 12405.4 12667.7 9989.2 10604.0 10655.5 10702.4 10799.8 10384.3 10499.6 10616.7 10635.0 10948.7 7927.8 10941.9 10998.8 11153.1 11190.2 6548.6 7634.6 7695.0 7711.6 7776.5 9619.2 10769.7 10793.2 10932.5 11011.8 05:30:33 INFO - PROCESS | 2965 | 05:30:33 INFO - PROCESS | 2965 | [#3] mootools.html Cycles:180 Average:6067.31 Median:4928.36 stddev:3211.75 (65.2%) stddev-sans-first:3201.90 05:30:33 INFO - PROCESS | 2965 | Values: 1437.5 1544.8 1758.2 1877.7 1883.1 7932.8 8511.5 8770.2 8788.6 8947.6 8655.1 8673.9 8794.2 8803.7 8817.8 2412.6 2428.9 2452.3 2470.8 2471.9 2423.5 2484.0 2486.9 2493.5 2495.7 2168.3 2398.7 2401.0 2418.4 2457.5 2411.9 2428.1 2435.2 2469.4 2481.7 2452.0 2457.9 2459.2 2466.5 2474.2 7892.4 8352.0 8604.6 8767.5 8811.0 4076.4 4583.3 4677.9 5443.6 5446.2 3667.7 3706.4 3736.2 3740.8 3759.3 1048.6 1060.7 1063.3 1094.7 1097.3 12002.8 12090.5 12097.2 12098.7 12161.8 4245.7 4796.1 4876.4 4958.5 4959.5 10205.8 10218.6 10222.4 10223.4 10241.8 5450.3 5451.3 5464.8 5494.4 5505.8 4916.3 4940.4 4993.7 5011.2 5013.2 3916.8 3965.0 3971.9 3989.1 4028.0 1068.2 1281.1 1290.7 1306.8 1321.1 1100.2 1111.1 1146.0 1246.2 1351.1 7934.2 8007.8 8057.0 8249.3 8448.0 1097.1 1138.4 1192.2 1199.1 1213.1 6303.7 6305.0 6347.2 6360.1 6397.2 10517.9 10571.4 10877.9 10886.7 10910.3 10514.6 10699.8 10749.5 10802.2 10946.2 8309.7 8319.0 8348.5 8390.4 8406.7 7754.8 7858.4 7870.9 7922.2 7975.8 9574.2 9649.9 9696.3 9728.7 9766.3 9736.6 10002.1 10057.4 10078.4 10105.2 6067.0 7076.8 7096.1 7219.4 7235.4 8234.3 8236.5 8298.6 8316.5 8352.5 6875.0 7155.7 7757.3 7792.2 8015.9 6905.0 7340.8 7527.1 7615.8 7676.2 7722.6 7764.3 7789.9 7822.9 7842.9 6867.6 6999.9 7037.6 7052.2 7061.2 7056.6 7067.3 7087.6 7126.1 7185.5 05:30:33 INFO - PROCESS | 2965 | 05:30:33 INFO - PROCESS | 2965 | [#4] prototype.html Cycles:180 Average:5971.05 Median:6787.91 stddev:1958.13 (28.8%) stddev-sans-first:1916.31 05:30:33 INFO - PROCESS | 2965 | Values: 270.2 297.6 323.0 329.4 330.9 5494.3 5496.4 5966.3 6819.7 6876.4 5871.7 6625.5 6756.1 6875.7 6881.6 5070.8 5075.9 5078.6 5086.9 5100.2 4934.2 5070.4 5092.8 5098.9 5120.8 4958.9 5002.8 5004.4 5014.5 5014.5 4992.7 4998.5 4999.8 5003.5 5005.3 3905.5 3972.9 4083.1 4151.0 4241.7 5375.7 6398.0 6515.3 6520.8 6546.8 4835.5 5935.3 5936.1 5937.3 5940.3 5951.6 7131.3 7240.0 7329.3 7331.5 4766.9 4795.8 4797.9 4799.5 4822.7 7770.4 7790.6 7794.1 7809.6 7840.8 4723.8 4864.6 4881.2 4892.3 4916.3 4136.3 4164.3 4965.5 4969.0 4988.4 5905.2 5922.2 5925.5 5930.6 5937.9 7367.4 7399.0 7411.6 7417.8 7424.1 1608.0 1669.3 1673.4 1678.0 1709.7 906.7 1042.8 1053.6 1054.4 1057.1 6839.3 6900.3 6906.2 6907.8 6915.3 7586.6 7625.8 7628.2 7665.7 7667.1 6734.8 6862.5 6864.3 6900.9 7000.2 3330.8 3946.5 4004.1 4119.3 4125.3 6955.3 8062.3 8137.1 8139.6 8160.4 7981.8 7994.2 8003.7 8017.0 8027.8 6465.9 7236.3 8110.0 8128.5 8138.1 5867.4 7338.8 7691.7 7711.7 7731.6 7366.7 7553.0 7587.4 7592.3 7608.1 6603.5 8085.0 8118.8 8131.4 8135.4 4737.9 4786.5 4786.5 4793.6 4808.3 7499.7 7745.2 7750.8 7756.0 7766.3 7433.3 7459.5 7467.7 7497.9 7499.6 7430.9 7438.4 7441.7 7459.9 7476.6 7027.5 7227.4 7236.9 7254.9 7312.9 6678.0 7162.5 7443.0 7453.9 7459.6 7122.9 7330.3 7336.7 7341.7 7351.2 05:30:33 INFO - PROCESS | 2965 | 05:30:33 INFO - PROCESS | 2965 | [#5] yui.html Cycles:180 Average:18384.49 Median:3459.86 stddev:25673.49 (742.0%) stddev-sans-first:25711.02 05:30:33 INFO - PROCESS | 2965 | Values: 659.5 665.6 729.1 734.8 742.8 14518.3 14591.6 14794.0 14860.2 14917.5 13985.4 15517.8 15712.8 15736.1 15802.0 686.8 853.4 858.3 858.4 867.5 761.7 836.0 844.0 871.0 873.1 915.0 922.1 923.5 923.6 923.9 914.3 915.6 917.5 918.3 919.9 648.9 677.7 679.1 680.2 681.4 9994.0 15014.8 15237.2 15519.1 15614.5 11769.9 12002.9 12236.1 12632.0 12652.2 10840.1 11056.1 11114.8 11541.5 11913.0 3442.4 3471.3 3483.7 3529.0 3540.0 66859.3 78419.0 80446.6 81188.0 90616.1 9498.7 9500.8 9580.3 9725.5 9866.4 20471.0 20615.2 20765.8 20777.2 20792.0 6283.8 7400.7 7592.8 7646.0 7809.9 4211.6 4214.9 4215.6 4244.4 4263.3 3525.4 3531.8 3540.4 3555.0 3563.7 649.9 651.5 660.1 678.3 690.7 532.3 598.8 605.3 606.5 617.3 7631.4 8456.3 8468.2 8524.7 8698.2 503.2 594.5 613.4 621.2 635.9 3885.6 4083.8 4112.3 4124.1 4239.8 93167.1 93255.5 93311.5 93857.0 95168.0 74802.3 75402.0 76015.6 77441.0 78419.6 68342.7 68360.0 69235.7 69763.0 69823.0 8759.0 8835.4 8889.7 9031.8 9163.0 49767.8 51031.0 53721.5 54123.7 54544.0 64467.9 67958.7 68453.3 69160.7 69198.0 10990.3 11052.9 11719.7 11740.0 12049.5 10241.9 11984.3 12409.8 12492.7 12552.4 11650.5 11672.3 11698.4 11735.7 11748.4 10116.5 11639.5 11860.9 11884.2 12037.9 11389.3 11595.4 11661.9 11732.0 11820.2 7867.5 9632.0 9797.9 10038.5 10183.6 9643.4 9830.2 9846.9 9864.5 9910.5 05:30:33 INFO - PROCESS | 2965 | -------- Summary: end -------- 05:30:33 INFO - PROCESS | 2965 | 05:30:33 INFO - TEST-INFO | 2965: exit 0 05:30:33 INFO - TEST-OK | dromaeo_css | took 1111294ms 05:30:33 INFO - TEST-START | kraken 05:30:33 INFO - operating with platform_type : mac_ 05:30:33 INFO - Initialising browser for kraken test... 05:30:33 INFO - TEST-INFO | started process 2971 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpIh0WJR/profile http://localhost:59273/getInfo.html) 05:30:36 INFO - PROCESS | 2971 | __metrics Screen width/height:1600/1200 05:30:36 INFO - PROCESS | 2971 | colorDepth:24 05:30:36 INFO - PROCESS | 2971 | Browser inner width/height: 1024/689 05:30:36 INFO - PROCESS | 2971 | __metrics 05:30:37 INFO - TEST-INFO | 2971: exit 0 05:30:37 INFO - Browser initialized. 05:30:37 INFO - Running cycle 1/1 for kraken test... 05:30:37 INFO - TEST-INFO | started process 2975 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpIh0WJR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:49 INFO - PROCESS | 2975 | RSS: Main: 257560576 05:30:49 INFO - PROCESS | 2975 | 05:30:52 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59273/tests/kraken/driver.html?testName=audio-beat-detection) 05:30:52 INFO - PROCESS | 2975 | RSS: Main: 269918208 05:30:52 INFO - PROCESS | 2975 | 05:30:55 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59273/tests/kraken/driver.html?testName=audio-dft) 05:30:56 INFO - PROCESS | 2975 | RSS: Main: 277078016 05:30:56 INFO - PROCESS | 2975 | 05:30:59 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59273/tests/kraken/driver.html?testName=audio-fft) 05:30:59 INFO - PROCESS | 2975 | RSS: Main: 281440256 05:30:59 INFO - PROCESS | 2975 | 05:31:01 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59273/tests/kraken/driver.html?testName=audio-oscillator) 05:31:02 INFO - PROCESS | 2975 | RSS: Main: 283660288 05:31:02 INFO - PROCESS | 2975 | 05:31:04 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:31:05 INFO - PROCESS | 2975 | RSS: Main: 284614656 05:31:05 INFO - PROCESS | 2975 | 05:31:08 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59273/tests/kraken/driver.html?testName=imaging-darkroom) 05:31:08 INFO - PROCESS | 2975 | RSS: Main: 284258304 05:31:08 INFO - PROCESS | 2975 | 05:31:11 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59273/tests/kraken/driver.html?testName=imaging-desaturate) 05:31:12 INFO - PROCESS | 2975 | RSS: Main: 283955200 05:31:12 INFO - PROCESS | 2975 | 05:31:15 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59273/tests/kraken/driver.html?testName=json-parse-financial) 05:31:16 INFO - PROCESS | 2975 | RSS: Main: 284434432 05:31:16 INFO - PROCESS | 2975 | 05:31:17 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:31:18 INFO - PROCESS | 2975 | RSS: Main: 283422720 05:31:18 INFO - PROCESS | 2975 | 05:31:19 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59273/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:31:20 INFO - PROCESS | 2975 | RSS: Main: 282963968 05:31:20 INFO - PROCESS | 2975 | 05:31:22 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:31:23 INFO - PROCESS | 2975 | RSS: Main: 285384704 05:31:23 INFO - PROCESS | 2975 | 05:31:26 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:31:26 INFO - PROCESS | 2975 | RSS: Main: 283344896 05:31:26 INFO - PROCESS | 2975 | 05:31:29 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:31:30 INFO - PROCESS | 2975 | RSS: Main: 283107328 05:31:30 INFO - PROCESS | 2975 | 05:31:31 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59273/tests/kraken/driver.html?testName=ai-astar) 05:31:32 INFO - PROCESS | 2975 | RSS: Main: 285855744 05:31:32 INFO - PROCESS | 2975 | 05:31:32 INFO - PROCESS | 2975 | __start_tp_report 05:31:32 INFO - PROCESS | 2975 | _x_x_mozilla_page_load 05:31:32 INFO - PROCESS | 2975 | _x_x_mozilla_page_load_details 05:31:32 INFO - PROCESS | 2975 | |i|pagename|runs| 05:31:32 INFO - PROCESS | 2975 | |0;ai-astar;115;110;115;115;116;128;114;115;118;116 05:31:32 INFO - PROCESS | 2975 | |1;audio-beat-detection;152;119;148;163;154;161;143;123;197;113 05:31:32 INFO - PROCESS | 2975 | |2;audio-dft;196;199;200;206;209;233;196;195;206;197 05:31:32 INFO - PROCESS | 2975 | |3;audio-fft;56;62;80;69;128;55;57;57;60;103 05:31:32 INFO - PROCESS | 2975 | |4;audio-oscillator;79;91;132;80;81;83;119;81;83;117 05:31:32 INFO - PROCESS | 2975 | |5;imaging-gaussian-blur;91;84;131;140;123;94;90;95;120;123 05:31:32 INFO - PROCESS | 2975 | |6;imaging-darkroom;99;104;97;129;124;90;146;127;150;152 05:31:32 INFO - PROCESS | 2975 | |7;imaging-desaturate;90;130;144;100;90;94;92;92;110;92 05:31:32 INFO - PROCESS | 2975 | |8;json-parse-financial;59;58;55;57;54;56;54;63;57;55 05:31:32 INFO - PROCESS | 2975 | |9;json-stringify-tinderbox;63;63;74;77;73;72;96;60;64;81 05:31:32 INFO - PROCESS | 2975 | |10;stanford-crypto-aes;100;103;108;110;85;87;104;110;111;110 05:31:32 INFO - PROCESS | 2975 | |11;stanford-crypto-ccm;155;139;135;118;129;149;132;123;132;143 05:31:32 INFO - PROCESS | 2975 | |12;stanford-crypto-pbkdf2;141;144;138;162;182;129;178;184;137;141 05:31:32 INFO - PROCESS | 2975 | |13;stanford-crypto-sha256-iterative;70;67;86;98;103;81;69;70;67;98 05:31:32 INFO - PROCESS | 2975 | __end_tp_report 05:31:32 INFO - PROCESS | 2975 | __start_cc_report 05:31:32 INFO - PROCESS | 2975 | _x_x_mozilla_cycle_collect,913 05:31:32 INFO - PROCESS | 2975 | __end_cc_report 05:31:32 INFO - PROCESS | 2975 | __startTimestamp1455715892114__endTimestamp 05:31:32 INFO - PROCESS | 2975 | 05:31:32 INFO - PROCESS | 2975 | ------- Summary: start ------- 05:31:32 INFO - PROCESS | 2975 | Number of tests: 14 05:31:32 INFO - PROCESS | 2975 | 05:31:32 INFO - PROCESS | 2975 | [#0] ai-astar Cycles:10 Average:116.20 Median:115.50 stddev:4.61 (4.0%) stddev-sans-first:4.87 05:31:32 INFO - PROCESS | 2975 | Values: 115.0 110.0 115.0 115.0 116.0 128.0 114.0 115.0 118.0 116.0 05:31:32 INFO - PROCESS | 2975 | 05:31:32 INFO - PROCESS | 2975 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:153.00 stddev:24.85 (16.2%) stddev-sans-first:26.30 05:31:32 INFO - PROCESS | 2975 | Values: 152.0 119.0 148.0 163.0 154.0 161.0 143.0 123.0 197.0 113.0 05:31:32 INFO - PROCESS | 2975 | 05:31:32 INFO - PROCESS | 2975 | [#2] audio-dft Cycles:10 Average:203.70 Median:203.00 stddev:11.41 (5.6%) stddev-sans-first:11.76 05:31:32 INFO - PROCESS | 2975 | Values: 196.0 199.0 200.0 206.0 209.0 233.0 196.0 195.0 206.0 197.0 05:31:32 INFO - PROCESS | 2975 | 05:31:32 INFO - PROCESS | 2975 | [#3] audio-fft Cycles:10 Average:72.70 Median:58.50 stddev:24.50 (41.9%) stddev-sans-first:25.23 05:31:32 INFO - PROCESS | 2975 | Values: 56.0 62.0 80.0 69.0 128.0 55.0 57.0 57.0 60.0 103.0 05:31:32 INFO - PROCESS | 2975 | 05:31:32 INFO - PROCESS | 2975 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:81.00 stddev:20.01 (24.7%) stddev-sans-first:20.41 05:31:32 INFO - PROCESS | 2975 | Values: 79.0 91.0 132.0 80.0 81.0 83.0 119.0 81.0 83.0 117.0 05:31:32 INFO - PROCESS | 2975 | 05:31:32 INFO - PROCESS | 2975 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:87.00 stddev:20.25 (23.3%) stddev-sans-first:20.39 05:31:32 INFO - PROCESS | 2975 | Values: 91.0 84.0 131.0 140.0 123.0 94.0 90.0 95.0 120.0 123.0 05:31:32 INFO - PROCESS | 2975 | 05:31:32 INFO - PROCESS | 2975 | [#6] imaging-darkroom Cycles:10 Average:121.80 Median:151.00 stddev:23.19 (15.4%) stddev-sans-first:23.08 05:31:32 INFO - PROCESS | 2975 | Values: 99.0 104.0 97.0 129.0 124.0 90.0 146.0 127.0 150.0 152.0 05:31:32 INFO - PROCESS | 2975 | 05:31:32 INFO - PROCESS | 2975 | [#7] imaging-desaturate Cycles:10 Average:103.40 Median:91.00 stddev:19.00 (20.9%) stddev-sans-first:19.52 05:31:32 INFO - PROCESS | 2975 | Values: 90.0 130.0 144.0 100.0 90.0 94.0 92.0 92.0 110.0 92.0 05:31:32 INFO - PROCESS | 2975 | 05:31:32 INFO - PROCESS | 2975 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.00 stddev:2.74 (4.8%) stddev-sans-first:2.79 05:31:32 INFO - PROCESS | 2975 | Values: 59.0 58.0 55.0 57.0 54.0 56.0 54.0 63.0 57.0 55.0 05:31:32 INFO - PROCESS | 2975 | 05:31:32 INFO - PROCESS | 2975 | [#9] json-stringify-tinderbox Cycles:10 Average:72.30 Median:73.50 stddev:10.83 (14.7%) stddev-sans-first:10.95 05:31:32 INFO - PROCESS | 2975 | Values: 63.0 63.0 74.0 77.0 73.0 72.0 96.0 60.0 64.0 81.0 05:31:32 INFO - PROCESS | 2975 | 05:31:32 INFO - PROCESS | 2975 | [#10] stanford-crypto-aes Cycles:10 Average:102.80 Median:110.00 stddev:9.58 (8.7%) stddev-sans-first:10.11 05:31:32 INFO - PROCESS | 2975 | Values: 100.0 103.0 108.0 110.0 85.0 87.0 104.0 110.0 111.0 110.0 05:31:32 INFO - PROCESS | 2975 | 05:31:32 INFO - PROCESS | 2975 | [#11] stanford-crypto-ccm Cycles:10 Average:135.50 Median:137.00 stddev:11.36 (8.3%) stddev-sans-first:9.60 05:31:32 INFO - PROCESS | 2975 | Values: 155.0 139.0 135.0 118.0 129.0 149.0 132.0 123.0 132.0 143.0 05:31:32 INFO - PROCESS | 2975 | 05:31:32 INFO - PROCESS | 2975 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.60 Median:153.00 stddev:20.90 (13.7%) stddev-sans-first:21.66 05:31:32 INFO - PROCESS | 2975 | Values: 141.0 144.0 138.0 162.0 182.0 129.0 178.0 184.0 137.0 141.0 05:31:32 INFO - PROCESS | 2975 | 05:31:32 INFO - PROCESS | 2975 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.90 Median:75.50 stddev:14.39 (19.1%) stddev-sans-first:14.72 05:31:32 INFO - PROCESS | 2975 | Values: 70.0 67.0 86.0 98.0 103.0 81.0 69.0 70.0 67.0 98.0 05:31:32 INFO - PROCESS | 2975 | -------- Summary: end -------- 05:31:32 INFO - PROCESS | 2975 | 05:31:32 INFO - TEST-INFO | 2975: exit 0 05:31:32 INFO - TEST-OK | kraken | took 59183ms 05:31:32 INFO - SUITE-END | took 1170s 05:31:33 INFO - Completed test suite (00:19:30) 05:31:33 INFO - Working with test: dromaeo_css 05:31:33 INFO - Generating results file: dromaeo_css 05:31:33 INFO - Working with test: kraken 05:31:33 INFO - Generating results file: kraken 05:31:33 INFO - javascript benchmark 05:31:33 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:31:33 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 05:31:33 INFO - process_Request line: dromaeo_css 7475.94 graph.html#tests=[[72,1,61]] 05:31:33 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:31:33 INFO - process_Request line: kraken 1570.70 graph.html#tests=[[232,1,61]] 05:31:33 INFO - RETURN: dromaeo_css: 7475.94 05:31:33 INFO - RETURN: kraken: 1570.70 05:31:33 INFO - javascript benchmark 05:31:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2872.597836302917, 2963.170312312553, 3186.4264432402174, 3190.5214217867324, 3356.942563092624, 5205.453427390122, 5666.433356664336, 5706.885862282752, 5715.457031581993, 5715.714214289284, 4673.228917228653, 5525.11598144297, 5558.888822223553, 5705.543556515479, 5885.146653735206, 4308.418363520932, 5112.795488180478, 5190.06578815813, 5220.634555581092, 5244.606654500928, 5122.385313762354, 5135.922961155586, 5224.63427560071, 5230.372355317349, 5248.606354523426, 4462.709923854939, 4480.865574032784, 5058.988202359506, 5064.366954130734, 5185.792568297264, 5065.11360511909, 5090.872728181788, 5111.718855462948, 5114.28400023997, 5161.200013997836, 4523.864284071483, 5044.495550444963, 5050.797968081272, 5065.189569668835, 5086.287919691246, 5439.292891924064, 5619.803306884281, 5622.662640241599, 5629.4652008059575, 5633.492985631272, 6175.2589689237575, 6211.503079753609, 6232.127502149703, 6238.814625221239, 6243.157173781527, 6147.108669242934, 6149.938500614981, 6218.191635087455, 6237.157983672191, 6238.532110091716, 4576.153411618861, 5471.452854714536, 5627.915581266284, 5653.547716182655, 5713.74288157034, 6154.323024467305, 6209.0996805462955, 6211.720472578745, 6228.532860035515, 6240.719167637467, 6084.60450070744, 6097.222222222223, 6101.298350689639, 6115.082737589309, 6117.418845209698, 6153.892299386064, 6259.96870015647, 6272.2159730033745, 6281.434670879643, 6340.985442329205, 6187.504999600022, 6193.318734939153, 6206.689665516707, 6226.470749986302, 6239.937600624026, 6090.939090609126, 6115.296740874767, 6152.230971128609, 6210.844728881814, 6251.9687401562705, 4860.684055536379, 4868.756562171948, 4883.877903052452, 4906.1414252505665, 4927.457979622239, 4331.696781225347, 4346.847860324873, 4386.0, 4421.801018954155, 4422.7346359218545, 4605.723656580616, 5695.487406133468, 5711.571632127607, 5763.366029736726, 5783.768649253982, 4751.311059896296, 5147.871303217449, 6140.355262697352, 6180.351063138396, 6193.349698281706, 4791.784369703371, 5520.641158324696, 5634.408387119293, 5640.802571909963, 5679.716014199274, 4536.637069034469, 4544.363789069533, 5051.015052064886, 5308.973455132699, 5400.972995135077, 6286.622802631857, 6315.084312774622, 6315.431611155018, 6316.62100273985, 6333.493320534346, 5189.481051894781, 6109.890546868166, 6113.962834745988, 6237.126802247598, 6279.623222606659, 6252.5935814171935, 6269.968650156902, 6280.7487700491465, 6304.873902521832, 6315.652639104894, 6105.084237364431, 6110.114033465212, 6181.474574661204, 6189.164462797645, 6199.628022318675, 6126.5098792097415, 6152.861720581706, 6153.169322141633, 6187.071939209155, 6199.938000619936, 5978.252718410199, 6047.637141771508, 6073.362296958756, 6074.908876366946, 6090.634561926298, 5992.43071908168, 6027.78902738402, 6029.758809647565, 6031.457168854824, 6047.274327080779, 5710.8001219957105, 5804.419558044162, 5886.234789477512, 5897.0, 5946.316173639913, 5842.802225543668, 5995.940040599538, 6035.6076855004285, 6081.513478921587, 6116.510679145568, 5904.852378690567, 5936.198613187337, 5959.374265702038, 5964.343922168645, 5967.731452084753], "unit": "score", "name": "dojo.html", "value": 5567.28015599641}, {"lowerIsBetter": false, "replicates": [442.49997502821805, 450.8286850996621, 456.9543045695429, 498.6085922550797, 559.7928766356449, 27377.72622273779, 29134.0, 35168.99999999997, 35363.646363536354, 35453.936381908585, 36825.263494730156, 37283.4407483888, 37296.44055339172, 37337.626623733755, 37516.81241593795, 8144.877826832602, 9238.214751746109, 9424.575894084783, 9454.243660507143, 9529.666461673844, 9397.013313602076, 9625.37435066722, 9626.181774549172, 9668.854967175497, 9670.468124253162, 8307.210814972597, 9583.377080489781, 9646.324757266993, 9651.227901767841, 9704.854427183598, 9579.425234485952, 9603.423794572278, 9605.519724013771, 9687.951560242189, 9714.028597140301, 9449.196818270455, 9572.234221262283, 9598.568064437117, 9609.13517783396, 9613.855792163124, 35404.468932966025, 35435.645643543496, 35842.46236306457, 36005.0, 36145.81927090348, 2845.47358738634, 3240.902772916816, 3274.2469232076755, 3361.798292102482, 3413.3343997920415, 26459.603105953425, 27237.727622723716, 27291.727082729118, 27321.590176147176, 27617.0, 2751.7523422892036, 2827.7313655202724, 2850.0594803714725, 2866.985665071682, 2885.75471084958, 399482.0, 400064.99967500265, 400974.0, 401275.0, 402693.0, 54244.72877635666, 60303.0, 64773.676131619985, 65706.0144097839, 65760.34239657542, 61281.0, 61454.69272653608, 61747.691261543405, 62146.0, 62157.0, 15950.76073858893, 15963.600909977344, 15988.520344389686, 16091.436799711953, 16124.919375403048, 12186.512539498499, 12226.755464890652, 12310.876891230973, 12352.949999249984, 12525.060620453502, 17709.20308586117, 19560.0, 19580.412587622395, 19679.508012299808, 19693.40919772409, 8898.0, 9130.680426185052, 9156.130167634064, 9164.776077635817, 9198.4480931143, 916.9495677737789, 950.7100334398075, 1067.8771941226703, 1090.5419723716059, 1092.208149091902, 27482.587761183597, 28507.714922850508, 28689.85655071711, 29002.0, 29256.85371573171, 1011.8967586437068, 1047.272145858621, 1117.5306371324064, 1137.056243318044, 1159.9884001160049, 14651.0, 14756.409743610135, 14837.0, 15032.774508382383, 15037.699246015018, 553957.0, 555246.2237688786, 561030.0, 561654.0, 563305.0, 55256.0, 55509.0, 55769.884602308535, 56133.43866561282, 56243.0, 1273.4778740716263, 1388.8333399992066, 1428.9425824889715, 1429.5068201470683, 1434.4907557817032, 24693.0, 28603.0, 28992.42015159727, 29184.27039324034, 29312.41375172527, 39532.22105005224, 44546.55453445424, 47469.762651186524, 47762.0, 48010.03979920452, 485886.0, 489153.0, 491543.0, 494174.0, 520707.0, 29489.0, 41354.79322603488, 42815.9296017602, 43026.78486607547, 43188.784056080774, 44266.0, 44384.77807610941, 44919.65241042643, 45378.54621453743, 45408.786834214894, 33818.0, 34339.11696282213, 34699.65300346964, 34932.30135397227, 35113.29773404467, 34217.0, 34262.80080197281, 34387.31225375429, 34534.75524090926, 34905.9528214154, 35172.47241291332, 35908.73218049736, 35915.820420897726, 36210.8189459051, 36297.27405451929, 31871.68128318687, 32061.519077213394, 32080.91474054179, 32176.873809416556, 33026.33947321088, 23638.29085127449, 23655.881720591286, 23825.761742382354, 23888.819456595375, 23899.880500598083], "unit": "score", "name": "ext.html", "value": 19216.7419438669}, {"lowerIsBetter": false, "replicates": [356.1363693044368, 361.6166863125087, 362.9891103266903, 363.3876917394191, 375.7013174526251, 13573.592792216237, 14846.851531484683, 18478.445646630607, 18839.905800470977, 19053.333133340355, 11304.039156671672, 18462.44612661619, 19057.52356191096, 19173.233070677157, 19289.13198906049, 5142.07442660321, 5339.679619222839, 5340.305760251162, 5344.572434205274, 5360.571154307646, 5045.369328833895, 5229.7385130743505, 5252.290940722992, 5258.92111618326, 5281.5774738021055, 3871.0, 4911.5088491150955, 5252.0, 5261.973690131544, 5264.499872512124, 5818.883622327572, 5854.88290234195, 5861.912071318934, 5873.67694776785, 5879.647221166722, 5431.83704488866, 5673.489385955242, 5735.799247026376, 5737.311522617271, 5743.4543718346695, 23846.403839904142, 23907.28278151641, 24234.515309693707, 24466.0, 24519.632205516933, 2280.521090570982, 2409.289259668402, 2517.282574466268, 2771.4457108578163, 2854.0866922584783, 9646.0, 9849.655262065793, 9976.600935962553, 10036.29745917786, 10039.648612298535, 1728.7752592162938, 1849.3897013985352, 1860.6464771693336, 1863.9347622833272, 1873.1477177884167, 92491.53754231254, 101768.0, 101941.47087793615, 102057.48971255096, 102584.0, 11006.944965275123, 11212.66362009141, 11258.66224013281, 11262.0, 11394.715132121597, 12072.396380181131, 13389.0, 13441.596752097452, 13476.05667603278, 13509.86490135086, 7043.577385356895, 8079.5960201989665, 8399.748007559783, 8458.534780587004, 8467.280281176169, 8288.958555207306, 8626.741197764077, 8627.654893804303, 8676.826463470821, 8740.0, 3689.612590677994, 4286.7856607169515, 4344.326629372389, 4384.649228061748, 4439.866803995886, 1644.2929540297787, 1845.4648152036027, 1881.5766452548066, 1907.0, 1923.836473899706, 388.42707007164205, 396.02972716843846, 417.4614746976427, 424.5670860844649, 428.15653163268314, 14917.328720207617, 16686.66626667484, 18892.622147556973, 20763.0, 20862.26982055621, 908.5230254116642, 920.8066306075799, 977.9755506112405, 1040.939637465848, 1045.1012129568717, 8650.653973841101, 10888.1236326305, 10912.781744365067, 11409.657710268706, 11485.885141148648, 748117.0, 770276.0, 773491.0, 775765.0, 785059.0, 84628.0, 106884.0, 108390.91609083966, 116331.8366816338, 120468.0, 1169.4678921090883, 1192.3799624195544, 1199.9580014699443, 1202.7474230411713, 1203.6879801016933, 15758.606034849221, 18363.632727345645, 18680.34618788336, 18716.438506844817, 18790.53023674419, 50001.249981251036, 50687.23969140392, 50866.491335086175, 51499.48500514947, 52579.737101315775, 60745.0, 74630.62684686542, 74933.62533187299, 75021.87467188106, 75401.11497212613, 7599.0, 7894.052713674396, 7910.367170626451, 7934.603269836601, 7961.402894782798, 11451.885481145082, 12281.87718122843, 12294.815577766161, 12405.379731013594, 12667.746645067231, 9989.200863930722, 10604.045635892806, 10655.467226638482, 10702.411367374869, 10799.838002429813, 10384.273100882865, 10499.580016799242, 10616.681499555025, 10635.042846143884, 10948.726281843017, 7927.762167134995, 10941.945290273497, 10998.780024399308, 11153.051990580567, 11190.216684831983, 6548.639824809681, 7634.580098094436, 7695.0, 7711.614419279126, 7776.455648104805, 9619.230461563198, 10769.730756731144, 10793.190510711886, 10932.453377330943, 11011.779764404828], "unit": "score", "name": "jquery.html", "value": 8977.076012007688}, {"lowerIsBetter": false, "replicates": [1437.482506297733, 1544.8377920318367, 1758.1648716859493, 1877.7371168036468, 1883.1243471785626, 7932.801679958004, 8511.489310641366, 8770.210681038714, 8788.648454061846, 8947.642094316228, 8655.091215422384, 8673.91326086739, 8794.208521233088, 8803.691870784523, 8817.779555511115, 2412.5657381671294, 2428.854268743881, 2452.337868775434, 2470.765277298654, 2471.938201544958, 2423.5074255949435, 2483.962740558893, 2486.9057614649496, 2493.451440683056, 2495.6506089147533, 2168.30614203455, 2398.6641870138196, 2400.95198096038, 2418.3591348292716, 2457.4716435966266, 2411.8794060296914, 2428.113738485458, 2435.1598698449006, 2469.444375015625, 2481.702195736514, 2452.0069371904406, 2457.8648174350405, 2459.1761759810483, 2466.4943686544216, 2474.183519438581, 7892.447528672995, 8352.0, 8604.612792424294, 8767.473951562926, 8810.955945220298, 4076.4496792932873, 4583.2666773316105, 4677.929831052537, 5443.646162999393, 5446.183072539111, 3667.7065834733426, 3706.4440333949856, 3736.17804083104, 3740.812959352049, 3759.3045286622064, 1048.6329784575414, 1060.6870973062964, 1063.292910214714, 1094.7372630568686, 1097.319661809683, 12002.819957700642, 12090.455929483194, 12097.2136811107, 12098.697532561668, 12161.756764864653, 4245.724027938174, 4796.088743138793, 4876.414830220397, 4958.479359667255, 4959.528844759742, 10205.795884082425, 10218.591256349662, 10222.437765922798, 10223.437710925822, 10241.795164096677, 5450.345958484928, 5451.291332126877, 5464.836054918359, 5494.36814766299, 5505.807296744595, 4916.317991631785, 4940.407151141886, 4993.675411098267, 5011.223260394645, 5013.248012798036, 3916.804159791999, 3965.048388386824, 3971.860984865516, 3989.1423343980605, 4027.9597204027586, 1068.2041878800344, 1281.1096288079882, 1290.6579756364572, 1306.758249723804, 1321.1346567997978, 1100.2463312630873, 1111.1055600241882, 1146.0487795130023, 1246.2211118051218, 1351.108268542757, 7934.20657934202, 8007.83984320322, 8056.959715201387, 8249.340052795762, 8447.95776021116, 1097.0948967102172, 1138.3909608359488, 1192.1773975956562, 1199.1006744941294, 1213.0538180219444, 6303.6532990685955, 6305.022721478178, 6347.174867267318, 6360.109584658151, 6397.200349956255, 10517.9474102629, 10571.418571978462, 10877.891221087846, 10886.72783180411, 10910.290831095954, 10514.579416823395, 10699.786004279871, 10749.516271767789, 10802.189835762349, 10946.233763636468, 8309.667613295522, 8318.958405207935, 8348.457350272212, 8390.37072219586, 8406.663733450594, 7754.844903102019, 7858.371330293677, 7870.921290787248, 7922.207779222032, 7975.84048319042, 9574.234061274941, 9649.855252171363, 9696.272779541703, 9728.708138755848, 9766.316357854881, 9736.610535578497, 10002.149817265614, 10057.446840423847, 10078.445685487368, 10105.242106842163, 6066.998945173997, 7076.787696369117, 7096.077509923677, 7219.386352160125, 7235.421166306577, 8234.300084492885, 8236.546989915372, 8298.626561804855, 8316.501009939422, 8352.540610266493, 6875.0, 7155.677994490156, 7757.301842834172, 7792.220777922163, 8015.879761803461, 6905.0, 7340.816479588053, 7527.134379546423, 7615.847683046197, 7676.193999630182, 7722.613869306625, 7764.262395072459, 7789.8831517528415, 7822.882656760039, 7842.882356764539, 6867.622280774605, 6999.860002800017, 7037.577745335297, 7052.18899826506, 7061.152661680631, 7056.6471676417, 7067.328603782633, 7087.645617719197, 7126.144862616519, 7185.497015208885], "unit": "score", "name": "mootools.html", "value": 4941.661795532761}, {"lowerIsBetter": false, "replicates": [270.2190668966686, 297.56258300298566, 322.9580154579904, 329.38240798502807, 330.86765293882456, 5494.313210848644, 5496.422875598065, 5966.254218222723, 6819.693113809878, 6876.381125698686, 5871.737576421068, 6625.469962403008, 6756.12170417845, 6875.6562171891455, 6881.621510816903, 5070.822521211759, 5075.898482030358, 5078.619103567238, 5086.949130508703, 5100.183970564711, 4934.1611925972675, 5070.416902056256, 5092.84721458355, 5098.872528186788, 5120.820771273006, 4958.8512344629535, 5002.774875130628, 5004.424491183524, 5014.473480284572, 5014.52362025607, 4992.725400102993, 4998.525140111684, 4999.825006124786, 5003.549680528734, 5005.324281222025, 3905.453236546886, 3972.940405893914, 4083.122128742305, 4150.979245103786, 4241.660667146652, 5375.6774593524515, 6397.976323788172, 6515.3484651534945, 6520.836979075513, 6546.803595892084, 4835.492273311322, 5935.287765468128, 5936.079907614327, 5937.287525496925, 5940.34656187819, 5951.642901425885, 7131.322524360177, 7240.0, 7329.303716146957, 7331.486795924287, 4766.903612169221, 4795.784189711471, 4797.856064318041, 4799.544043315879, 4822.686525375874, 7770.378369730408, 7790.571518566477, 7794.064712234512, 7809.609519524001, 7840.843183136362, 4723.787429565609, 4864.562189402971, 4881.170201065756, 4892.290617860391, 4916.262560615936, 4136.296829538986, 4164.250434921743, 4965.478624744422, 4968.975155124202, 4988.401391832931, 5905.202797622352, 5922.170896074553, 5925.466707996301, 5930.584859059824, 5937.910931336033, 7367.447441441806, 7398.96300518494, 7411.59236242001, 7417.776066949001, 7424.071991001125, 1607.9598010049842, 1669.2988944643037, 1673.4393978017501, 1677.9916100419664, 1709.7178965470807, 906.7461110888962, 1042.83314669654, 1053.6154303679102, 1054.4411461925192, 1057.1014637558014, 6839.2818754031105, 6900.309969003059, 6906.205786334636, 6907.758228461979, 6915.343042410963, 7586.62066896653, 7625.809354766176, 7628.160902300742, 7665.731699390494, 7667.079950405875, 6734.797956061228, 6862.451003919675, 6864.347886950732, 6900.861982760417, 7000.229974702778, 3330.833458327074, 3946.467226924386, 4004.0990777074926, 4119.299719047709, 4125.29869922114, 6955.269696681877, 8062.274395304451, 8137.104918458965, 8139.633716482773, 8160.4287699861625, 7981.760547183594, 7994.2405471480115, 8003.679852805939, 8016.959915200387, 8027.839443211103, 6465.900796864545, 7236.276372362721, 8109.959450202711, 8128.471649342774, 8138.104808471064, 5867.413258674099, 7338.752412089851, 7691.653875575725, 7711.652975615999, 7731.613419328898, 7366.742164024234, 7552.962235188789, 7587.430942679432, 7592.278733520307, 7608.087029556488, 6603.537752357289, 8084.959575202086, 8118.75643730689, 8131.390145738975, 8135.430519863553, 4737.9052418952115, 4786.473487916257, 4786.473487916396, 4793.640476964311, 4808.2547205183255, 7499.700011999459, 7745.186755390603, 7750.844983100419, 7755.961220193863, 7766.339861111869, 7433.25667433274, 7459.515131516434, 7467.663955121924, 7497.9250207497225, 7499.550026998179, 7430.919342584085, 7438.404927605887, 7441.702331906663, 7459.850802984019, 7476.5514069156025, 7027.543209691354, 7227.434260837327, 7236.855262894818, 7254.927450725425, 7312.890306645299, 6677.998300254806, 7162.498625096193, 7442.96278518604, 7453.888191677238, 7459.627018649155, 7122.928770712227, 7330.266973302627, 7336.669849856663, 7341.74303899361, 7351.228121047427], "unit": "score", "name": "prototype.html", "value": 5300.325630810498}, {"lowerIsBetter": false, "replicates": [659.5086660437975, 665.6106177885937, 729.0704351951262, 734.8456824066946, 742.8477162181754, 14518.346674399678, 14591.562253132397, 14793.999999999987, 14860.182689952047, 14917.477888273912, 13985.440582376717, 15517.844821551782, 15712.764308535352, 15736.134512601802, 15802.0, 686.7527690031585, 853.3685073045932, 858.3176374782063, 858.4034096303056, 867.5445391169624, 761.7067429039804, 835.9665613375457, 843.9915600844005, 870.9651613935466, 873.0963452826326, 914.9725508234731, 922.0733163171037, 923.4736200365761, 923.5705396990398, 923.9168474837263, 914.2548822709471, 915.6474757218452, 917.499962520428, 918.3158546882548, 919.8620206968975, 648.9415952564292, 677.6679427080695, 679.1171477079777, 680.2143524229523, 681.4344094401634, 9994.00059994002, 15014.849851501454, 15237.238138093162, 15519.068855868683, 15614.45349412765, 11769.88230117705, 12002.939985300105, 12236.143469957107, 12632.0, 12652.177608455513, 10840.078593319577, 11056.060234880046, 11114.833277500844, 11541.480633371519, 11913.0, 3442.4147894857933, 3471.340445315382, 3483.6690514401093, 3529.0118766745095, 3540.044188069207, 66859.3314066858, 78419.0, 80446.59776701138, 81187.97030074237, 90616.09383906209, 9498.675483498322, 9500.762480938032, 9580.281478888972, 9725.513724313756, 9866.358686685342, 20471.0, 20615.175392984413, 20765.79234207669, 20777.168913243302, 20792.0, 6283.7800676977, 7400.740974065882, 7592.772216833504, 7645.961770191114, 7809.9456573363, 4211.578842115825, 4214.873553793391, 4215.557366476476, 4244.427002354704, 4263.339182426729, 3525.383057964846, 3531.823408829548, 3540.3804334241404, 3554.982225088858, 3563.6970857476886, 649.8505343770959, 651.4625434016955, 660.0890770736353, 678.3386198456564, 690.6822861483773, 532.3452153850708, 598.7604958016741, 605.3250625552478, 606.4602503771647, 617.3332800575367, 7631.427642926803, 8456.323494120456, 8468.195521425578, 8524.74425767228, 8698.21716045559, 503.2099603622278, 594.4560726934893, 613.4049971527611, 621.2327775197627, 635.9491240700733, 3885.611438856148, 4083.775392353449, 4112.259793237186, 4124.1133156371525, 4239.788010599457, 93167.06832931584, 93255.53372233095, 93311.5334423337, 93857.0, 95168.0, 74802.25197748061, 75402.0, 76015.61992190004, 77441.0, 78419.60790196013, 68342.65828670825, 68360.0, 69235.65382173056, 69763.0, 69822.95265570919, 8758.99271583776, 8835.425697329652, 8889.73330800077, 9031.774205644648, 9163.0, 49767.75116124396, 51030.97938041144, 53721.462785371645, 54123.72938135442, 54544.0, 64467.8755518225, 67958.66020669865, 68453.3154668447, 69160.65419672869, 69198.0, 10990.340579565252, 11052.889471105185, 11719.707007324885, 11740.00209982127, 12049.457774400349, 10241.897581024094, 11984.340861252715, 12409.813852792035, 12492.687682808002, 12552.372381381078, 11650.475728592064, 11672.299662020307, 11698.35659038761, 11735.706607334885, 11748.353840538852, 10116.544755485873, 11639.53441862316, 11860.94069529647, 11884.168108232687, 12037.939810301243, 11389.316641001566, 11595.420228988685, 11661.883381166419, 11732.0, 11820.172587918763, 7867.527948323119, 9631.951840240754, 9797.890600970408, 10038.49807509607, 10183.643572474928, 9643.373180743229, 9830.213582913493, 9846.901530984598, 9864.506774661095, 9910.504474776088], "unit": "score", "name": "yui.html", "value": 6939.514208392181}], "name": "dromaeo_css", "value": 7475.9410420435315}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 110.0, 115.0, 115.0, 116.0, 128.0, 114.0, 115.0, 118.0, 116.0], "unit": "score", "name": "ai-astar", "value": 116.2}, {"lowerIsBetter": true, "replicates": [152.0, 119.0, 148.0, 163.0, 154.0, 161.0, 143.0, 123.0, 197.0, 113.0], "unit": "score", "name": "audio-beat-detection", "value": 147.3}, {"lowerIsBetter": true, "replicates": [196.0, 199.0, 200.0, 206.0, 209.0, 233.0, 196.0, 195.0, 206.0, 197.0], "unit": "score", "name": "audio-dft", "value": 203.7}, {"lowerIsBetter": true, "replicates": [56.0, 62.0, 80.0, 69.0, 128.0, 55.0, 57.0, 57.0, 60.0, 103.0], "unit": "score", "name": "audio-fft", "value": 72.7}, {"lowerIsBetter": true, "replicates": [79.0, 91.0, 132.0, 80.0, 81.0, 83.0, 119.0, 81.0, 83.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 94.6}, {"lowerIsBetter": true, "replicates": [91.0, 84.0, 131.0, 140.0, 123.0, 94.0, 90.0, 95.0, 120.0, 123.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [99.0, 104.0, 97.0, 129.0, 124.0, 90.0, 146.0, 127.0, 150.0, 152.0], "unit": "score", "name": "imaging-darkroom", "value": 121.8}, {"lowerIsBetter": true, "replicates": [90.0, 130.0, 144.0, 100.0, 90.0, 94.0, 92.0, 92.0, 110.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 103.4}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 55.0, 57.0, 54.0, 56.0, 54.0, 63.0, 57.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 74.0, 77.0, 73.0, 72.0, 96.0, 60.0, 64.0, 81.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 72.3}, {"lowerIsBetter": true, "replicates": [100.0, 103.0, 108.0, 110.0, 85.0, 87.0, 104.0, 110.0, 111.0, 110.0], "unit": "score", "name": "stanford-crypto-aes", "value": 102.8}, {"lowerIsBetter": true, "replicates": [155.0, 139.0, 135.0, 118.0, 129.0, 149.0, 132.0, 123.0, 132.0, 143.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 135.5}, {"lowerIsBetter": true, "replicates": [141.0, 144.0, 138.0, 162.0, 182.0, 129.0, 178.0, 184.0, 137.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.6}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 86.0, 98.0, 103.0, 81.0, 69.0, 70.0, 67.0, 98.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 80.9}], "name": "kraken", "value": 1570.6999999999998}]} 05:31:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1570.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7475.94"}}} 05:31:33 INFO - Return code: 0 05:31:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:31:33 INFO - # TBPL SUCCESS # 05:31:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:31:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:31:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:31:33 INFO - 2016-02-17 05:31:33.836 screenresolution[2980:85419] starting screenresolution argv=screenresolution get 05:31:33 INFO - 2016-02-17 05:31:33.838 screenresolution[2980:85419] Display 0: 1600x1200x32@60 05:31:33 INFO - 2016-02-17 05:31:33.844 screenresolution[2981:85421] starting screenresolution argv=screenresolution list 05:31:33 INFO - Available Modes on Display 0 05:31:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:31:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:31:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:31:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:31:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:31:34 INFO - Intel Iris: 05:31:34 INFO - Chipset Model: Intel Iris 05:31:34 INFO - Type: GPU 05:31:34 INFO - Bus: Built-In 05:31:34 INFO - VRAM (Dynamic, Max): 1536 MB 05:31:34 INFO - Vendor: Intel (0x8086) 05:31:34 INFO - Device ID: 0x0a2e 05:31:34 INFO - Revision ID: 0x0009 05:31:34 INFO - Displays: 05:31:34 INFO - Display: 05:31:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:31:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:31:34 INFO - Display Serial Number: 1600x1200 60 05:31:34 INFO - Main Display: Yes 05:31:34 INFO - Mirror: Off 05:31:34 INFO - Online: Yes 05:31:34 INFO - Rotation: Supported 05:31:34 INFO - Return code: 0 05:31:34 INFO - Running post-action listener: _resource_record_post_action 05:31:34 INFO - Running post-run listener: _resource_record_post_run 05:31:35 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 1011712; Write bytes: 711647744; Read time: 11; Write time: 2020 05:31:35 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 403483136; Write bytes: 395195904; Read time: 30103; Write time: 684 05:31:35 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 1011712; Write bytes: 304897024; Read time: 11; Write time: 1297 05:31:35 INFO - Running post-run listener: _upload_blobber_files 05:31:35 INFO - Blob upload gear active. 05:31:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:31:35 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 05:31:35 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:31:35 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:31:35 INFO - (blobuploader) - INFO - Open directory for files ... 05:31:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:31:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:31:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:36 INFO - (blobuploader) - INFO - Done attempting. 05:31:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:31:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:31:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:37 INFO - (blobuploader) - INFO - Done attempting. 05:31:37 INFO - (blobuploader) - INFO - Iteration through files over. 05:31:37 INFO - Return code: 0 05:31:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:31:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:31:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7edc4b533459ba6d346e268595d8bad86072fb18832ff4a811e5a340e23cda7c19b9687aa07d3ecd7eb8f4a57cb4b3504608a8039ec71fc9892648d6fa30c977", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c96eaad3039202a65621b68cf3c13df86798d8563603c4ae6f3b38722a16a8ebdcdc1b35495e174b6fc78573411b88eb07c80211b463eca72a56a7ea12f6d78a"} 05:31:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:31:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:31:37 INFO - Contents: 05:31:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7edc4b533459ba6d346e268595d8bad86072fb18832ff4a811e5a340e23cda7c19b9687aa07d3ecd7eb8f4a57cb4b3504608a8039ec71fc9892648d6fa30c977", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c96eaad3039202a65621b68cf3c13df86798d8563603c4ae6f3b38722a16a8ebdcdc1b35495e174b6fc78573411b88eb07c80211b463eca72a56a7ea12f6d78a"} 05:31:37 INFO - Running post-run listener: copy_logs_to_upload_dir 05:31:37 INFO - Copying logs to upload dir... 05:31:37 INFO - mkdir: /builds/slave/test/build/upload/logs 05:31:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.999243 ========= master_lag: 3.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-02-17 05:31:40.606995) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-02-17 05:31:40.611297) ========= 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.ti1b1HHkxn/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.CqgYvUt9VW/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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/Firefox/sha512/7edc4b533459ba6d346e268595d8bad86072fb18832ff4a811e5a340e23cda7c19b9687aa07d3ecd7eb8f4a57cb4b3504608a8039ec71fc9892648d6fa30c977", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c96eaad3039202a65621b68cf3c13df86798d8563603c4ae6f3b38722a16a8ebdcdc1b35495e174b6fc78573411b88eb07c80211b463eca72a56a7ea12f6d78a"} build_url:https://queue.taskcluster.net/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011639 build_url: 'https://queue.taskcluster.net/v1/task/MNUX_J81QKaXi0zm50xMGg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7edc4b533459ba6d346e268595d8bad86072fb18832ff4a811e5a340e23cda7c19b9687aa07d3ecd7eb8f4a57cb4b3504608a8039ec71fc9892648d6fa30c977", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c96eaad3039202a65621b68cf3c13df86798d8563603c4ae6f3b38722a16a8ebdcdc1b35495e174b6fc78573411b88eb07c80211b463eca72a56a7ea12f6d78a"}' ========= master_lag: 1.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-02-17 05:31:41.632086) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-02-17 05:31:41.632413) ========= 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.ti1b1HHkxn/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.CqgYvUt9VW/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.005504 ========= master_lag: 4.29 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-02-17 05:31:45.927251) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 05:31:45.927550) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 05:31:46.034644) ========= ========= Total master_lag: 8.66 =========