builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0387 starttime: 1464888800.51 results: success (0) buildid: 20160602084653 builduid: 7bd88d6f073144e79b1e6d4d820927e4 revision: fe57228e70aa503323bf177093e2cecb438a39cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 10:33:20.511814) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 10:33:20.512273) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 10:33:20.512577) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 10:33:20.548161) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 10:33:20.548619) ========= 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.uMmkCYf7GZ/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.HTiVl6dX6S/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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-06-02 10:33:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.62M=0.002s 2016-06-02 10:33:20 (7.62 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099755 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 10:33:20.668579) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 10:33:20.668914) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uMmkCYf7GZ/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.HTiVl6dX6S/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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.020061 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 10:33:20.718662) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 10:33:20.719016) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fe57228e70aa503323bf177093e2cecb438a39cc --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 fe57228e70aa503323bf177093e2cecb438a39cc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uMmkCYf7GZ/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.HTiVl6dX6S/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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-06-02 10:33:20,799 truncating revision to first 12 chars 2016-06-02 10:33:20,799 Setting DEBUG logging. 2016-06-02 10:33:20,800 attempt 1/10 2016-06-02 10:33:20,800 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fe57228e70aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 10:33:21,425 unpacking tar archive at: fx-team-fe57228e70aa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.892546 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 10:33:21.632704) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 10:33:21.633077) ========= script_repo_revision: fe57228e70aa503323bf177093e2cecb438a39cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 10:33:21.633519) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 10:33:21.633799) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 10:33:21.650938) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-06-02 10:33:21.651396) ========= /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.uMmkCYf7GZ/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.HTiVl6dX6S/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 10:33:21 INFO - MultiFileLogger online at 20160602 10:33:21 in /builds/slave/test 10:33:21 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 10:33:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:33:21 INFO - {'append_to_log': False, 10:33:21 INFO - 'base_work_dir': '/builds/slave/test', 10:33:21 INFO - 'blob_upload_branch': 'Fx-Team', 10:33:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:33:21 INFO - 'branch': 'Fx-Team', 10:33:21 INFO - 'buildbot_json_path': 'buildprops.json', 10:33:21 INFO - 'config_files': ('talos/mac_config.py',), 10:33:21 INFO - 'default_actions': ('clobber', 10:33:21 INFO - 'read-buildbot-config', 10:33:21 INFO - 'download-and-extract', 10:33:21 INFO - 'populate-webroot', 10:33:21 INFO - 'create-virtualenv', 10:33:21 INFO - 'install', 10:33:21 INFO - 'run-tests'), 10:33:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:33:21 INFO - 'download_minidump_stackwalk': True, 10:33:21 INFO - 'download_symbols': 'ondemand', 10:33:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:33:21 INFO - 'tooltool.py': '/tools/tooltool.py', 10:33:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:33:21 INFO - '/tools/misc-python/virtualenv.py')}, 10:33:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:33:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:33:21 INFO - 'installer_path': 'installer.exe', 10:33:21 INFO - 'log_level': 'info', 10:33:21 INFO - 'log_name': 'talos', 10:33:21 INFO - 'log_to_console': True, 10:33:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:33:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:33:21 INFO - 'opt_config_files': (), 10:33:21 INFO - 'pip_index': False, 10:33:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:33:21 INFO - 'cmd': ('bash', 10:33:21 INFO - '-c', 10:33:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:33:21 INFO - 'enabled': True, 10:33:21 INFO - 'halt_on_failure': False, 10:33:21 INFO - 'name': 'check_screen_resolution'},), 10:33:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:33:21 INFO - 'cmd': ('bash', 10:33:21 INFO - '-c', 10:33:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:33:21 INFO - 'enabled': True, 10:33:21 INFO - 'halt_on_failure': False, 10:33:21 INFO - 'name': 'check_screen_resolution'},), 10:33:21 INFO - 'run_cmd_checks_enabled': True, 10:33:21 INFO - 'sps_profile': False, 10:33:21 INFO - 'sps_profile_interval': 0, 10:33:21 INFO - 'suite': 'dromaeojs-e10s', 10:33:21 INFO - 'system_bits': '32', 10:33:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:33:21 INFO - 'title': 't-yosemite-r7-0387', 10:33:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:33:21 INFO - 'use_talos_json': True, 10:33:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:33:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:33:21 INFO - 'work_dir': 'build'} 10:33:21 INFO - ##### 10:33:21 INFO - ##### Running clobber step. 10:33:21 INFO - ##### 10:33:21 INFO - Running pre-action listener: _resource_record_pre_action 10:33:21 INFO - Running main action method: clobber 10:33:21 INFO - rmtree: /builds/slave/test/build 10:33:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:33:23 INFO - Running post-action listener: _resource_record_post_action 10:33:23 INFO - ##### 10:33:23 INFO - ##### Finished clobber step (success) 10:33:23 INFO - ##### 10:33:23 INFO - ##### 10:33:23 INFO - ##### Running read-buildbot-config step. 10:33:23 INFO - ##### 10:33:23 INFO - Running pre-action listener: _resource_record_pre_action 10:33:23 INFO - Running main action method: read_buildbot_config 10:33:23 INFO - Using buildbot properties: 10:33:23 INFO - { 10:33:23 INFO - "project": "", 10:33:23 INFO - "product": "firefox", 10:33:23 INFO - "script_repo_revision": "production", 10:33:23 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 10:33:23 INFO - "repository": "", 10:33:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 10:33:23 INFO - "buildid": "20160602084653", 10:33:23 INFO - "pgo_build": "False", 10:33:23 INFO - "basedir": "/builds/slave/test", 10:33:23 INFO - "buildnumber": 696, 10:33:23 INFO - "slavename": "t-yosemite-r7-0387", 10:33:23 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 10:33:23 INFO - "platform": "yosemite_r7", 10:33:23 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 10:33:23 INFO - "branch": "fx-team", 10:33:23 INFO - "repo_path": "integration/fx-team", 10:33:23 INFO - "revision": "fe57228e70aa503323bf177093e2cecb438a39cc", 10:33:23 INFO - "stage_platform": "macosx64", 10:33:23 INFO - "builduid": "7bd88d6f073144e79b1e6d4d820927e4", 10:33:23 INFO - "slavebuilddir": "test" 10:33:23 INFO - } 10:33:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 10:33:23 INFO - Running post-action listener: _resource_record_post_action 10:33:23 INFO - ##### 10:33:23 INFO - ##### Finished read-buildbot-config step (success) 10:33:23 INFO - ##### 10:33:23 INFO - ##### 10:33:23 INFO - ##### Running download-and-extract step. 10:33:23 INFO - ##### 10:33:23 INFO - Running pre-action listener: _resource_record_pre_action 10:33:23 INFO - Running main action method: download_and_extract 10:33:23 INFO - mkdir: /builds/slave/test/build/tests 10:33: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')]} 10:33:23 INFO - https://queue.taskcluster.net/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:33:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 10:33:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 10:33:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 10:33:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 10:33:24 INFO - Downloaded 1199 bytes. 10:33:24 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 10:33:24 INFO - Using the following test package requirements: 10:33:24 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 10:33:24 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:33:24 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 10:33:24 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:33:24 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 10:33:24 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:33:24 INFO - u'jsshell-mac.zip'], 10:33:24 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:33:24 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 10:33:24 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 10:33:24 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:33:24 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 10:33:24 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:33:24 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 10:33:24 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:33:24 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 10:33:24 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:33:24 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 10:33:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:24 INFO - https://queue.taskcluster.net/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:33:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:33:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:33:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:33:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:33:25 INFO - Downloaded 18713571 bytes. 10:33:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:33:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:33:28 INFO - Return code: 0 10:33:28 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:33:28 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')]} 10:33:28 INFO - https://queue.taskcluster.net/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:33:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:33:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:33:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:33:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:33:30 INFO - Downloaded 18713571 bytes. 10:33:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:33:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:33:33 INFO - Return code: 0 10:33:33 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')]} 10:33:33 INFO - https://queue.taskcluster.net/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:33:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 10:33:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 10:33:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 10:33:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:33:34 INFO - Downloaded 10834055 bytes. 10:33:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:33:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:33:34 INFO - Return code: 0 10:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:34 INFO - https://queue.taskcluster.net/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:33:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 10:33:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 10:33:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 10:33:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 10:33:40 INFO - Downloaded 111079536 bytes. 10:33:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 10:33:40 INFO - mkdir: /builds/slave/test/properties 10:33:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:33:40 INFO - Writing to file /builds/slave/test/properties/build_url 10:33:40 INFO - Contents: 10:33:40 INFO - build_url:https://queue.taskcluster.net/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 10:33:40 INFO - Running post-action listener: _resource_record_post_action 10:33:40 INFO - Running post-action listener: set_extra_try_arguments 10:33:40 INFO - ##### 10:33:40 INFO - ##### Finished download-and-extract step (success) 10:33:40 INFO - ##### 10:33:40 INFO - ##### 10:33:40 INFO - ##### Running populate-webroot step. 10:33:40 INFO - ##### 10:33:40 INFO - Running pre-action listener: _resource_record_pre_action 10:33:40 INFO - Running main action method: populate_webroot 10:33:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:33:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:33:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:33:40 INFO - '--tppagecycles', 10:33:40 INFO - '7'], 10:33:40 INFO - 'tests': ['tsvgm']}}, 10:33:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:33:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:33:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:33:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:33:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:33:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:33:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:40 INFO - 'talos_options': ['--disable-e10s'], 10:33:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:33:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:33:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:40 INFO - 'talos_options': ['--disable-e10s'], 10:33:40 INFO - 'tests': ['damp', 'tps']}, 10:33:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:40 INFO - 'tests': ['damp', 'tps']}, 10:33:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:33:40 INFO - 'tests': ['dromaeo_dom']}, 10:33:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:33:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:33:40 INFO - 'tests': ['a11yr', 10:33:40 INFO - 'ts_paint', 10:33:40 INFO - 'tpaint', 10:33:40 INFO - 'sessionrestore', 10:33:40 INFO - 'sessionrestore_no_auto_restore', 10:33:40 INFO - 'tabpaint']}, 10:33:40 INFO - 'other-e10s': {'tests': ['a11yr', 10:33:40 INFO - 'ts_paint', 10:33:40 INFO - 'tpaint', 10:33:40 INFO - 'sessionrestore', 10:33:40 INFO - 'sessionrestore_no_auto_restore', 10:33:40 INFO - 'tabpaint']}, 10:33:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:33:40 INFO - 'ts_paint', 10:33:40 INFO - 'tpaint', 10:33:40 INFO - 'sessionrestore', 10:33:40 INFO - 'sessionrestore_no_auto_restore', 10:33:40 INFO - 'tabpaint']}, 10:33:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:33:40 INFO - 'ts_paint', 10:33:40 INFO - 'tpaint', 10:33:40 INFO - 'sessionrestore', 10:33:40 INFO - 'sessionrestore_no_auto_restore', 10:33:40 INFO - 'tabpaint']}, 10:33:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:33:40 INFO - 'tests': ['a11yr', 10:33:40 INFO - 'ts_paint', 10:33:40 INFO - 'tpaint', 10:33:40 INFO - 'sessionrestore', 10:33:40 INFO - 'sessionrestore_no_auto_restore', 10:33:40 INFO - 'tabpaint']}, 10:33:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:33:40 INFO - 'tests': ['a11yr', 10:33:40 INFO - 'ts_paint', 10:33:40 INFO - 'tpaint', 10:33:40 INFO - 'sessionrestore', 10:33:40 INFO - 'sessionrestore_no_auto_restore', 10:33:40 INFO - 'tabpaint']}, 10:33:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:33:40 INFO - 'tests': ['tsvgx', 10:33:40 INFO - 'tsvgr_opacity', 10:33:40 INFO - 'tart', 10:33:40 INFO - 'tscrollx', 10:33:40 INFO - 'cart']}, 10:33:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:33:40 INFO - 'tsvgr_opacity', 10:33:40 INFO - 'tart', 10:33:40 INFO - 'tscrollx', 10:33:40 INFO - 'cart']}, 10:33:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:40 INFO - 'talos_options': ['--disable-e10s'], 10:33:40 INFO - 'tests': ['tp5o']}, 10:33:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:40 INFO - 'tests': ['tp5o']}, 10:33:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:40 INFO - 'talos_options': ['--disable-e10s', 10:33:40 INFO - '--xperf_path', 10:33:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:33:40 INFO - 'tests': ['tp5n']}, 10:33:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:40 INFO - 'talos_options': ['--xperf_path', 10:33:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:33:40 INFO - 'tests': ['tp5n']}}, 10:33:40 INFO - 'talos.zip': {'path': '', 10:33:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:33:40 INFO - Running post-action listener: _resource_record_post_action 10:33:40 INFO - ##### 10:33:40 INFO - ##### Finished populate-webroot step (success) 10:33:40 INFO - ##### 10:33:40 INFO - ##### 10:33:40 INFO - ##### Running create-virtualenv step. 10:33:40 INFO - ##### 10:33:40 INFO - Running pre-action listener: _resource_record_pre_action 10:33:40 INFO - Running main action method: create_virtualenv 10:33:40 INFO - Creating virtualenv /builds/slave/test/build/venv 10:33:40 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 10:33:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:33:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:33:41 INFO - Using real prefix '/tools/python27' 10:33:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:33:41 INFO - Installing distribute.............................................................................................................................................................................................done. 10:33:44 INFO - Installing pip.................done. 10:33:44 INFO - Return code: 0 10:33:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:33: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')]} 10:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33: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')]} 10:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:44 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 0x10f4e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4e7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec1d82b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f385d30>, '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 0x10f1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f37cb20>, '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.uMmkCYf7GZ/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.HTiVl6dX6S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 10:33:44 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 10:33:44 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 10:33:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uMmkCYf7GZ/Render', 10:33:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:44 INFO - 'HOME': '/Users/cltbld', 10:33:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:44 INFO - 'LOGNAME': 'cltbld', 10:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:44 INFO - 'MOZ_NO_REMOTE': '1', 10:33:44 INFO - 'NO_EM_RESTART': '1', 10:33:44 INFO - 'PAGER': '/bin/cat', 10:33:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:44 INFO - 'PWD': '/builds/slave/test', 10:33:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:44 INFO - 'SHELL': '/bin/bash', 10:33:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HTiVl6dX6S/Listeners', 10:33:44 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 10:33:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:44 INFO - 'USER': 'cltbld', 10:33:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:44 INFO - 'XPC_FLAGS': '0x0', 10:33:44 INFO - 'XPC_SERVICE_NAME': '0', 10:33:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:44 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 10:33:44 INFO - Cleaning up... 10:33:44 INFO - Return code: 0 10:33:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:33: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')]} 10:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33: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')]} 10:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:44 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f4e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4e7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec1d82b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f385d30>, '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 0x10f1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f37cb20>, '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.uMmkCYf7GZ/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.HTiVl6dX6S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 10:33:44 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>=3.1.1'] in /builds/slave/test/build 10:33:44 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>=3.1.1 10:33:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uMmkCYf7GZ/Render', 10:33:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:44 INFO - 'HOME': '/Users/cltbld', 10:33:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:44 INFO - 'LOGNAME': 'cltbld', 10:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:44 INFO - 'MOZ_NO_REMOTE': '1', 10:33:44 INFO - 'NO_EM_RESTART': '1', 10:33:44 INFO - 'PAGER': '/bin/cat', 10:33:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:44 INFO - 'PWD': '/builds/slave/test', 10:33:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:44 INFO - 'SHELL': '/bin/bash', 10:33:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HTiVl6dX6S/Listeners', 10:33:44 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 10:33:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:44 INFO - 'USER': 'cltbld', 10:33:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:44 INFO - 'XPC_FLAGS': '0x0', 10:33:44 INFO - 'XPC_SERVICE_NAME': '0', 10:33:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:45 INFO - Downloading/unpacking psutil>=3.1.1 10:33: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 10:33: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 10:33: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 10:33: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 10:33: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 10:33: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 10:33:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:33:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:33:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:33:48 INFO - Installing collected packages: psutil 10:33:48 INFO - Running setup.py install for psutil 10:33:48 INFO - building 'psutil._psutil_osx' extension 10:33:48 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 10:33:48 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 10:33:48 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 10:33:48 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 10:33:48 INFO - building 'psutil._psutil_posix' extension 10:33:48 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 10:33:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:33:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:33:48 INFO - ^ 10:33:48 INFO - 1 warning generated. 10:33:48 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 10:33:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:33:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:33:48 INFO - Successfully installed psutil 10:33:48 INFO - Cleaning up... 10:33:48 INFO - Return code: 0 10:33:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:33: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')]} 10:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33: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')]} 10:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f4e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4e7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec1d82b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f385d30>, '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 0x10f1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f37cb20>, '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.uMmkCYf7GZ/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.HTiVl6dX6S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 10:33: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:33: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 mozsystemmonitor==0.3 10:33:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uMmkCYf7GZ/Render', 10:33:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:48 INFO - 'HOME': '/Users/cltbld', 10:33:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:48 INFO - 'LOGNAME': 'cltbld', 10:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:48 INFO - 'MOZ_NO_REMOTE': '1', 10:33:48 INFO - 'NO_EM_RESTART': '1', 10:33:48 INFO - 'PAGER': '/bin/cat', 10:33:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:48 INFO - 'PWD': '/builds/slave/test', 10:33:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:48 INFO - 'SHELL': '/bin/bash', 10:33:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HTiVl6dX6S/Listeners', 10:33:48 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 10:33:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:48 INFO - 'USER': 'cltbld', 10:33:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:48 INFO - 'XPC_FLAGS': '0x0', 10:33:48 INFO - 'XPC_SERVICE_NAME': '0', 10:33:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:33:49 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 10:33:49 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 10:33:49 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 10:33:49 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 10:33:49 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 10:33:49 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 10:33:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:33:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:33:51 INFO - Installing collected packages: mozsystemmonitor 10:33:51 INFO - Running setup.py install for mozsystemmonitor 10:33:51 INFO - Successfully installed mozsystemmonitor 10:33:51 INFO - Cleaning up... 10:33:51 INFO - Return code: 0 10:33:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:33:51 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')]} 10:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:51 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')]} 10:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:51 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 0x10f4e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4e7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec1d82b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f385d30>, '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 0x10f1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f37cb20>, '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.uMmkCYf7GZ/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.HTiVl6dX6S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 10:33:51 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 10:33:51 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 10:33:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uMmkCYf7GZ/Render', 10:33:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:51 INFO - 'HOME': '/Users/cltbld', 10:33:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:51 INFO - 'LOGNAME': 'cltbld', 10:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:51 INFO - 'MOZ_NO_REMOTE': '1', 10:33:51 INFO - 'NO_EM_RESTART': '1', 10:33:51 INFO - 'PAGER': '/bin/cat', 10:33:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:51 INFO - 'PWD': '/builds/slave/test', 10:33:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:51 INFO - 'SHELL': '/bin/bash', 10:33:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HTiVl6dX6S/Listeners', 10:33:51 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 10:33:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:51 INFO - 'USER': 'cltbld', 10:33:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:51 INFO - 'XPC_FLAGS': '0x0', 10:33:51 INFO - 'XPC_SERVICE_NAME': '0', 10:33:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:52 INFO - Downloading/unpacking blobuploader==1.2.4 10:33:52 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 10:33:52 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 10:33:52 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 10:33:52 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 10:33:52 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 10:33:52 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 10:33:54 INFO - Downloading blobuploader-1.2.4.tar.gz 10:33:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:33:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:33:54 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 10:33:54 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 10:33:54 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 10:33:54 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 10:33:54 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 10:33:54 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 10:33:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:33:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:55 INFO - Downloading docopt-0.6.1.tar.gz 10:33:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:33:55 INFO - Installing collected packages: blobuploader, requests, docopt 10:33:55 INFO - Running setup.py install for blobuploader 10:33:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:33:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:33:55 INFO - Running setup.py install for requests 10:33:56 INFO - Running setup.py install for docopt 10:33:56 INFO - Successfully installed blobuploader requests docopt 10:33:56 INFO - Cleaning up... 10:33:56 INFO - Return code: 0 10:33:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:33:56 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')]} 10:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:56 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')]} 10:33:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:56 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 0x10f4e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4e7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec1d82b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f385d30>, '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 0x10f1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f37cb20>, '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.uMmkCYf7GZ/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.HTiVl6dX6S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 10:33:56 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 10:33:56 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 10:33:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uMmkCYf7GZ/Render', 10:33:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:56 INFO - 'HOME': '/Users/cltbld', 10:33:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:56 INFO - 'LOGNAME': 'cltbld', 10:33:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:56 INFO - 'MOZ_NO_REMOTE': '1', 10:33:56 INFO - 'NO_EM_RESTART': '1', 10:33:56 INFO - 'PAGER': '/bin/cat', 10:33:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:56 INFO - 'PWD': '/builds/slave/test', 10:33:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:56 INFO - 'SHELL': '/bin/bash', 10:33:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HTiVl6dX6S/Listeners', 10:33:56 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 10:33:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:56 INFO - 'USER': 'cltbld', 10:33:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:56 INFO - 'XPC_FLAGS': '0x0', 10:33:56 INFO - 'XPC_SERVICE_NAME': '0', 10:33:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:33:56 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-IHlQ1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:33:57 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-S_ofnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:33:57 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-csp60s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:33:57 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-xJAamW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:33:57 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-e4xqED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:33:57 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-0xpJ2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:33:57 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-Su0YMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:33:57 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-zMiiBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:33:57 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-tHRNBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:33:57 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-h7DBFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:33:57 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-Z9rJ1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:33:58 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-ash8Kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:33:58 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-RYzeSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:33:58 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-zJJV2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:33:58 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-nyjod7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:33:58 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-pOAOtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:33:58 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-XCrKt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:33:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:33:58 INFO - Running setup.py install for manifestparser 10:33:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:33:58 INFO - Running setup.py install for mozcrash 10:33:58 INFO - Running setup.py install for mozdebug 10:33:59 INFO - Running setup.py install for mozdevice 10:33:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:33:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:33:59 INFO - Running setup.py install for mozfile 10:33:59 INFO - Running setup.py install for mozhttpd 10:33:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:33:59 INFO - Running setup.py install for mozinfo 10:33:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:33:59 INFO - Running setup.py install for mozInstall 10:33:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:33:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:33:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:33:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:33:59 INFO - Running setup.py install for mozleak 10:33:59 INFO - Running setup.py install for mozlog 10:34:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:34:00 INFO - Running setup.py install for moznetwork 10:34:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:34:00 INFO - Running setup.py install for mozprocess 10:34:00 INFO - Running setup.py install for mozprofile 10:34:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:34:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:34:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:34:00 INFO - Running setup.py install for mozrunner 10:34:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:34:00 INFO - Running setup.py install for mozscreenshot 10:34:00 INFO - Running setup.py install for moztest 10:34:01 INFO - Running setup.py install for mozversion 10:34:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:34:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:34:01 INFO - Cleaning up... 10:34:01 INFO - Return code: 0 10:34:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:34:01 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')]} 10:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:01 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')]} 10:34:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:01 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 0x10f4e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4e7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec1d82b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f385d30>, '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 0x10f1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f37cb20>, '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.uMmkCYf7GZ/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.HTiVl6dX6S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 10:34:01 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 10:34:01 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 10:34:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uMmkCYf7GZ/Render', 10:34:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:34:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:34:01 INFO - 'HOME': '/Users/cltbld', 10:34:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:34:01 INFO - 'LOGNAME': 'cltbld', 10:34:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:01 INFO - 'MOZ_NO_REMOTE': '1', 10:34:01 INFO - 'NO_EM_RESTART': '1', 10:34:01 INFO - 'PAGER': '/bin/cat', 10:34:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:34:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:01 INFO - 'PWD': '/builds/slave/test', 10:34:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:34:01 INFO - 'SHELL': '/bin/bash', 10:34:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HTiVl6dX6S/Listeners', 10:34:01 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 10:34:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:34:01 INFO - 'USER': 'cltbld', 10:34:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:34:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:34:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:01 INFO - 'XPC_FLAGS': '0x0', 10:34:01 INFO - 'XPC_SERVICE_NAME': '0', 10:34:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:34:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:34:01 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-nEMdSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:34:01 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)) 10:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:34:01 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-9XiwqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:34:01 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)) 10:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:34:01 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-AQfesI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:34:01 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)) 10:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:34:01 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-X_w44v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:34:01 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)) 10:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:34:01 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-G0ZvGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:34:02 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)) 10:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:34:02 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-ok_9LV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:34:02 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)) 10:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:34:02 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-c2lqEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:34:02 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)) 10:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:34:02 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-XglsIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:34:02 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)) 10:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:34:02 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-uDrBvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:34:02 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)) 10:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:34:02 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-TDgVS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 10:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:34:02 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-fWElS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:34:02 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)) 10:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:34:02 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-DoSNeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:34:02 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)) 10:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:34:02 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-wdOtsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:34:02 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)) 10:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:34:02 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-7VLlRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:34:02 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)) 10:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:34:02 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-8bjEKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:34:03 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)) 10:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:34:03 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-wmm1Qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:34:03 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)) 10:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:34:03 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-jzLF4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:34:03 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)) 10:34:03 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)) 10:34:03 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)) 10:34:03 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)) 10:34:03 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)) 10:34:03 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)) 10:34:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:05 INFO - Downloading blessings-1.6.tar.gz 10:34:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:34:05 INFO - Installing collected packages: blessings 10:34:05 INFO - Running setup.py install for blessings 10:34:05 INFO - Successfully installed blessings 10:34:05 INFO - Cleaning up... 10:34:06 INFO - Return code: 0 10:34:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:34:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:34:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:34:06 INFO - Reading from file tmpfile_stdout 10:34:06 INFO - Current package versions: 10:34:06 INFO - blessings == 1.6 10:34:06 INFO - blobuploader == 1.2.4 10:34:06 INFO - docopt == 0.6.1 10:34:06 INFO - manifestparser == 1.1 10:34:06 INFO - mozInstall == 1.12 10:34:06 INFO - mozcrash == 0.17 10:34:06 INFO - mozdebug == 0.1 10:34:06 INFO - mozdevice == 0.48 10:34:06 INFO - mozfile == 1.2 10:34:06 INFO - mozhttpd == 0.7 10:34:06 INFO - mozinfo == 0.9 10:34:06 INFO - mozleak == 0.1 10:34:06 INFO - mozlog == 3.2 10:34:06 INFO - moznetwork == 0.27 10:34:06 INFO - mozprocess == 0.22 10:34:06 INFO - mozprofile == 0.28 10:34:06 INFO - mozrunner == 6.11 10:34:06 INFO - mozscreenshot == 0.1 10:34:06 INFO - mozsystemmonitor == 0.3 10:34:06 INFO - moztest == 0.7 10:34:06 INFO - mozversion == 1.4 10:34:06 INFO - psutil == 3.1.1 10:34:06 INFO - requests == 1.2.3 10:34:06 INFO - wsgiref == 0.1.2 10:34:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:06 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 0x10f4e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4e7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec1d82b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f385d30>, '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 0x10f1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f37cb20>, '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.uMmkCYf7GZ/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.HTiVl6dX6S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 10:34:06 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 10:34:06 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 10:34:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uMmkCYf7GZ/Render', 10:34:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:34:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:34:06 INFO - 'HOME': '/Users/cltbld', 10:34:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:34:06 INFO - 'LOGNAME': 'cltbld', 10:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:06 INFO - 'MOZ_NO_REMOTE': '1', 10:34:06 INFO - 'NO_EM_RESTART': '1', 10:34:06 INFO - 'PAGER': '/bin/cat', 10:34:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:34:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:06 INFO - 'PWD': '/builds/slave/test', 10:34:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:34:06 INFO - 'SHELL': '/bin/bash', 10:34:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HTiVl6dX6S/Listeners', 10:34:06 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 10:34:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:34:06 INFO - 'USER': 'cltbld', 10:34:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:34:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:06 INFO - 'XPC_FLAGS': '0x0', 10:34:06 INFO - 'XPC_SERVICE_NAME': '0', 10:34:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:34:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:06 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)) 10:34:06 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)) 10:34:06 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)) 10:34:06 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)) 10:34:06 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)) 10:34:06 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)) 10:34:06 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)) 10:34:06 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)) 10:34:06 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)) 10:34:06 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)) 10:34:06 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)) 10:34:06 INFO - Cleaning up... 10:34:06 INFO - Return code: 0 10:34:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f4e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4e7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec1d82b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f385d30>, '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 0x10f1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f37cb20>, '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.uMmkCYf7GZ/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.HTiVl6dX6S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 10:34:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:34:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:34:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uMmkCYf7GZ/Render', 10:34:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:34:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:34:06 INFO - 'HOME': '/Users/cltbld', 10:34:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:34:06 INFO - 'LOGNAME': 'cltbld', 10:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:06 INFO - 'MOZ_NO_REMOTE': '1', 10:34:06 INFO - 'NO_EM_RESTART': '1', 10:34:06 INFO - 'PAGER': '/bin/cat', 10:34:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:34:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:06 INFO - 'PWD': '/builds/slave/test', 10:34:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:34:06 INFO - 'SHELL': '/bin/bash', 10:34:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HTiVl6dX6S/Listeners', 10:34:06 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 10:34:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:34:06 INFO - 'USER': 'cltbld', 10:34:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:34:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:06 INFO - 'XPC_FLAGS': '0x0', 10:34:06 INFO - 'XPC_SERVICE_NAME': '0', 10:34:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:34:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:06 INFO - Downloading/unpacking jsonschema 10:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:34:09 INFO - Downloading/unpacking functools32 (from jsonschema) 10:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:09 INFO - Downloading functools32-3.2.3-2.tar.gz 10:34:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:34:09 INFO - warning: no files found matching '*.txt' 10:34:09 INFO - no previously-included directories found matching 'build' 10:34:09 INFO - no previously-included directories found matching 'dist' 10:34:09 INFO - no previously-included directories found matching '.git*' 10:34:09 INFO - Installing collected packages: jsonschema, functools32 10:34:09 INFO - Running setup.py install for functools32 10:34:10 INFO - warning: no files found matching '*.txt' 10:34:10 INFO - no previously-included directories found matching 'build' 10:34:10 INFO - no previously-included directories found matching 'dist' 10:34:10 INFO - no previously-included directories found matching '.git*' 10:34:10 INFO - Successfully installed jsonschema functools32 10:34:10 INFO - Cleaning up... 10:34:10 INFO - Return code: 0 10:34:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:10 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 0x10f4e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4e7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec1d82b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f385d30>, '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 0x10f1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f37cb20>, '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.uMmkCYf7GZ/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.HTiVl6dX6S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 10:34:10 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 10:34:10 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 10:34:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uMmkCYf7GZ/Render', 10:34:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:34:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:34:10 INFO - 'HOME': '/Users/cltbld', 10:34:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:34:10 INFO - 'LOGNAME': 'cltbld', 10:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:10 INFO - 'MOZ_NO_REMOTE': '1', 10:34:10 INFO - 'NO_EM_RESTART': '1', 10:34:10 INFO - 'PAGER': '/bin/cat', 10:34:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:10 INFO - 'PWD': '/builds/slave/test', 10:34:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:34:10 INFO - 'SHELL': '/bin/bash', 10:34:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HTiVl6dX6S/Listeners', 10:34:10 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 10:34:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:34:10 INFO - 'USER': 'cltbld', 10:34:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:34:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:10 INFO - 'XPC_FLAGS': '0x0', 10:34:10 INFO - 'XPC_SERVICE_NAME': '0', 10:34:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:10 INFO - Downloading/unpacking flake8 10:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:34:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:34:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:34:13 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 10:34:13 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 10:34:13 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 10:34:13 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 10:34:13 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 10:34:13 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 10:34:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:34:13 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 10:34:13 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 10:34:13 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 10:34:13 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 10:34:13 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 10:34:13 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 10:34:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:34:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:34:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:34:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:34:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:34:14 INFO - no previously-included directories found matching 'docs/_build' 10:34:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:34:14 INFO - Running setup.py install for pep8 10:34:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:34:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:34:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:34:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:34:14 INFO - no previously-included directories found matching 'docs/_build' 10:34:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:34:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:34:14 INFO - Cleaning up... 10:34:14 INFO - Return code: 0 10:34:14 INFO - Running post-action listener: _resource_record_post_action 10:34:14 INFO - Running post-action listener: _start_resource_monitoring 10:34:14 INFO - Starting resource monitoring. 10:34:14 INFO - ##### 10:34:14 INFO - ##### Finished create-virtualenv step (success) 10:34:14 INFO - ##### 10:34:14 INFO - ##### 10:34:14 INFO - ##### Running install step. 10:34:14 INFO - ##### 10:34:14 INFO - Running pre-action listener: _resource_record_pre_action 10:34:14 INFO - Running main action method: install 10:34:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:34:14 INFO - Reading from file tmpfile_stdout 10:34:14 INFO - Detecting whether we're running mozinstall >=1.0... 10:34:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:34:14 INFO - Reading from file tmpfile_stdout 10:34:14 INFO - Output received: 10:34:14 INFO - Usage: mozinstall [options] installer 10:34:14 INFO - Options: 10:34:14 INFO - -h, --help show this help message and exit 10:34:14 INFO - -d DEST, --destination=DEST 10:34:14 INFO - Directory to install application into. [default: 10:34:14 INFO - "/builds/slave/test"] 10:34:14 INFO - --app=APP Application being installed. [default: firefox] 10:34:14 INFO - mkdir: /builds/slave/test/build/application 10:34:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:34:48 INFO - Reading from file tmpfile_stdout 10:34:48 INFO - Output received: 10:34:48 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:34:48 INFO - Running post-action listener: _resource_record_post_action 10:34:48 INFO - ##### 10:34:48 INFO - ##### Finished install step (success) 10:34:48 INFO - ##### 10:34:48 INFO - ##### 10:34:48 INFO - ##### Running run-tests step. 10:34:48 INFO - ##### 10:34:48 INFO - Running pre-action listener: _resource_record_pre_action 10:34:48 INFO - Running main action method: run_tests 10:34:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:34:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:34:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:34:48 INFO - 2016-06-02 10:34:48.692 screenresolution[1925:15735] starting screenresolution argv=screenresolution get 10:34:48 INFO - 2016-06-02 10:34:48.695 screenresolution[1925:15735] Display 0: 1600x1200x32@60 10:34:48 INFO - 2016-06-02 10:34:48.701 screenresolution[1926:15738] starting screenresolution argv=screenresolution list 10:34:48 INFO - Available Modes on Display 0 10:34:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:34:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:34:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:34:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:34:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:34:48 INFO - Intel Iris: 10:34:48 INFO - Chipset Model: Intel Iris 10:34:48 INFO - Type: GPU 10:34:48 INFO - Bus: Built-In 10:34:48 INFO - VRAM (Dynamic, Max): 1536 MB 10:34:48 INFO - Vendor: Intel (0x8086) 10:34:48 INFO - Device ID: 0x0a2e 10:34:48 INFO - Revision ID: 0x0009 10:34:48 INFO - Displays: 10:34:48 INFO - Display: 10:34:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:34:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:34:48 INFO - Display Serial Number: 1600x1200 60 10:34:48 INFO - Main Display: Yes 10:34:48 INFO - Mirror: Off 10:34:48 INFO - Online: Yes 10:34:48 INFO - Rotation: Supported 10:34:48 INFO - Return code: 0 10:34:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:34:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:34:48 INFO - Python 2.7.3 10:34:48 INFO - Return code: 0 10:34:48 INFO - grabbing minidump binary from tooltool 10:34: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')]} 10:34:48 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f385d30>, '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 0x10f1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f37cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:34:48 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 10:34:48 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 10:34:48 INFO - Calling ['/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'] with output_timeout 600 10:34:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:34:49 INFO - Return code: 0 10:34:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:34:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:34:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:34:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:34:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:34:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:34:50 INFO - Return code: 0 10:34:50 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/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0387', '--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 10:34:50 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/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0387 --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 10:34:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uMmkCYf7GZ/Render', 10:34:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:34:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:34:50 INFO - 'HOME': '/Users/cltbld', 10:34:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:34:50 INFO - 'LOGNAME': 'cltbld', 10:34:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:34:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:50 INFO - 'MOZ_NO_REMOTE': '1', 10:34:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:34:50 INFO - 'NO_EM_RESTART': '1', 10:34:50 INFO - 'PAGER': '/bin/cat', 10:34:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:50 INFO - 'PWD': '/builds/slave/test', 10:34:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:34:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:34:50 INFO - 'SHELL': '/bin/bash', 10:34:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HTiVl6dX6S/Listeners', 10:34:50 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 10:34:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:34:50 INFO - 'USER': 'cltbld', 10:34:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:34:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:50 INFO - 'XPC_FLAGS': '0x0', 10:34:50 INFO - 'XPC_SERVICE_NAME': '0', 10:34:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:34:50 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/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0387', '--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 10:34:50 INFO - mozversion application_buildid: 20160602084653 10:34:50 INFO - mozversion application_changeset: fe57228e70aa503323bf177093e2cecb438a39cc 10:34:50 INFO - mozversion application_display_name: Nightly 10:34:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:34:50 INFO - mozversion application_name: Firefox 10:34:50 INFO - mozversion application_remotingname: firefox 10:34:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:34:50 INFO - mozversion application_vendor: Mozilla 10:34:50 INFO - mozversion application_version: 49.0a1 10:34:50 INFO - mozversion platform_buildid: 20160602084653 10:34:50 INFO - mozversion platform_changeset: fe57228e70aa503323bf177093e2cecb438a39cc 10:34:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:34:50 INFO - mozversion platform_version: 49.0a1 10:34:50 INFO - using testdate: 1464888890 10:34:50 INFO - actual date: 1464888890 10:34:50 INFO - starting webserver on 'localhost:52110' 10:34:50 INFO - SUITE-START | Running 2 tests 10:34:50 INFO - TEST-START | dromaeo_css 10:34:50 INFO - operating with platform_type : mac_ 10:34:50 INFO - Initialising browser for dromaeo_css test... 10:34:50 INFO - TEST-INFO | started process 1944 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmphRw3Gq/profile http://localhost:52110/getInfo.html) 10:34:53 INFO - PROCESS | 1944 | __metrics Screen width/height:1600/1200 10:34:53 INFO - PROCESS | 1944 | colorDepth:24 10:34:53 INFO - PROCESS | 1944 | Browser inner width/height: 1024/689 10:34:53 INFO - PROCESS | 1944 | __metrics 10:34:53 ERROR - PROCESS | 1944 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 10:34:54 INFO - TEST-INFO | 1944: exit 0 10:34:54 INFO - Browser initialized. 10:34:54 INFO - Running cycle 1/1 for dromaeo_css test... 10:34:54 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmphRw3Gq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:35:06 INFO - PROCESS | 1947 | RSS: Main: 252895232 10:35:06 INFO - PROCESS | 1947 | 10:35:56 INFO - PROCESS | 1947 | 1464888956080 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] 10:38:07 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52110/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52110/tests/dromaeo/cssquery-ext.html) 10:38:08 INFO - PROCESS | 1947 | RSS: Main: 267874304 10:38:08 INFO - PROCESS | 1947 | 10:41:10 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52110/tests/dromaeo/cssquery-ext.html (next: http://localhost:52110/tests/dromaeo/cssquery-jquery.html) 10:41:11 INFO - PROCESS | 1947 | RSS: Main: 278474752 10:41:11 INFO - PROCESS | 1947 | 10:44:12 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52110/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52110/tests/dromaeo/cssquery-mootools.html) 10:44:13 INFO - PROCESS | 1947 | RSS: Main: 280641536 10:44:13 INFO - PROCESS | 1947 | 10:47:15 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52110/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52110/tests/dromaeo/cssquery-prototype.html) 10:47:16 INFO - PROCESS | 1947 | RSS: Main: 282415104 10:47:16 INFO - PROCESS | 1947 | 10:50:18 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52110/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52110/tests/dromaeo/cssquery-yui.html) 10:50:19 INFO - PROCESS | 1947 | RSS: Main: 285782016 10:50:19 INFO - PROCESS | 1947 | 10:53:22 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52110/tests/dromaeo/cssquery-yui.html (next: http://localhost:52110/tests/dromaeo/cssquery-dojo.html) 10:53:22 INFO - PROCESS | 1947 | RSS: Main: 285990912 10:53:22 INFO - PROCESS | 1947 | 10:53:22 INFO - PROCESS | 1947 | __start_tp_report 10:53:22 INFO - PROCESS | 1947 | _x_x_mozilla_page_load 10:53:22 INFO - PROCESS | 1947 | _x_x_mozilla_page_load_details 10:53:22 INFO - PROCESS | 1947 | |i|pagename|runs| 10:53:22 INFO - PROCESS | 1947 | |0;dojo.html;2843.6492665983646;3098.349346637206;3461.4807778833174;3487.2851065531568;3496.8776092836747;4205.369194620808;4476.686631935766;5147.922781158286;5720.628159169651;5743;5626.521745651625;5681.147827825828;5697.373288938214;5721.34204566475;5771.278590176228;5164.302819119418;5212;5216.530512253897;5263.289455923459;5270.762815673284;5297.44376840432;5328.333958255218;5359.705216213126;5390.326209223847;5411.675299482024;4241.618254357123;4664.650151238654;4681.250999840026;5102.36220472441;5163.8192663256605;5131.666441681279;5160.458151894072;5167.767450464738;5225.6603320784025;5227.294315267466;5089.745512724386;5138.58891288696;5166.509181627739;5173.76718047685;5205.011047900886;5415.918761218545;5558.138488534284;5566.777328906839;5618.747156377973;5623.297087864017;6172.1667574877265;6234.968825155891;6256.2492500899725;6264.906026409608;6289.433950944437;6146.7541298348015;6157.415045570664;6218.595791273553;6243.625382477066;6251.4061164189325;5842.211301474289;5894.823155305347;5921.940780592225;5929.199558059693;5949.702514874282;6281.59169653971;6290.213723284498;6300.495960323163;6304.527160462983;6318;6055.6063855849225;6095.66473843934;6144.907826382608;6172.808752534631;6199.3490683477585;6242.906356404657;6246.3441338659695;6247.406496382927;6252.187215662026;6269.341719119518;6120.1737765401995;6173.290071641729;6180.907286390618;6193.225846769154;6239.500839932885;6097.887666312796;6113.354685976905;6155.138280640714;6195.845103872439;6297.338779428185;4982.950170498321;4988.002399520038;5007.724575148329;5013.3983921928875;5018.623603229699;4187;4441.933370999438;4485;4489.483709373464;4537.682362234612;5691.402402747652;5716.171155182476;5837.387074357216;5841.357450680422;5859.882802344015;6216.720247588869;6240.063990401385;6249.6562689051625;6250.374962503804;6262.436380725757;5833.912491312633;5836.562257830679;5844.26946631671;5846.736896839652;5876.647401155944;5371.6239863209985;5399.055165346049;5402.540784033323;5406.59450541211;5466.262054622654;4904;5319.441458646941;5674.432556744293;6305.92799224133;6325.620462772248;6122.062734707273;6247.187865577446;6247.812565623039;6264.968675156595;6278.905816412666;6199.070139479114;6214.627122372672;6275.403836635513;6313.116163737172;6330.651814150266;5165.225216217597;6154.538409619386;6223.751049957951;6231.594946328474;6231.937680623136;5136.743162841918;6137.591499645514;6175.228096487939;6238.469730072995;6241.906371404341;6052.697365131814;6110.480609148272;6128.785492507741;6138.786925362591;6204.348543402878;6121.938780612137;6168.814935551941;6172.22847144107;6179.011358182669;6185.226846644169;5823.475887170175;5918.17145599625;6032.225176418897;6066;6087.604305720114;5829.300483941955;6068.4538391544975;6119.877602448015;6122.173506576555;6171.506279497719;4993.925091123563;6057.333693293646;6077.665728384981;6081.695915204134;6083.6653984029535 10:53:22 INFO - PROCESS | 1947 | |1;ext.html;479.9784009719562;487.62452911258333;504.89902019596076;515.5952577226875;551.9613627046108;36332.81833590828;37523;37756;39049.80475097624;40362;41349.75950721483;41969.79015104928;42272;42353.576464235346;43262;8455.830883382328;9626.278029147807;9630.277729170306;9647.372920760163;9664.855027174597;9599.424034557915;9621.759456013586;9623.42259464431;9628.3260171788;9661.95169024154;8004.51972881629;9613.759656008586;9651.227901767877;9654.758631034245;9676.56455459506;9545.04549545047;9564.56959436827;9569.330146889686;9633.710988670386;9658.71023869285;8326.750197494084;8979.86530202041;9598.76003099921;9605.279604029725;9616.75958101053;32282;38917;39333.01667458336;39392;39420.21159576821;3323.5347051412823;3358.2947581008016;3526.100844284691;3614.963850361489;3670.596234414212;24809.379765506008;30215;30894;31132.8443357784;31333.686663133303;3126.8749250029973;3156.2582793043616;3178.284885900677;3180.25264062945;3193.1697758582704;370482;435250;441731;443813.9999999968;444296;34445.48331775025;34544.654553454646;34818.47772283418;34824.30351392958;34891.30217395638;30943.381132377228;35798.82100589533;36047;36164.09589760277;38061.2387752249;16622.75065874013;16657.33370665184;16719.582010449834;16730.247138878778;16737.497875063767;12371.381430928597;12581.37093145339;12717;12718.554850580185;12763.91506721939;20384.89807550953;20494.18023279052;20517.89741051285;20568.177272908917;20643.380698578767;8157.265846073882;8221.013478382632;8221.753347399588;8243.83512329762;8288.751337459886;925.4771054354268;977.5600979559084;984.13396211335;1076.1498416251231;1085.9511321990528;25061.62407563888;25758.613620795702;28698.856505717336;30993.69006309953;31089.844550777554;874.5714599846029;1035.9433377954595;1041.6198087697935;1173.178774857603;1269.6191142657167;14889.404423823142;16161.11113888724;16238.350465981464;16343.26455309514;16378.672426551402;694113;694619;703547;706069;714320;54638.45361546334;55206;58769.70615146897;60170;60456.39543604507;1379.9310034498235;1385.6466601016675;1409.3164815064686;1431.9069260498034;1445.219581426018;27572.862135689193;27689.584656230574;27778;29678.554821678124;30735.2316192097;43883;52500.73749631227;52729.736351317995;52885.7355713219;52899.206511903125;420910;522893;524018;528448;535051;26979.59530607003;27807.860960695067;27843.886244550802;27896.44207115887;27969.021084261953;48743.781405465146;50148.498515014384;50564.49435505598;50813.74593127011;51199.74400127975;39807.00482487845;40883.38674919938;41131.58868411397;41261.58738412578;41322.79338603288;39635.80182099071;40374.798126009184;40525.12323103753;40543.3918491217;41153.38269925894;39313;39492.60507395004;39529;42659.78670106754;43584.78207608942;40508.79745601253;43775.343369848844;43919;44726;44850;26003;30018.399632007673;30585.54121688132;30997.380052399276;31121.066368008997 10:53:22 INFO - PROCESS | 1947 | |2;jquery.html;380.20347372255117;389.04489478330703;389.3186922884951;400.4873761585172;401.01350677333755;19666.311679091217;21046;21309;21672.8916355418;21869.562608747834;20500;20618.587628247427;20787;21623.135074597038;21644;5638.013347664163;5649.265595472593;6015.308239552463;6031.6984150792505;6091.756329746827;3775.18833450808;5183.948160518385;5771.595988280822;6108.358622344635;6131.417515336036;5155.839936014404;6052.788152414666;6133.1413602095745;6157.599756015867;6160.476359509447;5513.807016754395;5897.292324920994;5928.347881733028;5929.73316200772;6006.039033754579;5687.26065611472;5799.072148456269;5935.436133567304;6000.459958603747;6001.729922153513;13330.200187988752;13516.986226032988;13680.794788078187;25010;25805.870970645214;1903.4955736729778;2196.952805648458;2224.377174391173;2340.8244381671443;2441.0967941861445;9953;10000.497388709276;10287.89712102877;10297.279190456671;10405.3756774593;1837.7610910581673;1931.1792488192602;1934.7194656774689;1966.3314473079079;1973.8223559879536;105997;118211.40894295559;124757;126778;131373;9464.337496375188;10421.9478902605;10952.726181845359;11724;11843.88156118445;12436.75126497465;14540.127592344494;14714.779278310834;14758.631034224016;14830.629234269014;6450.032495125769;7826.608669566499;8160.959195203986;8402.915970840335;8689.087645797226;8393.958030209931;8407.8318433631;8423.284020858173;8525.31797456202;8531.914680853237;3778.848846046127;4509.12072145935;4553.271476563734;4619.376384188159;4671.6262698984;1673.2303140555236;1716.695311563221;1808.1140241281678;1936.3319654719098;1954.4625228062396;805.830775537132;882.9161229683169;897.8249241397865;970.6942313171328;1061.2465149743614;19946.102425390603;20411.387658370273;20850;20862.895685521475;21063.368098957057;945.1163162443138;945.2815859946353;955.6225291010151;958.6309270930602;977.310995747996;8907.55462226886;10915.290506117077;11145;11164.888351116548;11175.050120739828;584354;589144;590606;605065;605952.7618895195;105856.47071764746;136025.99999999802;136296;141411.29294353668;141585.29207353896;984.5126662302063;991.4497453913148;1020.9795804084025;1023.7798873242289;1064.1061508332882;18754.343597974006;19193.232270709017;19241;19256.133473993985;19301.710474343177;57027.42972570221;57391;57447.71276143593;57910.4208957905;59254.70372648109;85498;85534.2893142146;85710.57144714237;86488.6755662227;87072;6801.557898736566;8090.543702133672;8170.877436838333;8385.454945428528;8453.830923381374;12321.260724356209;12697.746045078862;12801.29592872401;12815.551455699006;12915.418806153933;10958.45207739594;11011.83482247783;11170;11327;11428.71428214268;9133.725988220363;9267.258619310303;10379.740506487398;10414.323069000491;11459.541618335506;11666.183367164216;11842.105263157853;11869.465874035517;11893.643190704293;11925.165238433226;8286.171382861665;8301.626426810928;8394.328453723809;8419.747407577783;8473;8288.544130072903;10589.682309530726;11323.263987840764;11600.361980091177;11655.650330490098 10:53:22 INFO - PROCESS | 1947 | |3;mootools.html;1538.4384699584648;1580.2888700084961;1596.784434101396;1692.162379622088;1922.2599299269793;7880.2513761192595;8405.159484051599;8416.368772342068;8907.510086945224;8918.554072296383;8502.744917652464;8545.65817367306;8700.129472163499;8700.912990870089;8722.21500064994;2344.70691163605;2364.420716924356;2372.264597974625;2379.2505360811288;2383.034870877289;2336.380859072347;2365.124903785602;2365.846219995695;2390;2395.6167013277877;2358.2099996501192;2362.8582285062867;2363.326451961191;2369.490559529701;2386.570417324881;2343.121329501437;2347.495288512969;2348.56551537966;2352.647102934565;2360.7403185649564;2087.217293514932;2342.6837376954063;2357.587422201108;2361.9135197808855;2363.0311572255464;8602.569871506463;8613.397062205648;8649.351298652626;8737.475751454933;8739.126087391274;5167.276581278624;5290.656107353048;5325.3077099977145;5333.413324534298;5344.824138689521;3389.254364039907;3432.3650124726755;3536.3634545781747;3605.4952306677087;3638.2359704462096;1091.2252300866394;1094;1098.5111625326733;1098.730810951314;1106.5352551928129;11364.602238921598;11388;11408.030317423028;11408.258463199865;11422.600208992728;4615.284630882152;4619.6073333766335;4742.217534106902;4748.928766068511;4761.833335833298;9713.805723885624;9755.853662195073;9761.658341957997;9775;9788.070133337322;5197.7661005254095;5215.869603259873;5272.288241087481;5294.232336311214;5306.628536002443;4332.761698106634;4686.297055441642;4782.402199725035;4848.17581011229;4854.077725232195;3302.884399046022;3909.179072394829;4029.6097846243;4038.7172897897453;4054.2094291613444;1283.23647429781;1304.3217526886156;1307.9738405232033;1316.9934150329186;1326.071749775142;870.2254993056185;954.346272803132;970.6020531582018;972.2950860626131;997.6009596161448;5879.2944846618675;5920.348761636216;5927.4665280125;5997.580169388189;6047.213862197974;439.87463572882217;442.7343593843668;454.32759515916626;455.59224494077614;456.24035980093436;3514.2268700885766;3991.2815693174925;4070;4082.3876418537457;4086.6730661547003;10000.499975001221;10011.599536018623;10385.324953877975;10399.84400233997;10568.630097946689;9103.544822758968;9114.680986165453;10328.018838210359;10426.165906727443;10516.000979906896;6819.829504262433;8041.195880412029;8054.718084867119;8145.226203510657;8149.144339844231;5035.84892453227;5998.280206375263;6117.235345581802;6152.384761523812;6230.470410015199;9651.565679544578;9830.016998300112;9864.161546268648;9883.654072107442;9931.65239216624;8170.959145204473;9889.604415823287;9902.653407130716;10059.446730429896;10149.289549731448;6295.748170073146;6932.341427564374;7524.209957954336;7585.279398457138;7713.7685869424;8253.09215986229;8274.834503310021;8292.58537073156;8347.791305217175;8392.580370981304;7301.707931682673;7481.88777168332;7492.737754178577;7505.66224519887;7566.394688424803;7321.560706357635;7359.558426494427;7413.184549699421;7480.925190748023;7486.213947535431;6944.305569443015;6980.267071957372;6986.510944233854;7010.369066784014;7058.082449281561;4487.394201782718;4817.27740838877;4953.925691114709;5000.12497812874;5142.665726727751;4989.12690279207;5008.148614735431;5056.443791183041;5101.540861322499;5199.116150254541 10:53:22 INFO - PROCESS | 1947 | |4;prototype.html;267.56119963260255;278.2473409427499;313.5453592291178;318.39346045782776;329.3692578711767;4968.354113965189;5642.238297829792;5689.3172819261745;5709.286339207599;5718.199452076713;4909.435414927284;4924.679895806779;5542.584306177033;5555.944440555593;5668.68822214778;3336.699697027267;3989.7606143631474;4016.7589944603346;4230.74615523068;4254.723442976212;3874.2057878134915;3914.588968158345;4184.100418410041;4258.850940217093;4260.70175087744;3705.2589482103554;4015.337469317559;4225.387318838767;4227.767472789011;4241.448611680477;3642.1076836175043;4056.9391459128137;4212.209810830415;4228.4080228768;4230.407742915994;2937.735603795669;3636.254567813592;3649.7262705296944;3651.214988777399;3662.1393972416463;5293.841184764463;5386.703731294777;5387.892242155135;5405.324334458192;5422.213779002022;4427.845025424127;4465.419495465601;4884.877878053042;4904.264360345941;4926.556609905126;4927.728974906378;5575.916361254584;5851.8537036574;5911.290645122613;5922.3485416604135;3947.3289540778137;3949.6445319921345;3956.7823769692654;3965.3457179565626;3972.82122304497;5970.6716130612795;5971.790987315467;6195.265325708809;6234.812955611339;6274.968625156891;3407.9946415807394;3577.499150118985;4010.3984402339884;4018.095928416083;4018.4976877890263;3460.8442620082155;3498.3877821381157;4054.655354294859;4067.4206698105477;4082.6529744971417;4144.730592511477;4419.977900110479;4634.884127896829;4802.142725078573;4821.228603423506;4926.605871530269;5715.571332150105;5893.469587737124;6002.879942401128;6020.789272375533;1136.3295655563256;1183.8638556565934;1186.32379543661;1256.1960345378964;1376.2980879751399;751.0911796725914;775.6697264191938;816.4896939412866;829.7469271872017;883.6553744039829;4678.719276843401;5032.572231360376;5486.930048640476;5487.670739755627;5496;4935.777889994959;5651.2935883014625;5970.522358211333;6031.819045428644;6088.194878201124;4435.467743870756;5048.217526283432;5124.487551244845;5362.249285100089;5500.697461639648;2730.948584794868;2741.753242208211;2952.099609619087;3184.219866132766;3184.442722523549;5316.760745766373;5772;6275.717592708248;6285.937140628535;6325.968370158212;5165.535101840853;5488.17677348401;5646.4353564644025;6064.545159113084;6305.716242769086;5418.647787893696;5657;6159.5072394208355;6346.3019067903415;6415.871682566416;5008.373953255843;5055.570276526537;5833.329167145833;5891.941080589139;6231.3145553988115;5404.243405923095;5582.794796055454;5852.736626851717;5882.176495290748;5995.830812991425;5867.178594996789;6149.569530132848;6221.569039120937;6396.667299373679;6430.517711171775;3980.6266837940866;3993.92012159761;3996.460477835455;4011.799410029545;4024.1348110156455;5611;5719.742611582572;6067.878642427038;6132.78535251264;6142.416470435302;5643.266375371176;5933.643981361132;5935.643861368331;5996.730147143477;6011.939880601138;5466.835994920159;5715.9142612860005;5949.6430214187285;6001.189839371629;6014.248218972629;5360.303160589098;5595.216669666169;5723;5746.454086861741;5857.326407463196;5371.677699338053;5920.875033743747;5975.282966044103;5982.1455348842;5985.910211346746;5528.391876893619;5579.553635709052;5815.82552523425;5860.09168578871;5889.852753681193 10:53:22 INFO - PROCESS | 1947 | |5;yui.html;695.8886578147498;741.6069483173916;792.9246721561453;852.9147085291468;871.8692196170572;13869.751722344987;14930.253487325632;15713.607159821011;15749.055056696578;16307;13355;14775.92612036941;14857.628559285997;14939.775903361431;14954.177520236382;723.8769409200422;745.3776096959032;899.4333569850985;918.7197904639082;934.957926893288;776.1501156233915;880.8634661627458;913.6710784117712;940.6237504997987;945.7635591102224;990.5443495991852;991.4447909170851;993.4287784523891;997.2470784557685;998.346083315426;939.3800091939355;942.4580866002076;986.5264672956985;994.8557459168417;995.4077323992285;725.9111333000499;734.2363941500832;734.4124700239787;735.91904890462;736.5985537881867;14769;14836.109833409922;14867.628309292246;14873.256337183098;14913.850861491355;12440.688982775502;14579.927100364537;14630.414783408758;14658.486952956595;14748;10070.647527336509;11844.763104737856;11931.522739090426;12097.818532722016;12273.140880138393;3798;3854.094287842355;3863.3267370053973;3899.6100389960775;4027.476428064362;94957.5252123735;96383.55424668636;98477.03045939041;100182.49908750482;101069.49465252626;9404.90595094054;11063.502142403611;11265.54937802495;11342.829857552144;11405.885941140648;21845.45386365322;22357.329280121623;22547.774522254567;22559.43601409945;22609.54780904373;6811.352921472452;8133.715319963773;8189.7133600323705;8225.190458099209;8227.382946279053;3859.864904728377;4527.977360113178;4569.314602809539;4656.650751193606;4759.9524004759505;3625.4380571011534;3715.108373990223;3753.60587138352;3756.417755247941;3757.342465068602;661.1735330836455;674.2987293215001;674.8953912143626;691.4744793956529;692.3076923076923;647.7894684227645;665.3845193196274;675.2740803636111;694.4201591671011;707.8902770070647;7842.686292548348;8929.374943753875;9077.96030766316;9127.726168214964;9136.771580710403;578.7569220927137;603.3604379357807;645.1161908185816;680.792358330704;687.8246047258017;3917.4515567820526;4584.747838868828;4632.814687412533;4675;4710.882227944328;142153;143911;144798;146222;148718.51281487045;115516.42241788737;129395;130982;131019.34490327488;133177;110486;111208;111781.44109279402;112525;113034;8538.615762290836;9054;9079.727608171765;9093.884189335306;9198.26413886874;41779.74660760182;52255.21617175821;53235.201471977176;56151;57154;70403.64798175976;71083;85122;85490.57254713686;87142;12075.215111017756;12129.514819407124;12234.571789987664;12262.448189831657;12805.423755930819;13281.933590332374;13366.131201471873;13784.172949623055;13917.791233131713;13925.651858703208;12265.080118990933;12299.754004919672;12458.875411246134;12784.360781960679;12855.292958886977;12309.630711078682;12498.687532811753;12550.62348129521;12656.74686506283;12922.224666519664;12203.267803931793;12277.386130693609;12303.138780285293;12481.937590312353;12520.060995425561;10405.531751071372;10501.002404771534;10520.00614277998;10562.788744225227;10564.154867610727;10516.421596812248;10601.575936962436;10604.310719803188;10635.94682026585;10758.46207689628 10:53:22 INFO - PROCESS | 1947 | __end_tp_report 10:53:22 INFO - PROCESS | 1947 | __start_cc_report 10:53:22 INFO - PROCESS | 1947 | _x_x_mozilla_cycle_collect,424 10:53:22 INFO - PROCESS | 1947 | __end_cc_report 10:53:22 INFO - PROCESS | 1947 | __startTimestamp1464890002358__endTimestamp 10:53:22 INFO - PROCESS | 1947 | 10:53:22 INFO - PROCESS | 1947 | ------- Summary: start ------- 10:53:22 INFO - PROCESS | 1947 | Number of tests: 6 10:53:22 INFO - PROCESS | 1947 | 10:53:22 INFO - PROCESS | 1947 | [#0] dojo.html Cycles:165 Average:5690.51 Median:5929.20 stddev:685.40 (11.6%) stddev-sans-first:650.10 10:53:22 INFO - PROCESS | 1947 | Values: 2843.6 3098.3 3461.5 3487.3 3496.9 4205.4 4476.7 5147.9 5720.6 5743.0 5626.5 5681.1 5697.4 5721.3 5771.3 5164.3 5212.0 5216.5 5263.3 5270.8 5297.4 5328.3 5359.7 5390.3 5411.7 4241.6 4664.7 4681.3 5102.4 5163.8 5131.7 5160.5 5167.8 5225.7 5227.3 5089.7 5138.6 5166.5 5173.8 5205.0 5415.9 5558.1 5566.8 5618.7 5623.3 6172.2 6235.0 6256.2 6264.9 6289.4 6146.8 6157.4 6218.6 6243.6 6251.4 5842.2 5894.8 5921.9 5929.2 5949.7 6281.6 6290.2 6300.5 6304.5 6318.0 6055.6 6095.7 6144.9 6172.8 6199.3 6242.9 6246.3 6247.4 6252.2 6269.3 6120.2 6173.3 6180.9 6193.2 6239.5 6097.9 6113.4 6155.1 6195.8 6297.3 4983.0 4988.0 5007.7 5013.4 5018.6 4187.0 4441.9 4485.0 4489.5 4537.7 5691.4 5716.2 5837.4 5841.4 5859.9 6216.7 6240.1 6249.7 6250.4 6262.4 5833.9 5836.6 5844.3 5846.7 5876.6 5371.6 5399.1 5402.5 5406.6 5466.3 4904.0 5319.4 5674.4 6305.9 6325.6 6122.1 6247.2 6247.8 6265.0 6278.9 6199.1 6214.6 6275.4 6313.1 6330.7 5165.2 6154.5 6223.8 6231.6 6231.9 5136.7 6137.6 6175.2 6238.5 6241.9 6052.7 6110.5 6128.8 6138.8 6204.3 6121.9 6168.8 6172.2 6179.0 6185.2 5823.5 5918.2 6032.2 6066.0 6087.6 5829.3 6068.5 6119.9 6122.2 6171.5 4993.9 6057.3 6077.7 6081.7 6083.7 10:53:22 INFO - PROCESS | 1947 | 10:53:22 INFO - PROCESS | 1947 | [#1] ext.html Cycles:180 Average:67369.67 Median:40084.50 stddev:149483.57 (372.9%) stddev-sans-first:149818.55 10:53:22 INFO - PROCESS | 1947 | Values: 480.0 487.6 504.9 515.6 552.0 36332.8 37523.0 37756.0 39049.8 40362.0 41349.8 41969.8 42272.0 42353.6 43262.0 8455.8 9626.3 9630.3 9647.4 9664.9 9599.4 9621.8 9623.4 9628.3 9662.0 8004.5 9613.8 9651.2 9654.8 9676.6 9545.0 9564.6 9569.3 9633.7 9658.7 8326.8 8979.9 9598.8 9605.3 9616.8 32282.0 38917.0 39333.0 39392.0 39420.2 3323.5 3358.3 3526.1 3615.0 3670.6 24809.4 30215.0 30894.0 31132.8 31333.7 3126.9 3156.3 3178.3 3180.3 3193.2 370482.0 435250.0 441731.0 443814.0 444296.0 34445.5 34544.7 34818.5 34824.3 34891.3 30943.4 35798.8 36047.0 36164.1 38061.2 16622.8 16657.3 16719.6 16730.2 16737.5 12371.4 12581.4 12717.0 12718.6 12763.9 20384.9 20494.2 20517.9 20568.2 20643.4 8157.3 8221.0 8221.8 8243.8 8288.8 925.5 977.6 984.1 1076.1 1086.0 25061.6 25758.6 28698.9 30993.7 31089.8 874.6 1035.9 1041.6 1173.2 1269.6 14889.4 16161.1 16238.4 16343.3 16378.7 694113.0 694619.0 703547.0 706069.0 714320.0 54638.5 55206.0 58769.7 60170.0 60456.4 1379.9 1385.6 1409.3 1431.9 1445.2 27572.9 27689.6 27778.0 29678.6 30735.2 43883.0 52500.7 52729.7 52885.7 52899.2 420910.0 522893.0 524018.0 528448.0 535051.0 26979.6 27807.9 27843.9 27896.4 27969.0 48743.8 50148.5 50564.5 50813.7 51199.7 39807.0 40883.4 41131.6 41261.6 41322.8 39635.8 40374.8 40525.1 40543.4 41153.4 39313.0 39492.6 39529.0 42659.8 43584.8 40508.8 43775.3 43919.0 44726.0 44850.0 26003.0 30018.4 30585.5 30997.4 31121.1 10:53:22 INFO - PROCESS | 1947 | 10:53:22 INFO - PROCESS | 1947 | [#2] jquery.html Cycles:180 Average:35295.37 Median:13725.55 stddev:99752.36 (726.8%) stddev-sans-first:99997.74 10:53:22 INFO - PROCESS | 1947 | Values: 380.2 389.0 389.3 400.5 401.0 19666.3 21046.0 21309.0 21672.9 21869.6 20500.0 20618.6 20787.0 21623.1 21644.0 5638.0 5649.3 6015.3 6031.7 6091.8 3775.2 5183.9 5771.6 6108.4 6131.4 5155.8 6052.8 6133.1 6157.6 6160.5 5513.8 5897.3 5928.3 5929.7 6006.0 5687.3 5799.1 5935.4 6000.5 6001.7 13330.2 13517.0 13680.8 25010.0 25805.9 1903.5 2197.0 2224.4 2340.8 2441.1 9953.0 10000.5 10287.9 10297.3 10405.4 1837.8 1931.2 1934.7 1966.3 1973.8 105997.0 118211.4 124757.0 126778.0 131373.0 9464.3 10421.9 10952.7 11724.0 11843.9 12436.8 14540.1 14714.8 14758.6 14830.6 6450.0 7826.6 8161.0 8402.9 8689.1 8394.0 8407.8 8423.3 8525.3 8531.9 3778.8 4509.1 4553.3 4619.4 4671.6 1673.2 1716.7 1808.1 1936.3 1954.5 805.8 882.9 897.8 970.7 1061.2 19946.1 20411.4 20850.0 20862.9 21063.4 945.1 945.3 955.6 958.6 977.3 8907.6 10915.3 11145.0 11164.9 11175.1 584354.0 589144.0 590606.0 605065.0 605952.8 105856.5 136026.0 136296.0 141411.3 141585.3 984.5 991.4 1021.0 1023.8 1064.1 18754.3 19193.2 19241.0 19256.1 19301.7 57027.4 57391.0 57447.7 57910.4 59254.7 85498.0 85534.3 85710.6 86488.7 87072.0 6801.6 8090.5 8170.9 8385.5 8453.8 12321.3 12697.7 12801.3 12815.6 12915.4 10958.5 11011.8 11170.0 11327.0 11428.7 9133.7 9267.3 10379.7 10414.3 11459.5 11666.2 11842.1 11869.5 11893.6 11925.2 8286.2 8301.6 8394.3 8419.7 8473.0 8288.5 10589.7 11323.3 11600.4 11655.7 10:53:22 INFO - PROCESS | 1947 | 10:53:22 INFO - PROCESS | 1947 | [#3] mootools.html Cycles:180 Average:5616.01 Median:5022.00 stddev:3110.35 (61.9%) stddev-sans-first:3103.98 10:53:22 INFO - PROCESS | 1947 | Values: 1538.4 1580.3 1596.8 1692.2 1922.3 7880.3 8405.2 8416.4 8907.5 8918.6 8502.7 8545.7 8700.1 8700.9 8722.2 2344.7 2364.4 2372.3 2379.3 2383.0 2336.4 2365.1 2365.8 2390.0 2395.6 2358.2 2362.9 2363.3 2369.5 2386.6 2343.1 2347.5 2348.6 2352.6 2360.7 2087.2 2342.7 2357.6 2361.9 2363.0 8602.6 8613.4 8649.4 8737.5 8739.1 5167.3 5290.7 5325.3 5333.4 5344.8 3389.3 3432.4 3536.4 3605.5 3638.2 1091.2 1094.0 1098.5 1098.7 1106.5 11364.6 11388.0 11408.0 11408.3 11422.6 4615.3 4619.6 4742.2 4748.9 4761.8 9713.8 9755.9 9761.7 9775.0 9788.1 5197.8 5215.9 5272.3 5294.2 5306.6 4332.8 4686.3 4782.4 4848.2 4854.1 3302.9 3909.2 4029.6 4038.7 4054.2 1283.2 1304.3 1308.0 1317.0 1326.1 870.2 954.3 970.6 972.3 997.6 5879.3 5920.3 5927.5 5997.6 6047.2 439.9 442.7 454.3 455.6 456.2 3514.2 3991.3 4070.0 4082.4 4086.7 10000.5 10011.6 10385.3 10399.8 10568.6 9103.5 9114.7 10328.0 10426.2 10516.0 6819.8 8041.2 8054.7 8145.2 8149.1 5035.8 5998.3 6117.2 6152.4 6230.5 9651.6 9830.0 9864.2 9883.7 9931.7 8171.0 9889.6 9902.7 10059.4 10149.3 6295.7 6932.3 7524.2 7585.3 7713.8 8253.1 8274.8 8292.6 8347.8 8392.6 7301.7 7481.9 7492.7 7505.7 7566.4 7321.6 7359.6 7413.2 7480.9 7486.2 6944.3 6980.3 6986.5 7010.4 7058.1 4487.4 4817.3 4953.9 5000.1 5142.7 4989.1 5008.1 5056.4 5101.5 5199.1 10:53:22 INFO - PROCESS | 1947 | 10:53:22 INFO - PROCESS | 1947 | [#4] prototype.html Cycles:180 Average:4719.45 Median:5396.07 stddev:1504.71 (27.9%) stddev-sans-first:1471.36 10:53:22 INFO - PROCESS | 1947 | Values: 267.6 278.2 313.5 318.4 329.4 4968.4 5642.2 5689.3 5709.3 5718.2 4909.4 4924.7 5542.6 5555.9 5668.7 3336.7 3989.8 4016.8 4230.7 4254.7 3874.2 3914.6 4184.1 4258.9 4260.7 3705.3 4015.3 4225.4 4227.8 4241.4 3642.1 4056.9 4212.2 4228.4 4230.4 2937.7 3636.3 3649.7 3651.2 3662.1 5293.8 5386.7 5387.9 5405.3 5422.2 4427.8 4465.4 4884.9 4904.3 4926.6 4927.7 5575.9 5851.9 5911.3 5922.3 3947.3 3949.6 3956.8 3965.3 3972.8 5970.7 5971.8 6195.3 6234.8 6275.0 3408.0 3577.5 4010.4 4018.1 4018.5 3460.8 3498.4 4054.7 4067.4 4082.7 4144.7 4420.0 4634.9 4802.1 4821.2 4926.6 5715.6 5893.5 6002.9 6020.8 1136.3 1183.9 1186.3 1256.2 1376.3 751.1 775.7 816.5 829.7 883.7 4678.7 5032.6 5486.9 5487.7 5496.0 4935.8 5651.3 5970.5 6031.8 6088.2 4435.5 5048.2 5124.5 5362.2 5500.7 2730.9 2741.8 2952.1 3184.2 3184.4 5316.8 5772.0 6275.7 6285.9 6326.0 5165.5 5488.2 5646.4 6064.5 6305.7 5418.6 5657.0 6159.5 6346.3 6415.9 5008.4 5055.6 5833.3 5891.9 6231.3 5404.2 5582.8 5852.7 5882.2 5995.8 5867.2 6149.6 6221.6 6396.7 6430.5 3980.6 3993.9 3996.5 4011.8 4024.1 5611.0 5719.7 6067.9 6132.8 6142.4 5643.3 5933.6 5935.6 5996.7 6011.9 5466.8 5715.9 5949.6 6001.2 6014.2 5360.3 5595.2 5723.0 5746.5 5857.3 5371.7 5920.9 5975.3 5982.1 5985.9 5528.4 5579.6 5815.8 5860.1 5889.9 10:53:22 INFO - PROCESS | 1947 | 10:53:22 INFO - PROCESS | 1947 | [#5] yui.html Cycles:180 Average:23698.70 Median:3777.67 stddev:37954.81 (1004.7%) stddev-sans-first:38021.99 10:53:22 INFO - PROCESS | 1947 | Values: 695.9 741.6 792.9 852.9 871.9 13869.8 14930.3 15713.6 15749.1 16307.0 13355.0 14775.9 14857.6 14939.8 14954.2 723.9 745.4 899.4 918.7 935.0 776.2 880.9 913.7 940.6 945.8 990.5 991.4 993.4 997.2 998.3 939.4 942.5 986.5 994.9 995.4 725.9 734.2 734.4 735.9 736.6 14769.0 14836.1 14867.6 14873.3 14913.9 12440.7 14579.9 14630.4 14658.5 14748.0 10070.6 11844.8 11931.5 12097.8 12273.1 3798.0 3854.1 3863.3 3899.6 4027.5 94957.5 96383.6 98477.0 100182.5 101069.5 9404.9 11063.5 11265.5 11342.8 11405.9 21845.5 22357.3 22547.8 22559.4 22609.5 6811.4 8133.7 8189.7 8225.2 8227.4 3859.9 4528.0 4569.3 4656.7 4760.0 3625.4 3715.1 3753.6 3756.4 3757.3 661.2 674.3 674.9 691.5 692.3 647.8 665.4 675.3 694.4 707.9 7842.7 8929.4 9078.0 9127.7 9136.8 578.8 603.4 645.1 680.8 687.8 3917.5 4584.7 4632.8 4675.0 4710.9 142153.0 143911.0 144798.0 146222.0 148718.5 115516.4 129395.0 130982.0 131019.3 133177.0 110486.0 111208.0 111781.4 112525.0 113034.0 8538.6 9054.0 9079.7 9093.9 9198.3 41779.7 52255.2 53235.2 56151.0 57154.0 70403.6 71083.0 85122.0 85490.6 87142.0 12075.2 12129.5 12234.6 12262.4 12805.4 13281.9 13366.1 13784.2 13917.8 13925.7 12265.1 12299.8 12458.9 12784.4 12855.3 12309.6 12498.7 12550.6 12656.7 12922.2 12203.3 12277.4 12303.1 12481.9 12520.1 10405.5 10501.0 10520.0 10562.8 10564.2 10516.4 10601.6 10604.3 10635.9 10758.5 10:53:22 INFO - PROCESS | 1947 | -------- Summary: end -------- 10:53:22 INFO - PROCESS | 1947 | 10:53:22 INFO - TEST-INFO | 1947: exit 0 10:53:22 INFO - TEST-OK | dromaeo_css | took 1112500ms 10:53:22 INFO - TEST-START | kraken 10:53:22 INFO - operating with platform_type : mac_ 10:53:22 INFO - Initialising browser for kraken test... 10:53:22 INFO - TEST-INFO | started process 1952 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpxZy3i5/profile http://localhost:52110/getInfo.html) 10:53:25 INFO - PROCESS | 1952 | __metrics Screen width/height:1600/1200 10:53:25 INFO - PROCESS | 1952 | colorDepth:24 10:53:25 INFO - PROCESS | 1952 | Browser inner width/height: 1024/689 10:53:25 INFO - PROCESS | 1952 | __metrics 10:53:25 ERROR - PROCESS | 1952 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 10:53:26 INFO - TEST-INFO | 1952: exit 0 10:53:26 INFO - Browser initialized. 10:53:26 INFO - Running cycle 1/1 for kraken test... 10:53:26 INFO - TEST-INFO | started process 1954 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpxZy3i5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:53:38 INFO - PROCESS | 1954 | RSS: Main: 252899328 10:53:38 INFO - PROCESS | 1954 | 10:53:41 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:52110/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52110/tests/kraken/driver.html?testName=audio-beat-detection) 10:53:42 INFO - PROCESS | 1954 | RSS: Main: 265744384 10:53:42 INFO - PROCESS | 1954 | 10:53:45 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:52110/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52110/tests/kraken/driver.html?testName=audio-dft) 10:53:45 INFO - PROCESS | 1954 | RSS: Main: 269856768 10:53:45 INFO - PROCESS | 1954 | 10:53:49 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:52110/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52110/tests/kraken/driver.html?testName=audio-fft) 10:53:49 INFO - PROCESS | 1954 | RSS: Main: 270356480 10:53:49 INFO - PROCESS | 1954 | 10:53:51 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:52110/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52110/tests/kraken/driver.html?testName=audio-oscillator) 10:53:52 INFO - PROCESS | 1954 | RSS: Main: 271245312 10:53:52 INFO - PROCESS | 1954 | 10:53:54 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:52110/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52110/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:53:55 INFO - PROCESS | 1954 | RSS: Main: 271847424 10:53:55 INFO - PROCESS | 1954 | 10:53:57 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:52110/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52110/tests/kraken/driver.html?testName=imaging-darkroom) 10:53:58 INFO - PROCESS | 1954 | RSS: Main: 272326656 10:53:58 INFO - PROCESS | 1954 | 10:54:01 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:52110/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52110/tests/kraken/driver.html?testName=imaging-desaturate) 10:54:02 INFO - PROCESS | 1954 | RSS: Main: 272785408 10:54:02 INFO - PROCESS | 1954 | 10:54:05 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:52110/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52110/tests/kraken/driver.html?testName=json-parse-financial) 10:54:06 INFO - PROCESS | 1954 | RSS: Main: 272769024 10:54:06 INFO - PROCESS | 1954 | 10:54:07 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:52110/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52110/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:54:08 INFO - PROCESS | 1954 | RSS: Main: 272527360 10:54:08 INFO - PROCESS | 1954 | 10:54:10 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:52110/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52110/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:54:11 INFO - PROCESS | 1954 | RSS: Main: 272125952 10:54:11 INFO - PROCESS | 1954 | 10:54:13 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:52110/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52110/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:54:14 INFO - PROCESS | 1954 | RSS: Main: 272232448 10:54:14 INFO - PROCESS | 1954 | 10:54:17 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:52110/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52110/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:54:17 INFO - PROCESS | 1954 | RSS: Main: 272293888 10:54:17 INFO - PROCESS | 1954 | 10:54:20 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:52110/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52110/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:54:21 INFO - PROCESS | 1954 | RSS: Main: 272216064 10:54:21 INFO - PROCESS | 1954 | 10:54:23 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:52110/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52110/tests/kraken/driver.html?testName=ai-astar) 10:54:23 INFO - PROCESS | 1954 | RSS: Main: 273162240 10:54:23 INFO - PROCESS | 1954 | 10:54:23 INFO - PROCESS | 1954 | __start_tp_report 10:54:23 INFO - PROCESS | 1954 | _x_x_mozilla_page_load 10:54:23 INFO - PROCESS | 1954 | _x_x_mozilla_page_load_details 10:54:23 INFO - PROCESS | 1954 | |i|pagename|runs| 10:54:23 INFO - PROCESS | 1954 | |0;ai-astar;115;109;116;124;167;115;115;117;118;115 10:54:23 INFO - PROCESS | 1954 | |1;audio-beat-detection;155;123;163;192;117;144;152;146;199;125 10:54:23 INFO - PROCESS | 1954 | |2;audio-dft;204;166;235;266;195;194;203;196;199;195 10:54:23 INFO - PROCESS | 1954 | |3;audio-fft;72;80;75;161;83;57;58;59;124;75 10:54:23 INFO - PROCESS | 1954 | |4;audio-oscillator;69;70;117;83;100;127;108;101;106;152 10:54:23 INFO - PROCESS | 1954 | |5;imaging-gaussian-blur;87;85;93;86;81;131;89;85;88;85 10:54:23 INFO - PROCESS | 1954 | |6;imaging-darkroom;122;154;95;124;90;142;150;95;102;111 10:54:23 INFO - PROCESS | 1954 | |7;imaging-desaturate;114;115;89;109;118;132;104;92;92;90 10:54:23 INFO - PROCESS | 1954 | |8;json-parse-financial;56;60;55;57;57;58;61;76;87;76 10:54:23 INFO - PROCESS | 1954 | |9;json-stringify-tinderbox;67;70;69;77;79;99;110;96;74;71 10:54:23 INFO - PROCESS | 1954 | |10;stanford-crypto-aes;79;83;77;78;101;108;110;112;146;86 10:54:23 INFO - PROCESS | 1954 | |11;stanford-crypto-ccm;143;159;152;156;134;159;162;151;160;135 10:54:23 INFO - PROCESS | 1954 | |12;stanford-crypto-pbkdf2;164;170;172;166;214;232;204;168;163;168 10:54:23 INFO - PROCESS | 1954 | |13;stanford-crypto-sha256-iterative;64;90;90;95;84;68;68;68;67;69 10:54:23 INFO - PROCESS | 1954 | __end_tp_report 10:54:23 INFO - PROCESS | 1954 | __start_cc_report 10:54:23 INFO - PROCESS | 1954 | _x_x_mozilla_cycle_collect,1074 10:54:23 INFO - PROCESS | 1954 | __end_cc_report 10:54:23 INFO - PROCESS | 1954 | __startTimestamp1464890063304__endTimestamp 10:54:23 INFO - PROCESS | 1954 | 10:54:23 INFO - PROCESS | 1954 | ------- Summary: start ------- 10:54:23 INFO - PROCESS | 1954 | Number of tests: 14 10:54:23 INFO - PROCESS | 1954 | 10:54:23 INFO - PROCESS | 1954 | [#0] ai-astar Cycles:10 Average:121.10 Median:116.50 stddev:16.54 (14.2%) stddev-sans-first:17.40 10:54:23 INFO - PROCESS | 1954 | Values: 115.0 109.0 116.0 124.0 167.0 115.0 115.0 117.0 118.0 115.0 10:54:23 INFO - PROCESS | 1954 | 10:54:23 INFO - PROCESS | 1954 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:153.50 stddev:27.55 (17.9%) stddev-sans-first:29.20 10:54:23 INFO - PROCESS | 1954 | Values: 155.0 123.0 163.0 192.0 117.0 144.0 152.0 146.0 199.0 125.0 10:54:23 INFO - PROCESS | 1954 | 10:54:23 INFO - PROCESS | 1954 | [#2] audio-dft Cycles:10 Average:205.30 Median:201.00 stddev:27.05 (13.5%) stddev-sans-first:28.68 10:54:23 INFO - PROCESS | 1954 | Values: 204.0 166.0 235.0 266.0 195.0 194.0 203.0 196.0 199.0 195.0 10:54:23 INFO - PROCESS | 1954 | 10:54:23 INFO - PROCESS | 1954 | [#3] audio-fft Cycles:10 Average:84.40 Median:73.50 stddev:33.13 (45.1%) stddev-sans-first:34.84 10:54:23 INFO - PROCESS | 1954 | Values: 72.0 80.0 75.0 161.0 83.0 57.0 58.0 59.0 124.0 75.0 10:54:23 INFO - PROCESS | 1954 | 10:54:23 INFO - PROCESS | 1954 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:139.50 stddev:25.53 (18.3%) stddev-sans-first:23.87 10:54:23 INFO - PROCESS | 1954 | Values: 69.0 70.0 117.0 83.0 100.0 127.0 108.0 101.0 106.0 152.0 10:54:23 INFO - PROCESS | 1954 | 10:54:23 INFO - PROCESS | 1954 | [#5] imaging-gaussian-blur Cycles:10 Average:91.00 Median:86.50 stddev:14.40 (16.6%) stddev-sans-first:15.20 10:54:23 INFO - PROCESS | 1954 | Values: 87.0 85.0 93.0 86.0 81.0 131.0 89.0 85.0 88.0 85.0 10:54:23 INFO - PROCESS | 1954 | 10:54:23 INFO - PROCESS | 1954 | [#6] imaging-darkroom Cycles:10 Average:118.50 Median:152.00 stddev:23.79 (15.6%) stddev-sans-first:25.20 10:54:23 INFO - PROCESS | 1954 | Values: 122.0 154.0 95.0 124.0 90.0 142.0 150.0 95.0 102.0 111.0 10:54:23 INFO - PROCESS | 1954 | 10:54:23 INFO - PROCESS | 1954 | [#7] imaging-desaturate Cycles:10 Average:105.50 Median:110.50 stddev:14.58 (13.2%) stddev-sans-first:15.13 10:54:23 INFO - PROCESS | 1954 | Values: 114.0 115.0 89.0 109.0 118.0 132.0 104.0 92.0 92.0 90.0 10:54:23 INFO - PROCESS | 1954 | 10:54:23 INFO - PROCESS | 1954 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:60.50 stddev:11.16 (18.4%) stddev-sans-first:11.42 10:54:23 INFO - PROCESS | 1954 | Values: 56.0 60.0 55.0 57.0 57.0 58.0 61.0 76.0 87.0 76.0 10:54:23 INFO - PROCESS | 1954 | 10:54:23 INFO - PROCESS | 1954 | [#9] json-stringify-tinderbox Cycles:10 Average:81.20 Median:75.50 stddev:14.98 (19.8%) stddev-sans-first:14.98 10:54:23 INFO - PROCESS | 1954 | Values: 67.0 70.0 69.0 77.0 79.0 99.0 110.0 96.0 74.0 71.0 10:54:23 INFO - PROCESS | 1954 | 10:54:23 INFO - PROCESS | 1954 | [#10] stanford-crypto-aes Cycles:10 Average:98.00 Median:77.50 stddev:21.92 (28.3%) stddev-sans-first:22.14 10:54:23 INFO - PROCESS | 1954 | Values: 79.0 83.0 77.0 78.0 101.0 108.0 110.0 112.0 146.0 86.0 10:54:23 INFO - PROCESS | 1954 | 10:54:23 INFO - PROCESS | 1954 | [#11] stanford-crypto-ccm Cycles:10 Average:151.10 Median:157.50 stddev:10.35 (6.6%) stddev-sans-first:10.56 10:54:23 INFO - PROCESS | 1954 | Values: 143.0 159.0 152.0 156.0 134.0 159.0 162.0 151.0 160.0 135.0 10:54:23 INFO - PROCESS | 1954 | 10:54:23 INFO - PROCESS | 1954 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.10 Median:171.00 stddev:24.91 (14.6%) stddev-sans-first:25.55 10:54:23 INFO - PROCESS | 1954 | Values: 164.0 170.0 172.0 166.0 214.0 232.0 204.0 168.0 163.0 168.0 10:54:23 INFO - PROCESS | 1954 | 10:54:23 INFO - PROCESS | 1954 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.30 Median:76.50 stddev:11.94 (15.6%) stddev-sans-first:11.80 10:54:23 INFO - PROCESS | 1954 | Values: 64.0 90.0 90.0 95.0 84.0 68.0 68.0 68.0 67.0 69.0 10:54:23 INFO - PROCESS | 1954 | -------- Summary: end -------- 10:54:23 INFO - PROCESS | 1954 | 10:54:24 INFO - TEST-INFO | 1954: exit 0 10:54:24 INFO - TEST-OK | kraken | took 61183ms 10:54:24 INFO - SUITE-END | took 1173s 10:54:24 INFO - Completed test suite (00:19:34) 10:54:24 INFO - javascript benchmark 10:54:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7321.872208796453, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2843.6492665983646, 3098.349346637206, 3461.4807778833174, 3487.2851065531568, 3496.8776092836747, 4205.369194620808, 4476.686631935766, 5147.922781158286, 5720.628159169651, 5743.0, 5626.521745651625, 5681.147827825828, 5697.373288938214, 5721.34204566475, 5771.278590176228, 5164.302819119418, 5212.0, 5216.530512253897, 5263.289455923459, 5270.762815673284, 5297.44376840432, 5328.333958255218, 5359.705216213126, 5390.326209223847, 5411.675299482024, 4241.618254357123, 4664.650151238654, 4681.250999840026, 5102.36220472441, 5163.8192663256605, 5131.666441681279, 5160.458151894072, 5167.767450464738, 5225.6603320784025, 5227.294315267466, 5089.745512724386, 5138.58891288696, 5166.509181627739, 5173.76718047685, 5205.011047900886, 5415.918761218545, 5558.138488534284, 5566.777328906839, 5618.747156377973, 5623.297087864017, 6172.1667574877265, 6234.968825155891, 6256.2492500899725, 6264.906026409608, 6289.433950944437, 6146.7541298348015, 6157.415045570664, 6218.595791273553, 6243.625382477066, 6251.4061164189325, 5842.211301474289, 5894.823155305347, 5921.940780592225, 5929.199558059693, 5949.702514874282, 6281.59169653971, 6290.213723284498, 6300.495960323163, 6304.527160462983, 6318.0, 6055.6063855849225, 6095.66473843934, 6144.907826382608, 6172.808752534631, 6199.3490683477585, 6242.906356404657, 6246.3441338659695, 6247.406496382927, 6252.187215662026, 6269.341719119518, 6120.1737765401995, 6173.290071641729, 6180.907286390618, 6193.225846769154, 6239.500839932885, 6097.887666312796, 6113.354685976905, 6155.138280640714, 6195.845103872439, 6297.338779428185, 4982.950170498321, 4988.002399520038, 5007.724575148329, 5013.3983921928875, 5018.623603229699, 4187.0, 4441.933370999438, 4485.0, 4489.483709373464, 4537.682362234612, 5691.402402747652, 5716.171155182476, 5837.387074357216, 5841.357450680422, 5859.882802344015, 6216.720247588869, 6240.063990401385, 6249.6562689051625, 6250.374962503804, 6262.436380725757, 5833.912491312633, 5836.562257830679, 5844.26946631671, 5846.736896839652, 5876.647401155944, 5371.6239863209985, 5399.055165346049, 5402.540784033323, 5406.59450541211, 5466.262054622654, 4904.0, 5319.441458646941, 5674.432556744293, 6305.92799224133, 6325.620462772248, 6122.062734707273, 6247.187865577446, 6247.812565623039, 6264.968675156595, 6278.905816412666, 6199.070139479114, 6214.627122372672, 6275.403836635513, 6313.116163737172, 6330.651814150266, 5165.225216217597, 6154.538409619386, 6223.751049957951, 6231.594946328474, 6231.937680623136, 5136.743162841918, 6137.591499645514, 6175.228096487939, 6238.469730072995, 6241.906371404341, 6052.697365131814, 6110.480609148272, 6128.785492507741, 6138.786925362591, 6204.348543402878, 6121.938780612137, 6168.814935551941, 6172.22847144107, 6179.011358182669, 6185.226846644169, 5823.475887170175, 5918.17145599625, 6032.225176418897, 6066.0, 6087.604305720114, 5829.300483941955, 6068.4538391544975, 6119.877602448015, 6122.173506576555, 6171.506279497719, 4993.925091123563, 6057.333693293646, 6077.665728384981, 6081.695915204134, 6083.6653984029535], "value": 5646.36041579918, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.9784009719562, 487.62452911258333, 504.89902019596076, 515.5952577226875, 551.9613627046108, 36332.81833590828, 37523.0, 37756.0, 39049.80475097624, 40362.0, 41349.75950721483, 41969.79015104928, 42272.0, 42353.576464235346, 43262.0, 8455.830883382328, 9626.278029147807, 9630.277729170306, 9647.372920760163, 9664.855027174597, 9599.424034557915, 9621.759456013586, 9623.42259464431, 9628.3260171788, 9661.95169024154, 8004.51972881629, 9613.759656008586, 9651.227901767877, 9654.758631034245, 9676.56455459506, 9545.04549545047, 9564.56959436827, 9569.330146889686, 9633.710988670386, 9658.71023869285, 8326.750197494084, 8979.86530202041, 9598.76003099921, 9605.279604029725, 9616.75958101053, 32282.0, 38917.0, 39333.01667458336, 39392.0, 39420.21159576821, 3323.5347051412823, 3358.2947581008016, 3526.100844284691, 3614.963850361489, 3670.596234414212, 24809.379765506008, 30215.0, 30894.0, 31132.8443357784, 31333.686663133303, 3126.8749250029973, 3156.2582793043616, 3178.284885900677, 3180.25264062945, 3193.1697758582704, 370482.0, 435250.0, 441731.0, 443813.9999999968, 444296.0, 34445.48331775025, 34544.654553454646, 34818.47772283418, 34824.30351392958, 34891.30217395638, 30943.381132377228, 35798.82100589533, 36047.0, 36164.09589760277, 38061.2387752249, 16622.75065874013, 16657.33370665184, 16719.582010449834, 16730.247138878778, 16737.497875063767, 12371.381430928597, 12581.37093145339, 12717.0, 12718.554850580185, 12763.91506721939, 20384.89807550953, 20494.18023279052, 20517.89741051285, 20568.177272908917, 20643.380698578767, 8157.265846073882, 8221.013478382632, 8221.753347399588, 8243.83512329762, 8288.751337459886, 925.4771054354268, 977.5600979559084, 984.13396211335, 1076.1498416251231, 1085.9511321990528, 25061.62407563888, 25758.613620795702, 28698.856505717336, 30993.69006309953, 31089.844550777554, 874.5714599846029, 1035.9433377954595, 1041.6198087697935, 1173.178774857603, 1269.6191142657167, 14889.404423823142, 16161.11113888724, 16238.350465981464, 16343.26455309514, 16378.672426551402, 694113.0, 694619.0, 703547.0, 706069.0, 714320.0, 54638.45361546334, 55206.0, 58769.70615146897, 60170.0, 60456.39543604507, 1379.9310034498235, 1385.6466601016675, 1409.3164815064686, 1431.9069260498034, 1445.219581426018, 27572.862135689193, 27689.584656230574, 27778.0, 29678.554821678124, 30735.2316192097, 43883.0, 52500.73749631227, 52729.736351317995, 52885.7355713219, 52899.206511903125, 420910.0, 522893.0, 524018.0, 528448.0, 535051.0, 26979.59530607003, 27807.860960695067, 27843.886244550802, 27896.44207115887, 27969.021084261953, 48743.781405465146, 50148.498515014384, 50564.49435505598, 50813.74593127011, 51199.74400127975, 39807.00482487845, 40883.38674919938, 41131.58868411397, 41261.58738412578, 41322.79338603288, 39635.80182099071, 40374.798126009184, 40525.12323103753, 40543.3918491217, 41153.38269925894, 39313.0, 39492.60507395004, 39529.0, 42659.78670106754, 43584.78207608942, 40508.79745601253, 43775.343369848844, 43919.0, 44726.0, 44850.0, 26003.0, 30018.399632007673, 30585.54121688132, 30997.380052399276, 31121.066368008997], "value": 19653.44237540107, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.20347372255117, 389.04489478330703, 389.3186922884951, 400.4873761585172, 401.01350677333755, 19666.311679091217, 21046.0, 21309.0, 21672.8916355418, 21869.562608747834, 20500.0, 20618.587628247427, 20787.0, 21623.135074597038, 21644.0, 5638.013347664163, 5649.265595472593, 6015.308239552463, 6031.6984150792505, 6091.756329746827, 3775.18833450808, 5183.948160518385, 5771.595988280822, 6108.358622344635, 6131.417515336036, 5155.839936014404, 6052.788152414666, 6133.1413602095745, 6157.599756015867, 6160.476359509447, 5513.807016754395, 5897.292324920994, 5928.347881733028, 5929.73316200772, 6006.039033754579, 5687.26065611472, 5799.072148456269, 5935.436133567304, 6000.459958603747, 6001.729922153513, 13330.200187988752, 13516.986226032988, 13680.794788078187, 25010.0, 25805.870970645214, 1903.4955736729778, 2196.952805648458, 2224.377174391173, 2340.8244381671443, 2441.0967941861445, 9953.0, 10000.497388709276, 10287.89712102877, 10297.279190456671, 10405.3756774593, 1837.7610910581673, 1931.1792488192602, 1934.7194656774689, 1966.3314473079079, 1973.8223559879536, 105997.0, 118211.40894295559, 124757.0, 126778.0, 131373.0, 9464.337496375188, 10421.9478902605, 10952.726181845359, 11724.0, 11843.88156118445, 12436.75126497465, 14540.127592344494, 14714.779278310834, 14758.631034224016, 14830.629234269014, 6450.032495125769, 7826.608669566499, 8160.959195203986, 8402.915970840335, 8689.087645797226, 8393.958030209931, 8407.8318433631, 8423.284020858173, 8525.31797456202, 8531.914680853237, 3778.848846046127, 4509.12072145935, 4553.271476563734, 4619.376384188159, 4671.6262698984, 1673.2303140555236, 1716.695311563221, 1808.1140241281678, 1936.3319654719098, 1954.4625228062396, 805.830775537132, 882.9161229683169, 897.8249241397865, 970.6942313171328, 1061.2465149743614, 19946.102425390603, 20411.387658370273, 20850.0, 20862.895685521475, 21063.368098957057, 945.1163162443138, 945.2815859946353, 955.6225291010151, 958.6309270930602, 977.310995747996, 8907.55462226886, 10915.290506117077, 11145.0, 11164.888351116548, 11175.050120739828, 584354.0, 589144.0, 590606.0, 605065.0, 605952.7618895195, 105856.47071764746, 136025.99999999802, 136296.0, 141411.29294353668, 141585.29207353896, 984.5126662302063, 991.4497453913148, 1020.9795804084025, 1023.7798873242289, 1064.1061508332882, 18754.343597974006, 19193.232270709017, 19241.0, 19256.133473993985, 19301.710474343177, 57027.42972570221, 57391.0, 57447.71276143593, 57910.4208957905, 59254.70372648109, 85498.0, 85534.2893142146, 85710.57144714237, 86488.6755662227, 87072.0, 6801.557898736566, 8090.543702133672, 8170.877436838333, 8385.454945428528, 8453.830923381374, 12321.260724356209, 12697.746045078862, 12801.29592872401, 12815.551455699006, 12915.418806153933, 10958.45207739594, 11011.83482247783, 11170.0, 11327.0, 11428.71428214268, 9133.725988220363, 9267.258619310303, 10379.740506487398, 10414.323069000491, 11459.541618335506, 11666.183367164216, 11842.105263157853, 11869.465874035517, 11893.643190704293, 11925.165238433226, 8286.171382861665, 8301.626426810928, 8394.328453723809, 8419.747407577783, 8473.0, 8288.544130072903, 10589.682309530726, 11323.263987840764, 11600.361980091177, 11655.650330490098], "value": 9512.821758339147, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1538.4384699584648, 1580.2888700084961, 1596.784434101396, 1692.162379622088, 1922.2599299269793, 7880.2513761192595, 8405.159484051599, 8416.368772342068, 8907.510086945224, 8918.554072296383, 8502.744917652464, 8545.65817367306, 8700.129472163499, 8700.912990870089, 8722.21500064994, 2344.70691163605, 2364.420716924356, 2372.264597974625, 2379.2505360811288, 2383.034870877289, 2336.380859072347, 2365.124903785602, 2365.846219995695, 2390.0, 2395.6167013277877, 2358.2099996501192, 2362.8582285062867, 2363.326451961191, 2369.490559529701, 2386.570417324881, 2343.121329501437, 2347.495288512969, 2348.56551537966, 2352.647102934565, 2360.7403185649564, 2087.217293514932, 2342.6837376954063, 2357.587422201108, 2361.9135197808855, 2363.0311572255464, 8602.569871506463, 8613.397062205648, 8649.351298652626, 8737.475751454933, 8739.126087391274, 5167.276581278624, 5290.656107353048, 5325.3077099977145, 5333.413324534298, 5344.824138689521, 3389.254364039907, 3432.3650124726755, 3536.3634545781747, 3605.4952306677087, 3638.2359704462096, 1091.2252300866394, 1094.0, 1098.5111625326733, 1098.730810951314, 1106.5352551928129, 11364.602238921598, 11388.0, 11408.030317423028, 11408.258463199865, 11422.600208992728, 4615.284630882152, 4619.6073333766335, 4742.217534106902, 4748.928766068511, 4761.833335833298, 9713.805723885624, 9755.853662195073, 9761.658341957997, 9775.0, 9788.070133337322, 5197.7661005254095, 5215.869603259873, 5272.288241087481, 5294.232336311214, 5306.628536002443, 4332.761698106634, 4686.297055441642, 4782.402199725035, 4848.17581011229, 4854.077725232195, 3302.884399046022, 3909.179072394829, 4029.6097846243, 4038.7172897897453, 4054.2094291613444, 1283.23647429781, 1304.3217526886156, 1307.9738405232033, 1316.9934150329186, 1326.071749775142, 870.2254993056185, 954.346272803132, 970.6020531582018, 972.2950860626131, 997.6009596161448, 5879.2944846618675, 5920.348761636216, 5927.4665280125, 5997.580169388189, 6047.213862197974, 439.87463572882217, 442.7343593843668, 454.32759515916626, 455.59224494077614, 456.24035980093436, 3514.2268700885766, 3991.2815693174925, 4070.0, 4082.3876418537457, 4086.6730661547003, 10000.499975001221, 10011.599536018623, 10385.324953877975, 10399.84400233997, 10568.630097946689, 9103.544822758968, 9114.680986165453, 10328.018838210359, 10426.165906727443, 10516.000979906896, 6819.829504262433, 8041.195880412029, 8054.718084867119, 8145.226203510657, 8149.144339844231, 5035.84892453227, 5998.280206375263, 6117.235345581802, 6152.384761523812, 6230.470410015199, 9651.565679544578, 9830.016998300112, 9864.161546268648, 9883.654072107442, 9931.65239216624, 8170.959145204473, 9889.604415823287, 9902.653407130716, 10059.446730429896, 10149.289549731448, 6295.748170073146, 6932.341427564374, 7524.209957954336, 7585.279398457138, 7713.7685869424, 8253.09215986229, 8274.834503310021, 8292.58537073156, 8347.791305217175, 8392.580370981304, 7301.707931682673, 7481.88777168332, 7492.737754178577, 7505.66224519887, 7566.394688424803, 7321.560706357635, 7359.558426494427, 7413.184549699421, 7480.925190748023, 7486.213947535431, 6944.305569443015, 6980.267071957372, 6986.510944233854, 7010.369066784014, 7058.082449281561, 4487.394201782718, 4817.27740838877, 4953.925691114709, 5000.12497812874, 5142.665726727751, 4989.12690279207, 5008.148614735431, 5056.443791183041, 5101.540861322499, 5199.116150254541], "value": 4473.165832660401, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [267.56119963260255, 278.2473409427499, 313.5453592291178, 318.39346045782776, 329.3692578711767, 4968.354113965189, 5642.238297829792, 5689.3172819261745, 5709.286339207599, 5718.199452076713, 4909.435414927284, 4924.679895806779, 5542.584306177033, 5555.944440555593, 5668.68822214778, 3336.699697027267, 3989.7606143631474, 4016.7589944603346, 4230.74615523068, 4254.723442976212, 3874.2057878134915, 3914.588968158345, 4184.100418410041, 4258.850940217093, 4260.70175087744, 3705.2589482103554, 4015.337469317559, 4225.387318838767, 4227.767472789011, 4241.448611680477, 3642.1076836175043, 4056.9391459128137, 4212.209810830415, 4228.4080228768, 4230.407742915994, 2937.735603795669, 3636.254567813592, 3649.7262705296944, 3651.214988777399, 3662.1393972416463, 5293.841184764463, 5386.703731294777, 5387.892242155135, 5405.324334458192, 5422.213779002022, 4427.845025424127, 4465.419495465601, 4884.877878053042, 4904.264360345941, 4926.556609905126, 4927.728974906378, 5575.916361254584, 5851.8537036574, 5911.290645122613, 5922.3485416604135, 3947.3289540778137, 3949.6445319921345, 3956.7823769692654, 3965.3457179565626, 3972.82122304497, 5970.6716130612795, 5971.790987315467, 6195.265325708809, 6234.812955611339, 6274.968625156891, 3407.9946415807394, 3577.499150118985, 4010.3984402339884, 4018.095928416083, 4018.4976877890263, 3460.8442620082155, 3498.3877821381157, 4054.655354294859, 4067.4206698105477, 4082.6529744971417, 4144.730592511477, 4419.977900110479, 4634.884127896829, 4802.142725078573, 4821.228603423506, 4926.605871530269, 5715.571332150105, 5893.469587737124, 6002.879942401128, 6020.789272375533, 1136.3295655563256, 1183.8638556565934, 1186.32379543661, 1256.1960345378964, 1376.2980879751399, 751.0911796725914, 775.6697264191938, 816.4896939412866, 829.7469271872017, 883.6553744039829, 4678.719276843401, 5032.572231360376, 5486.930048640476, 5487.670739755627, 5496.0, 4935.777889994959, 5651.2935883014625, 5970.522358211333, 6031.819045428644, 6088.194878201124, 4435.467743870756, 5048.217526283432, 5124.487551244845, 5362.249285100089, 5500.697461639648, 2730.948584794868, 2741.753242208211, 2952.099609619087, 3184.219866132766, 3184.442722523549, 5316.760745766373, 5772.0, 6275.717592708248, 6285.937140628535, 6325.968370158212, 5165.535101840853, 5488.17677348401, 5646.4353564644025, 6064.545159113084, 6305.716242769086, 5418.647787893696, 5657.0, 6159.5072394208355, 6346.3019067903415, 6415.871682566416, 5008.373953255843, 5055.570276526537, 5833.329167145833, 5891.941080589139, 6231.3145553988115, 5404.243405923095, 5582.794796055454, 5852.736626851717, 5882.176495290748, 5995.830812991425, 5867.178594996789, 6149.569530132848, 6221.569039120937, 6396.667299373679, 6430.517711171775, 3980.6266837940866, 3993.92012159761, 3996.460477835455, 4011.799410029545, 4024.1348110156455, 5611.0, 5719.742611582572, 6067.878642427038, 6132.78535251264, 6142.416470435302, 5643.266375371176, 5933.643981361132, 5935.643861368331, 5996.730147143477, 6011.939880601138, 5466.835994920159, 5715.9142612860005, 5949.6430214187285, 6001.189839371629, 6014.248218972629, 5360.303160589098, 5595.216669666169, 5723.0, 5746.454086861741, 5857.326407463196, 5371.677699338053, 5920.875033743747, 5975.282966044103, 5982.1455348842, 5985.910211346746, 5528.391876893619, 5579.553635709052, 5815.82552523425, 5860.09168578871, 5889.852753681193], "value": 4219.272557921153, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.8886578147498, 741.6069483173916, 792.9246721561453, 852.9147085291468, 871.8692196170572, 13869.751722344987, 14930.253487325632, 15713.607159821011, 15749.055056696578, 16307.0, 13355.0, 14775.92612036941, 14857.628559285997, 14939.775903361431, 14954.177520236382, 723.8769409200422, 745.3776096959032, 899.4333569850985, 918.7197904639082, 934.957926893288, 776.1501156233915, 880.8634661627458, 913.6710784117712, 940.6237504997987, 945.7635591102224, 990.5443495991852, 991.4447909170851, 993.4287784523891, 997.2470784557685, 998.346083315426, 939.3800091939355, 942.4580866002076, 986.5264672956985, 994.8557459168417, 995.4077323992285, 725.9111333000499, 734.2363941500832, 734.4124700239787, 735.91904890462, 736.5985537881867, 14769.0, 14836.109833409922, 14867.628309292246, 14873.256337183098, 14913.850861491355, 12440.688982775502, 14579.927100364537, 14630.414783408758, 14658.486952956595, 14748.0, 10070.647527336509, 11844.763104737856, 11931.522739090426, 12097.818532722016, 12273.140880138393, 3798.0, 3854.094287842355, 3863.3267370053973, 3899.6100389960775, 4027.476428064362, 94957.5252123735, 96383.55424668636, 98477.03045939041, 100182.49908750482, 101069.49465252626, 9404.90595094054, 11063.502142403611, 11265.54937802495, 11342.829857552144, 11405.885941140648, 21845.45386365322, 22357.329280121623, 22547.774522254567, 22559.43601409945, 22609.54780904373, 6811.352921472452, 8133.715319963773, 8189.7133600323705, 8225.190458099209, 8227.382946279053, 3859.864904728377, 4527.977360113178, 4569.314602809539, 4656.650751193606, 4759.9524004759505, 3625.4380571011534, 3715.108373990223, 3753.60587138352, 3756.417755247941, 3757.342465068602, 661.1735330836455, 674.2987293215001, 674.8953912143626, 691.4744793956529, 692.3076923076923, 647.7894684227645, 665.3845193196274, 675.2740803636111, 694.4201591671011, 707.8902770070647, 7842.686292548348, 8929.374943753875, 9077.96030766316, 9127.726168214964, 9136.771580710403, 578.7569220927137, 603.3604379357807, 645.1161908185816, 680.792358330704, 687.8246047258017, 3917.4515567820526, 4584.747838868828, 4632.814687412533, 4675.0, 4710.882227944328, 142153.0, 143911.0, 144798.0, 146222.0, 148718.51281487045, 115516.42241788737, 129395.0, 130982.0, 131019.34490327488, 133177.0, 110486.0, 111208.0, 111781.44109279402, 112525.0, 113034.0, 8538.615762290836, 9054.0, 9079.727608171765, 9093.884189335306, 9198.26413886874, 41779.74660760182, 52255.21617175821, 53235.201471977176, 56151.0, 57154.0, 70403.64798175976, 71083.0, 85122.0, 85490.57254713686, 87142.0, 12075.215111017756, 12129.514819407124, 12234.571789987664, 12262.448189831657, 12805.423755930819, 13281.933590332374, 13366.131201471873, 13784.172949623055, 13917.791233131713, 13925.651858703208, 12265.080118990933, 12299.754004919672, 12458.875411246134, 12784.360781960679, 12855.292958886977, 12309.630711078682, 12498.687532811753, 12550.62348129521, 12656.74686506283, 12922.224666519664, 12203.267803931793, 12277.386130693609, 12303.138780285293, 12481.937590312353, 12520.060995425561, 10405.531751071372, 10501.002404771534, 10520.00614277998, 10562.788744225227, 10564.154867610727, 10516.421596812248, 10601.575936962436, 10604.310719803188, 10635.94682026585, 10758.46207689628], "value": 7732.479032473208, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1633.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 116.0, 124.0, 167.0, 115.0, 115.0, 117.0, 118.0, 115.0], "value": 121.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 123.0, 163.0, 192.0, 117.0, 144.0, 152.0, 146.0, 199.0, 125.0], "value": 151.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 166.0, 235.0, 266.0, 195.0, 194.0, 203.0, 196.0, 199.0, 195.0], "value": 205.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 80.0, 75.0, 161.0, 83.0, 57.0, 58.0, 59.0, 124.0, 75.0], "value": 84.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 117.0, 83.0, 100.0, 127.0, 108.0, 101.0, 106.0, 152.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 93.0, 86.0, 81.0, 131.0, 89.0, 85.0, 88.0, 85.0], "value": 91.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 154.0, 95.0, 124.0, 90.0, 142.0, 150.0, 95.0, 102.0, 111.0], "value": 118.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 89.0, 109.0, 118.0, 132.0, 104.0, 92.0, 92.0, 90.0], "value": 105.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 60.0, 55.0, 57.0, 57.0, 58.0, 61.0, 76.0, 87.0, 76.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 69.0, 77.0, 79.0, 99.0, 110.0, 96.0, 74.0, 71.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 83.0, 77.0, 78.0, 101.0, 108.0, 110.0, 112.0, 146.0, 86.0], "value": 98.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 159.0, 152.0, 156.0, 134.0, 159.0, 162.0, 151.0, 160.0, 135.0], "value": 151.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 170.0, 172.0, 166.0, 214.0, 232.0, 204.0, 168.0, 163.0, 168.0], "value": 182.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 90.0, 90.0, 95.0, 84.0, 68.0, 68.0, 68.0, 67.0, 69.0], "value": 76.3, "unit": "score"}]}]} 10:54:24 INFO - Return code: 0 10:54:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:54:24 ERROR - # TBPL SUCCESS # 10:54:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:54:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:54:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:54:24 INFO - 2016-06-02 10:54:24.643 screenresolution[1959:18192] starting screenresolution argv=screenresolution get 10:54:24 INFO - 2016-06-02 10:54:24.645 screenresolution[1959:18192] Display 0: 1600x1200x32@60 10:54:24 INFO - 2016-06-02 10:54:24.651 screenresolution[1960:18195] starting screenresolution argv=screenresolution list 10:54:24 INFO - Available Modes on Display 0 10:54:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:54:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:54:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:54:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:54:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:54:24 INFO - Intel Iris: 10:54:24 INFO - Chipset Model: Intel Iris 10:54:24 INFO - Type: GPU 10:54:24 INFO - Bus: Built-In 10:54:24 INFO - VRAM (Dynamic, Max): 1536 MB 10:54:24 INFO - Vendor: Intel (0x8086) 10:54:24 INFO - Device ID: 0x0a2e 10:54:24 INFO - Revision ID: 0x0009 10:54:24 INFO - Displays: 10:54:24 INFO - Display: 10:54:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:54:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:54:24 INFO - Display Serial Number: 1600x1200 60 10:54:24 INFO - Main Display: Yes 10:54:24 INFO - Mirror: Off 10:54:24 INFO - Online: Yes 10:54:24 INFO - Rotation: Supported 10:54:24 INFO - Return code: 0 10:54:24 INFO - Running post-action listener: _resource_record_post_action 10:54:24 INFO - ##### 10:54:24 INFO - ##### Finished run-tests step (success) 10:54:24 INFO - ##### 10:54:24 INFO - Running post-run listener: _resource_record_post_run 10:54:24 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 557056; Write bytes: 698366976; Read time: 5; Write time: 1958 10:54:24 INFO - TinderboxPrint: CPU usage
54.5% 10:54:24 INFO - TinderboxPrint: I/O read bytes / time
557,056 / 5 10:54:24 INFO - TinderboxPrint: I/O write bytes / time
698,366,976 / 1,958 10:54:24 INFO - TinderboxPrint: CPU idle
2,201.7 (45.5%) 10:54:24 INFO - TinderboxPrint: CPU system
977.9 (20.2%) 10:54:24 INFO - TinderboxPrint: CPU user
1,658.1 (34.3%) 10:54:24 INFO - TinderboxPrint: Swap in / out
399,831,040 / 0 10:54:24 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 400452096; Write bytes: 403033600; Read time: 30115; Write time: 863 10:54:24 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 557056; Write bytes: 294317568; Read time: 5; Write time: 1089 10:54:25 INFO - Running post-run listener: _upload_blobber_files 10:54:25 INFO - Blob upload gear active. 10:54:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:54:25 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 10:54:25 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'] 10:54:25 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 10:54:25 INFO - (blobuploader) - INFO - Open directory for files ... 10:54:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:54:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:54:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:54:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:54:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:54:26 INFO - (blobuploader) - INFO - Done attempting. 10:54:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:54:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:54:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:54:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:54:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:54:27 INFO - (blobuploader) - INFO - Done attempting. 10:54:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:54:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:54:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:54:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:54:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:54:30 INFO - (blobuploader) - INFO - Done attempting. 10:54:30 INFO - (blobuploader) - INFO - Iteration through files over. 10:54:30 INFO - Return code: 0 10:54:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:54:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:54:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7070fd79c2cb9d5b39b19dcf2022634157c1a7e04d3287740745322b57c374b6388e94cd5c45d85276a8c76fb308089d8409c7cc65f9ce4a3f557646c5043e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/78e89850f932b11fc9ba4b76721c15251eab1ac1ec8075fa495c00714f54102b8ac532cbaf730c9b94ddeb9f3831c74e7ab0637f650b527f7cd8765fff047798", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2a1356db2c4c292cffda9f233fc65520c0e57a629efd81f4a816f80f4047304c217f31d10632e463b9da9e7fdfa0ed2ac9411aeabfed383779d0d5f57c782fe"} 10:54:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:54:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:54:30 INFO - Contents: 10:54:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7070fd79c2cb9d5b39b19dcf2022634157c1a7e04d3287740745322b57c374b6388e94cd5c45d85276a8c76fb308089d8409c7cc65f9ce4a3f557646c5043e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/78e89850f932b11fc9ba4b76721c15251eab1ac1ec8075fa495c00714f54102b8ac532cbaf730c9b94ddeb9f3831c74e7ab0637f650b527f7cd8765fff047798", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2a1356db2c4c292cffda9f233fc65520c0e57a629efd81f4a816f80f4047304c217f31d10632e463b9da9e7fdfa0ed2ac9411aeabfed383779d0d5f57c782fe"} 10:54:30 INFO - Running post-run listener: copy_logs_to_upload_dir 10:54:30 INFO - Copying logs to upload dir... 10:54:30 INFO - mkdir: /builds/slave/test/build/upload/logs 10:54:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.603609 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-06-02 10:54:30.289962) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 10:54:30.293111) ========= 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.uMmkCYf7GZ/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.HTiVl6dX6S/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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/f7070fd79c2cb9d5b39b19dcf2022634157c1a7e04d3287740745322b57c374b6388e94cd5c45d85276a8c76fb308089d8409c7cc65f9ce4a3f557646c5043e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/78e89850f932b11fc9ba4b76721c15251eab1ac1ec8075fa495c00714f54102b8ac532cbaf730c9b94ddeb9f3831c74e7ab0637f650b527f7cd8765fff047798", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2a1356db2c4c292cffda9f233fc65520c0e57a629efd81f4a816f80f4047304c217f31d10632e463b9da9e7fdfa0ed2ac9411aeabfed383779d0d5f57c782fe"} build_url:https://queue.taskcluster.net/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011660 build_url: 'https://queue.taskcluster.net/v1/task/DEgOS8kXRNedxLjUuZ51HA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7070fd79c2cb9d5b39b19dcf2022634157c1a7e04d3287740745322b57c374b6388e94cd5c45d85276a8c76fb308089d8409c7cc65f9ce4a3f557646c5043e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/78e89850f932b11fc9ba4b76721c15251eab1ac1ec8075fa495c00714f54102b8ac532cbaf730c9b94ddeb9f3831c74e7ab0637f650b527f7cd8765fff047798", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2a1356db2c4c292cffda9f233fc65520c0e57a629efd81f4a816f80f4047304c217f31d10632e463b9da9e7fdfa0ed2ac9411aeabfed383779d0d5f57c782fe"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 10:54:30.325418) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 10:54:30.325777) ========= 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.uMmkCYf7GZ/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.HTiVl6dX6S/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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.005111 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 10:54:30.374460) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 10:54:30.374775) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 10:54:30.375134) ========= ========= Total master_lag: 0.17 =========