builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0003 starttime: 1458303860.53 results: success (0) buildid: 20160318030236 builduid: 214bc8d1cf4143859ec2c82ce073cccb revision: 3e04659fdf6aef792f7cf9840189c6c38d08d1e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 05:24:20.531670) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 05:24:20.532159) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 05:24:20.532444) ========= 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.s9blUDOkCt/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.DhbIRufXyl/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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.005550 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 05:24:20.555980) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 05:24:20.556269) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 05:24:20.573275) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 05:24:20.573579) ========= 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.s9blUDOkCt/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.DhbIRufXyl/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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.006026 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 05:24:20.621590) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 05:24:20.623937) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 05:24:20.624329) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 05:24:20.624611) ========= 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.s9blUDOkCt/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.DhbIRufXyl/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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-03-18 05:24:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.2M=0.001s 2016-03-18 05:24:20 (15.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135391 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 05:24:20.779010) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 05:24:20.779356) ========= 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.s9blUDOkCt/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.DhbIRufXyl/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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.025819 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 05:24:20.827630) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 05:24:20.831033) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3e04659fdf6aef792f7cf9840189c6c38d08d1e8 --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 3e04659fdf6aef792f7cf9840189c6c38d08d1e8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.s9blUDOkCt/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.DhbIRufXyl/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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-03-18 05:24:20,908 truncating revision to first 12 chars 2016-03-18 05:24:20,908 Setting DEBUG logging. 2016-03-18 05:24:20,908 attempt 1/10 2016-03-18 05:24:20,908 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3e04659fdf6a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-18 05:24:21,519 unpacking tar archive at: mozilla-central-3e04659fdf6a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.850938 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 05:24:21.698814) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 05:24:21.699207) ========= echo 3e04659fdf6aef792f7cf9840189c6c38d08d1e8 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3e04659fdf6aef792f7cf9840189c6c38d08d1e8'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.s9blUDOkCt/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.DhbIRufXyl/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 3e04659fdf6aef792f7cf9840189c6c38d08d1e8 program finished with exit code 0 elapsedTime=0.005465 script_repo_revision: '3e04659fdf6aef792f7cf9840189c6c38d08d1e8' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 05:24:21.748649) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 05:24:21.748983) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 05:24:21.763294) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-03-18 05:24:21.763621) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.s9blUDOkCt/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.DhbIRufXyl/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:24:21 INFO - MultiFileLogger online at 20160318 05:24:21 in /builds/slave/test 05:24:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:24:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:24:21 INFO - {'append_to_log': False, 05:24:21 INFO - 'base_work_dir': '/builds/slave/test', 05:24:21 INFO - 'blob_upload_branch': 'Firefox', 05:24:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:24:21 INFO - 'branch': 'Firefox', 05:24:21 INFO - 'buildbot_json_path': 'buildprops.json', 05:24:21 INFO - 'config_files': ('talos/mac_config.py',), 05:24:21 INFO - 'default_actions': ('clobber', 05:24:21 INFO - 'read-buildbot-config', 05:24:21 INFO - 'download-and-extract', 05:24:21 INFO - 'populate-webroot', 05:24:21 INFO - 'create-virtualenv', 05:24:21 INFO - 'install', 05:24:21 INFO - 'run-tests'), 05:24:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:24:21 INFO - 'download_minidump_stackwalk': True, 05:24:21 INFO - 'download_symbols': 'ondemand', 05:24:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:24:21 INFO - 'tooltool.py': '/tools/tooltool.py', 05:24:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:24:21 INFO - '/tools/misc-python/virtualenv.py')}, 05:24:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:24:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:24:21 INFO - 'installer_path': 'installer.exe', 05:24:21 INFO - 'log_level': 'info', 05:24:21 INFO - 'log_name': 'talos', 05:24:21 INFO - 'log_to_console': True, 05:24:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:24:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:24:21 INFO - 'opt_config_files': (), 05:24:21 INFO - 'pip_index': False, 05:24:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:24:21 INFO - 'cmd': ('bash', 05:24:21 INFO - '-c', 05:24:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:24:21 INFO - 'enabled': True, 05:24:21 INFO - 'halt_on_failure': False, 05:24:21 INFO - 'name': 'check_screen_resolution'},), 05:24:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:24:21 INFO - 'cmd': ('bash', 05:24:21 INFO - '-c', 05:24:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:24:21 INFO - 'enabled': True, 05:24:21 INFO - 'halt_on_failure': False, 05:24:21 INFO - 'name': 'check_screen_resolution'},), 05:24:21 INFO - 'run_cmd_checks_enabled': True, 05:24:21 INFO - 'sps_profile': False, 05:24:21 INFO - 'sps_profile_interval': 0, 05:24:21 INFO - 'suite': 'dromaeojs', 05:24:21 INFO - 'system_bits': '32', 05:24:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:24:21 INFO - 'title': 't-yosemite-r7-0003', 05:24:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:24:21 INFO - 'use_talos_json': True, 05:24:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:24:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:24:21 INFO - 'work_dir': 'build'} 05:24:21 INFO - ##### 05:24:21 INFO - ##### Running clobber step. 05:24:21 INFO - ##### 05:24:21 INFO - Running pre-action listener: _resource_record_pre_action 05:24:21 INFO - Running main action method: clobber 05:24:21 INFO - rmtree: /builds/slave/test/build 05:24:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:24:23 INFO - Running post-action listener: _resource_record_post_action 05:24:23 INFO - ##### 05:24:23 INFO - ##### Running read-buildbot-config step. 05:24:23 INFO - ##### 05:24:23 INFO - Running pre-action listener: _resource_record_pre_action 05:24:23 INFO - Running main action method: read_buildbot_config 05:24:23 INFO - Using buildbot properties: 05:24:23 INFO - { 05:24:23 INFO - "project": "", 05:24:23 INFO - "product": "firefox", 05:24:23 INFO - "script_repo_revision": "production", 05:24:23 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:24:23 INFO - "repository": "", 05:24:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:24:23 INFO - "buildid": "20160318030236", 05:24:23 INFO - "stage_platform": "macosx64", 05:24:23 INFO - "basedir": "/builds/slave/test", 05:24:23 INFO - "nightly_build": "True", 05:24:23 INFO - "buildnumber": 173, 05:24:23 INFO - "slavename": "t-yosemite-r7-0003", 05:24:23 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:24:23 INFO - "platform": "yosemite_r7", 05:24:23 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:24:23 INFO - "branch": "mozilla-central", 05:24:23 INFO - "repo_path": "mozilla-central", 05:24:23 INFO - "revision": "3e04659fdf6aef792f7cf9840189c6c38d08d1e8", 05:24:23 INFO - "pgo_build": "False", 05:24:23 INFO - "builduid": "214bc8d1cf4143859ec2c82ce073cccb", 05:24:23 INFO - "slavebuilddir": "test" 05:24:23 INFO - } 05:24:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:24:23 INFO - Running post-action listener: _resource_record_post_action 05:24:23 INFO - ##### 05:24:23 INFO - ##### Running download-and-extract step. 05:24:23 INFO - ##### 05:24:23 INFO - Running pre-action listener: _resource_record_pre_action 05:24:23 INFO - Running main action method: download_and_extract 05:24:23 INFO - mkdir: /builds/slave/test/build/tests 05:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:23 INFO - https://queue.taskcluster.net/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:24:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:24:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:24:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:24:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 05:24:34 INFO - Downloaded 1199 bytes. 05:24:34 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:24:34 INFO - Using the following test package requirements: 05:24:34 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:24:34 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:24:34 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:24:34 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:24:34 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:24:34 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:24:34 INFO - u'jsshell-mac.zip'], 05:24:34 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:24:34 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:24:34 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:24:34 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:24:34 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:24:34 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:24:34 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:24:34 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:24:34 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:24:34 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:24:34 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:24:34 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:34 INFO - https://queue.taskcluster.net/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:24:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:24:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:24:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:24:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:24:36 INFO - Downloaded 17870652 bytes. 05:24:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:24:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:24:39 INFO - Return code: 0 05:24:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:39 INFO - https://queue.taskcluster.net/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:24:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:24:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:24:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:24:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:24:41 INFO - Downloaded 17870652 bytes. 05:24:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:24:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:24:45 INFO - Return code: 0 05:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:45 INFO - https://queue.taskcluster.net/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:24:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:24:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:24:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:24:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:24:46 INFO - Downloaded 10846565 bytes. 05:24:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:24:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:24:46 INFO - Return code: 0 05:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:46 INFO - https://queue.taskcluster.net/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:24:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:24:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:24:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:24:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:24:53 INFO - Downloaded 111331510 bytes. 05:24:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:24:53 INFO - mkdir: /builds/slave/test/properties 05:24:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:24:53 INFO - Writing to file /builds/slave/test/properties/build_url 05:24:53 INFO - Contents: 05:24:53 INFO - build_url:https://queue.taskcluster.net/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:24:54 INFO - Running post-action listener: _resource_record_post_action 05:24:54 INFO - Running post-action listener: set_extra_try_arguments 05:24:54 INFO - ##### 05:24:54 INFO - ##### Running populate-webroot step. 05:24:54 INFO - ##### 05:24:54 INFO - Running pre-action listener: _resource_record_pre_action 05:24:54 INFO - Running main action method: populate_webroot 05:24:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:24:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:24:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:24:54 INFO - '--tppagecycles', 05:24:54 INFO - '7'], 05:24:54 INFO - 'tests': ['tsvgm']}}, 05:24:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:24:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:24:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:24:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:24:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:24:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:24:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:24:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:54 INFO - 'talos_options': ['--e10s'], 05:24:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:24:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:54 INFO - 'tests': ['damp', 'tps']}, 05:24:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:54 INFO - 'talos_options': ['--e10s'], 05:24:54 INFO - 'tests': ['damp', 'tps']}, 05:24:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:24:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:24:54 INFO - 'other': {'tests': ['a11yr', 05:24:54 INFO - 'ts_paint', 05:24:54 INFO - 'tpaint', 05:24:54 INFO - 'sessionrestore', 05:24:54 INFO - 'sessionrestore_no_auto_restore', 05:24:54 INFO - 'tabpaint']}, 05:24:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:24:54 INFO - 'tests': ['a11yr', 05:24:54 INFO - 'ts_paint', 05:24:54 INFO - 'tpaint', 05:24:54 INFO - 'sessionrestore', 05:24:54 INFO - 'sessionrestore_no_auto_restore', 05:24:54 INFO - 'tabpaint']}, 05:24:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:24:54 INFO - 'tests': ['a11yr', 05:24:54 INFO - 'ts_paint', 05:24:54 INFO - 'tpaint', 05:24:54 INFO - 'sessionrestore', 05:24:54 INFO - 'sessionrestore_no_auto_restore', 05:24:54 INFO - 'tabpaint']}, 05:24:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:24:54 INFO - 'tests': ['a11yr', 05:24:54 INFO - 'ts_paint', 05:24:54 INFO - 'tpaint', 05:24:54 INFO - 'sessionrestore', 05:24:54 INFO - 'sessionrestore_no_auto_restore', 05:24:54 INFO - 'tabpaint']}, 05:24:54 INFO - 'other_l64': {'tests': ['a11yr', 05:24:54 INFO - 'ts_paint', 05:24:54 INFO - 'tpaint', 05:24:54 INFO - 'sessionrestore', 05:24:54 INFO - 'sessionrestore_no_auto_restore', 05:24:54 INFO - 'tabpaint']}, 05:24:54 INFO - 'other_nol64': {'tests': ['a11yr', 05:24:54 INFO - 'ts_paint', 05:24:54 INFO - 'tpaint', 05:24:54 INFO - 'sessionrestore', 05:24:54 INFO - 'sessionrestore_no_auto_restore', 05:24:54 INFO - 'tabpaint']}, 05:24:54 INFO - 'svgr': {'tests': ['tsvgx', 05:24:54 INFO - 'tsvgr_opacity', 05:24:54 INFO - 'tart', 05:24:54 INFO - 'tscrollx', 05:24:54 INFO - 'cart']}, 05:24:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:24:54 INFO - 'tests': ['tsvgx', 05:24:54 INFO - 'tsvgr_opacity', 05:24:54 INFO - 'tart', 05:24:54 INFO - 'tscrollx', 05:24:54 INFO - 'cart']}, 05:24:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:54 INFO - 'tests': ['tp5o']}, 05:24:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:54 INFO - 'talos_options': ['--e10s'], 05:24:54 INFO - 'tests': ['tp5o']}, 05:24:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:54 INFO - 'talos_options': ['--xperf_path', 05:24:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:24:54 INFO - 'tests': ['tp5n']}, 05:24:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:54 INFO - 'talos_options': ['--e10s', 05:24:54 INFO - '--xperf_path', 05:24:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:24:54 INFO - 'tests': ['tp5n']}}, 05:24:54 INFO - 'talos.zip': {'path': '', 05:24:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:24:54 INFO - Running post-action listener: _resource_record_post_action 05:24:54 INFO - ##### 05:24:54 INFO - ##### Running create-virtualenv step. 05:24:54 INFO - ##### 05:24:54 INFO - Running pre-action listener: _resource_record_pre_action 05:24:54 INFO - Running main action method: create_virtualenv 05:24:54 INFO - Creating virtualenv /builds/slave/test/build/venv 05:24:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:24:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:24:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:24:55 INFO - Using real prefix '/tools/python27' 05:24:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:24:55 INFO - Installing distribute.............................................................................................................................................................................................done. 05:24:58 INFO - Installing pip.................done. 05:24:58 INFO - Return code: 0 05:24:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:58 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 0x10da2fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da3f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98d0561e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8cee00>, '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 0x10d6f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8c9b20>, '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.s9blUDOkCt/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.DhbIRufXyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:24:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:24:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:24:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9blUDOkCt/Render', 05:24:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:58 INFO - 'HOME': '/Users/cltbld', 05:24:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:58 INFO - 'LOGNAME': 'cltbld', 05:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:58 INFO - 'MOZ_NO_REMOTE': '1', 05:24:58 INFO - 'NO_EM_RESTART': '1', 05:24:58 INFO - 'PAGER': '/bin/cat', 05:24:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:58 INFO - 'PWD': '/builds/slave/test', 05:24:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:58 INFO - 'SHELL': '/bin/bash', 05:24:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DhbIRufXyl/Listeners', 05:24:58 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 05:24:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:58 INFO - 'USER': 'cltbld', 05:24:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:58 INFO - 'XPC_FLAGS': '0x0', 05:24:58 INFO - 'XPC_SERVICE_NAME': '0', 05:24:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:24:58 INFO - Cleaning up... 05:24:58 INFO - Return code: 0 05:24:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:58 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 0x10da2fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da3f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98d0561e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8cee00>, '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 0x10d6f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8c9b20>, '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.s9blUDOkCt/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.DhbIRufXyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:24:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:24:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:24:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9blUDOkCt/Render', 05:24:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:58 INFO - 'HOME': '/Users/cltbld', 05:24:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:58 INFO - 'LOGNAME': 'cltbld', 05:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:58 INFO - 'MOZ_NO_REMOTE': '1', 05:24:58 INFO - 'NO_EM_RESTART': '1', 05:24:58 INFO - 'PAGER': '/bin/cat', 05:24:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:58 INFO - 'PWD': '/builds/slave/test', 05:24:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:58 INFO - 'SHELL': '/bin/bash', 05:24:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DhbIRufXyl/Listeners', 05:24:58 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 05:24:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:58 INFO - 'USER': 'cltbld', 05:24:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:58 INFO - 'XPC_FLAGS': '0x0', 05:24:58 INFO - 'XPC_SERVICE_NAME': '0', 05:24:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:59 INFO - Downloading/unpacking psutil>=0.7.1 05:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:25:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:25:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:25:01 INFO - Installing collected packages: psutil 05:25:01 INFO - Running setup.py install for psutil 05:25:01 INFO - building 'psutil._psutil_osx' extension 05:25:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:25:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:25:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:25:02 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:25:02 INFO - building 'psutil._psutil_posix' extension 05:25:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:25:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:25:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:25:02 INFO - ^ 05:25:02 INFO - 1 warning generated. 05:25:02 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:25:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:25:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:25:02 INFO - Successfully installed psutil 05:25:02 INFO - Cleaning up... 05:25:02 INFO - Return code: 0 05:25:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10da2fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da3f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98d0561e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8cee00>, '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 0x10d6f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8c9b20>, '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.s9blUDOkCt/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.DhbIRufXyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:25:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:25:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9blUDOkCt/Render', 05:25:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:02 INFO - 'HOME': '/Users/cltbld', 05:25:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:02 INFO - 'LOGNAME': 'cltbld', 05:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:02 INFO - 'MOZ_NO_REMOTE': '1', 05:25:02 INFO - 'NO_EM_RESTART': '1', 05:25:02 INFO - 'PAGER': '/bin/cat', 05:25:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:02 INFO - 'PWD': '/builds/slave/test', 05:25:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:02 INFO - 'SHELL': '/bin/bash', 05:25:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DhbIRufXyl/Listeners', 05:25:02 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 05:25:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:02 INFO - 'USER': 'cltbld', 05:25:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:02 INFO - 'XPC_FLAGS': '0x0', 05:25:02 INFO - 'XPC_SERVICE_NAME': '0', 05:25:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:25:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:25:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:25:05 INFO - Installing collected packages: mozsystemmonitor 05:25:05 INFO - Running setup.py install for mozsystemmonitor 05:25:05 INFO - Successfully installed mozsystemmonitor 05:25:05 INFO - Cleaning up... 05:25:05 INFO - Return code: 0 05:25:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:05 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 0x10da2fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da3f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98d0561e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8cee00>, '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 0x10d6f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8c9b20>, '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.s9blUDOkCt/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.DhbIRufXyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:25:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:25:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9blUDOkCt/Render', 05:25:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:05 INFO - 'HOME': '/Users/cltbld', 05:25:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:05 INFO - 'LOGNAME': 'cltbld', 05:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:05 INFO - 'MOZ_NO_REMOTE': '1', 05:25:05 INFO - 'NO_EM_RESTART': '1', 05:25:05 INFO - 'PAGER': '/bin/cat', 05:25:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:05 INFO - 'PWD': '/builds/slave/test', 05:25:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:05 INFO - 'SHELL': '/bin/bash', 05:25:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DhbIRufXyl/Listeners', 05:25:05 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 05:25:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:05 INFO - 'USER': 'cltbld', 05:25:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:05 INFO - 'XPC_FLAGS': '0x0', 05:25:05 INFO - 'XPC_SERVICE_NAME': '0', 05:25:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:06 INFO - Downloading/unpacking blobuploader==1.2.4 05:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:08 INFO - Downloading blobuploader-1.2.4.tar.gz 05:25:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:25:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:25:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:09 INFO - Downloading docopt-0.6.1.tar.gz 05:25:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:25:09 INFO - Installing collected packages: blobuploader, requests, docopt 05:25:09 INFO - Running setup.py install for blobuploader 05:25:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:25:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:25:09 INFO - Running setup.py install for requests 05:25:10 INFO - Running setup.py install for docopt 05:25:10 INFO - Successfully installed blobuploader requests docopt 05:25:10 INFO - Cleaning up... 05:25:10 INFO - Return code: 0 05:25:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:10 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 0x10da2fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da3f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98d0561e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8cee00>, '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 0x10d6f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8c9b20>, '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.s9blUDOkCt/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.DhbIRufXyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:25:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:25:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9blUDOkCt/Render', 05:25:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:10 INFO - 'HOME': '/Users/cltbld', 05:25:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:10 INFO - 'LOGNAME': 'cltbld', 05:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:10 INFO - 'MOZ_NO_REMOTE': '1', 05:25:10 INFO - 'NO_EM_RESTART': '1', 05:25:10 INFO - 'PAGER': '/bin/cat', 05:25:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:10 INFO - 'PWD': '/builds/slave/test', 05:25:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:10 INFO - 'SHELL': '/bin/bash', 05:25:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DhbIRufXyl/Listeners', 05:25:10 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 05:25:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:10 INFO - 'USER': 'cltbld', 05:25:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:10 INFO - 'XPC_FLAGS': '0x0', 05:25:10 INFO - 'XPC_SERVICE_NAME': '0', 05:25:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:25:10 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-FcdT6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:25:10 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-sCrlHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:25:11 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-UlaVpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:25:11 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-XNvUDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:25:11 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-9Y2KSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:25:11 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-eqHZqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:25:11 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-1oh08P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:25:11 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-ieRgGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:25:11 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-eddaGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:25:11 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-SFZUuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:25:11 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-E4hB66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:25:12 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-MVh1I5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:25:12 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-CK7L5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:25:12 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-4rZ8e6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:12 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-XHcR2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:25:12 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-pQZsZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:25:12 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-lKz8Nz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:25:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:25:12 INFO - Running setup.py install for manifestparser 05:25:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:25:12 INFO - Running setup.py install for mozcrash 05:25:12 INFO - Running setup.py install for mozdebug 05:25:13 INFO - Running setup.py install for mozdevice 05:25:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:25:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:25:13 INFO - Running setup.py install for mozfile 05:25:13 INFO - Running setup.py install for mozhttpd 05:25:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:25:13 INFO - Running setup.py install for mozinfo 05:25:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:25:13 INFO - Running setup.py install for mozInstall 05:25:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:25:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:25:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:25:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:25:13 INFO - Running setup.py install for mozleak 05:25:13 INFO - Running setup.py install for mozlog 05:25:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:25:14 INFO - Running setup.py install for moznetwork 05:25:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:25:14 INFO - Running setup.py install for mozprocess 05:25:14 INFO - Running setup.py install for mozprofile 05:25:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:25:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:25:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:25:14 INFO - Running setup.py install for mozrunner 05:25:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:25:14 INFO - Running setup.py install for mozscreenshot 05:25:14 INFO - Running setup.py install for moztest 05:25:15 INFO - Running setup.py install for mozversion 05:25:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:25:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:25:15 INFO - Cleaning up... 05:25:15 INFO - Return code: 0 05:25:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:25: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')]} 05:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25: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')]} 05:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25: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 0x10da2fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da3f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98d0561e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8cee00>, '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 0x10d6f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8c9b20>, '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.s9blUDOkCt/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.DhbIRufXyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:25: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 05:25: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 05:25:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9blUDOkCt/Render', 05:25:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:15 INFO - 'HOME': '/Users/cltbld', 05:25:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:15 INFO - 'LOGNAME': 'cltbld', 05:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:15 INFO - 'MOZ_NO_REMOTE': '1', 05:25:15 INFO - 'NO_EM_RESTART': '1', 05:25:15 INFO - 'PAGER': '/bin/cat', 05:25:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:15 INFO - 'PWD': '/builds/slave/test', 05:25:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:15 INFO - 'SHELL': '/bin/bash', 05:25:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DhbIRufXyl/Listeners', 05:25:15 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 05:25:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:15 INFO - 'USER': 'cltbld', 05:25:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:15 INFO - 'XPC_FLAGS': '0x0', 05:25:15 INFO - 'XPC_SERVICE_NAME': '0', 05:25:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:25:16 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-Xc_1qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:25: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)) 05:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:25:16 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-UzVqy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:25:16 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-zrZgqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:25: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)) 05:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:25:16 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-yKpbR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:25: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)) 05:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:25:16 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-uJffyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:25: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)) 05:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:25:16 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-vUvnDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:25: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)) 05:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:25:16 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-W4Bp1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:25: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)) 05:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:25:16 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-VO2APP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:25: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)) 05:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:25:17 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-q6MJMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:25: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)) 05:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:25:17 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-7n_tOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:25: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)) 05:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:25:17 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-is21Lg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:25: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)) 05:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:25:17 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-Njva74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:25: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)) 05:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:25:17 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-3piEmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:25: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)) 05:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:25:17 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-EQjVbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:25: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)) 05:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:17 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-ei5NB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:25: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)) 05:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:25:17 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-r6rlQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:25: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)) 05:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:25:17 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-Ew2vLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:25: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)) 05:25: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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:25: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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:25: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)) 05:25: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)) 05:25: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)) 05:25:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:20 INFO - Downloading blessings-1.6.tar.gz 05:25:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:25:20 INFO - Installing collected packages: blessings 05:25:20 INFO - Running setup.py install for blessings 05:25:21 INFO - Successfully installed blessings 05:25:21 INFO - Cleaning up... 05:25:21 INFO - Return code: 0 05:25:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:25:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:25:21 INFO - Reading from file tmpfile_stdout 05:25:21 INFO - Current package versions: 05:25:21 INFO - blessings == 1.6 05:25:21 INFO - blobuploader == 1.2.4 05:25:21 INFO - docopt == 0.6.1 05:25:21 INFO - manifestparser == 1.1 05:25:21 INFO - mozInstall == 1.12 05:25:21 INFO - mozcrash == 0.17 05:25:21 INFO - mozdebug == 0.1 05:25:21 INFO - mozdevice == 0.48 05:25:21 INFO - mozfile == 1.2 05:25:21 INFO - mozhttpd == 0.7 05:25:21 INFO - mozinfo == 0.9 05:25:21 INFO - mozleak == 0.1 05:25:21 INFO - mozlog == 3.1 05:25:21 INFO - moznetwork == 0.27 05:25:21 INFO - mozprocess == 0.22 05:25:21 INFO - mozprofile == 0.28 05:25:21 INFO - mozrunner == 6.11 05:25:21 INFO - mozscreenshot == 0.1 05:25:21 INFO - mozsystemmonitor == 0.0 05:25:21 INFO - moztest == 0.7 05:25:21 INFO - mozversion == 1.4 05:25:21 INFO - psutil == 3.1.1 05:25:21 INFO - requests == 1.2.3 05:25:21 INFO - wsgiref == 0.1.2 05:25:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25: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 0x10da2fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da3f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98d0561e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8cee00>, '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 0x10d6f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8c9b20>, '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.s9blUDOkCt/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.DhbIRufXyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:25: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 05:25: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 05:25:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9blUDOkCt/Render', 05:25:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:21 INFO - 'HOME': '/Users/cltbld', 05:25:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:21 INFO - 'LOGNAME': 'cltbld', 05:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:21 INFO - 'MOZ_NO_REMOTE': '1', 05:25:21 INFO - 'NO_EM_RESTART': '1', 05:25:21 INFO - 'PAGER': '/bin/cat', 05:25:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:21 INFO - 'PWD': '/builds/slave/test', 05:25:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:21 INFO - 'SHELL': '/bin/bash', 05:25:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DhbIRufXyl/Listeners', 05:25:21 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 05:25:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:21 INFO - 'USER': 'cltbld', 05:25:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:21 INFO - 'XPC_FLAGS': '0x0', 05:25:21 INFO - 'XPC_SERVICE_NAME': '0', 05:25:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25: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)) 05:25: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)) 05:25: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)) 05:25: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)) 05:25: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)) 05:25: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)) 05:25: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)) 05:25: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)) 05:25: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)) 05:25: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)) 05:25: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)) 05:25:21 INFO - Cleaning up... 05:25:21 INFO - Return code: 0 05:25:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25: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 0x10da2fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da3f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98d0561e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8cee00>, '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 0x10d6f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8c9b20>, '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.s9blUDOkCt/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.DhbIRufXyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:25: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 05:25: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 05:25:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9blUDOkCt/Render', 05:25:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:21 INFO - 'HOME': '/Users/cltbld', 05:25:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:21 INFO - 'LOGNAME': 'cltbld', 05:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:21 INFO - 'MOZ_NO_REMOTE': '1', 05:25:21 INFO - 'NO_EM_RESTART': '1', 05:25:21 INFO - 'PAGER': '/bin/cat', 05:25:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:21 INFO - 'PWD': '/builds/slave/test', 05:25:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:21 INFO - 'SHELL': '/bin/bash', 05:25:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DhbIRufXyl/Listeners', 05:25:21 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 05:25:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:21 INFO - 'USER': 'cltbld', 05:25:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:21 INFO - 'XPC_FLAGS': '0x0', 05:25:21 INFO - 'XPC_SERVICE_NAME': '0', 05:25:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:21 INFO - Downloading/unpacking jsonschema 05:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:25:24 INFO - Downloading/unpacking functools32 (from jsonschema) 05:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:25 INFO - Downloading functools32-3.2.3-2.tar.gz 05:25:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:25:25 INFO - warning: no files found matching '*.txt' 05:25:25 INFO - no previously-included directories found matching 'build' 05:25:25 INFO - no previously-included directories found matching 'dist' 05:25:25 INFO - no previously-included directories found matching '.git*' 05:25:25 INFO - Installing collected packages: jsonschema, functools32 05:25:25 INFO - Running setup.py install for functools32 05:25:25 INFO - warning: no files found matching '*.txt' 05:25:25 INFO - no previously-included directories found matching 'build' 05:25:25 INFO - no previously-included directories found matching 'dist' 05:25:25 INFO - no previously-included directories found matching '.git*' 05:25:25 INFO - Successfully installed jsonschema functools32 05:25:25 INFO - Cleaning up... 05:25:25 INFO - Return code: 0 05:25:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:25:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:25 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 0x10da2fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da3f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98d0561e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8cee00>, '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 0x10d6f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8c9b20>, '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.s9blUDOkCt/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.DhbIRufXyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:25:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:25:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:25:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9blUDOkCt/Render', 05:25:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:25 INFO - 'HOME': '/Users/cltbld', 05:25:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:25 INFO - 'LOGNAME': 'cltbld', 05:25:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:25 INFO - 'MOZ_NO_REMOTE': '1', 05:25:25 INFO - 'NO_EM_RESTART': '1', 05:25:25 INFO - 'PAGER': '/bin/cat', 05:25:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:25 INFO - 'PWD': '/builds/slave/test', 05:25:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:25 INFO - 'SHELL': '/bin/bash', 05:25:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DhbIRufXyl/Listeners', 05:25:25 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 05:25:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:25 INFO - 'USER': 'cltbld', 05:25:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:25 INFO - 'XPC_FLAGS': '0x0', 05:25:25 INFO - 'XPC_SERVICE_NAME': '0', 05:25:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:25 INFO - Downloading/unpacking flake8 05:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:25:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:25:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:25:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:25:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:25:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:25:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:25:29 INFO - no previously-included directories found matching 'docs/_build' 05:25:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:25:29 INFO - Running setup.py install for pep8 05:25:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:25:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:25:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:25:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:25:29 INFO - no previously-included directories found matching 'docs/_build' 05:25:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:25:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:25:29 INFO - Cleaning up... 05:25:29 INFO - Return code: 0 05:25:29 INFO - Running post-action listener: _resource_record_post_action 05:25:29 INFO - Running post-action listener: _start_resource_monitoring 05:25:29 INFO - Starting resource monitoring. 05:25:29 INFO - ##### 05:25:29 INFO - ##### Running install step. 05:25:29 INFO - ##### 05:25:29 INFO - Running pre-action listener: _resource_record_pre_action 05:25:29 INFO - Running main action method: install 05:25:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:25:30 INFO - Reading from file tmpfile_stdout 05:25:30 INFO - Detecting whether we're running mozinstall >=1.0... 05:25:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:25:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:25:30 INFO - Reading from file tmpfile_stdout 05:25:30 INFO - Output received: 05:25:30 INFO - Usage: mozinstall [options] installer 05:25:30 INFO - Options: 05:25:30 INFO - -h, --help show this help message and exit 05:25:30 INFO - -d DEST, --destination=DEST 05:25:30 INFO - Directory to install application into. [default: 05:25:30 INFO - "/builds/slave/test"] 05:25:30 INFO - --app=APP Application being installed. [default: firefox] 05:25:30 INFO - mkdir: /builds/slave/test/build/application 05:25:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:25:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:26:04 INFO - Reading from file tmpfile_stdout 05:26:04 INFO - Output received: 05:26:04 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:26:04 INFO - Running post-action listener: _resource_record_post_action 05:26:04 INFO - ##### 05:26:04 INFO - ##### Running run-tests step. 05:26:04 INFO - ##### 05:26:04 INFO - Running pre-action listener: _resource_record_pre_action 05:26:04 INFO - Running main action method: run_tests 05:26:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:26:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:26:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:26:04 INFO - 2016-03-18 05:26:04.629 screenresolution[1638:7357] starting screenresolution argv=screenresolution get 05:26:04 INFO - 2016-03-18 05:26:04.631 screenresolution[1638:7357] Display 0: 1600x1200x32@60 05:26:04 INFO - 2016-03-18 05:26:04.638 screenresolution[1639:7359] starting screenresolution argv=screenresolution list 05:26:04 INFO - Available Modes on Display 0 05:26:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:26:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:26:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:26:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:26:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:26:04 INFO - Intel Iris: 05:26:04 INFO - Chipset Model: Intel Iris 05:26:04 INFO - Type: GPU 05:26:04 INFO - Bus: Built-In 05:26:04 INFO - VRAM (Dynamic, Max): 1536 MB 05:26:04 INFO - Vendor: Intel (0x8086) 05:26:04 INFO - Device ID: 0x0a2e 05:26:04 INFO - Revision ID: 0x0009 05:26:04 INFO - Displays: 05:26:04 INFO - Display: 05:26:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:26:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:26:04 INFO - Display Serial Number: 1600x1200 60 05:26:04 INFO - Main Display: Yes 05:26:04 INFO - Mirror: Off 05:26:04 INFO - Online: Yes 05:26:04 INFO - Rotation: Supported 05:26:04 INFO - Return code: 0 05:26:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:26:04 INFO - Python 2.7.3 05:26:04 INFO - Return code: 0 05:26:04 INFO - grabbing minidump binary from tooltool 05:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26: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 0x10d8cee00>, '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 0x10d6f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8c9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:26: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 05:26: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 05:26:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:26:04 INFO - Return code: 0 05:26:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:26:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:26:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:26:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:26:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:26:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:26:06 INFO - Return code: 0 05:26:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:26:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9blUDOkCt/Render', 05:26:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:06 INFO - 'HOME': '/Users/cltbld', 05:26:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:06 INFO - 'LOGNAME': 'cltbld', 05:26:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:26:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:06 INFO - 'MOZ_NO_REMOTE': '1', 05:26:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:26:06 INFO - 'NO_EM_RESTART': '1', 05:26:06 INFO - 'PAGER': '/bin/cat', 05:26:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:06 INFO - 'PWD': '/builds/slave/test', 05:26:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:26:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:06 INFO - 'SHELL': '/bin/bash', 05:26:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DhbIRufXyl/Listeners', 05:26:06 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 05:26:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:06 INFO - 'USER': 'cltbld', 05:26:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:06 INFO - 'XPC_FLAGS': '0x0', 05:26:06 INFO - 'XPC_SERVICE_NAME': '0', 05:26:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:26:06 INFO - mozversion application_buildid: 20160318030236 05:26:06 INFO - mozversion application_changeset: 3e04659fdf6aef792f7cf9840189c6c38d08d1e8 05:26:06 INFO - mozversion application_display_name: Nightly 05:26:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:26:06 INFO - mozversion application_name: Firefox 05:26:06 INFO - mozversion application_remotingname: firefox 05:26:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:26:06 INFO - mozversion application_vendor: Mozilla 05:26:06 INFO - mozversion application_version: 48.0a1 05:26:06 INFO - mozversion platform_buildid: 20160318030236 05:26:06 INFO - mozversion platform_changeset: 3e04659fdf6aef792f7cf9840189c6c38d08d1e8 05:26:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:26:06 INFO - mozversion platform_version: 48.0a1 05:26:06 INFO - using testdate: 1458303966 05:26:06 INFO - actual date: 1458303966 05:26:06 INFO - starting webserver on 'localhost:49270' 05:26:06 INFO - SUITE-START | Running 2 tests 05:26:06 INFO - TEST-START | dromaeo_css 05:26:06 INFO - operating with platform_type : mac_ 05:26:06 INFO - Initialising browser for dromaeo_css test... 05:26:06 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/tmpMKer0f/profile http://localhost:49270/getInfo.html) 05:26:08 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 05:26:08 INFO - PROCESS | 1657 | colorDepth:24 05:26:08 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 05:26:08 INFO - PROCESS | 1657 | __metrics 05:26:08 INFO - PROCESS | 1657 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:26:08 ERROR - PROCESS | 1657 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:26:09 INFO - TEST-INFO | 1657: exit 0 05:26:09 INFO - Browser initialized. 05:26:09 INFO - Running cycle 1/1 for dromaeo_css test... 05:26:09 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/tmpMKer0f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:26:21 INFO - PROCESS | 1661 | RSS: Main: 243904512 05:26:21 INFO - PROCESS | 1661 | 05:27:12 INFO - PROCESS | 1661 | 1458304032712 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:29:22 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 05:29:24 INFO - PROCESS | 1661 | RSS: Main: 418865152 05:29:24 INFO - PROCESS | 1661 | 05:32:27 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 05:32:27 INFO - PROCESS | 1661 | RSS: Main: 378052608 05:32:27 INFO - PROCESS | 1661 | 05:35:30 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 05:35:30 INFO - PROCESS | 1661 | RSS: Main: 375390208 05:35:30 INFO - PROCESS | 1661 | 05:38:32 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 05:38:33 INFO - PROCESS | 1661 | RSS: Main: 337879040 05:38:33 INFO - PROCESS | 1661 | 05:41:36 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 05:41:36 INFO - PROCESS | 1661 | RSS: Main: 335196160 05:41:36 INFO - PROCESS | 1661 | 05:44:39 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 05:44:40 INFO - PROCESS | 1661 | RSS: Main: 391598080 05:44:40 INFO - PROCESS | 1661 | 05:44:40 INFO - PROCESS | 1661 | __start_tp_report 05:44:40 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 05:44:40 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 05:44:40 INFO - PROCESS | 1661 | |i|pagename|runs| 05:44:40 INFO - PROCESS | 1661 | |0;dojo.html;2910.3888183481467;3491.79533061094;3520.7007404370634;3524.7885126892406;3563.127033876699;5557.138643510252;5654.293213348332;5691.772329106836;5706.514946229576;5707.657540547565;5692.231548740919;5703.543716502681;5726.026575482168;5814.622049566775;5831.883362332751;5037.3451451311275;5056.84829455117;5103.183490641498;5138.023775482647;5144.588432925357;5008.273800298973;5022.397312322526;5035.723035233061;5045.621578381618;5116.386033675964;5095.133827249377;5097.490250974892;5191.1953647184555;5211.088059589557;5215.530602245816;5164.483551644806;5165.354330708661;5170.353705786777;5172.767225474862;5212.817551385683;5098.923516147223;5117.667351622133;5123.974380128113;5148.9742551287;5176.663516871429;5499.972500137514;5628.240187574666;5641.548676105902;5671.291088613923;5741.425857414267;5152.587792976553;6167.537434692416;6203;6210.627362358227;6236.719347629368;6240.625562466266;6299.65351905645;6313.084602732624;6313.3686631336495;6330.525210609177;5653.604247702662;5695.572832037614;5758.74085666146;5768.192453056576;5771.307443106812;6251.843703907439;6317.1156038154695;6369.681515924185;6388.584741991755;6388.680565971776;6069.241344831896;6077.875593015307;6125.418085281891;6128.142060111588;6137.570370074052;6151.507879369639;6272.686365681698;6274.937250627527;6276.184096067574;6306.9684651576445;6035.6076855004285;6134.662593557308;6144.662043587646;6156.661383623854;6172.475339596095;6162.044883043135;6199.411055949678;6201.131841542187;6201.162843016225;6209.316975132731;4826.32431459596;4881.804727810919;4885.169521181408;4889.48660390661;4918.901621967612;4332.826686932487;4364.345348197732;4439.889002774892;4463.419755431773;4465.642748580106;5656.6888821115235;5656.85857853557;5658.943410565924;5681.630694004876;5686.402927692616;6247.75008999644;6276.780312689034;6279.3720627937755;6285.685715714196;6297.464715499143;5524.917126243109;5604.243427137366;5633.183188437653;5696.974544581932;5730.684812335361;5341;5348.1442969124755;5349.465053494697;5362.2224777407055;5370.650907690988;6281.932071547848;6318.052292156213;6320.905186422299;6331.905021424683;6343.397377249154;6028.216331876828;6122.2761798032625;6148;6227.1282020516255;6235.532335074979;5303.36359636846;6325.082862984934;6341.968290158519;6346.333634968447;6348.650824204528;6066.241719785027;6068.51451883857;6075.30134034574;6076.635401875901;6078.3617720138745;6097.420745029215;6104.0347610180015;6130.948521380091;6164.260288765377;6170.043643235305;5884.558658100574;5899.882002359843;5901.409859014236;5902.085176797432;5950.166976623363;5108.948910510996;5403.784148566541;5904.940950590611;5921.3190483094995;5934.495567876779;5705.7147142643535;5741.397153299011;5770.278715160605;5778.739956702043;5850.356460789225;5874.236349274567;5914.615549989237;5917.644941303535;5932.762689492372;5944.375840536682;5817.941820581909;5823.388544202798;5828.067509198508;5830.329512105993;5831.387704290988 05:44:40 INFO - PROCESS | 1661 | |1;ext.html;483.26784920844904;542.8045903474748;568.9146628005799;626.4330780643518;635.0791352538816;29863.55204671929;38719.612803871954;38901.8054909725;39074.4138837917;39127.21745565087;41375.379369309485;41762.373564396556;41791.79104104475;41822.099353606696;41979.58020419795;9608.135267825894;9797.755056123582;9824;9826.213902887752;9839.360441571274;9623.663171788989;9774.804503909918;9779.755506112333;9790.461524616143;9899.703008909708;9821.852672209923;9892.505374731234;9894.604215831358;9894.653687120952;9918.008199180096;9794.069563391466;9856.90143098567;9862.704118876409;9864.65473708424;9865.90134098657;9503.192228660571;9644.132028117503;9656.951715241448;9662.9516852416;9664.081912218327;39437.014074648076;39827.60172398297;39829.00427489336;39925;39981.60018399808;3428.8114153721535;3610.7833529988284;3778.376567866299;3839.9232015359817;4136.048708796993;23798.762012379826;27868.88524459019;28341.008064717636;28382.57426138589;28970.565441518393;2709.91870243893;2739.356251280947;2742.903998360068;2809.0028040045695;2814.4652516021893;468204.65897670295;468807;470186;471291.14835406543;472217;67642.98535521972;67952;67971.66014169897;68123.3187668117;68334.31665683379;60604;68254;72649.2735072653;73516;73557;17021.659566808594;17109.887857289235;17280.740788888175;17308.394206202724;17363.56591085233;13128.015398845126;13165.210087394787;13186.142900711424;13200;13238.933805330911;21479.140834366764;21718;21719.348419547438;21748.347549573537;21781.693098414147;7736.7678969631;8999.595018224196;9260.536973151315;9268.397554158959;9287.62849486013;945.4563625915126;973.8149751547184;1022.2639699416409;1059.6185373265619;1108.8634149996158;27027;27764;27897;27914.44171116607;27926.72073279241;970.1608108985677;1102.862142232221;1144.7882141803793;1148.4143087025677;1172.5251273234353;14038.789418158736;14352.856471435152;14366.281685915663;14566.19885906264;14767.26163691811;597812;601212;605299;606339;607710;61634;62200;62207;62259;62504.68747656233;1350.9121907076008;1447.7032208397254;1460.9853901461063;1466.7213229486576;1473.4106357457104;29735.85132074326;30126.945556905404;30752.69247307498;30834.894340129387;31067.378652427276;56492;57115.14327285011;57194.7140264296;57205.713971429876;57301.42698572961;446815;467455;468754;469691;469940;36742;43695.78152109219;44094.559054409045;44537.55462445334;45143;43954.90112747079;44244;44818.87952801206;45257.868553285116;45630.77184614056;37729.05677358088;37987.43018854664;37996.43005354867;38689.80655096706;39069.60930390773;37055.44416833696;37265.41822721598;37406;37969.4304585437;38018.80990595029;32340;37420.62579374172;38123.80938095292;38261.46954121804;38268.85193444201;31828.68171318257;32641.18397039998;32658.346833063682;32764.50853237251;32808;24069.398265043514;24642.260732178063;24677.50644987126;24942.750572494042;25008.74991250137 05:44:40 INFO - PROCESS | 1661 | |2;jquery.html;345.48867675839756;353.325148965476;354.84741561128703;360.53851070629605;365.2767520309785;19121;19288.807111928876;19653.64156301244;20042.498937526532;20086.69869951952;16112.274947627355;18532.258709651596;19547.609047819034;19832.909189994545;19875.900620496912;5661.631993920392;5857.502112320437;5870.911936320958;5888.263967004124;5933.228680271559;4200.915981680379;4405.933910991338;5854.121881717755;6149.446549810516;6442.162518872564;6357.65032923189;6382.329855365189;6392.936070639281;6401.5838970467;6409.327020662833;6106.755729770804;6406;6407.807765766988;6418.06937993993;6422.421982021617;3684.336819372512;5223.399309079467;5415.404305526428;5435.1847222916485;5503.477169668875;24079.398015049588;24273.150439734523;24528.632070518957;25784.74215257861;25790.484190316278;2038.8368930485674;2103.295396042328;2317.2700599311165;2697.5144473994674;2955.7635389168813;13188.076834621581;13221.405036773369;14267.643308917257;14446.711065778625;14516.346764395628;1678.8992660440413;1777.7155655095123;1795.5152108930647;1823;1891.5838515526561;75083.24916750817;91247;93648.12703745886;93999.59000614996;96067.55898661526;9690.806183876282;9754.731884854924;10091.848622270672;10303.175745940307;10554.155667546731;12671.87328126707;12762.425690843935;12777.93611031939;12794.488220471263;12813;8502.234798868009;8681.479111253346;8682.218600326001;8785.736427907173;8821.779455513664;9023.729288121367;9059.592318345558;9075.273978081737;9164.770880728036;9181.632734690538;6089.360617135226;6171.506279497629;6192.411720886508;6198.318184999646;6257;1645.8518733314058;1722.070082155622;1726.4561663076342;1728.0409372797967;1742.7473016412548;881.8544940084814;912.0970239463016;945.8533927241289;1026.7381817636456;1030.7783826477344;17084.40204592833;20974.2659006934;21356.893215534135;21579.568408631738;21596.784032159478;996.8554559588819;1002.4486532407146;1042.525650828871;1056.292284169593;1056.693558867935;10467.581296748045;10945.069669078059;10959.397233152094;11353.091752659768;11548.307101573933;628702;648116;652228;665038;666224;112324;113147;113397;113456;114769.4261528687;1043.7025447747355;1073.983890241647;1088.3361149698678;1089.4661615808197;1093.5024563823442;14489.347979340744;17559.736603951205;17699.557511062325;17838.464846054638;18260.452186434428;47591.04817903553;47996.29025743891;48251;48537.54387368385;49075.509244907094;71594.28405715876;71752;71760;71919.64040179766;72316.63841680757;5885.234919460443;7132.393746531603;7146.106736657918;7181.210066892533;7482.925170748223;11310.552233380888;12045.096617753528;12084.879151208375;12115.818262726243;12277.26336419782;8416.621252043795;10174.796504069729;10339.379637221791;10604.363738175734;10627;9388.95305523468;10054.29619926598;10349.379037257788;10547.578096876347;10549.208809339178;10477.842832357674;10498.95010498944;10634.73413164677;10676.733081673021;10737.194710396596;5760.308762948473;7563.9621801890635;7668.884966725392;7685.692572297045;7695.345895598937;10040.497975101362;10394.58421663125;10395.792084158425;10501.842472363074;10632.043116119587 05:44:40 INFO - PROCESS | 1661 | |3;mootools.html;1427.6074079628108;1464.9926750366246;1522.1399909051386;1818.2181661885384;1998.4004798560438;6997.9650101749485;8029.558374289411;8796;8804.339674524412;8806.163414475615;8454.492730436179;8727.127287271269;8729.607167677454;8734.86897696535;8746.300295976322;2369.9407514812183;2397.7722116399;2398.6881705378364;2401.9639705404434;2405.0980882169188;2397.568437681217;2432.7323994360604;2454.435479839638;2459.409741662006;2462.901483940649;2425.721042080157;2433.634954756792;2446;2453.55835949529;2460.9138680146107;2413.046846495642;2450.4363996280867;2450.840695354796;2453.9631905521433;2460.6063029915126;2390.414348484615;2429.259075981825;2435.3059378077164;2441.401856545158;2442.755724427561;8879.689210877654;8900.688475903376;8918.331125165638;8926.419782714167;8942.552872356357;5373.81191658294;5497.752601132918;5514.420985796473;5519.365272993577;5530.364008139035;3590.982045089758;3669.889903302905;3720.572134204574;3747.756395834262;3749.606291339425;927.2118699105706;1057.5716834681966;1072.5120070367964;1076.9892301076968;1085.4138765066934;10081.44552049637;11968.281903085755;11980.760384792342;12026;12036.999999999913;4813.844677277428;4827.782749776268;4834.105690447279;4868.367112275452;4871.342368780241;10133.341332813343;10137;10142.594296228215;10152.593896244067;10155.339902906288;5470.671759694352;5472.480114389126;5476.315460567429;5476.561875050066;5478.561715062865;4443.400140980926;4606.700564463299;4800.903981920412;4930.605551555867;4978.950210497921;3899.493065901415;3966.7421617594764;3968.761874287552;3988.102676897675;4016.9196616067516;1302.2381906584753;1309.3387839141174;1315.5724389573427;1325.4499382756242;1334.3261652865242;975.2782940623887;1011.3830563356347;1166.9416529173677;1256.5664845628426;1400.95096671616;7990.64042118106;7996.64015119321;8104.0680321762575;8115.3913456491;8124.390670699721;1198.4007996002;1207.4506099724604;1209.5585111434264;1217.975640487203;1228.4840367045863;6141.815745527641;6145.108959200891;6202.472789812826;6208.379162083756;6218.968905155445;10318.690439286833;11010.559577616967;11046.447677616248;11065.391403472726;11065.778684426428;10592.046715795615;10725.892741072645;10848.403337816339;10854.837177442345;10882.966118218757;8314.127016663284;8415.705450309331;8464.746057618282;8492.957535212408;8494.447860889022;7875.369970402239;7882.290593846581;7949.364050875801;7983.441159118806;7985.92014079875;9380.29647776406;9588.089131532493;9669.129778319984;9710.660126895526;9774.951125244328;9764.974677659027;9960.601575936882;9967.302288840001;10087.243456740627;10178.6437474691;7333.963330183315;7352.37504812097;7382.704691812482;7394.371478424179;7453.478256521991;8191.180881911761;8222.712205072794;8244.29923456513;8280.792980175544;8294.958525207336;6331.746730130743;7387.9683087149315;7526.059242594676;7635.23647635232;7681.731139410093;6245.96877015612;7260.087862830748;7309.488335816654;7320.194778574459;7432.814179645552;7644.770656880302;7762.223777622193;7773.18381569927;7795.103563090317;7801.570913599807;7004.824879377852;7023.578585284899;7115.039469671528;7120.537165084253;7123.679434425359;5943.494802941798;7188.317109874553;7209.0628218331285;7218.963905180441;7223.1693355264815 05:44:40 INFO - PROCESS | 1661 | |4;prototype.html;318.3235624298366;320.4408307503407;326.8540299616194;329.0441268116123;329.8466213210858;6395.904061439076;6496.447801936841;6502.9920362343855;6523.24982626998;6538.182727159111;6394.488440924726;6409.967950160254;6450.870982580357;6457.999999999988;6460.38626330499;4542.977285113569;4630.120277147331;4631.513691062441;4686.695364801294;4828.999999999991;4576.290674945372;4580.885477863063;4699;4720.0559888022535;4739.976300118495;4679.15775160471;4680.25115981443;4704.97647511762;4705.929411058837;4710.246360582308;4668.136394766979;4691.014886873761;4691.483936766953;4700.412448443944;4704;3891.9221615567812;3950.5654378018394;4060.817263223162;4083.244599749056;4087.2438598859308;5527.977324194997;5622.156676498558;6158.322584515699;6159.3224745277985;6184.474319682832;5588.133839254922;5592.412796656333;5596.720163991784;5606.131049687305;5609.831705048855;6834.794956151323;6838.452923766136;6847.760328388532;6860.485463590251;6861.725530978755;3796.52543432071;4586.633069354443;4592.655550833668;4596.287575425815;4609.285560738057;6955.374016338503;7247.565146091199;7262.455315851333;7276.308750668731;7288.890666640004;4666.883327916829;4699.647526435531;4702.247640377524;4707.764611769398;4727.220008698595;4816.20532612122;4816.975915120472;4818.494382920861;4819.421669399624;4829.517048295143;5611.607187496836;5614.578906582023;5614.6631202128;5627;5632.155176723442;5615.719214039282;6631.6684165792485;6852.45180385568;6907;6918.619475928772;1623.8863279570553;1666.3667806233796;1669.9415520456726;1672.0552887618458;1672.4313733330725;1067.5729708116814;1088.6951653536864;1097.7200813792592;1106.5463160104318;1107.479484642217;4858.416989961157;6086.695665216722;6336.334684858023;6348.841278968062;6363.140975968277;6985.266547012592;7066.505344625827;7214.242504537053;7234.891476627855;7244.311790379906;6440.516961227927;6441.32366101562;6450;6450.903236451457;6452.580582262138;3665.248624032067;3788.6969042476535;3790.8673196437994;3794.924101517954;3801.315763162602;7176.390006849372;7555.508891922007;7568.394528437711;7572.659230334648;7580.696772129053;7418.221086785918;7429.108506979197;7440.590767507731;7442.404607631376;7473.103227612722;7542.2834830691;7554.660040298199;7559.3196612305155;7563.848723025619;7570.545767253982;7196.424286057208;7200.89198662031;7208.207097219407;7215.8556828864175;7223.747168849065;6837.35045170708;7094.184168820651;7098.822529436598;7100.538464999759;7108.644567771487;7497.250274972459;7534.773956781305;7554.811129721801;7564.546127232384;7565.167831538416;4733.100710864925;4734.834280800155;4738.4787673356595;4739.0521895621705;4749.667523273338;5783.479486846036;5855.502282306052;7143.892841607484;7151.034610327539;7157.105361829771;6606.8348291293105;6879.6216208107035;6908.1019467468905;6909.654517274217;6938.06336144614;6893.620850853251;6906.102206713095;6910.723571057101;6920.619365934721;6923.342282483156;6684.097646817618;6724.428423583854;6740.224874139537;6743.35938085881;6743.52795304324;6908.447324214151;6913.585184888922;6914.9308506914285;6918.411934985583;6926.9307306926285;6502.577332473374;6733.293004234485;6752.763653272112;6755.324467553205;6766.830829229112 05:44:40 INFO - PROCESS | 1661 | |5;yui.html;676.5805200775517;677.9728810847565;693.4036728413566;699.7585832887654;700.5341447937119;14484.63788405289;14527.983041187133;14673.266336683164;15809;16038.679226415465;14651.853481465183;14799.186044767534;14809.555713328617;14811.111333320008;14829.036112652697;738.2949283434307;751.9248075192464;894.6689724801832;899.3299991506337;920.0891117793403;916.720400277915;920.7559996600907;921.2261700171854;922.5341202692631;922.7416323429451;971.2472833554017;978.7161723100328;980.039561229995;980.8283550378691;982.3810999070575;652.879217344788;788.538704857659;790.640258682304;970.8592254123148;973.5764942250108;686.6532401137443;715.5277516838913;715.6636380900968;715.7387553542972;716.7312257903286;12642.431090600945;15175.848241517664;15235.847641523664;15241.923790381088;15279.541613751606;9959.502024898798;12598.874011259863;12697.619071427873;12704.364781760967;12849.67875803103;8215.644418670972;9889.60441582343;10036.749081272954;10110.595576176944;10846.403447810446;3131.389379071082;3653.178034942117;3660.560732712065;3670.009097543675;3759.2669429461266;79908.60045699793;80205;80401;80527.5973620134;80715.5964220181;9060.411073280216;9158.403557355492;9286;9329.346945713734;9683.951580242054;20850.58298834015;21466;21482.355529334145;21501.354959351243;21525.354239372842;7256.2743725627015;7460.104787425544;7468.775936721907;7470.402367810562;7546.019017527796;4104.486939132608;4160.126373461607;4163.146554956226;4165.375193720966;4178.958210417918;3581.6239294874185;3616.4213725803747;3617.3127105849803;3617.4031284838234;3626.5104210931713;625.0967352176153;634.4290138874957;647.233028860792;651.1730102769457;664.4485077385758;498.81793145502354;504.57867680487203;524.0854708533633;526.4209369693307;535.7937194180191;8113.553754543439;8115.594220288962;8170.754877353689;8350.164983501723;8372.41393102477;566.0546886699223;600.2826622186533;601.1133577972543;601.227422761749;623.9968800155971;2996.325826689021;3638.4542318652416;3809.5428548573796;3850.4609354690365;4065.065035041957;69586;92162.61756073665;96324.51837740907;96580;96761.51619241858;79984.6000770004;80469.59765201254;81100;81149;81277;68577;68831;69170.61658766796;69472.30527694861;71438;7795.532268063935;7855.057393112635;7927.960360198162;7943.563104029334;8037.075736290168;47514.524854752395;47618.285725713446;47753.761231193625;47788.28317575309;47794.52205477901;60023;60442;66615;66782.3321766776;67384.38074731994;9959.05388988045;10003.749906252111;10020.24848136378;10330.690079297634;10601.151907847508;10834.945825270823;10952.835707464235;11286.774264514828;11296.43517824122;11315.259796735032;10402.427866467417;10510.369377837354;10583.94708026455;10589.311694739818;10822.67531974042;10049.346792458467;10266.230032747722;10425.374477531372;10725.678229653124;11187.216894817284;10121.746956326151;10167.034131757471;10202.438865862448;10225.079742823182;10503.842442363524;8679.522626255364;8804.64781408762;8837.116288371111;8951.104889510996;9340.626374944926;7551.73568925085;8835.602397892239;8946.418482798597;9062.637494500146;9067.637294508146 05:44:40 INFO - PROCESS | 1661 | __end_tp_report 05:44:40 INFO - PROCESS | 1661 | __start_cc_report 05:44:40 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,1692 05:44:40 INFO - PROCESS | 1661 | __end_cc_report 05:44:40 INFO - PROCESS | 1661 | __startTimestamp1458305080222__endTimestamp 05:44:40 INFO - PROCESS | 1661 | 05:44:40 INFO - PROCESS | 1661 | ------- Summary: start ------- 05:44:40 INFO - PROCESS | 1661 | Number of tests: 6 05:44:40 INFO - PROCESS | 1661 | 05:44:40 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5673.96 Median:5817.94 stddev:636.44 (10.9%) stddev-sans-first:600.34 05:44:40 INFO - PROCESS | 1661 | Values: 2910.4 3491.8 3520.7 3524.8 3563.1 5557.1 5654.3 5691.8 5706.5 5707.7 5692.2 5703.5 5726.0 5814.6 5831.9 5037.3 5056.8 5103.2 5138.0 5144.6 5008.3 5022.4 5035.7 5045.6 5116.4 5095.1 5097.5 5191.2 5211.1 5215.5 5164.5 5165.4 5170.4 5172.8 5212.8 5098.9 5117.7 5124.0 5149.0 5176.7 5500.0 5628.2 5641.5 5671.3 5741.4 5152.6 6167.5 6203.0 6210.6 6236.7 6240.6 6299.7 6313.1 6313.4 6330.5 5653.6 5695.6 5758.7 5768.2 5771.3 6251.8 6317.1 6369.7 6388.6 6388.7 6069.2 6077.9 6125.4 6128.1 6137.6 6151.5 6272.7 6274.9 6276.2 6307.0 6035.6 6134.7 6144.7 6156.7 6172.5 6162.0 6199.4 6201.1 6201.2 6209.3 4826.3 4881.8 4885.2 4889.5 4918.9 4332.8 4364.3 4439.9 4463.4 4465.6 5656.7 5656.9 5658.9 5681.6 5686.4 6247.8 6276.8 6279.4 6285.7 6297.5 5524.9 5604.2 5633.2 5697.0 5730.7 5341.0 5348.1 5349.5 5362.2 5370.7 6281.9 6318.1 6320.9 6331.9 6343.4 6028.2 6122.3 6148.0 6227.1 6235.5 5303.4 6325.1 6342.0 6346.3 6348.7 6066.2 6068.5 6075.3 6076.6 6078.4 6097.4 6104.0 6130.9 6164.3 6170.0 5884.6 5899.9 5901.4 5902.1 5950.2 5108.9 5403.8 5904.9 5921.3 5934.5 5705.7 5741.4 5770.3 5778.7 5850.4 5874.2 5914.6 5917.6 5932.8 5944.4 5817.9 5823.4 5828.1 5830.3 5831.4 05:44:40 INFO - PROCESS | 1661 | 05:44:40 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:66450.05 Median:39953.30 stddev:137584.60 (344.4%) stddev-sans-first:137881.41 05:44:40 INFO - PROCESS | 1661 | Values: 483.3 542.8 568.9 626.4 635.1 29863.6 38719.6 38901.8 39074.4 39127.2 41375.4 41762.4 41791.8 41822.1 41979.6 9608.1 9797.8 9824.0 9826.2 9839.4 9623.7 9774.8 9779.8 9790.5 9899.7 9821.9 9892.5 9894.6 9894.7 9918.0 9794.1 9856.9 9862.7 9864.7 9865.9 9503.2 9644.1 9657.0 9663.0 9664.1 39437.0 39827.6 39829.0 39925.0 39981.6 3428.8 3610.8 3778.4 3839.9 4136.0 23798.8 27868.9 28341.0 28382.6 28970.6 2709.9 2739.4 2742.9 2809.0 2814.5 468204.7 468807.0 470186.0 471291.1 472217.0 67643.0 67952.0 67971.7 68123.3 68334.3 60604.0 68254.0 72649.3 73516.0 73557.0 17021.7 17109.9 17280.7 17308.4 17363.6 13128.0 13165.2 13186.1 13200.0 13238.9 21479.1 21718.0 21719.3 21748.3 21781.7 7736.8 8999.6 9260.5 9268.4 9287.6 945.5 973.8 1022.3 1059.6 1108.9 27027.0 27764.0 27897.0 27914.4 27926.7 970.2 1102.9 1144.8 1148.4 1172.5 14038.8 14352.9 14366.3 14566.2 14767.3 597812.0 601212.0 605299.0 606339.0 607710.0 61634.0 62200.0 62207.0 62259.0 62504.7 1350.9 1447.7 1461.0 1466.7 1473.4 29735.9 30126.9 30752.7 30834.9 31067.4 56492.0 57115.1 57194.7 57205.7 57301.4 446815.0 467455.0 468754.0 469691.0 469940.0 36742.0 43695.8 44094.6 44537.6 45143.0 43954.9 44244.0 44818.9 45257.9 45630.8 37729.1 37987.4 37996.4 38689.8 39069.6 37055.4 37265.4 37406.0 37969.4 38018.8 32340.0 37420.6 38123.8 38261.5 38268.9 31828.7 32641.2 32658.3 32764.5 32808.0 24069.4 24642.3 24677.5 24942.8 25008.7 05:44:40 INFO - PROCESS | 1661 | 05:44:40 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:34840.66 Median:24176.27 stddev:107525.48 (444.8%) stddev-sans-first:107795.92 05:44:40 INFO - PROCESS | 1661 | Values: 345.5 353.3 354.8 360.5 365.3 19121.0 19288.8 19653.6 20042.5 20086.7 16112.3 18532.3 19547.6 19832.9 19875.9 5661.6 5857.5 5870.9 5888.3 5933.2 4200.9 4405.9 5854.1 6149.4 6442.2 6357.7 6382.3 6392.9 6401.6 6409.3 6106.8 6406.0 6407.8 6418.1 6422.4 3684.3 5223.4 5415.4 5435.2 5503.5 24079.4 24273.2 24528.6 25784.7 25790.5 2038.8 2103.3 2317.3 2697.5 2955.8 13188.1 13221.4 14267.6 14446.7 14516.3 1678.9 1777.7 1795.5 1823.0 1891.6 75083.2 91247.0 93648.1 93999.6 96067.6 9690.8 9754.7 10091.8 10303.2 10554.2 12671.9 12762.4 12777.9 12794.5 12813.0 8502.2 8681.5 8682.2 8785.7 8821.8 9023.7 9059.6 9075.3 9164.8 9181.6 6089.4 6171.5 6192.4 6198.3 6257.0 1645.9 1722.1 1726.5 1728.0 1742.7 881.9 912.1 945.9 1026.7 1030.8 17084.4 20974.3 21356.9 21579.6 21596.8 996.9 1002.4 1042.5 1056.3 1056.7 10467.6 10945.1 10959.4 11353.1 11548.3 628702.0 648116.0 652228.0 665038.0 666224.0 112324.0 113147.0 113397.0 113456.0 114769.4 1043.7 1074.0 1088.3 1089.5 1093.5 14489.3 17559.7 17699.6 17838.5 18260.5 47591.0 47996.3 48251.0 48537.5 49075.5 71594.3 71752.0 71760.0 71919.6 72316.6 5885.2 7132.4 7146.1 7181.2 7482.9 11310.6 12045.1 12084.9 12115.8 12277.3 8416.6 10174.8 10339.4 10604.4 10627.0 9389.0 10054.3 10349.4 10547.6 10549.2 10477.8 10499.0 10634.7 10676.7 10737.2 5760.3 7564.0 7668.9 7685.7 7695.3 10040.5 10394.6 10395.8 10501.8 10632.0 05:44:40 INFO - PROCESS | 1661 | 05:44:40 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:6060.12 Median:5422.24 stddev:3192.87 (58.9%) stddev-sans-first:3182.84 05:44:40 INFO - PROCESS | 1661 | Values: 1427.6 1465.0 1522.1 1818.2 1998.4 6998.0 8029.6 8796.0 8804.3 8806.2 8454.5 8727.1 8729.6 8734.9 8746.3 2369.9 2397.8 2398.7 2402.0 2405.1 2397.6 2432.7 2454.4 2459.4 2462.9 2425.7 2433.6 2446.0 2453.6 2460.9 2413.0 2450.4 2450.8 2454.0 2460.6 2390.4 2429.3 2435.3 2441.4 2442.8 8879.7 8900.7 8918.3 8926.4 8942.6 5373.8 5497.8 5514.4 5519.4 5530.4 3591.0 3669.9 3720.6 3747.8 3749.6 927.2 1057.6 1072.5 1077.0 1085.4 10081.4 11968.3 11980.8 12026.0 12037.0 4813.8 4827.8 4834.1 4868.4 4871.3 10133.3 10137.0 10142.6 10152.6 10155.3 5470.7 5472.5 5476.3 5476.6 5478.6 4443.4 4606.7 4800.9 4930.6 4979.0 3899.5 3966.7 3968.8 3988.1 4016.9 1302.2 1309.3 1315.6 1325.4 1334.3 975.3 1011.4 1166.9 1256.6 1401.0 7990.6 7996.6 8104.1 8115.4 8124.4 1198.4 1207.5 1209.6 1218.0 1228.5 6141.8 6145.1 6202.5 6208.4 6219.0 10318.7 11010.6 11046.4 11065.4 11065.8 10592.0 10725.9 10848.4 10854.8 10883.0 8314.1 8415.7 8464.7 8493.0 8494.4 7875.4 7882.3 7949.4 7983.4 7985.9 9380.3 9588.1 9669.1 9710.7 9775.0 9765.0 9960.6 9967.3 10087.2 10178.6 7334.0 7352.4 7382.7 7394.4 7453.5 8191.2 8222.7 8244.3 8280.8 8295.0 6331.7 7388.0 7526.1 7635.2 7681.7 6246.0 7260.1 7309.5 7320.2 7432.8 7644.8 7762.2 7773.2 7795.1 7801.6 7004.8 7023.6 7115.0 7120.5 7123.7 5943.5 7188.3 7209.1 7219.0 7223.2 05:44:40 INFO - PROCESS | 1661 | 05:44:40 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:5655.44 Median:6425.24 stddev:1795.45 (27.9%) stddev-sans-first:1755.23 05:44:40 INFO - PROCESS | 1661 | Values: 318.3 320.4 326.9 329.0 329.8 6395.9 6496.4 6503.0 6523.2 6538.2 6394.5 6410.0 6450.9 6458.0 6460.4 4543.0 4630.1 4631.5 4686.7 4829.0 4576.3 4580.9 4699.0 4720.1 4740.0 4679.2 4680.3 4705.0 4705.9 4710.2 4668.1 4691.0 4691.5 4700.4 4704.0 3891.9 3950.6 4060.8 4083.2 4087.2 5528.0 5622.2 6158.3 6159.3 6184.5 5588.1 5592.4 5596.7 5606.1 5609.8 6834.8 6838.5 6847.8 6860.5 6861.7 3796.5 4586.6 4592.7 4596.3 4609.3 6955.4 7247.6 7262.5 7276.3 7288.9 4666.9 4699.6 4702.2 4707.8 4727.2 4816.2 4817.0 4818.5 4819.4 4829.5 5611.6 5614.6 5614.7 5627.0 5632.2 5615.7 6631.7 6852.5 6907.0 6918.6 1623.9 1666.4 1669.9 1672.1 1672.4 1067.6 1088.7 1097.7 1106.5 1107.5 4858.4 6086.7 6336.3 6348.8 6363.1 6985.3 7066.5 7214.2 7234.9 7244.3 6440.5 6441.3 6450.0 6450.9 6452.6 3665.2 3788.7 3790.9 3794.9 3801.3 7176.4 7555.5 7568.4 7572.7 7580.7 7418.2 7429.1 7440.6 7442.4 7473.1 7542.3 7554.7 7559.3 7563.8 7570.5 7196.4 7200.9 7208.2 7215.9 7223.7 6837.4 7094.2 7098.8 7100.5 7108.6 7497.3 7534.8 7554.8 7564.5 7565.2 4733.1 4734.8 4738.5 4739.1 4749.7 5783.5 5855.5 7143.9 7151.0 7157.1 6606.8 6879.6 6908.1 6909.7 6938.1 6893.6 6906.1 6910.7 6920.6 6923.3 6684.1 6724.4 6740.2 6743.4 6743.5 6908.4 6913.6 6914.9 6918.4 6926.9 6502.6 6733.3 6752.8 6755.3 6766.8 05:44:40 INFO - PROCESS | 1661 | 05:44:40 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:17937.29 Median:649.20 stddev:25522.79 (3931.4%) stddev-sans-first:25561.48 05:44:40 INFO - PROCESS | 1661 | Values: 676.6 678.0 693.4 699.8 700.5 14484.6 14528.0 14673.3 15809.0 16038.7 14651.9 14799.2 14809.6 14811.1 14829.0 738.3 751.9 894.7 899.3 920.1 916.7 920.8 921.2 922.5 922.7 971.2 978.7 980.0 980.8 982.4 652.9 788.5 790.6 970.9 973.6 686.7 715.5 715.7 715.7 716.7 12642.4 15175.8 15235.8 15241.9 15279.5 9959.5 12598.9 12697.6 12704.4 12849.7 8215.6 9889.6 10036.7 10110.6 10846.4 3131.4 3653.2 3660.6 3670.0 3759.3 79908.6 80205.0 80401.0 80527.6 80715.6 9060.4 9158.4 9286.0 9329.3 9684.0 20850.6 21466.0 21482.4 21501.4 21525.4 7256.3 7460.1 7468.8 7470.4 7546.0 4104.5 4160.1 4163.1 4165.4 4179.0 3581.6 3616.4 3617.3 3617.4 3626.5 625.1 634.4 647.2 651.2 664.4 498.8 504.6 524.1 526.4 535.8 8113.6 8115.6 8170.8 8350.2 8372.4 566.1 600.3 601.1 601.2 624.0 2996.3 3638.5 3809.5 3850.5 4065.1 69586.0 92162.6 96324.5 96580.0 96761.5 79984.6 80469.6 81100.0 81149.0 81277.0 68577.0 68831.0 69170.6 69472.3 71438.0 7795.5 7855.1 7928.0 7943.6 8037.1 47514.5 47618.3 47753.8 47788.3 47794.5 60023.0 60442.0 66615.0 66782.3 67384.4 9959.1 10003.7 10020.2 10330.7 10601.2 10834.9 10952.8 11286.8 11296.4 11315.3 10402.4 10510.4 10583.9 10589.3 10822.7 10049.3 10266.2 10425.4 10725.7 11187.2 10121.7 10167.0 10202.4 10225.1 10503.8 8679.5 8804.6 8837.1 8951.1 9340.6 7551.7 8835.6 8946.4 9062.6 9067.6 05:44:40 INFO - PROCESS | 1661 | -------- Summary: end -------- 05:44:40 INFO - PROCESS | 1661 | 05:44:40 INFO - TEST-INFO | 1661: exit 0 05:44:40 INFO - TEST-OK | dromaeo_css | took 1114421ms 05:44:40 INFO - TEST-START | kraken 05:44:40 INFO - operating with platform_type : mac_ 05:44:40 INFO - Initialising browser for kraken test... 05:44:40 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/tmpCqcAVg/profile http://localhost:49270/getInfo.html) 05:44:43 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 05:44:43 INFO - PROCESS | 1672 | colorDepth:24 05:44:43 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 05:44:43 INFO - PROCESS | 1672 | __metrics 05:44:43 INFO - PROCESS | 1672 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:44:43 ERROR - PROCESS | 1672 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:44:43 INFO - TEST-INFO | 1672: exit 0 05:44:43 INFO - Browser initialized. 05:44:43 INFO - Running cycle 1/1 for kraken test... 05:44:43 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/tmpCqcAVg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:44:55 INFO - PROCESS | 1675 | RSS: Main: 243122176 05:44:55 INFO - PROCESS | 1675 | 05:44:58 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 05:44:58 INFO - PROCESS | 1675 | RSS: Main: 291700736 05:44:58 INFO - PROCESS | 1675 | 05:45:01 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 05:45:02 INFO - PROCESS | 1675 | RSS: Main: 300445696 05:45:02 INFO - PROCESS | 1675 | 05:45:05 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 05:45:05 INFO - PROCESS | 1675 | RSS: Main: 287784960 05:45:05 INFO - PROCESS | 1675 | 05:45:07 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 05:45:08 INFO - PROCESS | 1675 | RSS: Main: 291315712 05:45:08 INFO - PROCESS | 1675 | 05:45:10 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:45:11 INFO - PROCESS | 1675 | RSS: Main: 291098624 05:45:11 INFO - PROCESS | 1675 | 05:45:13 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 05:45:14 INFO - PROCESS | 1675 | RSS: Main: 292384768 05:45:14 INFO - PROCESS | 1675 | 05:45:17 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 05:45:18 INFO - PROCESS | 1675 | RSS: Main: 291057664 05:45:18 INFO - PROCESS | 1675 | 05:45:20 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 05:45:21 INFO - PROCESS | 1675 | RSS: Main: 292958208 05:45:21 INFO - PROCESS | 1675 | 05:45:22 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:45:23 INFO - PROCESS | 1675 | RSS: Main: 325300224 05:45:23 INFO - PROCESS | 1675 | 05:45:25 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:45:25 INFO - PROCESS | 1675 | RSS: Main: 326090752 05:45:25 INFO - PROCESS | 1675 | 05:45:27 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:45:28 INFO - PROCESS | 1675 | RSS: Main: 332812288 05:45:28 INFO - PROCESS | 1675 | 05:45:31 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:45:31 INFO - PROCESS | 1675 | RSS: Main: 333946880 05:45:31 INFO - PROCESS | 1675 | 05:45:34 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:45:34 INFO - PROCESS | 1675 | RSS: Main: 334934016 05:45:34 INFO - PROCESS | 1675 | 05:45:36 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 05:45:36 INFO - PROCESS | 1675 | RSS: Main: 395673600 05:45:36 INFO - PROCESS | 1675 | 05:45:36 INFO - PROCESS | 1675 | __start_tp_report 05:45:36 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 05:45:36 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 05:45:36 INFO - PROCESS | 1675 | |i|pagename|runs| 05:45:36 INFO - PROCESS | 1675 | |0;ai-astar;112;107;109;111;111;112;119;112;111;112 05:45:36 INFO - PROCESS | 1675 | |1;audio-beat-detection;155;119;141;156;120;139;136;123;191;150 05:45:36 INFO - PROCESS | 1675 | |2;audio-dft;185;186;188;186;187;188;187;187;183;184 05:45:36 INFO - PROCESS | 1675 | |3;audio-fft;76;79;82;77;56;57;58;80;77;57 05:45:36 INFO - PROCESS | 1675 | |4;audio-oscillator;95;99;128;79;77;87;146;112;79;115 05:45:36 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;90;86;91;87;89;86;91;90;90;86 05:45:36 INFO - PROCESS | 1675 | |6;imaging-darkroom;95;95;95;111;149;114;95;95;93;94 05:45:36 INFO - PROCESS | 1675 | |7;imaging-desaturate;85;88;86;85;84;85;85;88;87;87 05:45:36 INFO - PROCESS | 1675 | |8;json-parse-financial;56;54;53;53;53;54;54;63;56;53 05:45:36 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;63;70;72;76;71;71;66;68;67;67 05:45:36 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;82;80;83;82;82;80;82;82;83;80 05:45:36 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;122;133;110;107;108;131;133;129;117;134 05:45:36 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;142;127;137;139;137;127;142;139;137;138 05:45:36 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;69;67;68;67;67;70;86;99;95;97 05:45:36 INFO - PROCESS | 1675 | __end_tp_report 05:45:36 INFO - PROCESS | 1675 | __start_cc_report 05:45:36 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1273 05:45:36 INFO - PROCESS | 1675 | __end_cc_report 05:45:36 INFO - PROCESS | 1675 | __startTimestamp1458305136961__endTimestamp 05:45:36 INFO - PROCESS | 1675 | 05:45:36 INFO - PROCESS | 1675 | ------- Summary: start ------- 05:45:36 INFO - PROCESS | 1675 | Number of tests: 14 05:45:36 INFO - PROCESS | 1675 | 05:45:36 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:3.06 (2.7%) stddev-sans-first:3.24 05:45:36 INFO - PROCESS | 1675 | Values: 112.0 107.0 109.0 111.0 111.0 112.0 119.0 112.0 111.0 112.0 05:45:36 INFO - PROCESS | 1675 | 05:45:36 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:145.50 stddev:21.71 (14.9%) stddev-sans-first:22.58 05:45:36 INFO - PROCESS | 1675 | Values: 155.0 119.0 141.0 156.0 120.0 139.0 136.0 123.0 191.0 150.0 05:45:36 INFO - PROCESS | 1675 | 05:45:36 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:186.10 Median:187.00 stddev:1.66 (0.9%) stddev-sans-first:1.72 05:45:36 INFO - PROCESS | 1675 | Values: 185.0 186.0 188.0 186.0 187.0 188.0 187.0 187.0 183.0 184.0 05:45:36 INFO - PROCESS | 1675 | 05:45:36 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:69.90 Median:77.00 stddev:11.24 (14.6%) stddev-sans-first:11.70 05:45:36 INFO - PROCESS | 1675 | Values: 76.0 79.0 82.0 77.0 56.0 57.0 58.0 80.0 77.0 57.0 05:45:36 INFO - PROCESS | 1675 | 05:45:36 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:79.00 stddev:23.20 (29.4%) stddev-sans-first:24.49 05:45:36 INFO - PROCESS | 1675 | Values: 95.0 99.0 128.0 79.0 77.0 87.0 146.0 112.0 79.0 115.0 05:45:36 INFO - PROCESS | 1675 | 05:45:36 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:88.60 Median:90.00 stddev:2.12 (2.4%) stddev-sans-first:2.19 05:45:36 INFO - PROCESS | 1675 | Values: 90.0 86.0 91.0 87.0 89.0 86.0 91.0 90.0 90.0 86.0 05:45:36 INFO - PROCESS | 1675 | 05:45:36 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:103.60 Median:95.00 stddev:17.63 (18.6%) stddev-sans-first:18.43 05:45:36 INFO - PROCESS | 1675 | Values: 95.0 95.0 95.0 111.0 149.0 114.0 95.0 95.0 93.0 94.0 05:45:36 INFO - PROCESS | 1675 | 05:45:36 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.50 stddev:1.41 (1.6%) stddev-sans-first:1.45 05:45:36 INFO - PROCESS | 1675 | Values: 85.0 88.0 86.0 85.0 84.0 85.0 85.0 88.0 87.0 87.0 05:45:36 INFO - PROCESS | 1675 | 05:45:36 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:54.00 stddev:3.07 (5.7%) stddev-sans-first:3.23 05:45:36 INFO - PROCESS | 1675 | Values: 56.0 54.0 53.0 53.0 53.0 54.0 54.0 63.0 56.0 53.0 05:45:36 INFO - PROCESS | 1675 | 05:45:36 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:70.50 stddev:3.67 (5.2%) stddev-sans-first:3.15 05:45:36 INFO - PROCESS | 1675 | Values: 63.0 70.0 72.0 76.0 71.0 71.0 66.0 68.0 67.0 67.0 05:45:36 INFO - PROCESS | 1675 | 05:45:36 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:82.00 stddev:1.17 (1.4%) stddev-sans-first:1.24 05:45:36 INFO - PROCESS | 1675 | Values: 82.0 80.0 83.0 82.0 82.0 80.0 82.0 82.0 83.0 80.0 05:45:36 INFO - PROCESS | 1675 | 05:45:36 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:122.40 Median:130.00 stddev:11.08 (8.5%) stddev-sans-first:11.75 05:45:36 INFO - PROCESS | 1675 | Values: 122.0 133.0 110.0 107.0 108.0 131.0 133.0 129.0 117.0 134.0 05:45:36 INFO - PROCESS | 1675 | 05:45:36 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.50 Median:138.50 stddev:5.34 (3.9%) stddev-sans-first:5.28 05:45:36 INFO - PROCESS | 1675 | Values: 142.0 127.0 137.0 139.0 137.0 127.0 142.0 139.0 137.0 138.0 05:45:36 INFO - PROCESS | 1675 | 05:45:36 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.50 Median:78.00 stddev:13.99 (17.9%) stddev-sans-first:14.41 05:45:36 INFO - PROCESS | 1675 | Values: 69.0 67.0 68.0 67.0 67.0 70.0 86.0 99.0 95.0 97.0 05:45:36 INFO - PROCESS | 1675 | -------- Summary: end -------- 05:45:36 INFO - PROCESS | 1675 | 05:45:37 INFO - TEST-INFO | 1675: exit 0 05:45:37 INFO - TEST-OK | kraken | took 56924ms 05:45:37 INFO - SUITE-END | took 1171s 05:45:38 INFO - Completed test suite (00:19:31) 05:45:38 INFO - javascript benchmark 05:45:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2910.3888183481467, 3491.79533061094, 3520.7007404370634, 3524.7885126892406, 3563.127033876699, 5557.138643510252, 5654.293213348332, 5691.772329106836, 5706.514946229576, 5707.657540547565, 5692.231548740919, 5703.543716502681, 5726.026575482168, 5814.622049566775, 5831.883362332751, 5037.3451451311275, 5056.84829455117, 5103.183490641498, 5138.023775482647, 5144.588432925357, 5008.273800298973, 5022.397312322526, 5035.723035233061, 5045.621578381618, 5116.386033675964, 5095.133827249377, 5097.490250974892, 5191.1953647184555, 5211.088059589557, 5215.530602245816, 5164.483551644806, 5165.354330708661, 5170.353705786777, 5172.767225474862, 5212.817551385683, 5098.923516147223, 5117.667351622133, 5123.974380128113, 5148.9742551287, 5176.663516871429, 5499.972500137514, 5628.240187574666, 5641.548676105902, 5671.291088613923, 5741.425857414267, 5152.587792976553, 6167.537434692416, 6203.0, 6210.627362358227, 6236.719347629368, 6240.625562466266, 6299.65351905645, 6313.084602732624, 6313.3686631336495, 6330.525210609177, 5653.604247702662, 5695.572832037614, 5758.74085666146, 5768.192453056576, 5771.307443106812, 6251.843703907439, 6317.1156038154695, 6369.681515924185, 6388.584741991755, 6388.680565971776, 6069.241344831896, 6077.875593015307, 6125.418085281891, 6128.142060111588, 6137.570370074052, 6151.507879369639, 6272.686365681698, 6274.937250627527, 6276.184096067574, 6306.9684651576445, 6035.6076855004285, 6134.662593557308, 6144.662043587646, 6156.661383623854, 6172.475339596095, 6162.044883043135, 6199.411055949678, 6201.131841542187, 6201.162843016225, 6209.316975132731, 4826.32431459596, 4881.804727810919, 4885.169521181408, 4889.48660390661, 4918.901621967612, 4332.826686932487, 4364.345348197732, 4439.889002774892, 4463.419755431773, 4465.642748580106, 5656.6888821115235, 5656.85857853557, 5658.943410565924, 5681.630694004876, 5686.402927692616, 6247.75008999644, 6276.780312689034, 6279.3720627937755, 6285.685715714196, 6297.464715499143, 5524.917126243109, 5604.243427137366, 5633.183188437653, 5696.974544581932, 5730.684812335361, 5341.0, 5348.1442969124755, 5349.465053494697, 5362.2224777407055, 5370.650907690988, 6281.932071547848, 6318.052292156213, 6320.905186422299, 6331.905021424683, 6343.397377249154, 6028.216331876828, 6122.2761798032625, 6148.0, 6227.1282020516255, 6235.532335074979, 5303.36359636846, 6325.082862984934, 6341.968290158519, 6346.333634968447, 6348.650824204528, 6066.241719785027, 6068.51451883857, 6075.30134034574, 6076.635401875901, 6078.3617720138745, 6097.420745029215, 6104.0347610180015, 6130.948521380091, 6164.260288765377, 6170.043643235305, 5884.558658100574, 5899.882002359843, 5901.409859014236, 5902.085176797432, 5950.166976623363, 5108.948910510996, 5403.784148566541, 5904.940950590611, 5921.3190483094995, 5934.495567876779, 5705.7147142643535, 5741.397153299011, 5770.278715160605, 5778.739956702043, 5850.356460789225, 5874.236349274567, 5914.615549989237, 5917.644941303535, 5932.762689492372, 5944.375840536682, 5817.941820581909, 5823.388544202798, 5828.067509198508, 5830.329512105993, 5831.387704290988], "unit": "score", "name": "dojo.html", "value": 5634.196099376183}, {"lowerIsBetter": false, "replicates": [483.26784920844904, 542.8045903474748, 568.9146628005799, 626.4330780643518, 635.0791352538816, 29863.55204671929, 38719.612803871954, 38901.8054909725, 39074.4138837917, 39127.21745565087, 41375.379369309485, 41762.373564396556, 41791.79104104475, 41822.099353606696, 41979.58020419795, 9608.135267825894, 9797.755056123582, 9824.0, 9826.213902887752, 9839.360441571274, 9623.663171788989, 9774.804503909918, 9779.755506112333, 9790.461524616143, 9899.703008909708, 9821.852672209923, 9892.505374731234, 9894.604215831358, 9894.653687120952, 9918.008199180096, 9794.069563391466, 9856.90143098567, 9862.704118876409, 9864.65473708424, 9865.90134098657, 9503.192228660571, 9644.132028117503, 9656.951715241448, 9662.9516852416, 9664.081912218327, 39437.014074648076, 39827.60172398297, 39829.00427489336, 39925.0, 39981.60018399808, 3428.8114153721535, 3610.7833529988284, 3778.376567866299, 3839.9232015359817, 4136.048708796993, 23798.762012379826, 27868.88524459019, 28341.008064717636, 28382.57426138589, 28970.565441518393, 2709.91870243893, 2739.356251280947, 2742.903998360068, 2809.0028040045695, 2814.4652516021893, 468204.65897670295, 468807.0, 470186.0, 471291.14835406543, 472217.0, 67642.98535521972, 67952.0, 67971.66014169897, 68123.3187668117, 68334.31665683379, 60604.0, 68254.0, 72649.2735072653, 73516.0, 73557.0, 17021.659566808594, 17109.887857289235, 17280.740788888175, 17308.394206202724, 17363.56591085233, 13128.015398845126, 13165.210087394787, 13186.142900711424, 13200.0, 13238.933805330911, 21479.140834366764, 21718.0, 21719.348419547438, 21748.347549573537, 21781.693098414147, 7736.7678969631, 8999.595018224196, 9260.536973151315, 9268.397554158959, 9287.62849486013, 945.4563625915126, 973.8149751547184, 1022.2639699416409, 1059.6185373265619, 1108.8634149996158, 27027.0, 27764.0, 27897.0, 27914.44171116607, 27926.72073279241, 970.1608108985677, 1102.862142232221, 1144.7882141803793, 1148.4143087025677, 1172.5251273234353, 14038.789418158736, 14352.856471435152, 14366.281685915663, 14566.19885906264, 14767.26163691811, 597812.0, 601212.0, 605299.0, 606339.0, 607710.0, 61634.0, 62200.0, 62207.0, 62259.0, 62504.68747656233, 1350.9121907076008, 1447.7032208397254, 1460.9853901461063, 1466.7213229486576, 1473.4106357457104, 29735.85132074326, 30126.945556905404, 30752.69247307498, 30834.894340129387, 31067.378652427276, 56492.0, 57115.14327285011, 57194.7140264296, 57205.713971429876, 57301.42698572961, 446815.0, 467455.0, 468754.0, 469691.0, 469940.0, 36742.0, 43695.78152109219, 44094.559054409045, 44537.55462445334, 45143.0, 43954.90112747079, 44244.0, 44818.87952801206, 45257.868553285116, 45630.77184614056, 37729.05677358088, 37987.43018854664, 37996.43005354867, 38689.80655096706, 39069.60930390773, 37055.44416833696, 37265.41822721598, 37406.0, 37969.4304585437, 38018.80990595029, 32340.0, 37420.62579374172, 38123.80938095292, 38261.46954121804, 38268.85193444201, 31828.68171318257, 32641.18397039998, 32658.346833063682, 32764.50853237251, 32808.0, 24069.398265043514, 24642.260732178063, 24677.50644987126, 24942.750572494042, 25008.74991250137], "unit": "score", "name": "ext.html", "value": 20410.38371941978}, {"lowerIsBetter": false, "replicates": [345.48867675839756, 353.325148965476, 354.84741561128703, 360.53851070629605, 365.2767520309785, 19121.0, 19288.807111928876, 19653.64156301244, 20042.498937526532, 20086.69869951952, 16112.274947627355, 18532.258709651596, 19547.609047819034, 19832.909189994545, 19875.900620496912, 5661.631993920392, 5857.502112320437, 5870.911936320958, 5888.263967004124, 5933.228680271559, 4200.915981680379, 4405.933910991338, 5854.121881717755, 6149.446549810516, 6442.162518872564, 6357.65032923189, 6382.329855365189, 6392.936070639281, 6401.5838970467, 6409.327020662833, 6106.755729770804, 6406.0, 6407.807765766988, 6418.06937993993, 6422.421982021617, 3684.336819372512, 5223.399309079467, 5415.404305526428, 5435.1847222916485, 5503.477169668875, 24079.398015049588, 24273.150439734523, 24528.632070518957, 25784.74215257861, 25790.484190316278, 2038.8368930485674, 2103.295396042328, 2317.2700599311165, 2697.5144473994674, 2955.7635389168813, 13188.076834621581, 13221.405036773369, 14267.643308917257, 14446.711065778625, 14516.346764395628, 1678.8992660440413, 1777.7155655095123, 1795.5152108930647, 1823.0, 1891.5838515526561, 75083.24916750817, 91247.0, 93648.12703745886, 93999.59000614996, 96067.55898661526, 9690.806183876282, 9754.731884854924, 10091.848622270672, 10303.175745940307, 10554.155667546731, 12671.87328126707, 12762.425690843935, 12777.93611031939, 12794.488220471263, 12813.0, 8502.234798868009, 8681.479111253346, 8682.218600326001, 8785.736427907173, 8821.779455513664, 9023.729288121367, 9059.592318345558, 9075.273978081737, 9164.770880728036, 9181.632734690538, 6089.360617135226, 6171.506279497629, 6192.411720886508, 6198.318184999646, 6257.0, 1645.8518733314058, 1722.070082155622, 1726.4561663076342, 1728.0409372797967, 1742.7473016412548, 881.8544940084814, 912.0970239463016, 945.8533927241289, 1026.7381817636456, 1030.7783826477344, 17084.40204592833, 20974.2659006934, 21356.893215534135, 21579.568408631738, 21596.784032159478, 996.8554559588819, 1002.4486532407146, 1042.525650828871, 1056.292284169593, 1056.693558867935, 10467.581296748045, 10945.069669078059, 10959.397233152094, 11353.091752659768, 11548.307101573933, 628702.0, 648116.0, 652228.0, 665038.0, 666224.0, 112324.0, 113147.0, 113397.0, 113456.0, 114769.4261528687, 1043.7025447747355, 1073.983890241647, 1088.3361149698678, 1089.4661615808197, 1093.5024563823442, 14489.347979340744, 17559.736603951205, 17699.557511062325, 17838.464846054638, 18260.452186434428, 47591.04817903553, 47996.29025743891, 48251.0, 48537.54387368385, 49075.509244907094, 71594.28405715876, 71752.0, 71760.0, 71919.64040179766, 72316.63841680757, 5885.234919460443, 7132.393746531603, 7146.106736657918, 7181.210066892533, 7482.925170748223, 11310.552233380888, 12045.096617753528, 12084.879151208375, 12115.818262726243, 12277.26336419782, 8416.621252043795, 10174.796504069729, 10339.379637221791, 10604.363738175734, 10627.0, 9388.95305523468, 10054.29619926598, 10349.379037257788, 10547.578096876347, 10549.208809339178, 10477.842832357674, 10498.95010498944, 10634.73413164677, 10676.733081673021, 10737.194710396596, 5760.308762948473, 7563.9621801890635, 7668.884966725392, 7685.692572297045, 7695.345895598937, 10040.497975101362, 10394.58421663125, 10395.792084158425, 10501.842472363074, 10632.043116119587], "unit": "score", "name": "jquery.html", "value": 9355.802995743525}, {"lowerIsBetter": false, "replicates": [1427.6074079628108, 1464.9926750366246, 1522.1399909051386, 1818.2181661885384, 1998.4004798560438, 6997.9650101749485, 8029.558374289411, 8796.0, 8804.339674524412, 8806.163414475615, 8454.492730436179, 8727.127287271269, 8729.607167677454, 8734.86897696535, 8746.300295976322, 2369.9407514812183, 2397.7722116399, 2398.6881705378364, 2401.9639705404434, 2405.0980882169188, 2397.568437681217, 2432.7323994360604, 2454.435479839638, 2459.409741662006, 2462.901483940649, 2425.721042080157, 2433.634954756792, 2446.0, 2453.55835949529, 2460.9138680146107, 2413.046846495642, 2450.4363996280867, 2450.840695354796, 2453.9631905521433, 2460.6063029915126, 2390.414348484615, 2429.259075981825, 2435.3059378077164, 2441.401856545158, 2442.755724427561, 8879.689210877654, 8900.688475903376, 8918.331125165638, 8926.419782714167, 8942.552872356357, 5373.81191658294, 5497.752601132918, 5514.420985796473, 5519.365272993577, 5530.364008139035, 3590.982045089758, 3669.889903302905, 3720.572134204574, 3747.756395834262, 3749.606291339425, 927.2118699105706, 1057.5716834681966, 1072.5120070367964, 1076.9892301076968, 1085.4138765066934, 10081.44552049637, 11968.281903085755, 11980.760384792342, 12026.0, 12036.999999999913, 4813.844677277428, 4827.782749776268, 4834.105690447279, 4868.367112275452, 4871.342368780241, 10133.341332813343, 10137.0, 10142.594296228215, 10152.593896244067, 10155.339902906288, 5470.671759694352, 5472.480114389126, 5476.315460567429, 5476.561875050066, 5478.561715062865, 4443.400140980926, 4606.700564463299, 4800.903981920412, 4930.605551555867, 4978.950210497921, 3899.493065901415, 3966.7421617594764, 3968.761874287552, 3988.102676897675, 4016.9196616067516, 1302.2381906584753, 1309.3387839141174, 1315.5724389573427, 1325.4499382756242, 1334.3261652865242, 975.2782940623887, 1011.3830563356347, 1166.9416529173677, 1256.5664845628426, 1400.95096671616, 7990.64042118106, 7996.64015119321, 8104.0680321762575, 8115.3913456491, 8124.390670699721, 1198.4007996002, 1207.4506099724604, 1209.5585111434264, 1217.975640487203, 1228.4840367045863, 6141.815745527641, 6145.108959200891, 6202.472789812826, 6208.379162083756, 6218.968905155445, 10318.690439286833, 11010.559577616967, 11046.447677616248, 11065.391403472726, 11065.778684426428, 10592.046715795615, 10725.892741072645, 10848.403337816339, 10854.837177442345, 10882.966118218757, 8314.127016663284, 8415.705450309331, 8464.746057618282, 8492.957535212408, 8494.447860889022, 7875.369970402239, 7882.290593846581, 7949.364050875801, 7983.441159118806, 7985.92014079875, 9380.29647776406, 9588.089131532493, 9669.129778319984, 9710.660126895526, 9774.951125244328, 9764.974677659027, 9960.601575936882, 9967.302288840001, 10087.243456740627, 10178.6437474691, 7333.963330183315, 7352.37504812097, 7382.704691812482, 7394.371478424179, 7453.478256521991, 8191.180881911761, 8222.712205072794, 8244.29923456513, 8280.792980175544, 8294.958525207336, 6331.746730130743, 7387.9683087149315, 7526.059242594676, 7635.23647635232, 7681.731139410093, 6245.96877015612, 7260.087862830748, 7309.488335816654, 7320.194778574459, 7432.814179645552, 7644.770656880302, 7762.223777622193, 7773.18381569927, 7795.103563090317, 7801.570913599807, 7004.824879377852, 7023.578585284899, 7115.039469671528, 7120.537165084253, 7123.679434425359, 5943.494802941798, 7188.317109874553, 7209.0628218331285, 7218.963905180441, 7223.1693355264815], "unit": "score", "name": "mootools.html", "value": 4940.937687779833}, {"lowerIsBetter": false, "replicates": [318.3235624298366, 320.4408307503407, 326.8540299616194, 329.0441268116123, 329.8466213210858, 6395.904061439076, 6496.447801936841, 6502.9920362343855, 6523.24982626998, 6538.182727159111, 6394.488440924726, 6409.967950160254, 6450.870982580357, 6457.999999999988, 6460.38626330499, 4542.977285113569, 4630.120277147331, 4631.513691062441, 4686.695364801294, 4828.999999999991, 4576.290674945372, 4580.885477863063, 4699.0, 4720.0559888022535, 4739.976300118495, 4679.15775160471, 4680.25115981443, 4704.97647511762, 4705.929411058837, 4710.246360582308, 4668.136394766979, 4691.014886873761, 4691.483936766953, 4700.412448443944, 4704.0, 3891.9221615567812, 3950.5654378018394, 4060.817263223162, 4083.244599749056, 4087.2438598859308, 5527.977324194997, 5622.156676498558, 6158.322584515699, 6159.3224745277985, 6184.474319682832, 5588.133839254922, 5592.412796656333, 5596.720163991784, 5606.131049687305, 5609.831705048855, 6834.794956151323, 6838.452923766136, 6847.760328388532, 6860.485463590251, 6861.725530978755, 3796.52543432071, 4586.633069354443, 4592.655550833668, 4596.287575425815, 4609.285560738057, 6955.374016338503, 7247.565146091199, 7262.455315851333, 7276.308750668731, 7288.890666640004, 4666.883327916829, 4699.647526435531, 4702.247640377524, 4707.764611769398, 4727.220008698595, 4816.20532612122, 4816.975915120472, 4818.494382920861, 4819.421669399624, 4829.517048295143, 5611.607187496836, 5614.578906582023, 5614.6631202128, 5627.0, 5632.155176723442, 5615.719214039282, 6631.6684165792485, 6852.45180385568, 6907.0, 6918.619475928772, 1623.8863279570553, 1666.3667806233796, 1669.9415520456726, 1672.0552887618458, 1672.4313733330725, 1067.5729708116814, 1088.6951653536864, 1097.7200813792592, 1106.5463160104318, 1107.479484642217, 4858.416989961157, 6086.695665216722, 6336.334684858023, 6348.841278968062, 6363.140975968277, 6985.266547012592, 7066.505344625827, 7214.242504537053, 7234.891476627855, 7244.311790379906, 6440.516961227927, 6441.32366101562, 6450.0, 6450.903236451457, 6452.580582262138, 3665.248624032067, 3788.6969042476535, 3790.8673196437994, 3794.924101517954, 3801.315763162602, 7176.390006849372, 7555.508891922007, 7568.394528437711, 7572.659230334648, 7580.696772129053, 7418.221086785918, 7429.108506979197, 7440.590767507731, 7442.404607631376, 7473.103227612722, 7542.2834830691, 7554.660040298199, 7559.3196612305155, 7563.848723025619, 7570.545767253982, 7196.424286057208, 7200.89198662031, 7208.207097219407, 7215.8556828864175, 7223.747168849065, 6837.35045170708, 7094.184168820651, 7098.822529436598, 7100.538464999759, 7108.644567771487, 7497.250274972459, 7534.773956781305, 7554.811129721801, 7564.546127232384, 7565.167831538416, 4733.100710864925, 4734.834280800155, 4738.4787673356595, 4739.0521895621705, 4749.667523273338, 5783.479486846036, 5855.502282306052, 7143.892841607484, 7151.034610327539, 7157.105361829771, 6606.8348291293105, 6879.6216208107035, 6908.1019467468905, 6909.654517274217, 6938.06336144614, 6893.620850853251, 6906.102206713095, 6910.723571057101, 6920.619365934721, 6923.342282483156, 6684.097646817618, 6724.428423583854, 6740.224874139537, 6743.35938085881, 6743.52795304324, 6908.447324214151, 6913.585184888922, 6914.9308506914285, 6918.411934985583, 6926.9307306926285, 6502.577332473374, 6733.293004234485, 6752.763653272112, 6755.324467553205, 6766.830829229112], "unit": "score", "name": "prototype.html", "value": 5061.373733814727}, {"lowerIsBetter": false, "replicates": [676.5805200775517, 677.9728810847565, 693.4036728413566, 699.7585832887654, 700.5341447937119, 14484.63788405289, 14527.983041187133, 14673.266336683164, 15809.0, 16038.679226415465, 14651.853481465183, 14799.186044767534, 14809.555713328617, 14811.111333320008, 14829.036112652697, 738.2949283434307, 751.9248075192464, 894.6689724801832, 899.3299991506337, 920.0891117793403, 916.720400277915, 920.7559996600907, 921.2261700171854, 922.5341202692631, 922.7416323429451, 971.2472833554017, 978.7161723100328, 980.039561229995, 980.8283550378691, 982.3810999070575, 652.879217344788, 788.538704857659, 790.640258682304, 970.8592254123148, 973.5764942250108, 686.6532401137443, 715.5277516838913, 715.6636380900968, 715.7387553542972, 716.7312257903286, 12642.431090600945, 15175.848241517664, 15235.847641523664, 15241.923790381088, 15279.541613751606, 9959.502024898798, 12598.874011259863, 12697.619071427873, 12704.364781760967, 12849.67875803103, 8215.644418670972, 9889.60441582343, 10036.749081272954, 10110.595576176944, 10846.403447810446, 3131.389379071082, 3653.178034942117, 3660.560732712065, 3670.009097543675, 3759.2669429461266, 79908.60045699793, 80205.0, 80401.0, 80527.5973620134, 80715.5964220181, 9060.411073280216, 9158.403557355492, 9286.0, 9329.346945713734, 9683.951580242054, 20850.58298834015, 21466.0, 21482.355529334145, 21501.354959351243, 21525.354239372842, 7256.2743725627015, 7460.104787425544, 7468.775936721907, 7470.402367810562, 7546.019017527796, 4104.486939132608, 4160.126373461607, 4163.146554956226, 4165.375193720966, 4178.958210417918, 3581.6239294874185, 3616.4213725803747, 3617.3127105849803, 3617.4031284838234, 3626.5104210931713, 625.0967352176153, 634.4290138874957, 647.233028860792, 651.1730102769457, 664.4485077385758, 498.81793145502354, 504.57867680487203, 524.0854708533633, 526.4209369693307, 535.7937194180191, 8113.553754543439, 8115.594220288962, 8170.754877353689, 8350.164983501723, 8372.41393102477, 566.0546886699223, 600.2826622186533, 601.1133577972543, 601.227422761749, 623.9968800155971, 2996.325826689021, 3638.4542318652416, 3809.5428548573796, 3850.4609354690365, 4065.065035041957, 69586.0, 92162.61756073665, 96324.51837740907, 96580.0, 96761.51619241858, 79984.6000770004, 80469.59765201254, 81100.0, 81149.0, 81277.0, 68577.0, 68831.0, 69170.61658766796, 69472.30527694861, 71438.0, 7795.532268063935, 7855.057393112635, 7927.960360198162, 7943.563104029334, 8037.075736290168, 47514.524854752395, 47618.285725713446, 47753.761231193625, 47788.28317575309, 47794.52205477901, 60023.0, 60442.0, 66615.0, 66782.3321766776, 67384.38074731994, 9959.05388988045, 10003.749906252111, 10020.24848136378, 10330.690079297634, 10601.151907847508, 10834.945825270823, 10952.835707464235, 11286.774264514828, 11296.43517824122, 11315.259796735032, 10402.427866467417, 10510.369377837354, 10583.94708026455, 10589.311694739818, 10822.67531974042, 10049.346792458467, 10266.230032747722, 10425.374477531372, 10725.678229653124, 11187.216894817284, 10121.746956326151, 10167.034131757471, 10202.438865862448, 10225.079742823182, 10503.842442363524, 8679.522626255364, 8804.64781408762, 8837.116288371111, 8951.104889510996, 9340.626374944926, 7551.73568925085, 8835.602397892239, 8946.418482798597, 9062.637494500146, 9067.637294508146], "unit": "score", "name": "yui.html", "value": 6711.584530410077}], "name": "dromaeo_css", "value": 7518.258820295293}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 109.0, 111.0, 111.0, 112.0, 119.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [155.0, 119.0, 141.0, 156.0, 120.0, 139.0, 136.0, 123.0, 191.0, 150.0], "unit": "score", "name": "audio-beat-detection", "value": 143.0}, {"lowerIsBetter": true, "replicates": [185.0, 186.0, 188.0, 186.0, 187.0, 188.0, 187.0, 187.0, 183.0, 184.0], "unit": "score", "name": "audio-dft", "value": 186.1}, {"lowerIsBetter": true, "replicates": [76.0, 79.0, 82.0, 77.0, 56.0, 57.0, 58.0, 80.0, 77.0, 57.0], "unit": "score", "name": "audio-fft", "value": 69.9}, {"lowerIsBetter": true, "replicates": [95.0, 99.0, 128.0, 79.0, 77.0, 87.0, 146.0, 112.0, 79.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 101.7}, {"lowerIsBetter": true, "replicates": [90.0, 86.0, 91.0, 87.0, 89.0, 86.0, 91.0, 90.0, 90.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 111.0, 149.0, 114.0, 95.0, 95.0, 93.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 103.6}, {"lowerIsBetter": true, "replicates": [85.0, 88.0, 86.0, 85.0, 84.0, 85.0, 85.0, 88.0, 87.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 86.0}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 53.0, 53.0, 53.0, 54.0, 54.0, 63.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.9}, {"lowerIsBetter": true, "replicates": [63.0, 70.0, 72.0, 76.0, 71.0, 71.0, 66.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [82.0, 80.0, 83.0, 82.0, 82.0, 80.0, 82.0, 82.0, 83.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.6}, {"lowerIsBetter": true, "replicates": [122.0, 133.0, 110.0, 107.0, 108.0, 131.0, 133.0, 129.0, 117.0, 134.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.4}, {"lowerIsBetter": true, "replicates": [142.0, 127.0, 137.0, 139.0, 137.0, 127.0, 142.0, 139.0, 137.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.5}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 68.0, 67.0, 67.0, 70.0, 86.0, 99.0, 95.0, 97.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 78.5}], "name": "kraken", "value": 1433.5000000000002}]} 05:45:38 INFO - Return code: 0 05:45:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:45:38 ERROR - # TBPL SUCCESS # 05:45:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:45:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:45:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:45:38 INFO - 2016-03-18 05:45:38.249 screenresolution[1679:9595] starting screenresolution argv=screenresolution get 05:45:38 INFO - 2016-03-18 05:45:38.252 screenresolution[1679:9595] Display 0: 1600x1200x32@60 05:45:38 INFO - 2016-03-18 05:45:38.258 screenresolution[1680:9598] starting screenresolution argv=screenresolution list 05:45:38 INFO - Available Modes on Display 0 05:45:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:45:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:45:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:45:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:45:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:45:38 INFO - Intel Iris: 05:45:38 INFO - Chipset Model: Intel Iris 05:45:38 INFO - Type: GPU 05:45:38 INFO - Bus: Built-In 05:45:38 INFO - VRAM (Dynamic, Max): 1536 MB 05:45:38 INFO - Vendor: Intel (0x8086) 05:45:38 INFO - Device ID: 0x0a2e 05:45:38 INFO - Revision ID: 0x0009 05:45:38 INFO - Displays: 05:45:38 INFO - Display: 05:45:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:45:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:45:38 INFO - Display Serial Number: 1600x1200 60 05:45:38 INFO - Main Display: Yes 05:45:38 INFO - Mirror: Off 05:45:38 INFO - Online: Yes 05:45:38 INFO - Rotation: Supported 05:45:38 INFO - Return code: 0 05:45:38 INFO - Running post-action listener: _resource_record_post_action 05:45:38 INFO - Running post-run listener: _resource_record_post_run 05:45:39 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 39761408; Write bytes: 706668544; Read time: 445; Write time: 2213 05:45:39 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 383076864; Write bytes: 376673792; Read time: 29612; Write time: 805 05:45:39 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 38786560; Write bytes: 302985728; Read time: 429; Write time: 1353 05:45:39 INFO - Running post-run listener: _upload_blobber_files 05:45:39 INFO - Blob upload gear active. 05:45:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:45:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:45:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:45:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:45:39 INFO - (blobuploader) - INFO - Open directory for files ... 05:45:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:45:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:45:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:45:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:45:41 INFO - (blobuploader) - INFO - Done attempting. 05:45:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:45:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:45:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:45:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:45:42 INFO - (blobuploader) - INFO - Done attempting. 05:45:42 INFO - (blobuploader) - INFO - Iteration through files over. 05:45:42 INFO - Return code: 0 05:45:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:45:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:45:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cfe4cfdc141d307a0e9d599adb286955f3d3d3429afaa8676d5852bd17fff6564798fae8b6f3aa0c8d865d903e08d73eb66568ed35fa645babd0e633e2b6719b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5a7f8a7e82c57773d0f48bb8a4933de41d22198ece3fa275abb131a90874f125067e436623f198aad28e9ce11e4c85f85b5f1e18d075dcfcc33aea663cb1efa"} 05:45:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:45:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:45:42 INFO - Contents: 05:45:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cfe4cfdc141d307a0e9d599adb286955f3d3d3429afaa8676d5852bd17fff6564798fae8b6f3aa0c8d865d903e08d73eb66568ed35fa645babd0e633e2b6719b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5a7f8a7e82c57773d0f48bb8a4933de41d22198ece3fa275abb131a90874f125067e436623f198aad28e9ce11e4c85f85b5f1e18d075dcfcc33aea663cb1efa"} 05:45:42 INFO - Running post-run listener: copy_logs_to_upload_dir 05:45:42 INFO - Copying logs to upload dir... 05:45:42 INFO - mkdir: /builds/slave/test/build/upload/logs 05:45:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.590097 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-03-18 05:45:42.388320) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 05:45:42.392300) ========= 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.s9blUDOkCt/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.DhbIRufXyl/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cfe4cfdc141d307a0e9d599adb286955f3d3d3429afaa8676d5852bd17fff6564798fae8b6f3aa0c8d865d903e08d73eb66568ed35fa645babd0e633e2b6719b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5a7f8a7e82c57773d0f48bb8a4933de41d22198ece3fa275abb131a90874f125067e436623f198aad28e9ce11e4c85f85b5f1e18d075dcfcc33aea663cb1efa"} build_url:https://queue.taskcluster.net/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/EI9YNq2aTNqmvETbhHhYiw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cfe4cfdc141d307a0e9d599adb286955f3d3d3429afaa8676d5852bd17fff6564798fae8b6f3aa0c8d865d903e08d73eb66568ed35fa645babd0e633e2b6719b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5a7f8a7e82c57773d0f48bb8a4933de41d22198ece3fa275abb131a90874f125067e436623f198aad28e9ce11e4c85f85b5f1e18d075dcfcc33aea663cb1efa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 05:45:42.426967) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 05:45:42.427274) ========= 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.s9blUDOkCt/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.DhbIRufXyl/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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.005436 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 05:45:42.475423) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 05:45:42.475735) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 05:45:42.476094) ========= ========= Total master_lag: 0.26 =========