builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0121 starttime: 1459599697.48 results: success (0) buildid: 20160402030226 builduid: 7a68de5150194e12b6e19292e69a3855 revision: c40c0b2f3b4c778af4307e090b4063b63c806cda ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-02 05:21:37.479960) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-02 05:21:37.480362) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-02 05:21:37.480643) ========= 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.briI48ImE7/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.rQPKt6yfp3/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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.005533 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-02 05:21:37.509341) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-02 05:21:37.509652) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-02 05:21:37.527508) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 05:21:37.527806) ========= 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.briI48ImE7/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.rQPKt6yfp3/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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.005698 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 05:21:37.575646) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-02 05:21:37.578985) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-02 05:21:37.579408) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 05:21:37.579687) ========= 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.briI48ImE7/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.rQPKt6yfp3/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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-04-02 05:21:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 48.4M=0s 2016-04-02 05:21:37 (48.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182193 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 05:21:37.777310) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 05:21:37.777631) ========= 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.briI48ImE7/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.rQPKt6yfp3/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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.026733 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 05:21:37.829531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-02 05:21:37.832915) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c40c0b2f3b4c778af4307e090b4063b63c806cda --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 c40c0b2f3b4c778af4307e090b4063b63c806cda --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.briI48ImE7/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.rQPKt6yfp3/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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-04-02 05:21:37,910 truncating revision to first 12 chars 2016-04-02 05:21:37,910 Setting DEBUG logging. 2016-04-02 05:21:37,910 attempt 1/10 2016-04-02 05:21:37,910 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c40c0b2f3b4c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-02 05:21:39,706 unpacking tar archive at: mozilla-central-c40c0b2f3b4c/testing/mozharness/ program finished with exit code 0 elapsedTime=2.039905 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-02 05:21:39.889424) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-02 05:21:39.889776) ========= echo c40c0b2f3b4c778af4307e090b4063b63c806cda in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c40c0b2f3b4c778af4307e090b4063b63c806cda'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.briI48ImE7/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.rQPKt6yfp3/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 c40c0b2f3b4c778af4307e090b4063b63c806cda program finished with exit code 0 elapsedTime=0.005590 script_repo_revision: 'c40c0b2f3b4c778af4307e090b4063b63c806cda' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-02 05:21:39.939320) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-02 05:21:39.939598) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-02 05:21:39.952874) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-02 05:21:39.953143) ========= /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.briI48ImE7/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.rQPKt6yfp3/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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:21:40 INFO - MultiFileLogger online at 20160402 05:21:40 in /builds/slave/test 05:21:40 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:21:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:21:40 INFO - {'append_to_log': False, 05:21:40 INFO - 'base_work_dir': '/builds/slave/test', 05:21:40 INFO - 'blob_upload_branch': 'Firefox', 05:21:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:21:40 INFO - 'branch': 'Firefox', 05:21:40 INFO - 'buildbot_json_path': 'buildprops.json', 05:21:40 INFO - 'config_files': ('talos/mac_config.py',), 05:21:40 INFO - 'default_actions': ('clobber', 05:21:40 INFO - 'read-buildbot-config', 05:21:40 INFO - 'download-and-extract', 05:21:40 INFO - 'populate-webroot', 05:21:40 INFO - 'create-virtualenv', 05:21:40 INFO - 'install', 05:21:40 INFO - 'run-tests'), 05:21:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:21:40 INFO - 'download_minidump_stackwalk': True, 05:21:40 INFO - 'download_symbols': 'ondemand', 05:21:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:21:40 INFO - 'tooltool.py': '/tools/tooltool.py', 05:21:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:21:40 INFO - '/tools/misc-python/virtualenv.py')}, 05:21:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:21:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:21:40 INFO - 'installer_path': 'installer.exe', 05:21:40 INFO - 'log_level': 'info', 05:21:40 INFO - 'log_name': 'talos', 05:21:40 INFO - 'log_to_console': True, 05:21:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:21:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:21:40 INFO - 'opt_config_files': (), 05:21:40 INFO - 'pip_index': False, 05:21:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:21:40 INFO - 'cmd': ('bash', 05:21:40 INFO - '-c', 05:21:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:21:40 INFO - 'enabled': True, 05:21:40 INFO - 'halt_on_failure': False, 05:21:40 INFO - 'name': 'check_screen_resolution'},), 05:21:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:21:40 INFO - 'cmd': ('bash', 05:21:40 INFO - '-c', 05:21:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:21:40 INFO - 'enabled': True, 05:21:40 INFO - 'halt_on_failure': False, 05:21:40 INFO - 'name': 'check_screen_resolution'},), 05:21:40 INFO - 'run_cmd_checks_enabled': True, 05:21:40 INFO - 'sps_profile': False, 05:21:40 INFO - 'sps_profile_interval': 0, 05:21:40 INFO - 'suite': 'dromaeojs-e10s', 05:21:40 INFO - 'system_bits': '32', 05:21:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:21:40 INFO - 'title': 't-yosemite-r7-0121', 05:21:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:21:40 INFO - 'use_talos_json': True, 05:21:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:21:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:21:40 INFO - 'work_dir': 'build'} 05:21:40 INFO - ##### 05:21:40 INFO - ##### Running clobber step. 05:21:40 INFO - ##### 05:21:40 INFO - Running pre-action listener: _resource_record_pre_action 05:21:40 INFO - Running main action method: clobber 05:21:40 INFO - rmtree: /builds/slave/test/build 05:21:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:21:41 INFO - Running post-action listener: _resource_record_post_action 05:21:41 INFO - ##### 05:21:41 INFO - ##### Running read-buildbot-config step. 05:21:41 INFO - ##### 05:21:41 INFO - Running pre-action listener: _resource_record_pre_action 05:21:41 INFO - Running main action method: read_buildbot_config 05:21:41 INFO - Using buildbot properties: 05:21:41 INFO - { 05:21:41 INFO - "project": "", 05:21:41 INFO - "product": "firefox", 05:21:41 INFO - "script_repo_revision": "production", 05:21:41 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:21:41 INFO - "repository": "", 05:21:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:21:41 INFO - "buildid": "20160402030226", 05:21:41 INFO - "stage_platform": "macosx64", 05:21:41 INFO - "basedir": "/builds/slave/test", 05:21:41 INFO - "nightly_build": "True", 05:21:41 INFO - "buildnumber": 166, 05:21:41 INFO - "slavename": "t-yosemite-r7-0121", 05:21:41 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:21:41 INFO - "platform": "yosemite_r7", 05:21:41 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:21:41 INFO - "branch": "mozilla-central", 05:21:41 INFO - "repo_path": "mozilla-central", 05:21:41 INFO - "revision": "c40c0b2f3b4c778af4307e090b4063b63c806cda", 05:21:41 INFO - "pgo_build": "False", 05:21:41 INFO - "builduid": "7a68de5150194e12b6e19292e69a3855", 05:21:41 INFO - "slavebuilddir": "test" 05:21:41 INFO - } 05:21:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:21:41 INFO - Running post-action listener: _resource_record_post_action 05:21:41 INFO - ##### 05:21:41 INFO - ##### Running download-and-extract step. 05:21:41 INFO - ##### 05:21:41 INFO - Running pre-action listener: _resource_record_pre_action 05:21:41 INFO - Running main action method: download_and_extract 05:21:41 INFO - mkdir: /builds/slave/test/build/tests 05:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:41 INFO - https://queue.taskcluster.net/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:21:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:21:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:21:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:21:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 05:21:43 INFO - Downloaded 1199 bytes. 05:21:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:21:43 INFO - Using the following test package requirements: 05:21:43 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:21:43 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:21:43 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:21:43 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:21:43 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:21:43 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:21:43 INFO - u'jsshell-mac.zip'], 05:21:43 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:21:43 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:21:43 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:21:43 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:21:43 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:21:43 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:21:43 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:21:43 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:21:43 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:21:43 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:21:43 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:21:43 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:43 INFO - https://queue.taskcluster.net/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:21:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:21:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:21:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:21:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:21:45 INFO - Downloaded 17959929 bytes. 05:21:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:21:48 INFO - Return code: 0 05:21:48 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:21:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:48 INFO - https://queue.taskcluster.net/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:21:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:21:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:21:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:21:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:21:50 INFO - Downloaded 17959929 bytes. 05:21:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:21:53 INFO - Return code: 0 05:21:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:53 INFO - https://queue.taskcluster.net/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:21:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:21:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:21:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:21:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:21:54 INFO - Downloaded 10847584 bytes. 05:21:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:21:55 INFO - Return code: 0 05:21:55 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:21:55 INFO - https://queue.taskcluster.net/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:21:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:21:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:21:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:21:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:21:59 INFO - Downloaded 111628171 bytes. 05:21:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:21:59 INFO - mkdir: /builds/slave/test/properties 05:21:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:21:59 INFO - Writing to file /builds/slave/test/properties/build_url 05:21:59 INFO - Contents: 05:21:59 INFO - build_url:https://queue.taskcluster.net/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:22:00 INFO - Running post-action listener: _resource_record_post_action 05:22:00 INFO - Running post-action listener: set_extra_try_arguments 05:22:00 INFO - ##### 05:22:00 INFO - ##### Running populate-webroot step. 05:22:00 INFO - ##### 05:22:00 INFO - Running pre-action listener: _resource_record_pre_action 05:22:00 INFO - Running main action method: populate_webroot 05:22:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:22:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:22:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:22:00 INFO - '--tppagecycles', 05:22:00 INFO - '7'], 05:22:00 INFO - 'tests': ['tsvgm']}}, 05:22:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:22:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:22:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:22:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:22:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:22:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:22:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:22:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:00 INFO - 'talos_options': ['--e10s'], 05:22:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:22:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:00 INFO - 'tests': ['damp', 'tps']}, 05:22:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:00 INFO - 'talos_options': ['--e10s'], 05:22:00 INFO - 'tests': ['damp', 'tps']}, 05:22:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:22:00 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 05:22:00 INFO - 'tests': ['dromaeo_dom']}, 05:22:00 INFO - 'other': {'tests': ['a11yr', 05:22:00 INFO - 'ts_paint', 05:22:00 INFO - 'tpaint', 05:22:00 INFO - 'sessionrestore', 05:22:00 INFO - 'sessionrestore_no_auto_restore', 05:22:00 INFO - 'tabpaint']}, 05:22:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:22:00 INFO - 'tests': ['a11yr', 05:22:00 INFO - 'ts_paint', 05:22:00 INFO - 'tpaint', 05:22:00 INFO - 'sessionrestore', 05:22:00 INFO - 'sessionrestore_no_auto_restore', 05:22:00 INFO - 'tabpaint']}, 05:22:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:22:00 INFO - 'tests': ['a11yr', 05:22:00 INFO - 'ts_paint', 05:22:00 INFO - 'tpaint', 05:22:00 INFO - 'sessionrestore', 05:22:00 INFO - 'sessionrestore_no_auto_restore', 05:22:00 INFO - 'tabpaint']}, 05:22:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:22:00 INFO - 'tests': ['a11yr', 05:22:00 INFO - 'ts_paint', 05:22:00 INFO - 'tpaint', 05:22:00 INFO - 'sessionrestore', 05:22:00 INFO - 'sessionrestore_no_auto_restore', 05:22:00 INFO - 'tabpaint']}, 05:22:00 INFO - 'other_l64': {'tests': ['a11yr', 05:22:00 INFO - 'ts_paint', 05:22:00 INFO - 'tpaint', 05:22:00 INFO - 'sessionrestore', 05:22:00 INFO - 'sessionrestore_no_auto_restore', 05:22:00 INFO - 'tabpaint']}, 05:22:00 INFO - 'other_nol64': {'tests': ['a11yr', 05:22:00 INFO - 'ts_paint', 05:22:00 INFO - 'tpaint', 05:22:00 INFO - 'sessionrestore', 05:22:00 INFO - 'sessionrestore_no_auto_restore', 05:22:00 INFO - 'tabpaint']}, 05:22:00 INFO - 'svgr': {'tests': ['tsvgx', 05:22:00 INFO - 'tsvgr_opacity', 05:22:00 INFO - 'tart', 05:22:00 INFO - 'tscrollx', 05:22:00 INFO - 'cart']}, 05:22:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:22:00 INFO - 'tests': ['tsvgx', 05:22:00 INFO - 'tsvgr_opacity', 05:22:00 INFO - 'tart', 05:22:00 INFO - 'tscrollx', 05:22:00 INFO - 'cart']}, 05:22:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:00 INFO - 'tests': ['tp5o']}, 05:22:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:00 INFO - 'talos_options': ['--e10s'], 05:22:00 INFO - 'tests': ['tp5o']}, 05:22:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:00 INFO - 'talos_options': ['--xperf_path', 05:22:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:22:00 INFO - 'tests': ['tp5n']}, 05:22:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:00 INFO - 'talos_options': ['--e10s', 05:22:00 INFO - '--xperf_path', 05:22:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:22:00 INFO - 'tests': ['tp5n']}}, 05:22:00 INFO - 'talos.zip': {'path': '', 05:22:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:22:00 INFO - Running post-action listener: _resource_record_post_action 05:22:00 INFO - ##### 05:22:00 INFO - ##### Running create-virtualenv step. 05:22:00 INFO - ##### 05:22:00 INFO - Running pre-action listener: _resource_record_pre_action 05:22:00 INFO - Running main action method: create_virtualenv 05:22:00 INFO - Creating virtualenv /builds/slave/test/build/venv 05:22:00 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:22:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:22:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:22:00 INFO - Using real prefix '/tools/python27' 05:22:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:22:01 INFO - Installing distribute.............................................................................................................................................................................................done. 05:22:04 INFO - Installing pip.................done. 05:22:04 INFO - Return code: 0 05:22:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:04 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 0x10f91fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f92f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7c25630c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7bee00>, '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 0x10f627db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b9b20>, '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.briI48ImE7/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.rQPKt6yfp3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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:22:04 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:22:04 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:22:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.briI48ImE7/Render', 05:22:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:04 INFO - 'HOME': '/Users/cltbld', 05:22:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:04 INFO - 'LOGNAME': 'cltbld', 05:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:04 INFO - 'MOZ_NO_REMOTE': '1', 05:22:04 INFO - 'NO_EM_RESTART': '1', 05:22:04 INFO - 'PAGER': '/bin/cat', 05:22:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:04 INFO - 'PWD': '/builds/slave/test', 05:22:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:04 INFO - 'SHELL': '/bin/bash', 05:22:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rQPKt6yfp3/Listeners', 05:22:04 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 05:22:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:04 INFO - 'USER': 'cltbld', 05:22:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:04 INFO - 'XPC_FLAGS': '0x0', 05:22:04 INFO - 'XPC_SERVICE_NAME': '0', 05:22:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:04 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:22:04 INFO - Cleaning up... 05:22:04 INFO - Return code: 0 05:22:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:04 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 0x10f91fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f92f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7c25630c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7bee00>, '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 0x10f627db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b9b20>, '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.briI48ImE7/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.rQPKt6yfp3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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:22:04 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:22:04 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:22:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.briI48ImE7/Render', 05:22:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:04 INFO - 'HOME': '/Users/cltbld', 05:22:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:04 INFO - 'LOGNAME': 'cltbld', 05:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:04 INFO - 'MOZ_NO_REMOTE': '1', 05:22:04 INFO - 'NO_EM_RESTART': '1', 05:22:04 INFO - 'PAGER': '/bin/cat', 05:22:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:04 INFO - 'PWD': '/builds/slave/test', 05:22:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:04 INFO - 'SHELL': '/bin/bash', 05:22:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rQPKt6yfp3/Listeners', 05:22:04 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 05:22:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:04 INFO - 'USER': 'cltbld', 05:22:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:04 INFO - 'XPC_FLAGS': '0x0', 05:22:04 INFO - 'XPC_SERVICE_NAME': '0', 05:22:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:04 INFO - Downloading/unpacking psutil>=0.7.1 05:22:04 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:22:04 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:22:04 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:22:04 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:22:04 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:22:04 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:22:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:22:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:22:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:22:07 INFO - Installing collected packages: psutil 05:22:07 INFO - Running setup.py install for psutil 05:22:07 INFO - building 'psutil._psutil_osx' extension 05:22:07 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:22:08 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:22:08 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:22:08 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:22:08 INFO - building 'psutil._psutil_posix' extension 05:22:08 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:22:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:22:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:22:08 INFO - ^ 05:22:08 INFO - 1 warning generated. 05:22:08 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:22:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:22:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:22:08 INFO - Successfully installed psutil 05:22:08 INFO - Cleaning up... 05:22:09 INFO - Return code: 0 05:22:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:09 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 0x10f91fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f92f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7c25630c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7bee00>, '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 0x10f627db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b9b20>, '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.briI48ImE7/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.rQPKt6yfp3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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:22:09 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:22:09 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:22:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.briI48ImE7/Render', 05:22:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:09 INFO - 'HOME': '/Users/cltbld', 05:22:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:09 INFO - 'LOGNAME': 'cltbld', 05:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:09 INFO - 'MOZ_NO_REMOTE': '1', 05:22:09 INFO - 'NO_EM_RESTART': '1', 05:22:09 INFO - 'PAGER': '/bin/cat', 05:22:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:09 INFO - 'PWD': '/builds/slave/test', 05:22:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:09 INFO - 'SHELL': '/bin/bash', 05:22:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rQPKt6yfp3/Listeners', 05:22:09 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 05:22:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:09 INFO - 'USER': 'cltbld', 05:22:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:09 INFO - 'XPC_FLAGS': '0x0', 05:22:09 INFO - 'XPC_SERVICE_NAME': '0', 05:22:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:22:09 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:22:09 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:22:09 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:22:09 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:22:09 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:22:09 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:22:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:22:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:22:11 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:22:11 INFO - Installing collected packages: mozsystemmonitor 05:22:11 INFO - Running setup.py install for mozsystemmonitor 05:22:11 INFO - Successfully installed mozsystemmonitor 05:22:11 INFO - Cleaning up... 05:22:12 INFO - Return code: 0 05:22:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:22:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:12 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 0x10f91fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f92f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7c25630c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7bee00>, '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 0x10f627db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b9b20>, '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.briI48ImE7/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.rQPKt6yfp3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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:22:12 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:22:12 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:22:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.briI48ImE7/Render', 05:22:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:12 INFO - 'HOME': '/Users/cltbld', 05:22:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:12 INFO - 'LOGNAME': 'cltbld', 05:22:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:12 INFO - 'MOZ_NO_REMOTE': '1', 05:22:12 INFO - 'NO_EM_RESTART': '1', 05:22:12 INFO - 'PAGER': '/bin/cat', 05:22:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:12 INFO - 'PWD': '/builds/slave/test', 05:22:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:12 INFO - 'SHELL': '/bin/bash', 05:22:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rQPKt6yfp3/Listeners', 05:22:12 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 05:22:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:12 INFO - 'USER': 'cltbld', 05:22:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:12 INFO - 'XPC_FLAGS': '0x0', 05:22:12 INFO - 'XPC_SERVICE_NAME': '0', 05:22:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:12 INFO - Downloading/unpacking blobuploader==1.2.4 05:22:12 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:22:12 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:22:12 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:22:12 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:22:12 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:22:12 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:22:14 INFO - Downloading blobuploader-1.2.4.tar.gz 05:22:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:22:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:22:14 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:22:14 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:22:14 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:22:14 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:22:14 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:22:14 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:22:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:22:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:22: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:22: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:22: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:22: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:22: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:22: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:22:15 INFO - Downloading docopt-0.6.1.tar.gz 05:22:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:22:16 INFO - Installing collected packages: blobuploader, requests, docopt 05:22:16 INFO - Running setup.py install for blobuploader 05:22:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:22:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:22:16 INFO - Running setup.py install for requests 05:22:16 INFO - Running setup.py install for docopt 05:22:16 INFO - Successfully installed blobuploader requests docopt 05:22:16 INFO - Cleaning up... 05:22:16 INFO - Return code: 0 05:22:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:22:16 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:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:16 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:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:16 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 0x10f91fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f92f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7c25630c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7bee00>, '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 0x10f627db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b9b20>, '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.briI48ImE7/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.rQPKt6yfp3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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:22:16 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:22:16 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:22:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.briI48ImE7/Render', 05:22:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:16 INFO - 'HOME': '/Users/cltbld', 05:22:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:16 INFO - 'LOGNAME': 'cltbld', 05:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:16 INFO - 'MOZ_NO_REMOTE': '1', 05:22:16 INFO - 'NO_EM_RESTART': '1', 05:22:16 INFO - 'PAGER': '/bin/cat', 05:22:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:16 INFO - 'PWD': '/builds/slave/test', 05:22:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:16 INFO - 'SHELL': '/bin/bash', 05:22:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rQPKt6yfp3/Listeners', 05:22:16 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 05:22:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:16 INFO - 'USER': 'cltbld', 05:22:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:16 INFO - 'XPC_FLAGS': '0x0', 05:22:16 INFO - 'XPC_SERVICE_NAME': '0', 05:22:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:22:17 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-G6k6Z2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:22:17 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-f6YEiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:22:17 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-ihjE9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:22:17 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-H4kR5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:22:17 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-CRpqhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:22:17 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-nhts3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:22:17 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-N9Nt9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:22:17 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-Ajl63Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:22:17 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-kvpkcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:22:18 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-paIOR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:22:18 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-WJh9b0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:22:18 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-44Dd50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:22:18 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-9vTxzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:22:18 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-nHXIOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:18 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-fCcbVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:22:18 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-x2igV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:22:18 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-_oomTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:22:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:22:18 INFO - Running setup.py install for manifestparser 05:22:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:22:19 INFO - Running setup.py install for mozcrash 05:22:19 INFO - Running setup.py install for mozdebug 05:22:19 INFO - Running setup.py install for mozdevice 05:22:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:22:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:22:19 INFO - Running setup.py install for mozfile 05:22:19 INFO - Running setup.py install for mozhttpd 05:22:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:22:19 INFO - Running setup.py install for mozinfo 05:22:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:22:19 INFO - Running setup.py install for mozInstall 05:22:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:22:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:22:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:22:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:22:20 INFO - Running setup.py install for mozleak 05:22:20 INFO - Running setup.py install for mozlog 05:22:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:22:20 INFO - Running setup.py install for moznetwork 05:22:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:22:20 INFO - Running setup.py install for mozprocess 05:22:20 INFO - Running setup.py install for mozprofile 05:22:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:22:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:22:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:22:20 INFO - Running setup.py install for mozrunner 05:22:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:22:21 INFO - Running setup.py install for mozscreenshot 05:22:21 INFO - Running setup.py install for moztest 05:22:21 INFO - Running setup.py install for mozversion 05:22:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:22:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:22:21 INFO - Cleaning up... 05:22:21 INFO - Return code: 0 05:22:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:22: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:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22: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:22:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:21 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 0x10f91fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f92f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7c25630c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7bee00>, '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 0x10f627db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b9b20>, '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.briI48ImE7/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.rQPKt6yfp3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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:22:21 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:22:21 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:22:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.briI48ImE7/Render', 05:22:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:21 INFO - 'HOME': '/Users/cltbld', 05:22:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:21 INFO - 'LOGNAME': 'cltbld', 05:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:21 INFO - 'MOZ_NO_REMOTE': '1', 05:22:21 INFO - 'NO_EM_RESTART': '1', 05:22:21 INFO - 'PAGER': '/bin/cat', 05:22:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:21 INFO - 'PWD': '/builds/slave/test', 05:22:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:21 INFO - 'SHELL': '/bin/bash', 05:22:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rQPKt6yfp3/Listeners', 05:22:21 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 05:22:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:21 INFO - 'USER': 'cltbld', 05:22:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:21 INFO - 'XPC_FLAGS': '0x0', 05:22:21 INFO - 'XPC_SERVICE_NAME': '0', 05:22:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:22:22 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-GHvfFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:22:22 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:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:22:22 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-sYEe08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:22:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:22:22 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-WV95Ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:22:22 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:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:22:22 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-n3790z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:22:22 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:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:22:22 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-jNRdhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:22:22 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:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:22:22 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-kqxMLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:22:22 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:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:22:22 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-xtLsJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:22:22 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:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:22:22 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-Ud_m0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:22:23 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:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:22:23 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-FrD1Jr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:22:23 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:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:22:23 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-VcP1ee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:22:23 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:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:22:23 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-hmKGi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:22:23 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:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:22:23 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-VzYn9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:22:23 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:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:22:23 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-hw9Bpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:22:23 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:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:22:23 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-wYnK6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:22:23 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:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:23 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-UcqWz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:23 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:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:22:23 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-NuX_O1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:22:23 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:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:22:23 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-_i4lFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:22:24 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:22:24 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:22:24 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:22:24 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:22:24 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:22:24 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:22:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:22: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:22: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:22: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:22: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:22: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:22: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:22:26 INFO - Downloading blessings-1.6.tar.gz 05:22:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:22:26 INFO - Installing collected packages: blessings 05:22:26 INFO - Running setup.py install for blessings 05:22:26 INFO - Successfully installed blessings 05:22:26 INFO - Cleaning up... 05:22:27 INFO - Return code: 0 05:22:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:22:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:22:27 INFO - Reading from file tmpfile_stdout 05:22:27 INFO - Current package versions: 05:22:27 INFO - blessings == 1.6 05:22:27 INFO - blobuploader == 1.2.4 05:22:27 INFO - docopt == 0.6.1 05:22:27 INFO - manifestparser == 1.1 05:22:27 INFO - mozInstall == 1.12 05:22:27 INFO - mozcrash == 0.17 05:22:27 INFO - mozdebug == 0.1 05:22:27 INFO - mozdevice == 0.48 05:22:27 INFO - mozfile == 1.2 05:22:27 INFO - mozhttpd == 0.7 05:22:27 INFO - mozinfo == 0.9 05:22:27 INFO - mozleak == 0.1 05:22:27 INFO - mozlog == 3.1 05:22:27 INFO - moznetwork == 0.27 05:22:27 INFO - mozprocess == 0.22 05:22:27 INFO - mozprofile == 0.28 05:22:27 INFO - mozrunner == 6.11 05:22:27 INFO - mozscreenshot == 0.1 05:22:27 INFO - mozsystemmonitor == 0.0 05:22:27 INFO - moztest == 0.7 05:22:27 INFO - mozversion == 1.4 05:22:27 INFO - psutil == 3.1.1 05:22:27 INFO - requests == 1.2.3 05:22:27 INFO - wsgiref == 0.1.2 05:22:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:27 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 0x10f91fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f92f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7c25630c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7bee00>, '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 0x10f627db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b9b20>, '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.briI48ImE7/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.rQPKt6yfp3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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:22:27 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:22:27 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:22:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.briI48ImE7/Render', 05:22:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:27 INFO - 'HOME': '/Users/cltbld', 05:22:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:27 INFO - 'LOGNAME': 'cltbld', 05:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:27 INFO - 'MOZ_NO_REMOTE': '1', 05:22:27 INFO - 'NO_EM_RESTART': '1', 05:22:27 INFO - 'PAGER': '/bin/cat', 05:22:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:27 INFO - 'PWD': '/builds/slave/test', 05:22:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:27 INFO - 'SHELL': '/bin/bash', 05:22:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rQPKt6yfp3/Listeners', 05:22:27 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 05:22:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:27 INFO - 'USER': 'cltbld', 05:22:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:27 INFO - 'XPC_FLAGS': '0x0', 05:22:27 INFO - 'XPC_SERVICE_NAME': '0', 05:22:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:27 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:22:27 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:22:27 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:22:27 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:22:27 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:22:27 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:22:27 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:22:27 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:22:27 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:22:27 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:22:27 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:22:27 INFO - Cleaning up... 05:22:27 INFO - Return code: 0 05:22:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f91fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f92f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7c25630c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7bee00>, '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 0x10f627db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b9b20>, '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.briI48ImE7/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.rQPKt6yfp3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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:22:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:22:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.briI48ImE7/Render', 05:22:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:27 INFO - 'HOME': '/Users/cltbld', 05:22:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:27 INFO - 'LOGNAME': 'cltbld', 05:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:27 INFO - 'MOZ_NO_REMOTE': '1', 05:22:27 INFO - 'NO_EM_RESTART': '1', 05:22:27 INFO - 'PAGER': '/bin/cat', 05:22:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:27 INFO - 'PWD': '/builds/slave/test', 05:22:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:27 INFO - 'SHELL': '/bin/bash', 05:22:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rQPKt6yfp3/Listeners', 05:22:27 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 05:22:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:27 INFO - 'USER': 'cltbld', 05:22:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:27 INFO - 'XPC_FLAGS': '0x0', 05:22:27 INFO - 'XPC_SERVICE_NAME': '0', 05:22:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:27 INFO - Downloading/unpacking jsonschema 05:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:22:30 INFO - Downloading/unpacking functools32 (from jsonschema) 05:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:30 INFO - Downloading functools32-3.2.3-2.tar.gz 05:22:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:22:30 INFO - warning: no files found matching '*.txt' 05:22:30 INFO - no previously-included directories found matching 'build' 05:22:30 INFO - no previously-included directories found matching 'dist' 05:22:30 INFO - no previously-included directories found matching '.git*' 05:22:30 INFO - Installing collected packages: jsonschema, functools32 05:22:30 INFO - Running setup.py install for functools32 05:22:30 INFO - warning: no files found matching '*.txt' 05:22:30 INFO - no previously-included directories found matching 'build' 05:22:30 INFO - no previously-included directories found matching 'dist' 05:22:30 INFO - no previously-included directories found matching '.git*' 05:22:30 INFO - Successfully installed jsonschema functools32 05:22:30 INFO - Cleaning up... 05:22:31 INFO - Return code: 0 05:22:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:22:31 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:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:31 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:22:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:31 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 0x10f91fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f92f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7c25630c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7bee00>, '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 0x10f627db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b9b20>, '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.briI48ImE7/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.rQPKt6yfp3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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:22:31 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:22:31 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:22:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.briI48ImE7/Render', 05:22:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:31 INFO - 'HOME': '/Users/cltbld', 05:22:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:31 INFO - 'LOGNAME': 'cltbld', 05:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:31 INFO - 'MOZ_NO_REMOTE': '1', 05:22:31 INFO - 'NO_EM_RESTART': '1', 05:22:31 INFO - 'PAGER': '/bin/cat', 05:22:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:31 INFO - 'PWD': '/builds/slave/test', 05:22:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:31 INFO - 'SHELL': '/bin/bash', 05:22:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rQPKt6yfp3/Listeners', 05:22:31 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 05:22:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:31 INFO - 'USER': 'cltbld', 05:22:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:31 INFO - 'XPC_FLAGS': '0x0', 05:22:31 INFO - 'XPC_SERVICE_NAME': '0', 05:22:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:31 INFO - Downloading/unpacking flake8 05:22:31 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:22:31 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:22:31 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:22:31 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:22:31 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:22:31 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:22:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:22:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:22:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:22:34 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:22:34 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:22:34 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:22:34 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:22:34 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:22:34 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:22:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:22:34 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:22:34 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:22:34 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:22:34 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:22:34 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:22:34 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:22:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:22:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:22:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:22:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:22:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:22:34 INFO - no previously-included directories found matching 'docs/_build' 05:22:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:22:35 INFO - Running setup.py install for pep8 05:22:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:22:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:22:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:22:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:22:35 INFO - no previously-included directories found matching 'docs/_build' 05:22:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:22:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:22:35 INFO - Cleaning up... 05:22:35 INFO - Return code: 0 05:22:35 INFO - Running post-action listener: _resource_record_post_action 05:22:35 INFO - Running post-action listener: _start_resource_monitoring 05:22:35 INFO - Starting resource monitoring. 05:22:35 INFO - ##### 05:22:35 INFO - ##### Running install step. 05:22:35 INFO - ##### 05:22:35 INFO - Running pre-action listener: _resource_record_pre_action 05:22:35 INFO - Running main action method: install 05:22:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:22:35 INFO - Reading from file tmpfile_stdout 05:22:35 INFO - Detecting whether we're running mozinstall >=1.0... 05:22:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:22:35 INFO - Reading from file tmpfile_stdout 05:22:35 INFO - Output received: 05:22:35 INFO - Usage: mozinstall [options] installer 05:22:35 INFO - Options: 05:22:35 INFO - -h, --help show this help message and exit 05:22:35 INFO - -d DEST, --destination=DEST 05:22:35 INFO - Directory to install application into. [default: 05:22:35 INFO - "/builds/slave/test"] 05:22:35 INFO - --app=APP Application being installed. [default: firefox] 05:22:35 INFO - mkdir: /builds/slave/test/build/application 05:22:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:23:09 INFO - Reading from file tmpfile_stdout 05:23:09 INFO - Output received: 05:23:09 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:23:09 INFO - Running post-action listener: _resource_record_post_action 05:23:09 INFO - ##### 05:23:09 INFO - ##### Running run-tests step. 05:23:09 INFO - ##### 05:23:09 INFO - Running pre-action listener: _resource_record_pre_action 05:23:09 INFO - Running main action method: run_tests 05:23:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:23:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:23:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:23:09 INFO - 2016-04-02 05:23:09.651 screenresolution[1649:7702] starting screenresolution argv=screenresolution get 05:23:09 INFO - 2016-04-02 05:23:09.653 screenresolution[1649:7702] Display 0: 1600x1200x32@60 05:23:09 INFO - 2016-04-02 05:23:09.659 screenresolution[1650:7705] starting screenresolution argv=screenresolution list 05:23:09 INFO - Available Modes on Display 0 05:23:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:23:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:23:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:23:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:23:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:23:09 INFO - Intel Iris: 05:23:09 INFO - Chipset Model: Intel Iris 05:23:09 INFO - Type: GPU 05:23:09 INFO - Bus: Built-In 05:23:09 INFO - VRAM (Dynamic, Max): 1536 MB 05:23:09 INFO - Vendor: Intel (0x8086) 05:23:09 INFO - Device ID: 0x0a2e 05:23:09 INFO - Revision ID: 0x0009 05:23:09 INFO - Displays: 05:23:09 INFO - Display: 05:23:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:23:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:23:09 INFO - Display Serial Number: 1600x1200 60 05:23:09 INFO - Main Display: Yes 05:23:09 INFO - Mirror: Off 05:23:09 INFO - Online: Yes 05:23:09 INFO - Rotation: Supported 05:23:09 INFO - Return code: 0 05:23:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:23:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:23:09 INFO - Python 2.7.3 05:23:09 INFO - Return code: 0 05:23:09 INFO - grabbing minidump binary from tooltool 05:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:09 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 0x10f7bee00>, '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 0x10f627db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:23:09 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:23:09 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:23:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:23:09 INFO - Return code: 0 05:23:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:23:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:23:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:23:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:23:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:23:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:23:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:23:11 INFO - Return code: 0 05:23:11 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/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0121', '--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:23:11 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/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0121 --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:23:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.briI48ImE7/Render', 05:23:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:23:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:23:11 INFO - 'HOME': '/Users/cltbld', 05:23:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:23:11 INFO - 'LOGNAME': 'cltbld', 05:23:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:23:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:11 INFO - 'MOZ_NO_REMOTE': '1', 05:23:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:23:11 INFO - 'NO_EM_RESTART': '1', 05:23:11 INFO - 'PAGER': '/bin/cat', 05:23:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:11 INFO - 'PWD': '/builds/slave/test', 05:23:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:23:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:23:11 INFO - 'SHELL': '/bin/bash', 05:23:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rQPKt6yfp3/Listeners', 05:23:11 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 05:23:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:23:11 INFO - 'USER': 'cltbld', 05:23:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:23:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:11 INFO - 'XPC_FLAGS': '0x0', 05:23:11 INFO - 'XPC_SERVICE_NAME': '0', 05:23:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:23:11 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/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0121', '--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:23:11 INFO - mozversion application_buildid: 20160402030226 05:23:11 INFO - mozversion application_changeset: c40c0b2f3b4c778af4307e090b4063b63c806cda 05:23:11 INFO - mozversion application_display_name: Nightly 05:23:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:23:11 INFO - mozversion application_name: Firefox 05:23:11 INFO - mozversion application_remotingname: firefox 05:23:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:23:11 INFO - mozversion application_vendor: Mozilla 05:23:11 INFO - mozversion application_version: 48.0a1 05:23:11 INFO - mozversion platform_buildid: 20160402030226 05:23:11 INFO - mozversion platform_changeset: c40c0b2f3b4c778af4307e090b4063b63c806cda 05:23:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:23:11 INFO - mozversion platform_version: 48.0a1 05:23:11 INFO - using testdate: 1459599791 05:23:11 INFO - actual date: 1459599791 05:23:11 INFO - starting webserver on 'localhost:49279' 05:23:11 INFO - SUITE-START | Running 2 tests 05:23:11 INFO - TEST-START | dromaeo_css 05:23:11 INFO - operating with platform_type : mac_ 05:23:11 INFO - Initialising browser for dromaeo_css test... 05:23:11 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/tmpIcWe86/profile http://localhost:49279/getInfo.html) 05:23:14 INFO - PROCESS | 1668 | JavaScript error: jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 05:23:14 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 05:23:14 INFO - PROCESS | 1668 | colorDepth:24 05:23:14 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 05:23:14 INFO - PROCESS | 1668 | __metrics 05:23:14 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 05:23:15 INFO - TEST-INFO | 1668: exit 0 05:23:15 INFO - Browser initialized. 05:23:15 INFO - Running cycle 1/1 for dromaeo_css test... 05:23:15 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/tmpIcWe86/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:23:27 INFO - PROCESS | 1672 | RSS: Main: 247205888 05:23:27 INFO - PROCESS | 1672 | 05:24:16 INFO - PROCESS | 1672 | 1459599856946 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:26:28 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 05:26:29 INFO - PROCESS | 1672 | RSS: Main: 262860800 05:26:29 INFO - PROCESS | 1672 | 05:29:31 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 05:29:32 INFO - PROCESS | 1672 | RSS: Main: 274616320 05:29:32 INFO - PROCESS | 1672 | 05:32:34 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 05:32:34 INFO - PROCESS | 1672 | RSS: Main: 276422656 05:32:34 INFO - PROCESS | 1672 | 05:35:36 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 05:35:37 INFO - PROCESS | 1672 | RSS: Main: 278003712 05:35:37 INFO - PROCESS | 1672 | 05:38:39 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 05:38:40 INFO - PROCESS | 1672 | RSS: Main: 280809472 05:38:40 INFO - PROCESS | 1672 | 05:41:42 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 05:41:43 INFO - PROCESS | 1672 | RSS: Main: 282206208 05:41:43 INFO - PROCESS | 1672 | 05:41:43 INFO - PROCESS | 1672 | __start_tp_report 05:41:43 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 05:41:43 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 05:41:43 INFO - PROCESS | 1672 | |i|pagename|runs| 05:41:43 INFO - PROCESS | 1672 | |0;dojo.html;3507.5966263879645;3533.046077559059;3561.3767590671628;3577.123604716843;3607.026102952205;4314.460692413449;5699.344575373833;5716.056850619648;5845.035569131093;5852.239208902842;4899.461059283485;4902.705837649743;5937.020391635386;6007.939920600793;6046.606970546912;5261.263423120757;5298;5311.203319502067;5322.2814919985885;5377.139657654776;4388.363687265361;5421.864453388677;5454.890902181954;5480.424555421683;5517.172424136392;4065.9796701016307;5226.817061402832;5290.629655924087;5329.866753331159;5351.117065684158;5325.467453254682;5325.707086110262;5333.413324534298;5349.652272602269;5353.946460535384;4546.772661366951;5218.582513398919;5319.7340132993195;5324.840254792323;5325.600579956519;4624.722516648978;5428;5749.59752817303;5786.942130578683;5799;6211.4409703126485;6227.19046523949;6241.469475094623;6242.1261023456755;6247.125402443661;6144.279601711483;6268.811935641938;6311.526635502356;6321.462675672573;6335.5565110442285;5301.416844147141;5386.434424385383;6015.729292181819;6062.151298818169;6062.787802426894;6451.3548645135115;6456.451201647913;6461.127747754087;6473.449756770633;6486.383793539606;6125.509959203253;6145.631262124198;6155.661438620829;6186.876262474725;6192.225971753531;6145.832291864532;6223.315435302113;6311.463525600284;6313.55805093639;6317.6209427434505;6112.449879510866;6189.84525386869;6241.157443745127;6255.781047663401;6259.0924315973925;6142.007694998287;6239.970404883235;6260.060990851409;6268.686565671698;6293.559450838489;4289.528151903288;4982.551570358685;5020.221865610836;5035.370578677665;5036.924446133311;4425.070735145656;4454.242778727559;4455;4495;4512.729236245836;5529.447055294519;5798.391168927202;5902.527797776168;5914.556408269397;5916.556258280646;6264.749410023639;6302.558820882494;6322.810315690536;6342.873142537216;6349.015902535114;5973.462388384979;6017.488513476404;6017.608855424383;6036.245469316335;6046.818595442144;4663.370444989951;5366.382865970385;5448.318960129984;5518.53092487135;5523.530499907472;6459.354064593503;6480.611163330215;6487.286398496256;6488.9026664601015;6492.837679058061;6273.215848018997;6282.811515654537;6284.402981716729;6303.1175635412;6313.779017734358;4853.95146048535;6399.456046236122;6458.289588145206;6494.545381823227;6510.381513756186;4595.4025976622825;5464.9453505464435;5623.831285061455;6233.688315584293;6265.561410701207;6305.085762564494;6311.179546658905;6314.116023756769;6324.810255692337;6329.208848893888;6111.682900513496;6115.327313995546;6159.876802464015;6184.350643182581;6223.595466294857;4835.661503694708;5103.642745007814;6269.435750782452;6273;6273.52948528853;6082.148499210202;6141.6007959482495;6148.077788331786;6195.070739389128;6224.035274532454;6067.605605635619;6129.0757006688855;6146.770645870754;6233.065040244;6285.622862628257;6193.566450348432;6198.752049917953;6200.193974783249;6218.875622487615;6235.064740288993 05:41:43 INFO - PROCESS | 1672 | |1;ext.html;464.8373069425699;491.1086378223524;507.4367452128137;579.7767859374139;648.2804087462916;37243.4413483798;37799.24401511968;37820;37862.67480638178;37948.051298717546;32012.67987320126;36869.89390318295;38819.805900970525;39361.21277574454;39413.80293098531;9372.859407108881;9534.284928630346;9576.186024187917;9595.088466595696;9618.182454491342;9407.623695052223;9490.335676502647;9552.044795520427;9649.90350096497;9704.61181552737;9581.760455988586;9597;9608.711738647851;9702.466364349957;9739.805203895918;9531.47576883278;9561.904380956172;9621.470819104947;9722.319437639404;9733.31866769323;9442.57508412123;9480.194183494412;9500.23998080152;9621.18219951305;9658.082482164184;37944.482220711136;38226.426603600965;38406.80796596027;38498.61501384978;38733.806330968444;3343.782654127474;3459.567554055743;3650.689691376236;3756.6806821420214;3827.311084004878;28369;28538.714612854023;29141.980030698825;29145.70854291451;29162.70837291621;2748.931276718078;2753.2979090332037;2754.862256887168;2790.679071906736;2952.2914500519937;450870;455670;464204;465350;466218.6689066567;62177;62311.37688623056;62577;62605.68697156576;62622;66232;72257;72326;73475.63262183762;73609;14294.999350045606;16135;16173.676526469404;16685.833141668427;16765.83234167643;11268.436578171058;11957.701057473632;12597;12703.047271454678;12802;20416.693749593767;20450.79549204519;20637.801140823198;20662.896685516476;21601.67597486039;7256.746013889594;7770.611469426506;8689.653103768926;8997.19025287714;9053.230475409533;914.0813482450228;985.6254623243265;1037.818381783185;1067.9626213082504;1115.55935405516;28542.429151416854;28748.901493968187;28981;29043.7095629041;29340.413191736046;1019.4444028004755;1093.94530273486;1106.4301884529473;1209.9957035660382;1216.568118318002;14262.144271343752;14301.856981430261;14415.78376324356;14537.709245815236;14599.78100328496;521582;524399;537180;537211;538155;54853.45146548563;55218;55342.72328638331;55367.61580960508;55556.72221638866;1243.875612438749;1390.9095908765898;1418.666613345863;1442.3076923076983;1447.5802017414833;28846;28920.566191507565;28987.42025159527;29092.56361154542;29185;48284.79288017828;54766.72616637051;54781;56207.875842483736;56213.87572248614;415580.28616852727;419352;423224;423574.41063973645;424058;35645.465318019735;37149.88550343494;40371.59628403679;41154.38268426036;41602;43651.781741091094;43940.56059439493;43965.340519891586;44293.55706442894;44465.777671111435;30553.23616909595;37346.813265933495;37507.72728179145;38629.42055869108;38865.41701874418;37141.44287835739;37169.6283037177;37671.623283766814;37752.43371349377;37909.81045094757;37672;38080.61919380771;38172.42741358937;38262.2347553053;38967;23472.295831125095;27786;30720.23199419943;30893.536596950613;31198.844005779825;24273.514529708955;24282.028718851754;24300.27099187027;24755.009799607815;24868.875655621607 05:41:43 INFO - PROCESS | 1672 | |2;jquery.html;321.8841217161821;330.22562091894514;353.2599204666225;355.2911940678347;365.8372024449118;15450;19228.13473393697;19231.807681923194;20095.397138085846;20096.196152153916;11878.465469053892;12208.511659533608;12233.204841685285;19555;19895.502612434695;5208.869778255536;5341.679499230039;5372.758225879845;5390.380106287788;5390.865228369283;5120.795168193286;5259.8422047338645;5315.893682126355;5350.491703288181;5386.057439947994;5259.921101183485;5333.280007199037;5345.224942383352;5380.757865896044;5381;5428.75570599322;5513.8345849624575;5796.62321949072;5827.970860145714;5882.323532793741;5126.436092029874;5197.610179236534;5206.76569554371;5207.218917162456;5242.18746094356;13267.203967761965;20376.898115509477;24591.13931012406;25275.494490110093;25352.985880564756;1906.20892329683;1964.057252518799;1998.6102709971562;2224.165937773335;2703.931946880991;9223.169914707709;9389.295802814817;9571.042895710443;12904.548340808027;13971.79042314366;1703.0803366182247;1736.6179440523065;1736.6700326937842;1748.8513476354526;1771.3180425536132;99571.50214248955;103933;104343;106137.93862061358;106787;8931.508767017876;10977.560897564168;11114.333140011464;11249.550017999352;11317.264377815416;12147.939260303641;13038.674033149058;13719.039667223398;13733.45066197341;13736.793948090786;8255.628496717662;8258.42191046633;8486.575671216415;8503.362247831437;8570.142985701379;8671;8730.607122679494;8764.430312029697;8787.297016238686;8872.112788721206;4316.978415107905;4328.458942632171;4348.978255108705;4350.760708161081;4360.41134446852;1820.9544761380807;1855.8422534084484;1892.5647101166533;1925.0182406972265;1935.312963897796;852.0925214646381;863.4430792139035;879.6437442835662;894.7449976756724;978.3885071830106;15498.457553985556;17265.13674316279;19714.802851971297;20108.296209632594;20290.69563956542;918.7565295196778;936.9859452108224;958.9930572898568;990.4997976022063;1029.4749677664445;5653.689047102449;8481.660733570588;9032.32257580684;9048.457092574336;9553.570089345996;510285;516528;520108;579339;637881;100904.49547752214;125459;128916;129505.35247323703;130295.04557431646;1011.9645812396531;1032.4476405123223;1036.5076588620345;1059.8357254625546;1060.41677077607;17300.65398691994;17557.297708091533;17768.733468998234;18093.547661308574;18222.453326400228;37334.693285734866;50466.24300635567;50472.77729871497;50778.23832642439;50971.980560389326;54828.45171548233;67375.66312168408;70309;77020.459590809;77343.2265677336;7561.09266887977;7731.961340193263;7822.882656760039;7876.803079923047;7904.249096335839;11757.764844702888;12128.272303661808;12378.81431778542;12562.497500100259;12572;10584.153267738717;10627.734306642396;10698.358098514114;10992.890071099187;11104.056155226574;9748.658796942073;10396.428196449267;10425.218108641731;10550.050495455445;10824.296420732628;9818.65634702782;11169.162312826733;11211.71970700739;11418.257813242113;11520.308781473139;5924.763009479572;7629.198934111839;7756.495827771177;7777.883331749915;7788.727394541163;9163.404378715362;10102.24233182529;11175.050120739828;11186;11316.83024754613 05:41:43 INFO - PROCESS | 1672 | |3;mootools.html;1406.4303956897454;1641.860441862442;1878.7463692401523;1998.8400927925768;2014.486305991972;7443.59060251686;8052.114267430578;8752.256058235042;8786.780330491732;9016.188543031127;7357.852842943138;8697.47815131091;8763.605637746301;8799.692010779623;8847.424917380366;2467.4571594249282;2501.3371456564023;2505.060602274147;2505.6116301973225;2505.8496490210555;2410.08416801616;2489.800815934721;2501.4871951250043;2502.124256510225;2502.3744063984004;2291.8166546676225;2480.60310350344;2493.26717931038;2502.2118032819694;2503.7996960243136;2471.9752802472017;2480.218731099698;2484.751524847519;2497.113524698733;2514.35883849619;2476.108600903673;2492.5513407586627;2503.7996960243318;2504.511620234055;2521.6595759572588;8870.778230544223;8934.240589549896;9000.504972226525;9008.324375671786;9038.954805225932;5439.5376393006645;5575.442455754433;5606.24315717377;5627.296587926509;5651.321841379061;3636.127329440915;3724.3854763963914;3739.2895349883706;3754.962450375516;3756.812159392047;1052.747230795351;1062.755566219766;1073.7100982734696;1085.3433672628105;1086.293908959175;11917.106217033757;11928.224665396721;12134.211276267102;12154.513819447211;12159.027277817842;4866.78099485524;4935.259711043373;4957.90084198314;4990.600751939836;5031.421386540522;10198.898011019943;10222.897771022343;10234.6417875374;10251.538680759235;10264.948675256725;5395.325584301962;5408.702521361363;5469.890602187934;5584.692841893735;5614.578906582023;4564.7032942858605;4922.163232250526;5020.673656212334;5029.723365214875;5056.039352523009;3893.591172926802;3985.3822657488136;3990.900227494336;3996.140829721624;4037.3540233563076;1322.6627210061372;1327.3230652367363;1341.637757805387;1344.5831792144465;1354.7087376213965;1126.099120703434;1141.7145713571608;1171.9472623731951;1172.6247600767672;1271.6502961685426;6827.385535301747;8149.592520373958;8169.305609023299;8190.7133250335955;8251.422400432033;517.7954707890362;520.2066848056668;524.7140308531859;530.7797264135418;533.5011764000672;5020.49795020495;5175.948240517547;5858.619189752738;5940.910886336708;6034.758609655652;9581.664641737505;10348;10431.061204491632;10670.466476676134;10917.508712107974;9238.214751746042;10380.273380863267;10643.680689579325;10699.94650026745;10811.78376432467;8364.707235246737;8430.199131082538;8446.324294056461;8480.872786908201;8482.533460659723;7805.921940780747;7858.292753652198;7862.52824830512;7880.2513761192595;7949.682012719658;9547.283953703361;9654.469004204837;9751.707448776548;9787.314887957775;9814.509274536102;9597.376170548892;9833.950830245803;9956.601735930482;10015.499225038864;10099.848502272325;6889.552179108342;7352.485326027127;7457.179710231979;7508.136564295176;7535.284148005931;8085.8787118192095;8150.633221504928;8175.591220439073;8221.917780822116;8234;7270.636468176675;7355.668994895135;7367.26327367259;7483.812904677427;7490.662920168496;7185.065941427581;7298.37963773064;7315.926840731738;7323.304286092813;7363.226861179499;7682.500637458547;7687.0391201099865;7756.952811370393;7806.92193078062;7828.569428681477;6843.3840954314355;6990.790276291719;6993.930060699531;7021.473389495706;7123.145222573325;7038.824029399306;7076.2923707628825;7121.893171602534;7166.677499512639;7193.424526037799 05:41:43 INFO - PROCESS | 1672 | |4;prototype.html;265.43197557227535;328.53512280123624;331.4018197154137;336.0875223767471;337.2008340233647;6658.800235992916;6779.779639664871;6802.353776391247;6809.012693159489;6825.965870170642;6673.399394054534;6764.695588698508;6765.12053433053;6770.187577490696;6787.76242831501;4825.662203645747;4892.192788189962;5025.572826309768;5048.747562621873;5057.013882292954;4150.717105591927;4896.485868983759;5013.623978201631;5030.547250747432;5096.79612815487;5024.874378140557;5029.47190544993;5033.018561380532;5063.696178229299;5072.923906141411;5039.067772462088;5059.949400505985;5065.569426598743;5069.670471419346;5078.796848126089;4313.84901528445;4315.223259813232;4315.43899293093;4316.503602085738;4336.3712261722185;5383.623146379755;6486.902696459557;6515.609063456208;6521.217453905561;6522.869542609121;4360.738355698668;5803.82588522345;5837.474627283523;5856.121581762727;5882.911661342665;7260.98346231528;7278.1630112537205;7313.926860731431;7326.963365183194;7329.9371591119525;4650.674452788307;4655.976720116411;4662.440507139131;4674.2053850845095;4680.672352935296;7477.700891964315;7508.887366689504;7647.808804779869;7648.54108753471;7682.807929801744;4486.484054333728;4552.908941821145;4601.079784043205;4681.438227412732;4710.434747830213;4773.7374444405195;4778.235482322812;4779.450363208275;4787.640926930494;4796.592289655348;4608.539146085432;5775.537956963432;5779.393163717833;5789.189513468118;5804.506616937523;7266.781996540112;7274.49078564506;7283.4537409694485;7291.4531410144455;7292.34368906801;1565.4051460444957;1624.8537631613212;1640.0487717124279;1674.087622245879;1676.6898123847127;1038.60532997462;1039.2413538117066;1045.9895401046044;1062.4156713807374;1063.3411877471015;6649.700763465656;6653.234877988996;6661.233958094785;6663.700133494004;6665.666716664147;7389.334959853639;7436.330730234305;7451.813704657318;7470.85058298831;7478.401727861758;6569.638669873108;6573.375529324707;6628.072069910217;6653.334666533308;6671.13275274221;3171.8255495947947;3530.8940731777575;3643.0163855758797;3933.783641899666;3943.3493473576536;7161.319674630901;7746.070471543451;7875.094364148082;7880.054393472706;7958.164392738795;7811.336036436853;7895.368370530344;7902.565358905315;7905.802354941173;7912.446128770931;7142.8214294640975;7908.446408751447;7933;7944.9205507945335;7954.244346787046;7259.673314700745;7345.632718363953;7477.626118694152;7631.198724133886;7664.885026724715;7284.890726638999;7310.853782924418;7385.7045718170675;7396.14944281393;7433.70265189408;7882.5270483771155;7892.4080693947035;7926.841463170589;7928.167542407964;7929.722459713882;4675.742834144155;4738.928916066193;4739.834105806281;4743.241081426955;4756.262779269219;5979.833932383318;7308.342249197598;7522.548647080974;7542.509736867086;7558.470907036454;7209.927900720925;7222.6388680566815;7269.963650181715;7285.599292038989;7288.08898887639;7193.172785129777;7196.784096477114;7250.818729531593;7289.963550182428;7290.890636640349;7052.33002864727;7080.2919708028785;7102.14774227096;7119.6084215368655;7138.571685698875;5541.418151094238;7235.2041275458605;7274.781756547312;7287.672054757655;7306.159791623819;7098.645067746489;7111.964440177766;7129.643517824192;7150.67821948024;7155.3202445767565 05:41:43 INFO - PROCESS | 1672 | |5;yui.html;568.3605943313772;691.5574032619123;745.4148493432657;759.3393747439728;766.3486036868659;14749.48376806812;14892.776608350883;14963.326650300736;14973.401063957455;15043.548693539184;13733;13797.724045519084;13809.930950345235;13826.723465530684;13928.233947132903;713.7073799742094;876.7282142535803;909.0863681999581;912.8493798523235;914.8673442350855;900.729781065681;909.1090731083542;909.645238357038;910.6175406329324;911.3347256502757;848.6902280667574;922.6125027488438;957.3203025851653;960.4573416019962;961.4039295636715;913.0777914306532;926.1386910173536;947.2611363136764;948.127722495306;948.1608776233049;695.197047410242;711.2816055783644;712.081414974682;712.843174501614;713.1442269276837;13894.861051389458;13904.652383690489;14326.713465730627;14644;14752.041117327339;11556.711082222928;11688.766224675544;12595.622131336075;12853.807192892114;13017;9881.604735810559;10030.548625311878;10335.379877207391;10423.166146708321;10622.628208012682;3448.2241495663525;3458.4466485362473;3469.6356882527225;3531.4349704047486;3578.5526809148855;67707.32292677108;69567;69683.65158174228;72340.27659723388;72944.63527682381;9249.583768730423;9298.86051709225;9304.95347523258;9378.155965963097;9438.669646562337;19833.801661983485;19938.60122797565;20140.39578812638;20163.59672806565;20281.49296267605;7265.636718164176;7308.159561650372;7419.443541734391;7521.661525231269;7569.318761311509;4095.7542547447247;4112.424260603518;4114.382842573638;4134.524529679065;4151.252774500619;3646.033801042726;3663.9633603663624;3673.430618254175;3680.576733675608;3698.7225958053255;632.2570979099539;640.961542307463;646.1728986896779;648.4812150279757;671.9059331693567;565.9405762394972;569.2286951181172;577.7429044075346;578.4186892173338;584.5286257202403;7877.56673382958;8142.145074767182;8155.388345873965;8255.640522973617;8280.610717493337;559.3539461921487;574.5288863132191;593.27916581353;612.2377639838429;616.3128112154915;3611.494390785292;3807.6192380762254;3825.9617403825605;3867.690584753213;3910.287040093006;84277;85319;85979.14020859836;96679;97371.51314243526;47125.764371177924;70213;73915;81146.59426702828;81459;56674.43325566856;57756;69771.95342069873;71088;71950.32143781219;7980.760577182694;8365.665373384996;8381;8509.87235191485;8579.613917373608;48044.79888002828;49040.75479622579;49796.751016244685;50035;50505.98988020293;54480.727596361765;61537;65398.673006634664;71673;71696;10815.56737730482;10962.342259464458;11015.00196022963;11110.888891110986;11245.831312530483;11815.172937894265;11977.341246231541;12030.939845300718;12145.878541214475;12256.14207005501;11137.777244455228;11154.330740155616;11355.772884542428;11375.20373573842;11511.597094101666;11201.271917325348;11335;11404.429778510876;11626.360550169484;12268.570600028956;10796.136309095411;10912.836307455553;11077.556897724;11337.489812958602;11461;9046.63813447481;9247.72256832296;9352.251819854258;9619.27855410861;9874.711917051873;7567.129780075362;9332.440053596805;9413.388129771816;9531.428114313163;9552.761180970532 05:41:43 INFO - PROCESS | 1672 | __end_tp_report 05:41:43 INFO - PROCESS | 1672 | __start_cc_report 05:41:43 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,383 05:41:43 INFO - PROCESS | 1672 | __end_cc_report 05:41:43 INFO - PROCESS | 1672 | __startTimestamp1459600903072__endTimestamp 05:41:43 INFO - PROCESS | 1672 | 05:41:43 INFO - PROCESS | 1672 | ------- Summary: start ------- 05:41:43 INFO - PROCESS | 1672 | Number of tests: 6 05:41:43 INFO - PROCESS | 1672 | 05:41:43 INFO - PROCESS | 1672 | [#0] dojo.html Cycles:165 Average:5754.95 Median:6082.15 stddev:705.69 (11.6%) stddev-sans-first:685.48 05:41:43 INFO - PROCESS | 1672 | Values: 3507.6 3533.0 3561.4 3577.1 3607.0 4314.5 5699.3 5716.1 5845.0 5852.2 4899.5 4902.7 5937.0 6007.9 6046.6 5261.3 5298.0 5311.2 5322.3 5377.1 4388.4 5421.9 5454.9 5480.4 5517.2 4066.0 5226.8 5290.6 5329.9 5351.1 5325.5 5325.7 5333.4 5349.7 5353.9 4546.8 5218.6 5319.7 5324.8 5325.6 4624.7 5428.0 5749.6 5786.9 5799.0 6211.4 6227.2 6241.5 6242.1 6247.1 6144.3 6268.8 6311.5 6321.5 6335.6 5301.4 5386.4 6015.7 6062.2 6062.8 6451.4 6456.5 6461.1 6473.4 6486.4 6125.5 6145.6 6155.7 6186.9 6192.2 6145.8 6223.3 6311.5 6313.6 6317.6 6112.4 6189.8 6241.2 6255.8 6259.1 6142.0 6240.0 6260.1 6268.7 6293.6 4289.5 4982.6 5020.2 5035.4 5036.9 4425.1 4454.2 4455.0 4495.0 4512.7 5529.4 5798.4 5902.5 5914.6 5916.6 6264.7 6302.6 6322.8 6342.9 6349.0 5973.5 6017.5 6017.6 6036.2 6046.8 4663.4 5366.4 5448.3 5518.5 5523.5 6459.4 6480.6 6487.3 6488.9 6492.8 6273.2 6282.8 6284.4 6303.1 6313.8 4854.0 6399.5 6458.3 6494.5 6510.4 4595.4 5464.9 5623.8 6233.7 6265.6 6305.1 6311.2 6314.1 6324.8 6329.2 6111.7 6115.3 6159.9 6184.4 6223.6 4835.7 5103.6 6269.4 6273.0 6273.5 6082.1 6141.6 6148.1 6195.1 6224.0 6067.6 6129.1 6146.8 6233.1 6285.6 6193.6 6198.8 6200.2 6218.9 6235.1 05:41:43 INFO - PROCESS | 1672 | 05:41:43 INFO - PROCESS | 1672 | [#1] ext.html Cycles:180 Average:62111.09 Median:21117.06 stddev:125726.32 (595.4%) stddev-sans-first:125993.82 05:41:43 INFO - PROCESS | 1672 | Values: 464.8 491.1 507.4 579.8 648.3 37243.4 37799.2 37820.0 37862.7 37948.1 32012.7 36869.9 38819.8 39361.2 39413.8 9372.9 9534.3 9576.2 9595.1 9618.2 9407.6 9490.3 9552.0 9649.9 9704.6 9581.8 9597.0 9608.7 9702.5 9739.8 9531.5 9561.9 9621.5 9722.3 9733.3 9442.6 9480.2 9500.2 9621.2 9658.1 37944.5 38226.4 38406.8 38498.6 38733.8 3343.8 3459.6 3650.7 3756.7 3827.3 28369.0 28538.7 29142.0 29145.7 29162.7 2748.9 2753.3 2754.9 2790.7 2952.3 450870.0 455670.0 464204.0 465350.0 466218.7 62177.0 62311.4 62577.0 62605.7 62622.0 66232.0 72257.0 72326.0 73475.6 73609.0 14295.0 16135.0 16173.7 16685.8 16765.8 11268.4 11957.7 12597.0 12703.0 12802.0 20416.7 20450.8 20637.8 20662.9 21601.7 7256.7 7770.6 8689.7 8997.2 9053.2 914.1 985.6 1037.8 1068.0 1115.6 28542.4 28748.9 28981.0 29043.7 29340.4 1019.4 1093.9 1106.4 1210.0 1216.6 14262.1 14301.9 14415.8 14537.7 14599.8 521582.0 524399.0 537180.0 537211.0 538155.0 54853.5 55218.0 55342.7 55367.6 55556.7 1243.9 1390.9 1418.7 1442.3 1447.6 28846.0 28920.6 28987.4 29092.6 29185.0 48284.8 54766.7 54781.0 56207.9 56213.9 415580.3 419352.0 423224.0 423574.4 424058.0 35645.5 37149.9 40371.6 41154.4 41602.0 43651.8 43940.6 43965.3 44293.6 44465.8 30553.2 37346.8 37507.7 38629.4 38865.4 37141.4 37169.6 37671.6 37752.4 37909.8 37672.0 38080.6 38172.4 38262.2 38967.0 23472.3 27786.0 30720.2 30893.5 31198.8 24273.5 24282.0 24300.3 24755.0 24868.9 05:41:43 INFO - PROCESS | 1672 | 05:41:43 INFO - PROCESS | 1672 | [#2] jquery.html Cycles:180 Average:32236.00 Median:354.28 stddev:92643.40 (26150.1%) stddev-sans-first:92872.30 05:41:43 INFO - PROCESS | 1672 | Values: 321.9 330.2 353.3 355.3 365.8 15450.0 19228.1 19231.8 20095.4 20096.2 11878.5 12208.5 12233.2 19555.0 19895.5 5208.9 5341.7 5372.8 5390.4 5390.9 5120.8 5259.8 5315.9 5350.5 5386.1 5259.9 5333.3 5345.2 5380.8 5381.0 5428.8 5513.8 5796.6 5828.0 5882.3 5126.4 5197.6 5206.8 5207.2 5242.2 13267.2 20376.9 24591.1 25275.5 25353.0 1906.2 1964.1 1998.6 2224.2 2703.9 9223.2 9389.3 9571.0 12904.5 13971.8 1703.1 1736.6 1736.7 1748.9 1771.3 99571.5 103933.0 104343.0 106137.9 106787.0 8931.5 10977.6 11114.3 11249.6 11317.3 12147.9 13038.7 13719.0 13733.5 13736.8 8255.6 8258.4 8486.6 8503.4 8570.1 8671.0 8730.6 8764.4 8787.3 8872.1 4317.0 4328.5 4349.0 4350.8 4360.4 1821.0 1855.8 1892.6 1925.0 1935.3 852.1 863.4 879.6 894.7 978.4 15498.5 17265.1 19714.8 20108.3 20290.7 918.8 937.0 959.0 990.5 1029.5 5653.7 8481.7 9032.3 9048.5 9553.6 510285.0 516528.0 520108.0 579339.0 637881.0 100904.5 125459.0 128916.0 129505.4 130295.0 1012.0 1032.4 1036.5 1059.8 1060.4 17300.7 17557.3 17768.7 18093.5 18222.5 37334.7 50466.2 50472.8 50778.2 50972.0 54828.5 67375.7 70309.0 77020.5 77343.2 7561.1 7732.0 7822.9 7876.8 7904.2 11757.8 12128.3 12378.8 12562.5 12572.0 10584.2 10627.7 10698.4 10992.9 11104.1 9748.7 10396.4 10425.2 10550.1 10824.3 9818.7 11169.2 11211.7 11418.3 11520.3 5924.8 7629.2 7756.5 7777.9 7788.7 9163.4 10102.2 11175.1 11186.0 11316.8 05:41:43 INFO - PROCESS | 1672 | 05:41:43 INFO - PROCESS | 1672 | [#3] mootools.html Cycles:180 Average:6039.28 Median:532.14 stddev:3189.15 (599.3%) stddev-sans-first:3179.08 05:41:43 INFO - PROCESS | 1672 | Values: 1406.4 1641.9 1878.7 1998.8 2014.5 7443.6 8052.1 8752.3 8786.8 9016.2 7357.9 8697.5 8763.6 8799.7 8847.4 2467.5 2501.3 2505.1 2505.6 2505.8 2410.1 2489.8 2501.5 2502.1 2502.4 2291.8 2480.6 2493.3 2502.2 2503.8 2472.0 2480.2 2484.8 2497.1 2514.4 2476.1 2492.6 2503.8 2504.5 2521.7 8870.8 8934.2 9000.5 9008.3 9039.0 5439.5 5575.4 5606.2 5627.3 5651.3 3636.1 3724.4 3739.3 3755.0 3756.8 1052.7 1062.8 1073.7 1085.3 1086.3 11917.1 11928.2 12134.2 12154.5 12159.0 4866.8 4935.3 4957.9 4990.6 5031.4 10198.9 10222.9 10234.6 10251.5 10264.9 5395.3 5408.7 5469.9 5584.7 5614.6 4564.7 4922.2 5020.7 5029.7 5056.0 3893.6 3985.4 3990.9 3996.1 4037.4 1322.7 1327.3 1341.6 1344.6 1354.7 1126.1 1141.7 1171.9 1172.6 1271.7 6827.4 8149.6 8169.3 8190.7 8251.4 517.8 520.2 524.7 530.8 533.5 5020.5 5175.9 5858.6 5940.9 6034.8 9581.7 10348.0 10431.1 10670.5 10917.5 9238.2 10380.3 10643.7 10699.9 10811.8 8364.7 8430.2 8446.3 8480.9 8482.5 7805.9 7858.3 7862.5 7880.3 7949.7 9547.3 9654.5 9751.7 9787.3 9814.5 9597.4 9834.0 9956.6 10015.5 10099.8 6889.6 7352.5 7457.2 7508.1 7535.3 8085.9 8150.6 8175.6 8221.9 8234.0 7270.6 7355.7 7367.3 7483.8 7490.7 7185.1 7298.4 7315.9 7323.3 7363.2 7682.5 7687.0 7757.0 7806.9 7828.6 6843.4 6990.8 6993.9 7021.5 7123.1 7038.8 7076.3 7121.9 7166.7 7193.4 05:41:43 INFO - PROCESS | 1672 | 05:41:43 INFO - PROCESS | 1672 | [#4] prototype.html Cycles:180 Average:5901.62 Median:6664.68 stddev:1924.70 (28.9%) stddev-sans-first:1883.04 05:41:43 INFO - PROCESS | 1672 | Values: 265.4 328.5 331.4 336.1 337.2 6658.8 6779.8 6802.4 6809.0 6826.0 6673.4 6764.7 6765.1 6770.2 6787.8 4825.7 4892.2 5025.6 5048.7 5057.0 4150.7 4896.5 5013.6 5030.5 5096.8 5024.9 5029.5 5033.0 5063.7 5072.9 5039.1 5059.9 5065.6 5069.7 5078.8 4313.8 4315.2 4315.4 4316.5 4336.4 5383.6 6486.9 6515.6 6521.2 6522.9 4360.7 5803.8 5837.5 5856.1 5882.9 7261.0 7278.2 7313.9 7327.0 7329.9 4650.7 4656.0 4662.4 4674.2 4680.7 7477.7 7508.9 7647.8 7648.5 7682.8 4486.5 4552.9 4601.1 4681.4 4710.4 4773.7 4778.2 4779.5 4787.6 4796.6 4608.5 5775.5 5779.4 5789.2 5804.5 7266.8 7274.5 7283.5 7291.5 7292.3 1565.4 1624.9 1640.0 1674.1 1676.7 1038.6 1039.2 1046.0 1062.4 1063.3 6649.7 6653.2 6661.2 6663.7 6665.7 7389.3 7436.3 7451.8 7470.9 7478.4 6569.6 6573.4 6628.1 6653.3 6671.1 3171.8 3530.9 3643.0 3933.8 3943.3 7161.3 7746.1 7875.1 7880.1 7958.2 7811.3 7895.4 7902.6 7905.8 7912.4 7142.8 7908.4 7933.0 7944.9 7954.2 7259.7 7345.6 7477.6 7631.2 7664.9 7284.9 7310.9 7385.7 7396.1 7433.7 7882.5 7892.4 7926.8 7928.2 7929.7 4675.7 4738.9 4739.8 4743.2 4756.3 5979.8 7308.3 7522.5 7542.5 7558.5 7209.9 7222.6 7270.0 7285.6 7288.1 7193.2 7196.8 7250.8 7290.0 7290.9 7052.3 7080.3 7102.1 7119.6 7138.6 5541.4 7235.2 7274.8 7287.7 7306.2 7098.6 7112.0 7129.6 7150.7 7155.3 05:41:43 INFO - PROCESS | 1672 | 05:41:43 INFO - PROCESS | 1672 | [#5] yui.html Cycles:180 Average:17432.01 Median:588.90 stddev:24103.99 (4093.0%) stddev-sans-first:24138.35 05:41:43 INFO - PROCESS | 1672 | Values: 568.4 691.6 745.4 759.3 766.3 14749.5 14892.8 14963.3 14973.4 15043.5 13733.0 13797.7 13809.9 13826.7 13928.2 713.7 876.7 909.1 912.8 914.9 900.7 909.1 909.6 910.6 911.3 848.7 922.6 957.3 960.5 961.4 913.1 926.1 947.3 948.1 948.2 695.2 711.3 712.1 712.8 713.1 13894.9 13904.7 14326.7 14644.0 14752.0 11556.7 11688.8 12595.6 12853.8 13017.0 9881.6 10030.5 10335.4 10423.2 10622.6 3448.2 3458.4 3469.6 3531.4 3578.6 67707.3 69567.0 69683.7 72340.3 72944.6 9249.6 9298.9 9305.0 9378.2 9438.7 19833.8 19938.6 20140.4 20163.6 20281.5 7265.6 7308.2 7419.4 7521.7 7569.3 4095.8 4112.4 4114.4 4134.5 4151.3 3646.0 3664.0 3673.4 3680.6 3698.7 632.3 641.0 646.2 648.5 671.9 565.9 569.2 577.7 578.4 584.5 7877.6 8142.1 8155.4 8255.6 8280.6 559.4 574.5 593.3 612.2 616.3 3611.5 3807.6 3826.0 3867.7 3910.3 84277.0 85319.0 85979.1 96679.0 97371.5 47125.8 70213.0 73915.0 81146.6 81459.0 56674.4 57756.0 69772.0 71088.0 71950.3 7980.8 8365.7 8381.0 8509.9 8579.6 48044.8 49040.8 49796.8 50035.0 50506.0 54480.7 61537.0 65398.7 71673.0 71696.0 10815.6 10962.3 11015.0 11110.9 11245.8 11815.2 11977.3 12030.9 12145.9 12256.1 11137.8 11154.3 11355.8 11375.2 11511.6 11201.3 11335.0 11404.4 11626.4 12268.6 10796.1 10912.8 11077.6 11337.5 11461.0 9046.6 9247.7 9352.3 9619.3 9874.7 7567.1 9332.4 9413.4 9531.4 9552.8 05:41:43 INFO - PROCESS | 1672 | -------- Summary: end -------- 05:41:43 INFO - PROCESS | 1672 | 05:41:43 INFO - TEST-INFO | 1672: exit 0 05:41:43 INFO - TEST-OK | dromaeo_css | took 1112202ms 05:41:43 INFO - TEST-START | kraken 05:41:43 INFO - operating with platform_type : mac_ 05:41:43 INFO - Initialising browser for kraken test... 05:41:43 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/tmpZxclls/profile http://localhost:49279/getInfo.html) 05:41:45 INFO - PROCESS | 1684 | JavaScript error: jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 05:41:46 INFO - PROCESS | 1684 | __metrics Screen width/height:1600/1200 05:41:46 INFO - PROCESS | 1684 | colorDepth:24 05:41:46 INFO - PROCESS | 1684 | Browser inner width/height: 1024/689 05:41:46 INFO - PROCESS | 1684 | __metrics 05:41:46 ERROR - PROCESS | 1684 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 05:41:47 INFO - TEST-INFO | 1684: exit 0 05:41:47 INFO - Browser initialized. 05:41:47 INFO - Running cycle 1/1 for kraken test... 05:41:47 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/tmpZxclls/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:41:59 INFO - PROCESS | 1688 | RSS: Main: 247586816 05:41:59 INFO - PROCESS | 1688 | 05:42:01 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 05:42:02 INFO - PROCESS | 1688 | RSS: Main: 259481600 05:42:02 INFO - PROCESS | 1688 | 05:42:04 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 05:42:05 INFO - PROCESS | 1688 | RSS: Main: 268476416 05:42:05 INFO - PROCESS | 1688 | 05:42:09 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 05:42:09 INFO - PROCESS | 1688 | RSS: Main: 271552512 05:42:09 INFO - PROCESS | 1688 | 05:42:11 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 05:42:12 INFO - PROCESS | 1688 | RSS: Main: 272658432 05:42:12 INFO - PROCESS | 1688 | 05:42:14 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:42:14 INFO - PROCESS | 1688 | RSS: Main: 274464768 05:42:14 INFO - PROCESS | 1688 | 05:42:17 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 05:42:18 INFO - PROCESS | 1688 | RSS: Main: 274702336 05:42:18 INFO - PROCESS | 1688 | 05:42:21 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 05:42:22 INFO - PROCESS | 1688 | RSS: Main: 274214912 05:42:22 INFO - PROCESS | 1688 | 05:42:25 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 05:42:25 INFO - PROCESS | 1688 | RSS: Main: 274522112 05:42:25 INFO - PROCESS | 1688 | 05:42:27 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:42:27 INFO - PROCESS | 1688 | RSS: Main: 274456576 05:42:27 INFO - PROCESS | 1688 | 05:42:29 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:42:30 INFO - PROCESS | 1688 | RSS: Main: 274481152 05:42:30 INFO - PROCESS | 1688 | 05:42:32 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:42:33 INFO - PROCESS | 1688 | RSS: Main: 275046400 05:42:33 INFO - PROCESS | 1688 | 05:42:35 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:42:36 INFO - PROCESS | 1688 | RSS: Main: 274726912 05:42:36 INFO - PROCESS | 1688 | 05:42:39 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:42:39 INFO - PROCESS | 1688 | RSS: Main: 274710528 05:42:39 INFO - PROCESS | 1688 | 05:42:41 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 05:42:41 INFO - PROCESS | 1688 | RSS: Main: 276242432 05:42:41 INFO - PROCESS | 1688 | 05:42:41 INFO - PROCESS | 1688 | __start_tp_report 05:42:41 INFO - PROCESS | 1688 | _x_x_mozilla_page_load 05:42:41 INFO - PROCESS | 1688 | _x_x_mozilla_page_load_details 05:42:41 INFO - PROCESS | 1688 | |i|pagename|runs| 05:42:41 INFO - PROCESS | 1688 | |0;ai-astar;114;111;121;115;116;126;115;115;115;115 05:42:41 INFO - PROCESS | 1688 | |1;audio-beat-detection;156;124;145;157;138;174;171;108;161;149 05:42:41 INFO - PROCESS | 1688 | |2;audio-dft;194;200;198;206;210;240;256;256;204;197 05:42:41 INFO - PROCESS | 1688 | |3;audio-fft;58;58;62;86;106;147;82;76;57;58 05:42:41 INFO - PROCESS | 1688 | |4;audio-oscillator;87;88;124;78;114;123;162;80;79;117 05:42:41 INFO - PROCESS | 1688 | |5;imaging-gaussian-blur;88;99;135;115;89;85;89;86;88;98 05:42:41 INFO - PROCESS | 1688 | |6;imaging-darkroom;106;101;149;150;119;94;99;95;96;107 05:42:41 INFO - PROCESS | 1688 | |7;imaging-desaturate;92;90;126;88;140;147;109;146;103;78 05:42:41 INFO - PROCESS | 1688 | |8;json-parse-financial;54;59;85;57;44;70;74;85;82;45 05:42:41 INFO - PROCESS | 1688 | |9;json-stringify-tinderbox;65;72;71;68;80;62;86;96;100;83 05:42:41 INFO - PROCESS | 1688 | |10;stanford-crypto-aes;83;83;83;85;86;86;100;80;94;113 05:42:41 INFO - PROCESS | 1688 | |11;stanford-crypto-ccm;124;142;125;113;129;134;142;125;133;134 05:42:41 INFO - PROCESS | 1688 | |12;stanford-crypto-pbkdf2;143;145;150;180;144;135;138;140;143;139 05:42:41 INFO - PROCESS | 1688 | |13;stanford-crypto-sha256-iterative;70;75;88;87;67;67;69;69;70;69 05:42:41 INFO - PROCESS | 1688 | __end_tp_report 05:42:41 INFO - PROCESS | 1688 | __start_cc_report 05:42:41 INFO - PROCESS | 1688 | _x_x_mozilla_cycle_collect,964 05:42:41 INFO - PROCESS | 1688 | __end_cc_report 05:42:41 INFO - PROCESS | 1688 | __startTimestamp1459600961705__endTimestamp 05:42:41 INFO - PROCESS | 1688 | 05:42:41 INFO - PROCESS | 1688 | ------- Summary: start ------- 05:42:41 INFO - PROCESS | 1688 | Number of tests: 14 05:42:41 INFO - PROCESS | 1688 | 05:42:41 INFO - PROCESS | 1688 | [#0] ai-astar Cycles:10 Average:116.30 Median:115.00 stddev:4.19 (3.6%) stddev-sans-first:4.36 05:42:41 INFO - PROCESS | 1688 | Values: 114.0 111.0 121.0 115.0 116.0 126.0 115.0 115.0 115.0 115.0 05:42:41 INFO - PROCESS | 1688 | 05:42:41 INFO - PROCESS | 1688 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:156.50 stddev:20.56 (13.1%) stddev-sans-first:21.62 05:42:41 INFO - PROCESS | 1688 | Values: 156.0 124.0 145.0 157.0 138.0 174.0 171.0 108.0 161.0 149.0 05:42:41 INFO - PROCESS | 1688 | 05:42:41 INFO - PROCESS | 1688 | [#2] audio-dft Cycles:10 Average:216.10 Median:208.00 stddev:24.68 (11.9%) stddev-sans-first:24.85 05:42:41 INFO - PROCESS | 1688 | Values: 194.0 200.0 198.0 206.0 210.0 240.0 256.0 256.0 204.0 197.0 05:42:41 INFO - PROCESS | 1688 | 05:42:41 INFO - PROCESS | 1688 | [#3] audio-fft Cycles:10 Average:79.00 Median:60.00 stddev:28.90 (48.2%) stddev-sans-first:29.64 05:42:41 INFO - PROCESS | 1688 | Values: 58.0 58.0 62.0 86.0 106.0 147.0 82.0 76.0 57.0 58.0 05:42:41 INFO - PROCESS | 1688 | 05:42:41 INFO - PROCESS | 1688 | [#4] audio-oscillator Cycles:10 Average:105.20 Median:78.50 stddev:27.49 (35.0%) stddev-sans-first:28.36 05:42:41 INFO - PROCESS | 1688 | Values: 87.0 88.0 124.0 78.0 114.0 123.0 162.0 80.0 79.0 117.0 05:42:41 INFO - PROCESS | 1688 | 05:42:41 INFO - PROCESS | 1688 | [#5] imaging-gaussian-blur Cycles:10 Average:97.20 Median:88.50 stddev:16.08 (18.2%) stddev-sans-first:16.71 05:42:41 INFO - PROCESS | 1688 | Values: 88.0 99.0 135.0 115.0 89.0 85.0 89.0 86.0 88.0 98.0 05:42:41 INFO - PROCESS | 1688 | 05:42:41 INFO - PROCESS | 1688 | [#6] imaging-darkroom Cycles:10 Average:111.60 Median:122.00 stddev:21.29 (17.5%) stddev-sans-first:22.49 05:42:41 INFO - PROCESS | 1688 | Values: 106.0 101.0 149.0 150.0 119.0 94.0 99.0 95.0 96.0 107.0 05:42:41 INFO - PROCESS | 1688 | 05:42:41 INFO - PROCESS | 1688 | [#7] imaging-desaturate Cycles:10 Average:111.90 Median:112.50 stddev:25.96 (23.1%) stddev-sans-first:26.52 05:42:41 INFO - PROCESS | 1688 | Values: 92.0 90.0 126.0 88.0 140.0 147.0 109.0 146.0 103.0 78.0 05:42:41 INFO - PROCESS | 1688 | 05:42:41 INFO - PROCESS | 1688 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:72.00 stddev:15.83 (22.0%) stddev-sans-first:16.23 05:42:41 INFO - PROCESS | 1688 | Values: 54.0 59.0 85.0 57.0 44.0 70.0 74.0 85.0 82.0 45.0 05:42:41 INFO - PROCESS | 1688 | 05:42:41 INFO - PROCESS | 1688 | [#9] json-stringify-tinderbox Cycles:10 Average:78.30 Median:76.00 stddev:12.95 (17.0%) stddev-sans-first:12.81 05:42:41 INFO - PROCESS | 1688 | Values: 65.0 72.0 71.0 68.0 80.0 62.0 86.0 96.0 100.0 83.0 05:42:41 INFO - PROCESS | 1688 | 05:42:41 INFO - PROCESS | 1688 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:84.00 stddev:10.24 (12.2%) stddev-sans-first:10.61 05:42:41 INFO - PROCESS | 1688 | Values: 83.0 83.0 83.0 85.0 86.0 86.0 100.0 80.0 94.0 113.0 05:42:41 INFO - PROCESS | 1688 | 05:42:41 INFO - PROCESS | 1688 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:133.50 stddev:8.85 (6.6%) stddev-sans-first:9.11 05:42:41 INFO - PROCESS | 1688 | Values: 124.0 142.0 125.0 113.0 129.0 134.0 142.0 125.0 133.0 134.0 05:42:41 INFO - PROCESS | 1688 | 05:42:41 INFO - PROCESS | 1688 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.70 Median:143.50 stddev:12.75 (8.9%) stddev-sans-first:13.49 05:42:41 INFO - PROCESS | 1688 | Values: 143.0 145.0 150.0 180.0 144.0 135.0 138.0 140.0 143.0 139.0 05:42:41 INFO - PROCESS | 1688 | 05:42:41 INFO - PROCESS | 1688 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:70.00 stddev:7.91 (11.3%) stddev-sans-first:8.31 05:42:41 INFO - PROCESS | 1688 | Values: 70.0 75.0 88.0 87.0 67.0 67.0 69.0 69.0 70.0 69.0 05:42:41 INFO - PROCESS | 1688 | -------- Summary: end -------- 05:42:41 INFO - PROCESS | 1688 | 05:42:42 INFO - TEST-INFO | 1688: exit 0 05:42:42 INFO - TEST-OK | kraken | took 58826ms 05:42:42 INFO - SUITE-END | took 1171s 05:42:42 INFO - Completed test suite (00:19:31) 05:42:42 INFO - javascript benchmark 05:42:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3507.5966263879645, 3533.046077559059, 3561.3767590671628, 3577.123604716843, 3607.026102952205, 4314.460692413449, 5699.344575373833, 5716.056850619648, 5845.035569131093, 5852.239208902842, 4899.461059283485, 4902.705837649743, 5937.020391635386, 6007.939920600793, 6046.606970546912, 5261.263423120757, 5298.0, 5311.203319502067, 5322.2814919985885, 5377.139657654776, 4388.363687265361, 5421.864453388677, 5454.890902181954, 5480.424555421683, 5517.172424136392, 4065.9796701016307, 5226.817061402832, 5290.629655924087, 5329.866753331159, 5351.117065684158, 5325.467453254682, 5325.707086110262, 5333.413324534298, 5349.652272602269, 5353.946460535384, 4546.772661366951, 5218.582513398919, 5319.7340132993195, 5324.840254792323, 5325.600579956519, 4624.722516648978, 5428.0, 5749.59752817303, 5786.942130578683, 5799.0, 6211.4409703126485, 6227.19046523949, 6241.469475094623, 6242.1261023456755, 6247.125402443661, 6144.279601711483, 6268.811935641938, 6311.526635502356, 6321.462675672573, 6335.5565110442285, 5301.416844147141, 5386.434424385383, 6015.729292181819, 6062.151298818169, 6062.787802426894, 6451.3548645135115, 6456.451201647913, 6461.127747754087, 6473.449756770633, 6486.383793539606, 6125.509959203253, 6145.631262124198, 6155.661438620829, 6186.876262474725, 6192.225971753531, 6145.832291864532, 6223.315435302113, 6311.463525600284, 6313.55805093639, 6317.6209427434505, 6112.449879510866, 6189.84525386869, 6241.157443745127, 6255.781047663401, 6259.0924315973925, 6142.007694998287, 6239.970404883235, 6260.060990851409, 6268.686565671698, 6293.559450838489, 4289.528151903288, 4982.551570358685, 5020.221865610836, 5035.370578677665, 5036.924446133311, 4425.070735145656, 4454.242778727559, 4455.0, 4495.0, 4512.729236245836, 5529.447055294519, 5798.391168927202, 5902.527797776168, 5914.556408269397, 5916.556258280646, 6264.749410023639, 6302.558820882494, 6322.810315690536, 6342.873142537216, 6349.015902535114, 5973.462388384979, 6017.488513476404, 6017.608855424383, 6036.245469316335, 6046.818595442144, 4663.370444989951, 5366.382865970385, 5448.318960129984, 5518.53092487135, 5523.530499907472, 6459.354064593503, 6480.611163330215, 6487.286398496256, 6488.9026664601015, 6492.837679058061, 6273.215848018997, 6282.811515654537, 6284.402981716729, 6303.1175635412, 6313.779017734358, 4853.95146048535, 6399.456046236122, 6458.289588145206, 6494.545381823227, 6510.381513756186, 4595.4025976622825, 5464.9453505464435, 5623.831285061455, 6233.688315584293, 6265.561410701207, 6305.085762564494, 6311.179546658905, 6314.116023756769, 6324.810255692337, 6329.208848893888, 6111.682900513496, 6115.327313995546, 6159.876802464015, 6184.350643182581, 6223.595466294857, 4835.661503694708, 5103.642745007814, 6269.435750782452, 6273.0, 6273.52948528853, 6082.148499210202, 6141.6007959482495, 6148.077788331786, 6195.070739389128, 6224.035274532454, 6067.605605635619, 6129.0757006688855, 6146.770645870754, 6233.065040244, 6285.622862628257, 6193.566450348432, 6198.752049917953, 6200.193974783249, 6218.875622487615, 6235.064740288993], "unit": "score", "name": "dojo.html", "value": 5714.534730735834}, {"lowerIsBetter": false, "replicates": [464.8373069425699, 491.1086378223524, 507.4367452128137, 579.7767859374139, 648.2804087462916, 37243.4413483798, 37799.24401511968, 37820.0, 37862.67480638178, 37948.051298717546, 32012.67987320126, 36869.89390318295, 38819.805900970525, 39361.21277574454, 39413.80293098531, 9372.859407108881, 9534.284928630346, 9576.186024187917, 9595.088466595696, 9618.182454491342, 9407.623695052223, 9490.335676502647, 9552.044795520427, 9649.90350096497, 9704.61181552737, 9581.760455988586, 9597.0, 9608.711738647851, 9702.466364349957, 9739.805203895918, 9531.47576883278, 9561.904380956172, 9621.470819104947, 9722.319437639404, 9733.31866769323, 9442.57508412123, 9480.194183494412, 9500.23998080152, 9621.18219951305, 9658.082482164184, 37944.482220711136, 38226.426603600965, 38406.80796596027, 38498.61501384978, 38733.806330968444, 3343.782654127474, 3459.567554055743, 3650.689691376236, 3756.6806821420214, 3827.311084004878, 28369.0, 28538.714612854023, 29141.980030698825, 29145.70854291451, 29162.70837291621, 2748.931276718078, 2753.2979090332037, 2754.862256887168, 2790.679071906736, 2952.2914500519937, 450870.0, 455670.0, 464204.0, 465350.0, 466218.6689066567, 62177.0, 62311.37688623056, 62577.0, 62605.68697156576, 62622.0, 66232.0, 72257.0, 72326.0, 73475.63262183762, 73609.0, 14294.999350045606, 16135.0, 16173.676526469404, 16685.833141668427, 16765.83234167643, 11268.436578171058, 11957.701057473632, 12597.0, 12703.047271454678, 12802.0, 20416.693749593767, 20450.79549204519, 20637.801140823198, 20662.896685516476, 21601.67597486039, 7256.746013889594, 7770.611469426506, 8689.653103768926, 8997.19025287714, 9053.230475409533, 914.0813482450228, 985.6254623243265, 1037.818381783185, 1067.9626213082504, 1115.55935405516, 28542.429151416854, 28748.901493968187, 28981.0, 29043.7095629041, 29340.413191736046, 1019.4444028004755, 1093.94530273486, 1106.4301884529473, 1209.9957035660382, 1216.568118318002, 14262.144271343752, 14301.856981430261, 14415.78376324356, 14537.709245815236, 14599.78100328496, 521582.0, 524399.0, 537180.0, 537211.0, 538155.0, 54853.45146548563, 55218.0, 55342.72328638331, 55367.61580960508, 55556.72221638866, 1243.875612438749, 1390.9095908765898, 1418.666613345863, 1442.3076923076983, 1447.5802017414833, 28846.0, 28920.566191507565, 28987.42025159527, 29092.56361154542, 29185.0, 48284.79288017828, 54766.72616637051, 54781.0, 56207.875842483736, 56213.87572248614, 415580.28616852727, 419352.0, 423224.0, 423574.41063973645, 424058.0, 35645.465318019735, 37149.88550343494, 40371.59628403679, 41154.38268426036, 41602.0, 43651.781741091094, 43940.56059439493, 43965.340519891586, 44293.55706442894, 44465.777671111435, 30553.23616909595, 37346.813265933495, 37507.72728179145, 38629.42055869108, 38865.41701874418, 37141.44287835739, 37169.6283037177, 37671.623283766814, 37752.43371349377, 37909.81045094757, 37672.0, 38080.61919380771, 38172.42741358937, 38262.2347553053, 38967.0, 23472.295831125095, 27786.0, 30720.23199419943, 30893.536596950613, 31198.844005779825, 24273.514529708955, 24282.028718851754, 24300.27099187027, 24755.009799607815, 24868.875655621607], "unit": "score", "name": "ext.html", "value": 19703.542424508876}, {"lowerIsBetter": false, "replicates": [321.8841217161821, 330.22562091894514, 353.2599204666225, 355.2911940678347, 365.8372024449118, 15450.0, 19228.13473393697, 19231.807681923194, 20095.397138085846, 20096.196152153916, 11878.465469053892, 12208.511659533608, 12233.204841685285, 19555.0, 19895.502612434695, 5208.869778255536, 5341.679499230039, 5372.758225879845, 5390.380106287788, 5390.865228369283, 5120.795168193286, 5259.8422047338645, 5315.893682126355, 5350.491703288181, 5386.057439947994, 5259.921101183485, 5333.280007199037, 5345.224942383352, 5380.757865896044, 5381.0, 5428.75570599322, 5513.8345849624575, 5796.62321949072, 5827.970860145714, 5882.323532793741, 5126.436092029874, 5197.610179236534, 5206.76569554371, 5207.218917162456, 5242.18746094356, 13267.203967761965, 20376.898115509477, 24591.13931012406, 25275.494490110093, 25352.985880564756, 1906.20892329683, 1964.057252518799, 1998.6102709971562, 2224.165937773335, 2703.931946880991, 9223.169914707709, 9389.295802814817, 9571.042895710443, 12904.548340808027, 13971.79042314366, 1703.0803366182247, 1736.6179440523065, 1736.6700326937842, 1748.8513476354526, 1771.3180425536132, 99571.50214248955, 103933.0, 104343.0, 106137.93862061358, 106787.0, 8931.508767017876, 10977.560897564168, 11114.333140011464, 11249.550017999352, 11317.264377815416, 12147.939260303641, 13038.674033149058, 13719.039667223398, 13733.45066197341, 13736.793948090786, 8255.628496717662, 8258.42191046633, 8486.575671216415, 8503.362247831437, 8570.142985701379, 8671.0, 8730.607122679494, 8764.430312029697, 8787.297016238686, 8872.112788721206, 4316.978415107905, 4328.458942632171, 4348.978255108705, 4350.760708161081, 4360.41134446852, 1820.9544761380807, 1855.8422534084484, 1892.5647101166533, 1925.0182406972265, 1935.312963897796, 852.0925214646381, 863.4430792139035, 879.6437442835662, 894.7449976756724, 978.3885071830106, 15498.457553985556, 17265.13674316279, 19714.802851971297, 20108.296209632594, 20290.69563956542, 918.7565295196778, 936.9859452108224, 958.9930572898568, 990.4997976022063, 1029.4749677664445, 5653.689047102449, 8481.660733570588, 9032.32257580684, 9048.457092574336, 9553.570089345996, 510285.0, 516528.0, 520108.0, 579339.0, 637881.0, 100904.49547752214, 125459.0, 128916.0, 129505.35247323703, 130295.04557431646, 1011.9645812396531, 1032.4476405123223, 1036.5076588620345, 1059.8357254625546, 1060.41677077607, 17300.65398691994, 17557.297708091533, 17768.733468998234, 18093.547661308574, 18222.453326400228, 37334.693285734866, 50466.24300635567, 50472.77729871497, 50778.23832642439, 50971.980560389326, 54828.45171548233, 67375.66312168408, 70309.0, 77020.459590809, 77343.2265677336, 7561.09266887977, 7731.961340193263, 7822.882656760039, 7876.803079923047, 7904.249096335839, 11757.764844702888, 12128.272303661808, 12378.81431778542, 12562.497500100259, 12572.0, 10584.153267738717, 10627.734306642396, 10698.358098514114, 10992.890071099187, 11104.056155226574, 9748.658796942073, 10396.428196449267, 10425.218108641731, 10550.050495455445, 10824.296420732628, 9818.65634702782, 11169.162312826733, 11211.71970700739, 11418.257813242113, 11520.308781473139, 5924.763009479572, 7629.198934111839, 7756.495827771177, 7777.883331749915, 7788.727394541163, 9163.404378715362, 10102.24233182529, 11175.050120739828, 11186.0, 11316.83024754613], "unit": "score", "name": "jquery.html", "value": 8950.504104622312}, {"lowerIsBetter": false, "replicates": [1406.4303956897454, 1641.860441862442, 1878.7463692401523, 1998.8400927925768, 2014.486305991972, 7443.59060251686, 8052.114267430578, 8752.256058235042, 8786.780330491732, 9016.188543031127, 7357.852842943138, 8697.47815131091, 8763.605637746301, 8799.692010779623, 8847.424917380366, 2467.4571594249282, 2501.3371456564023, 2505.060602274147, 2505.6116301973225, 2505.8496490210555, 2410.08416801616, 2489.800815934721, 2501.4871951250043, 2502.124256510225, 2502.3744063984004, 2291.8166546676225, 2480.60310350344, 2493.26717931038, 2502.2118032819694, 2503.7996960243136, 2471.9752802472017, 2480.218731099698, 2484.751524847519, 2497.113524698733, 2514.35883849619, 2476.108600903673, 2492.5513407586627, 2503.7996960243318, 2504.511620234055, 2521.6595759572588, 8870.778230544223, 8934.240589549896, 9000.504972226525, 9008.324375671786, 9038.954805225932, 5439.5376393006645, 5575.442455754433, 5606.24315717377, 5627.296587926509, 5651.321841379061, 3636.127329440915, 3724.3854763963914, 3739.2895349883706, 3754.962450375516, 3756.812159392047, 1052.747230795351, 1062.755566219766, 1073.7100982734696, 1085.3433672628105, 1086.293908959175, 11917.106217033757, 11928.224665396721, 12134.211276267102, 12154.513819447211, 12159.027277817842, 4866.78099485524, 4935.259711043373, 4957.90084198314, 4990.600751939836, 5031.421386540522, 10198.898011019943, 10222.897771022343, 10234.6417875374, 10251.538680759235, 10264.948675256725, 5395.325584301962, 5408.702521361363, 5469.890602187934, 5584.692841893735, 5614.578906582023, 4564.7032942858605, 4922.163232250526, 5020.673656212334, 5029.723365214875, 5056.039352523009, 3893.591172926802, 3985.3822657488136, 3990.900227494336, 3996.140829721624, 4037.3540233563076, 1322.6627210061372, 1327.3230652367363, 1341.637757805387, 1344.5831792144465, 1354.7087376213965, 1126.099120703434, 1141.7145713571608, 1171.9472623731951, 1172.6247600767672, 1271.6502961685426, 6827.385535301747, 8149.592520373958, 8169.305609023299, 8190.7133250335955, 8251.422400432033, 517.7954707890362, 520.2066848056668, 524.7140308531859, 530.7797264135418, 533.5011764000672, 5020.49795020495, 5175.948240517547, 5858.619189752738, 5940.910886336708, 6034.758609655652, 9581.664641737505, 10348.0, 10431.061204491632, 10670.466476676134, 10917.508712107974, 9238.214751746042, 10380.273380863267, 10643.680689579325, 10699.94650026745, 10811.78376432467, 8364.707235246737, 8430.199131082538, 8446.324294056461, 8480.872786908201, 8482.533460659723, 7805.921940780747, 7858.292753652198, 7862.52824830512, 7880.2513761192595, 7949.682012719658, 9547.283953703361, 9654.469004204837, 9751.707448776548, 9787.314887957775, 9814.509274536102, 9597.376170548892, 9833.950830245803, 9956.601735930482, 10015.499225038864, 10099.848502272325, 6889.552179108342, 7352.485326027127, 7457.179710231979, 7508.136564295176, 7535.284148005931, 8085.8787118192095, 8150.633221504928, 8175.591220439073, 8221.917780822116, 8234.0, 7270.636468176675, 7355.668994895135, 7367.26327367259, 7483.812904677427, 7490.662920168496, 7185.065941427581, 7298.37963773064, 7315.926840731738, 7323.304286092813, 7363.226861179499, 7682.500637458547, 7687.0391201099865, 7756.952811370393, 7806.92193078062, 7828.569428681477, 6843.3840954314355, 6990.790276291719, 6993.930060699531, 7021.473389495706, 7123.145222573325, 7038.824029399306, 7076.2923707628825, 7121.893171602534, 7166.677499512639, 7193.424526037799], "unit": "score", "name": "mootools.html", "value": 4854.719060217595}, {"lowerIsBetter": false, "replicates": [265.43197557227535, 328.53512280123624, 331.4018197154137, 336.0875223767471, 337.2008340233647, 6658.800235992916, 6779.779639664871, 6802.353776391247, 6809.012693159489, 6825.965870170642, 6673.399394054534, 6764.695588698508, 6765.12053433053, 6770.187577490696, 6787.76242831501, 4825.662203645747, 4892.192788189962, 5025.572826309768, 5048.747562621873, 5057.013882292954, 4150.717105591927, 4896.485868983759, 5013.623978201631, 5030.547250747432, 5096.79612815487, 5024.874378140557, 5029.47190544993, 5033.018561380532, 5063.696178229299, 5072.923906141411, 5039.067772462088, 5059.949400505985, 5065.569426598743, 5069.670471419346, 5078.796848126089, 4313.84901528445, 4315.223259813232, 4315.43899293093, 4316.503602085738, 4336.3712261722185, 5383.623146379755, 6486.902696459557, 6515.609063456208, 6521.217453905561, 6522.869542609121, 4360.738355698668, 5803.82588522345, 5837.474627283523, 5856.121581762727, 5882.911661342665, 7260.98346231528, 7278.1630112537205, 7313.926860731431, 7326.963365183194, 7329.9371591119525, 4650.674452788307, 4655.976720116411, 4662.440507139131, 4674.2053850845095, 4680.672352935296, 7477.700891964315, 7508.887366689504, 7647.808804779869, 7648.54108753471, 7682.807929801744, 4486.484054333728, 4552.908941821145, 4601.079784043205, 4681.438227412732, 4710.434747830213, 4773.7374444405195, 4778.235482322812, 4779.450363208275, 4787.640926930494, 4796.592289655348, 4608.539146085432, 5775.537956963432, 5779.393163717833, 5789.189513468118, 5804.506616937523, 7266.781996540112, 7274.49078564506, 7283.4537409694485, 7291.4531410144455, 7292.34368906801, 1565.4051460444957, 1624.8537631613212, 1640.0487717124279, 1674.087622245879, 1676.6898123847127, 1038.60532997462, 1039.2413538117066, 1045.9895401046044, 1062.4156713807374, 1063.3411877471015, 6649.700763465656, 6653.234877988996, 6661.233958094785, 6663.700133494004, 6665.666716664147, 7389.334959853639, 7436.330730234305, 7451.813704657318, 7470.85058298831, 7478.401727861758, 6569.638669873108, 6573.375529324707, 6628.072069910217, 6653.334666533308, 6671.13275274221, 3171.8255495947947, 3530.8940731777575, 3643.0163855758797, 3933.783641899666, 3943.3493473576536, 7161.319674630901, 7746.070471543451, 7875.094364148082, 7880.054393472706, 7958.164392738795, 7811.336036436853, 7895.368370530344, 7902.565358905315, 7905.802354941173, 7912.446128770931, 7142.8214294640975, 7908.446408751447, 7933.0, 7944.9205507945335, 7954.244346787046, 7259.673314700745, 7345.632718363953, 7477.626118694152, 7631.198724133886, 7664.885026724715, 7284.890726638999, 7310.853782924418, 7385.7045718170675, 7396.14944281393, 7433.70265189408, 7882.5270483771155, 7892.4080693947035, 7926.841463170589, 7928.167542407964, 7929.722459713882, 4675.742834144155, 4738.928916066193, 4739.834105806281, 4743.241081426955, 4756.262779269219, 5979.833932383318, 7308.342249197598, 7522.548647080974, 7542.509736867086, 7558.470907036454, 7209.927900720925, 7222.6388680566815, 7269.963650181715, 7285.599292038989, 7288.08898887639, 7193.172785129777, 7196.784096477114, 7250.818729531593, 7289.963550182428, 7290.890636640349, 7052.33002864727, 7080.2919708028785, 7102.14774227096, 7119.6084215368655, 7138.571685698875, 5541.418151094238, 7235.2041275458605, 7274.781756547312, 7287.672054757655, 7306.159791623819, 7098.645067746489, 7111.964440177766, 7129.643517824192, 7150.67821948024, 7155.3202445767565], "unit": "score", "name": "prototype.html", "value": 5247.7475701618505}, {"lowerIsBetter": false, "replicates": [568.3605943313772, 691.5574032619123, 745.4148493432657, 759.3393747439728, 766.3486036868659, 14749.48376806812, 14892.776608350883, 14963.326650300736, 14973.401063957455, 15043.548693539184, 13733.0, 13797.724045519084, 13809.930950345235, 13826.723465530684, 13928.233947132903, 713.7073799742094, 876.7282142535803, 909.0863681999581, 912.8493798523235, 914.8673442350855, 900.729781065681, 909.1090731083542, 909.645238357038, 910.6175406329324, 911.3347256502757, 848.6902280667574, 922.6125027488438, 957.3203025851653, 960.4573416019962, 961.4039295636715, 913.0777914306532, 926.1386910173536, 947.2611363136764, 948.127722495306, 948.1608776233049, 695.197047410242, 711.2816055783644, 712.081414974682, 712.843174501614, 713.1442269276837, 13894.861051389458, 13904.652383690489, 14326.713465730627, 14644.0, 14752.041117327339, 11556.711082222928, 11688.766224675544, 12595.622131336075, 12853.807192892114, 13017.0, 9881.604735810559, 10030.548625311878, 10335.379877207391, 10423.166146708321, 10622.628208012682, 3448.2241495663525, 3458.4466485362473, 3469.6356882527225, 3531.4349704047486, 3578.5526809148855, 67707.32292677108, 69567.0, 69683.65158174228, 72340.27659723388, 72944.63527682381, 9249.583768730423, 9298.86051709225, 9304.95347523258, 9378.155965963097, 9438.669646562337, 19833.801661983485, 19938.60122797565, 20140.39578812638, 20163.59672806565, 20281.49296267605, 7265.636718164176, 7308.159561650372, 7419.443541734391, 7521.661525231269, 7569.318761311509, 4095.7542547447247, 4112.424260603518, 4114.382842573638, 4134.524529679065, 4151.252774500619, 3646.033801042726, 3663.9633603663624, 3673.430618254175, 3680.576733675608, 3698.7225958053255, 632.2570979099539, 640.961542307463, 646.1728986896779, 648.4812150279757, 671.9059331693567, 565.9405762394972, 569.2286951181172, 577.7429044075346, 578.4186892173338, 584.5286257202403, 7877.56673382958, 8142.145074767182, 8155.388345873965, 8255.640522973617, 8280.610717493337, 559.3539461921487, 574.5288863132191, 593.27916581353, 612.2377639838429, 616.3128112154915, 3611.494390785292, 3807.6192380762254, 3825.9617403825605, 3867.690584753213, 3910.287040093006, 84277.0, 85319.0, 85979.14020859836, 96679.0, 97371.51314243526, 47125.764371177924, 70213.0, 73915.0, 81146.59426702828, 81459.0, 56674.43325566856, 57756.0, 69771.95342069873, 71088.0, 71950.32143781219, 7980.760577182694, 8365.665373384996, 8381.0, 8509.87235191485, 8579.613917373608, 48044.79888002828, 49040.75479622579, 49796.751016244685, 50035.0, 50505.98988020293, 54480.727596361765, 61537.0, 65398.673006634664, 71673.0, 71696.0, 10815.56737730482, 10962.342259464458, 11015.00196022963, 11110.888891110986, 11245.831312530483, 11815.172937894265, 11977.341246231541, 12030.939845300718, 12145.878541214475, 12256.14207005501, 11137.777244455228, 11154.330740155616, 11355.772884542428, 11375.20373573842, 11511.597094101666, 11201.271917325348, 11335.0, 11404.429778510876, 11626.360550169484, 12268.570600028956, 10796.136309095411, 10912.836307455553, 11077.556897724, 11337.489812958602, 11461.0, 9046.63813447481, 9247.72256832296, 9352.251819854258, 9619.27855410861, 9874.711917051873, 7567.129780075362, 9332.440053596805, 9413.388129771816, 9531.428114313163, 9552.761180970532], "unit": "score", "name": "yui.html", "value": 6781.490992237575}], "name": "dromaeo_css", "value": 7472.710714188368}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 111.0, 121.0, 115.0, 116.0, 126.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 116.3}, {"lowerIsBetter": true, "replicates": [156.0, 124.0, 145.0, 157.0, 138.0, 174.0, 171.0, 108.0, 161.0, 149.0], "unit": "score", "name": "audio-beat-detection", "value": 148.3}, {"lowerIsBetter": true, "replicates": [194.0, 200.0, 198.0, 206.0, 210.0, 240.0, 256.0, 256.0, 204.0, 197.0], "unit": "score", "name": "audio-dft", "value": 216.1}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 62.0, 86.0, 106.0, 147.0, 82.0, 76.0, 57.0, 58.0], "unit": "score", "name": "audio-fft", "value": 79.0}, {"lowerIsBetter": true, "replicates": [87.0, 88.0, 124.0, 78.0, 114.0, 123.0, 162.0, 80.0, 79.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 105.2}, {"lowerIsBetter": true, "replicates": [88.0, 99.0, 135.0, 115.0, 89.0, 85.0, 89.0, 86.0, 88.0, 98.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 97.2}, {"lowerIsBetter": true, "replicates": [106.0, 101.0, 149.0, 150.0, 119.0, 94.0, 99.0, 95.0, 96.0, 107.0], "unit": "score", "name": "imaging-darkroom", "value": 111.6}, {"lowerIsBetter": true, "replicates": [92.0, 90.0, 126.0, 88.0, 140.0, 147.0, 109.0, 146.0, 103.0, 78.0], "unit": "score", "name": "imaging-desaturate", "value": 111.9}, {"lowerIsBetter": true, "replicates": [54.0, 59.0, 85.0, 57.0, 44.0, 70.0, 74.0, 85.0, 82.0, 45.0], "unit": "score", "name": "json-parse-financial", "value": 65.5}, {"lowerIsBetter": true, "replicates": [65.0, 72.0, 71.0, 68.0, 80.0, 62.0, 86.0, 96.0, 100.0, 83.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 78.3}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 85.0, 86.0, 86.0, 100.0, 80.0, 94.0, 113.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.3}, {"lowerIsBetter": true, "replicates": [124.0, 142.0, 125.0, 113.0, 129.0, 134.0, 142.0, 125.0, 133.0, 134.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.1}, {"lowerIsBetter": true, "replicates": [143.0, 145.0, 150.0, 180.0, 144.0, 135.0, 138.0, 140.0, 143.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.7}, {"lowerIsBetter": true, "replicates": [70.0, 75.0, 88.0, 87.0, 67.0, 67.0, 69.0, 69.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 73.1}], "name": "kraken", "value": 1567.6}]} 05:42:42 INFO - Return code: 0 05:42:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:42:42 ERROR - # TBPL SUCCESS # 05:42:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:42:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:42:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:42:43 INFO - 2016-04-02 05:42:43.000 screenresolution[1693:10723] starting screenresolution argv=screenresolution get 05:42:43 INFO - 2016-04-02 05:42:43.003 screenresolution[1693:10723] Display 0: 1600x1200x32@60 05:42:43 INFO - 2016-04-02 05:42:43.009 screenresolution[1694:10726] starting screenresolution argv=screenresolution list 05:42:43 INFO - Available Modes on Display 0 05:42:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:42:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:42:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:42:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:42:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:42:43 INFO - Intel Iris: 05:42:43 INFO - Chipset Model: Intel Iris 05:42:43 INFO - Type: GPU 05:42:43 INFO - Bus: Built-In 05:42:43 INFO - VRAM (Dynamic, Max): 1536 MB 05:42:43 INFO - Vendor: Intel (0x8086) 05:42:43 INFO - Device ID: 0x0a2e 05:42:43 INFO - Revision ID: 0x0009 05:42:43 INFO - Displays: 05:42:43 INFO - Display: 05:42:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:42:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:42:43 INFO - Display Serial Number: 1600x1200 60 05:42:43 INFO - Main Display: Yes 05:42:43 INFO - Mirror: Off 05:42:43 INFO - Online: Yes 05:42:43 INFO - Rotation: Supported 05:42:43 INFO - Return code: 0 05:42:43 INFO - Running post-action listener: _resource_record_post_action 05:42:43 INFO - Running post-run listener: _resource_record_post_run 05:42:44 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 38458880; Write bytes: 707019264; Read time: 401; Write time: 2072 05:42:44 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 398389760; Write bytes: 391792128; Read time: 30071; Write time: 737 05:42:44 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 36644352; Write bytes: 301976576; Read time: 381; Write time: 1292 05:42:44 INFO - Running post-run listener: _upload_blobber_files 05:42:44 INFO - Blob upload gear active. 05:42:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:42:44 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:42:44 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:42:44 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:42:44 INFO - (blobuploader) - INFO - Open directory for files ... 05:42:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:42:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:42:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:42:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:42:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:42:45 INFO - (blobuploader) - INFO - Done attempting. 05:42:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:42:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:42:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:42:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:42:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:42:46 INFO - (blobuploader) - INFO - Done attempting. 05:42:46 INFO - (blobuploader) - INFO - Iteration through files over. 05:42:46 INFO - Return code: 0 05:42:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:42:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:42:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1cc4f6a51a30e94867ffada318f094741cd8eaefe0c6cb8f4f69310bd4a3e4cb28f0013d5230c11455df5240612cf13f4fbe23fc15a9566f958bf3cf742ae2a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80e1f3ac45644ce46d9988f5cabec9fce7d8d93031e162e220056d68e7a4302222506a4a53a03bfc772c51cea008714b5412e2ed98eb7469596e1bdad2aea7f1"} 05:42:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:42:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:42:46 INFO - Contents: 05:42:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1cc4f6a51a30e94867ffada318f094741cd8eaefe0c6cb8f4f69310bd4a3e4cb28f0013d5230c11455df5240612cf13f4fbe23fc15a9566f958bf3cf742ae2a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80e1f3ac45644ce46d9988f5cabec9fce7d8d93031e162e220056d68e7a4302222506a4a53a03bfc772c51cea008714b5412e2ed98eb7469596e1bdad2aea7f1"} 05:42:46 INFO - Running post-run listener: copy_logs_to_upload_dir 05:42:46 INFO - Copying logs to upload dir... 05:42:46 INFO - mkdir: /builds/slave/test/build/upload/logs 05:42:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.538696 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-02 05:42:46.524614) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-02 05:42:46.528216) ========= 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.briI48ImE7/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.rQPKt6yfp3/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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/f1cc4f6a51a30e94867ffada318f094741cd8eaefe0c6cb8f4f69310bd4a3e4cb28f0013d5230c11455df5240612cf13f4fbe23fc15a9566f958bf3cf742ae2a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80e1f3ac45644ce46d9988f5cabec9fce7d8d93031e162e220056d68e7a4302222506a4a53a03bfc772c51cea008714b5412e2ed98eb7469596e1bdad2aea7f1"} build_url:https://queue.taskcluster.net/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010990 build_url: 'https://queue.taskcluster.net/v1/task/Tmf1iwKFQZOoVd3UxcQZhg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1cc4f6a51a30e94867ffada318f094741cd8eaefe0c6cb8f4f69310bd4a3e4cb28f0013d5230c11455df5240612cf13f4fbe23fc15a9566f958bf3cf742ae2a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80e1f3ac45644ce46d9988f5cabec9fce7d8d93031e162e220056d68e7a4302222506a4a53a03bfc772c51cea008714b5412e2ed98eb7469596e1bdad2aea7f1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-02 05:42:46.555219) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 05:42:46.555546) ========= 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.briI48ImE7/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.rQPKt6yfp3/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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.004550 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 05:42:46.605042) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-02 05:42:46.605393) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-02 05:42:46.605806) ========= ========= Total master_lag: 0.26 =========