builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0165 starttime: 1458002581.23 results: success (0) buildid: 20160314153910 builduid: 0f37627544394f4cbce46ffaa4e09502 revision: b21c3e5856ae8873a4ee618517c738f579bd2d39 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 17:43:01.228590) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 17:43:01.229016) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 17:43:01.229304) ========= 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.m1g8msvqYw/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.ZjxITcl11z/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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.005406 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 17:43:01.253297) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 17:43:01.253570) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 17:43:01.271451) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 17:43:01.271749) ========= 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.m1g8msvqYw/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.ZjxITcl11z/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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.005603 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 17:43:01.319266) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 17:43:01.319544) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 17:43:01.319909) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 17:43:01.320183) ========= 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.m1g8msvqYw/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.ZjxITcl11z/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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-14 17:43:01-- 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% 44.2M=0s 2016-03-14 17:43:01 (44.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115382 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 17:43:01.451475) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 17:43:01.451782) ========= 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.m1g8msvqYw/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.ZjxITcl11z/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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.027192 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 17:43:01.499478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 17:43:01.499821) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b21c3e5856ae8873a4ee618517c738f579bd2d39 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b21c3e5856ae8873a4ee618517c738f579bd2d39 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.m1g8msvqYw/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.ZjxITcl11z/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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-14 17:43:01,576 truncating revision to first 12 chars 2016-03-14 17:43:01,576 Setting DEBUG logging. 2016-03-14 17:43:01,577 attempt 1/10 2016-03-14 17:43:01,577 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b21c3e5856ae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-14 17:43:02,179 unpacking tar archive at: fx-team-b21c3e5856ae/testing/mozharness/ program finished with exit code 0 elapsedTime=0.863930 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 17:43:02.381348) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 17:43:02.381698) ========= echo b21c3e5856ae8873a4ee618517c738f579bd2d39 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b21c3e5856ae8873a4ee618517c738f579bd2d39'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.m1g8msvqYw/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.ZjxITcl11z/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 b21c3e5856ae8873a4ee618517c738f579bd2d39 program finished with exit code 0 elapsedTime=0.006033 script_repo_revision: 'b21c3e5856ae8873a4ee618517c738f579bd2d39' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 17:43:02.430863) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 17:43:02.431172) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 17:43:02.445671) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-03-14 17:43:02.445958) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.m1g8msvqYw/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.ZjxITcl11z/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 17:43:02 INFO - MultiFileLogger online at 20160314 17:43:02 in /builds/slave/test 17:43:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:43:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:43:02 INFO - {'append_to_log': False, 17:43:02 INFO - 'base_work_dir': '/builds/slave/test', 17:43:02 INFO - 'blob_upload_branch': 'Fx-Team', 17:43:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:43:02 INFO - 'branch': 'Fx-Team', 17:43:02 INFO - 'buildbot_json_path': 'buildprops.json', 17:43:02 INFO - 'config_files': ('talos/mac_config.py',), 17:43:02 INFO - 'default_actions': ('clobber', 17:43:02 INFO - 'read-buildbot-config', 17:43:02 INFO - 'download-and-extract', 17:43:02 INFO - 'populate-webroot', 17:43:02 INFO - 'create-virtualenv', 17:43:02 INFO - 'install', 17:43:02 INFO - 'run-tests'), 17:43:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:43:02 INFO - 'download_minidump_stackwalk': True, 17:43:02 INFO - 'download_symbols': 'ondemand', 17:43:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:43:02 INFO - 'tooltool.py': '/tools/tooltool.py', 17:43:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:43:02 INFO - '/tools/misc-python/virtualenv.py')}, 17:43:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:43:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:43:02 INFO - 'installer_path': 'installer.exe', 17:43:02 INFO - 'log_level': 'info', 17:43:02 INFO - 'log_name': 'talos', 17:43:02 INFO - 'log_to_console': True, 17:43:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:43:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:43:02 INFO - 'opt_config_files': (), 17:43:02 INFO - 'pip_index': False, 17:43:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:43:02 INFO - 'cmd': ('bash', 17:43:02 INFO - '-c', 17:43:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:43:02 INFO - 'enabled': True, 17:43:02 INFO - 'halt_on_failure': False, 17:43:02 INFO - 'name': 'check_screen_resolution'},), 17:43:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:43:02 INFO - 'cmd': ('bash', 17:43:02 INFO - '-c', 17:43:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:43:02 INFO - 'enabled': True, 17:43:02 INFO - 'halt_on_failure': False, 17:43:02 INFO - 'name': 'check_screen_resolution'},), 17:43:02 INFO - 'run_cmd_checks_enabled': True, 17:43:02 INFO - 'sps_profile': False, 17:43:02 INFO - 'sps_profile_interval': 0, 17:43:02 INFO - 'suite': 'dromaeojs-e10s', 17:43:02 INFO - 'system_bits': '32', 17:43:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:43:02 INFO - 'title': 't-yosemite-r7-0165', 17:43:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:43:02 INFO - 'use_talos_json': True, 17:43:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:43:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:43:02 INFO - 'work_dir': 'build'} 17:43:02 INFO - ##### 17:43:02 INFO - ##### Running clobber step. 17:43:02 INFO - ##### 17:43:02 INFO - Running pre-action listener: _resource_record_pre_action 17:43:02 INFO - Running main action method: clobber 17:43:02 INFO - rmtree: /builds/slave/test/build 17:43:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:43:04 INFO - Running post-action listener: _resource_record_post_action 17:43:04 INFO - ##### 17:43:04 INFO - ##### Running read-buildbot-config step. 17:43:04 INFO - ##### 17:43:04 INFO - Running pre-action listener: _resource_record_pre_action 17:43:04 INFO - Running main action method: read_buildbot_config 17:43:04 INFO - Using buildbot properties: 17:43:04 INFO - { 17:43:04 INFO - "project": "", 17:43:04 INFO - "product": "firefox", 17:43:04 INFO - "script_repo_revision": "production", 17:43:04 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 17:43:04 INFO - "repository": "", 17:43:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 17:43:04 INFO - "buildid": "20160314153910", 17:43:04 INFO - "pgo_build": "False", 17:43:04 INFO - "basedir": "/builds/slave/test", 17:43:04 INFO - "buildnumber": 528, 17:43:04 INFO - "slavename": "t-yosemite-r7-0165", 17:43:04 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 17:43:04 INFO - "platform": "yosemite_r7", 17:43:04 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 17:43:04 INFO - "branch": "fx-team", 17:43:04 INFO - "repo_path": "integration/fx-team", 17:43:04 INFO - "revision": "b21c3e5856ae8873a4ee618517c738f579bd2d39", 17:43:04 INFO - "stage_platform": "macosx64", 17:43:04 INFO - "builduid": "0f37627544394f4cbce46ffaa4e09502", 17:43:04 INFO - "slavebuilddir": "test" 17:43:04 INFO - } 17:43:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/QyHes70ySwmPafNt-o12hA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 17:43:04 INFO - Running post-action listener: _resource_record_post_action 17:43:04 INFO - ##### 17:43:04 INFO - ##### Running download-and-extract step. 17:43:04 INFO - ##### 17:43:04 INFO - Running pre-action listener: _resource_record_pre_action 17:43:04 INFO - Running main action method: download_and_extract 17:43:04 INFO - mkdir: /builds/slave/test/build/tests 17:43: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')]} 17:43:04 INFO - https://queue.taskcluster.net/v1/task/QyHes70ySwmPafNt-o12hA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:43:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QyHes70ySwmPafNt-o12hA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 17:43:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QyHes70ySwmPafNt-o12hA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 17:43:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QyHes70ySwmPafNt-o12hA/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 17:43:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QyHes70ySwmPafNt-o12hA/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 17:43:05 INFO - Downloaded 1199 bytes. 17:43:05 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 17:43:05 INFO - Using the following test package requirements: 17:43:05 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 17:43:05 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:43:05 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 17:43:05 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:43:05 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 17:43:05 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:43:05 INFO - u'jsshell-mac.zip'], 17:43:05 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:43:05 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 17:43:05 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 17:43:05 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:43:05 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 17:43:05 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:43:05 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 17:43:05 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:43:05 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 17:43:05 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:43:05 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 17:43:05 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:43: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')]} 17:43:05 INFO - https://queue.taskcluster.net/v1/task/QyHes70ySwmPafNt-o12hA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:43:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QyHes70ySwmPafNt-o12hA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:43:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QyHes70ySwmPafNt-o12hA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:43:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QyHes70ySwmPafNt-o12hA/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 17:43:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QyHes70ySwmPafNt-o12hA/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 17:43:06 INFO - Downloaded 17852459 bytes. 17:43:06 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'] 17:43:06 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 17:43:09 INFO - Return code: 0 17:43:09 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 17:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:09 INFO - https://queue.taskcluster.net/v1/task/QyHes70ySwmPafNt-o12hA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:43:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QyHes70ySwmPafNt-o12hA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:43:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QyHes70ySwmPafNt-o12hA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:43:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QyHes70ySwmPafNt-o12hA/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 17:43:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QyHes70ySwmPafNt-o12hA/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 17:43:10 INFO - Downloaded 17852459 bytes. 17:43:10 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'] 17:43:10 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 17:43:14 INFO - Return code: 0 17:43:14 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')]} 17:43:14 INFO - https://queue.taskcluster.net/v1/task/QyHes70ySwmPafNt-o12hA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:43:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QyHes70ySwmPafNt-o12hA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:43:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QyHes70ySwmPafNt-o12hA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:43:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QyHes70ySwmPafNt-o12hA/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 17:43:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QyHes70ySwmPafNt-o12hA/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 17:43:14 INFO - Downloaded 10845263 bytes. 17:43:14 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'] 17:43:14 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 17:43:15 INFO - Return code: 0 17:43: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')]} 17:43:15 INFO - https://queue.taskcluster.net/v1/task/QyHes70ySwmPafNt-o12hA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:43:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QyHes70ySwmPafNt-o12hA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:43:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QyHes70ySwmPafNt-o12hA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:43:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QyHes70ySwmPafNt-o12hA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 17:43:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QyHes70ySwmPafNt-o12hA/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 17:43:18 INFO - Downloaded 111187861 bytes. 17:43:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QyHes70ySwmPafNt-o12hA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:43:18 INFO - mkdir: /builds/slave/test/properties 17:43:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:43:18 INFO - Writing to file /builds/slave/test/properties/build_url 17:43:18 INFO - Contents: 17:43:18 INFO - build_url:https://queue.taskcluster.net/v1/task/QyHes70ySwmPafNt-o12hA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:43:19 INFO - Running post-action listener: _resource_record_post_action 17:43:19 INFO - Running post-action listener: set_extra_try_arguments 17:43:19 INFO - ##### 17:43:19 INFO - ##### Running populate-webroot step. 17:43:19 INFO - ##### 17:43:19 INFO - Running pre-action listener: _resource_record_pre_action 17:43:19 INFO - Running main action method: populate_webroot 17:43:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:43:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:43:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:43:19 INFO - '--tppagecycles', 17:43:19 INFO - '7'], 17:43:19 INFO - 'tests': ['tsvgm']}}, 17:43:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:43:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:43:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:43:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:43:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:43:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:43:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:43:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:19 INFO - 'talos_options': ['--e10s'], 17:43:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:43:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:19 INFO - 'tests': ['damp', 'tps']}, 17:43:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:19 INFO - 'talos_options': ['--e10s'], 17:43:19 INFO - 'tests': ['damp', 'tps']}, 17:43:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:43:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:43:19 INFO - 'other': {'tests': ['a11yr', 17:43:19 INFO - 'ts_paint', 17:43:19 INFO - 'tpaint', 17:43:19 INFO - 'sessionrestore', 17:43:19 INFO - 'sessionrestore_no_auto_restore', 17:43:19 INFO - 'tabpaint']}, 17:43:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:43:19 INFO - 'tests': ['a11yr', 17:43:19 INFO - 'ts_paint', 17:43:19 INFO - 'tpaint', 17:43:19 INFO - 'sessionrestore', 17:43:19 INFO - 'sessionrestore_no_auto_restore', 17:43:19 INFO - 'tabpaint']}, 17:43:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:43:19 INFO - 'tests': ['a11yr', 17:43:19 INFO - 'ts_paint', 17:43:19 INFO - 'tpaint', 17:43:19 INFO - 'sessionrestore', 17:43:19 INFO - 'sessionrestore_no_auto_restore', 17:43:19 INFO - 'tabpaint']}, 17:43:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:43:19 INFO - 'tests': ['a11yr', 17:43:19 INFO - 'ts_paint', 17:43:19 INFO - 'tpaint', 17:43:19 INFO - 'sessionrestore', 17:43:19 INFO - 'sessionrestore_no_auto_restore', 17:43:19 INFO - 'tabpaint']}, 17:43:19 INFO - 'other_l64': {'tests': ['a11yr', 17:43:19 INFO - 'ts_paint', 17:43:19 INFO - 'tpaint', 17:43:19 INFO - 'sessionrestore', 17:43:19 INFO - 'sessionrestore_no_auto_restore', 17:43:19 INFO - 'tabpaint']}, 17:43:19 INFO - 'other_nol64': {'tests': ['a11yr', 17:43:19 INFO - 'ts_paint', 17:43:19 INFO - 'tpaint', 17:43:19 INFO - 'sessionrestore', 17:43:19 INFO - 'sessionrestore_no_auto_restore', 17:43:19 INFO - 'tabpaint']}, 17:43:19 INFO - 'svgr': {'tests': ['tsvgx', 17:43:19 INFO - 'tsvgr_opacity', 17:43:19 INFO - 'tart', 17:43:19 INFO - 'tscrollx', 17:43:19 INFO - 'cart']}, 17:43:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:43:19 INFO - 'tests': ['tsvgx', 17:43:19 INFO - 'tsvgr_opacity', 17:43:19 INFO - 'tart', 17:43:19 INFO - 'tscrollx', 17:43:19 INFO - 'cart']}, 17:43:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:19 INFO - 'tests': ['tp5o']}, 17:43:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:19 INFO - 'talos_options': ['--e10s'], 17:43:19 INFO - 'tests': ['tp5o']}, 17:43:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:19 INFO - 'talos_options': ['--xperf_path', 17:43:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:43:19 INFO - 'tests': ['tp5n']}, 17:43:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:19 INFO - 'talos_options': ['--e10s', 17:43:19 INFO - '--xperf_path', 17:43:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:43:19 INFO - 'tests': ['tp5n']}}, 17:43:19 INFO - 'talos.zip': {'path': '', 17:43:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:43:19 INFO - Running post-action listener: _resource_record_post_action 17:43:19 INFO - ##### 17:43:19 INFO - ##### Running create-virtualenv step. 17:43:19 INFO - ##### 17:43:19 INFO - Running pre-action listener: _resource_record_pre_action 17:43:19 INFO - Running main action method: create_virtualenv 17:43:19 INFO - Creating virtualenv /builds/slave/test/build/venv 17:43:19 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 17:43:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:43:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:43:19 INFO - Using real prefix '/tools/python27' 17:43:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:43:19 INFO - Installing distribute.............................................................................................................................................................................................done. 17:43:22 INFO - Installing pip.................done. 17:43:22 INFO - Return code: 0 17:43:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:43:22 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')]} 17:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:22 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')]} 17:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:22 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 0x1098d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098d94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3cad9fee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109776d30>, '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 0x10959adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10976db20>, '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.m1g8msvqYw/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.ZjxITcl11z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 17:43:22 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 17:43:22 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 17:43:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m1g8msvqYw/Render', 17:43:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:22 INFO - 'HOME': '/Users/cltbld', 17:43:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:22 INFO - 'LOGNAME': 'cltbld', 17:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:22 INFO - 'MOZ_NO_REMOTE': '1', 17:43:22 INFO - 'NO_EM_RESTART': '1', 17:43:22 INFO - 'PAGER': '/bin/cat', 17:43:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:22 INFO - 'PWD': '/builds/slave/test', 17:43:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:22 INFO - 'SHELL': '/bin/bash', 17:43:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZjxITcl11z/Listeners', 17:43:22 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 17:43:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:22 INFO - 'USER': 'cltbld', 17:43:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:22 INFO - 'XPC_FLAGS': '0x0', 17:43:22 INFO - 'XPC_SERVICE_NAME': '0', 17:43:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:23 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 17:43:23 INFO - Cleaning up... 17:43:23 INFO - Return code: 0 17:43:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:43: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')]} 17:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43: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')]} 17:43:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:23 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 0x1098d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098d94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3cad9fee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109776d30>, '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 0x10959adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10976db20>, '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.m1g8msvqYw/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.ZjxITcl11z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 17:43:23 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 17:43:23 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 17:43:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m1g8msvqYw/Render', 17:43:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:23 INFO - 'HOME': '/Users/cltbld', 17:43:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:23 INFO - 'LOGNAME': 'cltbld', 17:43:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:23 INFO - 'MOZ_NO_REMOTE': '1', 17:43:23 INFO - 'NO_EM_RESTART': '1', 17:43:23 INFO - 'PAGER': '/bin/cat', 17:43:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:23 INFO - 'PWD': '/builds/slave/test', 17:43:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:23 INFO - 'SHELL': '/bin/bash', 17:43:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZjxITcl11z/Listeners', 17:43:23 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 17:43:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:23 INFO - 'USER': 'cltbld', 17:43:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:23 INFO - 'XPC_FLAGS': '0x0', 17:43:23 INFO - 'XPC_SERVICE_NAME': '0', 17:43:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:23 INFO - Downloading/unpacking psutil>=0.7.1 17:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:43:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:43:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:43:26 INFO - Installing collected packages: psutil 17:43:26 INFO - Running setup.py install for psutil 17:43:26 INFO - building 'psutil._psutil_osx' extension 17:43:26 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 17:43:27 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 17:43:27 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 17:43:27 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 17:43:27 INFO - building 'psutil._psutil_posix' extension 17:43:27 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 17:43:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:43:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:43:27 INFO - ^ 17:43:27 INFO - 1 warning generated. 17:43:27 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 17:43:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:43:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:43:27 INFO - Successfully installed psutil 17:43:27 INFO - Cleaning up... 17:43:27 INFO - Return code: 0 17:43:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1098d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098d94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3cad9fee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109776d30>, '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 0x10959adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10976db20>, '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.m1g8msvqYw/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.ZjxITcl11z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 17:43:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:43:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:43:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m1g8msvqYw/Render', 17:43:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:27 INFO - 'HOME': '/Users/cltbld', 17:43:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:27 INFO - 'LOGNAME': 'cltbld', 17:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:27 INFO - 'MOZ_NO_REMOTE': '1', 17:43:27 INFO - 'NO_EM_RESTART': '1', 17:43:27 INFO - 'PAGER': '/bin/cat', 17:43:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:27 INFO - 'PWD': '/builds/slave/test', 17:43:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:27 INFO - 'SHELL': '/bin/bash', 17:43:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZjxITcl11z/Listeners', 17:43:27 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 17:43:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:27 INFO - 'USER': 'cltbld', 17:43:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:27 INFO - 'XPC_FLAGS': '0x0', 17:43:27 INFO - 'XPC_SERVICE_NAME': '0', 17:43:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:43:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:43:30 INFO - Installing collected packages: mozsystemmonitor 17:43:30 INFO - Running setup.py install for mozsystemmonitor 17:43:30 INFO - Successfully installed mozsystemmonitor 17:43:30 INFO - Cleaning up... 17:43:30 INFO - Return code: 0 17:43:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:43:30 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')]} 17:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:30 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')]} 17:43:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:30 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 0x1098d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098d94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3cad9fee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109776d30>, '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 0x10959adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10976db20>, '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.m1g8msvqYw/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.ZjxITcl11z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 17:43:30 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 17:43:30 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 17:43:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m1g8msvqYw/Render', 17:43:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:30 INFO - 'HOME': '/Users/cltbld', 17:43:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:30 INFO - 'LOGNAME': 'cltbld', 17:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:30 INFO - 'MOZ_NO_REMOTE': '1', 17:43:30 INFO - 'NO_EM_RESTART': '1', 17:43:30 INFO - 'PAGER': '/bin/cat', 17:43:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:30 INFO - 'PWD': '/builds/slave/test', 17:43:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:30 INFO - 'SHELL': '/bin/bash', 17:43:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZjxITcl11z/Listeners', 17:43:30 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 17:43:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:30 INFO - 'USER': 'cltbld', 17:43:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:30 INFO - 'XPC_FLAGS': '0x0', 17:43:30 INFO - 'XPC_SERVICE_NAME': '0', 17:43:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:30 INFO - Downloading/unpacking blobuploader==1.2.4 17:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:33 INFO - Downloading blobuploader-1.2.4.tar.gz 17:43:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:43:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:43:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:34 INFO - Downloading docopt-0.6.1.tar.gz 17:43:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:43:34 INFO - Installing collected packages: blobuploader, requests, docopt 17:43:34 INFO - Running setup.py install for blobuploader 17:43:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:43:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:43:34 INFO - Running setup.py install for requests 17:43:34 INFO - Running setup.py install for docopt 17:43:35 INFO - Successfully installed blobuploader requests docopt 17:43:35 INFO - Cleaning up... 17:43:35 INFO - Return code: 0 17:43:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:35 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 0x1098d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098d94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3cad9fee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109776d30>, '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 0x10959adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10976db20>, '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.m1g8msvqYw/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.ZjxITcl11z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 17:43:35 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 17:43:35 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 17:43:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m1g8msvqYw/Render', 17:43:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:35 INFO - 'HOME': '/Users/cltbld', 17:43:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:35 INFO - 'LOGNAME': 'cltbld', 17:43:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:35 INFO - 'MOZ_NO_REMOTE': '1', 17:43:35 INFO - 'NO_EM_RESTART': '1', 17:43:35 INFO - 'PAGER': '/bin/cat', 17:43:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:35 INFO - 'PWD': '/builds/slave/test', 17:43:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:35 INFO - 'SHELL': '/bin/bash', 17:43:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZjxITcl11z/Listeners', 17:43:35 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 17:43:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:35 INFO - 'USER': 'cltbld', 17:43:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:35 INFO - 'XPC_FLAGS': '0x0', 17:43:35 INFO - 'XPC_SERVICE_NAME': '0', 17:43:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:43:35 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-XMIIfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:43:35 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-nspMd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:43:35 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-4depOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:43:35 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-XuZvj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:43:35 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-K4OIkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:43:36 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-BDN3Pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:43:36 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-CkuFLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:43:36 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-hCnaYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:43:36 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-y1OUzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:43:36 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-KV8UiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:43:36 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-ZoEfIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:43:36 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-QJ2iEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:43:36 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-Q5bv0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:43:36 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-khOLpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:36 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-WUkImx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:43:37 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-RTHzSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:43:37 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-SBgDjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:43:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:43:37 INFO - Running setup.py install for manifestparser 17:43:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:43:37 INFO - Running setup.py install for mozcrash 17:43:37 INFO - Running setup.py install for mozdebug 17:43:37 INFO - Running setup.py install for mozdevice 17:43:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:43:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:43:37 INFO - Running setup.py install for mozfile 17:43:38 INFO - Running setup.py install for mozhttpd 17:43:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:43:38 INFO - Running setup.py install for mozinfo 17:43:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:43:38 INFO - Running setup.py install for mozInstall 17:43:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:43:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:43:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:43:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:43:38 INFO - Running setup.py install for mozleak 17:43:38 INFO - Running setup.py install for mozlog 17:43:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:43:38 INFO - Running setup.py install for moznetwork 17:43:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:43:38 INFO - Running setup.py install for mozprocess 17:43:39 INFO - Running setup.py install for mozprofile 17:43:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:43:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:43:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:43:39 INFO - Running setup.py install for mozrunner 17:43:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:43:39 INFO - Running setup.py install for mozscreenshot 17:43:39 INFO - Running setup.py install for moztest 17:43:39 INFO - Running setup.py install for mozversion 17:43:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:43:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:43:39 INFO - Cleaning up... 17:43:39 INFO - Return code: 0 17:43:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43: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')]} 17:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43: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')]} 17:43:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:39 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 0x1098d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098d94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3cad9fee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109776d30>, '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 0x10959adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10976db20>, '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.m1g8msvqYw/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.ZjxITcl11z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 17:43:39 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 17:43:39 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 17:43:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m1g8msvqYw/Render', 17:43:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:39 INFO - 'HOME': '/Users/cltbld', 17:43:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:39 INFO - 'LOGNAME': 'cltbld', 17:43:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:39 INFO - 'MOZ_NO_REMOTE': '1', 17:43:39 INFO - 'NO_EM_RESTART': '1', 17:43:39 INFO - 'PAGER': '/bin/cat', 17:43:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:39 INFO - 'PWD': '/builds/slave/test', 17:43:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:39 INFO - 'SHELL': '/bin/bash', 17:43:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZjxITcl11z/Listeners', 17:43:39 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 17:43:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:39 INFO - 'USER': 'cltbld', 17:43:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:39 INFO - 'XPC_FLAGS': '0x0', 17:43:39 INFO - 'XPC_SERVICE_NAME': '0', 17:43:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:43:40 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-cnsUIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:43:40 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)) 17:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:43:40 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-0VjgDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:43:40 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)) 17:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:43:40 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-7DQWpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:43:40 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)) 17:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:43:40 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-thNiB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:43:40 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)) 17:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:43:40 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-w7w_iS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:43:40 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)) 17:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:43:40 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-IMIBNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:43:40 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)) 17:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:43:40 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-I8GOpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:43:40 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)) 17:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:43:40 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-WfiI1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:43:40 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)) 17:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:43:40 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-JVLTqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:43:41 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)) 17:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:43:41 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-4zS2IH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:43:41 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)) 17:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:43:41 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-aHaNrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:43:41 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)) 17:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:43:41 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-_nJfzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:43:41 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)) 17:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:43:41 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-qSr8rP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:43:41 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)) 17:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:43:41 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-Uhj05z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:43:41 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)) 17:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:41 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-ym5np9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:41 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)) 17:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:43:41 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-ZDBV5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:43:41 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)) 17:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:43:41 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-4Dohtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:43:41 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)) 17:43:41 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)) 17:43:41 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)) 17:43:41 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)) 17:43:41 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)) 17:43:41 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)) 17:43:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:43:41 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 17:43:41 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 17:43:41 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 17:43:41 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 17:43:41 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 17:43:41 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 17:43:44 INFO - Downloading blessings-1.6.tar.gz 17:43:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:43:44 INFO - Installing collected packages: blessings 17:43:44 INFO - Running setup.py install for blessings 17:43:44 INFO - Successfully installed blessings 17:43:44 INFO - Cleaning up... 17:43:44 INFO - Return code: 0 17:43:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:43:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:43:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:43:44 INFO - Reading from file tmpfile_stdout 17:43:44 INFO - Current package versions: 17:43:44 INFO - blessings == 1.6 17:43:44 INFO - blobuploader == 1.2.4 17:43:44 INFO - docopt == 0.6.1 17:43:44 INFO - manifestparser == 1.1 17:43:44 INFO - mozInstall == 1.12 17:43:44 INFO - mozcrash == 0.17 17:43:44 INFO - mozdebug == 0.1 17:43:44 INFO - mozdevice == 0.48 17:43:44 INFO - mozfile == 1.2 17:43:44 INFO - mozhttpd == 0.7 17:43:44 INFO - mozinfo == 0.9 17:43:44 INFO - mozleak == 0.1 17:43:44 INFO - mozlog == 3.1 17:43:44 INFO - moznetwork == 0.27 17:43:44 INFO - mozprocess == 0.22 17:43:44 INFO - mozprofile == 0.28 17:43:44 INFO - mozrunner == 6.11 17:43:44 INFO - mozscreenshot == 0.1 17:43:44 INFO - mozsystemmonitor == 0.0 17:43:44 INFO - moztest == 0.7 17:43:44 INFO - mozversion == 1.4 17:43:44 INFO - psutil == 3.1.1 17:43:44 INFO - requests == 1.2.3 17:43:44 INFO - wsgiref == 0.1.2 17:43:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:44 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 0x1098d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098d94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3cad9fee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109776d30>, '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 0x10959adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10976db20>, '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.m1g8msvqYw/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.ZjxITcl11z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 17:43:44 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 17:43:44 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 17:43:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m1g8msvqYw/Render', 17:43:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:44 INFO - 'HOME': '/Users/cltbld', 17:43:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:44 INFO - 'LOGNAME': 'cltbld', 17:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:44 INFO - 'MOZ_NO_REMOTE': '1', 17:43:44 INFO - 'NO_EM_RESTART': '1', 17:43:44 INFO - 'PAGER': '/bin/cat', 17:43:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:44 INFO - 'PWD': '/builds/slave/test', 17:43:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:44 INFO - 'SHELL': '/bin/bash', 17:43:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZjxITcl11z/Listeners', 17:43:44 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 17:43:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:44 INFO - 'USER': 'cltbld', 17:43:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:44 INFO - 'XPC_FLAGS': '0x0', 17:43:44 INFO - 'XPC_SERVICE_NAME': '0', 17:43:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:45 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)) 17:43:45 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)) 17:43:45 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)) 17:43:45 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)) 17:43:45 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)) 17:43:45 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)) 17:43:45 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)) 17:43:45 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)) 17:43:45 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)) 17:43:45 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)) 17:43:45 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)) 17:43:45 INFO - Cleaning up... 17:43:45 INFO - Return code: 0 17:43:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:43: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')]} 17:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43: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')]} 17:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:45 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 0x1098d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098d94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3cad9fee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109776d30>, '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 0x10959adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10976db20>, '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.m1g8msvqYw/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.ZjxITcl11z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 17:43:45 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 17:43:45 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 17:43:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m1g8msvqYw/Render', 17:43:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:45 INFO - 'HOME': '/Users/cltbld', 17:43:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:45 INFO - 'LOGNAME': 'cltbld', 17:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:45 INFO - 'MOZ_NO_REMOTE': '1', 17:43:45 INFO - 'NO_EM_RESTART': '1', 17:43:45 INFO - 'PAGER': '/bin/cat', 17:43:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:45 INFO - 'PWD': '/builds/slave/test', 17:43:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:45 INFO - 'SHELL': '/bin/bash', 17:43:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZjxITcl11z/Listeners', 17:43:45 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 17:43:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:45 INFO - 'USER': 'cltbld', 17:43:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:45 INFO - 'XPC_FLAGS': '0x0', 17:43:45 INFO - 'XPC_SERVICE_NAME': '0', 17:43:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:45 INFO - Downloading/unpacking jsonschema 17:43:45 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 17:43:45 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 17:43:45 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 17:43:45 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 17:43:45 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 17:43:45 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 17:43:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:43:47 INFO - Downloading/unpacking functools32 (from jsonschema) 17:43:47 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 17:43:47 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 17:43:47 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 17:43:47 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 17:43:47 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 17:43:47 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 17:43:48 INFO - Downloading functools32-3.2.3-2.tar.gz 17:43:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:43:48 INFO - warning: no files found matching '*.txt' 17:43:48 INFO - no previously-included directories found matching 'build' 17:43:48 INFO - no previously-included directories found matching 'dist' 17:43:48 INFO - no previously-included directories found matching '.git*' 17:43:48 INFO - Installing collected packages: jsonschema, functools32 17:43:48 INFO - Running setup.py install for functools32 17:43:48 INFO - warning: no files found matching '*.txt' 17:43:48 INFO - no previously-included directories found matching 'build' 17:43:48 INFO - no previously-included directories found matching 'dist' 17:43:48 INFO - no previously-included directories found matching '.git*' 17:43:48 INFO - Successfully installed jsonschema functools32 17:43:48 INFO - Cleaning up... 17:43:48 INFO - Return code: 0 17:43:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:48 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 0x1098d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098d94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3cad9fee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109776d30>, '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 0x10959adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10976db20>, '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.m1g8msvqYw/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.ZjxITcl11z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 17:43:48 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 17:43:48 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 17:43:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m1g8msvqYw/Render', 17:43:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:48 INFO - 'HOME': '/Users/cltbld', 17:43:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:48 INFO - 'LOGNAME': 'cltbld', 17:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:48 INFO - 'MOZ_NO_REMOTE': '1', 17:43:48 INFO - 'NO_EM_RESTART': '1', 17:43:48 INFO - 'PAGER': '/bin/cat', 17:43:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:48 INFO - 'PWD': '/builds/slave/test', 17:43:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:48 INFO - 'SHELL': '/bin/bash', 17:43:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZjxITcl11z/Listeners', 17:43:48 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 17:43:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:48 INFO - 'USER': 'cltbld', 17:43:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:48 INFO - 'XPC_FLAGS': '0x0', 17:43:48 INFO - 'XPC_SERVICE_NAME': '0', 17:43:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:48 INFO - Downloading/unpacking flake8 17:43:48 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 17:43:48 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 17:43:48 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 17:43:48 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 17:43:48 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 17:43:48 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 17:43:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:43:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:43:51 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 17:43:51 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 17:43:51 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 17:43:51 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 17:43:51 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 17:43:51 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 17:43:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:43:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:43:51 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 17:43:51 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 17:43:51 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 17:43:51 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 17:43:51 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 17:43:51 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 17:43:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:43:51 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 17:43:51 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 17:43:51 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 17:43:51 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 17:43:51 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 17:43:51 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 17:43:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:43:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:43:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:43:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:43:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:43:52 INFO - no previously-included directories found matching 'docs/_build' 17:43:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:43:52 INFO - Running setup.py install for pep8 17:43:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:43:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:43:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:43:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:43:52 INFO - no previously-included directories found matching 'docs/_build' 17:43:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:43:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:43:52 INFO - Cleaning up... 17:43:52 INFO - Return code: 0 17:43:52 INFO - Running post-action listener: _resource_record_post_action 17:43:52 INFO - Running post-action listener: _start_resource_monitoring 17:43:53 INFO - Starting resource monitoring. 17:43:53 INFO - ##### 17:43:53 INFO - ##### Running install step. 17:43:53 INFO - ##### 17:43:53 INFO - Running pre-action listener: _resource_record_pre_action 17:43:53 INFO - Running main action method: install 17:43:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:43:53 INFO - Reading from file tmpfile_stdout 17:43:53 INFO - Detecting whether we're running mozinstall >=1.0... 17:43:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:43:53 INFO - Reading from file tmpfile_stdout 17:43:53 INFO - Output received: 17:43:53 INFO - Usage: mozinstall [options] installer 17:43:53 INFO - Options: 17:43:53 INFO - -h, --help show this help message and exit 17:43:53 INFO - -d DEST, --destination=DEST 17:43:53 INFO - Directory to install application into. [default: 17:43:53 INFO - "/builds/slave/test"] 17:43:53 INFO - --app=APP Application being installed. [default: firefox] 17:43:53 INFO - mkdir: /builds/slave/test/build/application 17:43:53 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'] 17:43:53 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 17:44:27 INFO - Reading from file tmpfile_stdout 17:44:27 INFO - Output received: 17:44:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:44:27 INFO - Running post-action listener: _resource_record_post_action 17:44:27 INFO - ##### 17:44:27 INFO - ##### Running run-tests step. 17:44:27 INFO - ##### 17:44:27 INFO - Running pre-action listener: _resource_record_pre_action 17:44:27 INFO - Running main action method: run_tests 17:44:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:44:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:44:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:44:27 INFO - 2016-03-14 17:44:27.195 screenresolution[1635:7487] starting screenresolution argv=screenresolution get 17:44:27 INFO - 2016-03-14 17:44:27.197 screenresolution[1635:7487] Display 0: 1600x1200x32@60 17:44:27 INFO - 2016-03-14 17:44:27.203 screenresolution[1636:7489] starting screenresolution argv=screenresolution list 17:44:27 INFO - Available Modes on Display 0 17:44:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:44:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:44:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:44:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:44:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:44:27 INFO - Intel Iris: 17:44:27 INFO - Chipset Model: Intel Iris 17:44:27 INFO - Type: GPU 17:44:27 INFO - Bus: Built-In 17:44:27 INFO - VRAM (Dynamic, Max): 1536 MB 17:44:27 INFO - Vendor: Intel (0x8086) 17:44:27 INFO - Device ID: 0x0a2e 17:44:27 INFO - Revision ID: 0x0009 17:44:27 INFO - Displays: 17:44:27 INFO - Display: 17:44:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:44:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:44:27 INFO - Display Serial Number: 1600x1200 60 17:44:27 INFO - Main Display: Yes 17:44:27 INFO - Mirror: Off 17:44:27 INFO - Online: Yes 17:44:27 INFO - Rotation: Supported 17:44:27 INFO - Return code: 0 17:44:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:44:27 INFO - Python 2.7.3 17:44:27 INFO - Return code: 0 17:44:27 INFO - grabbing minidump binary from tooltool 17:44:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:27 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 0x109776d30>, '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 0x10959adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10976db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:44:27 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 17:44:27 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 17:44:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:44:27 INFO - Return code: 0 17:44:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:44:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:44:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:44:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:44:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:44:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:44:28 INFO - Return code: 0 17:44:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QyHes70ySwmPafNt-o12hA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0165', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:44:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QyHes70ySwmPafNt-o12hA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0165 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:44:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m1g8msvqYw/Render', 17:44:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:28 INFO - 'HOME': '/Users/cltbld', 17:44:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:28 INFO - 'LOGNAME': 'cltbld', 17:44:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:44:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:28 INFO - 'MOZ_NO_REMOTE': '1', 17:44:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:44:28 INFO - 'NO_EM_RESTART': '1', 17:44:28 INFO - 'PAGER': '/bin/cat', 17:44:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:28 INFO - 'PWD': '/builds/slave/test', 17:44:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:44:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:28 INFO - 'SHELL': '/bin/bash', 17:44:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZjxITcl11z/Listeners', 17:44:28 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 17:44:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:28 INFO - 'USER': 'cltbld', 17:44:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:28 INFO - 'XPC_FLAGS': '0x0', 17:44:28 INFO - 'XPC_SERVICE_NAME': '0', 17:44:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QyHes70ySwmPafNt-o12hA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0165', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:44:28 INFO - mozversion application_buildid: 20160314153910 17:44:28 INFO - mozversion application_changeset: b21c3e5856ae8873a4ee618517c738f579bd2d39 17:44:28 INFO - mozversion application_display_name: Nightly 17:44:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:44:28 INFO - mozversion application_name: Firefox 17:44:28 INFO - mozversion application_remotingname: firefox 17:44:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:44:28 INFO - mozversion application_vendor: Mozilla 17:44:28 INFO - mozversion application_version: 48.0a1 17:44:28 INFO - mozversion platform_buildid: 20160314153910 17:44:28 INFO - mozversion platform_changeset: b21c3e5856ae8873a4ee618517c738f579bd2d39 17:44:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:44:28 INFO - mozversion platform_version: 48.0a1 17:44:28 INFO - using testdate: 1458002668 17:44:28 INFO - actual date: 1458002668 17:44:28 INFO - starting webserver on 'localhost:49270' 17:44:28 INFO - SUITE-START | Running 2 tests 17:44:28 INFO - TEST-START | dromaeo_css 17:44:28 INFO - operating with platform_type : mac_ 17:44:28 INFO - Initialising browser for dromaeo_css test... 17:44:28 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmpPdS3qQ/profile http://localhost:49270/getInfo.html) 17:44:31 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 17:44:31 INFO - PROCESS | 1654 | colorDepth:24 17:44:31 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 17:44:31 INFO - PROCESS | 1654 | __metrics 17:44:31 ERROR - PROCESS | 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 17:44:32 INFO - TEST-INFO | 1654: exit 0 17:44:32 INFO - Browser initialized. 17:44:32 INFO - Running cycle 1/1 for dromaeo_css test... 17:44:32 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmpPdS3qQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:44:44 INFO - PROCESS | 1658 | RSS: Main: 255066112 17:44:44 INFO - PROCESS | 1658 | 17:45:34 INFO - PROCESS | 1658 | 1458002734338 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] 17:47:44 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 17:47:46 INFO - PROCESS | 1658 | RSS: Main: 267714560 17:47:46 INFO - PROCESS | 1658 | 17:50:48 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 17:50:48 INFO - PROCESS | 1658 | RSS: Main: 281145344 17:50:48 INFO - PROCESS | 1658 | 17:53:50 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 17:53:51 INFO - PROCESS | 1658 | RSS: Main: 281788416 17:53:51 INFO - PROCESS | 1658 | 17:56:52 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 17:56:53 INFO - PROCESS | 1658 | RSS: Main: 283131904 17:56:53 INFO - PROCESS | 1658 | 17:59:56 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 17:59:56 INFO - PROCESS | 1658 | RSS: Main: 286523392 17:59:56 INFO - PROCESS | 1658 | 18:02:59 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 18:02:59 INFO - PROCESS | 1658 | RSS: Main: 287477760 18:02:59 INFO - PROCESS | 1658 | 18:02:59 INFO - PROCESS | 1658 | __start_tp_report 18:02:59 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 18:02:59 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 18:02:59 INFO - PROCESS | 1658 | |i|pagename|runs| 18:02:59 INFO - PROCESS | 1658 | |0;dojo.html;3375.139339468435;3422.709069729073;3453.723702103832;3462.688358047775;3470.3926812807754;5467.835964921049;5520.22716819645;5533.280673512448;5551.500364967163;5562.110062390018;5433.1578605316145;5497.147942068986;5528.281323427958;5601.327840659126;5676.943230567693;5018.096742586333;5059.367579052619;5060.79756809729;5100.387953445592;5220.712860792655;4921.729304888229;4927.630427717918;4941.085899108676;4970.676906001117;4986.800527978877;3862.903427414309;4879.438864530589;4979.352684151074;4979.477154898737;5051.974740126313;4936.308916751657;4940.258961155855;4970.975145124287;4974.204127339644;4985.35190425246;4095.9385609215888;4903.901921961577;4982.825601103944;4991.975040124812;4992.051510213048;5343.198520221959;5398.514133727944;5424.593155513313;5451.918221226685;5457.154141108134;6043.516518678495;6106.694665266719;6111.908321375183;6117.5717699761035;6148.292946311142;5048.671836330664;5633.633813802131;6074.817755467343;6158.230221222348;6174.938250617482;4743.810247590127;5643.209950606918;5666.036773748473;5669.461401166883;5730.971345143289;5117.692938423706;6153.969230153821;6206.844828879224;6213.875722485525;6231.345708700521;5769.826905192851;5967.403259674084;5980.760769569169;5986.5210783137245;6020.976434006142;5930.644161350333;6019.608725432833;6111.075205202202;6133.701927635063;6136.985753961143;5921.437463440966;5988.28140623128;5990.880182396328;5996.2504686914135;6018.548608854266;5968.46283834457;5992.67040312787;6061.151438798572;6080.635161890301;6098.298695650057;3917.353636649978;4759.405074365704;4769.213079841857;4769.379980602499;4855.757212139379;4261.2542805009;4292.527821939584;4299.763513006815;4318.157959197926;4333.58830911063;5388.865278368072;5559.999200144013;5561.416051314634;5564.777408903679;5606.943930560724;6128.356123365552;6134.405972711579;6144.846378840565;6173.81478555644;6197.845053873689;5551.333839939233;5576.163575463713;5622.044252477089;5627.746751396197;5645.23789288449;5119.820806271762;5205.765740541685;5224.033553792485;5269.367675878919;5300.257963885059;6216.595921265194;6226.782062627786;6228;6228.065790131426;6264.718087686065;6113.388661134029;6135.294441139147;6146.815595532141;6153.569250152446;6170.197874276315;6106.976420671998;6153.107799369156;6180.258368995749;6229.2524897012645;6229.626222426669;5545.112781954868;5971.373005834324;6024.33732289439;6042.541795404627;6070.939290607037;5983;6095.329513753572;6122.173506576555;6150.876982460236;6153.723082461211;5743.712814359182;5747.798827041201;5775.364709881994;5814;5984.850378740392;5917.082852157922;5919.052951527735;5943.970280148572;5959.940400595939;5964.075568286922;5637.49262566371;5718.199452076796;5731.254936858349;5762.279715035621;5762.567807414544;5795.072788353843;5826.242588463472;5876.1773351729935;5877.676727780014;5925.229720136354;5747.568932330176;5780.364159942319;5782.710864456844;5785.103308987113;5789.044807606698 18:02:59 INFO - PROCESS | 1658 | |1;ext.html;569.988270819296;586.8767558812649;601.6330038676409;633.3128555517263;641.3682522715125;37350.43974340384;38167;38210.426843597335;38214.42678359823;38215;31454.685453145463;32908.50637240443;33210.16974575637;35035;41943.58056419435;7927.40544459165;9507.429554226734;9580.61677532898;9609.423434593911;9619.759506012371;9440.57517411718;9589.32874698768;9591.136797688207;9591.712248632552;9627.277954153431;8408.00619705638;9545.99767024463;9584.233261339075;9630;9648.565814538328;9531.332806703498;9631.08504692053;9644.32489725723;9654.324197306192;9666.75833104171;9327;9401.858972115424;9409.717708468757;9440.669576564787;9522;32234.677653223403;38531.807340963394;38857.61142388568;38944.805275973726;39171.02072448183;3046.31457921968;3165.2878102427;3207.7754557181006;3261.5107733839877;3391.067456449496;29504.114876553736;30108.096757097323;30462.54306185409;30498.69501305003;30959.38081238385;2325.302409277227;2351.259353303704;2482.416632091457;2741.8903243870423;2787.372841110754;408656;411299.8305025427;413540;417536.82463175285;418119;48441.75779121152;48448.757756210995;70551.2944870555;71165.64417177881;71439.57120857554;47914.04171916542;48369;48604.7569762156;48769.51230487721;48771;15754.842451575338;15822.208889555477;16196.838031619769;16350.937189082671;16355;12894.290814005131;13017.869821301856;13018.414171362312;13028.28344441046;13038.739225215442;15499.845001550066;15576.143312117716;15626.062436253862;15661.765073523906;16035.599110022344;6888.931110688929;6952.270011648805;6971.5468494547695;7013.088298521159;7027.121609798775;964.1756298364937;979.2313034268208;994.2940512236248;1031.5873650539845;1081.0486771641063;30012.24969375783;30151.849240754094;30470.69529304723;30686.53970190449;30801.69198308033;1071.3715152967602;1127.464454384161;1131.7623299107279;1136.4658610453073;1159.591096817371;15124.54626361211;15284.006539574892;15310.846891530942;15539.06765594068;15582.688346233012;531051;745233;768455;771450.7129572243;771472;62164.75670486565;62496;62578.687106565085;62913.68543157255;63363.366366335744;1469.3681716861638;1470.6029372069695;1475.7712554554062;1485.9405623774928;1501.5945694662598;30192.54711179378;30647.846760766053;31702;31833.681663183997;32072.839635801673;51787.223191652905;52039;52449.737751311;52533.737331313096;52581.737091314295;496673;499914;500087;501032;502601;32955.505667415484;34108.976730698116;34308.31383372368;34727.305453891284;34739.652603473645;45228.09543809039;45498.772506137255;45576.63270101902;46065.53934460613;47010.76494617505;37606.811965939996;37691.43462848114;38187.80906095452;38554;38911.80544097262;35412.46881296834;35739.46390804088;36113.458298126076;36376.81811591031;36543.08642283964;35159.47260791141;35509;36019.459708103874;36238.8188059058;36393.454098189075;30307.393852123274;31092.68907310898;31448.213794655316;32294.83852580722;32484;20910.790892091492;24451.877740611184;24492.14277500279;25060.248192554252;25648.871755641103 18:02:59 INFO - PROCESS | 1658 | |2;jquery.html;353.41509801278875;361.6564263949249;363.919937613725;367.6782815036843;368.123865200822;19268.614627707455;19829.603407931852;20394.286199982966;20569.794302056976;20587.27944521942;20955.68566471504;21224.4693882653;21537.56924861506;21688.457788555294;21764.782352176473;5737.311522617271;5984.491318237955;5997.22036135304;6000.2199714037115;6010.308814486324;5656.519195868356;5856.150858125569;5881.117832325164;5940.316863560681;5962.582619216657;5757.856053598673;5878.382769809173;5883.705814709268;5885.823425297248;5886.587938844283;5579.525740312079;5839.153322768218;5860.589758716891;5864.824055278348;5873.236479257712;5051.722155281458;5082.08522465956;5091.516305950929;5116.923246151311;5117.283580298761;24551.017959281606;24966.127540434358;25253.11614093498;25572.872135639387;26051.218463446126;2100.970524443012;2251.279590531031;2261.061659411342;2265.184533567914;2361.645753137026;14825.851741482662;14898.851011489854;15098.641122299046;15342.539723808304;15443.691126177413;1508.8868334874928;1735.6962531556926;1753.5791410061493;1817.1368599914936;1838.7793464784177;106870;107882.46058769735;108848.4557577215;109350;110115.44942275317;10550.366977981346;10551.94480551954;10747.462626868626;10749.785004300027;10853.728656783485;11285.548578056785;12984.480620775252;12996.870031299755;13001.349932503337;13024.08831381813;6154.846128846814;6997.895031574531;7156.82107947295;8342.791430214293;8355.95822020886;7283;8742.994555626185;8976.820463590691;8985.730428087169;9099.999000109983;5829.183914252008;5894;6238.095476155932;6322.272938612026;6329.715162817684;1842.4656849513758;1867.1971052447577;1867.7758668959812;1873.5597134673342;1900.562870539756;820.7414664380701;872.2760109109424;915.199200699388;982.513655740413;992.4541502173776;14056.648583785487;17243.913780431016;21379.037943292587;21465.356039318845;21640.891795540923;971.4754032822196;1005.215931573374;1024.3956065921143;1038.553422028535;1038.85456036155;10216.795664086676;11632;11643.184977051525;11664.708382290512;11718.88281117178;662862;668696;674134;684997;688778;64509.35490645033;66586.66706666436;67041;101474;111261;1065.9093977011885;1069.385103565453;1100.862392200975;1120.6581992492206;1134.466800603715;18600.883946963226;18769.343072992928;18802.717959230347;18821.90589047046;18909.716354254422;47546;48705.75647121741;48882.511174889216;49509.50490495049;49664.75167624139;68370;69052.10107469185;69687;70981.58036839338;71205.28794712193;7326.1610077216865;7342;7350;7412.925870741224;7538.886916696364;12365.381730913597;12407.689807754878;12713.87286127127;12943.676408089874;12988.610341689764;10875.891241087487;11087.002169804757;11137.164712646421;11151.996320331209;11208;9163.816723665623;10900.672979810619;11031.22781405294;11182.72043198894;11214.719632008939;11077.446127693744;11308.547658093585;11319.09447244202;11456.484458199235;11637.069034477052;7229.602371869387;7313.158986716596;7369.594672292861;7422.628868556659;7537.472376933562;10607.893921060691;11093.722656933642;11259.98660120593;11444.599439019594;11493.310401375944 18:02:59 INFO - PROCESS | 1658 | |3;mootools.html;1568.8980216285943;1592.466523714556;1859.851211903048;1943.4946913802407;1946.9513262168434;7373.852522949551;7932.365410767139;8649.78375540611;8792.824143517133;8806.603702833372;7230.385417239541;8484.830303393928;8522.701705440311;8642.654293828255;8652.783680407993;2094.4240333908147;2474.9133780317693;2477.925662230136;2486.9378265543323;2490.252924122765;2388.044782087162;2433.3065076453213;2435.8173137014705;2440.2191298784396;2477.6283557466345;2070.9585808283823;2352.070931981866;2409.204962362425;2474.418511649761;2481.6153496208117;2152.35429371188;2380.0955636858057;2388.5103553771523;2390.521895620883;2425.63615457681;1881.708335208045;2464.4331803685254;2490.1906880263805;2499.3751562109474;2592.988734393588;8739.650413983432;8749.081346458594;8761.430507017023;8770.736877893609;8777.429467084683;5397.676139431607;5512.91730624041;5538.889222215533;5552.750126244328;5560.77756889724;3575.302815950891;3657.8536858525626;3689.262147570497;3702.962970370316;3737.775733455974;1038.942858142802;1052.3159946035062;1058.142904247562;1067.9519421626046;1072.5441687282873;11629.94185029078;11680.474378653065;11712;11742;11743.882561174365;4854.68444551103;4885.41375034991;4938.678985865908;4995.875103122378;4998.350214472168;8568.400211985101;9964.551595178234;10016.1987041038;10017.899821001842;10043.69868903934;5383.5423988961375;5438.8912221755345;5462;5472.699001554873;5478.643888147258;4476.462824461086;4842;4908.239222920453;4956.653034287565;4963;3750.868719594801;3858.82635281413;3860.7876566789096;3865.207632435344;3882.1071153634257;1201.7656556971306;1322.7751282282036;1337.0774165825549;1339.8660133986523;1345.4752646467884;1209.1113031921532;1209.4617895036624;1283.9343345023608;1370.4312710225345;1386.182152529992;7881.960590197127;7920.049594048636;8271.33829293667;8303.169683031769;8318.251357377743;500.3820281951787;504.04231959276933;505.16647531572465;505.2824988516242;520.8359366799446;6180.3201647818705;6208.192934918522;6225.782097626561;6289.7484100636375;6296.905546416808;10451;10752.677419677422;10766.407847568458;10775.78448431027;10842.241043126905;9938.701838944698;10562.260641755158;10583.206259530565;10670.30643008202;10694.62568810088;8344.541050242295;8374.371922105745;8401.11788262248;8408.915910840935;8430.536320502308;7935.960320198362;8077.192280771876;8115.715949941724;8121.1472795358;8162.918370816215;9339.719808405758;9533.618655253713;9585;9589.42463452195;9791.412515249107;9741.707748767549;9756.17072548813;9776.706698799047;9915.752106197402;9958.203343732339;6016.217891674054;6818.829529261808;7496.25037496246;7566.432517561315;7637.427192960661;7004.579725216503;7019.894701579583;8169.959150204211;8201.466904651179;8207.179282071746;7227.385672217921;7383.224761400191;7407.9999200107295;7483.88774168377;7560.206178351414;7228.530145540523;7261.5280006799385;7287.744928927462;7325.890111648223;7354;7735;7772.7668169954995;7839.647215875185;7865.370770338473;7877.84244315099;6979.476539259677;7005.754798582026;7005.754798582229;7072;7076.32774886385;7170.569765814068;7229.927700722926;7236.421086312977;7239.710411583477;7240.891386629311 18:02:59 INFO - PROCESS | 1658 | |4;prototype.html;328.68446291560105;330.31459721078755;331.585518102372;336.784457946914;339.0608015796245;6815.965920170398;6823.942288945209;6828.317168283169;6851.760188393408;6891.724331026766;6790.456763458924;6817.147856517935;6853.4174595159475;6857.348551887575;6857.691403886824;4742.502037286087;4853.878653033667;5008.549230569248;5019.196928491442;5048.444671086187;4041.6766658667234;4101.995011222255;4967.279744437054;4992.800287988494;5019.422766381858;4898.975505122487;4939.604831613462;4947.01059788042;4963.106640804654;4978.303037574742;4948.084604348207;4955.82654607087;4956.4547899731;4961.429435614915;4961.627877909171;4281.422008028907;4286.635635970946;4292.59220374064;4296.334068219431;4302.9569704303185;6355.173827402455;6549.541532092755;6598.5051121165625;6622.437092847065;6623.867522649568;5872.825434912992;5914.645121292736;5936.109583562457;5943.346231914529;5944.613600116022;7212.963935180343;7221.711131554732;7222.0611320528;7230.60231687257;7230.819229519251;4766.952330476685;4780.450248221464;4796.424429068499;4800.711957282574;4804.663673542854;6185.6597887116195;7707.884381734279;7736.149023607399;7740.690372385098;7742.845143097163;4317.460317460317;4722.7874745635845;4793.544613261734;4798.064377446364;4807.687500312539;4889.4377146627885;4891.608671306358;4892.412910450697;4902.754862256873;4904.60763138948;5732.455416735404;5778;5785.218995435646;5790.768369265183;5803.274590676166;7247;7316.6341682915645;7323.816904577322;7332.046833911664;7344.192138864721;1616.3130669465666;1662.3599914033184;1687.64559442516;1694.618710790087;1705.5821323775754;1060.5757696921294;1063.7181146996052;1098.9890101099047;1109.6615532262738;1119.8264269038311;6134.294556126013;6770.763023294161;6774.796756097325;6794.694238759268;6828.5902845829405;7517.210692877278;7518.924810751822;7535.208803075708;7539.698412063566;7557.584332861636;6695.125364897739;6758.357955994173;6774.153230846145;6783.457323414115;6799;3617.1680513482047;3946.8223929923224;4002.639762421396;4004.4593979812935;4015.5382131055303;6809.5233333666165;6969.337912898267;7592.620368981528;7747.845043099219;7992.440529162903;7867.6066196689935;7874.251946065115;7905.407094467823;7913.802154946057;7923;7988.600569971594;7995.720149794729;7996.840063198703;8020.398470114765;8026.799330016563;7223.674934627849;7543.1325397579985;7556.811079723051;7647.579383133981;7664.73173438927;7404.888926666212;7429.888551671621;7482.663280152297;7484.251574842472;7516.924830751623;7952.522848629101;7982.521048737094;7984.361251099782;8000.679972801023;8003.039635243808;4674.088552732184;4715.764211789466;4724.503927087744;4744.572988431058;4745.1221524018165;7248.565086094851;7561.164563288767;7607.201243869536;7609.505382150364;7617.542947423172;7305.488615796843;7341.74303899361;7346.302101300368;7360.411167106726;7366.200843679368;5982.4316689914385;7308.598027108347;7325.963370183115;7346.4122870169185;7355.963220184079;7127.429805615642;7142.9999800027;7170.426365890612;7172.856542869218;7205.063341765537;5789.710514474344;6616.875131227799;7045.753398631024;7379.2251813558805;7381.44639152055;5949.494292984971;6352.396522330371;7092.361687447948;7197.928020719726;7207.747728829466 18:02:59 INFO - PROCESS | 1658 | |5;yui.html;683.9580742583054;706.8232941764559;761.5963539324154;775.4959276470296;782.2412260107697;14905.403783848647;15021.399144034252;15164.469243576463;15233.695326093486;17562.473125806213;16582.75125873113;16690.41583544576;16709;16716.916415417938;16839;757.0650246945019;926.0646746785727;944.5418971798672;955.254901177083;956.8325543029941;931.5109567477061;949.9382540134903;950.1686024728363;950.5959967014026;952.8427809411439;969.3747532841313;991.5191132300828;1003.6537394598852;1011.378002528447;1011.7470632341915;980.745006298364;981.8969008254138;985.7979114281627;1003.5985605757683;1006.7835415385728;707.6567864585672;730.6858051038105;738.752517906502;740.2338579570119;746.7796999885047;15373.923130384277;15416.460423885223;15458.458953936672;15465.072095674295;15493.922530387275;12408.75182496354;12458.12793104483;12485.438155283035;12676.556320528738;12708.682282942907;9889.80220395588;10041.748956276078;10096.848547271797;10177.949110254476;10446.26876118672;3387.356402283558;3412.2493051528622;3471.1322169457635;3479.982600087009;3506.0708912138302;76436.23563764346;77319.22680773177;78949.60525197395;79172.60413697953;79597.60201198957;9111.726648200565;9129.77175570616;9161.862572061424;9202.861957070649;9274;17124.571885702957;21008.684869726967;21039.368818935458;21041.473963150736;21052.684209736864;6959.930400696029;6965.129358830146;7646.770596882103;7651.846963060708;7743.845123097619;4060.1879624075304;4080.734752241154;4123.773192474383;4138.337865941435;4162.521310049323;3497.108237399447;3504.9474257886154;3522.330757156132;3541.4864844597905;3545.911352216215;468.7492191677436;566.2723400430427;580.8809194115196;582.260529128005;588.6026931821003;580.9506191973645;591.795830438498;600.0835937344502;612.5252928980076;613.6686189457732;7978.082520510099;8120.431569790177;8153.22544358285;8210.917890821134;8228.794280143044;487.44187904849457;576.3688760806909;608.9665068421191;611.3122736920964;611.9908201376983;3763.6800871925643;3877.3214687429586;3916.8433262669173;3989.7007724420782;4010.9598904010586;90633.09366906247;93585.5320723392;95770;95886.52056739671;96084;69865.95201071988;70045;70087;70160.29839701537;70702.64648676723;71264;71299.6435017832;72737.6363118181;73106;74389.25610743824;7893.447458677838;7941.12647608751;7974.601269936364;8017.639206235617;8022.077461091816;48109.5189048105;48908.75545622249;49747.751261243466;49963.75018124886;51511;65781.03985320768;70797.64601176961;71148;71692.56614867569;72876;9858.605655773688;9958.800823983625;10132.848007280045;10204.336718113298;10665.986731260518;10982.0665243452;11035.724106897393;11055.22613417053;11112.055475284691;11542.884571154182;10454.268201225841;10731.678049658523;10839.458027098455;10851.782964340511;11093.667189984313;10090.09189172978;10198.43908585035;10204.642837500653;10908.236423450282;10944.890551094388;10301.74245643865;10380.688579342632;10666.146708263164;10676.679699609023;10726.839097413702;8816.823663526822;8818.206361427503;8945.552722363725;9006.874140732409;9098.590563424794;8459.703910363107;9530.037187710695;9648.324617276723;9684.08001239881;9773.657921972697 18:02:59 INFO - PROCESS | 1658 | __end_tp_report 18:02:59 INFO - PROCESS | 1658 | __start_cc_report 18:02:59 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,365 18:02:59 INFO - PROCESS | 1658 | __end_cc_report 18:02:59 INFO - PROCESS | 1658 | __startTimestamp1458003779352__endTimestamp 18:02:59 INFO - PROCESS | 1658 | 18:02:59 INFO - PROCESS | 1658 | ------- Summary: start ------- 18:02:59 INFO - PROCESS | 1658 | Number of tests: 6 18:02:59 INFO - PROCESS | 1658 | 18:02:59 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5546.81 Median:5743.71 stddev:655.15 (11.4%) stddev-sans-first:634.63 18:02:59 INFO - PROCESS | 1658 | Values: 3375.1 3422.7 3453.7 3462.7 3470.4 5467.8 5520.2 5533.3 5551.5 5562.1 5433.2 5497.1 5528.3 5601.3 5676.9 5018.1 5059.4 5060.8 5100.4 5220.7 4921.7 4927.6 4941.1 4970.7 4986.8 3862.9 4879.4 4979.4 4979.5 5052.0 4936.3 4940.3 4971.0 4974.2 4985.4 4095.9 4903.9 4982.8 4992.0 4992.1 5343.2 5398.5 5424.6 5451.9 5457.2 6043.5 6106.7 6111.9 6117.6 6148.3 5048.7 5633.6 6074.8 6158.2 6174.9 4743.8 5643.2 5666.0 5669.5 5731.0 5117.7 6154.0 6206.8 6213.9 6231.3 5769.8 5967.4 5980.8 5986.5 6021.0 5930.6 6019.6 6111.1 6133.7 6137.0 5921.4 5988.3 5990.9 5996.3 6018.5 5968.5 5992.7 6061.2 6080.6 6098.3 3917.4 4759.4 4769.2 4769.4 4855.8 4261.3 4292.5 4299.8 4318.2 4333.6 5388.9 5560.0 5561.4 5564.8 5606.9 6128.4 6134.4 6144.8 6173.8 6197.8 5551.3 5576.2 5622.0 5627.7 5645.2 5119.8 5205.8 5224.0 5269.4 5300.3 6216.6 6226.8 6228.0 6228.1 6264.7 6113.4 6135.3 6146.8 6153.6 6170.2 6107.0 6153.1 6180.3 6229.3 6229.6 5545.1 5971.4 6024.3 6042.5 6070.9 5983.0 6095.3 6122.2 6150.9 6153.7 5743.7 5747.8 5775.4 5814.0 5984.9 5917.1 5919.1 5944.0 5959.9 5964.1 5637.5 5718.2 5731.3 5762.3 5762.6 5795.1 5826.2 5876.2 5877.7 5925.2 5747.6 5780.4 5782.7 5785.1 5789.0 18:02:59 INFO - PROCESS | 1658 | 18:02:59 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:67486.11 Median:38177.40 stddev:150534.07 (394.3%) stddev-sans-first:150872.51 18:02:59 INFO - PROCESS | 1658 | Values: 570.0 586.9 601.6 633.3 641.4 37350.4 38167.0 38210.4 38214.4 38215.0 31454.7 32908.5 33210.2 35035.0 41943.6 7927.4 9507.4 9580.6 9609.4 9619.8 9440.6 9589.3 9591.1 9591.7 9627.3 8408.0 9546.0 9584.2 9630.0 9648.6 9531.3 9631.1 9644.3 9654.3 9666.8 9327.0 9401.9 9409.7 9440.7 9522.0 32234.7 38531.8 38857.6 38944.8 39171.0 3046.3 3165.3 3207.8 3261.5 3391.1 29504.1 30108.1 30462.5 30498.7 30959.4 2325.3 2351.3 2482.4 2741.9 2787.4 408656.0 411299.8 413540.0 417536.8 418119.0 48441.8 48448.8 70551.3 71165.6 71439.6 47914.0 48369.0 48604.8 48769.5 48771.0 15754.8 15822.2 16196.8 16350.9 16355.0 12894.3 13017.9 13018.4 13028.3 13038.7 15499.8 15576.1 15626.1 15661.8 16035.6 6888.9 6952.3 6971.5 7013.1 7027.1 964.2 979.2 994.3 1031.6 1081.0 30012.2 30151.8 30470.7 30686.5 30801.7 1071.4 1127.5 1131.8 1136.5 1159.6 15124.5 15284.0 15310.8 15539.1 15582.7 531051.0 745233.0 768455.0 771450.7 771472.0 62164.8 62496.0 62578.7 62913.7 63363.4 1469.4 1470.6 1475.8 1485.9 1501.6 30192.5 30647.8 31702.0 31833.7 32072.8 51787.2 52039.0 52449.7 52533.7 52581.7 496673.0 499914.0 500087.0 501032.0 502601.0 32955.5 34109.0 34308.3 34727.3 34739.7 45228.1 45498.8 45576.6 46065.5 47010.8 37606.8 37691.4 38187.8 38554.0 38911.8 35412.5 35739.5 36113.5 36376.8 36543.1 35159.5 35509.0 36019.5 36238.8 36393.5 30307.4 31092.7 31448.2 32294.8 32484.0 20910.8 24451.9 24492.1 25060.2 25648.9 18:02:59 INFO - PROCESS | 1658 | 18:02:59 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:35326.55 Median:12008.03 stddev:111138.83 (925.5%) stddev-sans-first:111419.58 18:02:59 INFO - PROCESS | 1658 | Values: 353.4 361.7 363.9 367.7 368.1 19268.6 19829.6 20394.3 20569.8 20587.3 20955.7 21224.5 21537.6 21688.5 21764.8 5737.3 5984.5 5997.2 6000.2 6010.3 5656.5 5856.2 5881.1 5940.3 5962.6 5757.9 5878.4 5883.7 5885.8 5886.6 5579.5 5839.2 5860.6 5864.8 5873.2 5051.7 5082.1 5091.5 5116.9 5117.3 24551.0 24966.1 25253.1 25572.9 26051.2 2101.0 2251.3 2261.1 2265.2 2361.6 14825.9 14898.9 15098.6 15342.5 15443.7 1508.9 1735.7 1753.6 1817.1 1838.8 106870.0 107882.5 108848.5 109350.0 110115.4 10550.4 10551.9 10747.5 10749.8 10853.7 11285.5 12984.5 12996.9 13001.3 13024.1 6154.8 6997.9 7156.8 8342.8 8356.0 7283.0 8743.0 8976.8 8985.7 9100.0 5829.2 5894.0 6238.1 6322.3 6329.7 1842.5 1867.2 1867.8 1873.6 1900.6 820.7 872.3 915.2 982.5 992.5 14056.6 17243.9 21379.0 21465.4 21640.9 971.5 1005.2 1024.4 1038.6 1038.9 10216.8 11632.0 11643.2 11664.7 11718.9 662862.0 668696.0 674134.0 684997.0 688778.0 64509.4 66586.7 67041.0 101474.0 111261.0 1065.9 1069.4 1100.9 1120.7 1134.5 18600.9 18769.3 18802.7 18821.9 18909.7 47546.0 48705.8 48882.5 49509.5 49664.8 68370.0 69052.1 69687.0 70981.6 71205.3 7326.2 7342.0 7350.0 7412.9 7538.9 12365.4 12407.7 12713.9 12943.7 12988.6 10875.9 11087.0 11137.2 11152.0 11208.0 9163.8 10900.7 11031.2 11182.7 11214.7 11077.4 11308.5 11319.1 11456.5 11637.1 7229.6 7313.2 7369.6 7422.6 7537.5 10607.9 11093.7 11260.0 11444.6 11493.3 18:02:59 INFO - PROCESS | 1658 | 18:02:59 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5999.45 Median:5467.35 stddev:3170.63 (58.0%) stddev-sans-first:3162.04 18:02:59 INFO - PROCESS | 1658 | Values: 1568.9 1592.5 1859.9 1943.5 1947.0 7373.9 7932.4 8649.8 8792.8 8806.6 7230.4 8484.8 8522.7 8642.7 8652.8 2094.4 2474.9 2477.9 2486.9 2490.3 2388.0 2433.3 2435.8 2440.2 2477.6 2071.0 2352.1 2409.2 2474.4 2481.6 2152.4 2380.1 2388.5 2390.5 2425.6 1881.7 2464.4 2490.2 2499.4 2593.0 8739.7 8749.1 8761.4 8770.7 8777.4 5397.7 5512.9 5538.9 5552.8 5560.8 3575.3 3657.9 3689.3 3703.0 3737.8 1038.9 1052.3 1058.1 1068.0 1072.5 11629.9 11680.5 11712.0 11742.0 11743.9 4854.7 4885.4 4938.7 4995.9 4998.4 8568.4 9964.6 10016.2 10017.9 10043.7 5383.5 5438.9 5462.0 5472.7 5478.6 4476.5 4842.0 4908.2 4956.7 4963.0 3750.9 3858.8 3860.8 3865.2 3882.1 1201.8 1322.8 1337.1 1339.9 1345.5 1209.1 1209.5 1283.9 1370.4 1386.2 7882.0 7920.0 8271.3 8303.2 8318.3 500.4 504.0 505.2 505.3 520.8 6180.3 6208.2 6225.8 6289.7 6296.9 10451.0 10752.7 10766.4 10775.8 10842.2 9938.7 10562.3 10583.2 10670.3 10694.6 8344.5 8374.4 8401.1 8408.9 8430.5 7936.0 8077.2 8115.7 8121.1 8162.9 9339.7 9533.6 9585.0 9589.4 9791.4 9741.7 9756.2 9776.7 9915.8 9958.2 6016.2 6818.8 7496.3 7566.4 7637.4 7004.6 7019.9 8170.0 8201.5 8207.2 7227.4 7383.2 7408.0 7483.9 7560.2 7228.5 7261.5 7287.7 7325.9 7354.0 7735.0 7772.8 7839.6 7865.4 7877.8 6979.5 7005.8 7005.8 7072.0 7076.3 7170.6 7229.9 7236.4 7239.7 7240.9 18:02:59 INFO - PROCESS | 1658 | 18:02:59 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:5936.36 Median:6774.47 stddev:1917.17 (28.3%) stddev-sans-first:1875.78 18:02:59 INFO - PROCESS | 1658 | Values: 328.7 330.3 331.6 336.8 339.1 6816.0 6823.9 6828.3 6851.8 6891.7 6790.5 6817.1 6853.4 6857.3 6857.7 4742.5 4853.9 5008.5 5019.2 5048.4 4041.7 4102.0 4967.3 4992.8 5019.4 4899.0 4939.6 4947.0 4963.1 4978.3 4948.1 4955.8 4956.5 4961.4 4961.6 4281.4 4286.6 4292.6 4296.3 4303.0 6355.2 6549.5 6598.5 6622.4 6623.9 5872.8 5914.6 5936.1 5943.3 5944.6 7213.0 7221.7 7222.1 7230.6 7230.8 4767.0 4780.5 4796.4 4800.7 4804.7 6185.7 7707.9 7736.1 7740.7 7742.8 4317.5 4722.8 4793.5 4798.1 4807.7 4889.4 4891.6 4892.4 4902.8 4904.6 5732.5 5778.0 5785.2 5790.8 5803.3 7247.0 7316.6 7323.8 7332.0 7344.2 1616.3 1662.4 1687.6 1694.6 1705.6 1060.6 1063.7 1099.0 1109.7 1119.8 6134.3 6770.8 6774.8 6794.7 6828.6 7517.2 7518.9 7535.2 7539.7 7557.6 6695.1 6758.4 6774.2 6783.5 6799.0 3617.2 3946.8 4002.6 4004.5 4015.5 6809.5 6969.3 7592.6 7747.8 7992.4 7867.6 7874.3 7905.4 7913.8 7923.0 7988.6 7995.7 7996.8 8020.4 8026.8 7223.7 7543.1 7556.8 7647.6 7664.7 7404.9 7429.9 7482.7 7484.3 7516.9 7952.5 7982.5 7984.4 8000.7 8003.0 4674.1 4715.8 4724.5 4744.6 4745.1 7248.6 7561.2 7607.2 7609.5 7617.5 7305.5 7341.7 7346.3 7360.4 7366.2 5982.4 7308.6 7326.0 7346.4 7356.0 7127.4 7143.0 7170.4 7172.9 7205.1 5789.7 6616.9 7045.8 7379.2 7381.4 5949.5 6352.4 7092.4 7197.9 7207.7 18:02:59 INFO - PROCESS | 1658 | 18:02:59 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:18122.09 Median:595.94 stddev:25538.55 (4285.4%) stddev-sans-first:25576.62 18:02:59 INFO - PROCESS | 1658 | Values: 684.0 706.8 761.6 775.5 782.2 14905.4 15021.4 15164.5 15233.7 17562.5 16582.8 16690.4 16709.0 16716.9 16839.0 757.1 926.1 944.5 955.3 956.8 931.5 949.9 950.2 950.6 952.8 969.4 991.5 1003.7 1011.4 1011.7 980.7 981.9 985.8 1003.6 1006.8 707.7 730.7 738.8 740.2 746.8 15373.9 15416.5 15458.5 15465.1 15493.9 12408.8 12458.1 12485.4 12676.6 12708.7 9889.8 10041.7 10096.8 10177.9 10446.3 3387.4 3412.2 3471.1 3480.0 3506.1 76436.2 77319.2 78949.6 79172.6 79597.6 9111.7 9129.8 9161.9 9202.9 9274.0 17124.6 21008.7 21039.4 21041.5 21052.7 6959.9 6965.1 7646.8 7651.8 7743.8 4060.2 4080.7 4123.8 4138.3 4162.5 3497.1 3504.9 3522.3 3541.5 3545.9 468.7 566.3 580.9 582.3 588.6 581.0 591.8 600.1 612.5 613.7 7978.1 8120.4 8153.2 8210.9 8228.8 487.4 576.4 609.0 611.3 612.0 3763.7 3877.3 3916.8 3989.7 4011.0 90633.1 93585.5 95770.0 95886.5 96084.0 69866.0 70045.0 70087.0 70160.3 70702.6 71264.0 71299.6 72737.6 73106.0 74389.3 7893.4 7941.1 7974.6 8017.6 8022.1 48109.5 48908.8 49747.8 49963.8 51511.0 65781.0 70797.6 71148.0 71692.6 72876.0 9858.6 9958.8 10132.8 10204.3 10666.0 10982.1 11035.7 11055.2 11112.1 11542.9 10454.3 10731.7 10839.5 10851.8 11093.7 10090.1 10198.4 10204.6 10908.2 10944.9 10301.7 10380.7 10666.1 10676.7 10726.8 8816.8 8818.2 8945.6 9006.9 9098.6 8459.7 9530.0 9648.3 9684.1 9773.7 18:02:59 INFO - PROCESS | 1658 | -------- Summary: end -------- 18:02:59 INFO - PROCESS | 1658 | 18:02:59 INFO - TEST-INFO | 1658: exit 0 18:02:59 INFO - TEST-OK | dromaeo_css | took 1110905ms 18:02:59 INFO - TEST-START | kraken 18:02:59 INFO - operating with platform_type : mac_ 18:02:59 INFO - Initialising browser for kraken test... 18:02:59 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmpPolXyZ/profile http://localhost:49270/getInfo.html) 18:03:02 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 18:03:02 INFO - PROCESS | 1670 | colorDepth:24 18:03:02 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 18:03:02 INFO - PROCESS | 1670 | __metrics 18:03:02 ERROR - PROCESS | 1670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 18:03:03 INFO - TEST-INFO | 1670: exit 0 18:03:03 INFO - Browser initialized. 18:03:03 INFO - Running cycle 1/1 for kraken test... 18:03:03 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmpPolXyZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:03:15 INFO - PROCESS | 1673 | RSS: Main: 255541248 18:03:15 INFO - PROCESS | 1673 | 18:03:18 INFO - PROCESS | 1673 | 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) 18:03:18 INFO - PROCESS | 1673 | RSS: Main: 268115968 18:03:18 INFO - PROCESS | 1673 | 18:03:21 INFO - PROCESS | 1673 | 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) 18:03:22 INFO - PROCESS | 1673 | RSS: Main: 276492288 18:03:22 INFO - PROCESS | 1673 | 18:03:27 INFO - PROCESS | 1673 | 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) 18:03:28 INFO - PROCESS | 1673 | RSS: Main: 281604096 18:03:28 INFO - PROCESS | 1673 | 18:03:30 INFO - PROCESS | 1673 | 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) 18:03:30 INFO - PROCESS | 1673 | RSS: Main: 283447296 18:03:30 INFO - PROCESS | 1673 | 18:03:32 INFO - PROCESS | 1673 | 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) 18:03:33 INFO - PROCESS | 1673 | RSS: Main: 283873280 18:03:33 INFO - PROCESS | 1673 | 18:03:36 INFO - PROCESS | 1673 | 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) 18:03:36 INFO - PROCESS | 1673 | RSS: Main: 282923008 18:03:36 INFO - PROCESS | 1673 | 18:03:40 INFO - PROCESS | 1673 | 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) 18:03:41 INFO - PROCESS | 1673 | RSS: Main: 283332608 18:03:41 INFO - PROCESS | 1673 | 18:03:44 INFO - PROCESS | 1673 | 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) 18:03:44 INFO - PROCESS | 1673 | RSS: Main: 282378240 18:03:44 INFO - PROCESS | 1673 | 18:03:46 INFO - PROCESS | 1673 | 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) 18:03:47 INFO - PROCESS | 1673 | RSS: Main: 282034176 18:03:47 INFO - PROCESS | 1673 | 18:03:49 INFO - PROCESS | 1673 | 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) 18:03:49 INFO - PROCESS | 1673 | RSS: Main: 281960448 18:03:49 INFO - PROCESS | 1673 | 18:03:51 INFO - PROCESS | 1673 | 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) 18:03:52 INFO - PROCESS | 1673 | RSS: Main: 282288128 18:03:52 INFO - PROCESS | 1673 | 18:03:55 INFO - PROCESS | 1673 | 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) 18:03:55 INFO - PROCESS | 1673 | RSS: Main: 283652096 18:03:55 INFO - PROCESS | 1673 | 18:03:58 INFO - PROCESS | 1673 | 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) 18:03:58 INFO - PROCESS | 1673 | RSS: Main: 284598272 18:03:58 INFO - PROCESS | 1673 | 18:04:00 INFO - PROCESS | 1673 | 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) 18:04:00 INFO - PROCESS | 1673 | RSS: Main: 285540352 18:04:00 INFO - PROCESS | 1673 | 18:04:00 INFO - PROCESS | 1673 | __start_tp_report 18:04:00 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 18:04:00 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 18:04:00 INFO - PROCESS | 1673 | |i|pagename|runs| 18:04:00 INFO - PROCESS | 1673 | |0;ai-astar;133;114;116;115;116;118;122;115;118;116 18:04:00 INFO - PROCESS | 1673 | |1;audio-beat-detection;155;122;145;156;121;151;166;144;159;121 18:04:00 INFO - PROCESS | 1673 | |2;audio-dft;392;410;408;400;397;403;401;393;395;396 18:04:00 INFO - PROCESS | 1673 | |3;audio-fft;75;70;71;131;81;76;56;61;134;83 18:04:00 INFO - PROCESS | 1673 | |4;audio-oscillator;85;92;116;60;87;123;117;75;113;153 18:04:00 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;90;88;89;88;91;86;90;88;97;89 18:04:00 INFO - PROCESS | 1673 | |6;imaging-darkroom;210;159;170;226;175;162;169;233;257;203 18:04:00 INFO - PROCESS | 1673 | |7;imaging-desaturate;94;100;97;96;100;97;95;95;97;129 18:04:00 INFO - PROCESS | 1673 | |8;json-parse-financial;57;59;55;57;58;59;58;57;58;56 18:04:00 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;62;64;70;90;104;101;93;93;72;64 18:04:00 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;84;84;86;72;99;110;111;82;95;88 18:04:00 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;123;138;136;134;122;124;129;134;137;117 18:04:00 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;147;177;139;183;183;160;142;137;124;177 18:04:00 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;68;68;67;69;67;67;78;98;99;97 18:04:00 INFO - PROCESS | 1673 | __end_tp_report 18:04:00 INFO - PROCESS | 1673 | __start_cc_report 18:04:00 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,940 18:04:00 INFO - PROCESS | 1673 | __end_cc_report 18:04:00 INFO - PROCESS | 1673 | __startTimestamp1458003840959__endTimestamp 18:04:00 INFO - PROCESS | 1673 | 18:04:00 INFO - PROCESS | 1673 | ------- Summary: start ------- 18:04:00 INFO - PROCESS | 1673 | Number of tests: 14 18:04:00 INFO - PROCESS | 1673 | 18:04:00 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:118.30 Median:117.00 stddev:5.64 (4.8%) stddev-sans-first:2.40 18:04:00 INFO - PROCESS | 1673 | Values: 133.0 114.0 116.0 115.0 116.0 118.0 122.0 115.0 118.0 116.0 18:04:00 INFO - PROCESS | 1673 | 18:04:00 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:153.00 stddev:16.89 (11.0%) stddev-sans-first:17.43 18:04:00 INFO - PROCESS | 1673 | Values: 155.0 122.0 145.0 156.0 121.0 151.0 166.0 144.0 159.0 121.0 18:04:00 INFO - PROCESS | 1673 | 18:04:00 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:399.50 Median:400.50 stddev:6.10 (1.5%) stddev-sans-first:5.83 18:04:00 INFO - PROCESS | 1673 | Values: 392.0 410.0 408.0 400.0 397.0 403.0 401.0 393.0 395.0 396.0 18:04:00 INFO - PROCESS | 1673 | 18:04:00 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:83.80 Median:73.00 stddev:26.96 (36.9%) stddev-sans-first:28.41 18:04:00 INFO - PROCESS | 1673 | Values: 75.0 70.0 71.0 131.0 81.0 76.0 56.0 61.0 134.0 83.0 18:04:00 INFO - PROCESS | 1673 | 18:04:00 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:102.10 Median:67.50 stddev:27.27 (40.4%) stddev-sans-first:28.21 18:04:00 INFO - PROCESS | 1673 | Values: 85.0 92.0 116.0 60.0 87.0 123.0 117.0 75.0 113.0 153.0 18:04:00 INFO - PROCESS | 1673 | 18:04:00 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:89.60 Median:89.50 stddev:2.95 (3.3%) stddev-sans-first:3.13 18:04:00 INFO - PROCESS | 1673 | Values: 90.0 88.0 89.0 88.0 91.0 86.0 90.0 88.0 97.0 89.0 18:04:00 INFO - PROCESS | 1673 | 18:04:00 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:196.40 Median:206.50 stddev:34.33 (16.6%) stddev-sans-first:36.05 18:04:00 INFO - PROCESS | 1673 | Values: 210.0 159.0 170.0 226.0 175.0 162.0 169.0 233.0 257.0 203.0 18:04:00 INFO - PROCESS | 1673 | 18:04:00 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:100.00 Median:95.50 stddev:10.38 (10.9%) stddev-sans-first:10.78 18:04:00 INFO - PROCESS | 1673 | Values: 94.0 100.0 97.0 96.0 100.0 97.0 95.0 95.0 97.0 129.0 18:04:00 INFO - PROCESS | 1673 | 18:04:00 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:58.00 stddev:1.26 (2.2%) stddev-sans-first:1.33 18:04:00 INFO - PROCESS | 1673 | Values: 57.0 59.0 55.0 57.0 58.0 59.0 58.0 57.0 58.0 56.0 18:04:00 INFO - PROCESS | 1673 | 18:04:00 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:81.30 Median:71.00 stddev:16.46 (23.2%) stddev-sans-first:15.91 18:04:00 INFO - PROCESS | 1673 | Values: 62.0 64.0 70.0 90.0 104.0 101.0 93.0 93.0 72.0 64.0 18:04:00 INFO - PROCESS | 1673 | 18:04:00 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:91.10 Median:85.00 stddev:12.54 (14.8%) stddev-sans-first:13.03 18:04:00 INFO - PROCESS | 1673 | Values: 84.0 84.0 86.0 72.0 99.0 110.0 111.0 82.0 95.0 88.0 18:04:00 INFO - PROCESS | 1673 | 18:04:00 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:134.00 stddev:7.43 (5.5%) stddev-sans-first:7.51 18:04:00 INFO - PROCESS | 1673 | Values: 123.0 138.0 136.0 134.0 122.0 124.0 129.0 134.0 137.0 117.0 18:04:00 INFO - PROCESS | 1673 | 18:04:00 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.90 Median:168.50 stddev:21.86 (13.0%) stddev-sans-first:22.89 18:04:00 INFO - PROCESS | 1673 | Values: 147.0 177.0 139.0 183.0 183.0 160.0 142.0 137.0 124.0 177.0 18:04:00 INFO - PROCESS | 1673 | 18:04:00 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.80 Median:73.50 stddev:14.32 (19.5%) stddev-sans-first:14.74 18:04:00 INFO - PROCESS | 1673 | Values: 68.0 68.0 67.0 69.0 67.0 67.0 78.0 98.0 99.0 97.0 18:04:00 INFO - PROCESS | 1673 | -------- Summary: end -------- 18:04:00 INFO - PROCESS | 1673 | 18:04:01 INFO - TEST-INFO | 1673: exit 0 18:04:01 INFO - TEST-OK | kraken | took 61837ms 18:04:01 INFO - SUITE-END | took 1172s 18:04:02 INFO - Completed test suite (00:19:33) 18:04:02 INFO - javascript benchmark 18:04:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3375.139339468435, 3422.709069729073, 3453.723702103832, 3462.688358047775, 3470.3926812807754, 5467.835964921049, 5520.22716819645, 5533.280673512448, 5551.500364967163, 5562.110062390018, 5433.1578605316145, 5497.147942068986, 5528.281323427958, 5601.327840659126, 5676.943230567693, 5018.096742586333, 5059.367579052619, 5060.79756809729, 5100.387953445592, 5220.712860792655, 4921.729304888229, 4927.630427717918, 4941.085899108676, 4970.676906001117, 4986.800527978877, 3862.903427414309, 4879.438864530589, 4979.352684151074, 4979.477154898737, 5051.974740126313, 4936.308916751657, 4940.258961155855, 4970.975145124287, 4974.204127339644, 4985.35190425246, 4095.9385609215888, 4903.901921961577, 4982.825601103944, 4991.975040124812, 4992.051510213048, 5343.198520221959, 5398.514133727944, 5424.593155513313, 5451.918221226685, 5457.154141108134, 6043.516518678495, 6106.694665266719, 6111.908321375183, 6117.5717699761035, 6148.292946311142, 5048.671836330664, 5633.633813802131, 6074.817755467343, 6158.230221222348, 6174.938250617482, 4743.810247590127, 5643.209950606918, 5666.036773748473, 5669.461401166883, 5730.971345143289, 5117.692938423706, 6153.969230153821, 6206.844828879224, 6213.875722485525, 6231.345708700521, 5769.826905192851, 5967.403259674084, 5980.760769569169, 5986.5210783137245, 6020.976434006142, 5930.644161350333, 6019.608725432833, 6111.075205202202, 6133.701927635063, 6136.985753961143, 5921.437463440966, 5988.28140623128, 5990.880182396328, 5996.2504686914135, 6018.548608854266, 5968.46283834457, 5992.67040312787, 6061.151438798572, 6080.635161890301, 6098.298695650057, 3917.353636649978, 4759.405074365704, 4769.213079841857, 4769.379980602499, 4855.757212139379, 4261.2542805009, 4292.527821939584, 4299.763513006815, 4318.157959197926, 4333.58830911063, 5388.865278368072, 5559.999200144013, 5561.416051314634, 5564.777408903679, 5606.943930560724, 6128.356123365552, 6134.405972711579, 6144.846378840565, 6173.81478555644, 6197.845053873689, 5551.333839939233, 5576.163575463713, 5622.044252477089, 5627.746751396197, 5645.23789288449, 5119.820806271762, 5205.765740541685, 5224.033553792485, 5269.367675878919, 5300.257963885059, 6216.595921265194, 6226.782062627786, 6228.0, 6228.065790131426, 6264.718087686065, 6113.388661134029, 6135.294441139147, 6146.815595532141, 6153.569250152446, 6170.197874276315, 6106.976420671998, 6153.107799369156, 6180.258368995749, 6229.2524897012645, 6229.626222426669, 5545.112781954868, 5971.373005834324, 6024.33732289439, 6042.541795404627, 6070.939290607037, 5983.0, 6095.329513753572, 6122.173506576555, 6150.876982460236, 6153.723082461211, 5743.712814359182, 5747.798827041201, 5775.364709881994, 5814.0, 5984.850378740392, 5917.082852157922, 5919.052951527735, 5943.970280148572, 5959.940400595939, 5964.075568286922, 5637.49262566371, 5718.199452076796, 5731.254936858349, 5762.279715035621, 5762.567807414544, 5795.072788353843, 5826.242588463472, 5876.1773351729935, 5877.676727780014, 5925.229720136354, 5747.568932330176, 5780.364159942319, 5782.710864456844, 5785.103308987113, 5789.044807606698], "unit": "score", "name": "dojo.html", "value": 5506.094769450434}, {"lowerIsBetter": false, "replicates": [569.988270819296, 586.8767558812649, 601.6330038676409, 633.3128555517263, 641.3682522715125, 37350.43974340384, 38167.0, 38210.426843597335, 38214.42678359823, 38215.0, 31454.685453145463, 32908.50637240443, 33210.16974575637, 35035.0, 41943.58056419435, 7927.40544459165, 9507.429554226734, 9580.61677532898, 9609.423434593911, 9619.759506012371, 9440.57517411718, 9589.32874698768, 9591.136797688207, 9591.712248632552, 9627.277954153431, 8408.00619705638, 9545.99767024463, 9584.233261339075, 9630.0, 9648.565814538328, 9531.332806703498, 9631.08504692053, 9644.32489725723, 9654.324197306192, 9666.75833104171, 9327.0, 9401.858972115424, 9409.717708468757, 9440.669576564787, 9522.0, 32234.677653223403, 38531.807340963394, 38857.61142388568, 38944.805275973726, 39171.02072448183, 3046.31457921968, 3165.2878102427, 3207.7754557181006, 3261.5107733839877, 3391.067456449496, 29504.114876553736, 30108.096757097323, 30462.54306185409, 30498.69501305003, 30959.38081238385, 2325.302409277227, 2351.259353303704, 2482.416632091457, 2741.8903243870423, 2787.372841110754, 408656.0, 411299.8305025427, 413540.0, 417536.82463175285, 418119.0, 48441.75779121152, 48448.757756210995, 70551.2944870555, 71165.64417177881, 71439.57120857554, 47914.04171916542, 48369.0, 48604.7569762156, 48769.51230487721, 48771.0, 15754.842451575338, 15822.208889555477, 16196.838031619769, 16350.937189082671, 16355.0, 12894.290814005131, 13017.869821301856, 13018.414171362312, 13028.28344441046, 13038.739225215442, 15499.845001550066, 15576.143312117716, 15626.062436253862, 15661.765073523906, 16035.599110022344, 6888.931110688929, 6952.270011648805, 6971.5468494547695, 7013.088298521159, 7027.121609798775, 964.1756298364937, 979.2313034268208, 994.2940512236248, 1031.5873650539845, 1081.0486771641063, 30012.24969375783, 30151.849240754094, 30470.69529304723, 30686.53970190449, 30801.69198308033, 1071.3715152967602, 1127.464454384161, 1131.7623299107279, 1136.4658610453073, 1159.591096817371, 15124.54626361211, 15284.006539574892, 15310.846891530942, 15539.06765594068, 15582.688346233012, 531051.0, 745233.0, 768455.0, 771450.7129572243, 771472.0, 62164.75670486565, 62496.0, 62578.687106565085, 62913.68543157255, 63363.366366335744, 1469.3681716861638, 1470.6029372069695, 1475.7712554554062, 1485.9405623774928, 1501.5945694662598, 30192.54711179378, 30647.846760766053, 31702.0, 31833.681663183997, 32072.839635801673, 51787.223191652905, 52039.0, 52449.737751311, 52533.737331313096, 52581.737091314295, 496673.0, 499914.0, 500087.0, 501032.0, 502601.0, 32955.505667415484, 34108.976730698116, 34308.31383372368, 34727.305453891284, 34739.652603473645, 45228.09543809039, 45498.772506137255, 45576.63270101902, 46065.53934460613, 47010.76494617505, 37606.811965939996, 37691.43462848114, 38187.80906095452, 38554.0, 38911.80544097262, 35412.46881296834, 35739.46390804088, 36113.458298126076, 36376.81811591031, 36543.08642283964, 35159.47260791141, 35509.0, 36019.459708103874, 36238.8188059058, 36393.454098189075, 30307.393852123274, 31092.68907310898, 31448.213794655316, 32294.83852580722, 32484.0, 20910.790892091492, 24451.877740611184, 24492.14277500279, 25060.248192554252, 25648.871755641103], "unit": "score", "name": "ext.html", "value": 19494.56522535531}, {"lowerIsBetter": false, "replicates": [353.41509801278875, 361.6564263949249, 363.919937613725, 367.6782815036843, 368.123865200822, 19268.614627707455, 19829.603407931852, 20394.286199982966, 20569.794302056976, 20587.27944521942, 20955.68566471504, 21224.4693882653, 21537.56924861506, 21688.457788555294, 21764.782352176473, 5737.311522617271, 5984.491318237955, 5997.22036135304, 6000.2199714037115, 6010.308814486324, 5656.519195868356, 5856.150858125569, 5881.117832325164, 5940.316863560681, 5962.582619216657, 5757.856053598673, 5878.382769809173, 5883.705814709268, 5885.823425297248, 5886.587938844283, 5579.525740312079, 5839.153322768218, 5860.589758716891, 5864.824055278348, 5873.236479257712, 5051.722155281458, 5082.08522465956, 5091.516305950929, 5116.923246151311, 5117.283580298761, 24551.017959281606, 24966.127540434358, 25253.11614093498, 25572.872135639387, 26051.218463446126, 2100.970524443012, 2251.279590531031, 2261.061659411342, 2265.184533567914, 2361.645753137026, 14825.851741482662, 14898.851011489854, 15098.641122299046, 15342.539723808304, 15443.691126177413, 1508.8868334874928, 1735.6962531556926, 1753.5791410061493, 1817.1368599914936, 1838.7793464784177, 106870.0, 107882.46058769735, 108848.4557577215, 109350.0, 110115.44942275317, 10550.366977981346, 10551.94480551954, 10747.462626868626, 10749.785004300027, 10853.728656783485, 11285.548578056785, 12984.480620775252, 12996.870031299755, 13001.349932503337, 13024.08831381813, 6154.846128846814, 6997.895031574531, 7156.82107947295, 8342.791430214293, 8355.95822020886, 7283.0, 8742.994555626185, 8976.820463590691, 8985.730428087169, 9099.999000109983, 5829.183914252008, 5894.0, 6238.095476155932, 6322.272938612026, 6329.715162817684, 1842.4656849513758, 1867.1971052447577, 1867.7758668959812, 1873.5597134673342, 1900.562870539756, 820.7414664380701, 872.2760109109424, 915.199200699388, 982.513655740413, 992.4541502173776, 14056.648583785487, 17243.913780431016, 21379.037943292587, 21465.356039318845, 21640.891795540923, 971.4754032822196, 1005.215931573374, 1024.3956065921143, 1038.553422028535, 1038.85456036155, 10216.795664086676, 11632.0, 11643.184977051525, 11664.708382290512, 11718.88281117178, 662862.0, 668696.0, 674134.0, 684997.0, 688778.0, 64509.35490645033, 66586.66706666436, 67041.0, 101474.0, 111261.0, 1065.9093977011885, 1069.385103565453, 1100.862392200975, 1120.6581992492206, 1134.466800603715, 18600.883946963226, 18769.343072992928, 18802.717959230347, 18821.90589047046, 18909.716354254422, 47546.0, 48705.75647121741, 48882.511174889216, 49509.50490495049, 49664.75167624139, 68370.0, 69052.10107469185, 69687.0, 70981.58036839338, 71205.28794712193, 7326.1610077216865, 7342.0, 7350.0, 7412.925870741224, 7538.886916696364, 12365.381730913597, 12407.689807754878, 12713.87286127127, 12943.676408089874, 12988.610341689764, 10875.891241087487, 11087.002169804757, 11137.164712646421, 11151.996320331209, 11208.0, 9163.816723665623, 10900.672979810619, 11031.22781405294, 11182.72043198894, 11214.719632008939, 11077.446127693744, 11308.547658093585, 11319.09447244202, 11456.484458199235, 11637.069034477052, 7229.602371869387, 7313.158986716596, 7369.594672292861, 7422.628868556659, 7537.472376933562, 10607.893921060691, 11093.722656933642, 11259.98660120593, 11444.599439019594, 11493.310401375944], "unit": "score", "name": "jquery.html", "value": 9439.776737972046}, {"lowerIsBetter": false, "replicates": [1568.8980216285943, 1592.466523714556, 1859.851211903048, 1943.4946913802407, 1946.9513262168434, 7373.852522949551, 7932.365410767139, 8649.78375540611, 8792.824143517133, 8806.603702833372, 7230.385417239541, 8484.830303393928, 8522.701705440311, 8642.654293828255, 8652.783680407993, 2094.4240333908147, 2474.9133780317693, 2477.925662230136, 2486.9378265543323, 2490.252924122765, 2388.044782087162, 2433.3065076453213, 2435.8173137014705, 2440.2191298784396, 2477.6283557466345, 2070.9585808283823, 2352.070931981866, 2409.204962362425, 2474.418511649761, 2481.6153496208117, 2152.35429371188, 2380.0955636858057, 2388.5103553771523, 2390.521895620883, 2425.63615457681, 1881.708335208045, 2464.4331803685254, 2490.1906880263805, 2499.3751562109474, 2592.988734393588, 8739.650413983432, 8749.081346458594, 8761.430507017023, 8770.736877893609, 8777.429467084683, 5397.676139431607, 5512.91730624041, 5538.889222215533, 5552.750126244328, 5560.77756889724, 3575.302815950891, 3657.8536858525626, 3689.262147570497, 3702.962970370316, 3737.775733455974, 1038.942858142802, 1052.3159946035062, 1058.142904247562, 1067.9519421626046, 1072.5441687282873, 11629.94185029078, 11680.474378653065, 11712.0, 11742.0, 11743.882561174365, 4854.68444551103, 4885.41375034991, 4938.678985865908, 4995.875103122378, 4998.350214472168, 8568.400211985101, 9964.551595178234, 10016.1987041038, 10017.899821001842, 10043.69868903934, 5383.5423988961375, 5438.8912221755345, 5462.0, 5472.699001554873, 5478.643888147258, 4476.462824461086, 4842.0, 4908.239222920453, 4956.653034287565, 4963.0, 3750.868719594801, 3858.82635281413, 3860.7876566789096, 3865.207632435344, 3882.1071153634257, 1201.7656556971306, 1322.7751282282036, 1337.0774165825549, 1339.8660133986523, 1345.4752646467884, 1209.1113031921532, 1209.4617895036624, 1283.9343345023608, 1370.4312710225345, 1386.182152529992, 7881.960590197127, 7920.049594048636, 8271.33829293667, 8303.169683031769, 8318.251357377743, 500.3820281951787, 504.04231959276933, 505.16647531572465, 505.2824988516242, 520.8359366799446, 6180.3201647818705, 6208.192934918522, 6225.782097626561, 6289.7484100636375, 6296.905546416808, 10451.0, 10752.677419677422, 10766.407847568458, 10775.78448431027, 10842.241043126905, 9938.701838944698, 10562.260641755158, 10583.206259530565, 10670.30643008202, 10694.62568810088, 8344.541050242295, 8374.371922105745, 8401.11788262248, 8408.915910840935, 8430.536320502308, 7935.960320198362, 8077.192280771876, 8115.715949941724, 8121.1472795358, 8162.918370816215, 9339.719808405758, 9533.618655253713, 9585.0, 9589.42463452195, 9791.412515249107, 9741.707748767549, 9756.17072548813, 9776.706698799047, 9915.752106197402, 9958.203343732339, 6016.217891674054, 6818.829529261808, 7496.25037496246, 7566.432517561315, 7637.427192960661, 7004.579725216503, 7019.894701579583, 8169.959150204211, 8201.466904651179, 8207.179282071746, 7227.385672217921, 7383.224761400191, 7407.9999200107295, 7483.88774168377, 7560.206178351414, 7228.530145540523, 7261.5280006799385, 7287.744928927462, 7325.890111648223, 7354.0, 7735.0, 7772.7668169954995, 7839.647215875185, 7865.370770338473, 7877.84244315099, 6979.476539259677, 7005.754798582026, 7005.754798582229, 7072.0, 7076.32774886385, 7170.569765814068, 7229.927700722926, 7236.421086312977, 7239.710411583477, 7240.891386629311], "unit": "score", "name": "mootools.html", "value": 4814.784083524424}, {"lowerIsBetter": false, "replicates": [328.68446291560105, 330.31459721078755, 331.585518102372, 336.784457946914, 339.0608015796245, 6815.965920170398, 6823.942288945209, 6828.317168283169, 6851.760188393408, 6891.724331026766, 6790.456763458924, 6817.147856517935, 6853.4174595159475, 6857.348551887575, 6857.691403886824, 4742.502037286087, 4853.878653033667, 5008.549230569248, 5019.196928491442, 5048.444671086187, 4041.6766658667234, 4101.995011222255, 4967.279744437054, 4992.800287988494, 5019.422766381858, 4898.975505122487, 4939.604831613462, 4947.01059788042, 4963.106640804654, 4978.303037574742, 4948.084604348207, 4955.82654607087, 4956.4547899731, 4961.429435614915, 4961.627877909171, 4281.422008028907, 4286.635635970946, 4292.59220374064, 4296.334068219431, 4302.9569704303185, 6355.173827402455, 6549.541532092755, 6598.5051121165625, 6622.437092847065, 6623.867522649568, 5872.825434912992, 5914.645121292736, 5936.109583562457, 5943.346231914529, 5944.613600116022, 7212.963935180343, 7221.711131554732, 7222.0611320528, 7230.60231687257, 7230.819229519251, 4766.952330476685, 4780.450248221464, 4796.424429068499, 4800.711957282574, 4804.663673542854, 6185.6597887116195, 7707.884381734279, 7736.149023607399, 7740.690372385098, 7742.845143097163, 4317.460317460317, 4722.7874745635845, 4793.544613261734, 4798.064377446364, 4807.687500312539, 4889.4377146627885, 4891.608671306358, 4892.412910450697, 4902.754862256873, 4904.60763138948, 5732.455416735404, 5778.0, 5785.218995435646, 5790.768369265183, 5803.274590676166, 7247.0, 7316.6341682915645, 7323.816904577322, 7332.046833911664, 7344.192138864721, 1616.3130669465666, 1662.3599914033184, 1687.64559442516, 1694.618710790087, 1705.5821323775754, 1060.5757696921294, 1063.7181146996052, 1098.9890101099047, 1109.6615532262738, 1119.8264269038311, 6134.294556126013, 6770.763023294161, 6774.796756097325, 6794.694238759268, 6828.5902845829405, 7517.210692877278, 7518.924810751822, 7535.208803075708, 7539.698412063566, 7557.584332861636, 6695.125364897739, 6758.357955994173, 6774.153230846145, 6783.457323414115, 6799.0, 3617.1680513482047, 3946.8223929923224, 4002.639762421396, 4004.4593979812935, 4015.5382131055303, 6809.5233333666165, 6969.337912898267, 7592.620368981528, 7747.845043099219, 7992.440529162903, 7867.6066196689935, 7874.251946065115, 7905.407094467823, 7913.802154946057, 7923.0, 7988.600569971594, 7995.720149794729, 7996.840063198703, 8020.398470114765, 8026.799330016563, 7223.674934627849, 7543.1325397579985, 7556.811079723051, 7647.579383133981, 7664.73173438927, 7404.888926666212, 7429.888551671621, 7482.663280152297, 7484.251574842472, 7516.924830751623, 7952.522848629101, 7982.521048737094, 7984.361251099782, 8000.679972801023, 8003.039635243808, 4674.088552732184, 4715.764211789466, 4724.503927087744, 4744.572988431058, 4745.1221524018165, 7248.565086094851, 7561.164563288767, 7607.201243869536, 7609.505382150364, 7617.542947423172, 7305.488615796843, 7341.74303899361, 7346.302101300368, 7360.411167106726, 7366.200843679368, 5982.4316689914385, 7308.598027108347, 7325.963370183115, 7346.4122870169185, 7355.963220184079, 7127.429805615642, 7142.9999800027, 7170.426365890612, 7172.856542869218, 7205.063341765537, 5789.710514474344, 6616.875131227799, 7045.753398631024, 7379.2251813558805, 7381.44639152055, 5949.494292984971, 6352.396522330371, 7092.361687447948, 7197.928020719726, 7207.747728829466], "unit": "score", "name": "prototype.html", "value": 5293.119423470519}, {"lowerIsBetter": false, "replicates": [683.9580742583054, 706.8232941764559, 761.5963539324154, 775.4959276470296, 782.2412260107697, 14905.403783848647, 15021.399144034252, 15164.469243576463, 15233.695326093486, 17562.473125806213, 16582.75125873113, 16690.41583544576, 16709.0, 16716.916415417938, 16839.0, 757.0650246945019, 926.0646746785727, 944.5418971798672, 955.254901177083, 956.8325543029941, 931.5109567477061, 949.9382540134903, 950.1686024728363, 950.5959967014026, 952.8427809411439, 969.3747532841313, 991.5191132300828, 1003.6537394598852, 1011.378002528447, 1011.7470632341915, 980.745006298364, 981.8969008254138, 985.7979114281627, 1003.5985605757683, 1006.7835415385728, 707.6567864585672, 730.6858051038105, 738.752517906502, 740.2338579570119, 746.7796999885047, 15373.923130384277, 15416.460423885223, 15458.458953936672, 15465.072095674295, 15493.922530387275, 12408.75182496354, 12458.12793104483, 12485.438155283035, 12676.556320528738, 12708.682282942907, 9889.80220395588, 10041.748956276078, 10096.848547271797, 10177.949110254476, 10446.26876118672, 3387.356402283558, 3412.2493051528622, 3471.1322169457635, 3479.982600087009, 3506.0708912138302, 76436.23563764346, 77319.22680773177, 78949.60525197395, 79172.60413697953, 79597.60201198957, 9111.726648200565, 9129.77175570616, 9161.862572061424, 9202.861957070649, 9274.0, 17124.571885702957, 21008.684869726967, 21039.368818935458, 21041.473963150736, 21052.684209736864, 6959.930400696029, 6965.129358830146, 7646.770596882103, 7651.846963060708, 7743.845123097619, 4060.1879624075304, 4080.734752241154, 4123.773192474383, 4138.337865941435, 4162.521310049323, 3497.108237399447, 3504.9474257886154, 3522.330757156132, 3541.4864844597905, 3545.911352216215, 468.7492191677436, 566.2723400430427, 580.8809194115196, 582.260529128005, 588.6026931821003, 580.9506191973645, 591.795830438498, 600.0835937344502, 612.5252928980076, 613.6686189457732, 7978.082520510099, 8120.431569790177, 8153.22544358285, 8210.917890821134, 8228.794280143044, 487.44187904849457, 576.3688760806909, 608.9665068421191, 611.3122736920964, 611.9908201376983, 3763.6800871925643, 3877.3214687429586, 3916.8433262669173, 3989.7007724420782, 4010.9598904010586, 90633.09366906247, 93585.5320723392, 95770.0, 95886.52056739671, 96084.0, 69865.95201071988, 70045.0, 70087.0, 70160.29839701537, 70702.64648676723, 71264.0, 71299.6435017832, 72737.6363118181, 73106.0, 74389.25610743824, 7893.447458677838, 7941.12647608751, 7974.601269936364, 8017.639206235617, 8022.077461091816, 48109.5189048105, 48908.75545622249, 49747.751261243466, 49963.75018124886, 51511.0, 65781.03985320768, 70797.64601176961, 71148.0, 71692.56614867569, 72876.0, 9858.605655773688, 9958.800823983625, 10132.848007280045, 10204.336718113298, 10665.986731260518, 10982.0665243452, 11035.724106897393, 11055.22613417053, 11112.055475284691, 11542.884571154182, 10454.268201225841, 10731.678049658523, 10839.458027098455, 10851.782964340511, 11093.667189984313, 10090.09189172978, 10198.43908585035, 10204.642837500653, 10908.236423450282, 10944.890551094388, 10301.74245643865, 10380.688579342632, 10666.146708263164, 10676.679699609023, 10726.839097413702, 8816.823663526822, 8818.206361427503, 8945.552722363725, 9006.874140732409, 9098.590563424794, 8459.703910363107, 9530.037187710695, 9648.324617276723, 9684.08001239881, 9773.657921972697], "unit": "score", "name": "yui.html", "value": 6848.3376559601575}], "name": "dromaeo_css", "value": 7492.117984646363}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [133.0, 114.0, 116.0, 115.0, 116.0, 118.0, 122.0, 115.0, 118.0, 116.0], "unit": "score", "name": "ai-astar", "value": 118.3}, {"lowerIsBetter": true, "replicates": [155.0, 122.0, 145.0, 156.0, 121.0, 151.0, 166.0, 144.0, 159.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 144.0}, {"lowerIsBetter": true, "replicates": [392.0, 410.0, 408.0, 400.0, 397.0, 403.0, 401.0, 393.0, 395.0, 396.0], "unit": "score", "name": "audio-dft", "value": 399.5}, {"lowerIsBetter": true, "replicates": [75.0, 70.0, 71.0, 131.0, 81.0, 76.0, 56.0, 61.0, 134.0, 83.0], "unit": "score", "name": "audio-fft", "value": 83.8}, {"lowerIsBetter": true, "replicates": [85.0, 92.0, 116.0, 60.0, 87.0, 123.0, 117.0, 75.0, 113.0, 153.0], "unit": "score", "name": "audio-oscillator", "value": 102.1}, {"lowerIsBetter": true, "replicates": [90.0, 88.0, 89.0, 88.0, 91.0, 86.0, 90.0, 88.0, 97.0, 89.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 89.6}, {"lowerIsBetter": true, "replicates": [210.0, 159.0, 170.0, 226.0, 175.0, 162.0, 169.0, 233.0, 257.0, 203.0], "unit": "score", "name": "imaging-darkroom", "value": 196.4}, {"lowerIsBetter": true, "replicates": [94.0, 100.0, 97.0, 96.0, 100.0, 97.0, 95.0, 95.0, 97.0, 129.0], "unit": "score", "name": "imaging-desaturate", "value": 100.0}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 55.0, 57.0, 58.0, 59.0, 58.0, 57.0, 58.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [62.0, 64.0, 70.0, 90.0, 104.0, 101.0, 93.0, 93.0, 72.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 81.3}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 86.0, 72.0, 99.0, 110.0, 111.0, 82.0, 95.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 91.1}, {"lowerIsBetter": true, "replicates": [123.0, 138.0, 136.0, 134.0, 122.0, 124.0, 129.0, 134.0, 137.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.4}, {"lowerIsBetter": true, "replicates": [147.0, 177.0, 139.0, 183.0, 183.0, 160.0, 142.0, 137.0, 124.0, 177.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 156.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 69.0, 67.0, 67.0, 78.0, 98.0, 99.0, 97.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 77.8}], "name": "kraken", "value": 1827.6000000000001}]} 18:04:02 INFO - Return code: 0 18:04:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:04:02 ERROR - # TBPL SUCCESS # 18:04:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:04:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:04:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:04:02 INFO - 2016-03-14 18:04:02.229 screenresolution[1678:10580] starting screenresolution argv=screenresolution get 18:04:02 INFO - 2016-03-14 18:04:02.232 screenresolution[1678:10580] Display 0: 1600x1200x32@60 18:04:02 INFO - 2016-03-14 18:04:02.238 screenresolution[1679:10583] starting screenresolution argv=screenresolution list 18:04:02 INFO - Available Modes on Display 0 18:04:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:04:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:04:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:04:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:04:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:04:02 INFO - Intel Iris: 18:04:02 INFO - Chipset Model: Intel Iris 18:04:02 INFO - Type: GPU 18:04:02 INFO - Bus: Built-In 18:04:02 INFO - VRAM (Dynamic, Max): 1536 MB 18:04:02 INFO - Vendor: Intel (0x8086) 18:04:02 INFO - Device ID: 0x0a2e 18:04:02 INFO - Revision ID: 0x0009 18:04:02 INFO - Displays: 18:04:02 INFO - Display: 18:04:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:04:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:04:02 INFO - Display Serial Number: 1600x1200 60 18:04:02 INFO - Main Display: Yes 18:04:02 INFO - Mirror: Off 18:04:02 INFO - Online: Yes 18:04:02 INFO - Rotation: Supported 18:04:02 INFO - Return code: 0 18:04:02 INFO - Running post-action listener: _resource_record_post_action 18:04:02 INFO - Running post-run listener: _resource_record_post_run 18:04:03 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 39040512; Write bytes: 709358080; Read time: 443; Write time: 2344 18:04:03 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402708992; Write bytes: 404006400; Read time: 30322; Write time: 741 18:04:03 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 37213696; Write bytes: 304335872; Read time: 417; Write time: 1599 18:04:03 INFO - Running post-run listener: _upload_blobber_files 18:04:03 INFO - Blob upload gear active. 18:04:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:04:03 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 18:04:03 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:04:03 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:04:03 INFO - (blobuploader) - INFO - Open directory for files ... 18:04:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:04:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:04:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:05 INFO - (blobuploader) - INFO - Done attempting. 18:04:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:04:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:04:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:06 INFO - (blobuploader) - INFO - Done attempting. 18:04:06 INFO - (blobuploader) - INFO - Iteration through files over. 18:04:06 INFO - Return code: 0 18:04:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:04:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:04:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f32391ba325881634c6c7aceb0d733fb2fa76e71295a280eb5840e4e7bbb95285e9fac881f208be7cfc794b3ef2449353b28172d649166645679a52f1dcacf88", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5b678aa0af0fd46dd6fd6665638043b262884ea258765dffe567e8d8485482dc695771f498c87baeec2ef177b01f5a6ab8c69e66b8a375509387eedef6025fd6"} 18:04:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:04:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:04:06 INFO - Contents: 18:04:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f32391ba325881634c6c7aceb0d733fb2fa76e71295a280eb5840e4e7bbb95285e9fac881f208be7cfc794b3ef2449353b28172d649166645679a52f1dcacf88", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5b678aa0af0fd46dd6fd6665638043b262884ea258765dffe567e8d8485482dc695771f498c87baeec2ef177b01f5a6ab8c69e66b8a375509387eedef6025fd6"} 18:04:06 INFO - Running post-run listener: copy_logs_to_upload_dir 18:04:06 INFO - Copying logs to upload dir... 18:04:06 INFO - mkdir: /builds/slave/test/build/upload/logs 18:04:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.873482 ========= master_lag: 8.48 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-03-14 18:04:14.802427) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2016-03-14 18:04:14.806240) ========= 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.m1g8msvqYw/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.ZjxITcl11z/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f32391ba325881634c6c7aceb0d733fb2fa76e71295a280eb5840e4e7bbb95285e9fac881f208be7cfc794b3ef2449353b28172d649166645679a52f1dcacf88", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5b678aa0af0fd46dd6fd6665638043b262884ea258765dffe567e8d8485482dc695771f498c87baeec2ef177b01f5a6ab8c69e66b8a375509387eedef6025fd6"} build_url:https://queue.taskcluster.net/v1/task/QyHes70ySwmPafNt-o12hA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011222 build_url: 'https://queue.taskcluster.net/v1/task/QyHes70ySwmPafNt-o12hA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f32391ba325881634c6c7aceb0d733fb2fa76e71295a280eb5840e4e7bbb95285e9fac881f208be7cfc794b3ef2449353b28172d649166645679a52f1dcacf88", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5b678aa0af0fd46dd6fd6665638043b262884ea258765dffe567e8d8485482dc695771f498c87baeec2ef177b01f5a6ab8c69e66b8a375509387eedef6025fd6"}' ========= master_lag: 5.49 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2016-03-14 18:04:20.303581) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 18:04:20.303921) ========= 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.m1g8msvqYw/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.ZjxITcl11z/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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.005682 ========= master_lag: 0.60 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 18:04:20.913080) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 18:04:20.913587) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 18:04:20.975668) ========= ========= Total master_lag: 14.73 =========