builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0006 starttime: 1456151182.67 results: success (0) buildid: 20160222030212 builduid: c4c5afe0268442618a2d2c650e205c99 revision: e1cf617a1f2813b6cd66f460313a61c223406c9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:22.669374) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:22.669796) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:22.670118) ========= 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.wockmgXgdS/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.RaQn455aTw/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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.005766 basedir: '/builds/slave/test' ========= master_lag: 0.13 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:22.807159) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:22.807473) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:23.277256) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:23.277531) ========= 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.wockmgXgdS/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.RaQn455aTw/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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.005473 ========= master_lag: 0.14 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:23.420181) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:23.420478) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:23.420881) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:23.421189) ========= 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.wockmgXgdS/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.RaQn455aTw/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-22 06:26:23-- 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% 141M=0s 2016-02-22 06:26:24 (141 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.690350 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:24.202148) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:24.202467) ========= 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.wockmgXgdS/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.RaQn455aTw/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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.019384 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:24.282113) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-22 06:26:24.282474) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e1cf617a1f2813b6cd66f460313a61c223406c9b --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 e1cf617a1f2813b6cd66f460313a61c223406c9b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wockmgXgdS/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.RaQn455aTw/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-22 06:26:24,362 truncating revision to first 12 chars 2016-02-22 06:26:24,362 Setting DEBUG logging. 2016-02-22 06:26:24,362 attempt 1/10 2016-02-22 06:26:24,362 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e1cf617a1f28?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-22 06:26:25,422 unpacking tar archive at: mozilla-central-e1cf617a1f28/testing/mozharness/ program finished with exit code 0 elapsedTime=1.310274 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-22 06:26:25.611120) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:25.611493) ========= echo e1cf617a1f2813b6cd66f460313a61c223406c9b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e1cf617a1f2813b6cd66f460313a61c223406c9b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wockmgXgdS/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.RaQn455aTw/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 e1cf617a1f2813b6cd66f460313a61c223406c9b program finished with exit code 0 elapsedTime=0.005181 script_repo_revision: 'e1cf617a1f2813b6cd66f460313a61c223406c9b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:25.661710) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:25.662067) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:25.675981) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-02-22 06:26:25.676414) ========= /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.wockmgXgdS/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.RaQn455aTw/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 06:26:25 INFO - MultiFileLogger online at 20160222 06:26:25 in /builds/slave/test 06:26:25 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 06:26:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:26:25 INFO - {'append_to_log': False, 06:26:25 INFO - 'base_work_dir': '/builds/slave/test', 06:26:25 INFO - 'blob_upload_branch': 'Firefox', 06:26:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:26:25 INFO - 'branch': 'Firefox', 06:26:25 INFO - 'buildbot_json_path': 'buildprops.json', 06:26:25 INFO - 'config_files': ('talos/mac_config.py',), 06:26:25 INFO - 'default_actions': ('clobber', 06:26:25 INFO - 'read-buildbot-config', 06:26:25 INFO - 'download-and-extract', 06:26:25 INFO - 'populate-webroot', 06:26:25 INFO - 'create-virtualenv', 06:26:25 INFO - 'install', 06:26:25 INFO - 'run-tests'), 06:26:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:26:25 INFO - 'download_minidump_stackwalk': True, 06:26:25 INFO - 'download_symbols': 'ondemand', 06:26:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:26:25 INFO - 'tooltool.py': '/tools/tooltool.py', 06:26:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:26:25 INFO - '/tools/misc-python/virtualenv.py')}, 06:26:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:26:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:26:25 INFO - 'installer_path': 'installer.exe', 06:26:25 INFO - 'log_level': 'info', 06:26:25 INFO - 'log_name': 'talos', 06:26:25 INFO - 'log_to_console': True, 06:26:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:26:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:26:25 INFO - 'opt_config_files': (), 06:26:25 INFO - 'pip_index': False, 06:26:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:26:25 INFO - 'cmd': ('bash', 06:26:25 INFO - '-c', 06:26:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:26:25 INFO - 'enabled': True, 06:26:25 INFO - 'halt_on_failure': False, 06:26:25 INFO - 'name': 'check_screen_resolution'},), 06:26:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:26:25 INFO - 'cmd': ('bash', 06:26:25 INFO - '-c', 06:26:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:26:25 INFO - 'enabled': True, 06:26:25 INFO - 'halt_on_failure': False, 06:26:25 INFO - 'name': 'check_screen_resolution'},), 06:26:25 INFO - 'run_cmd_checks_enabled': True, 06:26:25 INFO - 'sps_profile': False, 06:26:25 INFO - 'sps_profile_interval': 0, 06:26:25 INFO - 'suite': 'dromaeojs-e10s', 06:26:25 INFO - 'system_bits': '32', 06:26:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:26:25 INFO - 'title': 't-yosemite-r7-0006', 06:26:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:26:25 INFO - 'use_talos_json': True, 06:26:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:26:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:26:25 INFO - 'work_dir': 'build'} 06:26:25 INFO - ##### 06:26:25 INFO - ##### Running clobber step. 06:26:25 INFO - ##### 06:26:25 INFO - Running pre-action listener: _resource_record_pre_action 06:26:25 INFO - Running main action method: clobber 06:26:25 INFO - rmtree: /builds/slave/test/build 06:26:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:26:26 INFO - Running post-action listener: _resource_record_post_action 06:26:26 INFO - ##### 06:26:26 INFO - ##### Running read-buildbot-config step. 06:26:26 INFO - ##### 06:26:26 INFO - Running pre-action listener: _resource_record_pre_action 06:26:26 INFO - Running main action method: read_buildbot_config 06:26:26 INFO - Using buildbot properties: 06:26:26 INFO - { 06:26:26 INFO - "project": "", 06:26:26 INFO - "product": "firefox", 06:26:26 INFO - "script_repo_revision": "production", 06:26:26 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 06:26:26 INFO - "repository": "", 06:26:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 06:26:26 INFO - "buildid": "20160222030212", 06:26:26 INFO - "stage_platform": "macosx64", 06:26:26 INFO - "basedir": "/builds/slave/test", 06:26:26 INFO - "nightly_build": "True", 06:26:26 INFO - "buildnumber": 180, 06:26:26 INFO - "slavename": "t-yosemite-r7-0006", 06:26:26 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 06:26:26 INFO - "platform": "yosemite_r7", 06:26:26 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:26:26 INFO - "branch": "mozilla-central", 06:26:26 INFO - "repo_path": "mozilla-central", 06:26:26 INFO - "revision": "e1cf617a1f2813b6cd66f460313a61c223406c9b", 06:26:26 INFO - "pgo_build": "False", 06:26:26 INFO - "builduid": "c4c5afe0268442618a2d2c650e205c99", 06:26:26 INFO - "slavebuilddir": "test" 06:26:26 INFO - } 06:26:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 06:26:26 INFO - Running post-action listener: _resource_record_post_action 06:26:26 INFO - ##### 06:26:26 INFO - ##### Running download-and-extract step. 06:26:26 INFO - ##### 06:26:26 INFO - Running pre-action listener: _resource_record_pre_action 06:26:26 INFO - Running main action method: download_and_extract 06:26:26 INFO - mkdir: /builds/slave/test/build/tests 06:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26:26 INFO - https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:26:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/test_packages.json 06:26:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/test_packages.json 06:26:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:26:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:26:32 INFO - Downloaded 1277 bytes. 06:26:32 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:26:32 INFO - Using the following test package requirements: 06:26:32 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:26:32 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:26:32 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 06:26:32 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:26:32 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 06:26:32 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:26:32 INFO - u'jsshell-mac.zip'], 06:26:32 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:26:32 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 06:26:32 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:26:32 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:26:32 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 06:26:32 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:26:32 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 06:26:32 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:26:32 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 06:26:32 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:26:32 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:26:32 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 06:26:32 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:26:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26:32 INFO - https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:26:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:26:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:26:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:26:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:26:33 INFO - Downloaded 17825439 bytes. 06:26:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:26:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:26:37 INFO - Return code: 0 06:26:37 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:26:37 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')]} 06:26:37 INFO - https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:26:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:26:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:26:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:26:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:26:44 INFO - Downloaded 17825439 bytes. 06:26:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:26:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:26:47 INFO - Return code: 0 06:26: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')]} 06:26:47 INFO - https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:26:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 06:26:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 06:26:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 06:26:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:26:48 INFO - Downloaded 10707015 bytes. 06:26:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:26:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:26:48 INFO - Return code: 0 06:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26:48 INFO - https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:26:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:26:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:26:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 06:26:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 06:26:54 INFO - Downloaded 111382499 bytes. 06:26:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:26:54 INFO - mkdir: /builds/slave/test/properties 06:26:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:26:54 INFO - Writing to file /builds/slave/test/properties/build_url 06:26:54 INFO - Contents: 06:26:54 INFO - build_url:https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:26:55 INFO - Running post-action listener: _resource_record_post_action 06:26:55 INFO - Running post-action listener: set_extra_try_arguments 06:26:55 INFO - ##### 06:26:55 INFO - ##### Running populate-webroot step. 06:26:55 INFO - ##### 06:26:55 INFO - Running pre-action listener: _resource_record_pre_action 06:26:55 INFO - Running main action method: populate_webroot 06:26:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:26:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:26:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:26:55 INFO - '--tppagecycles', 06:26:55 INFO - '7'], 06:26:55 INFO - 'tests': ['tsvgm']}}, 06:26:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:26:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:26:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:26:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:26:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:26:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:26:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:26:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:55 INFO - 'talos_options': ['--e10s'], 06:26:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:26:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:55 INFO - 'tests': ['damp', 'tps']}, 06:26:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:55 INFO - 'talos_options': ['--e10s'], 06:26:55 INFO - 'tests': ['damp', 'tps']}, 06:26:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:26:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:26:55 INFO - 'other': {'tests': ['a11yr', 06:26:55 INFO - 'ts_paint', 06:26:55 INFO - 'tpaint', 06:26:55 INFO - 'sessionrestore', 06:26:55 INFO - 'sessionrestore_no_auto_restore']}, 06:26:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:26:55 INFO - 'tests': ['a11yr', 06:26:55 INFO - 'ts_paint', 06:26:55 INFO - 'tpaint', 06:26:55 INFO - 'sessionrestore', 06:26:55 INFO - 'sessionrestore_no_auto_restore']}, 06:26:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:26:55 INFO - 'tests': ['a11yr', 06:26:55 INFO - 'ts_paint', 06:26:55 INFO - 'tpaint', 06:26:55 INFO - 'sessionrestore', 06:26:55 INFO - 'sessionrestore_no_auto_restore']}, 06:26:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:26:55 INFO - 'tests': ['a11yr', 06:26:55 INFO - 'ts_paint', 06:26:55 INFO - 'tpaint', 06:26:55 INFO - 'sessionrestore', 06:26:55 INFO - 'sessionrestore_no_auto_restore']}, 06:26:55 INFO - 'other_l64': {'tests': ['a11yr', 06:26:55 INFO - 'ts_paint', 06:26:55 INFO - 'tpaint', 06:26:55 INFO - 'sessionrestore', 06:26:55 INFO - 'sessionrestore_no_auto_restore']}, 06:26:55 INFO - 'other_nol64': {'tests': ['a11yr', 06:26:55 INFO - 'ts_paint', 06:26:55 INFO - 'tpaint', 06:26:55 INFO - 'sessionrestore', 06:26:55 INFO - 'sessionrestore_no_auto_restore']}, 06:26:55 INFO - 'svgr': {'tests': ['tsvgx', 06:26:55 INFO - 'tsvgr_opacity', 06:26:55 INFO - 'tart', 06:26:55 INFO - 'tscrollx', 06:26:55 INFO - 'cart']}, 06:26:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:26:55 INFO - 'tests': ['tsvgx', 06:26:55 INFO - 'tsvgr_opacity', 06:26:55 INFO - 'tart', 06:26:55 INFO - 'tscrollx', 06:26:55 INFO - 'cart']}, 06:26:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:55 INFO - 'tests': ['tp5o']}, 06:26:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:55 INFO - 'talos_options': ['--e10s'], 06:26:55 INFO - 'tests': ['tp5o']}, 06:26:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:55 INFO - 'talos_options': ['--xperf_path', 06:26:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:26:55 INFO - 'tests': ['tp5n']}, 06:26:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:55 INFO - 'talos_options': ['--e10s', 06:26:55 INFO - '--xperf_path', 06:26:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:26:55 INFO - 'tests': ['tp5n']}}, 06:26:55 INFO - 'talos.zip': {'path': '', 06:26:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:26:55 INFO - Running post-action listener: _resource_record_post_action 06:26:55 INFO - ##### 06:26:55 INFO - ##### Running create-virtualenv step. 06:26:55 INFO - ##### 06:26:55 INFO - Running pre-action listener: _resource_record_pre_action 06:26:55 INFO - Running main action method: create_virtualenv 06:26:55 INFO - Creating virtualenv /builds/slave/test/build/venv 06:26:55 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 06:26:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:26:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:26:55 INFO - Using real prefix '/tools/python27' 06:26:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:26:56 INFO - Installing distribute.............................................................................................................................................................................................done. 06:26:59 INFO - Installing pip.................done. 06:26:59 INFO - Return code: 0 06:26:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:26: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')]} 06:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26: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')]} 06:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d69ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6a24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e9587600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d53fd30>, '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 0x10d363db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d536b20>, '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.wockmgXgdS/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.RaQn455aTw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 06:26: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', 'pip>=1.5'] in /builds/slave/test/build 06:26: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 pip>=1.5 06:26:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wockmgXgdS/Render', 06:26:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:26:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:26:59 INFO - 'HOME': '/Users/cltbld', 06:26:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:26:59 INFO - 'LOGNAME': 'cltbld', 06:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:59 INFO - 'MOZ_NO_REMOTE': '1', 06:26:59 INFO - 'NO_EM_RESTART': '1', 06:26:59 INFO - 'PAGER': '/bin/cat', 06:26:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:26:59 INFO - 'PWD': '/builds/slave/test', 06:26:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:26:59 INFO - 'SHELL': '/bin/bash', 06:26:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RaQn455aTw/Listeners', 06:26:59 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 06:26:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:26:59 INFO - 'USER': 'cltbld', 06:26:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:26:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:59 INFO - 'XPC_FLAGS': '0x0', 06:26:59 INFO - 'XPC_SERVICE_NAME': '0', 06:26:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:59 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 06:26:59 INFO - Cleaning up... 06:26:59 INFO - Return code: 0 06:26:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:26: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')]} 06:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26: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')]} 06:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26: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', '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 0x10d69ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6a24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e9587600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d53fd30>, '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 0x10d363db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d536b20>, '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.wockmgXgdS/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.RaQn455aTw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 06:26: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', 'psutil>=0.7.1'] in /builds/slave/test/build 06:26: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 psutil>=0.7.1 06:26:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wockmgXgdS/Render', 06:26:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:26:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:26:59 INFO - 'HOME': '/Users/cltbld', 06:26:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:26:59 INFO - 'LOGNAME': 'cltbld', 06:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:59 INFO - 'MOZ_NO_REMOTE': '1', 06:26:59 INFO - 'NO_EM_RESTART': '1', 06:26:59 INFO - 'PAGER': '/bin/cat', 06:26:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:26:59 INFO - 'PWD': '/builds/slave/test', 06:26:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:26:59 INFO - 'SHELL': '/bin/bash', 06:26:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RaQn455aTw/Listeners', 06:26:59 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 06:26:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:26:59 INFO - 'USER': 'cltbld', 06:26:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:26:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:59 INFO - 'XPC_FLAGS': '0x0', 06:26:59 INFO - 'XPC_SERVICE_NAME': '0', 06:26:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:59 INFO - Downloading/unpacking psutil>=0.7.1 06:26: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 06:26: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 06:26: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 06:26: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 06:26: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 06:26: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 06:27:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:27:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:27:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:27:02 INFO - Installing collected packages: psutil 06:27:02 INFO - Running setup.py install for psutil 06:27:03 INFO - building 'psutil._psutil_osx' extension 06:27:03 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 06:27:03 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 06:27:03 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 06:27:03 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 06:27:03 INFO - building 'psutil._psutil_posix' extension 06:27:03 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 06:27:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:27:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:27:03 INFO - ^ 06:27:03 INFO - 1 warning generated. 06:27:03 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 06:27:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:27:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:27:03 INFO - Successfully installed psutil 06:27:03 INFO - Cleaning up... 06:27:03 INFO - Return code: 0 06:27:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d69ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6a24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e9587600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d53fd30>, '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 0x10d363db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d536b20>, '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.wockmgXgdS/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.RaQn455aTw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 06:27:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:27:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wockmgXgdS/Render', 06:27:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:03 INFO - 'HOME': '/Users/cltbld', 06:27:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:03 INFO - 'LOGNAME': 'cltbld', 06:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:03 INFO - 'MOZ_NO_REMOTE': '1', 06:27:03 INFO - 'NO_EM_RESTART': '1', 06:27:03 INFO - 'PAGER': '/bin/cat', 06:27:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:03 INFO - 'PWD': '/builds/slave/test', 06:27:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:03 INFO - 'SHELL': '/bin/bash', 06:27:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RaQn455aTw/Listeners', 06:27:03 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 06:27:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:03 INFO - 'USER': 'cltbld', 06:27:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:03 INFO - 'XPC_FLAGS': '0x0', 06:27:03 INFO - 'XPC_SERVICE_NAME': '0', 06:27:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:27:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:27:06 INFO - Installing collected packages: mozsystemmonitor 06:27:06 INFO - Running setup.py install for mozsystemmonitor 06:27:06 INFO - Successfully installed mozsystemmonitor 06:27:06 INFO - Cleaning up... 06:27:06 INFO - Return code: 0 06:27:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:27:06 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')]} 06:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:06 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')]} 06:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:06 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 0x10d69ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6a24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e9587600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d53fd30>, '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 0x10d363db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d536b20>, '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.wockmgXgdS/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.RaQn455aTw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 06:27:06 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 06:27:06 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 06:27:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wockmgXgdS/Render', 06:27:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:06 INFO - 'HOME': '/Users/cltbld', 06:27:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:06 INFO - 'LOGNAME': 'cltbld', 06:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:06 INFO - 'MOZ_NO_REMOTE': '1', 06:27:06 INFO - 'NO_EM_RESTART': '1', 06:27:06 INFO - 'PAGER': '/bin/cat', 06:27:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:06 INFO - 'PWD': '/builds/slave/test', 06:27:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:06 INFO - 'SHELL': '/bin/bash', 06:27:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RaQn455aTw/Listeners', 06:27:06 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 06:27:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:06 INFO - 'USER': 'cltbld', 06:27:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:06 INFO - 'XPC_FLAGS': '0x0', 06:27:06 INFO - 'XPC_SERVICE_NAME': '0', 06:27:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:06 INFO - Downloading/unpacking blobuploader==1.2.4 06:27: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 06:27: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 06:27: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 06:27: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 06:27: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 06:27: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 06:27:09 INFO - Downloading blobuploader-1.2.4.tar.gz 06:27:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:27:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:27:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:10 INFO - Downloading docopt-0.6.1.tar.gz 06:27:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:27:10 INFO - Installing collected packages: blobuploader, requests, docopt 06:27:10 INFO - Running setup.py install for blobuploader 06:27:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:27:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:27:10 INFO - Running setup.py install for requests 06:27:11 INFO - Running setup.py install for docopt 06:27:11 INFO - Successfully installed blobuploader requests docopt 06:27:11 INFO - Cleaning up... 06:27:11 INFO - Return code: 0 06:27:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:27:11 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')]} 06:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:11 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')]} 06:27:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:11 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 0x10d69ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6a24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e9587600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d53fd30>, '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 0x10d363db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d536b20>, '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.wockmgXgdS/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.RaQn455aTw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 06:27:11 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 06:27:11 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 06:27:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wockmgXgdS/Render', 06:27:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:11 INFO - 'HOME': '/Users/cltbld', 06:27:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:11 INFO - 'LOGNAME': 'cltbld', 06:27:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:11 INFO - 'MOZ_NO_REMOTE': '1', 06:27:11 INFO - 'NO_EM_RESTART': '1', 06:27:11 INFO - 'PAGER': '/bin/cat', 06:27:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:11 INFO - 'PWD': '/builds/slave/test', 06:27:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:11 INFO - 'SHELL': '/bin/bash', 06:27:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RaQn455aTw/Listeners', 06:27:11 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 06:27:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:11 INFO - 'USER': 'cltbld', 06:27:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:11 INFO - 'XPC_FLAGS': '0x0', 06:27:11 INFO - 'XPC_SERVICE_NAME': '0', 06:27:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:27:11 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-FdC8SS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:27:11 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-NokxJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:27:11 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-VaLQnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:27:11 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-BjnPc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:27:12 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-t_PFyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:27:12 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-1TKXsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:27:12 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-_O49Vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:27:12 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-u_lPjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:27:12 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-nCCbzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:27:12 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-e35VoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:27:12 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-UAqVO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:27:12 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-13I50M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:27:12 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-NYLbWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:27:12 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-HwTp__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:13 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-3vid8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:27:13 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-5MSdjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:27:13 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-xLhbMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:27:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:27:13 INFO - Running setup.py install for manifestparser 06:27:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:27:13 INFO - Running setup.py install for mozcrash 06:27:13 INFO - Running setup.py install for mozdebug 06:27:13 INFO - Running setup.py install for mozdevice 06:27:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:27:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:27:14 INFO - Running setup.py install for mozfile 06:27:14 INFO - Running setup.py install for mozhttpd 06:27:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:27:14 INFO - Running setup.py install for mozinfo 06:27:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:27:14 INFO - Running setup.py install for mozInstall 06:27:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:27:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:27:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:27:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:27:14 INFO - Running setup.py install for mozleak 06:27:14 INFO - Running setup.py install for mozlog 06:27:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:27:14 INFO - Running setup.py install for moznetwork 06:27:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:27:15 INFO - Running setup.py install for mozprocess 06:27:15 INFO - Running setup.py install for mozprofile 06:27:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:27:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:27:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:27:15 INFO - Running setup.py install for mozrunner 06:27:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:27:15 INFO - Running setup.py install for mozscreenshot 06:27:15 INFO - Running setup.py install for moztest 06:27:15 INFO - Running setup.py install for mozversion 06:27:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:27:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:27:15 INFO - Cleaning up... 06:27:15 INFO - Return code: 0 06:27:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:27:15 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')]} 06:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:15 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')]} 06:27:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:15 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 0x10d69ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6a24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e9587600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d53fd30>, '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 0x10d363db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d536b20>, '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.wockmgXgdS/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.RaQn455aTw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 06:27:15 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 06:27:15 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 06:27:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wockmgXgdS/Render', 06:27:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:15 INFO - 'HOME': '/Users/cltbld', 06:27:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:15 INFO - 'LOGNAME': 'cltbld', 06:27:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:15 INFO - 'MOZ_NO_REMOTE': '1', 06:27:15 INFO - 'NO_EM_RESTART': '1', 06:27:15 INFO - 'PAGER': '/bin/cat', 06:27:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:15 INFO - 'PWD': '/builds/slave/test', 06:27:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:15 INFO - 'SHELL': '/bin/bash', 06:27:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RaQn455aTw/Listeners', 06:27:15 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 06:27:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:15 INFO - 'USER': 'cltbld', 06:27:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:15 INFO - 'XPC_FLAGS': '0x0', 06:27:15 INFO - 'XPC_SERVICE_NAME': '0', 06:27:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:27:16 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-fxbUZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:27:16 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)) 06:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:27:16 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-b_Q46P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:27:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:27:16 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-N08_5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:27:16 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)) 06:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:27:16 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-9mrq1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:27:16 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)) 06:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:27:16 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-5nOyi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:27:16 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)) 06:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:27:16 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-1bEBoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:27:16 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)) 06:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:27:16 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-lvYI8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:27:16 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)) 06:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:27:16 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-gdsGYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:27:17 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)) 06:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:27:17 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-0XdkQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:27:17 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)) 06:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:27:17 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-_fbQfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:27:17 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)) 06:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:27:17 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-2GmrLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:27:17 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)) 06:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:27:17 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-YFhvKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:27:17 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)) 06:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:27:17 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-jnI2Zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:27:17 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)) 06:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:27:17 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-HIzLet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:27:17 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)) 06:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:17 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-WOXcGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:17 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)) 06:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:27:17 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-MtWu2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:27:17 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)) 06:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:27:17 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-Y96hV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:27:18 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)) 06:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:27:18 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)) 06:27:18 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)) 06:27:18 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)) 06:27:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:27: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 06:27: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 06:27: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 06:27: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 06:27: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 06:27: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 06:27:20 INFO - Downloading blessings-1.6.tar.gz 06:27:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:27:20 INFO - Installing collected packages: blessings 06:27:20 INFO - Running setup.py install for blessings 06:27:20 INFO - Successfully installed blessings 06:27:20 INFO - Cleaning up... 06:27:20 INFO - Return code: 0 06:27:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:27:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:27:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:27:21 INFO - Reading from file tmpfile_stdout 06:27:21 INFO - Current package versions: 06:27:21 INFO - blessings == 1.6 06:27:21 INFO - blobuploader == 1.2.4 06:27:21 INFO - docopt == 0.6.1 06:27:21 INFO - manifestparser == 1.1 06:27:21 INFO - mozInstall == 1.12 06:27:21 INFO - mozcrash == 0.16 06:27:21 INFO - mozdebug == 0.1 06:27:21 INFO - mozdevice == 0.48 06:27:21 INFO - mozfile == 1.2 06:27:21 INFO - mozhttpd == 0.7 06:27:21 INFO - mozinfo == 0.9 06:27:21 INFO - mozleak == 0.1 06:27:21 INFO - mozlog == 3.1 06:27:21 INFO - moznetwork == 0.27 06:27:21 INFO - mozprocess == 0.22 06:27:21 INFO - mozprofile == 0.28 06:27:21 INFO - mozrunner == 6.11 06:27:21 INFO - mozscreenshot == 0.1 06:27:21 INFO - mozsystemmonitor == 0.0 06:27:21 INFO - moztest == 0.7 06:27:21 INFO - mozversion == 1.4 06:27:21 INFO - psutil == 3.1.1 06:27:21 INFO - requests == 1.2.3 06:27:21 INFO - wsgiref == 0.1.2 06:27:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:27: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')]} 06:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27: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')]} 06:27:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:21 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 0x10d69ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6a24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e9587600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d53fd30>, '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 0x10d363db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d536b20>, '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.wockmgXgdS/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.RaQn455aTw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 06:27:21 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 06:27:21 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 06:27:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wockmgXgdS/Render', 06:27:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:21 INFO - 'HOME': '/Users/cltbld', 06:27:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:21 INFO - 'LOGNAME': 'cltbld', 06:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:21 INFO - 'MOZ_NO_REMOTE': '1', 06:27:21 INFO - 'NO_EM_RESTART': '1', 06:27:21 INFO - 'PAGER': '/bin/cat', 06:27:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:21 INFO - 'PWD': '/builds/slave/test', 06:27:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:21 INFO - 'SHELL': '/bin/bash', 06:27:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RaQn455aTw/Listeners', 06:27:21 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 06:27:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:21 INFO - 'USER': 'cltbld', 06:27:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:21 INFO - 'XPC_FLAGS': '0x0', 06:27:21 INFO - 'XPC_SERVICE_NAME': '0', 06:27:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:21 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)) 06:27:21 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)) 06:27:21 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)) 06:27:21 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)) 06:27:21 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)) 06:27:21 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)) 06:27:21 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)) 06:27:21 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)) 06:27:21 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)) 06:27:21 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)) 06:27:21 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)) 06:27:21 INFO - Cleaning up... 06:27:21 INFO - Return code: 0 06:27:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:27: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')]} 06:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27: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')]} 06:27:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d69ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6a24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e9587600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d53fd30>, '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 0x10d363db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d536b20>, '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.wockmgXgdS/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.RaQn455aTw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 06:27: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', 'jsonschema'] in /builds/slave/test/build 06:27: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 jsonschema 06:27:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wockmgXgdS/Render', 06:27:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:21 INFO - 'HOME': '/Users/cltbld', 06:27:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:21 INFO - 'LOGNAME': 'cltbld', 06:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:21 INFO - 'MOZ_NO_REMOTE': '1', 06:27:21 INFO - 'NO_EM_RESTART': '1', 06:27:21 INFO - 'PAGER': '/bin/cat', 06:27:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:21 INFO - 'PWD': '/builds/slave/test', 06:27:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:21 INFO - 'SHELL': '/bin/bash', 06:27:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RaQn455aTw/Listeners', 06:27:21 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 06:27:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:21 INFO - 'USER': 'cltbld', 06:27:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:21 INFO - 'XPC_FLAGS': '0x0', 06:27:21 INFO - 'XPC_SERVICE_NAME': '0', 06:27:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:21 INFO - Downloading/unpacking jsonschema 06:27: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 06:27: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 06:27: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 06:27: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 06:27: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 06:27: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 06:27:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:27:23 INFO - Downloading/unpacking functools32 (from jsonschema) 06:27: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 06:27: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 06:27: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 06:27: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 06:27: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 06:27: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 06:27:24 INFO - Downloading functools32-3.2.3-2.tar.gz 06:27:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:27:24 INFO - warning: no files found matching '*.txt' 06:27:24 INFO - no previously-included directories found matching 'build' 06:27:24 INFO - no previously-included directories found matching 'dist' 06:27:24 INFO - no previously-included directories found matching '.git*' 06:27:24 INFO - Installing collected packages: jsonschema, functools32 06:27:24 INFO - Running setup.py install for functools32 06:27:24 INFO - warning: no files found matching '*.txt' 06:27:24 INFO - no previously-included directories found matching 'build' 06:27:24 INFO - no previously-included directories found matching 'dist' 06:27:24 INFO - no previously-included directories found matching '.git*' 06:27:24 INFO - Successfully installed jsonschema functools32 06:27:24 INFO - Cleaning up... 06:27:24 INFO - Return code: 0 06:27:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:27:24 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')]} 06:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:24 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')]} 06:27:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:24 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 0x10d69ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6a24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e9587600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d53fd30>, '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 0x10d363db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d536b20>, '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.wockmgXgdS/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.RaQn455aTw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 06:27:24 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 06:27:24 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 06:27:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wockmgXgdS/Render', 06:27:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:24 INFO - 'HOME': '/Users/cltbld', 06:27:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:24 INFO - 'LOGNAME': 'cltbld', 06:27:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:24 INFO - 'MOZ_NO_REMOTE': '1', 06:27:24 INFO - 'NO_EM_RESTART': '1', 06:27:24 INFO - 'PAGER': '/bin/cat', 06:27:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:24 INFO - 'PWD': '/builds/slave/test', 06:27:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:24 INFO - 'SHELL': '/bin/bash', 06:27:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RaQn455aTw/Listeners', 06:27:24 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 06:27:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:24 INFO - 'USER': 'cltbld', 06:27:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:24 INFO - 'XPC_FLAGS': '0x0', 06:27:24 INFO - 'XPC_SERVICE_NAME': '0', 06:27:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:24 INFO - Downloading/unpacking flake8 06:27: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 06:27: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 06:27: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 06:27: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 06:27: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 06:27: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 06:27:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:27:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:27:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:27:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:27:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:27:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:27:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:27:28 INFO - no previously-included directories found matching 'docs/_build' 06:27:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:27:28 INFO - Running setup.py install for pep8 06:27:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:27:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:27:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:27:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:27:28 INFO - no previously-included directories found matching 'docs/_build' 06:27:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:27:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:27:28 INFO - Cleaning up... 06:27:28 INFO - Return code: 0 06:27:28 INFO - Running post-action listener: _resource_record_post_action 06:27:28 INFO - Running post-action listener: _start_resource_monitoring 06:27:28 INFO - Starting resource monitoring. 06:27:28 INFO - ##### 06:27:28 INFO - ##### Running install step. 06:27:28 INFO - ##### 06:27:28 INFO - Running pre-action listener: _resource_record_pre_action 06:27:28 INFO - Running main action method: install 06:27:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:27:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:27:29 INFO - Reading from file tmpfile_stdout 06:27:29 INFO - Detecting whether we're running mozinstall >=1.0... 06:27:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:27:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:27:29 INFO - Reading from file tmpfile_stdout 06:27:29 INFO - Output received: 06:27:29 INFO - Usage: mozinstall [options] installer 06:27:29 INFO - Options: 06:27:29 INFO - -h, --help show this help message and exit 06:27:29 INFO - -d DEST, --destination=DEST 06:27:29 INFO - Directory to install application into. [default: 06:27:29 INFO - "/builds/slave/test"] 06:27:29 INFO - --app=APP Application being installed. [default: firefox] 06:27:29 INFO - mkdir: /builds/slave/test/build/application 06:27:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:27:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:28:03 INFO - Reading from file tmpfile_stdout 06:28:03 INFO - Output received: 06:28:03 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 06:28:03 INFO - Running post-action listener: _resource_record_post_action 06:28:03 INFO - ##### 06:28:03 INFO - ##### Running run-tests step. 06:28:03 INFO - ##### 06:28:03 INFO - Running pre-action listener: _resource_record_pre_action 06:28:03 INFO - Running main action method: run_tests 06:28:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:28:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:28:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:28:03 INFO - 2016-02-22 06:28:03.788 screenresolution[6232:101920] starting screenresolution argv=screenresolution get 06:28:03 INFO - 2016-02-22 06:28:03.790 screenresolution[6232:101920] Display 0: 1600x1200x32@60 06:28:03 INFO - 2016-02-22 06:28:03.795 screenresolution[6233:101922] starting screenresolution argv=screenresolution list 06:28:03 INFO - Available Modes on Display 0 06:28:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:28:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:28:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:28:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:28:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:28:04 INFO - Intel Iris: 06:28:04 INFO - Chipset Model: Intel Iris 06:28:04 INFO - Type: GPU 06:28:04 INFO - Bus: Built-In 06:28:04 INFO - VRAM (Dynamic, Max): 1536 MB 06:28:04 INFO - Vendor: Intel (0x8086) 06:28:04 INFO - Device ID: 0x0a2e 06:28:04 INFO - Revision ID: 0x0009 06:28:04 INFO - Displays: 06:28:04 INFO - Display: 06:28:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:28:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:28:04 INFO - Display Serial Number: 1600x1200 60 06:28:04 INFO - Main Display: Yes 06:28:04 INFO - Mirror: Off 06:28:04 INFO - Online: Yes 06:28:04 INFO - Rotation: Supported 06:28:04 INFO - Return code: 0 06:28:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:28:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:28:04 INFO - Python 2.7.3 06:28:04 INFO - Return code: 0 06:28:04 INFO - grabbing minidump binary from tooltool 06:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:04 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d53fd30>, '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 0x10d363db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d536b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:28:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:28:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:28:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:28:04 INFO - Return code: 0 06:28:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:28:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:28:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:28:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:28:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:28:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:28:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:28:05 INFO - Return code: 0 06:28:05 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/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0006', '--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 06:28:05 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/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0006 --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 06:28:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wockmgXgdS/Render', 06:28:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:05 INFO - 'HOME': '/Users/cltbld', 06:28:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:05 INFO - 'LOGNAME': 'cltbld', 06:28:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:28:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:28:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:05 INFO - 'MOZ_NO_REMOTE': '1', 06:28:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:28:05 INFO - 'NO_EM_RESTART': '1', 06:28:05 INFO - 'PAGER': '/bin/cat', 06:28:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:05 INFO - 'PWD': '/builds/slave/test', 06:28:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:28:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:05 INFO - 'SHELL': '/bin/bash', 06:28:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RaQn455aTw/Listeners', 06:28:05 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 06:28:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:05 INFO - 'USER': 'cltbld', 06:28:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:05 INFO - 'XPC_FLAGS': '0x0', 06:28:05 INFO - 'XPC_SERVICE_NAME': '0', 06:28:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:05 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/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0006', '--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 06:28:05 INFO - mozversion application_buildid: 20160222030212 06:28:05 INFO - mozversion application_changeset: e1cf617a1f2813b6cd66f460313a61c223406c9b 06:28:05 INFO - mozversion application_display_name: Nightly 06:28:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:28:05 INFO - mozversion application_name: Firefox 06:28:05 INFO - mozversion application_remotingname: firefox 06:28:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:28:05 INFO - mozversion application_vendor: Mozilla 06:28:05 INFO - mozversion application_version: 47.0a1 06:28:05 INFO - mozversion platform_buildid: 20160222030212 06:28:05 INFO - mozversion platform_changeset: e1cf617a1f2813b6cd66f460313a61c223406c9b 06:28:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:28:05 INFO - mozversion platform_version: 47.0a1 06:28:05 INFO - using testdate: 1456151285 06:28:05 INFO - actual date: 1456151285 06:28:05 INFO - starting webserver on 'localhost:57173' 06:28:05 INFO - SUITE-START | Running 2 tests 06:28:05 INFO - TEST-START | dromaeo_css 06:28:05 INFO - operating with platform_type : mac_ 06:28:05 INFO - Initialising browser for dromaeo_css test... 06:28:06 INFO - TEST-INFO | started process 6251 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmp4fyY7S/profile http://localhost:57173/getInfo.html) 06:28:08 INFO - PROCESS | 6251 | __metrics Screen width/height:1600/1200 06:28:08 INFO - PROCESS | 6251 | colorDepth:24 06:28:08 INFO - PROCESS | 6251 | Browser inner width/height: 1024/689 06:28:08 INFO - PROCESS | 6251 | __metrics 06:28:08 ERROR - PROCESS | 6251 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 06:28:09 INFO - TEST-INFO | 6251: exit 0 06:28:09 INFO - Browser initialized. 06:28:09 INFO - Running cycle 1/1 for dromaeo_css test... 06:28:09 INFO - TEST-INFO | started process 6257 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmp4fyY7S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:28:21 INFO - PROCESS | 6257 | RSS: Main: 256393216 06:28:21 INFO - PROCESS | 6257 | 06:29:11 INFO - PROCESS | 6257 | 1456151351399 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] 06:31:23 INFO - PROCESS | 6257 | Cycle 1(1): loaded http://localhost:57173/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57173/tests/dromaeo/cssquery-ext.html) 06:31:24 INFO - PROCESS | 6257 | RSS: Main: 268144640 06:31:24 INFO - PROCESS | 6257 | 06:34:26 INFO - PROCESS | 6257 | Cycle 1(1): loaded http://localhost:57173/tests/dromaeo/cssquery-ext.html (next: http://localhost:57173/tests/dromaeo/cssquery-jquery.html) 06:34:26 INFO - PROCESS | 6257 | RSS: Main: 281526272 06:34:26 INFO - PROCESS | 6257 | 06:37:28 INFO - PROCESS | 6257 | Cycle 1(1): loaded http://localhost:57173/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57173/tests/dromaeo/cssquery-mootools.html) 06:37:29 INFO - PROCESS | 6257 | RSS: Main: 282484736 06:37:29 INFO - PROCESS | 6257 | 06:40:30 INFO - PROCESS | 6257 | Cycle 1(1): loaded http://localhost:57173/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57173/tests/dromaeo/cssquery-prototype.html) 06:40:31 INFO - PROCESS | 6257 | RSS: Main: 283975680 06:40:31 INFO - PROCESS | 6257 | 06:43:34 INFO - PROCESS | 6257 | Cycle 1(1): loaded http://localhost:57173/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57173/tests/dromaeo/cssquery-yui.html) 06:43:34 INFO - PROCESS | 6257 | RSS: Main: 285880320 06:43:34 INFO - PROCESS | 6257 | 06:46:37 INFO - PROCESS | 6257 | Cycle 1(1): loaded http://localhost:57173/tests/dromaeo/cssquery-yui.html (next: http://localhost:57173/tests/dromaeo/cssquery-dojo.html) 06:46:37 INFO - PROCESS | 6257 | RSS: Main: 289021952 06:46:37 INFO - PROCESS | 6257 | 06:46:37 INFO - PROCESS | 6257 | __start_tp_report 06:46:37 INFO - PROCESS | 6257 | _x_x_mozilla_page_load 06:46:37 INFO - PROCESS | 6257 | _x_x_mozilla_page_load_details 06:46:37 INFO - PROCESS | 6257 | |i|pagename|runs| 06:46:37 INFO - PROCESS | 6257 | |0;dojo.html;3508.5789705235366;3539.4690796380523;3556.7865928044334;3593.1196856770093;3596.1728802375446;5752.194692743009;5813.796517121901;5814.09881468372;5820.505257053151;5840.153177789229;5253.763580638871;5476.26070480485;5777.364489906107;5849.327327357355;5990.460858522732;5220.477952204768;5280.339957505312;5282.973585132088;5303.098473259555;5337.386200586924;5317.9202311965355;5354.22363757255;5354.839354819343;5372.274742909716;5387.811426600069;3915.706322025831;5204.739763011853;5311.1502159654465;5332.68003919766;5356.4375740547075;5235.057689615867;5294.047071527124;5294.602904782157;5317.73411329432;5346.385165705955;5230.8692282692855;5280.947190528084;5285.894282114336;5305.177697456862;5323;5564.387917329091;5644;5700.971495142498;5716.085426331767;5753.194552762575;6114.875284800343;6182.598131121463;6231.844203894893;6283.088952101965;6359.332270111618;5308.522232999048;6124.938750612481;6228.5951413158;6306.3378345274;6313.337099604521;5908.320543137551;5943.762249510014;5948.2862056553495;5960.493358064569;5974.4921681657115;6195.380461953769;6289.528285378615;6346.968265158737;6368.140301059298;6370.936290637127;5461.535769459561;6163.753449861955;6245.063240513869;6284.842878927972;6291.433770960635;5148.665336753174;6262.436380725757;6282.151909492251;6282.591631543935;6297.149884765498;6225.750969961151;6282.717277722513;6295.527835412362;6299.842503937347;6311.084892690534;6136.110264011693;6242.094896240111;6254.655993920287;6297.244330680348;6301.684915754194;4622.352870598119;4863.878403039952;4945.134601444733;4985.175583664817;5016.44819069902;4427.623651989553;4435.6895017349125;4468.352088947085;4476.552344765498;4507.526709695435;5861.589688721749;5900.085486749561;5900.1739756434135;5903.586748927534;5917.822465326047;6200.658963756947;6245.219347581552;6254.468370188585;6259.843503912348;6271.560990730696;5843.444872737083;5870.823875283749;5874.823755287348;5891.646501209942;5938.168656388109;5356.678599283978;5447.673139611636;5487.478689524489;5503.807366742145;5504.174373843875;6277.2781130170615;6422.229332480132;6455.9677201613695;6457.192850893638;6478.2550006749825;6192.287886893065;6272;6275.905861411991;6284.717187726655;6289;6248.812535623939;6322.841928951813;6428.710708018244;6464.127342808661;6490;6195.1636529068;6249.1563638908165;6257.030160325156;6296.370362963667;6302.558820882494;5063.936573319645;5840.737166827588;6280.277768056732;6298.338674439301;6317.305096439296;5449.945500544944;6075.422834830684;6131.417515336036;6186.628802271878;6203.875922481435;5388.706710389557;5942.435468630473;6044.818655440344;6205.813825585059;6221.657808820558;5157.613179011514;5680.602357835077;5922.970385148046;6034.336223015553;6098.451139397298;6126.6398181747245;6219.129321894848;6222.62664240147;6227.470664993526;6239.688015599111;6084.269887613515;6087.147799308189;6096.116063170904;6149.446549810538;6171.876562468815 06:46:37 INFO - PROCESS | 6257 | |1;ext.html;435.790820406205;481.1027433835897;490.42865062202526;558.3718316893495;593.8456001439624;37198.62801371989;37628.87113386603;37680.811595942054;37697.81151094244;37792.622073779254;38889.833305000895;39226.607733922654;39291.80354098233;39357.60642393575;39480;9384.81230375392;9606.327557071008;9612.951935240313;9621.182199513014;9641.035896410338;9494.477803720793;9637.951810240938;9643.903560964405;9690.32167748258;9699.03009699028;9617.711468655916;9665.565049572786;9672.129508344247;9688.321817472744;9718.222542196643;9595.184409325217;9678.27412944032;9682.661106861226;9686.70939871805;9756.024397560222;9323.207527360182;9457.054294570557;9457.19613832825;9478.004809495042;9492.098250666175;38148.237035259415;38225.279862406256;38381;38386;38428;3148.323110531224;3237.2877966847254;3401.1157099154398;3568.3220188164164;3762.097096696773;28730.712692873014;28850.845966161327;29184.978525751496;29206.269843253875;29623;2733.1527226559633;2777.9305517362227;2794.203651959202;2970.7177818107243;2975.598294230273;507668;511719;511791;512801;513011;45274.09451810945;45688.543114569096;45700.771496142974;51956;66423.33576664267;37152.62847371546;44642.33036504455;44922.55077449249;45003.77498112489;45325.093498129856;15339;15367.231638418258;15463.613409664847;15609.843901560838;15611.453599123975;12068.456919438646;12245.265284082983;12306.81539776904;12415.813762793565;12443.191192572454;12120.75758484843;13130.737385252241;13770.104943178661;14756.926215369069;15034.323455444532;6124.265088189357;6386.680665966776;6398.744050238031;6430.7106180222;6442.77450289247;838.3293365307729;914.3096961793804;978.9657361992296;989.7129832348683;1073.7798751255973;29696.851515742284;29916.850415747784;30528.7788488458;30529.69470305313;31073.68926310753;1053.0995998421392;1067.2635881241918;1095.446799366315;1113.7494063835572;1195.8505186851644;13376.063675542813;14054.85945140556;14492.202928839015;14502.347394367278;14834.184119873295;154469;155972;157099;157588;157878;47977.28034079492;57129.714351427974;57921;58294.7085264571;58356.4164358351;1286.691194113406;1468.1631470061961;1479.9186044767425;1495.185124107386;1496.1920562895914;23490.295291141294;28483.28791780222;28491.857540712164;28969.56545651859;29082.854585726935;49532.25701614551;49646.50353496419;50096.74951625219;50152.749236253585;50308.74845625748;471961;478353.6082319566;478761;479259;479589;33339.49990750189;33710.157246069044;44045.898852528946;45517.77241113773;45682.771586143186;34792.652073478945;42878.35682464828;42940;43010.784946075066;43045.311906618095;36442.27115457729;36802.89591312265;37744.433833491974;38052.809735951145;38495;36563;36602.26795464129;37187.6281237195;37191;37240.25519489649;36826.447603286506;37308.440373394966;37552.24895502129;38743;38926;31040.84479577678;33293.33413331671;33666.83166584151;33757.49363759496;33791.831040845624;24797.380065498506;24957.376065598506;24975.250742477754;25315.74684253134;25389.365265868502 06:46:37 INFO - PROCESS | 6257 | |2;jquery.html;364.4551395663485;369.700542560526;373.1175769305592;374.2197518174606;374.51687323352877;15610.063396196236;16372.672546549062;19253.614927701456;19766.209351625937;20867.060982255796;19626.901865490654;19811.801881981177;19845.603087938234;19976;20104.9947502625;5597.132444471114;5623.831285061434;5758.337791154029;5803.303603567578;5864.149698293745;5683.8579035524235;5744.16709577111;5757.568182386317;5791.478766910977;5817.069268916975;5004.674696144739;5659.405762394951;5708.8858222835515;5745.5116315113055;5752.050911599581;5191.325127733389;5747.683877386742;5772.509336706406;5779.971100144472;5797.188393624896;4713.457952335457;5545.085060964976;5566.137248726453;5584.944150558483;5719.6854173020465;13502.122362046533;13717.794233086512;18403.35588254418;25381.873090634614;25447.363815904566;2194.692743015979;2450.399652085233;2490.427201743591;2804.2708895687065;2822.9272876306873;8638.956805215996;9486.667966621204;9767.609295628166;9825.754356141082;10278.794424111551;1623.4399132299338;1716.828317168273;1717.4160785333047;1736.5050960476203;1768.5843826700716;101268;104428;106240.46879765629;115787;116514;9659.9034009659;10535.789284214272;11641.88358116408;11667;11677.591284305008;10304.845427318596;13093.410796513988;13623.386947587382;13854.86145138556;13864.168149911038;7294.869295259244;7835.177306382861;8426.494410335277;8447.53538555373;8517.57412129391;8571.271441927382;8577.785555361166;8594.183552562497;8647.783805404915;8725.432846864933;4391.692581519263;4433.512313645497;4498.3252512123445;4502.4371953505815;4516.412866327357;1897.8102189781187;1912.5218695326168;1916.8562357823218;1930.9613807723767;1959.2456904091741;850.7362717557577;901.197933838884;916.8533034714548;1012.4836333469983;1066.7813098314828;20980.808966716664;21003.369898903056;21271.0428030739;21310.254141104986;21407.892960535097;876.9210771030638;949.5015117063459;976.7313988653035;1031.9019693129142;1042.4839704346398;10391.116755075904;10481.580736770597;10637.787244255072;10719.624813131502;10729.9463502682;555536;601510;627751;653775;672052;113592.43978424909;116813.41593292149;129143;132321;133458.33270833583;1040.3965699894043;1061.5276202089997;1062.3094988257694;1094.874089479704;1099.1591432554103;18417.723734143732;18878.433646990612;19013.524661883563;19227;19469.415917522496;44393.778031109636;50353;52770.20844687256;53856.73071634617;54044.72977635244;71738.64130679313;74721;79636;84614.15385846309;85008;5950.375210602824;7151.463640227108;8029.675103608073;8282.50304981703;8316.62575184106;9592.9040709592;10897.67306980792;13468.461261549428;13514.662133446742;13639.249841258827;11277.887221127683;11810.468528916048;11855.762884742084;11898.821517677416;12110.576129835767;5086.872828179326;6308.905366419599;8189.362127574628;9114.954425227832;11953.462094205956;5687.658740475585;7860.764177074697;10902.291351062155;11013.614523491638;11822.940885295518;8122.472039317426;8270.37972152079;8270.503769773833;8316.62575184106;8381.203785640355;9102.954485227532;11728.179027467995;11885.405729713653;11897.286162830258;11997.64007079789 06:46:37 INFO - PROCESS | 6257 | |3;mootools.html;1506.7363211437996;1517.3323737555475;1740.3734655524008;1881.6048629787736;1885.1328388941085;7828.334591559725;8364.749057528268;8580.442271252372;8819.250363719084;8819.867701984474;8505.872411913826;8521.829563408728;8614.655413783457;8622.784430389227;8641.697540586081;2109.314472796347;2153.655415133579;2414.0343862454984;2451.5832308507506;2458.60662294033;2058.4133521946246;2108.947276318089;2463.581191197492;2474.7401522840114;2503.123906632682;2251.8761468119246;2434.5982912819363;2438.890249938757;2470.0490311230215;2482.900683972639;2437.3419176822335;2442.413820683041;2465.4822487277693;2471.9629205561932;2472.777450029488;2371.537550177716;2486.6145747409;2495.6506089147533;2496.151308555082;2504.912328068527;8583.484990900566;8604.8709269361;8614.655413783441;8617.870731939025;8659.956700216522;4481.126180394825;5441.782328706847;5490.094134467808;5500.532454741312;5524.640898341595;3610.9528236811293;3711.5546134463766;3716.0709822544363;3721.292954338667;3778.2254637799183;928.2342067794096;1045.5504133222712;1062.95216715248;1080.200651517879;1096.5449338524502;11576.53693852245;11592.942035289769;11687.883121168765;11729.120315976335;11736.061115110771;4952.306677065214;4958.479359667255;5003.949960500421;5018.498150185025;5057.140286151363;8625.223729864218;10210.897891020995;10224.284300098921;10247.59009639621;10259.17926565873;5458.317710286215;5465.207544905967;5483.150111732608;5510.972445137749;5525.060739674265;4418.756968366771;4823.686460380064;4870.805167793249;4946.727929963815;4985.52637499437;3950.7036972227197;3954.8615798446917;3999.3601023836627;4012.277789997828;4030.1133750574827;1324.7946568281932;1326.9336533173303;1335.3456806165104;1336.038052602125;1342.704604986921;1323.3118778235264;1326.9004824637998;1328.249539010456;1339.36380219395;1351.3243378310844;7879.251471110236;7979.960100199578;7987.600619968978;8014.599270036475;8129.715459958873;493.47444971106376;512.8871648237382;520.9635325527253;521.0776924843083;521.1947541049088;6177.907331390033;6234.906476402857;6251.874962500816;6257.405546473078;6292.433680968735;10121.291509594257;10437;10460.163186945027;10485.633002844865;10628.14974802014;10135.493225338703;10307.793844123076;10309.484525773682;10361.171106311476;10540.525676344583;8071.919280807117;8160.102388737234;8163.632636531371;8279.54462504556;8375.246227839401;7941.642626081955;7941.722039728582;7999.32005779492;8078.83842323162;8106.351491880753;9349.158575728217;9593.42439453635;9598.280128990215;9688.46713430768;9727.708168754949;9488.288378371511;9621.951890240503;9705.223582113273;9991.200703943521;10139;6766.492513061442;7208.098987626547;7396.815079623052;7411.444141689287;7510.924890751023;8150.2664760171865;8151.144129866516;8156.755297341089;8192.672293108448;8214.917850821415;6120.663363515049;7081.185663648746;7223.313785190398;7327.8534429312185;7371.6314184289495;5998.940010600013;7114.715411383487;7183.20984691694;7257.0565826442225;7299;6078.392160784063;7473.850522989618;7644.579548124907;7731.0336207974005;7743.225677432211;6964.79105626832;6965.547239429624;7024.227334993249;7027.22700502934;7064.222935477196;7148.785536433916;7159.642017899188;7175.784726458214;7178.210396856237;7181.281871812777 06:46:37 INFO - PROCESS | 6257 | |4;prototype.html;281.47504903355235;323.2065279738243;325.7882376455304;333.626338500879;335.75154385754547;5832.38759930207;6564.212294524657;6679.833004174898;6698.330166983299;7002.684879180436;6402.423781859632;6744.156980377453;6810.3189681032;6827.078344423501;6856.760013399532;5024.020316038374;5025.070361983036;5034.219695947116;5034.421041580228;5046.1169295373165;5012.248162775594;5026.773795179226;5030.11972904742;5031.798728050873;5032.9748351258195;4947.604191664658;4959.677620954626;4975.4527002029745;4983.651144419892;4990.900181996358;4720.362751028636;4914.483979182206;4969.9751501242445;4987.850364489072;5005.549500544932;4104.938425923614;4125.195586860564;4140.275451795954;4153.460050193486;4155.688323375729;6360.618362898241;6448.290688024314;6488.90266645996;6500.4799616030605;6515.185601799775;5597.244372009767;5796.942030579725;5807.651540907516;5816.1275808628625;5820.243368362128;7250.891236631454;7255;7257.963710181468;7264.963675181591;7266.346028857428;4606.585407313324;4638.327442520849;4645.837395691168;4652.58126768589;4662.090892276007;6281.905771413387;7651.9234807651765;7750.806229844243;7785.338246249075;7810.726624568113;4459.082594484403;4577;4584.541545845389;4635.536446355338;4709.858704238878;4736.64475164364;4747.928781068286;4748.548887855648;4748.7863046163;4756.239001759702;5666.206731057655;5674.886502269931;5707.6575405475805;5713.314402271754;5717.799877004285;7251.419886409075;7276.527025743309;7293.817654558572;7310.4517161213125;7349.118105827335;1642.9424970125988;1660.800703915538;1665.408779883124;1668.0242058395731;1677.622534929631;1024.1908891975256;1054.536004158168;1064.1912146768357;1074.0280046557878;1079.9892001080045;5583.944160558423;5816.5055970243;6603.910354791406;6778.3221677831825;6854.794356169323;6060.727267272983;7531.849363012709;7554.8866766998535;7561.508501947355;7613.9238607614325;5540.972295138498;6791.830204244933;6825;6849.452043836481;6893.310668933066;3291.8847840325475;3978.781167035841;4004.3192657248337;4008.6191811777835;4015.558288588253;5767.480926716532;7876.291133797986;7878.015248093989;7908.813677948354;7911;7736.535807851435;7783.883241751379;7787.688492460352;7791.142974272825;7808.492447990862;6334.5565810393755;7837.373010159174;7867.881981770278;7890.132085470594;7928.088269848926;6381.234251889803;7263.673134709056;7499.775006749806;7520.09758828944;7525.435592330487;7378.96310518444;7416.96291518539;7423.109226892808;7480.102387713509;7601.619919003917;5728.570357223141;6732.124823772878;7538;7867.134615192439;7913.050433947733;4090.3864420336;4148.69316165407;4239.558550092983;4481.395011673382;4689.390379250675;6057.42454466825;6944.131983502062;7274.127104747464;7405.62971851416;7612.467127301035;7278.526895751759;7332.266773322625;7353.970444137932;7373.152087510005;7388.482806203514;7235.819104522429;7272.41820654357;7310.634468276671;7322.267773222635;7329.780106596811;6423.164988551458;6726.091977583159;7152.892706609301;7161.283871612797;7163.641817909188;6914.204866440424;7248.238934911969;7454.515456495311;7516.210797866145;7532.924670753222;7132.643367831692;7150.320719531636;7162.2121566628675;7175.210726819942;7196.244394338519 06:46:37 INFO - PROCESS | 6257 | |5;yui.html;694.7811439396589;722.9530080544768;724.6521470065678;728.1626129950556;754.6981207516993;15010.249487525622;15040.17279049652;15049.774253386195;15175.317110730017;15197.620059498518;12078.577249796259;13474.93262533686;13675.726485470284;13966.092204006733;14136.646583835409;688.6625553478809;763.3892885691439;872.0625327772638;874.0778478704964;875.9430637008574;751.6918063593928;843.6161546496329;845.3152946113637;862.633380813155;875.7241468937297;900.5632268349846;907.6233363154283;911.2846415563783;914.1772404835634;920.0109881876975;897.9012308646044;905.3255324783013;906.5875026862761;910.0626354854511;913.8309412758628;658.2791842931982;667.436016566001;667.6127845849396;673.0341959288437;676.5399528320739;14661.560153195422;14664.853351466456;14667.413303467849;14727.410903563952;14779.482718104922;12924;13029.34853257343;13039.869601304055;13081.803772943413;13217.14088584239;9801.215902727765;9820.705378838646;9941.602335906555;9950.502474876228;10488.528016239288;3502.5446691929887;3548.591911930135;3615.620359862229;3669.1560940983723;3700.777953322782;83426;83554.58222708848;83594.58202708948;83722.58138709329;84352;9312.441253524674;9549.379290346105;9614.807703846023;9617.23062155026;9628.66299679508;21689;21781.782182178293;21897.562048759253;21913.342599722033;21966.780332196795;7241.203467618558;7270.818229544304;7456.888146677804;7467.58928258951;7503.849923001619;3914.9021274468364;3939.5666476687543;3959.3269144245546;3972.5828787976848;3979.8010099495486;3196.8241746704152;3291.4240007998983;3472.8089955052715;3498.8250587470525;3525;606.9166537730131;645.8579112595315;654.1496055128314;657.8914479110989;670.2325836916704;540.2706346432285;569.564283323258;609.5367520684312;622.3372108704216;623.4918541388754;7353.6323183840595;8237.546934918517;8315.83368332642;8727.214550690469;9044.683436079706;510.89271253037276;520.0664806672032;564.8136115082013;633.4711948492203;636.5512313818747;3985.4221137934837;4058.7564746115327;4074.103697186614;4084.06617975851;4193.916121677549;89095.10904890997;89603.55198223967;89821.55089224513;93441;93485;79503.40993180104;79915;80088;80336.39327213539;81515;46404;64183.99999999907;66169.6766064676;68011.31988680149;68915.96626050613;8021.197880211932;8193.631286591999;8216.876746848922;8230.465019773696;8257.343719552126;34839;48490.757546212044;49749.75125124351;49869.50130498649;50192.74518137076;64146.35853641404;68650.65674671595;70699.29300707133;71078.28921710924;71668;9858.964808695271;10024.899751002396;10086.697399078039;10596.735081623021;11267.830982535104;11843.703907402383;11972.940135299616;12202.633920982385;12648.936755316165;12762.553310634083;11595.014423774073;11682.532698691957;11692.47383867711;11926.284422934652;11988.46051927648;11188.72028199269;11467.369294688539;11586.652400428;11883.821742673694;11947.223430476992;11219.214654974074;11276.718082047686;11319.490622922152;11364;11595.304281743123;9231.446113233227;9325.114114159143;9373.671921482715;9457.385269957706;9473.431594104375;8722.65109395617;9523.142917137491;9573.994730553191;9733;9759.12167904892 06:46:37 INFO - PROCESS | 6257 | __end_tp_report 06:46:37 INFO - PROCESS | 6257 | __start_cc_report 06:46:37 INFO - PROCESS | 6257 | _x_x_mozilla_cycle_collect,346 06:46:37 INFO - PROCESS | 6257 | __end_cc_report 06:46:37 INFO - PROCESS | 6257 | __startTimestamp1456152397640__endTimestamp 06:46:37 INFO - PROCESS | 6257 | 06:46:37 INFO - PROCESS | 6257 | ------- Summary: start ------- 06:46:37 INFO - PROCESS | 6257 | Number of tests: 6 06:46:37 INFO - PROCESS | 6257 | 06:46:37 INFO - PROCESS | 6257 | [#0] dojo.html Cycles:165 Average:5769.36 Median:5948.29 stddev:644.50 (10.8%) stddev-sans-first:621.60 06:46:37 INFO - PROCESS | 6257 | Values: 3508.6 3539.5 3556.8 3593.1 3596.2 5752.2 5813.8 5814.1 5820.5 5840.2 5253.8 5476.3 5777.4 5849.3 5990.5 5220.5 5280.3 5283.0 5303.1 5337.4 5317.9 5354.2 5354.8 5372.3 5387.8 3915.7 5204.7 5311.2 5332.7 5356.4 5235.1 5294.0 5294.6 5317.7 5346.4 5230.9 5280.9 5285.9 5305.2 5323.0 5564.4 5644.0 5701.0 5716.1 5753.2 6114.9 6182.6 6231.8 6283.1 6359.3 5308.5 6124.9 6228.6 6306.3 6313.3 5908.3 5943.8 5948.3 5960.5 5974.5 6195.4 6289.5 6347.0 6368.1 6370.9 5461.5 6163.8 6245.1 6284.8 6291.4 5148.7 6262.4 6282.2 6282.6 6297.1 6225.8 6282.7 6295.5 6299.8 6311.1 6136.1 6242.1 6254.7 6297.2 6301.7 4622.4 4863.9 4945.1 4985.2 5016.4 4427.6 4435.7 4468.4 4476.6 4507.5 5861.6 5900.1 5900.2 5903.6 5917.8 6200.7 6245.2 6254.5 6259.8 6271.6 5843.4 5870.8 5874.8 5891.6 5938.2 5356.7 5447.7 5487.5 5503.8 5504.2 6277.3 6422.2 6456.0 6457.2 6478.3 6192.3 6272.0 6275.9 6284.7 6289.0 6248.8 6322.8 6428.7 6464.1 6490.0 6195.2 6249.2 6257.0 6296.4 6302.6 5063.9 5840.7 6280.3 6298.3 6317.3 5449.9 6075.4 6131.4 6186.6 6203.9 5388.7 5942.4 6044.8 6205.8 6221.7 5157.6 5680.6 5923.0 6034.3 6098.5 6126.6 6219.1 6222.6 6227.5 6239.7 6084.3 6087.1 6096.1 6149.4 6171.9 06:46:37 INFO - PROCESS | 6257 | 06:46:37 INFO - PROCESS | 6257 | [#1] ext.html Cycles:180 Average:53360.70 Median:37922.72 stddev:110792.74 (292.2%) stddev-sans-first:111032.28 06:46:37 INFO - PROCESS | 6257 | Values: 435.8 481.1 490.4 558.4 593.8 37198.6 37628.9 37680.8 37697.8 37792.6 38889.8 39226.6 39291.8 39357.6 39480.0 9384.8 9606.3 9613.0 9621.2 9641.0 9494.5 9638.0 9643.9 9690.3 9699.0 9617.7 9665.6 9672.1 9688.3 9718.2 9595.2 9678.3 9682.7 9686.7 9756.0 9323.2 9457.1 9457.2 9478.0 9492.1 38148.2 38225.3 38381.0 38386.0 38428.0 3148.3 3237.3 3401.1 3568.3 3762.1 28730.7 28850.8 29185.0 29206.3 29623.0 2733.2 2777.9 2794.2 2970.7 2975.6 507668.0 511719.0 511791.0 512801.0 513011.0 45274.1 45688.5 45700.8 51956.0 66423.3 37152.6 44642.3 44922.6 45003.8 45325.1 15339.0 15367.2 15463.6 15609.8 15611.5 12068.5 12245.3 12306.8 12415.8 12443.2 12120.8 13130.7 13770.1 14756.9 15034.3 6124.3 6386.7 6398.7 6430.7 6442.8 838.3 914.3 979.0 989.7 1073.8 29696.9 29916.9 30528.8 30529.7 31073.7 1053.1 1067.3 1095.4 1113.7 1195.9 13376.1 14054.9 14492.2 14502.3 14834.2 154469.0 155972.0 157099.0 157588.0 157878.0 47977.3 57129.7 57921.0 58294.7 58356.4 1286.7 1468.2 1479.9 1495.2 1496.2 23490.3 28483.3 28491.9 28969.6 29082.9 49532.3 49646.5 50096.7 50152.7 50308.7 471961.0 478353.6 478761.0 479259.0 479589.0 33339.5 33710.2 44045.9 45517.8 45682.8 34792.7 42878.4 42940.0 43010.8 43045.3 36442.3 36802.9 37744.4 38052.8 38495.0 36563.0 36602.3 37187.6 37191.0 37240.3 36826.4 37308.4 37552.2 38743.0 38926.0 31040.8 33293.3 33666.8 33757.5 33791.8 24797.4 24957.4 24975.3 25315.7 25389.4 06:46:37 INFO - PROCESS | 6257 | 06:46:37 INFO - PROCESS | 6257 | [#2] jquery.html Cycles:180 Average:34883.76 Median:1593.69 stddev:103690.38 (6506.3%) stddev-sans-first:103948.86 06:46:37 INFO - PROCESS | 6257 | Values: 364.5 369.7 373.1 374.2 374.5 15610.1 16372.7 19253.6 19766.2 20867.1 19626.9 19811.8 19845.6 19976.0 20105.0 5597.1 5623.8 5758.3 5803.3 5864.1 5683.9 5744.2 5757.6 5791.5 5817.1 5004.7 5659.4 5708.9 5745.5 5752.1 5191.3 5747.7 5772.5 5780.0 5797.2 4713.5 5545.1 5566.1 5584.9 5719.7 13502.1 13717.8 18403.4 25381.9 25447.4 2194.7 2450.4 2490.4 2804.3 2822.9 8639.0 9486.7 9767.6 9825.8 10278.8 1623.4 1716.8 1717.4 1736.5 1768.6 101268.0 104428.0 106240.5 115787.0 116514.0 9659.9 10535.8 11641.9 11667.0 11677.6 10304.8 13093.4 13623.4 13854.9 13864.2 7294.9 7835.2 8426.5 8447.5 8517.6 8571.3 8577.8 8594.2 8647.8 8725.4 4391.7 4433.5 4498.3 4502.4 4516.4 1897.8 1912.5 1916.9 1931.0 1959.2 850.7 901.2 916.9 1012.5 1066.8 20980.8 21003.4 21271.0 21310.3 21407.9 876.9 949.5 976.7 1031.9 1042.5 10391.1 10481.6 10637.8 10719.6 10729.9 555536.0 601510.0 627751.0 653775.0 672052.0 113592.4 116813.4 129143.0 132321.0 133458.3 1040.4 1061.5 1062.3 1094.9 1099.2 18417.7 18878.4 19013.5 19227.0 19469.4 44393.8 50353.0 52770.2 53856.7 54044.7 71738.6 74721.0 79636.0 84614.2 85008.0 5950.4 7151.5 8029.7 8282.5 8316.6 9592.9 10897.7 13468.5 13514.7 13639.2 11277.9 11810.5 11855.8 11898.8 12110.6 5086.9 6308.9 8189.4 9115.0 11953.5 5687.7 7860.8 10902.3 11013.6 11822.9 8122.5 8270.4 8270.5 8316.6 8381.2 9103.0 11728.2 11885.4 11897.3 11997.6 06:46:37 INFO - PROCESS | 6257 | 06:46:37 INFO - PROCESS | 6257 | [#3] mootools.html Cycles:180 Average:5972.07 Median:5450.05 stddev:3145.18 (57.7%) stddev-sans-first:3136.09 06:46:37 INFO - PROCESS | 6257 | Values: 1506.7 1517.3 1740.4 1881.6 1885.1 7828.3 8364.7 8580.4 8819.3 8819.9 8505.9 8521.8 8614.7 8622.8 8641.7 2109.3 2153.7 2414.0 2451.6 2458.6 2058.4 2108.9 2463.6 2474.7 2503.1 2251.9 2434.6 2438.9 2470.0 2482.9 2437.3 2442.4 2465.5 2472.0 2472.8 2371.5 2486.6 2495.7 2496.2 2504.9 8583.5 8604.9 8614.7 8617.9 8660.0 4481.1 5441.8 5490.1 5500.5 5524.6 3611.0 3711.6 3716.1 3721.3 3778.2 928.2 1045.6 1063.0 1080.2 1096.5 11576.5 11592.9 11687.9 11729.1 11736.1 4952.3 4958.5 5003.9 5018.5 5057.1 8625.2 10210.9 10224.3 10247.6 10259.2 5458.3 5465.2 5483.2 5511.0 5525.1 4418.8 4823.7 4870.8 4946.7 4985.5 3950.7 3954.9 3999.4 4012.3 4030.1 1324.8 1326.9 1335.3 1336.0 1342.7 1323.3 1326.9 1328.2 1339.4 1351.3 7879.3 7980.0 7987.6 8014.6 8129.7 493.5 512.9 521.0 521.1 521.2 6177.9 6234.9 6251.9 6257.4 6292.4 10121.3 10437.0 10460.2 10485.6 10628.1 10135.5 10307.8 10309.5 10361.2 10540.5 8071.9 8160.1 8163.6 8279.5 8375.2 7941.6 7941.7 7999.3 8078.8 8106.4 9349.2 9593.4 9598.3 9688.5 9727.7 9488.3 9622.0 9705.2 9991.2 10139.0 6766.5 7208.1 7396.8 7411.4 7510.9 8150.3 8151.1 8156.8 8192.7 8214.9 6120.7 7081.2 7223.3 7327.9 7371.6 5998.9 7114.7 7183.2 7257.1 7299.0 6078.4 7473.9 7644.6 7731.0 7743.2 6964.8 6965.5 7024.2 7027.2 7064.2 7148.8 7159.6 7175.8 7178.2 7181.3 06:46:37 INFO - PROCESS | 6257 | 06:46:37 INFO - PROCESS | 6257 | [#4] prototype.html Cycles:180 Average:5846.94 Median:6494.69 stddev:1898.59 (29.2%) stddev-sans-first:1857.39 06:46:37 INFO - PROCESS | 6257 | Values: 281.5 323.2 325.8 333.6 335.8 5832.4 6564.2 6679.8 6698.3 7002.7 6402.4 6744.2 6810.3 6827.1 6856.8 5024.0 5025.1 5034.2 5034.4 5046.1 5012.2 5026.8 5030.1 5031.8 5033.0 4947.6 4959.7 4975.5 4983.7 4990.9 4720.4 4914.5 4970.0 4987.9 5005.5 4104.9 4125.2 4140.3 4153.5 4155.7 6360.6 6448.3 6488.9 6500.5 6515.2 5597.2 5796.9 5807.7 5816.1 5820.2 7250.9 7255.0 7258.0 7265.0 7266.3 4606.6 4638.3 4645.8 4652.6 4662.1 6281.9 7651.9 7750.8 7785.3 7810.7 4459.1 4577.0 4584.5 4635.5 4709.9 4736.6 4747.9 4748.5 4748.8 4756.2 5666.2 5674.9 5707.7 5713.3 5717.8 7251.4 7276.5 7293.8 7310.5 7349.1 1642.9 1660.8 1665.4 1668.0 1677.6 1024.2 1054.5 1064.2 1074.0 1080.0 5583.9 5816.5 6603.9 6778.3 6854.8 6060.7 7531.8 7554.9 7561.5 7613.9 5541.0 6791.8 6825.0 6849.5 6893.3 3291.9 3978.8 4004.3 4008.6 4015.6 5767.5 7876.3 7878.0 7908.8 7911.0 7736.5 7783.9 7787.7 7791.1 7808.5 6334.6 7837.4 7867.9 7890.1 7928.1 6381.2 7263.7 7499.8 7520.1 7525.4 7379.0 7417.0 7423.1 7480.1 7601.6 5728.6 6732.1 7538.0 7867.1 7913.1 4090.4 4148.7 4239.6 4481.4 4689.4 6057.4 6944.1 7274.1 7405.6 7612.5 7278.5 7332.3 7354.0 7373.2 7388.5 7235.8 7272.4 7310.6 7322.3 7329.8 6423.2 6726.1 7152.9 7161.3 7163.6 6914.2 7248.2 7454.5 7516.2 7532.9 7132.6 7150.3 7162.2 7175.2 7196.2 06:46:37 INFO - PROCESS | 6257 | 06:46:37 INFO - PROCESS | 6257 | [#5] yui.html Cycles:180 Average:18146.47 Median:656.02 stddev:25607.70 (3903.5%) stddev-sans-first:25646.01 06:46:37 INFO - PROCESS | 6257 | Values: 694.8 723.0 724.7 728.2 754.7 15010.2 15040.2 15049.8 15175.3 15197.6 12078.6 13474.9 13675.7 13966.1 14136.6 688.7 763.4 872.1 874.1 875.9 751.7 843.6 845.3 862.6 875.7 900.6 907.6 911.3 914.2 920.0 897.9 905.3 906.6 910.1 913.8 658.3 667.4 667.6 673.0 676.5 14661.6 14664.9 14667.4 14727.4 14779.5 12924.0 13029.3 13039.9 13081.8 13217.1 9801.2 9820.7 9941.6 9950.5 10488.5 3502.5 3548.6 3615.6 3669.2 3700.8 83426.0 83554.6 83594.6 83722.6 84352.0 9312.4 9549.4 9614.8 9617.2 9628.7 21689.0 21781.8 21897.6 21913.3 21966.8 7241.2 7270.8 7456.9 7467.6 7503.8 3914.9 3939.6 3959.3 3972.6 3979.8 3196.8 3291.4 3472.8 3498.8 3525.0 606.9 645.9 654.1 657.9 670.2 540.3 569.6 609.5 622.3 623.5 7353.6 8237.5 8315.8 8727.2 9044.7 510.9 520.1 564.8 633.5 636.6 3985.4 4058.8 4074.1 4084.1 4193.9 89095.1 89603.6 89821.6 93441.0 93485.0 79503.4 79915.0 80088.0 80336.4 81515.0 46404.0 64184.0 66169.7 68011.3 68916.0 8021.2 8193.6 8216.9 8230.5 8257.3 34839.0 48490.8 49749.8 49869.5 50192.7 64146.4 68650.7 70699.3 71078.3 71668.0 9859.0 10024.9 10086.7 10596.7 11267.8 11843.7 11972.9 12202.6 12648.9 12762.6 11595.0 11682.5 11692.5 11926.3 11988.5 11188.7 11467.4 11586.7 11883.8 11947.2 11219.2 11276.7 11319.5 11364.0 11595.3 9231.4 9325.1 9373.7 9457.4 9473.4 8722.7 9523.1 9574.0 9733.0 9759.1 06:46:37 INFO - PROCESS | 6257 | -------- Summary: end -------- 06:46:37 INFO - PROCESS | 6257 | 06:46:38 INFO - TEST-INFO | 6257: exit 0 06:46:38 INFO - TEST-OK | dromaeo_css | took 1112194ms 06:46:38 INFO - TEST-START | kraken 06:46:38 INFO - operating with platform_type : mac_ 06:46:38 INFO - Initialising browser for kraken test... 06:46:38 INFO - TEST-INFO | started process 6262 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmpIjtz69/profile http://localhost:57173/getInfo.html) 06:46:41 INFO - PROCESS | 6262 | __metrics Screen width/height:1600/1200 06:46:41 INFO - PROCESS | 6262 | colorDepth:24 06:46:41 INFO - PROCESS | 6262 | Browser inner width/height: 1024/689 06:46:41 INFO - PROCESS | 6262 | __metrics 06:46:41 ERROR - PROCESS | 6262 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 06:46:41 INFO - TEST-INFO | 6262: exit 0 06:46:41 INFO - Browser initialized. 06:46:41 INFO - Running cycle 1/1 for kraken test... 06:46:41 INFO - TEST-INFO | started process 6266 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmpIjtz69/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:46:53 INFO - PROCESS | 6266 | RSS: Main: 255512576 06:46:53 INFO - PROCESS | 6266 | 06:46:56 INFO - PROCESS | 6266 | Cycle 1(1): loaded http://localhost:57173/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57173/tests/kraken/driver.html?testName=audio-beat-detection) 06:46:57 INFO - PROCESS | 6266 | RSS: Main: 268234752 06:46:57 INFO - PROCESS | 6266 | 06:46:59 INFO - PROCESS | 6266 | Cycle 1(1): loaded http://localhost:57173/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57173/tests/kraken/driver.html?testName=audio-dft) 06:47:00 INFO - PROCESS | 6266 | RSS: Main: 277934080 06:47:00 INFO - PROCESS | 6266 | 06:47:03 INFO - PROCESS | 6266 | Cycle 1(1): loaded http://localhost:57173/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57173/tests/kraken/driver.html?testName=audio-fft) 06:47:04 INFO - PROCESS | 6266 | RSS: Main: 280506368 06:47:04 INFO - PROCESS | 6266 | 06:47:12 INFO - PROCESS | 6266 | Cycle 1(1): loaded http://localhost:57173/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57173/tests/kraken/driver.html?testName=audio-oscillator) 06:47:12 INFO - PROCESS | 6266 | RSS: Main: 280936448 06:47:12 INFO - PROCESS | 6266 | 06:47:14 INFO - PROCESS | 6266 | Cycle 1(1): loaded http://localhost:57173/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57173/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:47:15 INFO - PROCESS | 6266 | RSS: Main: 280911872 06:47:15 INFO - PROCESS | 6266 | 06:47:18 INFO - PROCESS | 6266 | Cycle 1(1): loaded http://localhost:57173/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57173/tests/kraken/driver.html?testName=imaging-darkroom) 06:47:19 INFO - PROCESS | 6266 | RSS: Main: 282034176 06:47:19 INFO - PROCESS | 6266 | 06:47:22 INFO - PROCESS | 6266 | Cycle 1(1): loaded http://localhost:57173/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57173/tests/kraken/driver.html?testName=imaging-desaturate) 06:47:22 INFO - PROCESS | 6266 | RSS: Main: 281526272 06:47:22 INFO - PROCESS | 6266 | 06:47:25 INFO - PROCESS | 6266 | Cycle 1(1): loaded http://localhost:57173/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57173/tests/kraken/driver.html?testName=json-parse-financial) 06:47:26 INFO - PROCESS | 6266 | RSS: Main: 281608192 06:47:26 INFO - PROCESS | 6266 | 06:47:27 INFO - PROCESS | 6266 | Cycle 1(1): loaded http://localhost:57173/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57173/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:47:28 INFO - PROCESS | 6266 | RSS: Main: 283590656 06:47:28 INFO - PROCESS | 6266 | 06:47:30 INFO - PROCESS | 6266 | Cycle 1(1): loaded http://localhost:57173/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57173/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:47:30 INFO - PROCESS | 6266 | RSS: Main: 283697152 06:47:30 INFO - PROCESS | 6266 | 06:47:33 INFO - PROCESS | 6266 | Cycle 1(1): loaded http://localhost:57173/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57173/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:47:33 INFO - PROCESS | 6266 | RSS: Main: 281763840 06:47:33 INFO - PROCESS | 6266 | 06:47:36 INFO - PROCESS | 6266 | Cycle 1(1): loaded http://localhost:57173/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57173/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:47:36 INFO - PROCESS | 6266 | RSS: Main: 284172288 06:47:36 INFO - PROCESS | 6266 | 06:47:39 INFO - PROCESS | 6266 | Cycle 1(1): loaded http://localhost:57173/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57173/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:47:40 INFO - PROCESS | 6266 | RSS: Main: 283062272 06:47:40 INFO - PROCESS | 6266 | 06:47:41 INFO - PROCESS | 6266 | Cycle 1(1): loaded http://localhost:57173/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57173/tests/kraken/driver.html?testName=ai-astar) 06:47:42 INFO - PROCESS | 6266 | RSS: Main: 285351936 06:47:42 INFO - PROCESS | 6266 | 06:47:42 INFO - PROCESS | 6266 | __start_tp_report 06:47:42 INFO - PROCESS | 6266 | _x_x_mozilla_page_load 06:47:42 INFO - PROCESS | 6266 | _x_x_mozilla_page_load_details 06:47:42 INFO - PROCESS | 6266 | |i|pagename|runs| 06:47:42 INFO - PROCESS | 6266 | |0;ai-astar;117;109;115;113;114;124;113;115;117;114 06:47:42 INFO - PROCESS | 6266 | |1;audio-beat-detection;157;120;159;186;155;128;132;107;180;152 06:47:42 INFO - PROCESS | 6266 | |2;audio-dft;195;204;199;207;204;213;210;208;205;199 06:47:42 INFO - PROCESS | 6266 | |3;audio-fft;66;67;77;142;48;87;82;87;141;82 06:47:42 INFO - PROCESS | 6266 | |4;audio-oscillator;82;80;117;80;82;86;118;76;95;154 06:47:42 INFO - PROCESS | 6266 | |5;imaging-gaussian-blur;89;93;79;140;132;92;86;92;106;132 06:47:42 INFO - PROCESS | 6266 | |6;imaging-darkroom;115;92;153;153;121;96;96;95;95;96 06:47:42 INFO - PROCESS | 6266 | |7;imaging-desaturate;93;92;104;94;92;93;92;92;90;92 06:47:42 INFO - PROCESS | 6266 | |8;json-parse-financial;57;60;59;56;59;61;65;90;85;86 06:47:42 INFO - PROCESS | 6266 | |9;json-stringify-tinderbox;68;68;67;69;76;73;68;65;65;66 06:47:42 INFO - PROCESS | 6266 | |10;stanford-crypto-aes;91;99;101;103;107;112;112;111;89;92 06:47:42 INFO - PROCESS | 6266 | |11;stanford-crypto-ccm;144;120;134;137;136;128;125;124;130;137 06:47:42 INFO - PROCESS | 6266 | |12;stanford-crypto-pbkdf2;130;141;144;142;144;142;142;147;146;180 06:47:42 INFO - PROCESS | 6266 | |13;stanford-crypto-sha256-iterative;69;70;70;83;102;96;72;69;70;71 06:47:42 INFO - PROCESS | 6266 | __end_tp_report 06:47:42 INFO - PROCESS | 6266 | __start_cc_report 06:47:42 INFO - PROCESS | 6266 | _x_x_mozilla_cycle_collect,883 06:47:42 INFO - PROCESS | 6266 | __end_cc_report 06:47:42 INFO - PROCESS | 6266 | __startTimestamp1456152462111__endTimestamp 06:47:42 INFO - PROCESS | 6266 | 06:47:42 INFO - PROCESS | 6266 | ------- Summary: start ------- 06:47:42 INFO - PROCESS | 6266 | Number of tests: 14 06:47:42 INFO - PROCESS | 6266 | 06:47:42 INFO - PROCESS | 6266 | [#0] ai-astar Cycles:10 Average:115.10 Median:115.00 stddev:3.87 (3.4%) stddev-sans-first:4.04 06:47:42 INFO - PROCESS | 6266 | Values: 117.0 109.0 115.0 113.0 114.0 124.0 113.0 115.0 117.0 114.0 06:47:42 INFO - PROCESS | 6266 | 06:47:42 INFO - PROCESS | 6266 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:156.00 stddev:25.50 (16.3%) stddev-sans-first:26.82 06:47:42 INFO - PROCESS | 6266 | Values: 157.0 120.0 159.0 186.0 155.0 128.0 132.0 107.0 180.0 152.0 06:47:42 INFO - PROCESS | 6266 | 06:47:42 INFO - PROCESS | 6266 | [#2] audio-dft Cycles:10 Average:204.40 Median:206.00 stddev:5.50 (2.7%) stddev-sans-first:4.67 06:47:42 INFO - PROCESS | 6266 | Values: 195.0 204.0 199.0 207.0 204.0 213.0 210.0 208.0 205.0 199.0 06:47:42 INFO - PROCESS | 6266 | 06:47:42 INFO - PROCESS | 6266 | [#3] audio-fft Cycles:10 Average:87.90 Median:79.50 stddev:30.63 (38.5%) stddev-sans-first:31.45 06:47:42 INFO - PROCESS | 6266 | Values: 66.0 67.0 77.0 142.0 48.0 87.0 82.0 87.0 141.0 82.0 06:47:42 INFO - PROCESS | 6266 | 06:47:42 INFO - PROCESS | 6266 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:81.00 stddev:25.13 (31.0%) stddev-sans-first:26.06 06:47:42 INFO - PROCESS | 6266 | Values: 82.0 80.0 117.0 80.0 82.0 86.0 118.0 76.0 95.0 154.0 06:47:42 INFO - PROCESS | 6266 | 06:47:42 INFO - PROCESS | 6266 | [#5] imaging-gaussian-blur Cycles:10 Average:104.10 Median:87.50 stddev:22.24 (25.4%) stddev-sans-first:22.91 06:47:42 INFO - PROCESS | 6266 | Values: 89.0 93.0 79.0 140.0 132.0 92.0 86.0 92.0 106.0 132.0 06:47:42 INFO - PROCESS | 6266 | 06:47:42 INFO - PROCESS | 6266 | [#6] imaging-darkroom Cycles:10 Average:111.20 Median:95.00 stddev:24.02 (25.3%) stddev-sans-first:25.44 06:47:42 INFO - PROCESS | 6266 | Values: 115.0 92.0 153.0 153.0 121.0 96.0 96.0 95.0 95.0 96.0 06:47:42 INFO - PROCESS | 6266 | 06:47:42 INFO - PROCESS | 6266 | [#7] imaging-desaturate Cycles:10 Average:93.40 Median:92.00 stddev:3.86 (4.2%) stddev-sans-first:4.10 06:47:42 INFO - PROCESS | 6266 | Values: 93.0 92.0 104.0 94.0 92.0 93.0 92.0 92.0 90.0 92.0 06:47:42 INFO - PROCESS | 6266 | 06:47:42 INFO - PROCESS | 6266 | [#8] json-parse-financial Cycles:10 Average:67.80 Median:63.00 stddev:13.52 (21.5%) stddev-sans-first:13.77 06:47:42 INFO - PROCESS | 6266 | Values: 57.0 60.0 59.0 56.0 59.0 61.0 65.0 90.0 85.0 86.0 06:47:42 INFO - PROCESS | 6266 | 06:47:42 INFO - PROCESS | 6266 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.00 stddev:3.50 (5.2%) stddev-sans-first:3.71 06:47:42 INFO - PROCESS | 6266 | Values: 68.0 68.0 67.0 69.0 76.0 73.0 68.0 65.0 65.0 66.0 06:47:42 INFO - PROCESS | 6266 | 06:47:42 INFO - PROCESS | 6266 | [#10] stanford-crypto-aes Cycles:10 Average:101.70 Median:100.50 stddev:8.86 (8.8%) stddev-sans-first:8.51 06:47:42 INFO - PROCESS | 6266 | Values: 91.0 99.0 101.0 103.0 107.0 112.0 112.0 111.0 89.0 92.0 06:47:42 INFO - PROCESS | 6266 | 06:47:42 INFO - PROCESS | 6266 | [#11] stanford-crypto-ccm Cycles:10 Average:131.50 Median:135.00 stddev:7.37 (5.5%) stddev-sans-first:6.27 06:47:42 INFO - PROCESS | 6266 | Values: 144.0 120.0 134.0 137.0 136.0 128.0 125.0 124.0 130.0 137.0 06:47:42 INFO - PROCESS | 6266 | 06:47:42 INFO - PROCESS | 6266 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.80 Median:144.00 stddev:12.88 (8.9%) stddev-sans-first:12.33 06:47:42 INFO - PROCESS | 6266 | Values: 130.0 141.0 144.0 142.0 144.0 142.0 142.0 147.0 146.0 180.0 06:47:42 INFO - PROCESS | 6266 | 06:47:42 INFO - PROCESS | 6266 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.20 Median:70.50 stddev:12.28 (17.4%) stddev-sans-first:12.66 06:47:42 INFO - PROCESS | 6266 | Values: 69.0 70.0 70.0 83.0 102.0 96.0 72.0 69.0 70.0 71.0 06:47:42 INFO - PROCESS | 6266 | -------- Summary: end -------- 06:47:42 INFO - PROCESS | 6266 | 06:47:42 INFO - TEST-INFO | 6266: exit 0 06:47:42 INFO - TEST-OK | kraken | took 64767ms 06:47:42 INFO - SUITE-END | took 1176s 06:47:43 INFO - Completed test suite (00:19:37) 06:47:43 INFO - Working with test: dromaeo_css 06:47:43 INFO - Generating results file: dromaeo_css 06:47:43 INFO - Working with test: kraken 06:47:43 INFO - Generating results file: kraken 06:47:43 INFO - javascript benchmark 06:47:43 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:47:43 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 06:47:43 INFO - process_Request line: dromaeo_css 7419.74 graph.html#tests=[[72,1,61]] 06:47:43 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:47:43 INFO - process_Request line: kraken 1553.20 graph.html#tests=[[232,1,61]] 06:47:43 INFO - RETURN: dromaeo_css: 7419.74 06:47:43 INFO - RETURN: kraken: 1553.20 06:47:43 INFO - javascript benchmark 06:47:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3508.5789705235366, 3539.4690796380523, 3556.7865928044334, 3593.1196856770093, 3596.1728802375446, 5752.194692743009, 5813.796517121901, 5814.09881468372, 5820.505257053151, 5840.153177789229, 5253.763580638871, 5476.26070480485, 5777.364489906107, 5849.327327357355, 5990.460858522732, 5220.477952204768, 5280.339957505312, 5282.973585132088, 5303.098473259555, 5337.386200586924, 5317.9202311965355, 5354.22363757255, 5354.839354819343, 5372.274742909716, 5387.811426600069, 3915.706322025831, 5204.739763011853, 5311.1502159654465, 5332.68003919766, 5356.4375740547075, 5235.057689615867, 5294.047071527124, 5294.602904782157, 5317.73411329432, 5346.385165705955, 5230.8692282692855, 5280.947190528084, 5285.894282114336, 5305.177697456862, 5323.0, 5564.387917329091, 5644.0, 5700.971495142498, 5716.085426331767, 5753.194552762575, 6114.875284800343, 6182.598131121463, 6231.844203894893, 6283.088952101965, 6359.332270111618, 5308.522232999048, 6124.938750612481, 6228.5951413158, 6306.3378345274, 6313.337099604521, 5908.320543137551, 5943.762249510014, 5948.2862056553495, 5960.493358064569, 5974.4921681657115, 6195.380461953769, 6289.528285378615, 6346.968265158737, 6368.140301059298, 6370.936290637127, 5461.535769459561, 6163.753449861955, 6245.063240513869, 6284.842878927972, 6291.433770960635, 5148.665336753174, 6262.436380725757, 6282.151909492251, 6282.591631543935, 6297.149884765498, 6225.750969961151, 6282.717277722513, 6295.527835412362, 6299.842503937347, 6311.084892690534, 6136.110264011693, 6242.094896240111, 6254.655993920287, 6297.244330680348, 6301.684915754194, 4622.352870598119, 4863.878403039952, 4945.134601444733, 4985.175583664817, 5016.44819069902, 4427.623651989553, 4435.6895017349125, 4468.352088947085, 4476.552344765498, 4507.526709695435, 5861.589688721749, 5900.085486749561, 5900.1739756434135, 5903.586748927534, 5917.822465326047, 6200.658963756947, 6245.219347581552, 6254.468370188585, 6259.843503912348, 6271.560990730696, 5843.444872737083, 5870.823875283749, 5874.823755287348, 5891.646501209942, 5938.168656388109, 5356.678599283978, 5447.673139611636, 5487.478689524489, 5503.807366742145, 5504.174373843875, 6277.2781130170615, 6422.229332480132, 6455.9677201613695, 6457.192850893638, 6478.2550006749825, 6192.287886893065, 6272.0, 6275.905861411991, 6284.717187726655, 6289.0, 6248.812535623939, 6322.841928951813, 6428.710708018244, 6464.127342808661, 6490.0, 6195.1636529068, 6249.1563638908165, 6257.030160325156, 6296.370362963667, 6302.558820882494, 5063.936573319645, 5840.737166827588, 6280.277768056732, 6298.338674439301, 6317.305096439296, 5449.945500544944, 6075.422834830684, 6131.417515336036, 6186.628802271878, 6203.875922481435, 5388.706710389557, 5942.435468630473, 6044.818655440344, 6205.813825585059, 6221.657808820558, 5157.613179011514, 5680.602357835077, 5922.970385148046, 6034.336223015553, 6098.451139397298, 6126.6398181747245, 6219.129321894848, 6222.62664240147, 6227.470664993526, 6239.688015599111, 6084.269887613515, 6087.147799308189, 6096.116063170904, 6149.446549810538, 6171.876562468815], "unit": "score", "name": "dojo.html", "value": 5731.931881097767}, {"lowerIsBetter": false, "replicates": [435.790820406205, 481.1027433835897, 490.42865062202526, 558.3718316893495, 593.8456001439624, 37198.62801371989, 37628.87113386603, 37680.811595942054, 37697.81151094244, 37792.622073779254, 38889.833305000895, 39226.607733922654, 39291.80354098233, 39357.60642393575, 39480.0, 9384.81230375392, 9606.327557071008, 9612.951935240313, 9621.182199513014, 9641.035896410338, 9494.477803720793, 9637.951810240938, 9643.903560964405, 9690.32167748258, 9699.03009699028, 9617.711468655916, 9665.565049572786, 9672.129508344247, 9688.321817472744, 9718.222542196643, 9595.184409325217, 9678.27412944032, 9682.661106861226, 9686.70939871805, 9756.024397560222, 9323.207527360182, 9457.054294570557, 9457.19613832825, 9478.004809495042, 9492.098250666175, 38148.237035259415, 38225.279862406256, 38381.0, 38386.0, 38428.0, 3148.323110531224, 3237.2877966847254, 3401.1157099154398, 3568.3220188164164, 3762.097096696773, 28730.712692873014, 28850.845966161327, 29184.978525751496, 29206.269843253875, 29623.0, 2733.1527226559633, 2777.9305517362227, 2794.203651959202, 2970.7177818107243, 2975.598294230273, 507668.0, 511719.0, 511791.0, 512801.0, 513011.0, 45274.09451810945, 45688.543114569096, 45700.771496142974, 51956.0, 66423.33576664267, 37152.62847371546, 44642.33036504455, 44922.55077449249, 45003.77498112489, 45325.093498129856, 15339.0, 15367.231638418258, 15463.613409664847, 15609.843901560838, 15611.453599123975, 12068.456919438646, 12245.265284082983, 12306.81539776904, 12415.813762793565, 12443.191192572454, 12120.75758484843, 13130.737385252241, 13770.104943178661, 14756.926215369069, 15034.323455444532, 6124.265088189357, 6386.680665966776, 6398.744050238031, 6430.7106180222, 6442.77450289247, 838.3293365307729, 914.3096961793804, 978.9657361992296, 989.7129832348683, 1073.7798751255973, 29696.851515742284, 29916.850415747784, 30528.7788488458, 30529.69470305313, 31073.68926310753, 1053.0995998421392, 1067.2635881241918, 1095.446799366315, 1113.7494063835572, 1195.8505186851644, 13376.063675542813, 14054.85945140556, 14492.202928839015, 14502.347394367278, 14834.184119873295, 154469.0, 155972.0, 157099.0, 157588.0, 157878.0, 47977.28034079492, 57129.714351427974, 57921.0, 58294.7085264571, 58356.4164358351, 1286.691194113406, 1468.1631470061961, 1479.9186044767425, 1495.185124107386, 1496.1920562895914, 23490.295291141294, 28483.28791780222, 28491.857540712164, 28969.56545651859, 29082.854585726935, 49532.25701614551, 49646.50353496419, 50096.74951625219, 50152.749236253585, 50308.74845625748, 471961.0, 478353.6082319566, 478761.0, 479259.0, 479589.0, 33339.49990750189, 33710.157246069044, 44045.898852528946, 45517.77241113773, 45682.771586143186, 34792.652073478945, 42878.35682464828, 42940.0, 43010.784946075066, 43045.311906618095, 36442.27115457729, 36802.89591312265, 37744.433833491974, 38052.809735951145, 38495.0, 36563.0, 36602.26795464129, 37187.6281237195, 37191.0, 37240.25519489649, 36826.447603286506, 37308.440373394966, 37552.24895502129, 38743.0, 38926.0, 31040.84479577678, 33293.33413331671, 33666.83166584151, 33757.49363759496, 33791.831040845624, 24797.380065498506, 24957.376065598506, 24975.250742477754, 25315.74684253134, 25389.365265868502], "unit": "score", "name": "ext.html", "value": 18419.99115423449}, {"lowerIsBetter": false, "replicates": [364.4551395663485, 369.700542560526, 373.1175769305592, 374.2197518174606, 374.51687323352877, 15610.063396196236, 16372.672546549062, 19253.614927701456, 19766.209351625937, 20867.060982255796, 19626.901865490654, 19811.801881981177, 19845.603087938234, 19976.0, 20104.9947502625, 5597.132444471114, 5623.831285061434, 5758.337791154029, 5803.303603567578, 5864.149698293745, 5683.8579035524235, 5744.16709577111, 5757.568182386317, 5791.478766910977, 5817.069268916975, 5004.674696144739, 5659.405762394951, 5708.8858222835515, 5745.5116315113055, 5752.050911599581, 5191.325127733389, 5747.683877386742, 5772.509336706406, 5779.971100144472, 5797.188393624896, 4713.457952335457, 5545.085060964976, 5566.137248726453, 5584.944150558483, 5719.6854173020465, 13502.122362046533, 13717.794233086512, 18403.35588254418, 25381.873090634614, 25447.363815904566, 2194.692743015979, 2450.399652085233, 2490.427201743591, 2804.2708895687065, 2822.9272876306873, 8638.956805215996, 9486.667966621204, 9767.609295628166, 9825.754356141082, 10278.794424111551, 1623.4399132299338, 1716.828317168273, 1717.4160785333047, 1736.5050960476203, 1768.5843826700716, 101268.0, 104428.0, 106240.46879765629, 115787.0, 116514.0, 9659.9034009659, 10535.789284214272, 11641.88358116408, 11667.0, 11677.591284305008, 10304.845427318596, 13093.410796513988, 13623.386947587382, 13854.86145138556, 13864.168149911038, 7294.869295259244, 7835.177306382861, 8426.494410335277, 8447.53538555373, 8517.57412129391, 8571.271441927382, 8577.785555361166, 8594.183552562497, 8647.783805404915, 8725.432846864933, 4391.692581519263, 4433.512313645497, 4498.3252512123445, 4502.4371953505815, 4516.412866327357, 1897.8102189781187, 1912.5218695326168, 1916.8562357823218, 1930.9613807723767, 1959.2456904091741, 850.7362717557577, 901.197933838884, 916.8533034714548, 1012.4836333469983, 1066.7813098314828, 20980.808966716664, 21003.369898903056, 21271.0428030739, 21310.254141104986, 21407.892960535097, 876.9210771030638, 949.5015117063459, 976.7313988653035, 1031.9019693129142, 1042.4839704346398, 10391.116755075904, 10481.580736770597, 10637.787244255072, 10719.624813131502, 10729.9463502682, 555536.0, 601510.0, 627751.0, 653775.0, 672052.0, 113592.43978424909, 116813.41593292149, 129143.0, 132321.0, 133458.33270833583, 1040.3965699894043, 1061.5276202089997, 1062.3094988257694, 1094.874089479704, 1099.1591432554103, 18417.723734143732, 18878.433646990612, 19013.524661883563, 19227.0, 19469.415917522496, 44393.778031109636, 50353.0, 52770.20844687256, 53856.73071634617, 54044.72977635244, 71738.64130679313, 74721.0, 79636.0, 84614.15385846309, 85008.0, 5950.375210602824, 7151.463640227108, 8029.675103608073, 8282.50304981703, 8316.62575184106, 9592.9040709592, 10897.67306980792, 13468.461261549428, 13514.662133446742, 13639.249841258827, 11277.887221127683, 11810.468528916048, 11855.762884742084, 11898.821517677416, 12110.576129835767, 5086.872828179326, 6308.905366419599, 8189.362127574628, 9114.954425227832, 11953.462094205956, 5687.658740475585, 7860.764177074697, 10902.291351062155, 11013.614523491638, 11822.940885295518, 8122.472039317426, 8270.37972152079, 8270.503769773833, 8316.62575184106, 8381.203785640355, 9102.954485227532, 11728.179027467995, 11885.405729713653, 11897.286162830258, 11997.64007079789], "unit": "score", "name": "jquery.html", "value": 9251.453905547804}, {"lowerIsBetter": false, "replicates": [1506.7363211437996, 1517.3323737555475, 1740.3734655524008, 1881.6048629787736, 1885.1328388941085, 7828.334591559725, 8364.749057528268, 8580.442271252372, 8819.250363719084, 8819.867701984474, 8505.872411913826, 8521.829563408728, 8614.655413783457, 8622.784430389227, 8641.697540586081, 2109.314472796347, 2153.655415133579, 2414.0343862454984, 2451.5832308507506, 2458.60662294033, 2058.4133521946246, 2108.947276318089, 2463.581191197492, 2474.7401522840114, 2503.123906632682, 2251.8761468119246, 2434.5982912819363, 2438.890249938757, 2470.0490311230215, 2482.900683972639, 2437.3419176822335, 2442.413820683041, 2465.4822487277693, 2471.9629205561932, 2472.777450029488, 2371.537550177716, 2486.6145747409, 2495.6506089147533, 2496.151308555082, 2504.912328068527, 8583.484990900566, 8604.8709269361, 8614.655413783441, 8617.870731939025, 8659.956700216522, 4481.126180394825, 5441.782328706847, 5490.094134467808, 5500.532454741312, 5524.640898341595, 3610.9528236811293, 3711.5546134463766, 3716.0709822544363, 3721.292954338667, 3778.2254637799183, 928.2342067794096, 1045.5504133222712, 1062.95216715248, 1080.200651517879, 1096.5449338524502, 11576.53693852245, 11592.942035289769, 11687.883121168765, 11729.120315976335, 11736.061115110771, 4952.306677065214, 4958.479359667255, 5003.949960500421, 5018.498150185025, 5057.140286151363, 8625.223729864218, 10210.897891020995, 10224.284300098921, 10247.59009639621, 10259.17926565873, 5458.317710286215, 5465.207544905967, 5483.150111732608, 5510.972445137749, 5525.060739674265, 4418.756968366771, 4823.686460380064, 4870.805167793249, 4946.727929963815, 4985.52637499437, 3950.7036972227197, 3954.8615798446917, 3999.3601023836627, 4012.277789997828, 4030.1133750574827, 1324.7946568281932, 1326.9336533173303, 1335.3456806165104, 1336.038052602125, 1342.704604986921, 1323.3118778235264, 1326.9004824637998, 1328.249539010456, 1339.36380219395, 1351.3243378310844, 7879.251471110236, 7979.960100199578, 7987.600619968978, 8014.599270036475, 8129.715459958873, 493.47444971106376, 512.8871648237382, 520.9635325527253, 521.0776924843083, 521.1947541049088, 6177.907331390033, 6234.906476402857, 6251.874962500816, 6257.405546473078, 6292.433680968735, 10121.291509594257, 10437.0, 10460.163186945027, 10485.633002844865, 10628.14974802014, 10135.493225338703, 10307.793844123076, 10309.484525773682, 10361.171106311476, 10540.525676344583, 8071.919280807117, 8160.102388737234, 8163.632636531371, 8279.54462504556, 8375.246227839401, 7941.642626081955, 7941.722039728582, 7999.32005779492, 8078.83842323162, 8106.351491880753, 9349.158575728217, 9593.42439453635, 9598.280128990215, 9688.46713430768, 9727.708168754949, 9488.288378371511, 9621.951890240503, 9705.223582113273, 9991.200703943521, 10139.0, 6766.492513061442, 7208.098987626547, 7396.815079623052, 7411.444141689287, 7510.924890751023, 8150.2664760171865, 8151.144129866516, 8156.755297341089, 8192.672293108448, 8214.917850821415, 6120.663363515049, 7081.185663648746, 7223.313785190398, 7327.8534429312185, 7371.6314184289495, 5998.940010600013, 7114.715411383487, 7183.20984691694, 7257.0565826442225, 7299.0, 6078.392160784063, 7473.850522989618, 7644.579548124907, 7731.0336207974005, 7743.225677432211, 6964.79105626832, 6965.547239429624, 7024.227334993249, 7027.22700502934, 7064.222935477196, 7148.785536433916, 7159.642017899188, 7175.784726458214, 7178.210396856237, 7181.281871812777], "unit": "score", "name": "mootools.html", "value": 4803.165148317854}, {"lowerIsBetter": false, "replicates": [281.47504903355235, 323.2065279738243, 325.7882376455304, 333.626338500879, 335.75154385754547, 5832.38759930207, 6564.212294524657, 6679.833004174898, 6698.330166983299, 7002.684879180436, 6402.423781859632, 6744.156980377453, 6810.3189681032, 6827.078344423501, 6856.760013399532, 5024.020316038374, 5025.070361983036, 5034.219695947116, 5034.421041580228, 5046.1169295373165, 5012.248162775594, 5026.773795179226, 5030.11972904742, 5031.798728050873, 5032.9748351258195, 4947.604191664658, 4959.677620954626, 4975.4527002029745, 4983.651144419892, 4990.900181996358, 4720.362751028636, 4914.483979182206, 4969.9751501242445, 4987.850364489072, 5005.549500544932, 4104.938425923614, 4125.195586860564, 4140.275451795954, 4153.460050193486, 4155.688323375729, 6360.618362898241, 6448.290688024314, 6488.90266645996, 6500.4799616030605, 6515.185601799775, 5597.244372009767, 5796.942030579725, 5807.651540907516, 5816.1275808628625, 5820.243368362128, 7250.891236631454, 7255.0, 7257.963710181468, 7264.963675181591, 7266.346028857428, 4606.585407313324, 4638.327442520849, 4645.837395691168, 4652.58126768589, 4662.090892276007, 6281.905771413387, 7651.9234807651765, 7750.806229844243, 7785.338246249075, 7810.726624568113, 4459.082594484403, 4577.0, 4584.541545845389, 4635.536446355338, 4709.858704238878, 4736.64475164364, 4747.928781068286, 4748.548887855648, 4748.7863046163, 4756.239001759702, 5666.206731057655, 5674.886502269931, 5707.6575405475805, 5713.314402271754, 5717.799877004285, 7251.419886409075, 7276.527025743309, 7293.817654558572, 7310.4517161213125, 7349.118105827335, 1642.9424970125988, 1660.800703915538, 1665.408779883124, 1668.0242058395731, 1677.622534929631, 1024.1908891975256, 1054.536004158168, 1064.1912146768357, 1074.0280046557878, 1079.9892001080045, 5583.944160558423, 5816.5055970243, 6603.910354791406, 6778.3221677831825, 6854.794356169323, 6060.727267272983, 7531.849363012709, 7554.8866766998535, 7561.508501947355, 7613.9238607614325, 5540.972295138498, 6791.830204244933, 6825.0, 6849.452043836481, 6893.310668933066, 3291.8847840325475, 3978.781167035841, 4004.3192657248337, 4008.6191811777835, 4015.558288588253, 5767.480926716532, 7876.291133797986, 7878.015248093989, 7908.813677948354, 7911.0, 7736.535807851435, 7783.883241751379, 7787.688492460352, 7791.142974272825, 7808.492447990862, 6334.5565810393755, 7837.373010159174, 7867.881981770278, 7890.132085470594, 7928.088269848926, 6381.234251889803, 7263.673134709056, 7499.775006749806, 7520.09758828944, 7525.435592330487, 7378.96310518444, 7416.96291518539, 7423.109226892808, 7480.102387713509, 7601.619919003917, 5728.570357223141, 6732.124823772878, 7538.0, 7867.134615192439, 7913.050433947733, 4090.3864420336, 4148.69316165407, 4239.558550092983, 4481.395011673382, 4689.390379250675, 6057.42454466825, 6944.131983502062, 7274.127104747464, 7405.62971851416, 7612.467127301035, 7278.526895751759, 7332.266773322625, 7353.970444137932, 7373.152087510005, 7388.482806203514, 7235.819104522429, 7272.41820654357, 7310.634468276671, 7322.267773222635, 7329.780106596811, 6423.164988551458, 6726.091977583159, 7152.892706609301, 7161.283871612797, 7163.641817909188, 6914.204866440424, 7248.238934911969, 7454.515456495311, 7516.210797866145, 7532.924670753222, 7132.643367831692, 7150.320719531636, 7162.2121566628675, 7175.210726819942, 7196.244394338519], "unit": "score", "name": "prototype.html", "value": 5210.118608371314}, {"lowerIsBetter": false, "replicates": [694.7811439396589, 722.9530080544768, 724.6521470065678, 728.1626129950556, 754.6981207516993, 15010.249487525622, 15040.17279049652, 15049.774253386195, 15175.317110730017, 15197.620059498518, 12078.577249796259, 13474.93262533686, 13675.726485470284, 13966.092204006733, 14136.646583835409, 688.6625553478809, 763.3892885691439, 872.0625327772638, 874.0778478704964, 875.9430637008574, 751.6918063593928, 843.6161546496329, 845.3152946113637, 862.633380813155, 875.7241468937297, 900.5632268349846, 907.6233363154283, 911.2846415563783, 914.1772404835634, 920.0109881876975, 897.9012308646044, 905.3255324783013, 906.5875026862761, 910.0626354854511, 913.8309412758628, 658.2791842931982, 667.436016566001, 667.6127845849396, 673.0341959288437, 676.5399528320739, 14661.560153195422, 14664.853351466456, 14667.413303467849, 14727.410903563952, 14779.482718104922, 12924.0, 13029.34853257343, 13039.869601304055, 13081.803772943413, 13217.14088584239, 9801.215902727765, 9820.705378838646, 9941.602335906555, 9950.502474876228, 10488.528016239288, 3502.5446691929887, 3548.591911930135, 3615.620359862229, 3669.1560940983723, 3700.777953322782, 83426.0, 83554.58222708848, 83594.58202708948, 83722.58138709329, 84352.0, 9312.441253524674, 9549.379290346105, 9614.807703846023, 9617.23062155026, 9628.66299679508, 21689.0, 21781.782182178293, 21897.562048759253, 21913.342599722033, 21966.780332196795, 7241.203467618558, 7270.818229544304, 7456.888146677804, 7467.58928258951, 7503.849923001619, 3914.9021274468364, 3939.5666476687543, 3959.3269144245546, 3972.5828787976848, 3979.8010099495486, 3196.8241746704152, 3291.4240007998983, 3472.8089955052715, 3498.8250587470525, 3525.0, 606.9166537730131, 645.8579112595315, 654.1496055128314, 657.8914479110989, 670.2325836916704, 540.2706346432285, 569.564283323258, 609.5367520684312, 622.3372108704216, 623.4918541388754, 7353.6323183840595, 8237.546934918517, 8315.83368332642, 8727.214550690469, 9044.683436079706, 510.89271253037276, 520.0664806672032, 564.8136115082013, 633.4711948492203, 636.5512313818747, 3985.4221137934837, 4058.7564746115327, 4074.103697186614, 4084.06617975851, 4193.916121677549, 89095.10904890997, 89603.55198223967, 89821.55089224513, 93441.0, 93485.0, 79503.40993180104, 79915.0, 80088.0, 80336.39327213539, 81515.0, 46404.0, 64183.99999999907, 66169.6766064676, 68011.31988680149, 68915.96626050613, 8021.197880211932, 8193.631286591999, 8216.876746848922, 8230.465019773696, 8257.343719552126, 34839.0, 48490.757546212044, 49749.75125124351, 49869.50130498649, 50192.74518137076, 64146.35853641404, 68650.65674671595, 70699.29300707133, 71078.28921710924, 71668.0, 9858.964808695271, 10024.899751002396, 10086.697399078039, 10596.735081623021, 11267.830982535104, 11843.703907402383, 11972.940135299616, 12202.633920982385, 12648.936755316165, 12762.553310634083, 11595.014423774073, 11682.532698691957, 11692.47383867711, 11926.284422934652, 11988.46051927648, 11188.72028199269, 11467.369294688539, 11586.652400428, 11883.821742673694, 11947.223430476992, 11219.214654974074, 11276.718082047686, 11319.490622922152, 11364.0, 11595.304281743123, 9231.446113233227, 9325.114114159143, 9373.671921482715, 9457.385269957706, 9473.431594104375, 8722.65109395617, 9523.142917137491, 9573.994730553191, 9733.0, 9759.12167904892], "unit": "score", "name": "yui.html", "value": 6825.363568092887}], "name": "dromaeo_css", "value": 7419.744880848883}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 109.0, 115.0, 113.0, 114.0, 124.0, 113.0, 115.0, 117.0, 114.0], "unit": "score", "name": "ai-astar", "value": 115.1}, {"lowerIsBetter": true, "replicates": [157.0, 120.0, 159.0, 186.0, 155.0, 128.0, 132.0, 107.0, 180.0, 152.0], "unit": "score", "name": "audio-beat-detection", "value": 147.6}, {"lowerIsBetter": true, "replicates": [195.0, 204.0, 199.0, 207.0, 204.0, 213.0, 210.0, 208.0, 205.0, 199.0], "unit": "score", "name": "audio-dft", "value": 204.4}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 77.0, 142.0, 48.0, 87.0, 82.0, 87.0, 141.0, 82.0], "unit": "score", "name": "audio-fft", "value": 87.9}, {"lowerIsBetter": true, "replicates": [82.0, 80.0, 117.0, 80.0, 82.0, 86.0, 118.0, 76.0, 95.0, 154.0], "unit": "score", "name": "audio-oscillator", "value": 97.0}, {"lowerIsBetter": true, "replicates": [89.0, 93.0, 79.0, 140.0, 132.0, 92.0, 86.0, 92.0, 106.0, 132.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 104.1}, {"lowerIsBetter": true, "replicates": [115.0, 92.0, 153.0, 153.0, 121.0, 96.0, 96.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 111.2}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 104.0, 94.0, 92.0, 93.0, 92.0, 92.0, 90.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 93.4}, {"lowerIsBetter": true, "replicates": [57.0, 60.0, 59.0, 56.0, 59.0, 61.0, 65.0, 90.0, 85.0, 86.0], "unit": "score", "name": "json-parse-financial", "value": 67.8}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 69.0, 76.0, 73.0, 68.0, 65.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [91.0, 99.0, 101.0, 103.0, 107.0, 112.0, 112.0, 111.0, 89.0, 92.0], "unit": "score", "name": "stanford-crypto-aes", "value": 101.7}, {"lowerIsBetter": true, "replicates": [144.0, 120.0, 134.0, 137.0, 136.0, 128.0, 125.0, 124.0, 130.0, 137.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 131.5}, {"lowerIsBetter": true, "replicates": [130.0, 141.0, 144.0, 142.0, 144.0, 142.0, 142.0, 147.0, 146.0, 180.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.8}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 83.0, 102.0, 96.0, 72.0, 69.0, 70.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 77.2}], "name": "kraken", "value": 1553.2}]} 06:47:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1553.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7419.74"}}} 06:47:43 INFO - Return code: 0 06:47:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:47:43 ERROR - # TBPL SUCCESS # 06:47:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:47:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:47:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:47:43 INFO - 2016-02-22 06:47:43.533 screenresolution[6271:104664] starting screenresolution argv=screenresolution get 06:47:43 INFO - 2016-02-22 06:47:43.535 screenresolution[6271:104664] Display 0: 1600x1200x32@60 06:47:43 INFO - 2016-02-22 06:47:43.541 screenresolution[6272:104667] starting screenresolution argv=screenresolution list 06:47:43 INFO - Available Modes on Display 0 06:47:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:47:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:47:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:47:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:47:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:47:43 INFO - Intel Iris: 06:47:43 INFO - Chipset Model: Intel Iris 06:47:43 INFO - Type: GPU 06:47:43 INFO - Bus: Built-In 06:47:43 INFO - VRAM (Dynamic, Max): 1536 MB 06:47:43 INFO - Vendor: Intel (0x8086) 06:47:43 INFO - Device ID: 0x0a2e 06:47:43 INFO - Revision ID: 0x0009 06:47:43 INFO - Displays: 06:47:43 INFO - Display: 06:47:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:47:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:47:43 INFO - Display Serial Number: 1600x1200 60 06:47:43 INFO - Main Display: Yes 06:47:43 INFO - Mirror: Off 06:47:43 INFO - Online: Yes 06:47:43 INFO - Rotation: Supported 06:47:43 INFO - Return code: 0 06:47:43 INFO - Running post-action listener: _resource_record_post_action 06:47:43 INFO - Running post-run listener: _resource_record_post_run 06:47:44 INFO - Total resource usage - Wall time: 1214s; CPU: 53.0%; Read bytes: 4582912; Write bytes: 713517056; Read time: 64; Write time: 2687 06:47:44 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 386605568; Write bytes: 381985792; Read time: 29080; Write time: 730 06:47:44 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 4582912; Write bytes: 306131968; Read time: 64; Write time: 1903 06:47:44 INFO - Running post-run listener: _upload_blobber_files 06:47:44 INFO - Blob upload gear active. 06:47:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:47:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:47:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:47:45 INFO - (blobuploader) - INFO - Open directory for files ... 06:47:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:47:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:47:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:47:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:47:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:47:45 INFO - (blobuploader) - INFO - Done attempting. 06:47:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:47:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:47:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:47:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:47:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:47:46 INFO - (blobuploader) - INFO - Done attempting. 06:47:46 INFO - (blobuploader) - INFO - Iteration through files over. 06:47:46 INFO - Return code: 0 06:47:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:47:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:47:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51cedee09ac070fb16ecc5e676ce37721a5b3d4e609fe427107dbb1e89d9eb0713a5a02f25c915634afc0e8c11c70bae1b60f7752d7e2e8580507c1f908e704d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/139e52a87d42622866013bb968ca3ab9c3580087a8d880d8e37fdf08582e354b612100cb07647af0b6173e5aa6a06cc072a9d957211f06348eee002a4e557963"} 06:47:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:47:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:47:46 INFO - Contents: 06:47:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51cedee09ac070fb16ecc5e676ce37721a5b3d4e609fe427107dbb1e89d9eb0713a5a02f25c915634afc0e8c11c70bae1b60f7752d7e2e8580507c1f908e704d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/139e52a87d42622866013bb968ca3ab9c3580087a8d880d8e37fdf08582e354b612100cb07647af0b6173e5aa6a06cc072a9d957211f06348eee002a4e557963"} 06:47:46 INFO - Running post-run listener: copy_logs_to_upload_dir 06:47:46 INFO - Copying logs to upload dir... 06:47:46 INFO - mkdir: /builds/slave/test/build/upload/logs 06:47:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.307320 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-02-22 06:47:47.054385) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 06:47:47.059012) ========= 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.wockmgXgdS/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.RaQn455aTw/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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/51cedee09ac070fb16ecc5e676ce37721a5b3d4e609fe427107dbb1e89d9eb0713a5a02f25c915634afc0e8c11c70bae1b60f7752d7e2e8580507c1f908e704d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/139e52a87d42622866013bb968ca3ab9c3580087a8d880d8e37fdf08582e354b612100cb07647af0b6173e5aa6a06cc072a9d957211f06348eee002a4e557963"} build_url:https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011095 build_url: 'https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51cedee09ac070fb16ecc5e676ce37721a5b3d4e609fe427107dbb1e89d9eb0713a5a02f25c915634afc0e8c11c70bae1b60f7752d7e2e8580507c1f908e704d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/139e52a87d42622866013bb968ca3ab9c3580087a8d880d8e37fdf08582e354b612100cb07647af0b6173e5aa6a06cc072a9d957211f06348eee002a4e557963"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 06:47:47.088064) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:47:47.088388) ========= 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.wockmgXgdS/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.RaQn455aTw/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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.005299 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:47:47.139169) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 06:47:47.139491) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 06:47:47.139892) ========= ========= Total master_lag: 0.62 =========