builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0090 starttime: 1462798827.13 results: success (0) buildid: 20160509024850 builduid: 19c9eb1de1f448e0a508eb57f0ef353e revision: cb53cee341a60d134fd5dc55ead4a95632a22dce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 06:00:27.131024) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 06:00:27.131469) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 06:00:27.131758) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 06:00:27.155144) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:00:27.155403) ========= 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.zU3InvHR3P/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.rj93OEWp0e/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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-05-09 06:00:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 17.6M=0.001s 2016-05-09 06:00:27 (17.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.388828 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:00:27.561412) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:00:27.564753) ========= 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.zU3InvHR3P/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.rj93OEWp0e/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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.026537 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:00:27.614111) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:00:27.614455) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cb53cee341a60d134fd5dc55ead4a95632a22dce --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 cb53cee341a60d134fd5dc55ead4a95632a22dce --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zU3InvHR3P/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.rj93OEWp0e/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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-05-09 06:00:27,688 truncating revision to first 12 chars 2016-05-09 06:00:27,688 Setting DEBUG logging. 2016-05-09 06:00:27,688 attempt 1/10 2016-05-09 06:00:27,689 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cb53cee341a6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 06:00:28,429 unpacking tar archive at: fx-team-cb53cee341a6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.982488 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:00:28.613435) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 06:00:28.616777) ========= script_repo_revision: cb53cee341a60d134fd5dc55ead4a95632a22dce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 06:00:28.617185) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 06:00:28.617447) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 06:00:28.632813) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-05-09 06:00:28.633097) ========= /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.zU3InvHR3P/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.rj93OEWp0e/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 06:00:28 INFO - MultiFileLogger online at 20160509 06:00:28 in /builds/slave/test 06:00:28 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 06:00:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:00:28 INFO - {'append_to_log': False, 06:00:28 INFO - 'base_work_dir': '/builds/slave/test', 06:00:28 INFO - 'blob_upload_branch': 'Fx-Team', 06:00:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:00:28 INFO - 'branch': 'Fx-Team', 06:00:28 INFO - 'buildbot_json_path': 'buildprops.json', 06:00:28 INFO - 'config_files': ('talos/mac_config.py',), 06:00:28 INFO - 'default_actions': ('clobber', 06:00:28 INFO - 'read-buildbot-config', 06:00:28 INFO - 'download-and-extract', 06:00:28 INFO - 'populate-webroot', 06:00:28 INFO - 'create-virtualenv', 06:00:28 INFO - 'install', 06:00:28 INFO - 'run-tests'), 06:00:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:00:28 INFO - 'download_minidump_stackwalk': True, 06:00:28 INFO - 'download_symbols': 'ondemand', 06:00:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:00:28 INFO - 'tooltool.py': '/tools/tooltool.py', 06:00:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:00:28 INFO - '/tools/misc-python/virtualenv.py')}, 06:00:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:00:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:00:28 INFO - 'installer_path': 'installer.exe', 06:00:28 INFO - 'log_level': 'info', 06:00:28 INFO - 'log_name': 'talos', 06:00:28 INFO - 'log_to_console': True, 06:00:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:00:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:00:28 INFO - 'opt_config_files': (), 06:00:28 INFO - 'pip_index': False, 06:00:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:00:28 INFO - 'cmd': ('bash', 06:00:28 INFO - '-c', 06:00:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:00:28 INFO - 'enabled': True, 06:00:28 INFO - 'halt_on_failure': False, 06:00:28 INFO - 'name': 'check_screen_resolution'},), 06:00:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:00:28 INFO - 'cmd': ('bash', 06:00:28 INFO - '-c', 06:00:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:00:28 INFO - 'enabled': True, 06:00:28 INFO - 'halt_on_failure': False, 06:00:28 INFO - 'name': 'check_screen_resolution'},), 06:00:28 INFO - 'run_cmd_checks_enabled': True, 06:00:28 INFO - 'sps_profile': False, 06:00:28 INFO - 'sps_profile_interval': 0, 06:00:28 INFO - 'suite': 'dromaeojs-e10s', 06:00:28 INFO - 'system_bits': '32', 06:00:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:00:28 INFO - 'title': 't-yosemite-r7-0090', 06:00:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:00:28 INFO - 'use_talos_json': True, 06:00:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:00:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:00:28 INFO - 'work_dir': 'build'} 06:00:28 INFO - ##### 06:00:28 INFO - ##### Running clobber step. 06:00:28 INFO - ##### 06:00:28 INFO - Running pre-action listener: _resource_record_pre_action 06:00:28 INFO - Running main action method: clobber 06:00:28 INFO - rmtree: /builds/slave/test/build 06:00:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:00:30 INFO - Running post-action listener: _resource_record_post_action 06:00:30 INFO - ##### 06:00:30 INFO - ##### Finished clobber step (success) 06:00:30 INFO - ##### 06:00:30 INFO - ##### 06:00:30 INFO - ##### Running read-buildbot-config step. 06:00:30 INFO - ##### 06:00:30 INFO - Running pre-action listener: _resource_record_pre_action 06:00:30 INFO - Running main action method: read_buildbot_config 06:00:30 INFO - Using buildbot properties: 06:00:30 INFO - { 06:00:30 INFO - "project": "", 06:00:30 INFO - "product": "firefox", 06:00:30 INFO - "script_repo_revision": "production", 06:00:30 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 06:00:30 INFO - "repository": "", 06:00:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 06:00:30 INFO - "buildid": "20160509024850", 06:00:30 INFO - "pgo_build": "False", 06:00:30 INFO - "basedir": "/builds/slave/test", 06:00:30 INFO - "buildnumber": 751, 06:00:30 INFO - "slavename": "t-yosemite-r7-0090", 06:00:30 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 06:00:30 INFO - "platform": "yosemite_r7", 06:00:30 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 06:00:30 INFO - "branch": "fx-team", 06:00:30 INFO - "repo_path": "integration/fx-team", 06:00:30 INFO - "revision": "cb53cee341a60d134fd5dc55ead4a95632a22dce", 06:00:30 INFO - "stage_platform": "macosx64", 06:00:30 INFO - "builduid": "19c9eb1de1f448e0a508eb57f0ef353e", 06:00:30 INFO - "slavebuilddir": "test" 06:00:30 INFO - } 06:00:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/RzInJaChQfOijPZIIQwj7w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 06:00:30 INFO - Running post-action listener: _resource_record_post_action 06:00:30 INFO - ##### 06:00:30 INFO - ##### Finished read-buildbot-config step (success) 06:00:30 INFO - ##### 06:00:30 INFO - ##### 06:00:30 INFO - ##### Running download-and-extract step. 06:00:30 INFO - ##### 06:00:30 INFO - Running pre-action listener: _resource_record_pre_action 06:00:30 INFO - Running main action method: download_and_extract 06:00:30 INFO - mkdir: /builds/slave/test/build/tests 06:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:30 INFO - https://queue.taskcluster.net/v1/task/RzInJaChQfOijPZIIQwj7w/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:00:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RzInJaChQfOijPZIIQwj7w/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 06:00:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RzInJaChQfOijPZIIQwj7w/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 06:00:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RzInJaChQfOijPZIIQwj7w/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 06:00:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RzInJaChQfOijPZIIQwj7w/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 06:00:32 INFO - Downloaded 1199 bytes. 06:00:32 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 06:00:32 INFO - Using the following test package requirements: 06:00:32 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 06:00:32 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:00:32 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 06:00:32 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:00:32 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 06:00:32 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:00:32 INFO - u'jsshell-mac.zip'], 06:00:32 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:00:32 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 06:00:32 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 06:00:32 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:00:32 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 06:00:32 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:00:32 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 06:00:32 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:00:32 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 06:00:32 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:00:32 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 06:00:32 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:32 INFO - https://queue.taskcluster.net/v1/task/RzInJaChQfOijPZIIQwj7w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:00:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RzInJaChQfOijPZIIQwj7w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:00:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RzInJaChQfOijPZIIQwj7w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:00:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RzInJaChQfOijPZIIQwj7w/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 06:00:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RzInJaChQfOijPZIIQwj7w/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 06:00:33 INFO - Downloaded 18146609 bytes. 06:00:33 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'] 06:00:33 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 06:00:36 INFO - Return code: 0 06:00:36 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 06:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:36 INFO - https://queue.taskcluster.net/v1/task/RzInJaChQfOijPZIIQwj7w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:00:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RzInJaChQfOijPZIIQwj7w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:00:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RzInJaChQfOijPZIIQwj7w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:00:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RzInJaChQfOijPZIIQwj7w/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 06:00:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RzInJaChQfOijPZIIQwj7w/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 06:00:37 INFO - Downloaded 18146609 bytes. 06:00:37 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'] 06:00:37 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 06:00:41 INFO - Return code: 0 06:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:41 INFO - https://queue.taskcluster.net/v1/task/RzInJaChQfOijPZIIQwj7w/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:00:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RzInJaChQfOijPZIIQwj7w/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 06:00:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RzInJaChQfOijPZIIQwj7w/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 06:00:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RzInJaChQfOijPZIIQwj7w/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 06:00:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RzInJaChQfOijPZIIQwj7w/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 06:00:42 INFO - Downloaded 10840152 bytes. 06:00:42 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'] 06:00:42 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 06:00:42 INFO - Return code: 0 06:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:42 INFO - https://queue.taskcluster.net/v1/task/RzInJaChQfOijPZIIQwj7w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:00:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RzInJaChQfOijPZIIQwj7w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:00:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RzInJaChQfOijPZIIQwj7w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:00:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RzInJaChQfOijPZIIQwj7w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 06:00:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RzInJaChQfOijPZIIQwj7w/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 06:00:46 INFO - Downloaded 110424594 bytes. 06:00:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RzInJaChQfOijPZIIQwj7w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:00:46 INFO - mkdir: /builds/slave/test/properties 06:00:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:00:46 INFO - Writing to file /builds/slave/test/properties/build_url 06:00:46 INFO - Contents: 06:00:46 INFO - build_url:https://queue.taskcluster.net/v1/task/RzInJaChQfOijPZIIQwj7w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:00:47 INFO - Running post-action listener: _resource_record_post_action 06:00:47 INFO - Running post-action listener: set_extra_try_arguments 06:00:47 INFO - ##### 06:00:47 INFO - ##### Finished download-and-extract step (success) 06:00:47 INFO - ##### 06:00:47 INFO - ##### 06:00:47 INFO - ##### Running populate-webroot step. 06:00:47 INFO - ##### 06:00:47 INFO - Running pre-action listener: _resource_record_pre_action 06:00:47 INFO - Running main action method: populate_webroot 06:00:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:00:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:00:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:00:47 INFO - '--tppagecycles', 06:00:47 INFO - '7'], 06:00:47 INFO - 'tests': ['tsvgm']}}, 06:00:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:00:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:00:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:00:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:00:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:00:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:00:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:47 INFO - 'talos_options': ['--disable-e10s'], 06:00:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:00:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:00:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:47 INFO - 'talos_options': ['--disable-e10s'], 06:00:47 INFO - 'tests': ['damp', 'tps']}, 06:00:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:47 INFO - 'tests': ['damp', 'tps']}, 06:00:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:00:47 INFO - 'tests': ['dromaeo_dom']}, 06:00:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:00:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:00:47 INFO - 'tests': ['a11yr', 06:00:47 INFO - 'ts_paint', 06:00:47 INFO - 'tpaint', 06:00:47 INFO - 'sessionrestore', 06:00:47 INFO - 'sessionrestore_no_auto_restore', 06:00:47 INFO - 'tabpaint']}, 06:00:47 INFO - 'other-e10s': {'tests': ['a11yr', 06:00:47 INFO - 'ts_paint', 06:00:47 INFO - 'tpaint', 06:00:47 INFO - 'sessionrestore', 06:00:47 INFO - 'sessionrestore_no_auto_restore', 06:00:47 INFO - 'tabpaint']}, 06:00:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:00:47 INFO - 'ts_paint', 06:00:47 INFO - 'tpaint', 06:00:47 INFO - 'sessionrestore', 06:00:47 INFO - 'sessionrestore_no_auto_restore', 06:00:47 INFO - 'tabpaint']}, 06:00:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:00:47 INFO - 'ts_paint', 06:00:47 INFO - 'tpaint', 06:00:47 INFO - 'sessionrestore', 06:00:47 INFO - 'sessionrestore_no_auto_restore', 06:00:47 INFO - 'tabpaint']}, 06:00:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:00:47 INFO - 'tests': ['a11yr', 06:00:47 INFO - 'ts_paint', 06:00:47 INFO - 'tpaint', 06:00:47 INFO - 'sessionrestore', 06:00:47 INFO - 'sessionrestore_no_auto_restore', 06:00:47 INFO - 'tabpaint']}, 06:00:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:00:47 INFO - 'tests': ['a11yr', 06:00:47 INFO - 'ts_paint', 06:00:47 INFO - 'tpaint', 06:00:47 INFO - 'sessionrestore', 06:00:47 INFO - 'sessionrestore_no_auto_restore', 06:00:47 INFO - 'tabpaint']}, 06:00:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:00:47 INFO - 'tests': ['tsvgx', 06:00:47 INFO - 'tsvgr_opacity', 06:00:47 INFO - 'tart', 06:00:47 INFO - 'tscrollx', 06:00:47 INFO - 'cart']}, 06:00:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:00:47 INFO - 'tsvgr_opacity', 06:00:47 INFO - 'tart', 06:00:47 INFO - 'tscrollx', 06:00:47 INFO - 'cart']}, 06:00:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:47 INFO - 'talos_options': ['--disable-e10s'], 06:00:47 INFO - 'tests': ['tp5o']}, 06:00:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:47 INFO - 'tests': ['tp5o']}, 06:00:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:47 INFO - 'talos_options': ['--disable-e10s', 06:00:47 INFO - '--xperf_path', 06:00:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:00:47 INFO - 'tests': ['tp5n']}, 06:00:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:47 INFO - 'talos_options': ['--xperf_path', 06:00:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:00:47 INFO - 'tests': ['tp5n']}}, 06:00:47 INFO - 'talos.zip': {'path': '', 06:00:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:00:47 INFO - Running post-action listener: _resource_record_post_action 06:00:47 INFO - ##### 06:00:47 INFO - ##### Finished populate-webroot step (success) 06:00:47 INFO - ##### 06:00:47 INFO - ##### 06:00:47 INFO - ##### Running create-virtualenv step. 06:00:47 INFO - ##### 06:00:47 INFO - Running pre-action listener: _resource_record_pre_action 06:00:47 INFO - Running main action method: create_virtualenv 06:00:47 INFO - Creating virtualenv /builds/slave/test/build/venv 06:00:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:00:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:00:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:00:47 INFO - Using real prefix '/tools/python27' 06:00:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:00:48 INFO - Installing distribute.............................................................................................................................................................................................done. 06:00:51 INFO - Installing pip.................done. 06:00:51 INFO - Return code: 0 06:00:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:00: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')]} 06:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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')]} 06:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107df8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dfe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca61dd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c9cd30>, '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 0x107ac0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c93b20>, '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.zU3InvHR3P/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.rj93OEWp0e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:00: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', 'pip>=1.5'] in /builds/slave/test/build 06:00: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 pip>=1.5 06:00:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zU3InvHR3P/Render', 06:00:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:51 INFO - 'HOME': '/Users/cltbld', 06:00:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:51 INFO - 'LOGNAME': 'cltbld', 06:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:51 INFO - 'MOZ_NO_REMOTE': '1', 06:00:51 INFO - 'NO_EM_RESTART': '1', 06:00:51 INFO - 'PAGER': '/bin/cat', 06:00:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:51 INFO - 'PWD': '/builds/slave/test', 06:00:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:51 INFO - 'SHELL': '/bin/bash', 06:00:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rj93OEWp0e/Listeners', 06:00:51 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 06:00:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:51 INFO - 'USER': 'cltbld', 06:00:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:51 INFO - 'XPC_FLAGS': '0x0', 06:00:51 INFO - 'XPC_SERVICE_NAME': '0', 06:00:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:00:51 INFO - Cleaning up... 06:00:51 INFO - Return code: 0 06:00:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:00: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')]} 06:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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')]} 06:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107df8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dfe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca61dd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c9cd30>, '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 0x107ac0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c93b20>, '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.zU3InvHR3P/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.rj93OEWp0e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:00: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', 'psutil>=0.7.1'] in /builds/slave/test/build 06:00: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 psutil>=0.7.1 06:00:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zU3InvHR3P/Render', 06:00:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:51 INFO - 'HOME': '/Users/cltbld', 06:00:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:51 INFO - 'LOGNAME': 'cltbld', 06:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:51 INFO - 'MOZ_NO_REMOTE': '1', 06:00:51 INFO - 'NO_EM_RESTART': '1', 06:00:51 INFO - 'PAGER': '/bin/cat', 06:00:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:51 INFO - 'PWD': '/builds/slave/test', 06:00:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:51 INFO - 'SHELL': '/bin/bash', 06:00:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rj93OEWp0e/Listeners', 06:00:51 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 06:00:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:51 INFO - 'USER': 'cltbld', 06:00:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:51 INFO - 'XPC_FLAGS': '0x0', 06:00:51 INFO - 'XPC_SERVICE_NAME': '0', 06:00:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:51 INFO - Downloading/unpacking psutil>=0.7.1 06:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:00:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:00:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:00:54 INFO - Installing collected packages: psutil 06:00:54 INFO - Running setup.py install for psutil 06:00:54 INFO - building 'psutil._psutil_osx' extension 06:00:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:00:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:00:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:00:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:00:55 INFO - building 'psutil._psutil_posix' extension 06:00:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:00:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:00:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:00:55 INFO - ^ 06:00:55 INFO - 1 warning generated. 06:00:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:00:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:00:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:00:56 INFO - Successfully installed psutil 06:00:56 INFO - Cleaning up... 06:00:56 INFO - Return code: 0 06:00:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:00: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')]} 06:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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')]} 06:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107df8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dfe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca61dd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c9cd30>, '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 0x107ac0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c93b20>, '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.zU3InvHR3P/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.rj93OEWp0e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:00:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:00:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zU3InvHR3P/Render', 06:00:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:56 INFO - 'HOME': '/Users/cltbld', 06:00:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:56 INFO - 'LOGNAME': 'cltbld', 06:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:56 INFO - 'MOZ_NO_REMOTE': '1', 06:00:56 INFO - 'NO_EM_RESTART': '1', 06:00:56 INFO - 'PAGER': '/bin/cat', 06:00:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:56 INFO - 'PWD': '/builds/slave/test', 06:00:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:56 INFO - 'SHELL': '/bin/bash', 06:00:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rj93OEWp0e/Listeners', 06:00:56 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 06:00:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:56 INFO - 'USER': 'cltbld', 06:00:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:56 INFO - 'XPC_FLAGS': '0x0', 06:00:56 INFO - 'XPC_SERVICE_NAME': '0', 06:00:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:00:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:00:58 INFO - Installing collected packages: mozsystemmonitor 06:00:58 INFO - Running setup.py install for mozsystemmonitor 06:00:58 INFO - Successfully installed mozsystemmonitor 06:00:58 INFO - Cleaning up... 06:00:59 INFO - Return code: 0 06:00:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107df8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dfe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca61dd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c9cd30>, '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 0x107ac0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c93b20>, '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.zU3InvHR3P/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.rj93OEWp0e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:00:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:00:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:00:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zU3InvHR3P/Render', 06:00:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:59 INFO - 'HOME': '/Users/cltbld', 06:00:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:59 INFO - 'LOGNAME': 'cltbld', 06:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:59 INFO - 'MOZ_NO_REMOTE': '1', 06:00:59 INFO - 'NO_EM_RESTART': '1', 06:00:59 INFO - 'PAGER': '/bin/cat', 06:00:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:59 INFO - 'PWD': '/builds/slave/test', 06:00:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:59 INFO - 'SHELL': '/bin/bash', 06:00:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rj93OEWp0e/Listeners', 06:00:59 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 06:00:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:59 INFO - 'USER': 'cltbld', 06:00:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:59 INFO - 'XPC_FLAGS': '0x0', 06:00:59 INFO - 'XPC_SERVICE_NAME': '0', 06:00:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:59 INFO - Downloading/unpacking blobuploader==1.2.4 06:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:01 INFO - Downloading blobuploader-1.2.4.tar.gz 06:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:01:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:01:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:02 INFO - Downloading docopt-0.6.1.tar.gz 06:01:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:01:02 INFO - Installing collected packages: blobuploader, requests, docopt 06:01:02 INFO - Running setup.py install for blobuploader 06:01:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:01:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:01:03 INFO - Running setup.py install for requests 06:01:03 INFO - Running setup.py install for docopt 06:01:03 INFO - Successfully installed blobuploader requests docopt 06:01:03 INFO - Cleaning up... 06:01:03 INFO - Return code: 0 06:01:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:03 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 0x107df8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dfe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca61dd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c9cd30>, '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 0x107ac0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c93b20>, '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.zU3InvHR3P/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.rj93OEWp0e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:01:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:01:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:01:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zU3InvHR3P/Render', 06:01:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:01:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:01:03 INFO - 'HOME': '/Users/cltbld', 06:01:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:01:03 INFO - 'LOGNAME': 'cltbld', 06:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:03 INFO - 'MOZ_NO_REMOTE': '1', 06:01:03 INFO - 'NO_EM_RESTART': '1', 06:01:03 INFO - 'PAGER': '/bin/cat', 06:01:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:03 INFO - 'PWD': '/builds/slave/test', 06:01:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:01:03 INFO - 'SHELL': '/bin/bash', 06:01:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rj93OEWp0e/Listeners', 06:01:03 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 06:01:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:01:03 INFO - 'USER': 'cltbld', 06:01:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:01:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:03 INFO - 'XPC_FLAGS': '0x0', 06:01:03 INFO - 'XPC_SERVICE_NAME': '0', 06:01:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:01:04 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-AMhj0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:01:04 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-DR8NtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:01:04 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-LhjAUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:01:04 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-3KhuUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:01:04 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-d_xEw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:01:04 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-1rvhe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:01:04 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-gvLj7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:01:04 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-ZTMCQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:01:04 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-Nam8fQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:01:05 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-5iYXXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:01:05 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-kdBfDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:01:05 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-lzSEdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:01:05 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-jovL_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:01:05 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-5jhLqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:05 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-xLz_lu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:01:05 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-UBo0Xt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:01:05 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-tzCQwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:01:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:01:05 INFO - Running setup.py install for manifestparser 06:01:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:01:05 INFO - Running setup.py install for mozcrash 06:01:06 INFO - Running setup.py install for mozdebug 06:01:06 INFO - Running setup.py install for mozdevice 06:01:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:01:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:01:06 INFO - Running setup.py install for mozfile 06:01:06 INFO - Running setup.py install for mozhttpd 06:01:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:01:06 INFO - Running setup.py install for mozinfo 06:01:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:01:06 INFO - Running setup.py install for mozInstall 06:01:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:01:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:01:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:01:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:01:06 INFO - Running setup.py install for mozleak 06:01:07 INFO - Running setup.py install for mozlog 06:01:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:01:07 INFO - Running setup.py install for moznetwork 06:01:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:01:07 INFO - Running setup.py install for mozprocess 06:01:07 INFO - Running setup.py install for mozprofile 06:01:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:01:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:01:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:01:07 INFO - Running setup.py install for mozrunner 06:01:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:01:07 INFO - Running setup.py install for mozscreenshot 06:01:08 INFO - Running setup.py install for moztest 06:01:08 INFO - Running setup.py install for mozversion 06:01:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:01:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:01:08 INFO - Cleaning up... 06:01:08 INFO - Return code: 0 06:01:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:01:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:08 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 0x107df8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dfe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca61dd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c9cd30>, '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 0x107ac0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c93b20>, '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.zU3InvHR3P/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.rj93OEWp0e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:01:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:01:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:01:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zU3InvHR3P/Render', 06:01:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:01:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:01:08 INFO - 'HOME': '/Users/cltbld', 06:01:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:01:08 INFO - 'LOGNAME': 'cltbld', 06:01:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:08 INFO - 'MOZ_NO_REMOTE': '1', 06:01:08 INFO - 'NO_EM_RESTART': '1', 06:01:08 INFO - 'PAGER': '/bin/cat', 06:01:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:01:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:08 INFO - 'PWD': '/builds/slave/test', 06:01:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:01:08 INFO - 'SHELL': '/bin/bash', 06:01:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rj93OEWp0e/Listeners', 06:01:08 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 06:01:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:01:08 INFO - 'USER': 'cltbld', 06:01:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:01:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:01:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:08 INFO - 'XPC_FLAGS': '0x0', 06:01:08 INFO - 'XPC_SERVICE_NAME': '0', 06:01:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:01:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:01:08 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-mRsLFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:01:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:01:08 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-PyHoP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:01:08 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)) 06:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:01:08 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-9FtAnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:01:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:01:08 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-AF6ACp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:01:09 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-SEKo6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:01:09 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-cBCo17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:01:09 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-xp4TUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:01:09 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-CQajay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:01:09 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-rkUZBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:01:09 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-26BcRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:01:09 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-tX4SSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:01:09 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-N6qYLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:01:09 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-qfcmpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:01:10 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-2CRyEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:10 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-VtQGsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:01:10 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-hBP35O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:01:10 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-iLRngu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:01:10 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)) 06:01:10 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)) 06:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:01:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:12 INFO - Downloading blessings-1.6.tar.gz 06:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:01:13 INFO - Installing collected packages: blessings 06:01:13 INFO - Running setup.py install for blessings 06:01:13 INFO - Successfully installed blessings 06:01:13 INFO - Cleaning up... 06:01:13 INFO - Return code: 0 06:01:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:01:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:01:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:01:13 INFO - Reading from file tmpfile_stdout 06:01:13 INFO - Current package versions: 06:01:13 INFO - blessings == 1.6 06:01:13 INFO - blobuploader == 1.2.4 06:01:13 INFO - docopt == 0.6.1 06:01:13 INFO - manifestparser == 1.1 06:01:13 INFO - mozInstall == 1.12 06:01:13 INFO - mozcrash == 0.17 06:01:13 INFO - mozdebug == 0.1 06:01:13 INFO - mozdevice == 0.48 06:01:13 INFO - mozfile == 1.2 06:01:13 INFO - mozhttpd == 0.7 06:01:13 INFO - mozinfo == 0.9 06:01:13 INFO - mozleak == 0.1 06:01:13 INFO - mozlog == 3.1 06:01:13 INFO - moznetwork == 0.27 06:01:13 INFO - mozprocess == 0.22 06:01:13 INFO - mozprofile == 0.28 06:01:13 INFO - mozrunner == 6.11 06:01:13 INFO - mozscreenshot == 0.1 06:01:13 INFO - mozsystemmonitor == 0.0 06:01:13 INFO - moztest == 0.7 06:01:13 INFO - mozversion == 1.4 06:01:13 INFO - psutil == 3.1.1 06:01:13 INFO - requests == 1.2.3 06:01:13 INFO - wsgiref == 0.1.2 06:01:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:13 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 0x107df8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dfe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca61dd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c9cd30>, '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 0x107ac0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c93b20>, '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.zU3InvHR3P/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.rj93OEWp0e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:01:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:01:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:01:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zU3InvHR3P/Render', 06:01:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:01:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:01:13 INFO - 'HOME': '/Users/cltbld', 06:01:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:01:13 INFO - 'LOGNAME': 'cltbld', 06:01:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:13 INFO - 'MOZ_NO_REMOTE': '1', 06:01:13 INFO - 'NO_EM_RESTART': '1', 06:01:13 INFO - 'PAGER': '/bin/cat', 06:01:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:01:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:13 INFO - 'PWD': '/builds/slave/test', 06:01:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:01:13 INFO - 'SHELL': '/bin/bash', 06:01:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rj93OEWp0e/Listeners', 06:01:13 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 06:01:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:01:13 INFO - 'USER': 'cltbld', 06:01:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:01:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:01:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:13 INFO - 'XPC_FLAGS': '0x0', 06:01:13 INFO - 'XPC_SERVICE_NAME': '0', 06:01:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:01:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:01:13 INFO - Cleaning up... 06:01:13 INFO - Return code: 0 06:01:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:13 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 0x107df8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dfe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca61dd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c9cd30>, '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 0x107ac0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c93b20>, '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.zU3InvHR3P/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.rj93OEWp0e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:01:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:01:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:01:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zU3InvHR3P/Render', 06:01:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:01:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:01:13 INFO - 'HOME': '/Users/cltbld', 06:01:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:01:13 INFO - 'LOGNAME': 'cltbld', 06:01:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:13 INFO - 'MOZ_NO_REMOTE': '1', 06:01:13 INFO - 'NO_EM_RESTART': '1', 06:01:13 INFO - 'PAGER': '/bin/cat', 06:01:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:01:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:13 INFO - 'PWD': '/builds/slave/test', 06:01:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:01:13 INFO - 'SHELL': '/bin/bash', 06:01:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rj93OEWp0e/Listeners', 06:01:13 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 06:01:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:01:13 INFO - 'USER': 'cltbld', 06:01:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:01:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:01:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:13 INFO - 'XPC_FLAGS': '0x0', 06:01:13 INFO - 'XPC_SERVICE_NAME': '0', 06:01:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:01:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:14 INFO - Downloading/unpacking jsonschema 06:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:01:16 INFO - Downloading/unpacking functools32 (from jsonschema) 06:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:16 INFO - Downloading functools32-3.2.3-2.tar.gz 06:01:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:01:17 INFO - warning: no files found matching '*.txt' 06:01:17 INFO - no previously-included directories found matching 'build' 06:01:17 INFO - no previously-included directories found matching 'dist' 06:01:17 INFO - no previously-included directories found matching '.git*' 06:01:17 INFO - Installing collected packages: jsonschema, functools32 06:01:17 INFO - Running setup.py install for functools32 06:01:17 INFO - warning: no files found matching '*.txt' 06:01:17 INFO - no previously-included directories found matching 'build' 06:01:17 INFO - no previously-included directories found matching 'dist' 06:01:17 INFO - no previously-included directories found matching '.git*' 06:01:17 INFO - Successfully installed jsonschema functools32 06:01:17 INFO - Cleaning up... 06:01:17 INFO - Return code: 0 06:01:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107df8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dfe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca61dd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c9cd30>, '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 0x107ac0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c93b20>, '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.zU3InvHR3P/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.rj93OEWp0e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:01:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:01:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:01:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zU3InvHR3P/Render', 06:01:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:01:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:01:17 INFO - 'HOME': '/Users/cltbld', 06:01:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:01:17 INFO - 'LOGNAME': 'cltbld', 06:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:17 INFO - 'MOZ_NO_REMOTE': '1', 06:01:17 INFO - 'NO_EM_RESTART': '1', 06:01:17 INFO - 'PAGER': '/bin/cat', 06:01:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:17 INFO - 'PWD': '/builds/slave/test', 06:01:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:01:17 INFO - 'SHELL': '/bin/bash', 06:01:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rj93OEWp0e/Listeners', 06:01:17 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 06:01:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:01:17 INFO - 'USER': 'cltbld', 06:01:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:01:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:17 INFO - 'XPC_FLAGS': '0x0', 06:01:17 INFO - 'XPC_SERVICE_NAME': '0', 06:01:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:17 INFO - Downloading/unpacking flake8 06:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:01:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:01:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:01:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:01:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:01:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:01:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:01:21 INFO - no previously-included directories found matching 'docs/_build' 06:01:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:01:21 INFO - Running setup.py install for pep8 06:01:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:01:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:01:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:01:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:01:21 INFO - no previously-included directories found matching 'docs/_build' 06:01:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:01:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:01:21 INFO - Cleaning up... 06:01:21 INFO - Return code: 0 06:01:21 INFO - Running post-action listener: _resource_record_post_action 06:01:21 INFO - Running post-action listener: _start_resource_monitoring 06:01:21 INFO - Starting resource monitoring. 06:01:21 INFO - ##### 06:01:21 INFO - ##### Finished create-virtualenv step (success) 06:01:21 INFO - ##### 06:01:21 INFO - ##### 06:01:21 INFO - ##### Running install step. 06:01:21 INFO - ##### 06:01:21 INFO - Running pre-action listener: _resource_record_pre_action 06:01:21 INFO - Running main action method: install 06:01:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:01:21 INFO - Reading from file tmpfile_stdout 06:01:21 INFO - Detecting whether we're running mozinstall >=1.0... 06:01:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:01:21 INFO - Reading from file tmpfile_stdout 06:01:21 INFO - Output received: 06:01:21 INFO - Usage: mozinstall [options] installer 06:01:21 INFO - Options: 06:01:21 INFO - -h, --help show this help message and exit 06:01:21 INFO - -d DEST, --destination=DEST 06:01:21 INFO - Directory to install application into. [default: 06:01:21 INFO - "/builds/slave/test"] 06:01:21 INFO - --app=APP Application being installed. [default: firefox] 06:01:21 INFO - mkdir: /builds/slave/test/build/application 06:01:21 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'] 06:01:21 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 06:01:55 INFO - Reading from file tmpfile_stdout 06:01:55 INFO - Output received: 06:01:55 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:01:55 INFO - Running post-action listener: _resource_record_post_action 06:01:55 INFO - ##### 06:01:55 INFO - ##### Finished install step (success) 06:01:55 INFO - ##### 06:01:55 INFO - ##### 06:01:55 INFO - ##### Running run-tests step. 06:01:55 INFO - ##### 06:01:55 INFO - Running pre-action listener: _resource_record_pre_action 06:01:55 INFO - Running main action method: run_tests 06:01:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:01:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:01:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:01:55 INFO - 2016-05-09 06:01:55.644 screenresolution[1642:7539] starting screenresolution argv=screenresolution get 06:01:55 INFO - 2016-05-09 06:01:55.646 screenresolution[1642:7539] Display 0: 1600x1200x32@60 06:01:55 INFO - 2016-05-09 06:01:55.652 screenresolution[1643:7541] starting screenresolution argv=screenresolution list 06:01:55 INFO - Available Modes on Display 0 06:01:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:01:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:01:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:01:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:01:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:01:55 INFO - Intel Iris: 06:01:55 INFO - Chipset Model: Intel Iris 06:01:55 INFO - Type: GPU 06:01:55 INFO - Bus: Built-In 06:01:55 INFO - VRAM (Dynamic, Max): 1536 MB 06:01:55 INFO - Vendor: Intel (0x8086) 06:01:55 INFO - Device ID: 0x0a2e 06:01:55 INFO - Revision ID: 0x0009 06:01:55 INFO - Displays: 06:01:55 INFO - Display: 06:01:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:01:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:01:55 INFO - Display Serial Number: 1600x1200 60 06:01:55 INFO - Main Display: Yes 06:01:55 INFO - Mirror: Off 06:01:55 INFO - Online: Yes 06:01:55 INFO - Rotation: Supported 06:01:55 INFO - Return code: 0 06:01:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:01:55 INFO - Python 2.7.3 06:01:55 INFO - Return code: 0 06:01:55 INFO - grabbing minidump binary from tooltool 06:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:55 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c9cd30>, '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 0x107ac0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c93b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:01:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:01:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:01:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:01:55 INFO - Return code: 0 06:01:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:01:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:01:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:01:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:01:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:01:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:01:57 INFO - Return code: 0 06:01:57 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/RzInJaChQfOijPZIIQwj7w/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0090', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:01:57 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/RzInJaChQfOijPZIIQwj7w/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0090 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:01:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zU3InvHR3P/Render', 06:01:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:01:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:01:57 INFO - 'HOME': '/Users/cltbld', 06:01:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:01:57 INFO - 'LOGNAME': 'cltbld', 06:01:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:01:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:57 INFO - 'MOZ_NO_REMOTE': '1', 06:01:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:01:57 INFO - 'NO_EM_RESTART': '1', 06:01:57 INFO - 'PAGER': '/bin/cat', 06:01:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:57 INFO - 'PWD': '/builds/slave/test', 06:01:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:01:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:01:57 INFO - 'SHELL': '/bin/bash', 06:01:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rj93OEWp0e/Listeners', 06:01:57 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 06:01:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:01:57 INFO - 'USER': 'cltbld', 06:01:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:01:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:57 INFO - 'XPC_FLAGS': '0x0', 06:01:57 INFO - 'XPC_SERVICE_NAME': '0', 06:01:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:01:57 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/RzInJaChQfOijPZIIQwj7w/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0090', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:01:57 INFO - mozversion application_buildid: 20160509024850 06:01:57 INFO - mozversion application_changeset: cb53cee341a60d134fd5dc55ead4a95632a22dce 06:01:57 INFO - mozversion application_display_name: Nightly 06:01:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:01:57 INFO - mozversion application_name: Firefox 06:01:57 INFO - mozversion application_remotingname: firefox 06:01:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 06:01:57 INFO - mozversion application_vendor: Mozilla 06:01:57 INFO - mozversion application_version: 49.0a1 06:01:57 INFO - mozversion platform_buildid: 20160509024850 06:01:57 INFO - mozversion platform_changeset: cb53cee341a60d134fd5dc55ead4a95632a22dce 06:01:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 06:01:57 INFO - mozversion platform_version: 49.0a1 06:01:57 INFO - using testdate: 1462798917 06:01:57 INFO - actual date: 1462798917 06:01:57 INFO - starting webserver on 'localhost:49271' 06:01:57 INFO - SUITE-START | Running 2 tests 06:01:57 INFO - TEST-START | dromaeo_css 06:01:57 INFO - operating with platform_type : mac_ 06:01:57 INFO - Initialising browser for dromaeo_css test... 06:01:57 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmp6iI7gO/profile http://localhost:49271/getInfo.html) 06:02:00 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 06:02:00 INFO - PROCESS | 1661 | colorDepth:24 06:02:00 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 06:02:00 INFO - PROCESS | 1661 | __metrics 06:02:00 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 06:02:00 INFO - TEST-INFO | 1661: exit 0 06:02:00 INFO - Browser initialized. 06:02:00 INFO - Running cycle 1/1 for dromaeo_css test... 06:02:00 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmp6iI7gO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:02:12 INFO - PROCESS | 1664 | RSS: Main: 249974784 06:02:12 INFO - PROCESS | 1664 | 06:03:02 INFO - PROCESS | 1664 | 1462798982612 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:05:14 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 06:05:15 INFO - PROCESS | 1664 | RSS: Main: 264605696 06:05:15 INFO - PROCESS | 1664 | 06:08:17 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 06:08:18 INFO - PROCESS | 1664 | RSS: Main: 275476480 06:08:18 INFO - PROCESS | 1664 | 06:11:20 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 06:11:21 INFO - PROCESS | 1664 | RSS: Main: 277241856 06:11:21 INFO - PROCESS | 1664 | 06:14:22 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 06:14:23 INFO - PROCESS | 1664 | RSS: Main: 279109632 06:14:23 INFO - PROCESS | 1664 | 06:17:26 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 06:17:26 INFO - PROCESS | 1664 | RSS: Main: 281882624 06:17:26 INFO - PROCESS | 1664 | 06:20:29 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 06:20:29 INFO - PROCESS | 1664 | RSS: Main: 282927104 06:20:29 INFO - PROCESS | 1664 | 06:20:29 INFO - PROCESS | 1664 | __start_tp_report 06:20:29 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 06:20:29 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 06:20:29 INFO - PROCESS | 1664 | |i|pagename|runs| 06:20:29 INFO - PROCESS | 1664 | |0;dojo.html;3505.8071806050657;3512.701420379268;3530.558680164979;3538.6638269364403;3551.5915669697984;4872.805087796488;5863.970680146599;5891.499222566082;5986.8802623947495;5997.550183736226;5784.103463963082;5927.140564618138;5944.702764861761;5967.552433567489;6032.457078862902;5319.441458646835;5336.4930331618625;5367.275417818583;5417.810376636819;5466.590005749565;5362.410134885159;5525.4474552544825;5543.36251331096;5554.777808887639;5604.187392828037;5267.841964741026;5310.946890531084;5315.973420132913;5407.918881216805;5428.728563571825;5348.786048558053;5352.2506849041165;5353.330833645794;5373.408925018245;5377.11277639189;5016.648834581581;5381.408045115034;5386.326709161355;5418;5422.263917443444;5654.095344744862;5718;5750.079987202028;5760;5784.595078344518;6232.345603711636;6291.1506946562085;6299.842503937392;6318.526110541682;6323.241211054657;6201.906971395432;6382.840428989266;6395.136656551399;6406.903896441557;6415.582987105823;6046.123312119762;6093.390660933916;6096.11606317086;6119.908201376983;6142.723577439026;5476.644018138808;6465.967670161619;6483.222013358333;6549.574277671936;6560.081588577507;6135.416406698409;6201.96899015502;6260.092286618415;6285.182926219562;6300.432961033437;6197.25632924052;6262.874742505124;6407.839804004937;6407.871842563216;6413.390727880844;6181.320054793969;6219.626822390671;6306.9684651576445;6307.463865571386;6337.809865704036;5899.941000590025;6195.411435913581;6207.286162091327;6331.398517140864;6332.1135041094285;4484.215262329145;5019.222020586815;5086.287919691246;5123.308353372247;5134.229865520202;4553.1804275230115;4561.384213131251;4571.885702857455;4579.679422440464;4607.3089036644105;5864.794732184353;6014.338422773491;6058.697065146725;6083.361247069082;6132.08018797184;6402.199725034371;6418.935810641927;6431.1317972073175;6435.774747883802;6473.741050357933;6052.515798736091;6055.576109672369;6089.634621922699;6094.664793436404;6130.325664176937;5437.646552974044;5497.862553436116;5516.724163791794;5527.39198688144;5553.8333849984565;6582.802515924625;6584.473242140617;6596.406323430914;6602.8679426410245;6618.900716489353;6413.486921046212;6416.550841441054;6417.2299324081405;6431;6439.613623182624;6349.9682501587195;6446.29090800021;6453.483721302191;6474.805755827333;6488.253850807028;6327.746890124344;6330.556861019869;6333.65164915934;6334.746610135543;6346.650934198663;6396.10454536356;6412.935870641234;6416.358364163546;6431.485481161402;6436.742530298736;6077.3011103721865;6109.602875813058;6180.258368995749;6218.409251121137;6245.500359971283;5149.2276158576515;6078.270607527125;6199.876002480015;6267.373262673696;6268.404501572343;5106.7701953412925;5962.766435830609;6040.637561746309;6118.510519158545;6126.111713801563;6161.045038019114;6184.721687523982;6241.282252541016;6259.906101408574;6289.591176573508;6134.447899689049;6142.815715528542;6178.505719542336;6187.16473276102;6191.4118158774845 06:20:29 INFO - PROCESS | 1664 | |1;ext.html;507.63450315772656;521.1687358662933;524.3655177235544;554.3486403475915;555.6638233868512;36673.633263667354;37911.81044094779;39691.801540992325;39725.602743972624;39871;40725.981850453754;40819.59180408195;41528;41532.377014344806;41579.58420415795;9370.016148304416;9601.711948641552;9614.423134611945;9663;9731.902680973206;9523.619055237783;9534.094261045224;9552.283578731589;9564.856527152098;9630.80738385232;9612.759681007961;9629.518524073768;9633.66282180124;9688.951555242214;9725.173360264385;9580.712578622653;9684.661036863747;9687;9687.273454490942;9735.123838854537;9520.428774273565;9619.326647134703;9626;9638.42169469834;9639.277054220962;31379.68620313813;37780;37985.67050153259;38273.23453530914;38312.85061448161;2743.7804975602103;2962.377900640868;3049.420610084077;3142.6543080261154;3229.9664107485614;22280.220192293193;27883;28104.718952810414;28453.430931381463;28504.144875653765;2665.9066932657456;2687.6506054213023;2696.339396847785;2740.3012231880944;2743.0262256898914;400238;405317;405723;407288.9635551833;412913;35686.10784730351;36099.278014439566;36213;36241.27517449636;36320.636793631726;36505.63494365022;37164.25671486609;37469;37832;37941.43087853684;15193.316300766272;15357.308921098578;15646.452374166849;15649.29578168985;15684.607884802743;12601.621951341474;12801.743965120646;13119.540816071392;13158.671033224055;13175.736485270241;8294.58527073644;8300.792480187924;8336.041355244224;8347.165283471604;8387.748367548984;3466.2374277658873;3485.9477107843404;3493.21402684394;3494.266204097117;3541.220931395089;929.5816882402946;950.695777351241;986.6645340584236;1041.4584416103585;1143.1026644084354;21820.78179218219;29799.851000744857;30460.84769576138;31379.84310078435;31422.68577314243;1014.7818219082933;1062.617457715222;1082.8971247731454;1151.0791366906442;1160.4139909345727;12577.930875875652;14110.294485275695;15316.310766015557;15596.298166582532;15603.141827199386;694702;698378;703706;705205;706929;60411.697941510014;60644.69677651583;60773.39226607766;61159.694201528706;61259;1409.598264494614;1467.5303902751018;1511.1839606612307;1524.6036030631894;1525.4660868695867;24495.51008979846;29326.26684332909;29764.85117574398;30147.547786782776;30150.69849301479;53357.733211333696;53476.46523534715;53871;53946.730266348415;54006.729966349914;570520;571936;575964;576447;578496;26254.34364140912;26429.471410571296;26437.206883792747;26987.460250795266;27757;45860.8534786633;46551.06897862092;46779.766101169276;46864.297035545176;47035.05929881315;37814.054648632904;38041.42937855879;38274.617253827106;38453.65924341835;39177.82466526009;37419.43870841885;37767.62232377751;37883.62116378801;38045.47818087246;38616.8414947552;36832;37208.88373348804;37689.24621507609;38077;38203.85388438351;27053.59419608747;32810.835945820116;32880.34239315153;33208;33664.15839604029;21924.780752192273;23273.952672130134;24784;24788.628170577096;24800.379990500383 06:20:29 INFO - PROCESS | 1664 | |2;jquery.html;384.87683941138835;395.53524608584905;395.72892568590515;402.09327965437967;422.72100413726946;19799.802001979977;21111.944402779878;21213.045412956417;21421.14315427381;21925.23261685841;20676.689849652266;20883.582328353423;21431.892840535813;21646.24238151665;21681.02435390407;5192;5890.293164820217;6141.692915354214;6141.815745527641;6150.169727086831;6054.455099041085;6079;6136.631802091889;6136.754529818824;6194;5847.824565263028;6052.243469566304;6054.969725151368;6082.209312789353;6093.207882975207;5412.539934105605;5711.171880077407;5804.722960948585;6020.969895150518;6050.485708714765;5766.394528574523;5769.672975215682;5811.651300921958;5909.084091965752;5924.20023296858;13886.722265554734;18041.007744574043;19293.61412771751;21059.78940210609;26383.94464221429;1860.3302810988034;2038.613742654994;2447.7919376852988;2499.46261553765;2747.9450410991867;9789.90210097897;10062.446565438899;10379.42913139777;11993;15628.92185539065;1709.4187976088065;1712.221253270213;1733.159417682423;1742.4249997500795;1797.748315235868;92514;122629;126906;127729.36135319264;128689;11733.4719937603;11836.88163118375;11888.28670279786;11928.343941083323;12050.457729402022;15066.171360575054;15149.697006060038;15192.924035379752;15410.537683869501;15475.535733928;7469.85060298791;8798.208161265517;8903.243224326005;8986.786783784237;9006.684766033157;8779.29765618749;8856;8883.955580222188;8894.243989260856;8969.775755606031;4661.976690116596;4728.503507131771;4750.453697824794;4782;4841.394825646794;1970.881747095179;2003.4891102768702;2062.484378905274;2066.359428577146;2106.599746048246;798.8961435013412;923.1507013547553;956.1920177450044;1032.1902561636398;1054.836500342448;17439.60483161344;19185.90407047984;20392;21105.89447052755;21253.36239912805;1010.540204207084;1020.4795554267378;1064.8402739589123;1088.6081010836092;1090.1224514266091;11058.612948546763;11434.371109589052;11464.828027579593;11487.483063262172;11499.137564682682;620340;623632;633875;639607;640960;102208;137653;137890;149136.2543187277;160457;1024.9436281004466;1056.7146870345118;1070.1224995503612;1078.0567003871613;1079.4818487126224;18927;19091.61816763629;19098.427047188605;19137.808621913602;19139.234430623175;47639.76180119077;49430.517084487525;49687.503124969735;50476.242856356446;50646.74676626593;72379.27620723726;73693;74748.62625687054;75192;77450.6127469359;5862.973979553476;7118.644067796486;7644.885326720215;8003.3597312213715;8407.8738818919;10869.456527173452;11590.130740194687;12457.1902826316;12518.937405312916;12941.935290323489;9314.161725444743;10614;10682.73293167677;10863.511141998788;10997.670069897917;10385.013423724735;10543;10917.617883374043;11047.392393418439;11241;9104.817903642022;10890.23768336209;11042.33745975244;11342.319460832376;11651.30092194471;6471.899777037821;6962.721491140298;7610.847783044419;7639.121501027231;7766.650500727368;9412.95293523528;10054.447005414773;10897.964693354119;10995.725106872393;11121 06:20:29 INFO - PROCESS | 1664 | |3;mootools.html;1628.7394016957285;1655.9337626494942;1918.3573502876536;1950.5026218314329;2004.8095430934056;7961.880571791427;8553.957230213848;8650.56747162641;9050.004499505048;9052.230560402366;8699.434536755107;8738.03881573028;8767.254783343424;8856.91143088569;8892.110788921105;2381.4641705616273;2405.3144853716694;2416.4079800448912;2419.032387045187;2425.9029638814427;2412.2522018174336;2415.311636183688;2436.8294219404647;2441.7314095449487;2455.3002394317623;2423;2424.490856920049;2433.9634905476432;2442.05980697431;2447.596146635803;2390.1992832401165;2397.0172229385958;2403.3150552092657;2414.1791790791126;2415.1667674652217;2382.5830479665988;2399.9520009599887;2402.423418379594;2403.098837935774;2408.9397765055837;8847.159519845605;8923.776905577413;8930.151635594608;8939.150780675825;8940.955295223483;4058.8782336529953;5395.190721391783;5424.403315635277;5445.673259604437;5464.535514481274;3427.9485807712904;3512.3502152101687;3603.4234522476277;3603.9099022524383;3616.945745813815;1030.3354336453021;1036.5542816588863;1042.6246551241547;1048.5858086055964;1065.1957771882257;11662.183647144704;11704.648860534198;11846;11882.702932426671;11894.286342819372;4560.087982403533;4563.292689633112;4677.2750223715375;4699.906001879944;4701;9239.076092390707;9293.39592926471;9309.813803724022;9340.206082483064;9353.298502612195;5228.712420816892;5268.394134674485;5288.65623734456;5305.920411193835;5312.203169524602;4366.978165109154;4708.364370809965;4873.951260487421;4958.45456999737;4971.627127965345;3740.8503659853845;3913.5108111486065;4086.959130408717;4155.148194620096;4185.727927684691;1344.4151793969654;1354.1739538881275;1358.151155527795;1366.5626999360109;1370.506617617657;922.280621115531;948.9051094890593;949.7388218240039;961.110972350573;964.4550828781715;5148.56237219833;5292.967871265143;5899.823005309848;6051;6058;442.7365717398143;449.3260109835247;450.56070331427253;453.0734647645573;477.5701868318472;3541.486484459739;3776.169242766587;4018.2566225248424;4092.7544347339253;4100.179964007151;10328.380297182193;10794;10852.837207441895;10908.61819836302;10932.125429965583;10776.622818201326;10879.782404351869;10890.509927053301;10948.671539853816;10951.616693415692;7776.883346749803;8252.8349433011;8285.50286982771;8318.37612179089;8388;6043.54673399488;6057.061155520902;6131.233595800525;6146.170267014075;6196.845078873064;9808.85286720714;10016.749581260236;10119.59521619127;10142;10164.695059148238;9619.470929098967;9917.801643966935;10193.439360835226;10247.231457640557;10344.431056291674;7004.614746189009;7443.069616297963;7619.923800762143;7689.192634773492;7793.688252469838;8351.749447516584;8366.665333386596;8473.067962524241;8507.021692505194;8537.53043582609;7367.77896663101;7504.549727016397;7557.093148822177;7559.357454616419;7578.280063393969;7420.146683131509;7459.477836551389;7461.92538074634;7577.583232922242;7588.81027974305;7052.929470705228;7061.71753129869;7126.429885609243;7136.000959865519;7168.856622867409;4873.610111191168;5001.42483614389;5037.395512538519;5061.519155680205;5153.046686362885;4979.203327467588;5045.974770126126;5106.948930510796;5139.997700448376;5320.467953204648 06:20:29 INFO - PROCESS | 1664 | |4;prototype.html;311.24523031648255;314.63502337288736;322.4840255591055;330.67428582845895;330.7932542161149;5370.731463426823;5501.642393244446;5519.50324470798;5558.666480011202;5657.717114144291;4364.9781751091205;5513.807016754415;5561.332640083186;5598.356189038262;5606.831795046145;4238.512571054322;4245.490541135068;4252.702310838243;4267.935980960273;4268.487781466229;3911.178652482982;4121.9175616487655;4187.246295666779;4245.872623821275;4261.872143835674;4126.504819421659;4164;4182.184474027566;4187.895302617429;4218.746875187483;3930.724849260553;4024.973631723921;4191.7694526801015;4215.45199124115;4217.283061879472;3205.9038228853174;3231.2568109334984;3495.3009398120475;3598.5861625913094;3625.347437461256;5073.604758691353;5298.311219541473;5325.857743931099;5338.185017094168;5340.54605358545;4018.874715079753;4753.3582966299455;4789.49710280419;4798.280257961299;4845.248986407112;5222.8694282642855;5471.5896307777075;5594.664320140804;5803.314895041637;5863.413658634145;3563.2695297464215;3584.4623306503972;3775.8112094395447;4027.51669799623;4050.0482386639114;5463.098588732854;6016.428439298304;6095;6158.3841615838055;6175.320714721377;3432.0608855996284;3779.622037796253;3836.827342769582;4061.0354441257455;4063.004563881868;3485.3203625292826;3842.6733727633464;3918.5885482024546;4097.783240156463;4174.912543728136;4797.136515427256;4797.424309082862;4799.832005879777;4803.567678908915;4823.469418363977;4747.869353662336;5472.097103977799;5689.459501347365;5831;5834.591578589543;1160.1762748448527;1211.9274442118788;1305.7790965447336;1352.8230439517683;1369.657585603599;795.1611050341829;841.7306461932122;866.9726374246538;870.0299166429386;888.2938064238816;4457.331400289982;4644.674872758875;4644.676267263813;4869.975650121727;4980.626453016038;5098.623371689697;5186.92219616706;5353.411124776271;5538.418466061086;5733.455321744427;4182.937255941163;4692.9530704692515;4814.759262036954;5045.217991211368;5079.136546786981;2652.9469410611678;2756.54517004692;2794.7842688430596;2972.5689774982507;3015.8793648253823;4953.18272485036;5239.956416997374;5466.753996070186;5919.661733615284;6028.246469191351;4660.697054691502;5191.430242030219;5385.811496597678;5453.727313634303;6002.199340197923;5216.817411390583;5566.109422492382;5951.256092988377;5962.344142144448;6019.247594050744;4503.932441013453;5158.226266060121;5228.947710522846;5352.768863161573;5615.989121957923;4827.42070951488;5035.597152227886;5406.324209473659;5476.2607048049595;5660.962053660761;5368.651037682538;5448.645838020516;5994.340622531605;6031;6039.818805435844;3631.8728844490315;3730.403135498307;3734.8879533614036;3748.9690335158048;3784.0918179636137;5263.9210411844615;5450.863728406822;5594.748236329294;5748.568857335633;5842.503387212135;5210.97141258672;5241.077582331941;5733.655980641175;5783.219265399117;5841.50347220491;4953.18272485036;5064.5819170632285;5713.257276554022;5800.274965629296;5812.796552120655;5037.924431133462;5369.818639899216;5555.833325000256;5678.290213723285;5707.5433965281845;5194.610404219774;5374.758135883816;5868.975203554767;5871.7651293947765;5965.552583556338;5305.628605997543;5744.712764361849;5787.742780315596;5792.333881603501;5813.883722325614 06:20:29 INFO - PROCESS | 1664 | |5;yui.html;641.9133416988707;741.2143128284023;747.8691229034918;748.0574476160036;757.6666266842589;11218.719532011704;14362.928185359071;15338.233088345565;15437.691246175069;15451.304691288891;14800.555983320492;15411.537653870373;15411.69176616467;15637.374505019814;15648.84351156488;717.9030830837848;922.6447817590225;923.4920793563547;928.9163975242227;930.1070971866982;860.3461369359301;909.9272058235358;912.4479689787682;913.7806926337664;926.9026752191024;935.7426707655382;964.0407794244736;964.8600952861831;965.652365148546;966.2559828931718;945.4043952310069;955.3694561589317;956.364017928077;957.1720461800562;959.3620242538703;719.133444199738;720.5244538604496;723.3670538279006;724.4494184419826;724.7318492157883;14375.78436323456;14605.415783368653;14610.488632897905;14629.634259143606;14640.853591464162;12081.6375508734;12104.455299511455;12128.090393220455;12191.390430478441;12473.685520193061;8183;8776.912230877673;9597.992210817833;9720.222382209406;9765.902340976641;3410.660934016331;3426.691597756189;3448.6551344865566;3450.896473105786;3537.451694987281;50144;59380;70709.64645176793;78031.60984195043;80229.99999999942;9046.547672616343;9074.047225041408;9168.404053736485;9266.397684150508;9449.527523623929;20626.896865515577;20750.792492075187;20768.273110441063;20913.268035618985;20935.79064209369;5958.582899197015;7230.2046774854725;7461.515001524884;7525.962370188114;7575.545467271982;3929.2927273090545;3968.3650615901893;4018.216447792711;4041.4341992121126;4064.207479541461;3384.966150338514;3406.437937740245;3492.2666240089357;3504.649535046526;3505.6844883960566;596.3887015808831;649.8018104478085;651.2250421997808;652.5366989437553;654.4535313013591;487.7804987755524;512.3876967024445;553.242058380022;577.6938222741953;583.2272239282967;7679.500832445985;7752.186020467882;7820.7262745804765;7901.723439679584;8006.599670016476;564.8559617297562;567.7643777832153;580.2447596021983;589.6904125334233;593.24657684741;3777.8299976501125;3784.7350685452307;3836.3094642963974;3837.1558257183374;3877.806109694504;92089.53955230181;94291.52854235684;94957;95575;97066.5146674262;50614.746926265136;72163.55672886512;80321.59839200767;84470.5776471126;84855;67005.32994670089;67231;68601;68931;69099.65450172717;6180.938190618036;7220.675069621985;7369.336759691439;7430.517016393917;7501.474896757175;46234.53765462437;46826.614939281055;46891.76554117208;47057.529424706685;47216.445368742214;46679;54315.91368172535;61772.911354432996;64646.67676661586;66302.34244143935;9568.90431095708;9607.56765945548;9658;9658.806823863624;10360.481975901326;10838.132949363875;11177.385243811668;11214.046806021579;11302.886971130512;11355.261907975955;9697.272704547328;9864.260180486635;9869.802603948025;9927.056929591678;10155.136813370946;10002.549885255035;10030.548625312025;10166.796664066826;10197.082262596401;10200.489975501343;9956.153726933002;10008.64969726056;11001.779964400506;11202.88797112051;11250.549978000789;9219.308551858772;9362.578683959102;9380.108889655472;9670.129688328085;9780.41317520951;8897.154770297071;8990;9079.818403632022;9423.670171544238;9450.747163776465 06:20:29 INFO - PROCESS | 1664 | __end_tp_report 06:20:29 INFO - PROCESS | 1664 | __start_cc_report 06:20:29 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,427 06:20:29 INFO - PROCESS | 1664 | __end_cc_report 06:20:29 INFO - PROCESS | 1664 | __startTimestamp1462800029498__endTimestamp 06:20:29 INFO - PROCESS | 1664 | 06:20:29 INFO - PROCESS | 1664 | ------- Summary: start ------- 06:20:29 INFO - PROCESS | 1664 | Number of tests: 6 06:20:29 INFO - PROCESS | 1664 | 06:20:29 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5884.37 Median:6126.11 stddev:650.31 (10.6%) stddev-sans-first:624.96 06:20:29 INFO - PROCESS | 1664 | Values: 3505.8 3512.7 3530.6 3538.7 3551.6 4872.8 5864.0 5891.5 5986.9 5997.6 5784.1 5927.1 5944.7 5967.6 6032.5 5319.4 5336.5 5367.3 5417.8 5466.6 5362.4 5525.4 5543.4 5554.8 5604.2 5267.8 5310.9 5316.0 5407.9 5428.7 5348.8 5352.3 5353.3 5373.4 5377.1 5016.6 5381.4 5386.3 5418.0 5422.3 5654.1 5718.0 5750.1 5760.0 5784.6 6232.3 6291.2 6299.8 6318.5 6323.2 6201.9 6382.8 6395.1 6406.9 6415.6 6046.1 6093.4 6096.1 6119.9 6142.7 5476.6 6466.0 6483.2 6549.6 6560.1 6135.4 6202.0 6260.1 6285.2 6300.4 6197.3 6262.9 6407.8 6407.9 6413.4 6181.3 6219.6 6307.0 6307.5 6337.8 5899.9 6195.4 6207.3 6331.4 6332.1 4484.2 5019.2 5086.3 5123.3 5134.2 4553.2 4561.4 4571.9 4579.7 4607.3 5864.8 6014.3 6058.7 6083.4 6132.1 6402.2 6418.9 6431.1 6435.8 6473.7 6052.5 6055.6 6089.6 6094.7 6130.3 5437.6 5497.9 5516.7 5527.4 5553.8 6582.8 6584.5 6596.4 6602.9 6618.9 6413.5 6416.6 6417.2 6431.0 6439.6 6350.0 6446.3 6453.5 6474.8 6488.3 6327.7 6330.6 6333.7 6334.7 6346.7 6396.1 6412.9 6416.4 6431.5 6436.7 6077.3 6109.6 6180.3 6218.4 6245.5 5149.2 6078.3 6199.9 6267.4 6268.4 5106.8 5962.8 6040.6 6118.5 6126.1 6161.0 6184.7 6241.3 6259.9 6289.6 6134.4 6142.8 6178.5 6187.2 6191.4 06:20:29 INFO - PROCESS | 1664 | 06:20:29 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:67456.11 Median:37897.72 stddev:154118.73 (406.7%) stddev-sans-first:154469.10 06:20:29 INFO - PROCESS | 1664 | Values: 507.6 521.2 524.4 554.3 555.7 36673.6 37911.8 39691.8 39725.6 39871.0 40726.0 40819.6 41528.0 41532.4 41579.6 9370.0 9601.7 9614.4 9663.0 9731.9 9523.6 9534.1 9552.3 9564.9 9630.8 9612.8 9629.5 9633.7 9689.0 9725.2 9580.7 9684.7 9687.0 9687.3 9735.1 9520.4 9619.3 9626.0 9638.4 9639.3 31379.7 37780.0 37985.7 38273.2 38312.9 2743.8 2962.4 3049.4 3142.7 3230.0 22280.2 27883.0 28104.7 28453.4 28504.1 2665.9 2687.7 2696.3 2740.3 2743.0 400238.0 405317.0 405723.0 407289.0 412913.0 35686.1 36099.3 36213.0 36241.3 36320.6 36505.6 37164.3 37469.0 37832.0 37941.4 15193.3 15357.3 15646.5 15649.3 15684.6 12601.6 12801.7 13119.5 13158.7 13175.7 8294.6 8300.8 8336.0 8347.2 8387.7 3466.2 3485.9 3493.2 3494.3 3541.2 929.6 950.7 986.7 1041.5 1143.1 21820.8 29799.9 30460.8 31379.8 31422.7 1014.8 1062.6 1082.9 1151.1 1160.4 12577.9 14110.3 15316.3 15596.3 15603.1 694702.0 698378.0 703706.0 705205.0 706929.0 60411.7 60644.7 60773.4 61159.7 61259.0 1409.6 1467.5 1511.2 1524.6 1525.5 24495.5 29326.3 29764.9 30147.5 30150.7 53357.7 53476.5 53871.0 53946.7 54006.7 570520.0 571936.0 575964.0 576447.0 578496.0 26254.3 26429.5 26437.2 26987.5 27757.0 45860.9 46551.1 46779.8 46864.3 47035.1 37814.1 38041.4 38274.6 38453.7 39177.8 37419.4 37767.6 37883.6 38045.5 38616.8 36832.0 37208.9 37689.2 38077.0 38203.9 27053.6 32810.8 32880.3 33208.0 33664.2 21924.8 23274.0 24784.0 24788.6 24800.4 06:20:29 INFO - PROCESS | 1664 | 06:20:29 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:35977.24 Median:21162.49 stddev:105454.42 (498.3%) stddev-sans-first:105716.39 06:20:29 INFO - PROCESS | 1664 | Values: 384.9 395.5 395.7 402.1 422.7 19799.8 21111.9 21213.0 21421.1 21925.2 20676.7 20883.6 21431.9 21646.2 21681.0 5192.0 5890.3 6141.7 6141.8 6150.2 6054.5 6079.0 6136.6 6136.8 6194.0 5847.8 6052.2 6055.0 6082.2 6093.2 5412.5 5711.2 5804.7 6021.0 6050.5 5766.4 5769.7 5811.7 5909.1 5924.2 13886.7 18041.0 19293.6 21059.8 26383.9 1860.3 2038.6 2447.8 2499.5 2747.9 9789.9 10062.4 10379.4 11993.0 15628.9 1709.4 1712.2 1733.2 1742.4 1797.7 92514.0 122629.0 126906.0 127729.4 128689.0 11733.5 11836.9 11888.3 11928.3 12050.5 15066.2 15149.7 15192.9 15410.5 15475.5 7469.9 8798.2 8903.2 8986.8 9006.7 8779.3 8856.0 8884.0 8894.2 8969.8 4662.0 4728.5 4750.5 4782.0 4841.4 1970.9 2003.5 2062.5 2066.4 2106.6 798.9 923.2 956.2 1032.2 1054.8 17439.6 19185.9 20392.0 21105.9 21253.4 1010.5 1020.5 1064.8 1088.6 1090.1 11058.6 11434.4 11464.8 11487.5 11499.1 620340.0 623632.0 633875.0 639607.0 640960.0 102208.0 137653.0 137890.0 149136.3 160457.0 1024.9 1056.7 1070.1 1078.1 1079.5 18927.0 19091.6 19098.4 19137.8 19139.2 47639.8 49430.5 49687.5 50476.2 50646.7 72379.3 73693.0 74748.6 75192.0 77450.6 5863.0 7118.6 7644.9 8003.4 8407.9 10869.5 11590.1 12457.2 12518.9 12941.9 9314.2 10614.0 10682.7 10863.5 10997.7 10385.0 10543.0 10917.6 11047.4 11241.0 9104.8 10890.2 11042.3 11342.3 11651.3 6471.9 6962.7 7610.8 7639.1 7766.7 9413.0 10054.4 10898.0 10995.7 11121.0 06:20:29 INFO - PROCESS | 1664 | 06:20:29 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5736.57 Median:4873.78 stddev:3213.09 (65.9%) stddev-sans-first:3207.28 06:20:29 INFO - PROCESS | 1664 | Values: 1628.7 1655.9 1918.4 1950.5 2004.8 7961.9 8554.0 8650.6 9050.0 9052.2 8699.4 8738.0 8767.3 8856.9 8892.1 2381.5 2405.3 2416.4 2419.0 2425.9 2412.3 2415.3 2436.8 2441.7 2455.3 2423.0 2424.5 2434.0 2442.1 2447.6 2390.2 2397.0 2403.3 2414.2 2415.2 2382.6 2400.0 2402.4 2403.1 2408.9 8847.2 8923.8 8930.2 8939.2 8941.0 4058.9 5395.2 5424.4 5445.7 5464.5 3427.9 3512.4 3603.4 3603.9 3616.9 1030.3 1036.6 1042.6 1048.6 1065.2 11662.2 11704.6 11846.0 11882.7 11894.3 4560.1 4563.3 4677.3 4699.9 4701.0 9239.1 9293.4 9309.8 9340.2 9353.3 5228.7 5268.4 5288.7 5305.9 5312.2 4367.0 4708.4 4874.0 4958.5 4971.6 3740.9 3913.5 4087.0 4155.1 4185.7 1344.4 1354.2 1358.2 1366.6 1370.5 922.3 948.9 949.7 961.1 964.5 5148.6 5293.0 5899.8 6051.0 6058.0 442.7 449.3 450.6 453.1 477.6 3541.5 3776.2 4018.3 4092.8 4100.2 10328.4 10794.0 10852.8 10908.6 10932.1 10776.6 10879.8 10890.5 10948.7 10951.6 7776.9 8252.8 8285.5 8318.4 8388.0 6043.5 6057.1 6131.2 6146.2 6196.8 9808.9 10016.7 10119.6 10142.0 10164.7 9619.5 9917.8 10193.4 10247.2 10344.4 7004.6 7443.1 7619.9 7689.2 7793.7 8351.7 8366.7 8473.1 8507.0 8537.5 7367.8 7504.5 7557.1 7559.4 7578.3 7420.1 7459.5 7461.9 7577.6 7588.8 7052.9 7061.7 7126.4 7136.0 7168.9 4873.6 5001.4 5037.4 5061.5 5153.0 4979.2 5046.0 5106.9 5140.0 5320.5 06:20:29 INFO - PROCESS | 1664 | 06:20:29 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:4568.42 Median:5088.88 stddev:1399.84 (27.5%) stddev-sans-first:1366.81 06:20:29 INFO - PROCESS | 1664 | Values: 311.2 314.6 322.5 330.7 330.8 5370.7 5501.6 5519.5 5558.7 5657.7 4365.0 5513.8 5561.3 5598.4 5606.8 4238.5 4245.5 4252.7 4267.9 4268.5 3911.2 4121.9 4187.2 4245.9 4261.9 4126.5 4164.0 4182.2 4187.9 4218.7 3930.7 4025.0 4191.8 4215.5 4217.3 3205.9 3231.3 3495.3 3598.6 3625.3 5073.6 5298.3 5325.9 5338.2 5340.5 4018.9 4753.4 4789.5 4798.3 4845.2 5222.9 5471.6 5594.7 5803.3 5863.4 3563.3 3584.5 3775.8 4027.5 4050.0 5463.1 6016.4 6095.0 6158.4 6175.3 3432.1 3779.6 3836.8 4061.0 4063.0 3485.3 3842.7 3918.6 4097.8 4174.9 4797.1 4797.4 4799.8 4803.6 4823.5 4747.9 5472.1 5689.5 5831.0 5834.6 1160.2 1211.9 1305.8 1352.8 1369.7 795.2 841.7 867.0 870.0 888.3 4457.3 4644.7 4644.7 4870.0 4980.6 5098.6 5186.9 5353.4 5538.4 5733.5 4182.9 4693.0 4814.8 5045.2 5079.1 2652.9 2756.5 2794.8 2972.6 3015.9 4953.2 5240.0 5466.8 5919.7 6028.2 4660.7 5191.4 5385.8 5453.7 6002.2 5216.8 5566.1 5951.3 5962.3 6019.2 4503.9 5158.2 5228.9 5352.8 5616.0 4827.4 5035.6 5406.3 5476.3 5661.0 5368.7 5448.6 5994.3 6031.0 6039.8 3631.9 3730.4 3734.9 3749.0 3784.1 5263.9 5450.9 5594.7 5748.6 5842.5 5211.0 5241.1 5733.7 5783.2 5841.5 4953.2 5064.6 5713.3 5800.3 5812.8 5037.9 5369.8 5555.8 5678.3 5707.5 5194.6 5374.8 5869.0 5871.8 5965.6 5305.6 5744.7 5787.7 5792.3 5813.9 06:20:29 INFO - PROCESS | 1664 | 06:20:29 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:17237.46 Median:33478.40 stddev:24453.13 (73.0%) stddev-sans-first:24489.98 06:20:29 INFO - PROCESS | 1664 | Values: 641.9 741.2 747.9 748.1 757.7 11218.7 14362.9 15338.2 15437.7 15451.3 14800.6 15411.5 15411.7 15637.4 15648.8 717.9 922.6 923.5 928.9 930.1 860.3 909.9 912.4 913.8 926.9 935.7 964.0 964.9 965.7 966.3 945.4 955.4 956.4 957.2 959.4 719.1 720.5 723.4 724.4 724.7 14375.8 14605.4 14610.5 14629.6 14640.9 12081.6 12104.5 12128.1 12191.4 12473.7 8183.0 8776.9 9598.0 9720.2 9765.9 3410.7 3426.7 3448.7 3450.9 3537.5 50144.0 59380.0 70709.6 78031.6 80230.0 9046.5 9074.0 9168.4 9266.4 9449.5 20626.9 20750.8 20768.3 20913.3 20935.8 5958.6 7230.2 7461.5 7526.0 7575.5 3929.3 3968.4 4018.2 4041.4 4064.2 3385.0 3406.4 3492.3 3504.6 3505.7 596.4 649.8 651.2 652.5 654.5 487.8 512.4 553.2 577.7 583.2 7679.5 7752.2 7820.7 7901.7 8006.6 564.9 567.8 580.2 589.7 593.2 3777.8 3784.7 3836.3 3837.2 3877.8 92089.5 94291.5 94957.0 95575.0 97066.5 50614.7 72163.6 80321.6 84470.6 84855.0 67005.3 67231.0 68601.0 68931.0 69099.7 6180.9 7220.7 7369.3 7430.5 7501.5 46234.5 46826.6 46891.8 47057.5 47216.4 46679.0 54315.9 61772.9 64646.7 66302.3 9568.9 9607.6 9658.0 9658.8 10360.5 10838.1 11177.4 11214.0 11302.9 11355.3 9697.3 9864.3 9869.8 9927.1 10155.1 10002.5 10030.5 10166.8 10197.1 10200.5 9956.2 10008.6 11001.8 11202.9 11250.5 9219.3 9362.6 9380.1 9670.1 9780.4 8897.2 8990.0 9079.8 9423.7 9450.7 06:20:29 INFO - PROCESS | 1664 | -------- Summary: end -------- 06:20:29 INFO - PROCESS | 1664 | 06:20:30 INFO - TEST-INFO | 1664: exit 0 06:20:30 INFO - TEST-OK | dromaeo_css | took 1112918ms 06:20:30 INFO - TEST-START | kraken 06:20:30 INFO - operating with platform_type : mac_ 06:20:30 INFO - Initialising browser for kraken test... 06:20:30 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpoNM0k0/profile http://localhost:49271/getInfo.html) 06:20:32 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 06:20:32 INFO - PROCESS | 1675 | colorDepth:24 06:20:32 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 06:20:32 INFO - PROCESS | 1675 | __metrics 06:20:33 ERROR - PROCESS | 1675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 06:20:33 INFO - TEST-INFO | 1675: exit 0 06:20:33 INFO - Browser initialized. 06:20:33 INFO - Running cycle 1/1 for kraken test... 06:20:33 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpoNM0k0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:20:45 INFO - PROCESS | 1678 | RSS: Main: 250036224 06:20:45 INFO - PROCESS | 1678 | 06:20:48 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 06:20:49 INFO - PROCESS | 1678 | RSS: Main: 261898240 06:20:49 INFO - PROCESS | 1678 | 06:20:52 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 06:20:52 INFO - PROCESS | 1678 | RSS: Main: 266559488 06:20:52 INFO - PROCESS | 1678 | 06:20:56 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 06:20:56 INFO - PROCESS | 1678 | RSS: Main: 266895360 06:20:56 INFO - PROCESS | 1678 | 06:20:58 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 06:20:59 INFO - PROCESS | 1678 | RSS: Main: 267546624 06:20:59 INFO - PROCESS | 1678 | 06:21:01 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:21:02 INFO - PROCESS | 1678 | RSS: Main: 268107776 06:21:02 INFO - PROCESS | 1678 | 06:21:05 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 06:21:05 INFO - PROCESS | 1678 | RSS: Main: 268607488 06:21:05 INFO - PROCESS | 1678 | 06:21:09 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 06:21:09 INFO - PROCESS | 1678 | RSS: Main: 269221888 06:21:09 INFO - PROCESS | 1678 | 06:21:13 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 06:21:13 INFO - PROCESS | 1678 | RSS: Main: 268779520 06:21:13 INFO - PROCESS | 1678 | 06:21:15 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:21:16 INFO - PROCESS | 1678 | RSS: Main: 268288000 06:21:16 INFO - PROCESS | 1678 | 06:21:18 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:21:18 INFO - PROCESS | 1678 | RSS: Main: 268259328 06:21:18 INFO - PROCESS | 1678 | 06:21:21 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:21:21 INFO - PROCESS | 1678 | RSS: Main: 268611584 06:21:21 INFO - PROCESS | 1678 | 06:21:25 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:21:25 INFO - PROCESS | 1678 | RSS: Main: 268914688 06:21:25 INFO - PROCESS | 1678 | 06:21:28 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:21:29 INFO - PROCESS | 1678 | RSS: Main: 268673024 06:21:29 INFO - PROCESS | 1678 | 06:21:31 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 06:21:31 INFO - PROCESS | 1678 | RSS: Main: 271298560 06:21:31 INFO - PROCESS | 1678 | 06:21:31 INFO - PROCESS | 1678 | __start_tp_report 06:21:31 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 06:21:31 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 06:21:31 INFO - PROCESS | 1678 | |i|pagename|runs| 06:21:31 INFO - PROCESS | 1678 | |0;ai-astar;112;116;108;123;175;171;108;112;117;114 06:21:31 INFO - PROCESS | 1678 | |1;audio-beat-detection;159;128;147;202;125;140;141;124;172;119 06:21:31 INFO - PROCESS | 1678 | |2;audio-dft;225;267;229;193;194;201;201;196;196;214 06:21:31 INFO - PROCESS | 1678 | |3;audio-fft;77;84;75;174;70;83;82;103;139;52 06:21:31 INFO - PROCESS | 1678 | |4;audio-oscillator;82;83;147;78;82;87;121;83;82;123 06:21:31 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;89;85;88;103;113;85;90;88;88;90 06:21:31 INFO - PROCESS | 1678 | |6;imaging-darkroom;95;96;97;130;150;95;96;104;123;96 06:21:31 INFO - PROCESS | 1678 | |7;imaging-desaturate;123;85;127;77;120;144;135;92;92;88 06:21:31 INFO - PROCESS | 1678 | |8;json-parse-financial;61;64;63;62;64;63;62;125;84;59 06:21:31 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;68;65;60;72;76;93;100;101;101;98 06:21:31 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;98;108;76;98;107;109;113;95;86;87 06:21:31 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;140;145;139;143;159;157;137;158;279;162 06:21:31 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;170;175;187;233;197;170;174;171;168;193 06:21:31 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;67;68;69;80;91;91;85;79;72;68 06:21:31 INFO - PROCESS | 1678 | __end_tp_report 06:21:31 INFO - PROCESS | 1678 | __start_cc_report 06:21:31 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1066 06:21:31 INFO - PROCESS | 1678 | __end_cc_report 06:21:31 INFO - PROCESS | 1678 | __startTimestamp1462800091495__endTimestamp 06:21:31 INFO - PROCESS | 1678 | 06:21:31 INFO - PROCESS | 1678 | ------- Summary: start ------- 06:21:31 INFO - PROCESS | 1678 | Number of tests: 14 06:21:31 INFO - PROCESS | 1678 | 06:21:31 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:125.60 Median:116.50 stddev:25.38 (21.8%) stddev-sans-first:26.44 06:21:31 INFO - PROCESS | 1678 | Values: 112.0 116.0 108.0 123.0 175.0 171.0 108.0 112.0 117.0 114.0 06:21:31 INFO - PROCESS | 1678 | 06:21:31 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:144.00 stddev:25.86 (18.0%) stddev-sans-first:26.98 06:21:31 INFO - PROCESS | 1678 | Values: 159.0 128.0 147.0 202.0 125.0 140.0 141.0 124.0 172.0 119.0 06:21:31 INFO - PROCESS | 1678 | 06:21:31 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:211.60 Median:207.50 stddev:23.39 (11.3%) stddev-sans-first:24.30 06:21:31 INFO - PROCESS | 1678 | Values: 225.0 267.0 229.0 193.0 194.0 201.0 201.0 196.0 196.0 214.0 06:21:31 INFO - PROCESS | 1678 | 06:21:31 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:36.30 (47.8%) stddev-sans-first:37.99 06:21:31 INFO - PROCESS | 1678 | Values: 77.0 84.0 75.0 174.0 70.0 83.0 82.0 103.0 139.0 52.0 06:21:31 INFO - PROCESS | 1678 | 06:21:31 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:82.00 stddev:24.22 (29.5%) stddev-sans-first:25.09 06:21:31 INFO - PROCESS | 1678 | Values: 82.0 83.0 147.0 78.0 82.0 87.0 121.0 83.0 82.0 123.0 06:21:31 INFO - PROCESS | 1678 | 06:21:31 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:91.90 Median:88.00 stddev:8.97 (10.2%) stddev-sans-first:9.46 06:21:31 INFO - PROCESS | 1678 | Values: 89.0 85.0 88.0 103.0 113.0 85.0 90.0 88.0 88.0 90.0 06:21:31 INFO - PROCESS | 1678 | 06:21:31 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:108.20 Median:95.50 stddev:19.38 (20.3%) stddev-sans-first:19.96 06:21:31 INFO - PROCESS | 1678 | Values: 95.0 96.0 97.0 130.0 150.0 95.0 96.0 104.0 123.0 96.0 06:21:31 INFO - PROCESS | 1678 | 06:21:31 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:108.30 Median:81.00 stddev:23.94 (29.5%) stddev-sans-first:24.79 06:21:31 INFO - PROCESS | 1678 | Values: 123.0 85.0 127.0 77.0 120.0 144.0 135.0 92.0 92.0 88.0 06:21:31 INFO - PROCESS | 1678 | 06:21:31 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:70.70 Median:63.00 stddev:20.32 (32.3%) stddev-sans-first:21.25 06:21:31 INFO - PROCESS | 1678 | Values: 61.0 64.0 63.0 62.0 64.0 63.0 62.0 125.0 84.0 59.0 06:21:31 INFO - PROCESS | 1678 | 06:21:31 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:83.40 Median:70.00 stddev:16.69 (23.8%) stddev-sans-first:16.75 06:21:31 INFO - PROCESS | 1678 | Values: 68.0 65.0 60.0 72.0 76.0 93.0 100.0 101.0 101.0 98.0 06:21:31 INFO - PROCESS | 1678 | 06:21:31 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:97.70 Median:86.50 stddev:11.94 (13.8%) stddev-sans-first:12.67 06:21:31 INFO - PROCESS | 1678 | Values: 98.0 108.0 76.0 98.0 107.0 109.0 113.0 95.0 86.0 87.0 06:21:31 INFO - PROCESS | 1678 | 06:21:31 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:161.90 Median:157.50 stddev:42.20 (26.8%) stddev-sans-first:44.01 06:21:31 INFO - PROCESS | 1678 | Values: 140.0 145.0 139.0 143.0 159.0 157.0 137.0 158.0 279.0 162.0 06:21:31 INFO - PROCESS | 1678 | 06:21:31 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.80 Median:181.00 stddev:20.16 (11.1%) stddev-sans-first:20.75 06:21:31 INFO - PROCESS | 1678 | Values: 170.0 175.0 187.0 233.0 197.0 170.0 174.0 171.0 168.0 193.0 06:21:31 INFO - PROCESS | 1678 | 06:21:31 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.00 Median:79.50 stddev:9.55 (12.0%) stddev-sans-first:9.41 06:21:31 INFO - PROCESS | 1678 | Values: 67.0 68.0 69.0 80.0 91.0 91.0 85.0 79.0 72.0 68.0 06:21:31 INFO - PROCESS | 1678 | -------- Summary: end -------- 06:21:31 INFO - PROCESS | 1678 | 06:21:32 INFO - TEST-INFO | 1678: exit 0 06:21:32 INFO - TEST-OK | kraken | took 62151ms 06:21:32 INFO - SUITE-END | took 1175s 06:21:32 INFO - Completed test suite (00:19:35) 06:21:32 INFO - javascript benchmark 06:21:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3505.8071806050657, 3512.701420379268, 3530.558680164979, 3538.6638269364403, 3551.5915669697984, 4872.805087796488, 5863.970680146599, 5891.499222566082, 5986.8802623947495, 5997.550183736226, 5784.103463963082, 5927.140564618138, 5944.702764861761, 5967.552433567489, 6032.457078862902, 5319.441458646835, 5336.4930331618625, 5367.275417818583, 5417.810376636819, 5466.590005749565, 5362.410134885159, 5525.4474552544825, 5543.36251331096, 5554.777808887639, 5604.187392828037, 5267.841964741026, 5310.946890531084, 5315.973420132913, 5407.918881216805, 5428.728563571825, 5348.786048558053, 5352.2506849041165, 5353.330833645794, 5373.408925018245, 5377.11277639189, 5016.648834581581, 5381.408045115034, 5386.326709161355, 5418.0, 5422.263917443444, 5654.095344744862, 5718.0, 5750.079987202028, 5760.0, 5784.595078344518, 6232.345603711636, 6291.1506946562085, 6299.842503937392, 6318.526110541682, 6323.241211054657, 6201.906971395432, 6382.840428989266, 6395.136656551399, 6406.903896441557, 6415.582987105823, 6046.123312119762, 6093.390660933916, 6096.11606317086, 6119.908201376983, 6142.723577439026, 5476.644018138808, 6465.967670161619, 6483.222013358333, 6549.574277671936, 6560.081588577507, 6135.416406698409, 6201.96899015502, 6260.092286618415, 6285.182926219562, 6300.432961033437, 6197.25632924052, 6262.874742505124, 6407.839804004937, 6407.871842563216, 6413.390727880844, 6181.320054793969, 6219.626822390671, 6306.9684651576445, 6307.463865571386, 6337.809865704036, 5899.941000590025, 6195.411435913581, 6207.286162091327, 6331.398517140864, 6332.1135041094285, 4484.215262329145, 5019.222020586815, 5086.287919691246, 5123.308353372247, 5134.229865520202, 4553.1804275230115, 4561.384213131251, 4571.885702857455, 4579.679422440464, 4607.3089036644105, 5864.794732184353, 6014.338422773491, 6058.697065146725, 6083.361247069082, 6132.08018797184, 6402.199725034371, 6418.935810641927, 6431.1317972073175, 6435.774747883802, 6473.741050357933, 6052.515798736091, 6055.576109672369, 6089.634621922699, 6094.664793436404, 6130.325664176937, 5437.646552974044, 5497.862553436116, 5516.724163791794, 5527.39198688144, 5553.8333849984565, 6582.802515924625, 6584.473242140617, 6596.406323430914, 6602.8679426410245, 6618.900716489353, 6413.486921046212, 6416.550841441054, 6417.2299324081405, 6431.0, 6439.613623182624, 6349.9682501587195, 6446.29090800021, 6453.483721302191, 6474.805755827333, 6488.253850807028, 6327.746890124344, 6330.556861019869, 6333.65164915934, 6334.746610135543, 6346.650934198663, 6396.10454536356, 6412.935870641234, 6416.358364163546, 6431.485481161402, 6436.742530298736, 6077.3011103721865, 6109.602875813058, 6180.258368995749, 6218.409251121137, 6245.500359971283, 5149.2276158576515, 6078.270607527125, 6199.876002480015, 6267.373262673696, 6268.404501572343, 5106.7701953412925, 5962.766435830609, 6040.637561746309, 6118.510519158545, 6126.111713801563, 6161.045038019114, 6184.721687523982, 6241.282252541016, 6259.906101408574, 6289.591176573508, 6134.447899689049, 6142.815715528542, 6178.505719542336, 6187.16473276102, 6191.4118158774845], "value": 5844.706233563556, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.63450315772656, 521.1687358662933, 524.3655177235544, 554.3486403475915, 555.6638233868512, 36673.633263667354, 37911.81044094779, 39691.801540992325, 39725.602743972624, 39871.0, 40725.981850453754, 40819.59180408195, 41528.0, 41532.377014344806, 41579.58420415795, 9370.016148304416, 9601.711948641552, 9614.423134611945, 9663.0, 9731.902680973206, 9523.619055237783, 9534.094261045224, 9552.283578731589, 9564.856527152098, 9630.80738385232, 9612.759681007961, 9629.518524073768, 9633.66282180124, 9688.951555242214, 9725.173360264385, 9580.712578622653, 9684.661036863747, 9687.0, 9687.273454490942, 9735.123838854537, 9520.428774273565, 9619.326647134703, 9626.0, 9638.42169469834, 9639.277054220962, 31379.68620313813, 37780.0, 37985.67050153259, 38273.23453530914, 38312.85061448161, 2743.7804975602103, 2962.377900640868, 3049.420610084077, 3142.6543080261154, 3229.9664107485614, 22280.220192293193, 27883.0, 28104.718952810414, 28453.430931381463, 28504.144875653765, 2665.9066932657456, 2687.6506054213023, 2696.339396847785, 2740.3012231880944, 2743.0262256898914, 400238.0, 405317.0, 405723.0, 407288.9635551833, 412913.0, 35686.10784730351, 36099.278014439566, 36213.0, 36241.27517449636, 36320.636793631726, 36505.63494365022, 37164.25671486609, 37469.0, 37832.0, 37941.43087853684, 15193.316300766272, 15357.308921098578, 15646.452374166849, 15649.29578168985, 15684.607884802743, 12601.621951341474, 12801.743965120646, 13119.540816071392, 13158.671033224055, 13175.736485270241, 8294.58527073644, 8300.792480187924, 8336.041355244224, 8347.165283471604, 8387.748367548984, 3466.2374277658873, 3485.9477107843404, 3493.21402684394, 3494.266204097117, 3541.220931395089, 929.5816882402946, 950.695777351241, 986.6645340584236, 1041.4584416103585, 1143.1026644084354, 21820.78179218219, 29799.851000744857, 30460.84769576138, 31379.84310078435, 31422.68577314243, 1014.7818219082933, 1062.617457715222, 1082.8971247731454, 1151.0791366906442, 1160.4139909345727, 12577.930875875652, 14110.294485275695, 15316.310766015557, 15596.298166582532, 15603.141827199386, 694702.0, 698378.0, 703706.0, 705205.0, 706929.0, 60411.697941510014, 60644.69677651583, 60773.39226607766, 61159.694201528706, 61259.0, 1409.598264494614, 1467.5303902751018, 1511.1839606612307, 1524.6036030631894, 1525.4660868695867, 24495.51008979846, 29326.26684332909, 29764.85117574398, 30147.547786782776, 30150.69849301479, 53357.733211333696, 53476.46523534715, 53871.0, 53946.730266348415, 54006.729966349914, 570520.0, 571936.0, 575964.0, 576447.0, 578496.0, 26254.34364140912, 26429.471410571296, 26437.206883792747, 26987.460250795266, 27757.0, 45860.8534786633, 46551.06897862092, 46779.766101169276, 46864.297035545176, 47035.05929881315, 37814.054648632904, 38041.42937855879, 38274.617253827106, 38453.65924341835, 39177.82466526009, 37419.43870841885, 37767.62232377751, 37883.62116378801, 38045.47818087246, 38616.8414947552, 36832.0, 37208.88373348804, 37689.24621507609, 38077.0, 38203.85388438351, 27053.59419608747, 32810.835945820116, 32880.34239315153, 33208.0, 33664.15839604029, 21924.780752192273, 23273.952672130134, 24784.0, 24788.628170577096, 24800.379990500383], "value": 18250.476704915254, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.87683941138835, 395.53524608584905, 395.72892568590515, 402.09327965437967, 422.72100413726946, 19799.802001979977, 21111.944402779878, 21213.045412956417, 21421.14315427381, 21925.23261685841, 20676.689849652266, 20883.582328353423, 21431.892840535813, 21646.24238151665, 21681.02435390407, 5192.0, 5890.293164820217, 6141.692915354214, 6141.815745527641, 6150.169727086831, 6054.455099041085, 6079.0, 6136.631802091889, 6136.754529818824, 6194.0, 5847.824565263028, 6052.243469566304, 6054.969725151368, 6082.209312789353, 6093.207882975207, 5412.539934105605, 5711.171880077407, 5804.722960948585, 6020.969895150518, 6050.485708714765, 5766.394528574523, 5769.672975215682, 5811.651300921958, 5909.084091965752, 5924.20023296858, 13886.722265554734, 18041.007744574043, 19293.61412771751, 21059.78940210609, 26383.94464221429, 1860.3302810988034, 2038.613742654994, 2447.7919376852988, 2499.46261553765, 2747.9450410991867, 9789.90210097897, 10062.446565438899, 10379.42913139777, 11993.0, 15628.92185539065, 1709.4187976088065, 1712.221253270213, 1733.159417682423, 1742.4249997500795, 1797.748315235868, 92514.0, 122629.0, 126906.0, 127729.36135319264, 128689.0, 11733.4719937603, 11836.88163118375, 11888.28670279786, 11928.343941083323, 12050.457729402022, 15066.171360575054, 15149.697006060038, 15192.924035379752, 15410.537683869501, 15475.535733928, 7469.85060298791, 8798.208161265517, 8903.243224326005, 8986.786783784237, 9006.684766033157, 8779.29765618749, 8856.0, 8883.955580222188, 8894.243989260856, 8969.775755606031, 4661.976690116596, 4728.503507131771, 4750.453697824794, 4782.0, 4841.394825646794, 1970.881747095179, 2003.4891102768702, 2062.484378905274, 2066.359428577146, 2106.599746048246, 798.8961435013412, 923.1507013547553, 956.1920177450044, 1032.1902561636398, 1054.836500342448, 17439.60483161344, 19185.90407047984, 20392.0, 21105.89447052755, 21253.36239912805, 1010.540204207084, 1020.4795554267378, 1064.8402739589123, 1088.6081010836092, 1090.1224514266091, 11058.612948546763, 11434.371109589052, 11464.828027579593, 11487.483063262172, 11499.137564682682, 620340.0, 623632.0, 633875.0, 639607.0, 640960.0, 102208.0, 137653.0, 137890.0, 149136.2543187277, 160457.0, 1024.9436281004466, 1056.7146870345118, 1070.1224995503612, 1078.0567003871613, 1079.4818487126224, 18927.0, 19091.61816763629, 19098.427047188605, 19137.808621913602, 19139.234430623175, 47639.76180119077, 49430.517084487525, 49687.503124969735, 50476.242856356446, 50646.74676626593, 72379.27620723726, 73693.0, 74748.62625687054, 75192.0, 77450.6127469359, 5862.973979553476, 7118.644067796486, 7644.885326720215, 8003.3597312213715, 8407.8738818919, 10869.456527173452, 11590.130740194687, 12457.1902826316, 12518.937405312916, 12941.935290323489, 9314.161725444743, 10614.0, 10682.73293167677, 10863.511141998788, 10997.670069897917, 10385.013423724735, 10543.0, 10917.617883374043, 11047.392393418439, 11241.0, 9104.817903642022, 10890.23768336209, 11042.33745975244, 11342.319460832376, 11651.30092194471, 6471.899777037821, 6962.721491140298, 7610.847783044419, 7639.121501027231, 7766.650500727368, 9412.95293523528, 10054.447005414773, 10897.964693354119, 10995.725106872393, 11121.0], "value": 9618.439442199813, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1628.7394016957285, 1655.9337626494942, 1918.3573502876536, 1950.5026218314329, 2004.8095430934056, 7961.880571791427, 8553.957230213848, 8650.56747162641, 9050.004499505048, 9052.230560402366, 8699.434536755107, 8738.03881573028, 8767.254783343424, 8856.91143088569, 8892.110788921105, 2381.4641705616273, 2405.3144853716694, 2416.4079800448912, 2419.032387045187, 2425.9029638814427, 2412.2522018174336, 2415.311636183688, 2436.8294219404647, 2441.7314095449487, 2455.3002394317623, 2423.0, 2424.490856920049, 2433.9634905476432, 2442.05980697431, 2447.596146635803, 2390.1992832401165, 2397.0172229385958, 2403.3150552092657, 2414.1791790791126, 2415.1667674652217, 2382.5830479665988, 2399.9520009599887, 2402.423418379594, 2403.098837935774, 2408.9397765055837, 8847.159519845605, 8923.776905577413, 8930.151635594608, 8939.150780675825, 8940.955295223483, 4058.8782336529953, 5395.190721391783, 5424.403315635277, 5445.673259604437, 5464.535514481274, 3427.9485807712904, 3512.3502152101687, 3603.4234522476277, 3603.9099022524383, 3616.945745813815, 1030.3354336453021, 1036.5542816588863, 1042.6246551241547, 1048.5858086055964, 1065.1957771882257, 11662.183647144704, 11704.648860534198, 11846.0, 11882.702932426671, 11894.286342819372, 4560.087982403533, 4563.292689633112, 4677.2750223715375, 4699.906001879944, 4701.0, 9239.076092390707, 9293.39592926471, 9309.813803724022, 9340.206082483064, 9353.298502612195, 5228.712420816892, 5268.394134674485, 5288.65623734456, 5305.920411193835, 5312.203169524602, 4366.978165109154, 4708.364370809965, 4873.951260487421, 4958.45456999737, 4971.627127965345, 3740.8503659853845, 3913.5108111486065, 4086.959130408717, 4155.148194620096, 4185.727927684691, 1344.4151793969654, 1354.1739538881275, 1358.151155527795, 1366.5626999360109, 1370.506617617657, 922.280621115531, 948.9051094890593, 949.7388218240039, 961.110972350573, 964.4550828781715, 5148.56237219833, 5292.967871265143, 5899.823005309848, 6051.0, 6058.0, 442.7365717398143, 449.3260109835247, 450.56070331427253, 453.0734647645573, 477.5701868318472, 3541.486484459739, 3776.169242766587, 4018.2566225248424, 4092.7544347339253, 4100.179964007151, 10328.380297182193, 10794.0, 10852.837207441895, 10908.61819836302, 10932.125429965583, 10776.622818201326, 10879.782404351869, 10890.509927053301, 10948.671539853816, 10951.616693415692, 7776.883346749803, 8252.8349433011, 8285.50286982771, 8318.37612179089, 8388.0, 6043.54673399488, 6057.061155520902, 6131.233595800525, 6146.170267014075, 6196.845078873064, 9808.85286720714, 10016.749581260236, 10119.59521619127, 10142.0, 10164.695059148238, 9619.470929098967, 9917.801643966935, 10193.439360835226, 10247.231457640557, 10344.431056291674, 7004.614746189009, 7443.069616297963, 7619.923800762143, 7689.192634773492, 7793.688252469838, 8351.749447516584, 8366.665333386596, 8473.067962524241, 8507.021692505194, 8537.53043582609, 7367.77896663101, 7504.549727016397, 7557.093148822177, 7559.357454616419, 7578.280063393969, 7420.146683131509, 7459.477836551389, 7461.92538074634, 7577.583232922242, 7588.81027974305, 7052.929470705228, 7061.71753129869, 7126.429885609243, 7136.000959865519, 7168.856622867409, 4873.610111191168, 5001.42483614389, 5037.395512538519, 5061.519155680205, 5153.046686362885, 4979.203327467588, 5045.974770126126, 5106.948930510796, 5139.997700448376, 5320.467953204648], "value": 4556.546151360021, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.24523031648255, 314.63502337288736, 322.4840255591055, 330.67428582845895, 330.7932542161149, 5370.731463426823, 5501.642393244446, 5519.50324470798, 5558.666480011202, 5657.717114144291, 4364.9781751091205, 5513.807016754415, 5561.332640083186, 5598.356189038262, 5606.831795046145, 4238.512571054322, 4245.490541135068, 4252.702310838243, 4267.935980960273, 4268.487781466229, 3911.178652482982, 4121.9175616487655, 4187.246295666779, 4245.872623821275, 4261.872143835674, 4126.504819421659, 4164.0, 4182.184474027566, 4187.895302617429, 4218.746875187483, 3930.724849260553, 4024.973631723921, 4191.7694526801015, 4215.45199124115, 4217.283061879472, 3205.9038228853174, 3231.2568109334984, 3495.3009398120475, 3598.5861625913094, 3625.347437461256, 5073.604758691353, 5298.311219541473, 5325.857743931099, 5338.185017094168, 5340.54605358545, 4018.874715079753, 4753.3582966299455, 4789.49710280419, 4798.280257961299, 4845.248986407112, 5222.8694282642855, 5471.5896307777075, 5594.664320140804, 5803.314895041637, 5863.413658634145, 3563.2695297464215, 3584.4623306503972, 3775.8112094395447, 4027.51669799623, 4050.0482386639114, 5463.098588732854, 6016.428439298304, 6095.0, 6158.3841615838055, 6175.320714721377, 3432.0608855996284, 3779.622037796253, 3836.827342769582, 4061.0354441257455, 4063.004563881868, 3485.3203625292826, 3842.6733727633464, 3918.5885482024546, 4097.783240156463, 4174.912543728136, 4797.136515427256, 4797.424309082862, 4799.832005879777, 4803.567678908915, 4823.469418363977, 4747.869353662336, 5472.097103977799, 5689.459501347365, 5831.0, 5834.591578589543, 1160.1762748448527, 1211.9274442118788, 1305.7790965447336, 1352.8230439517683, 1369.657585603599, 795.1611050341829, 841.7306461932122, 866.9726374246538, 870.0299166429386, 888.2938064238816, 4457.331400289982, 4644.674872758875, 4644.676267263813, 4869.975650121727, 4980.626453016038, 5098.623371689697, 5186.92219616706, 5353.411124776271, 5538.418466061086, 5733.455321744427, 4182.937255941163, 4692.9530704692515, 4814.759262036954, 5045.217991211368, 5079.136546786981, 2652.9469410611678, 2756.54517004692, 2794.7842688430596, 2972.5689774982507, 3015.8793648253823, 4953.18272485036, 5239.956416997374, 5466.753996070186, 5919.661733615284, 6028.246469191351, 4660.697054691502, 5191.430242030219, 5385.811496597678, 5453.727313634303, 6002.199340197923, 5216.817411390583, 5566.109422492382, 5951.256092988377, 5962.344142144448, 6019.247594050744, 4503.932441013453, 5158.226266060121, 5228.947710522846, 5352.768863161573, 5615.989121957923, 4827.42070951488, 5035.597152227886, 5406.324209473659, 5476.2607048049595, 5660.962053660761, 5368.651037682538, 5448.645838020516, 5994.340622531605, 6031.0, 6039.818805435844, 3631.8728844490315, 3730.403135498307, 3734.8879533614036, 3748.9690335158048, 3784.0918179636137, 5263.9210411844615, 5450.863728406822, 5594.748236329294, 5748.568857335633, 5842.503387212135, 5210.97141258672, 5241.077582331941, 5733.655980641175, 5783.219265399117, 5841.50347220491, 4953.18272485036, 5064.5819170632285, 5713.257276554022, 5800.274965629296, 5812.796552120655, 5037.924431133462, 5369.818639899216, 5555.833325000256, 5678.290213723285, 5707.5433965281845, 5194.610404219774, 5374.758135883816, 5868.975203554767, 5871.7651293947765, 5965.552583556338, 5305.628605997543, 5744.712764361849, 5787.742780315596, 5792.333881603501, 5813.883722325614], "value": 4119.22550110538, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.9133416988707, 741.2143128284023, 747.8691229034918, 748.0574476160036, 757.6666266842589, 11218.719532011704, 14362.928185359071, 15338.233088345565, 15437.691246175069, 15451.304691288891, 14800.555983320492, 15411.537653870373, 15411.69176616467, 15637.374505019814, 15648.84351156488, 717.9030830837848, 922.6447817590225, 923.4920793563547, 928.9163975242227, 930.1070971866982, 860.3461369359301, 909.9272058235358, 912.4479689787682, 913.7806926337664, 926.9026752191024, 935.7426707655382, 964.0407794244736, 964.8600952861831, 965.652365148546, 966.2559828931718, 945.4043952310069, 955.3694561589317, 956.364017928077, 957.1720461800562, 959.3620242538703, 719.133444199738, 720.5244538604496, 723.3670538279006, 724.4494184419826, 724.7318492157883, 14375.78436323456, 14605.415783368653, 14610.488632897905, 14629.634259143606, 14640.853591464162, 12081.6375508734, 12104.455299511455, 12128.090393220455, 12191.390430478441, 12473.685520193061, 8183.0, 8776.912230877673, 9597.992210817833, 9720.222382209406, 9765.902340976641, 3410.660934016331, 3426.691597756189, 3448.6551344865566, 3450.896473105786, 3537.451694987281, 50144.0, 59380.0, 70709.64645176793, 78031.60984195043, 80229.99999999942, 9046.547672616343, 9074.047225041408, 9168.404053736485, 9266.397684150508, 9449.527523623929, 20626.896865515577, 20750.792492075187, 20768.273110441063, 20913.268035618985, 20935.79064209369, 5958.582899197015, 7230.2046774854725, 7461.515001524884, 7525.962370188114, 7575.545467271982, 3929.2927273090545, 3968.3650615901893, 4018.216447792711, 4041.4341992121126, 4064.207479541461, 3384.966150338514, 3406.437937740245, 3492.2666240089357, 3504.649535046526, 3505.6844883960566, 596.3887015808831, 649.8018104478085, 651.2250421997808, 652.5366989437553, 654.4535313013591, 487.7804987755524, 512.3876967024445, 553.242058380022, 577.6938222741953, 583.2272239282967, 7679.500832445985, 7752.186020467882, 7820.7262745804765, 7901.723439679584, 8006.599670016476, 564.8559617297562, 567.7643777832153, 580.2447596021983, 589.6904125334233, 593.24657684741, 3777.8299976501125, 3784.7350685452307, 3836.3094642963974, 3837.1558257183374, 3877.806109694504, 92089.53955230181, 94291.52854235684, 94957.0, 95575.0, 97066.5146674262, 50614.746926265136, 72163.55672886512, 80321.59839200767, 84470.5776471126, 84855.0, 67005.32994670089, 67231.0, 68601.0, 68931.0, 69099.65450172717, 6180.938190618036, 7220.675069621985, 7369.336759691439, 7430.517016393917, 7501.474896757175, 46234.53765462437, 46826.614939281055, 46891.76554117208, 47057.529424706685, 47216.445368742214, 46679.0, 54315.91368172535, 61772.911354432996, 64646.67676661586, 66302.34244143935, 9568.90431095708, 9607.56765945548, 9658.0, 9658.806823863624, 10360.481975901326, 10838.132949363875, 11177.385243811668, 11214.046806021579, 11302.886971130512, 11355.261907975955, 9697.272704547328, 9864.260180486635, 9869.802603948025, 9927.056929591678, 10155.136813370946, 10002.549885255035, 10030.548625312025, 10166.796664066826, 10197.082262596401, 10200.489975501343, 9956.153726933002, 10008.64969726056, 11001.779964400506, 11202.88797112051, 11250.549978000789, 9219.308551858772, 9362.578683959102, 9380.108889655472, 9670.129688328085, 9780.41317520951, 8897.154770297071, 8990.0, 9079.818403632022, 9423.670171544238, 9450.747163776465], "value": 6623.072053208665, "unit": "score"}], "name": "dromaeo_css", "value": 7094.946157313014, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 108.0, 123.0, 175.0, 171.0, 108.0, 112.0, 117.0, 114.0], "value": 125.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 128.0, 147.0, 202.0, 125.0, 140.0, 141.0, 124.0, 172.0, 119.0], "value": 145.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [225.0, 267.0, 229.0, 193.0, 194.0, 201.0, 201.0, 196.0, 196.0, 214.0], "value": 211.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 84.0, 75.0, 174.0, 70.0, 83.0, 82.0, 103.0, 139.0, 52.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 147.0, 78.0, 82.0, 87.0, 121.0, 83.0, 82.0, 123.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 88.0, 103.0, 113.0, 85.0, 90.0, 88.0, 88.0, 90.0], "value": 91.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 130.0, 150.0, 95.0, 96.0, 104.0, 123.0, 96.0], "value": 108.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 85.0, 127.0, 77.0, 120.0, 144.0, 135.0, 92.0, 92.0, 88.0], "value": 108.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 63.0, 62.0, 64.0, 63.0, 62.0, 125.0, 84.0, 59.0], "value": 70.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 60.0, 72.0, 76.0, 93.0, 100.0, 101.0, 101.0, 98.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 108.0, 76.0, 98.0, 107.0, 109.0, 113.0, 95.0, 86.0, 87.0], "value": 97.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 145.0, 139.0, 143.0, 159.0, 157.0, 137.0, 158.0, 279.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 175.0, 187.0, 233.0, 197.0, 170.0, 174.0, 171.0, 168.0, 193.0], "value": 183.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 80.0, 91.0, 91.0, 85.0, 79.0, 72.0, 68.0], "value": 77.0, "unit": "score"}], "name": "kraken", "value": 1656.5, "alertThreshold": 2.0}]} 06:21:32 INFO - Return code: 0 06:21:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:21:32 ERROR - # TBPL SUCCESS # 06:21:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:21:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:21:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:21:32 INFO - 2016-05-09 06:21:32.834 screenresolution[1683:10580] starting screenresolution argv=screenresolution get 06:21:32 INFO - 2016-05-09 06:21:32.837 screenresolution[1683:10580] Display 0: 1600x1200x32@60 06:21:32 INFO - 2016-05-09 06:21:32.843 screenresolution[1684:10583] starting screenresolution argv=screenresolution list 06:21:32 INFO - Available Modes on Display 0 06:21:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:21:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:21:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:21:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:21:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:21:33 INFO - Intel Iris: 06:21:33 INFO - Chipset Model: Intel Iris 06:21:33 INFO - Type: GPU 06:21:33 INFO - Bus: Built-In 06:21:33 INFO - VRAM (Dynamic, Max): 1536 MB 06:21:33 INFO - Vendor: Intel (0x8086) 06:21:33 INFO - Device ID: 0x0a2e 06:21:33 INFO - Revision ID: 0x0009 06:21:33 INFO - Displays: 06:21:33 INFO - Display: 06:21:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:21:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:21:33 INFO - Display Serial Number: 1600x1200 60 06:21:33 INFO - Main Display: Yes 06:21:33 INFO - Mirror: Off 06:21:33 INFO - Online: Yes 06:21:33 INFO - Rotation: Supported 06:21:33 INFO - Return code: 0 06:21:33 INFO - Running post-action listener: _resource_record_post_action 06:21:33 INFO - ##### 06:21:33 INFO - ##### Finished run-tests step (success) 06:21:33 INFO - ##### 06:21:33 INFO - Running post-run listener: _resource_record_post_run 06:21:34 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 37946880; Write bytes: 700147200; Read time: 393; Write time: 1995 06:21:34 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 373977600; Write bytes: 369039360; Read time: 28047; Write time: 666 06:21:34 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 36992512; Write bytes: 301043200; Read time: 378; Write time: 1265 06:21:34 INFO - Running post-run listener: _upload_blobber_files 06:21:34 INFO - Blob upload gear active. 06:21:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:21:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:21:34 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'] 06:21:34 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 06:21:34 INFO - (blobuploader) - INFO - Open directory for files ... 06:21:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:21:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:21:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:21:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:21:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:21:35 INFO - (blobuploader) - INFO - Done attempting. 06:21:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:21:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:21:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:21:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:21:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:21:37 INFO - (blobuploader) - INFO - Done attempting. 06:21:37 INFO - (blobuploader) - INFO - Iteration through files over. 06:21:37 INFO - Return code: 0 06:21:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:21:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:21:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ddcbcc77892330c353fa78e3317db2215be182551bc140771c31db86126343c8daabc37c572956284afd57295423a72086e796010a96d4078930b0a9d706a86", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e56161494946256b42f3b1f5f3a3afc38b574d21ab70fc0258f341b1aa8e98cfdf69366b37c5380df29eb571b4dd10fc0aa1e7cd0013d6e0e7f67ac260cb639b"} 06:21:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:21:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:21:37 INFO - Contents: 06:21:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ddcbcc77892330c353fa78e3317db2215be182551bc140771c31db86126343c8daabc37c572956284afd57295423a72086e796010a96d4078930b0a9d706a86", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e56161494946256b42f3b1f5f3a3afc38b574d21ab70fc0258f341b1aa8e98cfdf69366b37c5380df29eb571b4dd10fc0aa1e7cd0013d6e0e7f67ac260cb639b"} 06:21:37 INFO - Running post-run listener: copy_logs_to_upload_dir 06:21:37 INFO - Copying logs to upload dir... 06:21:37 INFO - mkdir: /builds/slave/test/build/upload/logs 06:21:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.420208 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-05-09 06:21:37.107245) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:37.111610) ========= 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.zU3InvHR3P/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.rj93OEWp0e/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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/6ddcbcc77892330c353fa78e3317db2215be182551bc140771c31db86126343c8daabc37c572956284afd57295423a72086e796010a96d4078930b0a9d706a86", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e56161494946256b42f3b1f5f3a3afc38b574d21ab70fc0258f341b1aa8e98cfdf69366b37c5380df29eb571b4dd10fc0aa1e7cd0013d6e0e7f67ac260cb639b"} build_url:https://queue.taskcluster.net/v1/task/RzInJaChQfOijPZIIQwj7w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011278 build_url: 'https://queue.taskcluster.net/v1/task/RzInJaChQfOijPZIIQwj7w/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/6ddcbcc77892330c353fa78e3317db2215be182551bc140771c31db86126343c8daabc37c572956284afd57295423a72086e796010a96d4078930b0a9d706a86", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e56161494946256b42f3b1f5f3a3afc38b574d21ab70fc0258f341b1aa8e98cfdf69366b37c5380df29eb571b4dd10fc0aa1e7cd0013d6e0e7f67ac260cb639b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:37.143181) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:37.143498) ========= 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.zU3InvHR3P/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.rj93OEWp0e/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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.005130 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:37.207545) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:21:37.207883) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:21:37.208306) ========= ========= Total master_lag: 0.19 =========