builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0086 starttime: 1460377052.25 results: success (0) buildid: 20160411030231 builduid: 4404a4045cb54d21a35be9c67442e9cd revision: e847cfcb315f511f4928b03fd47dcf57aad05e1e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 05:17:32.251739) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 05:17:32.252163) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 05:17:32.252440) ========= 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.tINXrG2yLU/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.46deX5RbO7/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.005690 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 05:17:32.276164) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 05:17:32.276439) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 05:17:32.293117) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 05:17:32.293377) ========= 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.tINXrG2yLU/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.46deX5RbO7/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.005273 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 05:17:32.341333) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 05:17:32.341595) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 05:17:32.341929) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 05:17:32.342197) ========= 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.tINXrG2yLU/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.46deX5RbO7/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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-11 05:17:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2016-04-11 05:17:32 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105981 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 05:17:32.463607) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 05:17:32.463929) ========= 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.tINXrG2yLU/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.46deX5RbO7/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.025256 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 05:17:32.512375) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 05:17:32.512686) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e847cfcb315f511f4928b03fd47dcf57aad05e1e --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 e847cfcb315f511f4928b03fd47dcf57aad05e1e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tINXrG2yLU/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.46deX5RbO7/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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-11 05:17:32,593 truncating revision to first 12 chars 2016-04-11 05:17:32,593 Setting DEBUG logging. 2016-04-11 05:17:32,593 attempt 1/10 2016-04-11 05:17:32,593 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e847cfcb315f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-11 05:17:33,264 unpacking tar archive at: mozilla-central-e847cfcb315f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.926038 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 05:17:33.455321) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 05:17:33.455665) ========= echo e847cfcb315f511f4928b03fd47dcf57aad05e1e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e847cfcb315f511f4928b03fd47dcf57aad05e1e'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tINXrG2yLU/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.46deX5RbO7/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 e847cfcb315f511f4928b03fd47dcf57aad05e1e program finished with exit code 0 elapsedTime=0.005513 script_repo_revision: 'e847cfcb315f511f4928b03fd47dcf57aad05e1e' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 05:17:33.505950) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 05:17:33.506235) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 05:17:33.519756) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-11 05:17:33.520033) ========= /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.tINXrG2yLU/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.46deX5RbO7/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:17:33 INFO - MultiFileLogger online at 20160411 05:17:33 in /builds/slave/test 05:17:33 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:17:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:17:33 INFO - {'append_to_log': False, 05:17:33 INFO - 'base_work_dir': '/builds/slave/test', 05:17:33 INFO - 'blob_upload_branch': 'Firefox', 05:17:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:17:33 INFO - 'branch': 'Firefox', 05:17:33 INFO - 'buildbot_json_path': 'buildprops.json', 05:17:33 INFO - 'config_files': ('talos/mac_config.py',), 05:17:33 INFO - 'default_actions': ('clobber', 05:17:33 INFO - 'read-buildbot-config', 05:17:33 INFO - 'download-and-extract', 05:17:33 INFO - 'populate-webroot', 05:17:33 INFO - 'create-virtualenv', 05:17:33 INFO - 'install', 05:17:33 INFO - 'run-tests'), 05:17:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:17:33 INFO - 'download_minidump_stackwalk': True, 05:17:33 INFO - 'download_symbols': 'ondemand', 05:17:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:17:33 INFO - 'tooltool.py': '/tools/tooltool.py', 05:17:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:17:33 INFO - '/tools/misc-python/virtualenv.py')}, 05:17:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:17:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:17:33 INFO - 'installer_path': 'installer.exe', 05:17:33 INFO - 'log_level': 'info', 05:17:33 INFO - 'log_name': 'talos', 05:17:33 INFO - 'log_to_console': True, 05:17:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:17:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:17:33 INFO - 'opt_config_files': (), 05:17:33 INFO - 'pip_index': False, 05:17:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:17:33 INFO - 'cmd': ('bash', 05:17:33 INFO - '-c', 05:17:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:17:33 INFO - 'enabled': True, 05:17:33 INFO - 'halt_on_failure': False, 05:17:33 INFO - 'name': 'check_screen_resolution'},), 05:17:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:17:33 INFO - 'cmd': ('bash', 05:17:33 INFO - '-c', 05:17:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:17:33 INFO - 'enabled': True, 05:17:33 INFO - 'halt_on_failure': False, 05:17:33 INFO - 'name': 'check_screen_resolution'},), 05:17:33 INFO - 'run_cmd_checks_enabled': True, 05:17:33 INFO - 'sps_profile': False, 05:17:33 INFO - 'sps_profile_interval': 0, 05:17:33 INFO - 'suite': 'dromaeojs-e10s', 05:17:33 INFO - 'system_bits': '32', 05:17:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:17:33 INFO - 'title': 't-yosemite-r7-0086', 05:17:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:17:33 INFO - 'use_talos_json': True, 05:17:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:17:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:17:33 INFO - 'work_dir': 'build'} 05:17:33 INFO - ##### 05:17:33 INFO - ##### Running clobber step. 05:17:33 INFO - ##### 05:17:33 INFO - Running pre-action listener: _resource_record_pre_action 05:17:33 INFO - Running main action method: clobber 05:17:33 INFO - rmtree: /builds/slave/test/build 05:17:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:17:35 INFO - Running post-action listener: _resource_record_post_action 05:17:35 INFO - ##### 05:17:35 INFO - ##### Running read-buildbot-config step. 05:17:35 INFO - ##### 05:17:35 INFO - Running pre-action listener: _resource_record_pre_action 05:17:35 INFO - Running main action method: read_buildbot_config 05:17:35 INFO - Using buildbot properties: 05:17:35 INFO - { 05:17:35 INFO - "project": "", 05:17:35 INFO - "product": "firefox", 05:17:35 INFO - "script_repo_revision": "production", 05:17:35 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:17:35 INFO - "repository": "", 05:17:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:17:35 INFO - "buildid": "20160411030231", 05:17:35 INFO - "stage_platform": "macosx64", 05:17:35 INFO - "basedir": "/builds/slave/test", 05:17:35 INFO - "nightly_build": "True", 05:17:35 INFO - "buildnumber": 183, 05:17:35 INFO - "slavename": "t-yosemite-r7-0086", 05:17:35 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:17:35 INFO - "platform": "yosemite_r7", 05:17:35 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:17:35 INFO - "branch": "mozilla-central", 05:17:35 INFO - "repo_path": "mozilla-central", 05:17:35 INFO - "revision": "e847cfcb315f511f4928b03fd47dcf57aad05e1e", 05:17:35 INFO - "pgo_build": "False", 05:17:35 INFO - "builduid": "4404a4045cb54d21a35be9c67442e9cd", 05:17:35 INFO - "slavebuilddir": "test" 05:17:35 INFO - } 05:17:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/eEBwAGbBTeyhjtrT5or2_A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:17:35 INFO - Running post-action listener: _resource_record_post_action 05:17:35 INFO - ##### 05:17:35 INFO - ##### Running download-and-extract step. 05:17:35 INFO - ##### 05:17:35 INFO - Running pre-action listener: _resource_record_pre_action 05:17:35 INFO - Running main action method: download_and_extract 05:17:35 INFO - mkdir: /builds/slave/test/build/tests 05:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:35 INFO - https://queue.taskcluster.net/v1/task/eEBwAGbBTeyhjtrT5or2_A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:17:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEBwAGbBTeyhjtrT5or2_A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:17:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEBwAGbBTeyhjtrT5or2_A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:17:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEBwAGbBTeyhjtrT5or2_A/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:17:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEBwAGbBTeyhjtrT5or2_A/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:17:36 INFO - Downloaded 1199 bytes. 05:17:36 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:17:36 INFO - Using the following test package requirements: 05:17:36 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:17:36 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:17:36 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:17:36 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:17:36 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:17:36 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:17:36 INFO - u'jsshell-mac.zip'], 05:17:36 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:17:36 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:17:36 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:17:36 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:17:36 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:17:36 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:17:36 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:17:36 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:17:36 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:17:36 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:17:36 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:17:36 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:17:36 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:17:36 INFO - https://queue.taskcluster.net/v1/task/eEBwAGbBTeyhjtrT5or2_A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:17:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEBwAGbBTeyhjtrT5or2_A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:17:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEBwAGbBTeyhjtrT5or2_A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:17:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEBwAGbBTeyhjtrT5or2_A/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:17:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEBwAGbBTeyhjtrT5or2_A/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:17:37 INFO - Downloaded 18018909 bytes. 05:17:37 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:17:37 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:17:41 INFO - Return code: 0 05:17:41 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:17: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:17:41 INFO - https://queue.taskcluster.net/v1/task/eEBwAGbBTeyhjtrT5or2_A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:17:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEBwAGbBTeyhjtrT5or2_A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:17:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEBwAGbBTeyhjtrT5or2_A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:17:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEBwAGbBTeyhjtrT5or2_A/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:17:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEBwAGbBTeyhjtrT5or2_A/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:17:42 INFO - Downloaded 18018909 bytes. 05:17:42 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:17:42 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:17:45 INFO - Return code: 0 05:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:45 INFO - https://queue.taskcluster.net/v1/task/eEBwAGbBTeyhjtrT5or2_A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:17:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEBwAGbBTeyhjtrT5or2_A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:17:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEBwAGbBTeyhjtrT5or2_A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:17:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEBwAGbBTeyhjtrT5or2_A/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:17:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEBwAGbBTeyhjtrT5or2_A/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:17:46 INFO - Downloaded 10841046 bytes. 05:17:46 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:17:46 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:17:47 INFO - Return code: 0 05:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:47 INFO - https://queue.taskcluster.net/v1/task/eEBwAGbBTeyhjtrT5or2_A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:17:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEBwAGbBTeyhjtrT5or2_A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:17:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEBwAGbBTeyhjtrT5or2_A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:17:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEBwAGbBTeyhjtrT5or2_A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:17:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEBwAGbBTeyhjtrT5or2_A/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:17:50 INFO - Downloaded 108961217 bytes. 05:17:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eEBwAGbBTeyhjtrT5or2_A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:17:50 INFO - mkdir: /builds/slave/test/properties 05:17:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:17:50 INFO - Writing to file /builds/slave/test/properties/build_url 05:17:50 INFO - Contents: 05:17:50 INFO - build_url:https://queue.taskcluster.net/v1/task/eEBwAGbBTeyhjtrT5or2_A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:17:50 INFO - Running post-action listener: _resource_record_post_action 05:17:50 INFO - Running post-action listener: set_extra_try_arguments 05:17:50 INFO - ##### 05:17:50 INFO - ##### Running populate-webroot step. 05:17:50 INFO - ##### 05:17:50 INFO - Running pre-action listener: _resource_record_pre_action 05:17:50 INFO - Running main action method: populate_webroot 05:17:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:17:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:17:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:17:50 INFO - '--tppagecycles', 05:17:50 INFO - '7'], 05:17:50 INFO - 'tests': ['tsvgm']}}, 05:17:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:17:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:17:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:17:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:17:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:17:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:17:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:50 INFO - 'talos_options': ['--disable-e10s'], 05:17:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:17:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:17:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:50 INFO - 'talos_options': ['--disable-e10s'], 05:17:50 INFO - 'tests': ['damp', 'tps']}, 05:17:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:50 INFO - 'tests': ['damp', 'tps']}, 05:17:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:17:50 INFO - 'tests': ['dromaeo_dom']}, 05:17:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:17:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:17:50 INFO - 'tests': ['a11yr', 05:17:50 INFO - 'ts_paint', 05:17:50 INFO - 'tpaint', 05:17:50 INFO - 'sessionrestore', 05:17:50 INFO - 'sessionrestore_no_auto_restore', 05:17:50 INFO - 'tabpaint']}, 05:17:50 INFO - 'other-e10s': {'tests': ['a11yr', 05:17:50 INFO - 'ts_paint', 05:17:50 INFO - 'tpaint', 05:17:50 INFO - 'sessionrestore', 05:17:50 INFO - 'sessionrestore_no_auto_restore', 05:17:50 INFO - 'tabpaint']}, 05:17:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:17:50 INFO - 'ts_paint', 05:17:50 INFO - 'tpaint', 05:17:50 INFO - 'sessionrestore', 05:17:50 INFO - 'sessionrestore_no_auto_restore', 05:17:50 INFO - 'tabpaint']}, 05:17:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:17:50 INFO - 'ts_paint', 05:17:50 INFO - 'tpaint', 05:17:50 INFO - 'sessionrestore', 05:17:50 INFO - 'sessionrestore_no_auto_restore', 05:17:50 INFO - 'tabpaint']}, 05:17:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:17:50 INFO - 'tests': ['a11yr', 05:17:50 INFO - 'ts_paint', 05:17:50 INFO - 'tpaint', 05:17:50 INFO - 'sessionrestore', 05:17:50 INFO - 'sessionrestore_no_auto_restore', 05:17:50 INFO - 'tabpaint']}, 05:17:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:17:50 INFO - 'tests': ['a11yr', 05:17:50 INFO - 'ts_paint', 05:17:50 INFO - 'tpaint', 05:17:50 INFO - 'sessionrestore', 05:17:50 INFO - 'sessionrestore_no_auto_restore', 05:17:50 INFO - 'tabpaint']}, 05:17:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:17:50 INFO - 'tests': ['tsvgx', 05:17:50 INFO - 'tsvgr_opacity', 05:17:50 INFO - 'tart', 05:17:50 INFO - 'tscrollx', 05:17:50 INFO - 'cart']}, 05:17:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:17:50 INFO - 'tsvgr_opacity', 05:17:50 INFO - 'tart', 05:17:50 INFO - 'tscrollx', 05:17:50 INFO - 'cart']}, 05:17:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:50 INFO - 'talos_options': ['--disable-e10s'], 05:17:50 INFO - 'tests': ['tp5o']}, 05:17:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:50 INFO - 'tests': ['tp5o']}, 05:17:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:50 INFO - 'talos_options': ['--disable-e10s', 05:17:50 INFO - '--xperf_path', 05:17:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:17:50 INFO - 'tests': ['tp5n']}, 05:17:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:50 INFO - 'talos_options': ['--xperf_path', 05:17:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:17:50 INFO - 'tests': ['tp5n']}}, 05:17:50 INFO - 'talos.zip': {'path': '', 05:17:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:17:50 INFO - Running post-action listener: _resource_record_post_action 05:17:50 INFO - ##### 05:17:50 INFO - ##### Running create-virtualenv step. 05:17:50 INFO - ##### 05:17:50 INFO - Running pre-action listener: _resource_record_pre_action 05:17:50 INFO - Running main action method: create_virtualenv 05:17:50 INFO - Creating virtualenv /builds/slave/test/build/venv 05:17:50 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:17:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:17:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:17:50 INFO - Using real prefix '/tools/python27' 05:17:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:17:51 INFO - Installing distribute.............................................................................................................................................................................................done. 05:17:54 INFO - Installing pip.................done. 05:17:54 INFO - Return code: 0 05:17:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:17:54 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:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:54 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:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:54 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 0x1071a0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071b0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa208569510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10703fe00>, '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 0x106ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10703ab20>, '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.tINXrG2yLU/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.46deX5RbO7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:17:54 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:17:54 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:17:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tINXrG2yLU/Render', 05:17:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:54 INFO - 'HOME': '/Users/cltbld', 05:17:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:54 INFO - 'LOGNAME': 'cltbld', 05:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:54 INFO - 'MOZ_NO_REMOTE': '1', 05:17:54 INFO - 'NO_EM_RESTART': '1', 05:17:54 INFO - 'PAGER': '/bin/cat', 05:17:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:54 INFO - 'PWD': '/builds/slave/test', 05:17:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:54 INFO - 'SHELL': '/bin/bash', 05:17:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46deX5RbO7/Listeners', 05:17:54 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 05:17:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:54 INFO - 'USER': 'cltbld', 05:17:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:54 INFO - 'XPC_FLAGS': '0x0', 05:17:54 INFO - 'XPC_SERVICE_NAME': '0', 05:17:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:54 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:17:54 INFO - Cleaning up... 05:17:54 INFO - Return code: 0 05:17:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:17:54 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:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:54 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:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:54 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 0x1071a0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071b0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa208569510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10703fe00>, '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 0x106ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10703ab20>, '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.tINXrG2yLU/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.46deX5RbO7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:17:54 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:17:54 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:17:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tINXrG2yLU/Render', 05:17:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:54 INFO - 'HOME': '/Users/cltbld', 05:17:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:54 INFO - 'LOGNAME': 'cltbld', 05:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:54 INFO - 'MOZ_NO_REMOTE': '1', 05:17:54 INFO - 'NO_EM_RESTART': '1', 05:17:54 INFO - 'PAGER': '/bin/cat', 05:17:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:54 INFO - 'PWD': '/builds/slave/test', 05:17:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:54 INFO - 'SHELL': '/bin/bash', 05:17:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46deX5RbO7/Listeners', 05:17:54 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 05:17:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:54 INFO - 'USER': 'cltbld', 05:17:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:54 INFO - 'XPC_FLAGS': '0x0', 05:17:54 INFO - 'XPC_SERVICE_NAME': '0', 05:17:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:55 INFO - Downloading/unpacking psutil>=0.7.1 05:17:55 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:17:55 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:17:55 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:17:55 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:17:55 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:17:55 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:17:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:17:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:58 INFO - Installing collected packages: psutil 05:17:58 INFO - Running setup.py install for psutil 05:17:58 INFO - building 'psutil._psutil_osx' extension 05:17:58 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:17:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:17:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:17:59 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:17:59 INFO - building 'psutil._psutil_posix' extension 05:17:59 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:17:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:17:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:17:59 INFO - ^ 05:17:59 INFO - 1 warning generated. 05:17:59 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:17:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:59 INFO - Successfully installed psutil 05:17:59 INFO - Cleaning up... 05:17:59 INFO - Return code: 0 05:17:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:17:59 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:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:59 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:17:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:59 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 0x1071a0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071b0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa208569510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10703fe00>, '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 0x106ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10703ab20>, '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.tINXrG2yLU/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.46deX5RbO7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:17:59 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:17:59 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:17:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tINXrG2yLU/Render', 05:17:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:59 INFO - 'HOME': '/Users/cltbld', 05:17:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:59 INFO - 'LOGNAME': 'cltbld', 05:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:59 INFO - 'MOZ_NO_REMOTE': '1', 05:17:59 INFO - 'NO_EM_RESTART': '1', 05:17:59 INFO - 'PAGER': '/bin/cat', 05:17:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:59 INFO - 'PWD': '/builds/slave/test', 05:17:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:59 INFO - 'SHELL': '/bin/bash', 05:17:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46deX5RbO7/Listeners', 05:17:59 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 05:17:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:59 INFO - 'USER': 'cltbld', 05:17:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:59 INFO - 'XPC_FLAGS': '0x0', 05:17:59 INFO - 'XPC_SERVICE_NAME': '0', 05:17:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:17:59 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:17:59 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:17:59 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:17:59 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:17:59 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:17:59 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:18:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:18:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:18:02 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:18:02 INFO - Installing collected packages: mozsystemmonitor 05:18:02 INFO - Running setup.py install for mozsystemmonitor 05:18:02 INFO - Successfully installed mozsystemmonitor 05:18:02 INFO - Cleaning up... 05:18:02 INFO - Return code: 0 05:18:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:18:02 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:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:02 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:18:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:02 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 0x1071a0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071b0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa208569510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10703fe00>, '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 0x106ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10703ab20>, '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.tINXrG2yLU/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.46deX5RbO7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:18:02 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:18:02 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:18:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tINXrG2yLU/Render', 05:18:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:02 INFO - 'HOME': '/Users/cltbld', 05:18:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:02 INFO - 'LOGNAME': 'cltbld', 05:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:02 INFO - 'MOZ_NO_REMOTE': '1', 05:18:02 INFO - 'NO_EM_RESTART': '1', 05:18:02 INFO - 'PAGER': '/bin/cat', 05:18:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:02 INFO - 'PWD': '/builds/slave/test', 05:18:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:02 INFO - 'SHELL': '/bin/bash', 05:18:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46deX5RbO7/Listeners', 05:18:02 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 05:18:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:02 INFO - 'USER': 'cltbld', 05:18:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:02 INFO - 'XPC_FLAGS': '0x0', 05:18:02 INFO - 'XPC_SERVICE_NAME': '0', 05:18:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:03 INFO - Downloading/unpacking blobuploader==1.2.4 05:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:05 INFO - Downloading blobuploader-1.2.4.tar.gz 05:18:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:18:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:18:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:06 INFO - Downloading docopt-0.6.1.tar.gz 05:18:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:18:06 INFO - Installing collected packages: blobuploader, requests, docopt 05:18:06 INFO - Running setup.py install for blobuploader 05:18:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:18:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:18:07 INFO - Running setup.py install for requests 05:18:07 INFO - Running setup.py install for docopt 05:18:07 INFO - Successfully installed blobuploader requests docopt 05:18:07 INFO - Cleaning up... 05:18:07 INFO - Return code: 0 05:18:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18:07 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:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:07 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:18:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:07 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 0x1071a0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071b0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa208569510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10703fe00>, '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 0x106ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10703ab20>, '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.tINXrG2yLU/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.46deX5RbO7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:18:07 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:18:07 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:18:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tINXrG2yLU/Render', 05:18:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:07 INFO - 'HOME': '/Users/cltbld', 05:18:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:07 INFO - 'LOGNAME': 'cltbld', 05:18:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:07 INFO - 'MOZ_NO_REMOTE': '1', 05:18:07 INFO - 'NO_EM_RESTART': '1', 05:18:07 INFO - 'PAGER': '/bin/cat', 05:18:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:07 INFO - 'PWD': '/builds/slave/test', 05:18:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:07 INFO - 'SHELL': '/bin/bash', 05:18:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46deX5RbO7/Listeners', 05:18:07 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 05:18:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:07 INFO - 'USER': 'cltbld', 05:18:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:07 INFO - 'XPC_FLAGS': '0x0', 05:18:07 INFO - 'XPC_SERVICE_NAME': '0', 05:18:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:18:08 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-c88Spt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:18:08 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-B4pF7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:18:08 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-7UnY_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:18:08 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-BFj9Ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:18:08 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-o4PfNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:18:08 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-gn7u0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:18:08 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-sYr9SY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:18:08 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-zl_U27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:18:08 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-ePcEY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:18:08 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-KdTPTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:18:09 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Y2gL0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:18:09 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-V5hr2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:18:09 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-rDLA4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:18:09 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-cq1UH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:09 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-V0XTyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:18:09 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-gSTAij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:18:09 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-SCCqum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:18:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:18:09 INFO - Running setup.py install for manifestparser 05:18:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:18:09 INFO - Running setup.py install for mozcrash 05:18:10 INFO - Running setup.py install for mozdebug 05:18:10 INFO - Running setup.py install for mozdevice 05:18:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:18:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:18:10 INFO - Running setup.py install for mozfile 05:18:10 INFO - Running setup.py install for mozhttpd 05:18:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:18:10 INFO - Running setup.py install for mozinfo 05:18:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:18:10 INFO - Running setup.py install for mozInstall 05:18:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:18:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:18:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:18:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:18:10 INFO - Running setup.py install for mozleak 05:18:11 INFO - Running setup.py install for mozlog 05:18:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:18:11 INFO - Running setup.py install for moznetwork 05:18:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:18:11 INFO - Running setup.py install for mozprocess 05:18:11 INFO - Running setup.py install for mozprofile 05:18:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:18:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:18:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:18:11 INFO - Running setup.py install for mozrunner 05:18:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:18:11 INFO - Running setup.py install for mozscreenshot 05:18:12 INFO - Running setup.py install for moztest 05:18:12 INFO - Running setup.py install for mozversion 05:18:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:18:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:18:12 INFO - Cleaning up... 05:18:12 INFO - Return code: 0 05:18:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18: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:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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:18:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:12 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 0x1071a0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071b0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa208569510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10703fe00>, '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 0x106ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10703ab20>, '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.tINXrG2yLU/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.46deX5RbO7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:18:12 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:18:12 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:18:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tINXrG2yLU/Render', 05:18:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:12 INFO - 'HOME': '/Users/cltbld', 05:18:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:12 INFO - 'LOGNAME': 'cltbld', 05:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:12 INFO - 'MOZ_NO_REMOTE': '1', 05:18:12 INFO - 'NO_EM_RESTART': '1', 05:18:12 INFO - 'PAGER': '/bin/cat', 05:18:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:12 INFO - 'PWD': '/builds/slave/test', 05:18:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:12 INFO - 'SHELL': '/bin/bash', 05:18:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46deX5RbO7/Listeners', 05:18:12 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 05:18:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:12 INFO - 'USER': 'cltbld', 05:18:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:12 INFO - 'XPC_FLAGS': '0x0', 05:18:12 INFO - 'XPC_SERVICE_NAME': '0', 05:18:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:18:12 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-HSd25e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:18:12 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:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:18:12 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-ypCY7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:18:12 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:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:18:12 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-8voqxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:18:12 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:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:18:13 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-WDBvKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:18:13 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-7XqQ_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:18:13 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-VLTIiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:18:13 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-vq_40w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:18:13 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:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:18:13 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-DaEKnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:18:13 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:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:18:13 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-3NhAGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:18:13 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:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:18:13 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-yTTyJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:18:13 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:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:18:13 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Nx53qw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:18:13 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:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:18:13 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-A9rahI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:18:13 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:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:18:13 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-sTrHLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:18:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:18:14 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Dek5ZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:18:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:14 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-mYiVbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:18:14 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-nBaEj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:18:14 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:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:18:14 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-K2PrWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:18:14 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:18:14 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:18:14 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:18:14 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:18:14 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:18:14 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:18:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:18: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:18: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:18: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:18: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:18: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:18: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:18:16 INFO - Downloading blessings-1.6.tar.gz 05:18:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:18:16 INFO - Installing collected packages: blessings 05:18:16 INFO - Running setup.py install for blessings 05:18:17 INFO - Successfully installed blessings 05:18:17 INFO - Cleaning up... 05:18:17 INFO - Return code: 0 05:18:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:18:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:18:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:18:17 INFO - Reading from file tmpfile_stdout 05:18:17 INFO - Current package versions: 05:18:17 INFO - blessings == 1.6 05:18:17 INFO - blobuploader == 1.2.4 05:18:17 INFO - docopt == 0.6.1 05:18:17 INFO - manifestparser == 1.1 05:18:17 INFO - mozInstall == 1.12 05:18:17 INFO - mozcrash == 0.17 05:18:17 INFO - mozdebug == 0.1 05:18:17 INFO - mozdevice == 0.48 05:18:17 INFO - mozfile == 1.2 05:18:17 INFO - mozhttpd == 0.7 05:18:17 INFO - mozinfo == 0.9 05:18:17 INFO - mozleak == 0.1 05:18:17 INFO - mozlog == 3.1 05:18:17 INFO - moznetwork == 0.27 05:18:17 INFO - mozprocess == 0.22 05:18:17 INFO - mozprofile == 0.28 05:18:17 INFO - mozrunner == 6.11 05:18:17 INFO - mozscreenshot == 0.1 05:18:17 INFO - mozsystemmonitor == 0.0 05:18:17 INFO - moztest == 0.7 05:18:17 INFO - mozversion == 1.4 05:18:17 INFO - psutil == 3.1.1 05:18:17 INFO - requests == 1.2.3 05:18:17 INFO - wsgiref == 0.1.2 05:18:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:17 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 0x1071a0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071b0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa208569510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10703fe00>, '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 0x106ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10703ab20>, '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.tINXrG2yLU/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.46deX5RbO7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:18:17 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:18:17 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:18:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tINXrG2yLU/Render', 05:18:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:17 INFO - 'HOME': '/Users/cltbld', 05:18:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:17 INFO - 'LOGNAME': 'cltbld', 05:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:17 INFO - 'MOZ_NO_REMOTE': '1', 05:18:17 INFO - 'NO_EM_RESTART': '1', 05:18:17 INFO - 'PAGER': '/bin/cat', 05:18:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:17 INFO - 'PWD': '/builds/slave/test', 05:18:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:17 INFO - 'SHELL': '/bin/bash', 05:18:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46deX5RbO7/Listeners', 05:18:17 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 05:18:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:17 INFO - 'USER': 'cltbld', 05:18:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:17 INFO - 'XPC_FLAGS': '0x0', 05:18:17 INFO - 'XPC_SERVICE_NAME': '0', 05:18:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:17 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:18:17 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:18:17 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:18:17 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:18:17 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:18:17 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:18:17 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:18:17 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:18:17 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:18:17 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:18:17 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:18:17 INFO - Cleaning up... 05:18:17 INFO - Return code: 0 05:18:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:17 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 0x1071a0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071b0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa208569510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10703fe00>, '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 0x106ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10703ab20>, '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.tINXrG2yLU/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.46deX5RbO7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:18:17 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:18:17 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:18:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tINXrG2yLU/Render', 05:18:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:17 INFO - 'HOME': '/Users/cltbld', 05:18:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:17 INFO - 'LOGNAME': 'cltbld', 05:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:17 INFO - 'MOZ_NO_REMOTE': '1', 05:18:17 INFO - 'NO_EM_RESTART': '1', 05:18:17 INFO - 'PAGER': '/bin/cat', 05:18:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:17 INFO - 'PWD': '/builds/slave/test', 05:18:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:17 INFO - 'SHELL': '/bin/bash', 05:18:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46deX5RbO7/Listeners', 05:18:17 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 05:18:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:17 INFO - 'USER': 'cltbld', 05:18:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:17 INFO - 'XPC_FLAGS': '0x0', 05:18:17 INFO - 'XPC_SERVICE_NAME': '0', 05:18:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:18 INFO - Downloading/unpacking jsonschema 05:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:18:20 INFO - Downloading/unpacking functools32 (from jsonschema) 05:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:20 INFO - Downloading functools32-3.2.3-2.tar.gz 05:18:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:18:20 INFO - warning: no files found matching '*.txt' 05:18:20 INFO - no previously-included directories found matching 'build' 05:18:20 INFO - no previously-included directories found matching 'dist' 05:18:20 INFO - no previously-included directories found matching '.git*' 05:18:20 INFO - Installing collected packages: jsonschema, functools32 05:18:20 INFO - Running setup.py install for functools32 05:18:21 INFO - warning: no files found matching '*.txt' 05:18:21 INFO - no previously-included directories found matching 'build' 05:18:21 INFO - no previously-included directories found matching 'dist' 05:18:21 INFO - no previously-included directories found matching '.git*' 05:18:21 INFO - Successfully installed jsonschema functools32 05:18:21 INFO - Cleaning up... 05:18:21 INFO - Return code: 0 05:18:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:18: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:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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:18:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1071a0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071b0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa208569510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10703fe00>, '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 0x106ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10703ab20>, '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.tINXrG2yLU/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.46deX5RbO7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:18:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:18:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tINXrG2yLU/Render', 05:18:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:21 INFO - 'HOME': '/Users/cltbld', 05:18:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:21 INFO - 'LOGNAME': 'cltbld', 05:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:21 INFO - 'MOZ_NO_REMOTE': '1', 05:18:21 INFO - 'NO_EM_RESTART': '1', 05:18:21 INFO - 'PAGER': '/bin/cat', 05:18:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:21 INFO - 'PWD': '/builds/slave/test', 05:18:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:21 INFO - 'SHELL': '/bin/bash', 05:18:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46deX5RbO7/Listeners', 05:18:21 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 05:18:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:21 INFO - 'USER': 'cltbld', 05:18:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:21 INFO - 'XPC_FLAGS': '0x0', 05:18:21 INFO - 'XPC_SERVICE_NAME': '0', 05:18:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:21 INFO - Downloading/unpacking flake8 05:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:18:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:18:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:18: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:18: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:18: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:18: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:18: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:18: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:18:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:18: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:18: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:18: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:18: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:18: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:18: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:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:18:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:18:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:18:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:18:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:18:25 INFO - no previously-included directories found matching 'docs/_build' 05:18:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:18:25 INFO - Running setup.py install for pep8 05:18:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:18:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:18:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:18:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:18:25 INFO - no previously-included directories found matching 'docs/_build' 05:18:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:18:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:18:25 INFO - Cleaning up... 05:18:25 INFO - Return code: 0 05:18:25 INFO - Running post-action listener: _resource_record_post_action 05:18:25 INFO - Running post-action listener: _start_resource_monitoring 05:18:25 INFO - Starting resource monitoring. 05:18:25 INFO - ##### 05:18:25 INFO - ##### Running install step. 05:18:25 INFO - ##### 05:18:25 INFO - Running pre-action listener: _resource_record_pre_action 05:18:25 INFO - Running main action method: install 05:18:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:18:25 INFO - Reading from file tmpfile_stdout 05:18:25 INFO - Detecting whether we're running mozinstall >=1.0... 05:18:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:18:25 INFO - Reading from file tmpfile_stdout 05:18:25 INFO - Output received: 05:18:25 INFO - Usage: mozinstall [options] installer 05:18:25 INFO - Options: 05:18:25 INFO - -h, --help show this help message and exit 05:18:25 INFO - -d DEST, --destination=DEST 05:18:25 INFO - Directory to install application into. [default: 05:18:25 INFO - "/builds/slave/test"] 05:18:25 INFO - --app=APP Application being installed. [default: firefox] 05:18:25 INFO - mkdir: /builds/slave/test/build/application 05:18:25 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:18:25 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:18:59 INFO - Reading from file tmpfile_stdout 05:18:59 INFO - Output received: 05:18:59 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:18:59 INFO - Running post-action listener: _resource_record_post_action 05:18:59 INFO - ##### 05:18:59 INFO - ##### Running run-tests step. 05:18:59 INFO - ##### 05:18:59 INFO - Running pre-action listener: _resource_record_pre_action 05:18:59 INFO - Running main action method: run_tests 05:18:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:18:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:18:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:18:59 INFO - 2016-04-11 05:18:59.102 screenresolution[1636:7589] starting screenresolution argv=screenresolution get 05:18:59 INFO - 2016-04-11 05:18:59.104 screenresolution[1636:7589] Display 0: 1600x1200x32@60 05:18:59 INFO - 2016-04-11 05:18:59.110 screenresolution[1637:7591] starting screenresolution argv=screenresolution list 05:18:59 INFO - Available Modes on Display 0 05:18:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:18:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:18:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:18:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:18:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:18:59 INFO - Intel Iris: 05:18:59 INFO - Chipset Model: Intel Iris 05:18:59 INFO - Type: GPU 05:18:59 INFO - Bus: Built-In 05:18:59 INFO - VRAM (Dynamic, Max): 1536 MB 05:18:59 INFO - Vendor: Intel (0x8086) 05:18:59 INFO - Device ID: 0x0a2e 05:18:59 INFO - Revision ID: 0x0009 05:18:59 INFO - Displays: 05:18:59 INFO - Display: 05:18:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:18:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:18:59 INFO - Display Serial Number: 1600x1200 60 05:18:59 INFO - Main Display: Yes 05:18:59 INFO - Mirror: Off 05:18:59 INFO - Online: Yes 05:18:59 INFO - Rotation: Supported 05:18:59 INFO - Return code: 0 05:18:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:18:59 INFO - Python 2.7.3 05:18:59 INFO - Return code: 0 05:18:59 INFO - grabbing minidump binary from tooltool 05:18:59 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:18:59 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 0x10703fe00>, '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 0x106ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10703ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:18:59 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:18:59 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:18:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:18:59 INFO - Return code: 0 05:18:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:18:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:18:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:18:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:18:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:18:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:19:00 INFO - Return code: 0 05:19:00 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/eEBwAGbBTeyhjtrT5or2_A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--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:19:00 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/eEBwAGbBTeyhjtrT5or2_A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0086 --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:19:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tINXrG2yLU/Render', 05:19:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:00 INFO - 'HOME': '/Users/cltbld', 05:19:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:00 INFO - 'LOGNAME': 'cltbld', 05:19:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:19:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:00 INFO - 'MOZ_NO_REMOTE': '1', 05:19:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:19:00 INFO - 'NO_EM_RESTART': '1', 05:19:00 INFO - 'PAGER': '/bin/cat', 05:19:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:00 INFO - 'PWD': '/builds/slave/test', 05:19:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:19:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:00 INFO - 'SHELL': '/bin/bash', 05:19:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46deX5RbO7/Listeners', 05:19:00 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 05:19:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:00 INFO - 'USER': 'cltbld', 05:19:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:00 INFO - 'XPC_FLAGS': '0x0', 05:19:00 INFO - 'XPC_SERVICE_NAME': '0', 05:19:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:19:00 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/eEBwAGbBTeyhjtrT5or2_A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--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:19:00 INFO - mozversion application_buildid: 20160411030231 05:19:00 INFO - mozversion application_changeset: e847cfcb315f511f4928b03fd47dcf57aad05e1e 05:19:00 INFO - mozversion application_display_name: Nightly 05:19:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:19:00 INFO - mozversion application_name: Firefox 05:19:00 INFO - mozversion application_remotingname: firefox 05:19:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:19:00 INFO - mozversion application_vendor: Mozilla 05:19:00 INFO - mozversion application_version: 48.0a1 05:19:00 INFO - mozversion platform_buildid: 20160411030231 05:19:00 INFO - mozversion platform_changeset: e847cfcb315f511f4928b03fd47dcf57aad05e1e 05:19:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:19:00 INFO - mozversion platform_version: 48.0a1 05:19:00 INFO - using testdate: 1460377140 05:19:00 INFO - actual date: 1460377140 05:19:00 INFO - starting webserver on 'localhost:49275' 05:19:00 INFO - SUITE-START | Running 2 tests 05:19:00 INFO - TEST-START | dromaeo_css 05:19:00 INFO - operating with platform_type : mac_ 05:19:00 INFO - Initialising browser for dromaeo_css test... 05:19:00 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmphwlxf7/profile http://localhost:49275/getInfo.html) 05:19:03 INFO - PROCESS | 1655 | 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:19:03 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 05:19:03 INFO - PROCESS | 1655 | colorDepth:24 05:19:03 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 05:19:03 INFO - PROCESS | 1655 | __metrics 05:19:04 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 05:19:04 INFO - TEST-INFO | 1655: exit 0 05:19:04 INFO - Browser initialized. 05:19:04 INFO - Running cycle 1/1 for dromaeo_css test... 05:19:04 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmphwlxf7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:19:16 INFO - PROCESS | 1659 | RSS: Main: 247832576 05:19:16 INFO - PROCESS | 1659 | 05:20:06 INFO - PROCESS | 1659 | 1460377206390 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:22:17 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 05:22:19 INFO - PROCESS | 1659 | RSS: Main: 259985408 05:22:19 INFO - PROCESS | 1659 | 05:25:21 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 05:25:21 INFO - PROCESS | 1659 | RSS: Main: 271945728 05:25:21 INFO - PROCESS | 1659 | 05:28:23 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 05:28:24 INFO - PROCESS | 1659 | RSS: Main: 273743872 05:28:24 INFO - PROCESS | 1659 | 05:31:25 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 05:31:26 INFO - PROCESS | 1659 | RSS: Main: 275406848 05:31:26 INFO - PROCESS | 1659 | 05:34:29 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 05:34:29 INFO - PROCESS | 1659 | RSS: Main: 278290432 05:34:29 INFO - PROCESS | 1659 | 05:37:31 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 05:37:32 INFO - PROCESS | 1659 | RSS: Main: 279490560 05:37:32 INFO - PROCESS | 1659 | 05:37:32 INFO - PROCESS | 1659 | __start_tp_report 05:37:32 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 05:37:32 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 05:37:32 INFO - PROCESS | 1659 | |i|pagename|runs| 05:37:32 INFO - PROCESS | 1659 | |0;dojo.html;3293.868245270189;3430.622631510534;3469.9826500867493;3492.2840817632386;3494.947575786362;4848.903021939559;5771.682557459338;5792.623479473831;5792.7972520961775;5832.300123985127;5699.800506982257;5796.768129274835;5817.1565123057235;5866.88266234675;5937.7921772737855;5213.530782229599;5235.685858848462;5283.8150664726745;5284.894302113956;5348.732563371816;5356.866078348034;5382.381026182;5412.377576578704;5450.836474905759;5469.124940009599;5132.28148059272;5213.739313034371;5222.268882356473;5276.762545685453;5364.839054828361;5212.348456442945;5217.3217481727515;5232.450592687751;5234.7644356004075;5240.633155679104;5118.07874582575;5180.171172612364;5200;5229.633925625208;5235.816746413857;5669.525923259941;5715.3141623005085;5719.342275638313;5783.855403614902;5793.275840519935;6151.753929842801;6179.412955769195;6204.348543402923;6208.472279856218;6230.376962303779;6098.795324190776;6124.197855633957;6245.87508249837;6253.3433989430905;6331;5446.591505637093;5924.7333869975955;5939.643621382731;5939.970300148471;5998.640081595118;5483.972580137153;6313.96843015782;6341.651209183539;6357.4914006879335;6362.745490180433;6082.513398928075;6103.969480152571;6160.291566469824;6175.783847565313;6206.844828879314;6217.813465596039;6252.718627661766;6254;6261;6271.341509141565;5995.040793473024;6117.480014198754;6220.906686399708;6242.438180563771;6243.843903902348;4438.023634800339;5995.250593675791;6127.111568822495;6196.969015154986;6206.968965155235;4856.417229932431;4991.301217829507;5010.524000220046;5011.072951503984;5039.949600503948;4470.173017991682;4478.753668548261;4506.729596224237;4529.230030894756;4536.160810250114;5726.0838265877255;5752.108423194411;5832.912506312408;5926.496247818897;5953.702314884238;6238.282597501346;6250.499960003189;6250.937490625036;6258.3428739982555;6279.277883043417;5941.70291485424;5952.166696662471;5955.285365756137;5972.5520585955355;6001.699915004232;5361.865953351119;5430.266913966643;5462.371827239918;5502.064649009678;5545.972270138624;6280.48019567223;6353.205849268841;6363.268224154282;6384.904226436607;6503.707333169924;6212.689365531615;6222.16000839899;6233.345498722569;6241.594296370721;6246.500279977682;6183.227096612924;6298.338674439301;6362.331955144643;6438.90341644885;6445.065465507569;6187.474064704371;6222.657753823583;6227.377262273736;6255.593386429868;6284.371562843862;6122.916604401471;6232.407921247474;6262.311145774052;6262.499000079892;6263.217097862767;4294.119705460435;5362.195670649434;5869.530437564899;6113.3546859767275;6131.101423540661;6211.689415529115;6220.502359811295;6225.346338634378;6249.96875015622;6269.059641053878;5659.547236221175;6034.00438927572;6037.516998640011;6068.666223357758;6090.604110732788;6073.089036644538;6126.029144987285;6189.102580125947;6218.284897236876;6239.1577137085915;6090.23872015998;6106.992346262817;6107.786227482017;6113.388661133851;6156.815295541141 05:37:32 INFO - PROCESS | 1659 | |1;ext.html;485.5751217684524;535.9544438722708;542.2814770429181;545.6725964421348;554.9139883318082;37462.99999999996;38151.80924095379;38160.236795264114;38198.618013819854;38250.23499530015;39060;39192.21615567687;39548.60451395485;39707.40438893419;39777.20445591086;9336.81326373472;9342;9471.952640236823;9501;9533.761655958588;9369.812603747921;9452.291078169164;9467.66863159786;9493.382930109556;9612.423254604711;9515.238780897545;9529.332946693734;9544.475053872035;9648.71053868385;9690.854637180448;9472.95263523678;9473.763155921122;9482.81034379312;9493.335466517277;9602.471864047475;9427.151556359891;9432.90567094334;9507.001764814733;9537.093976072261;9567.330286879922;38166.61833381659;38328.80835595804;38348.61651383506;38629.80685096585;38754.41868371977;2695.5687090065494;3082.5992620959355;3169.144331030609;3174.904752857418;3382.2051817822794;26432.73567264322;26904.59643105355;26962.191134266002;27102.728972710218;27236.31909202266;2664.920052398431;2752.3669556002233;2775.722427757208;2800.1179628417185;2821.153653903841;264681;266170;266827;268252.658736707;268930;35014.47478287828;36054.639453605654;49327.01345973132;61672;62153.689231554454;34674.653253467644;34786.47820282698;34847.65152348495;34879.651203488145;35092.82453587716;15015.849841501664;15072.246387680572;15184.164870931983;15188.01277916932;15231.086134831945;12706.9364653178;12790.97672186223;12890;12892;12910.28993405353;8010.71962481322;8180.836383272302;8187.795305117301;8190.8771368429525;8281.047679516812;2787.540055890796;2969.703029697013;3047.9941619265587;3081.936731827516;3372.2918187180967;797.6530209358947;940.830650482906;1062.458146345354;1066.4774260612398;1074.414444127952;27716.584251236247;29593.112206633836;30080.947166849055;30525.38949221003;30775.922842700398;1076.8815430302661;1112.8330750387506;1119.630521927762;1139.7093741095966;1147.5639257082423;12496.81254781179;15228.933974621892;15536.145511996949;15731.921340393224;16145.677086458205;511267.88732112944;603254;603297;613663;622868;60682.69658651679;60741.69629151826;61730;61805.69097154486;62036.68981655153;1233.7532493501335;1390.9220354225556;1408.2184387664945;1466.3621324723993;1468.6768910839598;24159.75840241575;25674.486510270064;29475.968341107957;29817.25456863596;29860.402791944474;53427;53714.65713357197;54327;54393.72803135959;54607.72696136653;565862;567093;568898;569741;570534;41959.951001225214;41993.740187794414;42553;43309;43922;42127.57872421359;42669.57330426656;42946.35580466233;43070;43914.341284880116;35840.64159358373;36412;36824;36956.81521592375;37658;32295;36605;36651.43439959177;37222.904252877954;37665.43501847529;37030.8148459256;37334;37374.87875363744;37526;37703.05742356463;27014.75370825738;32043;32211.67788322087;32665.836670816494;32837.67162328346;24444.75555244496;24610.384740381633;24959.625605616293;24978.62532061984;24983.625245620966 05:37:32 INFO - PROCESS | 1659 | |2;jquery.html;356.714628297362;400.8076123460739;400.8356573804739;403.69319317318826;408.77313091234373;14298.356573954172;19465.026748662563;19812.70280945787;20296.89851550742;20401.183952641895;19520.31678891239;19520.804791952076;19545.12046957887;20883.955802209905;21103.788962110375;5097.158968770167;5174.586033117351;5512.641678290898;5806.332271788735;5930.822075337746;5665.745041473144;5697.715114244292;5713.4286571342745;5763.308402991647;5769.913451298234;5430.945690543083;5659.717014149297;5720.713964301789;5724.370319264898;5753.165790960308;5640.520555752766;5684.289463817002;5699.658020518782;5717.199592057115;5717.456841600041;4915.21356582945;5162.354705661793;5260.342457192851;5268.92096618551;5275.920861187085;13231.338433078308;14144.71710565783;21405.250816221513;22473.539219950813;24336;1903.1626084522766;2069.7619773726065;2115.2490865742593;2134.8292136629034;2272.8409011369213;8604.139586041409;9583.472908990003;10171.89828101717;10184.439855807928;10516.421596812172;1358.3276278242236;1470.1546610698783;1650.5543503254055;1652.7603497492796;1683.3434960365466;95224.57163142558;106218.46890765574;112530.43734781355;115856.42071789672;126773.99999999908;9898.752531186634;11717.472713727902;11809.350485723196;11822.467988940518;11823.46794394237;12609.621711348675;15178.620534486727;15220.771688424682;15230.695386092217;15283.923580382027;7299.817504562428;8609.784755381166;8683.435576687496;8754.69358572447;8828;8571.871421928676;8576.528290944058;8623.267022303175;8632.309415246766;8722.476651400937;4599.425071866017;4686.601638860735;4686.859394218179;4749.453812811571;4767.6424268179335;1701.5065630967129;1966.4493941696348;1992.3325685895388;2001.1495114576246;2005.5788284460134;859.621766422772;897.1342654338595;920.1994264989369;997.665781963036;1031.4224034540682;17834.19746111428;18218.180181891847;19449.4165175045;20554.38336849897;20614.587708245752;916.6333466613274;960.9615615375446;965.3290962780941;985.7831277119022;1008.8890222075565;8035.477693949874;8979.022372813819;10845.945770271099;10872.425686317429;11027.503762330714;609912;613253;614758;619828;633010.8349458316;124812.12781808099;127022;133117.33441332926;133229;134721.97917031252;993.9254555908336;996.7508122969258;1009.6213919780082;1019.1184625299063;1019.7552587379124;14911.850881491046;17778.37775677897;17793.73309400386;18020.819791801914;18338.083095844886;49593.752031239615;50376.74811625919;50564.74717626388;51263.743681281354;51771.74114129405;47139;58959;67697.3230267691;73278.26721732714;74815.87776183471;6849.1780986281965;7028.262032486516;8140.104588495379;8164.918350816416;8327.375446841632;9114.635414583343;10483.47582620881;12436.689082772642;12468.625941221779;12759.362031898554;7910.367170626451;9847.704568862946;10962.397068161008;11242.494087765906;11334.659960201207;8313.293370063371;10711.25021248505;10953.34279943206;10984.835227471434;11004.614838480615;11039.337639741641;11081;11297.15271354668;11412.714682133013;11593.768124637292;7017.5087743859485;8166.346692264723;8331.875021874555;8342.457740246864;8480.10958849312;9303.627854885728;9627.470489123165;10928.726781830517;11089.05743011853;11165.330080195214 05:37:32 INFO - PROCESS | 1659 | |3;mootools.html;1576.8896177267588;1612.8467795559422;1743.9738403923936;1841.7053271476566;1867.738516607676;8052.8389432211325;8596.785080372994;8711.259542938842;8840.4253723508;8896.332775041874;8692.34807389445;8743.256823170039;8750;8828.117188281169;8835.690750823707;2457.2505385857307;2485.2792690119845;2486.0677246032737;2486.7015958085053;2490.0413340863715;2405.530921470314;2477.987610061947;2485.5774518331837;2489.3278814720015;2491.451880586277;2432.5621388150125;2437.561238976992;2466.48203877186;2476.182859656318;2482.193287181673;2430.7569243075727;2450.1669432392982;2465.543874383236;2486.191987604036;2490.7011158660894;2452.852828830276;2468.790152837011;2475.653408522808;2476.826622136451;2489.4772097859473;8887.600057997406;9018.233450156678;9064.501452420114;9077.228435582983;9097.13577210164;5307.814226502092;5413.2150838128255;5460.372057213432;5516.531094856942;5524.8342549723575;3638.7634803737674;3651.178484840916;3657.7805331680183;3659.8536058557625;3672.944905826415;1037.7820657661825;1048.8688913885765;1049.192122066005;1063.8989296016866;1067.2742535076145;10237.846432303522;11177.658680958255;11863.347515886622;11921.642350729491;11931;4754.381930349033;4760.667273036256;4837.177679794373;4904.4605093439695;4979.751012449363;9695;9921.057499537532;9975.750606234902;9982.600695972225;9997.250206234561;5126.154184559506;5126.410462796752;5142.485751424902;5185.299984502044;5215.374155101412;4425.955740442554;4690.108879312919;4816.831410900601;4972.577330926912;5008.724520151354;4043.8180281887385;4075.6885665695822;4129.339305711072;4162.937555936664;4168.7290326128705;1332.7210470096245;1371.1293328736324;1378.951736689211;1387.2855479428104;1387.7155183187624;1081.302559848893;1120.7142178744368;1125.8198688209848;1295.0222581950568;1381.1851007905384;8082.797930051678;8107.756767296991;8204.589770511451;8226.341892648574;8243.175682431709;510.316176323728;510.6162300166516;514.8146667199806;521.3405042621088;524.7140308531859;6212.813615591449;6299.874002519924;6329.968350158312;6438.3883531064475;6486.059521369375;10275.794484110276;10635.149188064936;10647.520861561248;10692.465376731132;10721.927807219216;10399.688009359732;10520.736981575368;10567.682969510926;10707;10735.570577176826;8174;8264.545450000187;8274.8345033099;8352.749417517483;8383.95808020956;7833.451658383859;7982.281594656277;8063.83872322562;8081.111077781322;8104.5137291762685;9633.421994680342;9746.074122958307;9912.107910288109;10008.499575021075;10279.331843430153;9936.503174841373;10004.24968127408;10036.698899033041;10212.897871021194;10273.794524109626;6214.564980451325;7486;7500.32497075244;7511.624418779148;7542.208068152765;8136.471129376571;8156.632951517077;8181.754547363351;8225.424220304521;8303.916960830315;7228.349448549656;7475.963339410265;7482.214367491335;7519.323260906544;7598.12621548529;6335.922893108091;7264.273572642694;7298.321386081125;7440.55356678601;7454.291842274975;7722.150563437905;7754;7820.374370050268;7823.2567906048835;7824.256695613907;5871;6924.653767311514;7076.610786406797;7090.688222678821;7108.289171082851;7104.822379440556;7138.750143744944;7178.030965819547;7196.676149573177;7202.099737532809 05:37:32 INFO - PROCESS | 1659 | |4;prototype.html;275.80555708225705;328.2499488668393;335.0685095434692;335.2122512096572;336.0975780030618;5036.194208926572;5409.594280428969;5439.428859969706;6275.937240627598;6280.685965701719;6093.87812243756;6137.294211165718;6166.475849552782;6206;6236.532260080501;3963.266795642801;4162.771047592381;4500.729956202638;4596.195665758479;4633.397658304416;4627.907441851161;4665.510121437251;4669.949261416171;4677.391939047936;4700.670953033289;3852.7880966546827;4230.302000169968;4653.488116307203;4654.743989080599;4659.534046595347;4272.850450234227;4331.740095594275;4528.162289976365;4533.795979180944;4627.652926030544;3566.5006899034156;3856.3058649443087;3883.339832228528;3916.608339166089;3918.8628398005935;4657.930131048037;5871.2073870027425;5893.292804863401;5895.410458954113;5962.731677074542;4425.424694789689;4807.95192048082;5104.770285337168;5314.627976041678;5372.194170874361;5166.974165129188;5799.014167591519;5941.811637672439;6090.390960903918;6109.511239100906;3910.608939106095;4280.72175308604;4301.806418711166;4309.6336811371075;4323.718958267703;6446.323136070739;6807.863842723118;6957.5129740918155;6958.47811414146;6990.580565166107;3710.4434334849448;4347.413099231627;4374.62815660666;4376.277914144194;4386.649068074546;3454.928972018682;4400.559944005574;4441.267190913528;4469.307257375112;4573.748443835554;4274.819841880663;4986.783524626596;5281;5286.20706893969;5314.0700377433795;5808.39011903744;6597.505187110986;6600.900986485207;6623.350659736144;6636.2368327642935;1347.9797803032961;1413.1309244814365;1423.3452611798482;1511.2594828533938;1537.8846586506056;856.661618660638;917.1882883648019;958.7986522830283;959.9728290728854;973.9269554783419;5104.095367044214;5533.280673512498;5805.403514033675;6169.470517087972;6248.9062664060075;5941.989861723518;6249.9062514062325;6348.079528468346;6860.5540639858245;6868.690908909011;5897.52819774417;6147.600405973598;6160;6168.414000669929;6177.4749146322165;3503.5095086687884;3580.3555360035443;3590.6588874056924;3606.206634540397;3609.6209897960334;6510.381513756186;6736.1916570010935;7048.118985126859;7068.222495525488;7132.893006604905;6487.61074335532;6895.069165662571;6897.3447522485285;6963.79108626742;6989.4408447324095;6757.8648427031185;6854.9657251713425;7024.01663767073;7089.397401220954;7109.289071093056;6769.830754231184;6807.21717002551;6824.123366074369;6833.753966865699;6860.187323197465;6232.376762323732;6324.778632747832;6682.2649508555;6685.164354455693;6719.563228390139;6036.456718895321;6242.250929888442;7034.929650703428;7182;7193.424526037799;3544.858205671744;4411.977940110279;4430.645548356189;4436.645068394456;4443.155800397914;6695.0292207628645;6819.488538359544;6821.965890170517;6846.760363387258;6875.518713689994;6609.966950165219;6654.367835055662;6680.966595166993;6699.799006029827;6700.865982680417;5305.142811616166;5555.361133469541;5800.854978625568;6662.733490660319;6691.631960242039;5258.6581872178185;6149.325043606045;6441.871162576628;6493.902591461227;6521.413072823469;6236.563440559117;6254.499640028877;6306.9684651576445;6656.73373065072;6692.631905245258;6294.782495727782;6469.676516174079;6514;6519.543631945908;6561.967190164019 05:37:32 INFO - PROCESS | 1659 | |5;yui.html;671.8219671786976;730.6200775596686;742.662088749619;757.3600307739957;778.8052986753308;14506.92746536267;15006.249687515621;15086.924565377185;15162.090274583532;15172.772408413868;13894.096883702552;13950.860491395082;14609.78085328721;15270.694586108271;15362.69274614507;916.8258030974127;919.7838507950627;920.742192186189;922.7139586728102;928.707457150997;708.9291070892921;751.5265382808823;899.9875140466975;902.1429641840245;938.3384713776805;925.1211349218236;925.9444433333988;937.7280588629324;970.9029097090305;974.541965276319;951.3435729346728;963.5375019990408;964.4261664309724;966.7824739433642;969.0116081596802;688.8622275544911;689.3657834792003;693.7537174303101;715.5277516838861;727.4907564704728;15290.770638440432;15453.768193477106;15653.530394088195;15695.215239237992;15913.522594322074;9688.806223875483;12389;12428.937855310665;12444.875551244462;12479.875201247962;10031.448270345129;10035.548400322003;10047.346922450017;10133.442660653662;10259.487025648688;3232.595925509311;3449.6722811332884;3459.39460594395;3558.430651095838;3644.3622366086092;81384.18615813825;82935.68257269701;83624.58187709084;83626;84448;9314.72055838326;9315.903921617582;9318.487483188354;9371.718848434557;9405.670801521914;20956.895215523826;20985.79014209869;20990;21178.152873884872;21405.35783926485;6934.133233345832;7149.285071492809;7313.89029164563;7417.480776345712;7443;3940.5862384449792;3993.900152496211;3999.8000099995465;4012.859549915739;4020.979895100506;3579.803110828929;3637.0907273181706;3704.5739739929713;3705.184859330943;3753.6434038766274;581.1399129288592;655.88194125057;665.6571865489277;666.9799906002828;674.8245456181428;495.2274451855117;546.8359492152339;567.4609121334748;614.2690198663576;626;6638.402543771083;7484.47608667399;7909.525428474195;7935.206479352134;8121.715739949073;433.3954133983076;529.9019681358884;594.349187639534;602.5420680283016;606.8604221029188;3062.8973569514956;3824.320582301502;3830.674392676598;3939.743916645466;3941.1132495188353;77536.61231693806;77702.22297777062;78646;78985.21014789894;80257.19742802613;50432;66499.33500665028;67008;68407.3159268411;68852.655736722;61660;61974.76050479055;62207.37792622016;62249;62719.74560508764;6429.906915824415;7063.929360706327;7472.40220782347;7775.300222979959;7919.643616037177;31177.441127943057;38453.4231986526;38572.80713596414;38703.61296387113;39135;50826.74586627043;55897.16154257608;56208.718956404955;57053.42946570481;57223.849853513384;9635.518224088908;9713.174380177481;9799.314048016571;9863.865655449716;9987.950060249652;10484.21368397358;10587.947060264649;10613.991670791262;10847.511861966388;10927.344359338465;10049.899501004897;10093;10129.442880641636;10397.896021039693;10947.781044379228;10253;10262.281640285108;10418.635347763095;10433.21750868703;10704.839427408438;9864.704058878246;10017.899821001696;10946.835797462885;11582.247153934968;11775.76448471043;9331.906680933103;9406.529673516434;9493;9600.519974001412;9635.22918166559;9525.936735311958;9553.761155971157;9635;9749.610015599297;9847.359921605073 05:37:32 INFO - PROCESS | 1659 | __end_tp_report 05:37:32 INFO - PROCESS | 1659 | __start_cc_report 05:37:32 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,387 05:37:32 INFO - PROCESS | 1659 | __end_cc_report 05:37:32 INFO - PROCESS | 1659 | __startTimestamp1460378252212__endTimestamp 05:37:32 INFO - PROCESS | 1659 | 05:37:32 INFO - PROCESS | 1659 | ------- Summary: start ------- 05:37:32 INFO - PROCESS | 1659 | Number of tests: 6 05:37:32 INFO - PROCESS | 1659 | 05:37:32 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5763.94 Median:6001.70 stddev:646.36 (10.8%) stddev-sans-first:618.62 05:37:32 INFO - PROCESS | 1659 | Values: 3293.9 3430.6 3470.0 3492.3 3494.9 4848.9 5771.7 5792.6 5792.8 5832.3 5699.8 5796.8 5817.2 5866.9 5937.8 5213.5 5235.7 5283.8 5284.9 5348.7 5356.9 5382.4 5412.4 5450.8 5469.1 5132.3 5213.7 5222.3 5276.8 5364.8 5212.3 5217.3 5232.5 5234.8 5240.6 5118.1 5180.2 5200.0 5229.6 5235.8 5669.5 5715.3 5719.3 5783.9 5793.3 6151.8 6179.4 6204.3 6208.5 6230.4 6098.8 6124.2 6245.9 6253.3 6331.0 5446.6 5924.7 5939.6 5940.0 5998.6 5484.0 6314.0 6341.7 6357.5 6362.7 6082.5 6104.0 6160.3 6175.8 6206.8 6217.8 6252.7 6254.0 6261.0 6271.3 5995.0 6117.5 6220.9 6242.4 6243.8 4438.0 5995.3 6127.1 6197.0 6207.0 4856.4 4991.3 5010.5 5011.1 5039.9 4470.2 4478.8 4506.7 4529.2 4536.2 5726.1 5752.1 5832.9 5926.5 5953.7 6238.3 6250.5 6250.9 6258.3 6279.3 5941.7 5952.2 5955.3 5972.6 6001.7 5361.9 5430.3 5462.4 5502.1 5546.0 6280.5 6353.2 6363.3 6384.9 6503.7 6212.7 6222.2 6233.3 6241.6 6246.5 6183.2 6298.3 6362.3 6438.9 6445.1 6187.5 6222.7 6227.4 6255.6 6284.4 6122.9 6232.4 6262.3 6262.5 6263.2 4294.1 5362.2 5869.5 6113.4 6131.1 6211.7 6220.5 6225.3 6250.0 6269.1 5659.5 6034.0 6037.5 6068.7 6090.6 6073.1 6126.0 6189.1 6218.3 6239.2 6090.2 6107.0 6107.8 6113.4 6156.8 05:37:32 INFO - PROCESS | 1659 | 05:37:32 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:60821.15 Median:37418.94 stddev:133683.24 (357.3%) stddev-sans-first:133981.50 05:37:32 INFO - PROCESS | 1659 | Values: 485.6 536.0 542.3 545.7 554.9 37463.0 38151.8 38160.2 38198.6 38250.2 39060.0 39192.2 39548.6 39707.4 39777.2 9336.8 9342.0 9472.0 9501.0 9533.8 9369.8 9452.3 9467.7 9493.4 9612.4 9515.2 9529.3 9544.5 9648.7 9690.9 9473.0 9473.8 9482.8 9493.3 9602.5 9427.2 9432.9 9507.0 9537.1 9567.3 38166.6 38328.8 38348.6 38629.8 38754.4 2695.6 3082.6 3169.1 3174.9 3382.2 26432.7 26904.6 26962.2 27102.7 27236.3 2664.9 2752.4 2775.7 2800.1 2821.2 264681.0 266170.0 266827.0 268252.7 268930.0 35014.5 36054.6 49327.0 61672.0 62153.7 34674.7 34786.5 34847.7 34879.7 35092.8 15015.8 15072.2 15184.2 15188.0 15231.1 12706.9 12791.0 12890.0 12892.0 12910.3 8010.7 8180.8 8187.8 8190.9 8281.0 2787.5 2969.7 3048.0 3081.9 3372.3 797.7 940.8 1062.5 1066.5 1074.4 27716.6 29593.1 30080.9 30525.4 30775.9 1076.9 1112.8 1119.6 1139.7 1147.6 12496.8 15228.9 15536.1 15731.9 16145.7 511267.9 603254.0 603297.0 613663.0 622868.0 60682.7 60741.7 61730.0 61805.7 62036.7 1233.8 1390.9 1408.2 1466.4 1468.7 24159.8 25674.5 29476.0 29817.3 29860.4 53427.0 53714.7 54327.0 54393.7 54607.7 565862.0 567093.0 568898.0 569741.0 570534.0 41960.0 41993.7 42553.0 43309.0 43922.0 42127.6 42669.6 42946.4 43070.0 43914.3 35840.6 36412.0 36824.0 36956.8 37658.0 32295.0 36605.0 36651.4 37222.9 37665.4 37030.8 37334.0 37374.9 37526.0 37703.1 27014.8 32043.0 32211.7 32665.8 32837.7 24444.8 24610.4 24959.6 24978.6 24983.6 05:37:32 INFO - PROCESS | 1659 | 05:37:32 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:34550.54 Median:402.26 stddev:102893.36 (25578.5%) stddev-sans-first:103149.97 05:37:32 INFO - PROCESS | 1659 | Values: 356.7 400.8 400.8 403.7 408.8 14298.4 19465.0 19812.7 20296.9 20401.2 19520.3 19520.8 19545.1 20884.0 21103.8 5097.2 5174.6 5512.6 5806.3 5930.8 5665.7 5697.7 5713.4 5763.3 5769.9 5430.9 5659.7 5720.7 5724.4 5753.2 5640.5 5684.3 5699.7 5717.2 5717.5 4915.2 5162.4 5260.3 5268.9 5275.9 13231.3 14144.7 21405.3 22473.5 24336.0 1903.2 2069.8 2115.2 2134.8 2272.8 8604.1 9583.5 10171.9 10184.4 10516.4 1358.3 1470.2 1650.6 1652.8 1683.3 95224.6 106218.5 112530.4 115856.4 126774.0 9898.8 11717.5 11809.4 11822.5 11823.5 12609.6 15178.6 15220.8 15230.7 15283.9 7299.8 8609.8 8683.4 8754.7 8828.0 8571.9 8576.5 8623.3 8632.3 8722.5 4599.4 4686.6 4686.9 4749.5 4767.6 1701.5 1966.4 1992.3 2001.1 2005.6 859.6 897.1 920.2 997.7 1031.4 17834.2 18218.2 19449.4 20554.4 20614.6 916.6 961.0 965.3 985.8 1008.9 8035.5 8979.0 10845.9 10872.4 11027.5 609912.0 613253.0 614758.0 619828.0 633010.8 124812.1 127022.0 133117.3 133229.0 134722.0 993.9 996.8 1009.6 1019.1 1019.8 14911.9 17778.4 17793.7 18020.8 18338.1 49593.8 50376.7 50564.7 51263.7 51771.7 47139.0 58959.0 67697.3 73278.3 74815.9 6849.2 7028.3 8140.1 8164.9 8327.4 9114.6 10483.5 12436.7 12468.6 12759.4 7910.4 9847.7 10962.4 11242.5 11334.7 8313.3 10711.3 10953.3 10984.8 11004.6 11039.3 11081.0 11297.2 11412.7 11593.8 7017.5 8166.3 8331.9 8342.5 8480.1 9303.6 9627.5 10928.7 11089.1 11165.3 05:37:32 INFO - PROCESS | 1659 | 05:37:32 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:6051.12 Median:2828.65 stddev:3196.34 (113.0%) stddev-sans-first:3187.61 05:37:32 INFO - PROCESS | 1659 | Values: 1576.9 1612.8 1744.0 1841.7 1867.7 8052.8 8596.8 8711.3 8840.4 8896.3 8692.3 8743.3 8750.0 8828.1 8835.7 2457.3 2485.3 2486.1 2486.7 2490.0 2405.5 2478.0 2485.6 2489.3 2491.5 2432.6 2437.6 2466.5 2476.2 2482.2 2430.8 2450.2 2465.5 2486.2 2490.7 2452.9 2468.8 2475.7 2476.8 2489.5 8887.6 9018.2 9064.5 9077.2 9097.1 5307.8 5413.2 5460.4 5516.5 5524.8 3638.8 3651.2 3657.8 3659.9 3672.9 1037.8 1048.9 1049.2 1063.9 1067.3 10237.8 11177.7 11863.3 11921.6 11931.0 4754.4 4760.7 4837.2 4904.5 4979.8 9695.0 9921.1 9975.8 9982.6 9997.3 5126.2 5126.4 5142.5 5185.3 5215.4 4426.0 4690.1 4816.8 4972.6 5008.7 4043.8 4075.7 4129.3 4162.9 4168.7 1332.7 1371.1 1379.0 1387.3 1387.7 1081.3 1120.7 1125.8 1295.0 1381.2 8082.8 8107.8 8204.6 8226.3 8243.2 510.3 510.6 514.8 521.3 524.7 6212.8 6299.9 6330.0 6438.4 6486.1 10275.8 10635.1 10647.5 10692.5 10721.9 10399.7 10520.7 10567.7 10707.0 10735.6 8174.0 8264.5 8274.8 8352.7 8384.0 7833.5 7982.3 8063.8 8081.1 8104.5 9633.4 9746.1 9912.1 10008.5 10279.3 9936.5 10004.2 10036.7 10212.9 10273.8 6214.6 7486.0 7500.3 7511.6 7542.2 8136.5 8156.6 8181.8 8225.4 8303.9 7228.3 7476.0 7482.2 7519.3 7598.1 6335.9 7264.3 7298.3 7440.6 7454.3 7722.2 7754.0 7820.4 7823.3 7824.3 5871.0 6924.7 7076.6 7090.7 7108.3 7104.8 7138.8 7178.0 7196.7 7202.1 05:37:32 INFO - PROCESS | 1659 | 05:37:32 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:5259.71 Median:5999.59 stddev:1696.08 (28.3%) stddev-sans-first:1659.08 05:37:32 INFO - PROCESS | 1659 | Values: 275.8 328.2 335.1 335.2 336.1 5036.2 5409.6 5439.4 6275.9 6280.7 6093.9 6137.3 6166.5 6206.0 6236.5 3963.3 4162.8 4500.7 4596.2 4633.4 4627.9 4665.5 4669.9 4677.4 4700.7 3852.8 4230.3 4653.5 4654.7 4659.5 4272.9 4331.7 4528.2 4533.8 4627.7 3566.5 3856.3 3883.3 3916.6 3918.9 4657.9 5871.2 5893.3 5895.4 5962.7 4425.4 4808.0 5104.8 5314.6 5372.2 5167.0 5799.0 5941.8 6090.4 6109.5 3910.6 4280.7 4301.8 4309.6 4323.7 6446.3 6807.9 6957.5 6958.5 6990.6 3710.4 4347.4 4374.6 4376.3 4386.6 3454.9 4400.6 4441.3 4469.3 4573.7 4274.8 4986.8 5281.0 5286.2 5314.1 5808.4 6597.5 6600.9 6623.4 6636.2 1348.0 1413.1 1423.3 1511.3 1537.9 856.7 917.2 958.8 960.0 973.9 5104.1 5533.3 5805.4 6169.5 6248.9 5942.0 6249.9 6348.1 6860.6 6868.7 5897.5 6147.6 6160.0 6168.4 6177.5 3503.5 3580.4 3590.7 3606.2 3609.6 6510.4 6736.2 7048.1 7068.2 7132.9 6487.6 6895.1 6897.3 6963.8 6989.4 6757.9 6855.0 7024.0 7089.4 7109.3 6769.8 6807.2 6824.1 6833.8 6860.2 6232.4 6324.8 6682.3 6685.2 6719.6 6036.5 6242.3 7034.9 7182.0 7193.4 3544.9 4412.0 4430.6 4436.6 4443.2 6695.0 6819.5 6822.0 6846.8 6875.5 6610.0 6654.4 6681.0 6699.8 6700.9 5305.1 5555.4 5800.9 6662.7 6691.6 5258.7 6149.3 6441.9 6493.9 6521.4 6236.6 6254.5 6307.0 6656.7 6692.6 6294.8 6469.7 6514.0 6519.5 6562.0 05:37:32 INFO - PROCESS | 1659 | 05:37:32 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:16491.41 Median:62091.07 stddev:22572.67 (36.4%) stddev-sans-first:22604.74 05:37:32 INFO - PROCESS | 1659 | Values: 671.8 730.6 742.7 757.4 778.8 14506.9 15006.2 15086.9 15162.1 15172.8 13894.1 13950.9 14609.8 15270.7 15362.7 916.8 919.8 920.7 922.7 928.7 708.9 751.5 900.0 902.1 938.3 925.1 925.9 937.7 970.9 974.5 951.3 963.5 964.4 966.8 969.0 688.9 689.4 693.8 715.5 727.5 15290.8 15453.8 15653.5 15695.2 15913.5 9688.8 12389.0 12428.9 12444.9 12479.9 10031.4 10035.5 10047.3 10133.4 10259.5 3232.6 3449.7 3459.4 3558.4 3644.4 81384.2 82935.7 83624.6 83626.0 84448.0 9314.7 9315.9 9318.5 9371.7 9405.7 20956.9 20985.8 20990.0 21178.2 21405.4 6934.1 7149.3 7313.9 7417.5 7443.0 3940.6 3993.9 3999.8 4012.9 4021.0 3579.8 3637.1 3704.6 3705.2 3753.6 581.1 655.9 665.7 667.0 674.8 495.2 546.8 567.5 614.3 626.0 6638.4 7484.5 7909.5 7935.2 8121.7 433.4 529.9 594.3 602.5 606.9 3062.9 3824.3 3830.7 3939.7 3941.1 77536.6 77702.2 78646.0 78985.2 80257.2 50432.0 66499.3 67008.0 68407.3 68852.7 61660.0 61974.8 62207.4 62249.0 62719.7 6429.9 7063.9 7472.4 7775.3 7919.6 31177.4 38453.4 38572.8 38703.6 39135.0 50826.7 55897.2 56208.7 57053.4 57223.8 9635.5 9713.2 9799.3 9863.9 9988.0 10484.2 10587.9 10614.0 10847.5 10927.3 10049.9 10093.0 10129.4 10397.9 10947.8 10253.0 10262.3 10418.6 10433.2 10704.8 9864.7 10017.9 10946.8 11582.2 11775.8 9331.9 9406.5 9493.0 9600.5 9635.2 9525.9 9553.8 9635.0 9749.6 9847.4 05:37:32 INFO - PROCESS | 1659 | -------- Summary: end -------- 05:37:32 INFO - PROCESS | 1659 | 05:37:32 INFO - TEST-INFO | 1659: exit 0 05:37:32 INFO - TEST-OK | dromaeo_css | took 1111842ms 05:37:32 INFO - TEST-START | kraken 05:37:32 INFO - operating with platform_type : mac_ 05:37:32 INFO - Initialising browser for kraken test... 05:37:32 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpJMqlDY/profile http://localhost:49275/getInfo.html) 05:37:35 INFO - PROCESS | 1672 | 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:37:35 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 05:37:35 INFO - PROCESS | 1672 | colorDepth:24 05:37:35 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 05:37:35 INFO - PROCESS | 1672 | __metrics 05:37:35 ERROR - PROCESS | 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 05:37:36 INFO - TEST-INFO | 1672: exit 0 05:37:36 INFO - Browser initialized. 05:37:36 INFO - Running cycle 1/1 for kraken test... 05:37:36 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpJMqlDY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:37:48 INFO - PROCESS | 1676 | RSS: Main: 247963648 05:37:48 INFO - PROCESS | 1676 | 05:37:51 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 05:37:52 INFO - PROCESS | 1676 | RSS: Main: 259805184 05:37:52 INFO - PROCESS | 1676 | 05:37:54 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 05:37:55 INFO - PROCESS | 1676 | RSS: Main: 269135872 05:37:55 INFO - PROCESS | 1676 | 05:37:58 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 05:37:59 INFO - PROCESS | 1676 | RSS: Main: 272003072 05:37:59 INFO - PROCESS | 1676 | 05:38:01 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 05:38:02 INFO - PROCESS | 1676 | RSS: Main: 274169856 05:38:02 INFO - PROCESS | 1676 | 05:38:04 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:38:04 INFO - PROCESS | 1676 | RSS: Main: 274620416 05:38:04 INFO - PROCESS | 1676 | 05:38:07 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 05:38:08 INFO - PROCESS | 1676 | RSS: Main: 274575360 05:38:08 INFO - PROCESS | 1676 | 05:38:11 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 05:38:12 INFO - PROCESS | 1676 | RSS: Main: 274649088 05:38:12 INFO - PROCESS | 1676 | 05:38:15 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 05:38:15 INFO - PROCESS | 1676 | RSS: Main: 275173376 05:38:15 INFO - PROCESS | 1676 | 05:38:17 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:38:17 INFO - PROCESS | 1676 | RSS: Main: 274714624 05:38:17 INFO - PROCESS | 1676 | 05:38:19 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:38:20 INFO - PROCESS | 1676 | RSS: Main: 274939904 05:38:20 INFO - PROCESS | 1676 | 05:38:22 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:38:23 INFO - PROCESS | 1676 | RSS: Main: 275230720 05:38:23 INFO - PROCESS | 1676 | 05:38:26 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:38:26 INFO - PROCESS | 1676 | RSS: Main: 275279872 05:38:26 INFO - PROCESS | 1676 | 05:38:29 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:38:30 INFO - PROCESS | 1676 | RSS: Main: 275759104 05:38:30 INFO - PROCESS | 1676 | 05:38:32 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 05:38:32 INFO - PROCESS | 1676 | RSS: Main: 277041152 05:38:32 INFO - PROCESS | 1676 | 05:38:32 INFO - PROCESS | 1676 | __start_tp_report 05:38:32 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 05:38:32 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 05:38:32 INFO - PROCESS | 1676 | |i|pagename|runs| 05:38:32 INFO - PROCESS | 1676 | |0;ai-astar;115;106;117;116;119;129;127;171;164;114 05:38:32 INFO - PROCESS | 1676 | |1;audio-beat-detection;147;123;144;165;120;146;144;121;178;129 05:38:32 INFO - PROCESS | 1676 | |2;audio-dft;197;193;209;231;250;280;193;198;201;193 05:38:32 INFO - PROCESS | 1676 | |3;audio-fft;68;102;107;167;56;57;56;60;130;66 05:38:32 INFO - PROCESS | 1676 | |4;audio-oscillator;78;80;135;88;80;82;119;81;115;148 05:38:32 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;136;121;93;85;93;76;76;96;109;128 05:38:32 INFO - PROCESS | 1676 | |6;imaging-darkroom;93;100;95;97;150;95;96;89;151;136 05:38:32 INFO - PROCESS | 1676 | |7;imaging-desaturate;94;97;91;90;149;122;92;125;146;105 05:38:32 INFO - PROCESS | 1676 | |8;json-parse-financial;51;75;57;55;58;59;57;73;60;57 05:38:32 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;65;67;71;70;75;71;66;66;68;66 05:38:32 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;90;84;85;87;90;90;88;91;79;86 05:38:32 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;145;148;144;144;145;147;145;144;200;181 05:38:32 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;172;172;190;147;225;226;216;173;171;172 05:38:32 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;70;71;71;69;71;94;100;98;67;70 05:38:32 INFO - PROCESS | 1676 | __end_tp_report 05:38:32 INFO - PROCESS | 1676 | __start_cc_report 05:38:32 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,976 05:38:32 INFO - PROCESS | 1676 | __end_cc_report 05:38:32 INFO - PROCESS | 1676 | __startTimestamp1460378312519__endTimestamp 05:38:32 INFO - PROCESS | 1676 | 05:38:32 INFO - PROCESS | 1676 | ------- Summary: start ------- 05:38:32 INFO - PROCESS | 1676 | Number of tests: 14 05:38:32 INFO - PROCESS | 1676 | 05:38:32 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:127.80 Median:123.00 stddev:21.96 (17.9%) stddev-sans-first:22.80 05:38:32 INFO - PROCESS | 1676 | Values: 115.0 106.0 117.0 116.0 119.0 129.0 127.0 171.0 164.0 114.0 05:38:32 INFO - PROCESS | 1676 | 05:38:32 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:145.00 stddev:19.23 (13.3%) stddev-sans-first:20.30 05:38:32 INFO - PROCESS | 1676 | Values: 147.0 123.0 144.0 165.0 120.0 146.0 144.0 121.0 178.0 129.0 05:38:32 INFO - PROCESS | 1676 | 05:38:32 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:214.50 Median:205.00 stddev:29.82 (14.5%) stddev-sans-first:30.94 05:38:32 INFO - PROCESS | 1676 | Values: 197.0 193.0 209.0 231.0 250.0 280.0 193.0 198.0 201.0 193.0 05:38:32 INFO - PROCESS | 1676 | 05:38:32 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:86.90 Median:56.50 stddev:38.34 (67.9%) stddev-sans-first:40.05 05:38:32 INFO - PROCESS | 1676 | Values: 68.0 102.0 107.0 167.0 56.0 57.0 56.0 60.0 130.0 66.0 05:38:32 INFO - PROCESS | 1676 | 05:38:32 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:100.60 Median:80.00 stddev:26.30 (32.9%) stddev-sans-first:26.59 05:38:32 INFO - PROCESS | 1676 | Values: 78.0 80.0 135.0 88.0 80.0 82.0 119.0 81.0 115.0 148.0 05:38:32 INFO - PROCESS | 1676 | 05:38:32 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:101.30 Median:80.50 stddev:21.28 (26.4%) stddev-sans-first:18.50 05:38:32 INFO - PROCESS | 1676 | Values: 136.0 121.0 93.0 85.0 93.0 76.0 76.0 96.0 109.0 128.0 05:38:32 INFO - PROCESS | 1676 | 05:38:32 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:110.20 Median:94.00 stddev:24.95 (26.5%) stddev-sans-first:25.67 05:38:32 INFO - PROCESS | 1676 | Values: 93.0 100.0 95.0 97.0 150.0 95.0 96.0 89.0 151.0 136.0 05:38:32 INFO - PROCESS | 1676 | 05:38:32 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:111.10 Median:90.50 stddev:22.87 (25.3%) stddev-sans-first:23.41 05:38:32 INFO - PROCESS | 1676 | Values: 94.0 97.0 91.0 90.0 149.0 122.0 92.0 125.0 146.0 105.0 05:38:32 INFO - PROCESS | 1676 | 05:38:32 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:58.50 stddev:7.69 (13.1%) stddev-sans-first:7.40 05:38:32 INFO - PROCESS | 1676 | Values: 51.0 75.0 57.0 55.0 58.0 59.0 57.0 73.0 60.0 57.0 05:38:32 INFO - PROCESS | 1676 | 05:38:32 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:3.17 (4.6%) stddev-sans-first:3.10 05:38:32 INFO - PROCESS | 1676 | Values: 65.0 67.0 71.0 70.0 75.0 71.0 66.0 66.0 68.0 66.0 05:38:32 INFO - PROCESS | 1676 | 05:38:32 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:89.00 stddev:3.68 (4.1%) stddev-sans-first:3.74 05:38:32 INFO - PROCESS | 1676 | Values: 90.0 84.0 85.0 87.0 90.0 90.0 88.0 91.0 79.0 86.0 05:38:32 INFO - PROCESS | 1676 | 05:38:32 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:154.30 Median:146.00 stddev:19.64 (13.5%) stddev-sans-first:20.54 05:38:32 INFO - PROCESS | 1676 | Values: 145.0 148.0 144.0 144.0 145.0 147.0 145.0 144.0 200.0 181.0 05:38:32 INFO - PROCESS | 1676 | 05:38:32 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.40 Median:181.50 stddev:26.95 (14.9%) stddev-sans-first:28.08 05:38:32 INFO - PROCESS | 1676 | Values: 172.0 172.0 190.0 147.0 225.0 226.0 216.0 173.0 171.0 172.0 05:38:32 INFO - PROCESS | 1676 | 05:38:32 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.10 Median:71.00 stddev:13.40 (18.9%) stddev-sans-first:13.89 05:38:32 INFO - PROCESS | 1676 | Values: 70.0 71.0 71.0 69.0 71.0 94.0 100.0 98.0 67.0 70.0 05:38:32 INFO - PROCESS | 1676 | -------- Summary: end -------- 05:38:32 INFO - PROCESS | 1676 | 05:38:33 INFO - TEST-INFO | 1676: exit 0 05:38:33 INFO - TEST-OK | kraken | took 60594ms 05:38:33 INFO - SUITE-END | took 1172s 05:38:33 INFO - Completed test suite (00:19:32) 05:38:33 INFO - javascript benchmark 05:38:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3293.868245270189, 3430.622631510534, 3469.9826500867493, 3492.2840817632386, 3494.947575786362, 4848.903021939559, 5771.682557459338, 5792.623479473831, 5792.7972520961775, 5832.300123985127, 5699.800506982257, 5796.768129274835, 5817.1565123057235, 5866.88266234675, 5937.7921772737855, 5213.530782229599, 5235.685858848462, 5283.8150664726745, 5284.894302113956, 5348.732563371816, 5356.866078348034, 5382.381026182, 5412.377576578704, 5450.836474905759, 5469.124940009599, 5132.28148059272, 5213.739313034371, 5222.268882356473, 5276.762545685453, 5364.839054828361, 5212.348456442945, 5217.3217481727515, 5232.450592687751, 5234.7644356004075, 5240.633155679104, 5118.07874582575, 5180.171172612364, 5200.0, 5229.633925625208, 5235.816746413857, 5669.525923259941, 5715.3141623005085, 5719.342275638313, 5783.855403614902, 5793.275840519935, 6151.753929842801, 6179.412955769195, 6204.348543402923, 6208.472279856218, 6230.376962303779, 6098.795324190776, 6124.197855633957, 6245.87508249837, 6253.3433989430905, 6331.0, 5446.591505637093, 5924.7333869975955, 5939.643621382731, 5939.970300148471, 5998.640081595118, 5483.972580137153, 6313.96843015782, 6341.651209183539, 6357.4914006879335, 6362.745490180433, 6082.513398928075, 6103.969480152571, 6160.291566469824, 6175.783847565313, 6206.844828879314, 6217.813465596039, 6252.718627661766, 6254.0, 6261.0, 6271.341509141565, 5995.040793473024, 6117.480014198754, 6220.906686399708, 6242.438180563771, 6243.843903902348, 4438.023634800339, 5995.250593675791, 6127.111568822495, 6196.969015154986, 6206.968965155235, 4856.417229932431, 4991.301217829507, 5010.524000220046, 5011.072951503984, 5039.949600503948, 4470.173017991682, 4478.753668548261, 4506.729596224237, 4529.230030894756, 4536.160810250114, 5726.0838265877255, 5752.108423194411, 5832.912506312408, 5926.496247818897, 5953.702314884238, 6238.282597501346, 6250.499960003189, 6250.937490625036, 6258.3428739982555, 6279.277883043417, 5941.70291485424, 5952.166696662471, 5955.285365756137, 5972.5520585955355, 6001.699915004232, 5361.865953351119, 5430.266913966643, 5462.371827239918, 5502.064649009678, 5545.972270138624, 6280.48019567223, 6353.205849268841, 6363.268224154282, 6384.904226436607, 6503.707333169924, 6212.689365531615, 6222.16000839899, 6233.345498722569, 6241.594296370721, 6246.500279977682, 6183.227096612924, 6298.338674439301, 6362.331955144643, 6438.90341644885, 6445.065465507569, 6187.474064704371, 6222.657753823583, 6227.377262273736, 6255.593386429868, 6284.371562843862, 6122.916604401471, 6232.407921247474, 6262.311145774052, 6262.499000079892, 6263.217097862767, 4294.119705460435, 5362.195670649434, 5869.530437564899, 6113.3546859767275, 6131.101423540661, 6211.689415529115, 6220.502359811295, 6225.346338634378, 6249.96875015622, 6269.059641053878, 5659.547236221175, 6034.00438927572, 6037.516998640011, 6068.666223357758, 6090.604110732788, 6073.089036644538, 6126.029144987285, 6189.102580125947, 6218.284897236876, 6239.1577137085915, 6090.23872015998, 6106.992346262817, 6107.786227482017, 6113.388661133851, 6156.815295541141], "value": 5725.385886545292, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [485.5751217684524, 535.9544438722708, 542.2814770429181, 545.6725964421348, 554.9139883318082, 37462.99999999996, 38151.80924095379, 38160.236795264114, 38198.618013819854, 38250.23499530015, 39060.0, 39192.21615567687, 39548.60451395485, 39707.40438893419, 39777.20445591086, 9336.81326373472, 9342.0, 9471.952640236823, 9501.0, 9533.761655958588, 9369.812603747921, 9452.291078169164, 9467.66863159786, 9493.382930109556, 9612.423254604711, 9515.238780897545, 9529.332946693734, 9544.475053872035, 9648.71053868385, 9690.854637180448, 9472.95263523678, 9473.763155921122, 9482.81034379312, 9493.335466517277, 9602.471864047475, 9427.151556359891, 9432.90567094334, 9507.001764814733, 9537.093976072261, 9567.330286879922, 38166.61833381659, 38328.80835595804, 38348.61651383506, 38629.80685096585, 38754.41868371977, 2695.5687090065494, 3082.5992620959355, 3169.144331030609, 3174.904752857418, 3382.2051817822794, 26432.73567264322, 26904.59643105355, 26962.191134266002, 27102.728972710218, 27236.31909202266, 2664.920052398431, 2752.3669556002233, 2775.722427757208, 2800.1179628417185, 2821.153653903841, 264681.0, 266170.0, 266827.0, 268252.658736707, 268930.0, 35014.47478287828, 36054.639453605654, 49327.01345973132, 61672.0, 62153.689231554454, 34674.653253467644, 34786.47820282698, 34847.65152348495, 34879.651203488145, 35092.82453587716, 15015.849841501664, 15072.246387680572, 15184.164870931983, 15188.01277916932, 15231.086134831945, 12706.9364653178, 12790.97672186223, 12890.0, 12892.0, 12910.28993405353, 8010.71962481322, 8180.836383272302, 8187.795305117301, 8190.8771368429525, 8281.047679516812, 2787.540055890796, 2969.703029697013, 3047.9941619265587, 3081.936731827516, 3372.2918187180967, 797.6530209358947, 940.830650482906, 1062.458146345354, 1066.4774260612398, 1074.414444127952, 27716.584251236247, 29593.112206633836, 30080.947166849055, 30525.38949221003, 30775.922842700398, 1076.8815430302661, 1112.8330750387506, 1119.630521927762, 1139.7093741095966, 1147.5639257082423, 12496.81254781179, 15228.933974621892, 15536.145511996949, 15731.921340393224, 16145.677086458205, 511267.88732112944, 603254.0, 603297.0, 613663.0, 622868.0, 60682.69658651679, 60741.69629151826, 61730.0, 61805.69097154486, 62036.68981655153, 1233.7532493501335, 1390.9220354225556, 1408.2184387664945, 1466.3621324723993, 1468.6768910839598, 24159.75840241575, 25674.486510270064, 29475.968341107957, 29817.25456863596, 29860.402791944474, 53427.0, 53714.65713357197, 54327.0, 54393.72803135959, 54607.72696136653, 565862.0, 567093.0, 568898.0, 569741.0, 570534.0, 41959.951001225214, 41993.740187794414, 42553.0, 43309.0, 43922.0, 42127.57872421359, 42669.57330426656, 42946.35580466233, 43070.0, 43914.341284880116, 35840.64159358373, 36412.0, 36824.0, 36956.81521592375, 37658.0, 32295.0, 36605.0, 36651.43439959177, 37222.904252877954, 37665.43501847529, 37030.8148459256, 37334.0, 37374.87875363744, 37526.0, 37703.05742356463, 27014.75370825738, 32043.0, 32211.67788322087, 32665.836670816494, 32837.67162328346, 24444.75555244496, 24610.384740381633, 24959.625605616293, 24978.62532061984, 24983.625245620966], "value": 18085.766294184657, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.714628297362, 400.8076123460739, 400.8356573804739, 403.69319317318826, 408.77313091234373, 14298.356573954172, 19465.026748662563, 19812.70280945787, 20296.89851550742, 20401.183952641895, 19520.31678891239, 19520.804791952076, 19545.12046957887, 20883.955802209905, 21103.788962110375, 5097.158968770167, 5174.586033117351, 5512.641678290898, 5806.332271788735, 5930.822075337746, 5665.745041473144, 5697.715114244292, 5713.4286571342745, 5763.308402991647, 5769.913451298234, 5430.945690543083, 5659.717014149297, 5720.713964301789, 5724.370319264898, 5753.165790960308, 5640.520555752766, 5684.289463817002, 5699.658020518782, 5717.199592057115, 5717.456841600041, 4915.21356582945, 5162.354705661793, 5260.342457192851, 5268.92096618551, 5275.920861187085, 13231.338433078308, 14144.71710565783, 21405.250816221513, 22473.539219950813, 24336.0, 1903.1626084522766, 2069.7619773726065, 2115.2490865742593, 2134.8292136629034, 2272.8409011369213, 8604.139586041409, 9583.472908990003, 10171.89828101717, 10184.439855807928, 10516.421596812172, 1358.3276278242236, 1470.1546610698783, 1650.5543503254055, 1652.7603497492796, 1683.3434960365466, 95224.57163142558, 106218.46890765574, 112530.43734781355, 115856.42071789672, 126773.99999999908, 9898.752531186634, 11717.472713727902, 11809.350485723196, 11822.467988940518, 11823.46794394237, 12609.621711348675, 15178.620534486727, 15220.771688424682, 15230.695386092217, 15283.923580382027, 7299.817504562428, 8609.784755381166, 8683.435576687496, 8754.69358572447, 8828.0, 8571.871421928676, 8576.528290944058, 8623.267022303175, 8632.309415246766, 8722.476651400937, 4599.425071866017, 4686.601638860735, 4686.859394218179, 4749.453812811571, 4767.6424268179335, 1701.5065630967129, 1966.4493941696348, 1992.3325685895388, 2001.1495114576246, 2005.5788284460134, 859.621766422772, 897.1342654338595, 920.1994264989369, 997.665781963036, 1031.4224034540682, 17834.19746111428, 18218.180181891847, 19449.4165175045, 20554.38336849897, 20614.587708245752, 916.6333466613274, 960.9615615375446, 965.3290962780941, 985.7831277119022, 1008.8890222075565, 8035.477693949874, 8979.022372813819, 10845.945770271099, 10872.425686317429, 11027.503762330714, 609912.0, 613253.0, 614758.0, 619828.0, 633010.8349458316, 124812.12781808099, 127022.0, 133117.33441332926, 133229.0, 134721.97917031252, 993.9254555908336, 996.7508122969258, 1009.6213919780082, 1019.1184625299063, 1019.7552587379124, 14911.850881491046, 17778.37775677897, 17793.73309400386, 18020.819791801914, 18338.083095844886, 49593.752031239615, 50376.74811625919, 50564.74717626388, 51263.743681281354, 51771.74114129405, 47139.0, 58959.0, 67697.3230267691, 73278.26721732714, 74815.87776183471, 6849.1780986281965, 7028.262032486516, 8140.104588495379, 8164.918350816416, 8327.375446841632, 9114.635414583343, 10483.47582620881, 12436.689082772642, 12468.625941221779, 12759.362031898554, 7910.367170626451, 9847.704568862946, 10962.397068161008, 11242.494087765906, 11334.659960201207, 8313.293370063371, 10711.25021248505, 10953.34279943206, 10984.835227471434, 11004.614838480615, 11039.337639741641, 11081.0, 11297.15271354668, 11412.714682133013, 11593.768124637292, 7017.5087743859485, 8166.346692264723, 8331.875021874555, 8342.457740246864, 8480.10958849312, 9303.627854885728, 9627.470489123165, 10928.726781830517, 11089.05743011853, 11165.330080195214], "value": 9164.810059386366, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1576.8896177267588, 1612.8467795559422, 1743.9738403923936, 1841.7053271476566, 1867.738516607676, 8052.8389432211325, 8596.785080372994, 8711.259542938842, 8840.4253723508, 8896.332775041874, 8692.34807389445, 8743.256823170039, 8750.0, 8828.117188281169, 8835.690750823707, 2457.2505385857307, 2485.2792690119845, 2486.0677246032737, 2486.7015958085053, 2490.0413340863715, 2405.530921470314, 2477.987610061947, 2485.5774518331837, 2489.3278814720015, 2491.451880586277, 2432.5621388150125, 2437.561238976992, 2466.48203877186, 2476.182859656318, 2482.193287181673, 2430.7569243075727, 2450.1669432392982, 2465.543874383236, 2486.191987604036, 2490.7011158660894, 2452.852828830276, 2468.790152837011, 2475.653408522808, 2476.826622136451, 2489.4772097859473, 8887.600057997406, 9018.233450156678, 9064.501452420114, 9077.228435582983, 9097.13577210164, 5307.814226502092, 5413.2150838128255, 5460.372057213432, 5516.531094856942, 5524.8342549723575, 3638.7634803737674, 3651.178484840916, 3657.7805331680183, 3659.8536058557625, 3672.944905826415, 1037.7820657661825, 1048.8688913885765, 1049.192122066005, 1063.8989296016866, 1067.2742535076145, 10237.846432303522, 11177.658680958255, 11863.347515886622, 11921.642350729491, 11931.0, 4754.381930349033, 4760.667273036256, 4837.177679794373, 4904.4605093439695, 4979.751012449363, 9695.0, 9921.057499537532, 9975.750606234902, 9982.600695972225, 9997.250206234561, 5126.154184559506, 5126.410462796752, 5142.485751424902, 5185.299984502044, 5215.374155101412, 4425.955740442554, 4690.108879312919, 4816.831410900601, 4972.577330926912, 5008.724520151354, 4043.8180281887385, 4075.6885665695822, 4129.339305711072, 4162.937555936664, 4168.7290326128705, 1332.7210470096245, 1371.1293328736324, 1378.951736689211, 1387.2855479428104, 1387.7155183187624, 1081.302559848893, 1120.7142178744368, 1125.8198688209848, 1295.0222581950568, 1381.1851007905384, 8082.797930051678, 8107.756767296991, 8204.589770511451, 8226.341892648574, 8243.175682431709, 510.316176323728, 510.6162300166516, 514.8146667199806, 521.3405042621088, 524.7140308531859, 6212.813615591449, 6299.874002519924, 6329.968350158312, 6438.3883531064475, 6486.059521369375, 10275.794484110276, 10635.149188064936, 10647.520861561248, 10692.465376731132, 10721.927807219216, 10399.688009359732, 10520.736981575368, 10567.682969510926, 10707.0, 10735.570577176826, 8174.0, 8264.545450000187, 8274.8345033099, 8352.749417517483, 8383.95808020956, 7833.451658383859, 7982.281594656277, 8063.83872322562, 8081.111077781322, 8104.5137291762685, 9633.421994680342, 9746.074122958307, 9912.107910288109, 10008.499575021075, 10279.331843430153, 9936.503174841373, 10004.24968127408, 10036.698899033041, 10212.897871021194, 10273.794524109626, 6214.564980451325, 7486.0, 7500.32497075244, 7511.624418779148, 7542.208068152765, 8136.471129376571, 8156.632951517077, 8181.754547363351, 8225.424220304521, 8303.916960830315, 7228.349448549656, 7475.963339410265, 7482.214367491335, 7519.323260906544, 7598.12621548529, 6335.922893108091, 7264.273572642694, 7298.321386081125, 7440.55356678601, 7454.291842274975, 7722.150563437905, 7754.0, 7820.374370050268, 7823.2567906048835, 7824.256695613907, 5871.0, 6924.653767311514, 7076.610786406797, 7090.688222678821, 7108.289171082851, 7104.822379440556, 7138.750143744944, 7178.030965819547, 7196.676149573177, 7202.099737532809], "value": 4855.289775634211, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [275.80555708225705, 328.2499488668393, 335.0685095434692, 335.2122512096572, 336.0975780030618, 5036.194208926572, 5409.594280428969, 5439.428859969706, 6275.937240627598, 6280.685965701719, 6093.87812243756, 6137.294211165718, 6166.475849552782, 6206.0, 6236.532260080501, 3963.266795642801, 4162.771047592381, 4500.729956202638, 4596.195665758479, 4633.397658304416, 4627.907441851161, 4665.510121437251, 4669.949261416171, 4677.391939047936, 4700.670953033289, 3852.7880966546827, 4230.302000169968, 4653.488116307203, 4654.743989080599, 4659.534046595347, 4272.850450234227, 4331.740095594275, 4528.162289976365, 4533.795979180944, 4627.652926030544, 3566.5006899034156, 3856.3058649443087, 3883.339832228528, 3916.608339166089, 3918.8628398005935, 4657.930131048037, 5871.2073870027425, 5893.292804863401, 5895.410458954113, 5962.731677074542, 4425.424694789689, 4807.95192048082, 5104.770285337168, 5314.627976041678, 5372.194170874361, 5166.974165129188, 5799.014167591519, 5941.811637672439, 6090.390960903918, 6109.511239100906, 3910.608939106095, 4280.72175308604, 4301.806418711166, 4309.6336811371075, 4323.718958267703, 6446.323136070739, 6807.863842723118, 6957.5129740918155, 6958.47811414146, 6990.580565166107, 3710.4434334849448, 4347.413099231627, 4374.62815660666, 4376.277914144194, 4386.649068074546, 3454.928972018682, 4400.559944005574, 4441.267190913528, 4469.307257375112, 4573.748443835554, 4274.819841880663, 4986.783524626596, 5281.0, 5286.20706893969, 5314.0700377433795, 5808.39011903744, 6597.505187110986, 6600.900986485207, 6623.350659736144, 6636.2368327642935, 1347.9797803032961, 1413.1309244814365, 1423.3452611798482, 1511.2594828533938, 1537.8846586506056, 856.661618660638, 917.1882883648019, 958.7986522830283, 959.9728290728854, 973.9269554783419, 5104.095367044214, 5533.280673512498, 5805.403514033675, 6169.470517087972, 6248.9062664060075, 5941.989861723518, 6249.9062514062325, 6348.079528468346, 6860.5540639858245, 6868.690908909011, 5897.52819774417, 6147.600405973598, 6160.0, 6168.414000669929, 6177.4749146322165, 3503.5095086687884, 3580.3555360035443, 3590.6588874056924, 3606.206634540397, 3609.6209897960334, 6510.381513756186, 6736.1916570010935, 7048.118985126859, 7068.222495525488, 7132.893006604905, 6487.61074335532, 6895.069165662571, 6897.3447522485285, 6963.79108626742, 6989.4408447324095, 6757.8648427031185, 6854.9657251713425, 7024.01663767073, 7089.397401220954, 7109.289071093056, 6769.830754231184, 6807.21717002551, 6824.123366074369, 6833.753966865699, 6860.187323197465, 6232.376762323732, 6324.778632747832, 6682.2649508555, 6685.164354455693, 6719.563228390139, 6036.456718895321, 6242.250929888442, 7034.929650703428, 7182.0, 7193.424526037799, 3544.858205671744, 4411.977940110279, 4430.645548356189, 4436.645068394456, 4443.155800397914, 6695.0292207628645, 6819.488538359544, 6821.965890170517, 6846.760363387258, 6875.518713689994, 6609.966950165219, 6654.367835055662, 6680.966595166993, 6699.799006029827, 6700.865982680417, 5305.142811616166, 5555.361133469541, 5800.854978625568, 6662.733490660319, 6691.631960242039, 5258.6581872178185, 6149.325043606045, 6441.871162576628, 6493.902591461227, 6521.413072823469, 6236.563440559117, 6254.499640028877, 6306.9684651576445, 6656.73373065072, 6692.631905245258, 6294.782495727782, 6469.676516174079, 6514.0, 6519.543631945908, 6561.967190164019], "value": 4700.419965002557, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.8219671786976, 730.6200775596686, 742.662088749619, 757.3600307739957, 778.8052986753308, 14506.92746536267, 15006.249687515621, 15086.924565377185, 15162.090274583532, 15172.772408413868, 13894.096883702552, 13950.860491395082, 14609.78085328721, 15270.694586108271, 15362.69274614507, 916.8258030974127, 919.7838507950627, 920.742192186189, 922.7139586728102, 928.707457150997, 708.9291070892921, 751.5265382808823, 899.9875140466975, 902.1429641840245, 938.3384713776805, 925.1211349218236, 925.9444433333988, 937.7280588629324, 970.9029097090305, 974.541965276319, 951.3435729346728, 963.5375019990408, 964.4261664309724, 966.7824739433642, 969.0116081596802, 688.8622275544911, 689.3657834792003, 693.7537174303101, 715.5277516838861, 727.4907564704728, 15290.770638440432, 15453.768193477106, 15653.530394088195, 15695.215239237992, 15913.522594322074, 9688.806223875483, 12389.0, 12428.937855310665, 12444.875551244462, 12479.875201247962, 10031.448270345129, 10035.548400322003, 10047.346922450017, 10133.442660653662, 10259.487025648688, 3232.595925509311, 3449.6722811332884, 3459.39460594395, 3558.430651095838, 3644.3622366086092, 81384.18615813825, 82935.68257269701, 83624.58187709084, 83626.0, 84448.0, 9314.72055838326, 9315.903921617582, 9318.487483188354, 9371.718848434557, 9405.670801521914, 20956.895215523826, 20985.79014209869, 20990.0, 21178.152873884872, 21405.35783926485, 6934.133233345832, 7149.285071492809, 7313.89029164563, 7417.480776345712, 7443.0, 3940.5862384449792, 3993.900152496211, 3999.8000099995465, 4012.859549915739, 4020.979895100506, 3579.803110828929, 3637.0907273181706, 3704.5739739929713, 3705.184859330943, 3753.6434038766274, 581.1399129288592, 655.88194125057, 665.6571865489277, 666.9799906002828, 674.8245456181428, 495.2274451855117, 546.8359492152339, 567.4609121334748, 614.2690198663576, 626.0, 6638.402543771083, 7484.47608667399, 7909.525428474195, 7935.206479352134, 8121.715739949073, 433.3954133983076, 529.9019681358884, 594.349187639534, 602.5420680283016, 606.8604221029188, 3062.8973569514956, 3824.320582301502, 3830.674392676598, 3939.743916645466, 3941.1132495188353, 77536.61231693806, 77702.22297777062, 78646.0, 78985.21014789894, 80257.19742802613, 50432.0, 66499.33500665028, 67008.0, 68407.3159268411, 68852.655736722, 61660.0, 61974.76050479055, 62207.37792622016, 62249.0, 62719.74560508764, 6429.906915824415, 7063.929360706327, 7472.40220782347, 7775.300222979959, 7919.643616037177, 31177.441127943057, 38453.4231986526, 38572.80713596414, 38703.61296387113, 39135.0, 50826.74586627043, 55897.16154257608, 56208.718956404955, 57053.42946570481, 57223.849853513384, 9635.518224088908, 9713.174380177481, 9799.314048016571, 9863.865655449716, 9987.950060249652, 10484.21368397358, 10587.947060264649, 10613.991670791262, 10847.511861966388, 10927.344359338465, 10049.899501004897, 10093.0, 10129.442880641636, 10397.896021039693, 10947.781044379228, 10253.0, 10262.281640285108, 10418.635347763095, 10433.21750868703, 10704.839427408438, 9864.704058878246, 10017.899821001696, 10946.835797462885, 11582.247153934968, 11775.76448471043, 9331.906680933103, 9406.529673516434, 9493.0, 9600.519974001412, 9635.22918166559, 9525.936735311958, 9553.761155971157, 9635.0, 9749.610015599297, 9847.359921605073], "value": 6578.222134351266, "unit": "score"}], "name": "dromaeo_css", "value": 7227.032503387345, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 106.0, 117.0, 116.0, 119.0, 129.0, 127.0, 171.0, 164.0, 114.0], "value": 127.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 123.0, 144.0, 165.0, 120.0, 146.0, 144.0, 121.0, 178.0, 129.0], "value": 141.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 193.0, 209.0, 231.0, 250.0, 280.0, 193.0, 198.0, 201.0, 193.0], "value": 214.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 102.0, 107.0, 167.0, 56.0, 57.0, 56.0, 60.0, 130.0, 66.0], "value": 86.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 135.0, 88.0, 80.0, 82.0, 119.0, 81.0, 115.0, 148.0], "value": 100.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 121.0, 93.0, 85.0, 93.0, 76.0, 76.0, 96.0, 109.0, 128.0], "value": 101.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 100.0, 95.0, 97.0, 150.0, 95.0, 96.0, 89.0, 151.0, 136.0], "value": 110.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 91.0, 90.0, 149.0, 122.0, 92.0, 125.0, 146.0, 105.0], "value": 111.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 75.0, 57.0, 55.0, 58.0, 59.0, 57.0, 73.0, 60.0, 57.0], "value": 60.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 71.0, 70.0, 75.0, 71.0, 66.0, 66.0, 68.0, 66.0], "value": 68.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 84.0, 85.0, 87.0, 90.0, 90.0, 88.0, 91.0, 79.0, 86.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 148.0, 144.0, 144.0, 145.0, 147.0, 145.0, 144.0, 200.0, 181.0], "value": 154.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 190.0, 147.0, 225.0, 226.0, 216.0, 173.0, 171.0, 172.0], "value": 186.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 71.0, 69.0, 71.0, 94.0, 100.0, 98.0, 67.0, 70.0], "value": 78.1, "unit": "score"}], "name": "kraken", "value": 1628.6, "alertThreshold": 2.0}]} 05:38:33 INFO - Return code: 0 05:38:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:38:33 ERROR - # TBPL SUCCESS # 05:38:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:38:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:38:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:38:33 INFO - 2016-04-11 05:38:33.858 screenresolution[1681:10671] starting screenresolution argv=screenresolution get 05:38:33 INFO - 2016-04-11 05:38:33.861 screenresolution[1681:10671] Display 0: 1600x1200x32@60 05:38:33 INFO - 2016-04-11 05:38:33.867 screenresolution[1682:10674] starting screenresolution argv=screenresolution list 05:38:33 INFO - Available Modes on Display 0 05:38:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:38:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:38:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:38:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:38:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:38:34 INFO - Intel Iris: 05:38:34 INFO - Chipset Model: Intel Iris 05:38:34 INFO - Type: GPU 05:38:34 INFO - Bus: Built-In 05:38:34 INFO - VRAM (Dynamic, Max): 1536 MB 05:38:34 INFO - Vendor: Intel (0x8086) 05:38:34 INFO - Device ID: 0x0a2e 05:38:34 INFO - Revision ID: 0x0009 05:38:34 INFO - Displays: 05:38:34 INFO - Display: 05:38:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:38:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:38:34 INFO - Display Serial Number: 1600x1200 60 05:38:34 INFO - Main Display: Yes 05:38:34 INFO - Mirror: Off 05:38:34 INFO - Online: Yes 05:38:34 INFO - Rotation: Supported 05:38:34 INFO - Return code: 0 05:38:34 INFO - Running post-action listener: _resource_record_post_action 05:38:34 INFO - Running post-run listener: _resource_record_post_run 05:38:35 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 38712832; Write bytes: 697874944; Read time: 404; Write time: 1902 05:38:35 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 381649408; Write bytes: 375719424; Read time: 28294; Write time: 699 05:38:35 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 36910592; Write bytes: 302576640; Read time: 384; Write time: 1166 05:38:35 INFO - Running post-run listener: _upload_blobber_files 05:38:35 INFO - Blob upload gear active. 05:38:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:38:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:38:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:38:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:38:35 INFO - (blobuploader) - INFO - Open directory for files ... 05:38:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:38:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:38:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:37 INFO - (blobuploader) - INFO - Done attempting. 05:38:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:38:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:38:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:38 INFO - (blobuploader) - INFO - Done attempting. 05:38:38 INFO - (blobuploader) - INFO - Iteration through files over. 05:38:38 INFO - Return code: 0 05:38:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:38:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:38:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c9b17d765053eaa899beac95aa870a9ec0b9dc09e967308c30f324e5ee2acd6d92503679bed3aad4764c4f8053159075b78209e43c91513d6687a7b01b66ac8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f35cf422181addfd74e3d2ead2841a3d3fcaa9bd663b215e77680847d8abfd79e37e5afe304ab570b3e038c8d08aff1d6c938dbd41a6a2d2ae0a27a6327ed632"} 05:38:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:38:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:38:38 INFO - Contents: 05:38:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c9b17d765053eaa899beac95aa870a9ec0b9dc09e967308c30f324e5ee2acd6d92503679bed3aad4764c4f8053159075b78209e43c91513d6687a7b01b66ac8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f35cf422181addfd74e3d2ead2841a3d3fcaa9bd663b215e77680847d8abfd79e37e5afe304ab570b3e038c8d08aff1d6c938dbd41a6a2d2ae0a27a6327ed632"} 05:38:38 INFO - Running post-run listener: copy_logs_to_upload_dir 05:38:38 INFO - Copying logs to upload dir... 05:38:38 INFO - mkdir: /builds/slave/test/build/upload/logs 05:38:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.346579 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-11 05:38:38.916360) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 05:38:38.920183) ========= 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.tINXrG2yLU/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.46deX5RbO7/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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/7c9b17d765053eaa899beac95aa870a9ec0b9dc09e967308c30f324e5ee2acd6d92503679bed3aad4764c4f8053159075b78209e43c91513d6687a7b01b66ac8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f35cf422181addfd74e3d2ead2841a3d3fcaa9bd663b215e77680847d8abfd79e37e5afe304ab570b3e038c8d08aff1d6c938dbd41a6a2d2ae0a27a6327ed632"} build_url:https://queue.taskcluster.net/v1/task/eEBwAGbBTeyhjtrT5or2_A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011175 build_url: 'https://queue.taskcluster.net/v1/task/eEBwAGbBTeyhjtrT5or2_A/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/7c9b17d765053eaa899beac95aa870a9ec0b9dc09e967308c30f324e5ee2acd6d92503679bed3aad4764c4f8053159075b78209e43c91513d6687a7b01b66ac8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f35cf422181addfd74e3d2ead2841a3d3fcaa9bd663b215e77680847d8abfd79e37e5afe304ab570b3e038c8d08aff1d6c938dbd41a6a2d2ae0a27a6327ed632"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 05:38:38.978486) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 05:38:38.978764) ========= 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.tINXrG2yLU/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.46deX5RbO7/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.005124 ========= master_lag: 0.12 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 05:38:39.101569) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 05:38:39.101891) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 05:38:39.102234) ========= ========= Total master_lag: 0.38 =========