builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0294 starttime: 1474984448.73 results: success (0) buildid: 20160927035852 builduid: 49547c1fcc474257a48ac2001e699ca4 revision: 7c1929f35c5d11b0b921ebd03c197bdb5afbeaca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 06:54:08.734788) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 06:54:08.735336) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 06:54:08.735641) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 06:54:08.761644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 06:54:08.762047) ========= 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.R4dQaFRrm9/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.hmZALvBxEZ/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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-09-27 06:54:08-- 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% 19.9M=0.001s 2016-09-27 06:54:09 (19.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.456433 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 06:54:09.242780) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 06:54:09.243111) ========= 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.R4dQaFRrm9/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.hmZALvBxEZ/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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.026609 ========= master_lag: 0.23 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 06:54:09.495527) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 06:54:09.495973) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7c1929f35c5d11b0b921ebd03c197bdb5afbeaca --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 7c1929f35c5d11b0b921ebd03c197bdb5afbeaca --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.R4dQaFRrm9/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.hmZALvBxEZ/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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-09-27 06:54:09,578 truncating revision to first 12 chars 2016-09-27 06:54:09,578 Setting DEBUG logging. 2016-09-27 06:54:09,578 attempt 1/10 2016-09-27 06:54:09,578 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7c1929f35c5d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 06:54:10,841 unpacking tar archive at: fx-team-7c1929f35c5d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.531431 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 06:54:11.073462) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 06:54:11.074261) ========= script_repo_revision: 7c1929f35c5d11b0b921ebd03c197bdb5afbeaca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 06:54:11.074919) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 06:54:11.075415) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 06:54:11.254347) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-27 06:54:11.254811) ========= /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.R4dQaFRrm9/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.hmZALvBxEZ/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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:54:11 INFO - MultiFileLogger online at 20160927 06:54:11 in /builds/slave/test 06:54:11 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:54:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:54:11 INFO - {'append_to_log': False, 06:54:11 INFO - 'base_work_dir': '/builds/slave/test', 06:54:11 INFO - 'blob_upload_branch': 'Fx-Team', 06:54:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:54:11 INFO - 'branch': 'Fx-Team', 06:54:11 INFO - 'buildbot_json_path': 'buildprops.json', 06:54:11 INFO - 'config_files': ('talos/mac_config.py',), 06:54:11 INFO - 'default_actions': ('clobber', 06:54:11 INFO - 'read-buildbot-config', 06:54:11 INFO - 'download-and-extract', 06:54:11 INFO - 'populate-webroot', 06:54:11 INFO - 'create-virtualenv', 06:54:11 INFO - 'install', 06:54:11 INFO - 'run-tests'), 06:54:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:54:11 INFO - 'download_minidump_stackwalk': True, 06:54:11 INFO - 'download_symbols': 'ondemand', 06:54:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:54:11 INFO - 'tooltool.py': '/tools/tooltool.py', 06:54:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:54:11 INFO - '/tools/misc-python/virtualenv.py')}, 06:54:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:54:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:54:11 INFO - 'installer_path': 'installer.exe', 06:54:11 INFO - 'log_level': 'info', 06:54:11 INFO - 'log_name': 'talos', 06:54:11 INFO - 'log_to_console': True, 06:54:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:54:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:54:11 INFO - 'opt_config_files': (), 06:54:11 INFO - 'pip_index': False, 06:54:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:54:11 INFO - 'cmd': ('bash', 06:54:11 INFO - '-c', 06:54:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:54:11 INFO - 'enabled': True, 06:54:11 INFO - 'halt_on_failure': False, 06:54:11 INFO - 'name': 'check_screen_resolution'},), 06:54:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:54:11 INFO - 'cmd': ('bash', 06:54:11 INFO - '-c', 06:54:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:54:11 INFO - 'enabled': True, 06:54:11 INFO - 'halt_on_failure': False, 06:54:11 INFO - 'name': 'check_screen_resolution'},), 06:54:11 INFO - 'run_cmd_checks_enabled': True, 06:54:11 INFO - 'sps_profile': False, 06:54:11 INFO - 'sps_profile_interval': 0, 06:54:11 INFO - 'suite': 'dromaeojs-e10s', 06:54:11 INFO - 'system_bits': '32', 06:54:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:54:11 INFO - 'title': 't-yosemite-r7-0294', 06:54:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:54:11 INFO - 'use_talos_json': True, 06:54:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:54:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:54:11 INFO - 'work_dir': 'build'} 06:54:11 INFO - [mozharness: 2016-09-27 13:54:11.458967Z] Running clobber step. 06:54:11 INFO - Running pre-action listener: _resource_record_pre_action 06:54:11 INFO - Running main action method: clobber 06:54:11 INFO - rmtree: /builds/slave/test/build 06:54:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:54:13 INFO - Running post-action listener: _resource_record_post_action 06:54:13 INFO - [mozharness: 2016-09-27 13:54:13.459720Z] Finished clobber step (success) 06:54:13 INFO - [mozharness: 2016-09-27 13:54:13.459839Z] Running read-buildbot-config step. 06:54:13 INFO - Running pre-action listener: _resource_record_pre_action 06:54:13 INFO - Running main action method: read_buildbot_config 06:54:13 INFO - Using buildbot properties: 06:54:13 INFO - { 06:54:13 INFO - "project": "", 06:54:13 INFO - "product": "firefox", 06:54:13 INFO - "script_repo_revision": "production", 06:54:13 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 06:54:13 INFO - "repository": "", 06:54:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 06:54:13 INFO - "buildid": "20160927035852", 06:54:13 INFO - "pgo_build": "False", 06:54:13 INFO - "basedir": "/builds/slave/test", 06:54:13 INFO - "buildnumber": 0, 06:54:13 INFO - "slavename": "t-yosemite-r7-0294", 06:54:13 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 06:54:13 INFO - "platform": "yosemite_r7", 06:54:13 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 06:54:13 INFO - "branch": "fx-team", 06:54:13 INFO - "repo_path": "integration/fx-team", 06:54:13 INFO - "revision": "7c1929f35c5d11b0b921ebd03c197bdb5afbeaca", 06:54:13 INFO - "stage_platform": "macosx64", 06:54:13 INFO - "builduid": "49547c1fcc474257a48ac2001e699ca4", 06:54:13 INFO - "slavebuilddir": "test" 06:54:13 INFO - } 06:54:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/KoVGd3pnSrScmXcGPDoVVA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 06:54:13 INFO - Running post-action listener: _resource_record_post_action 06:54:13 INFO - [mozharness: 2016-09-27 13:54:13.463179Z] Finished read-buildbot-config step (success) 06:54:13 INFO - [mozharness: 2016-09-27 13:54:13.463287Z] Running download-and-extract step. 06:54:13 INFO - Running pre-action listener: _resource_record_pre_action 06:54:13 INFO - Running main action method: download_and_extract 06:54:13 INFO - mkdir: /builds/slave/test/build/tests 06:54: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:13 INFO - trying https://queue.taskcluster.net/v1/task/KoVGd3pnSrScmXcGPDoVVA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 06:54:13 INFO - Downloading https://queue.taskcluster.net/v1/task/KoVGd3pnSrScmXcGPDoVVA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:54:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KoVGd3pnSrScmXcGPDoVVA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 06:54:15 INFO - Downloaded 1199 bytes. 06:54:15 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:54:15 INFO - Using the following test package requirements: 06:54:15 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:54:15 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:54:15 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 06:54:15 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:54:15 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 06:54:15 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:54:15 INFO - u'jsshell-mac.zip'], 06:54:15 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:54:15 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 06:54:15 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:54:15 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:54:15 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 06:54:15 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:54:15 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 06:54:15 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:54:15 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 06:54:15 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:54:15 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 06:54:15 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:54:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KoVGd3pnSrScmXcGPDoVVA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:54:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KoVGd3pnSrScmXcGPDoVVA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:54:15 INFO - Fetch https://queue.taskcluster.net/v1/task/KoVGd3pnSrScmXcGPDoVVA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:54:15 INFO - Expected file size: 16470542 06:54:22 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:54:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KoVGd3pnSrScmXcGPDoVVA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:54:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KoVGd3pnSrScmXcGPDoVVA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:54:22 INFO - Fetch https://queue.taskcluster.net/v1/task/KoVGd3pnSrScmXcGPDoVVA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:54:23 INFO - Expected file size: 16470542 06:54:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KoVGd3pnSrScmXcGPDoVVA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 06:54:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KoVGd3pnSrScmXcGPDoVVA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:54:29 INFO - Fetch https://queue.taskcluster.net/v1/task/KoVGd3pnSrScmXcGPDoVVA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 06:54:30 INFO - Expected file size: 14414062 06:54:31 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:31 INFO - trying https://queue.taskcluster.net/v1/task/KoVGd3pnSrScmXcGPDoVVA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:54:31 INFO - Downloading https://queue.taskcluster.net/v1/task/KoVGd3pnSrScmXcGPDoVVA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 06:54:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KoVGd3pnSrScmXcGPDoVVA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 06:54:34 INFO - Downloaded 111546703 bytes. 06:54:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KoVGd3pnSrScmXcGPDoVVA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:54:34 INFO - mkdir: /builds/slave/test/properties 06:54:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:54:34 INFO - Writing to file /builds/slave/test/properties/build_url 06:54:34 INFO - Contents: 06:54:34 INFO - build_url:https://queue.taskcluster.net/v1/task/KoVGd3pnSrScmXcGPDoVVA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:54:34 INFO - Running post-action listener: _resource_record_post_action 06:54:34 INFO - Running post-action listener: set_extra_try_arguments 06:54:34 INFO - [mozharness: 2016-09-27 13:54:34.725875Z] Finished download-and-extract step (success) 06:54:34 INFO - [mozharness: 2016-09-27 13:54:34.725979Z] Running populate-webroot step. 06:54:34 INFO - Running pre-action listener: _resource_record_pre_action 06:54:34 INFO - Running main action method: populate_webroot 06:54:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:54:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:54:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:54:34 INFO - '--tppagecycles', 06:54:34 INFO - '7'], 06:54:34 INFO - 'tests': ['tsvgm']}}, 06:54:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:54:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:54:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:54:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:54:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:54:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:54:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:34 INFO - 'talos_options': ['--disable-e10s'], 06:54:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:54:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:54:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:34 INFO - 'talos_options': ['--disable-e10s'], 06:54:34 INFO - 'tests': ['damp', 'tps']}, 06:54:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:34 INFO - 'tests': ['damp', 'tps']}, 06:54:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:54:34 INFO - 'tests': ['dromaeo_dom']}, 06:54:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:54:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:54:34 INFO - 'tests': ['basic_compositor_video']}, 06:54:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:54:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:54:34 INFO - 'tests': ['a11yr', 06:54:34 INFO - 'ts_paint', 06:54:34 INFO - 'tpaint', 06:54:34 INFO - 'sessionrestore', 06:54:34 INFO - 'sessionrestore_no_auto_restore', 06:54:34 INFO - 'tabpaint']}, 06:54:34 INFO - 'other-e10s': {'tests': ['a11yr', 06:54:34 INFO - 'ts_paint', 06:54:34 INFO - 'tpaint', 06:54:34 INFO - 'sessionrestore', 06:54:34 INFO - 'sessionrestore_no_auto_restore', 06:54:34 INFO - 'tabpaint']}, 06:54:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:54:34 INFO - 'ts_paint', 06:54:34 INFO - 'tpaint', 06:54:34 INFO - 'sessionrestore', 06:54:34 INFO - 'sessionrestore_no_auto_restore', 06:54:34 INFO - 'tabpaint']}, 06:54:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:54:34 INFO - 'ts_paint', 06:54:34 INFO - 'tpaint', 06:54:34 INFO - 'sessionrestore', 06:54:34 INFO - 'sessionrestore_no_auto_restore', 06:54:34 INFO - 'tabpaint']}, 06:54:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:54:34 INFO - 'tests': ['a11yr', 06:54:34 INFO - 'ts_paint', 06:54:34 INFO - 'tpaint', 06:54:34 INFO - 'sessionrestore', 06:54:34 INFO - 'sessionrestore_no_auto_restore', 06:54:34 INFO - 'tabpaint']}, 06:54:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:54:34 INFO - 'tests': ['a11yr', 06:54:34 INFO - 'ts_paint', 06:54:34 INFO - 'tpaint', 06:54:34 INFO - 'sessionrestore', 06:54:34 INFO - 'sessionrestore_no_auto_restore', 06:54:34 INFO - 'tabpaint']}, 06:54:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:54:34 INFO - 'tests': ['tsvgx', 06:54:34 INFO - 'tsvgr_opacity', 06:54:34 INFO - 'tart', 06:54:34 INFO - 'tscrollx', 06:54:34 INFO - 'cart']}, 06:54:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:54:34 INFO - 'tsvgr_opacity', 06:54:34 INFO - 'tart', 06:54:34 INFO - 'tscrollx', 06:54:34 INFO - 'cart']}, 06:54:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:34 INFO - 'talos_options': ['--disable-e10s'], 06:54:34 INFO - 'tests': ['tp5o']}, 06:54:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:34 INFO - 'tests': ['tp5o']}, 06:54:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:34 INFO - 'talos_options': ['--disable-e10s', 06:54:34 INFO - '--xperf_path', 06:54:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:54:34 INFO - 'tests': ['tp5n']}, 06:54:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:34 INFO - 'talos_options': ['--xperf_path', 06:54:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:54:34 INFO - 'tests': ['tp5n']}}, 06:54:34 INFO - 'talos.zip': {'path': '', 06:54:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:54:34 INFO - Running post-action listener: _resource_record_post_action 06:54:34 INFO - [mozharness: 2016-09-27 13:54:34.744980Z] Finished populate-webroot step (success) 06:54:34 INFO - [mozharness: 2016-09-27 13:54:34.745119Z] Running create-virtualenv step. 06:54:34 INFO - Running pre-action listener: _resource_record_pre_action 06:54:34 INFO - Running main action method: create_virtualenv 06:54:34 INFO - Creating virtualenv /builds/slave/test/build/venv 06:54:34 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:54:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:54:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:54:34 INFO - Using real prefix '/tools/python27' 06:54:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:54:35 INFO - Installing distribute.............................................................................................................................................................................................done. 06:54:38 INFO - Installing pip.................done. 06:54:38 INFO - Return code: 0 06:54:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:54:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:54:38 INFO - Reading from file tmpfile_stdout 06:54:38 INFO - Output received: 06:54:38 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:54:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:54:38 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:38 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:38 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 0x1035f9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10356f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f858045dc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10340dd30>, '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 0x103233db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103405b20>, '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.R4dQaFRrm9/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.hmZALvBxEZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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:54:38 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:54:38 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:54:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R4dQaFRrm9/Render', 06:54:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:38 INFO - 'HOME': '/Users/cltbld', 06:54:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:38 INFO - 'LOGNAME': 'cltbld', 06:54:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:38 INFO - 'MOZ_NO_REMOTE': '1', 06:54:38 INFO - 'NO_EM_RESTART': '1', 06:54:38 INFO - 'PAGER': '/bin/cat', 06:54:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:38 INFO - 'PWD': '/builds/slave/test', 06:54:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:38 INFO - 'SHELL': '/bin/bash', 06:54:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hmZALvBxEZ/Listeners', 06:54:38 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 06:54:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:38 INFO - 'USER': 'cltbld', 06:54:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:38 INFO - 'XPC_FLAGS': '0x0', 06:54:38 INFO - 'XPC_SERVICE_NAME': '0', 06:54:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:38 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:54:38 INFO - Cleaning up... 06:54:38 INFO - Return code: 0 06:54:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:54:38 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:38 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1035f9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10356f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f858045dc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10340dd30>, '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 0x103233db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103405b20>, '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.R4dQaFRrm9/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.hmZALvBxEZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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:54:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:54:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:54:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R4dQaFRrm9/Render', 06:54:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:38 INFO - 'HOME': '/Users/cltbld', 06:54:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:38 INFO - 'LOGNAME': 'cltbld', 06:54:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:38 INFO - 'MOZ_NO_REMOTE': '1', 06:54:38 INFO - 'NO_EM_RESTART': '1', 06:54:38 INFO - 'PAGER': '/bin/cat', 06:54:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:38 INFO - 'PWD': '/builds/slave/test', 06:54:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:38 INFO - 'SHELL': '/bin/bash', 06:54:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hmZALvBxEZ/Listeners', 06:54:38 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 06:54:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:38 INFO - 'USER': 'cltbld', 06:54:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:38 INFO - 'XPC_FLAGS': '0x0', 06:54:38 INFO - 'XPC_SERVICE_NAME': '0', 06:54:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:39 INFO - Downloading/unpacking psutil>=3.1.1 06:54:39 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:54:39 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:54:39 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:54:39 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:54:39 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:54:39 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:54:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:54:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:42 INFO - Installing collected packages: psutil 06:54:42 INFO - Running setup.py install for psutil 06:54:43 INFO - building 'psutil._psutil_osx' extension 06:54:43 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:54:43 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:54:43 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:54:43 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:54:43 INFO - building 'psutil._psutil_posix' extension 06:54:43 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:54:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:54:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:54:43 INFO - ^ 06:54:43 INFO - 1 warning generated. 06:54:43 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:54:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:44 INFO - Successfully installed psutil 06:54:44 INFO - Cleaning up... 06:54:44 INFO - Return code: 0 06:54:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1035f9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10356f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f858045dc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10340dd30>, '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 0x103233db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103405b20>, '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.R4dQaFRrm9/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.hmZALvBxEZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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:54:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:54:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:54:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R4dQaFRrm9/Render', 06:54:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:44 INFO - 'HOME': '/Users/cltbld', 06:54:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:44 INFO - 'LOGNAME': 'cltbld', 06:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:44 INFO - 'MOZ_NO_REMOTE': '1', 06:54:44 INFO - 'NO_EM_RESTART': '1', 06:54:44 INFO - 'PAGER': '/bin/cat', 06:54:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:44 INFO - 'PWD': '/builds/slave/test', 06:54:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:44 INFO - 'SHELL': '/bin/bash', 06:54:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hmZALvBxEZ/Listeners', 06:54:44 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 06:54:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:44 INFO - 'USER': 'cltbld', 06:54:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:44 INFO - 'XPC_FLAGS': '0x0', 06:54:44 INFO - 'XPC_SERVICE_NAME': '0', 06:54:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:54:44 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:54:44 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:54:44 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:54:44 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:54:44 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:54:44 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:54:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:54:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:54:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:54:46 INFO - Installing collected packages: mozsystemmonitor 06:54:46 INFO - Running setup.py install for mozsystemmonitor 06:54:47 INFO - Successfully installed mozsystemmonitor 06:54:47 INFO - Cleaning up... 06:54:47 INFO - Return code: 0 06:54:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:47 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1035f9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10356f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f858045dc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10340dd30>, '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 0x103233db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103405b20>, '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.R4dQaFRrm9/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.hmZALvBxEZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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:54:47 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==2.5.1'] in /builds/slave/test/build 06:54:47 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==2.5.1 06:54:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R4dQaFRrm9/Render', 06:54:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:47 INFO - 'HOME': '/Users/cltbld', 06:54:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:47 INFO - 'LOGNAME': 'cltbld', 06:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:47 INFO - 'MOZ_NO_REMOTE': '1', 06:54:47 INFO - 'NO_EM_RESTART': '1', 06:54:47 INFO - 'PAGER': '/bin/cat', 06:54:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:47 INFO - 'PWD': '/builds/slave/test', 06:54:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:47 INFO - 'SHELL': '/bin/bash', 06:54:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hmZALvBxEZ/Listeners', 06:54:47 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 06:54:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:47 INFO - 'USER': 'cltbld', 06:54:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:47 INFO - 'XPC_FLAGS': '0x0', 06:54:47 INFO - 'XPC_SERVICE_NAME': '0', 06:54:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:47 INFO - Downloading/unpacking jsonschema==2.5.1 06:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:54:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:50 INFO - Downloading functools32-3.2.3-2.tar.gz 06:54:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:54:50 INFO - warning: no files found matching '*.txt' 06:54:50 INFO - no previously-included directories found matching 'build' 06:54:50 INFO - no previously-included directories found matching 'dist' 06:54:50 INFO - no previously-included directories found matching '.git*' 06:54:50 INFO - Installing collected packages: jsonschema, functools32 06:54:50 INFO - Running setup.py install for functools32 06:54:50 INFO - warning: no files found matching '*.txt' 06:54:50 INFO - no previously-included directories found matching 'build' 06:54:50 INFO - no previously-included directories found matching 'dist' 06:54:50 INFO - no previously-included directories found matching '.git*' 06:54:50 INFO - Successfully installed jsonschema functools32 06:54:50 INFO - Cleaning up... 06:54:50 INFO - Return code: 0 06:54:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:54:50 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:50 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:50 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1035f9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10356f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f858045dc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10340dd30>, '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 0x103233db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103405b20>, '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.R4dQaFRrm9/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.hmZALvBxEZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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:54:50 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:54:50 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 functools32==3.2.3-2 06:54:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R4dQaFRrm9/Render', 06:54:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:50 INFO - 'HOME': '/Users/cltbld', 06:54:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:50 INFO - 'LOGNAME': 'cltbld', 06:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:50 INFO - 'MOZ_NO_REMOTE': '1', 06:54:50 INFO - 'NO_EM_RESTART': '1', 06:54:50 INFO - 'PAGER': '/bin/cat', 06:54:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:50 INFO - 'PWD': '/builds/slave/test', 06:54:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:50 INFO - 'SHELL': '/bin/bash', 06:54:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hmZALvBxEZ/Listeners', 06:54:50 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 06:54:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:50 INFO - 'USER': 'cltbld', 06:54:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:50 INFO - 'XPC_FLAGS': '0x0', 06:54:50 INFO - 'XPC_SERVICE_NAME': '0', 06:54:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:54:51 INFO - Cleaning up... 06:54:51 INFO - Return code: 0 06:54:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:54: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1035f9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10356f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f858045dc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10340dd30>, '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 0x103233db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103405b20>, '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.R4dQaFRrm9/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.hmZALvBxEZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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:54:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:54:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:54:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R4dQaFRrm9/Render', 06:54:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:51 INFO - 'HOME': '/Users/cltbld', 06:54:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:51 INFO - 'LOGNAME': 'cltbld', 06:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:51 INFO - 'MOZ_NO_REMOTE': '1', 06:54:51 INFO - 'NO_EM_RESTART': '1', 06:54:51 INFO - 'PAGER': '/bin/cat', 06:54:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:51 INFO - 'PWD': '/builds/slave/test', 06:54:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:51 INFO - 'SHELL': '/bin/bash', 06:54:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hmZALvBxEZ/Listeners', 06:54:51 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 06:54:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:51 INFO - 'USER': 'cltbld', 06:54:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:51 INFO - 'XPC_FLAGS': '0x0', 06:54:51 INFO - 'XPC_SERVICE_NAME': '0', 06:54:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:51 INFO - Downloading/unpacking blobuploader==1.2.4 06:54: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:54: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:54: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:54: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:54: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:54: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:54:53 INFO - Downloading blobuploader-1.2.4.tar.gz 06:54:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:54:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:54:53 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:54:53 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:54:53 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:54:53 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:54:53 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:54:53 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:54:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:54:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:54 INFO - Downloading docopt-0.6.1.tar.gz 06:54:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:54:55 INFO - Installing collected packages: blobuploader, requests, docopt 06:54:55 INFO - Running setup.py install for blobuploader 06:54:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:54:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:54:55 INFO - Running setup.py install for requests 06:54:55 INFO - Running setup.py install for docopt 06:54:55 INFO - Successfully installed blobuploader requests docopt 06:54:55 INFO - Cleaning up... 06:54:55 INFO - Return code: 0 06:54:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:54: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:55 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 0x1035f9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10356f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f858045dc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10340dd30>, '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 0x103233db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103405b20>, '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.R4dQaFRrm9/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.hmZALvBxEZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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:54:55 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:54:55 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:54:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R4dQaFRrm9/Render', 06:54:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:55 INFO - 'HOME': '/Users/cltbld', 06:54:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:55 INFO - 'LOGNAME': 'cltbld', 06:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:55 INFO - 'MOZ_NO_REMOTE': '1', 06:54:55 INFO - 'NO_EM_RESTART': '1', 06:54:55 INFO - 'PAGER': '/bin/cat', 06:54:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:55 INFO - 'PWD': '/builds/slave/test', 06:54:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:55 INFO - 'SHELL': '/bin/bash', 06:54:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hmZALvBxEZ/Listeners', 06:54:55 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 06:54:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:55 INFO - 'USER': 'cltbld', 06:54:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:55 INFO - 'XPC_FLAGS': '0x0', 06:54:55 INFO - 'XPC_SERVICE_NAME': '0', 06:54:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:54:56 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-NmjA1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:54:56 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-46yjEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:54:56 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-QAi87F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:54:56 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-OLLnTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:54:56 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-cBuvnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:54:56 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-IMw24W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:54:56 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-VLHzfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:54:56 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-rGL3jg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:54:56 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-aSMMdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:54:57 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-vdkL5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:54:57 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-98HppP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:54:57 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-AKFVyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:54:57 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-BSag1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:54:57 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-xcg8Cx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:54:57 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-xO7cxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:54:57 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-byRKD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:54:57 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-3lavke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:54:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:54:57 INFO - Running setup.py install for manifestparser 06:54:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:54:58 INFO - Running setup.py install for mozcrash 06:54:58 INFO - Running setup.py install for mozdebug 06:54:58 INFO - Running setup.py install for mozdevice 06:54:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:54:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:54:58 INFO - Running setup.py install for mozfile 06:54:58 INFO - Running setup.py install for mozhttpd 06:54:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:54:58 INFO - Running setup.py install for mozinfo 06:54:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:54:58 INFO - Running setup.py install for mozInstall 06:54:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:54:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:54:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:54:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:54:59 INFO - Running setup.py install for mozleak 06:54:59 INFO - Running setup.py install for mozlog 06:54:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:54:59 INFO - Running setup.py install for moznetwork 06:54:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:54:59 INFO - Running setup.py install for mozprocess 06:54:59 INFO - Running setup.py install for mozprofile 06:54:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:54:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:54:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:54:59 INFO - Running setup.py install for mozrunner 06:55:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:55:00 INFO - Running setup.py install for mozscreenshot 06:55:00 INFO - Running setup.py install for moztest 06:55:00 INFO - Running setup.py install for mozversion 06:55:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:55:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:55:00 INFO - Cleaning up... 06:55:00 INFO - Return code: 0 06:55:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:00 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:00 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:00 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 0x1035f9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10356f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f858045dc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10340dd30>, '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 0x103233db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103405b20>, '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.R4dQaFRrm9/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.hmZALvBxEZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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:55:00 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:55:00 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:55:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R4dQaFRrm9/Render', 06:55:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:00 INFO - 'HOME': '/Users/cltbld', 06:55:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:00 INFO - 'LOGNAME': 'cltbld', 06:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:00 INFO - 'MOZ_NO_REMOTE': '1', 06:55:00 INFO - 'NO_EM_RESTART': '1', 06:55:00 INFO - 'PAGER': '/bin/cat', 06:55:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:00 INFO - 'PWD': '/builds/slave/test', 06:55:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:00 INFO - 'SHELL': '/bin/bash', 06:55:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hmZALvBxEZ/Listeners', 06:55:00 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 06:55:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:00 INFO - 'USER': 'cltbld', 06:55:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:00 INFO - 'XPC_FLAGS': '0x0', 06:55:00 INFO - 'XPC_SERVICE_NAME': '0', 06:55:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:55:00 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-v4ijG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:55:00 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:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:55:00 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-ViWtyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:55:00 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:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:55:00 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-xLMpS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:55:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:55:01 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-C_QlJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:55:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:55:01 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-C1lr21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:55:01 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:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:55:01 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-CDeDi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:55:01 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:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:55:01 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-OA88Kq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:55:01 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:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:55:01 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-lnGyK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:55:01 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:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:55:01 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-noMp0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:55:01 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:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:55:01 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-Jtt4Xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:55:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:55:01 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-XH6Io_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:55:01 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:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:55:01 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-6ONINv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:55:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:55:02 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-SN_pUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:55:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:55:02 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-8Rqfac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:55:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:02 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-QLnvok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:02 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:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:55:02 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-JSr6yJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:55:02 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:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:55:02 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-HiYdwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:55:02 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:55:02 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:55:02 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:55:02 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:55:02 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:55:02 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:55:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:55: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:55: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:55: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:55: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:55: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:55: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:55:04 INFO - Downloading blessings-1.6.tar.gz 06:55:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:55:05 INFO - Installing collected packages: blessings 06:55:05 INFO - Running setup.py install for blessings 06:55:05 INFO - Successfully installed blessings 06:55:05 INFO - Cleaning up... 06:55:05 INFO - Return code: 0 06:55:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:55:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:55:05 INFO - Reading from file tmpfile_stdout 06:55:05 INFO - Current package versions: 06:55:05 INFO - blessings == 1.6 06:55:05 INFO - blobuploader == 1.2.4 06:55:05 INFO - docopt == 0.6.1 06:55:05 INFO - functools32 == 3.2.3-2 06:55:05 INFO - jsonschema == 2.5.1 06:55:05 INFO - manifestparser == 1.1 06:55:05 INFO - mozInstall == 1.12 06:55:05 INFO - mozcrash == 0.17 06:55:05 INFO - mozdebug == 0.1 06:55:05 INFO - mozdevice == 0.48 06:55:05 INFO - mozfile == 1.2 06:55:05 INFO - mozhttpd == 0.7 06:55:05 INFO - mozinfo == 0.9 06:55:05 INFO - mozleak == 0.1 06:55:05 INFO - mozlog == 3.4 06:55:05 INFO - moznetwork == 0.27 06:55:05 INFO - mozprocess == 0.23 06:55:05 INFO - mozprofile == 0.28 06:55:05 INFO - mozrunner == 6.12 06:55:05 INFO - mozscreenshot == 0.1 06:55:05 INFO - mozsystemmonitor == 0.3 06:55:05 INFO - moztest == 0.7 06:55:05 INFO - mozversion == 1.4 06:55:05 INFO - psutil == 3.1.1 06:55:05 INFO - requests == 1.2.3 06:55:05 INFO - wsgiref == 0.1.2 06:55:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:05 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 0x1035f9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10356f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f858045dc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10340dd30>, '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 0x103233db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103405b20>, '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.R4dQaFRrm9/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.hmZALvBxEZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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:55:05 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:55:05 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:55:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R4dQaFRrm9/Render', 06:55:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:05 INFO - 'HOME': '/Users/cltbld', 06:55:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:05 INFO - 'LOGNAME': 'cltbld', 06:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:05 INFO - 'MOZ_NO_REMOTE': '1', 06:55:05 INFO - 'NO_EM_RESTART': '1', 06:55:05 INFO - 'PAGER': '/bin/cat', 06:55:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:05 INFO - 'PWD': '/builds/slave/test', 06:55:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:05 INFO - 'SHELL': '/bin/bash', 06:55:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hmZALvBxEZ/Listeners', 06:55:05 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 06:55:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:05 INFO - 'USER': 'cltbld', 06:55:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:05 INFO - 'XPC_FLAGS': '0x0', 06:55:05 INFO - 'XPC_SERVICE_NAME': '0', 06:55:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:05 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:55:05 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:55:05 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:55:05 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:55:05 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:55:05 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:55:05 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:55:05 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:55:05 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:55:05 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:55:05 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:55:05 INFO - Cleaning up... 06:55:05 INFO - Return code: 0 06:55:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1035f9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10356f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f858045dc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10340dd30>, '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 0x103233db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103405b20>, '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.R4dQaFRrm9/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.hmZALvBxEZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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:55:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:55:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R4dQaFRrm9/Render', 06:55:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:05 INFO - 'HOME': '/Users/cltbld', 06:55:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:05 INFO - 'LOGNAME': 'cltbld', 06:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:05 INFO - 'MOZ_NO_REMOTE': '1', 06:55:05 INFO - 'NO_EM_RESTART': '1', 06:55:05 INFO - 'PAGER': '/bin/cat', 06:55:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:05 INFO - 'PWD': '/builds/slave/test', 06:55:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:05 INFO - 'SHELL': '/bin/bash', 06:55:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hmZALvBxEZ/Listeners', 06:55:05 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 06:55:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:05 INFO - 'USER': 'cltbld', 06:55:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:05 INFO - 'XPC_FLAGS': '0x0', 06:55:05 INFO - 'XPC_SERVICE_NAME': '0', 06:55:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:55:06 INFO - Cleaning up... 06:55:06 INFO - Return code: 0 06:55:06 INFO - Running post-action listener: _resource_record_post_action 06:55:06 INFO - Running post-action listener: _start_resource_monitoring 06:55:06 INFO - Starting resource monitoring. 06:55:06 INFO - [mozharness: 2016-09-27 13:55:06.218416Z] Finished create-virtualenv step (success) 06:55:06 INFO - [mozharness: 2016-09-27 13:55:06.219428Z] Running install step. 06:55:06 INFO - Running pre-action listener: _resource_record_pre_action 06:55:06 INFO - Running main action method: install 06:55:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:55:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:55:06 INFO - Reading from file tmpfile_stdout 06:55:06 INFO - Detecting whether we're running mozinstall >=1.0... 06:55:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:55:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:55:06 INFO - Reading from file tmpfile_stdout 06:55:06 INFO - Output received: 06:55:06 INFO - Usage: mozinstall [options] installer 06:55:06 INFO - Options: 06:55:06 INFO - -h, --help show this help message and exit 06:55:06 INFO - -d DEST, --destination=DEST 06:55:06 INFO - Directory to install application into. [default: 06:55:06 INFO - "/builds/slave/test"] 06:55:06 INFO - --app=APP Application being installed. [default: firefox] 06:55:06 INFO - mkdir: /builds/slave/test/build/application 06:55:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:55:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:55:40 INFO - Reading from file tmpfile_stdout 06:55:40 INFO - Output received: 06:55:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:55:40 INFO - Running post-action listener: _resource_record_post_action 06:55:40 INFO - [mozharness: 2016-09-27 13:55:40.899695Z] Finished install step (success) 06:55:40 INFO - [mozharness: 2016-09-27 13:55:40.899834Z] Running run-tests step. 06:55:40 INFO - Running pre-action listener: _resource_record_pre_action 06:55:40 INFO - Running main action method: run_tests 06:55:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:55:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:55:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:55:40 INFO - 2016-09-27 06:55:40.914 screenresolution[1650:8900] starting screenresolution argv=screenresolution get 06:55:40 INFO - 2016-09-27 06:55:40.916 screenresolution[1650:8900] Display 0: 1600x1200x32@60 06:55:40 INFO - 2016-09-27 06:55:40.922 screenresolution[1651:8902] starting screenresolution argv=screenresolution list 06:55:40 INFO - Available Modes on Display 0 06:55:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:55:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:55:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:55:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:55:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:55:41 INFO - Intel Iris: 06:55:41 INFO - Chipset Model: Intel Iris 06:55:41 INFO - Type: GPU 06:55:41 INFO - Bus: Built-In 06:55:41 INFO - VRAM (Dynamic, Max): 1536 MB 06:55:41 INFO - Vendor: Intel (0x8086) 06:55:41 INFO - Device ID: 0x0a2e 06:55:41 INFO - Revision ID: 0x0009 06:55:41 INFO - Displays: 06:55:41 INFO - Display: 06:55:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:55:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:55:41 INFO - Display Serial Number: 1600x1200 60 06:55:41 INFO - Main Display: Yes 06:55:41 INFO - Mirror: Off 06:55:41 INFO - Online: Yes 06:55:41 INFO - Rotation: Supported 06:55:41 INFO - Return code: 0 06:55:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:55:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:55:41 INFO - Python 2.7.3 06:55:41 INFO - Return code: 0 06:55:41 INFO - grabbing minidump binary from tooltool 06:55: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:41 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10340dd30>, '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 0x103233db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103405b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:55:41 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:55:41 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:55:41 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:55:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:55:41 INFO - Return code: 0 06:55:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:55:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:55:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:55:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:55:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:55:41 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/KoVGd3pnSrScmXcGPDoVVA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0294', '--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:55:41 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/KoVGd3pnSrScmXcGPDoVVA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0294 --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:55:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R4dQaFRrm9/Render', 06:55:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:41 INFO - 'HOME': '/Users/cltbld', 06:55:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:41 INFO - 'LOGNAME': 'cltbld', 06:55:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:55:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:41 INFO - 'MOZ_NO_REMOTE': '1', 06:55:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:55:41 INFO - 'NO_EM_RESTART': '1', 06:55:41 INFO - 'PAGER': '/bin/cat', 06:55:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:41 INFO - 'PWD': '/builds/slave/test', 06:55:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:55:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:41 INFO - 'SHELL': '/bin/bash', 06:55:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hmZALvBxEZ/Listeners', 06:55:41 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 06:55:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:41 INFO - 'USER': 'cltbld', 06:55:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:41 INFO - 'XPC_FLAGS': '0x0', 06:55:41 INFO - 'XPC_SERVICE_NAME': '0', 06:55:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:41 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/KoVGd3pnSrScmXcGPDoVVA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0294', '--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:55:41 INFO - mozversion application_buildid: 20160927035852 06:55:41 INFO - mozversion application_changeset: 7c1929f35c5d11b0b921ebd03c197bdb5afbeaca 06:55:41 INFO - mozversion application_display_name: Nightly 06:55:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:55:41 INFO - mozversion application_name: Firefox 06:55:41 INFO - mozversion application_remotingname: firefox 06:55:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:55:41 INFO - mozversion application_vendor: Mozilla 06:55:41 INFO - mozversion application_version: 52.0a1 06:55:41 INFO - mozversion platform_buildid: 20160927035852 06:55:41 INFO - mozversion platform_changeset: 7c1929f35c5d11b0b921ebd03c197bdb5afbeaca 06:55:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:55:41 INFO - mozversion platform_version: 52.0a1 06:55:41 INFO - using testdate: 1474984541 06:55:41 INFO - actual date: 1474984541 06:55:41 INFO - starting webserver on 'localhost:49272' 06:55:41 INFO - SUITE-START | Running 2 tests 06:55:41 INFO - TEST-START | dromaeo_css 06:55:41 INFO - operating with platform_type : mac_ 06:55:41 INFO - Initialising browser for dromaeo_css test... 06:55:41 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/tmp7WK0rG/profile http://localhost:49272/getInfo.html) 06:55:44 INFO - PROCESS | 1661 | 2016-09-27 06:55:44.160 plugin-container[1663:9072] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a43, name = 'com.apple.tsm.portname' 06:55:44 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:55:44 INFO - PROCESS | 1661 | 2016-09-27 06:55:44.163 plugin-container[1663:9072] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b07, name = 'com.apple.CFPasteboardClient' 06:55:44 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:55:44 INFO - PROCESS | 1661 | 2016-09-27 06:55:44.163 plugin-container[1663:9072] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:55:44 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 06:55:44 INFO - PROCESS | 1661 | colorDepth:24 06:55:44 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 06:55:44 INFO - PROCESS | 1661 | __metrics 06:55:44 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 06:55:44 INFO - TEST-INFO | 1661: exit 0 06:55:44 INFO - Browser initialized. 06:55:44 INFO - Running cycle 1/1 for dromaeo_css test... 06:55:44 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/tmp7WK0rG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:55:47 INFO - PROCESS | 1665 | 2016-09-27 06:55:47.203 plugin-container[1666:9191] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x421f, name = 'com.apple.tsm.portname' 06:55:47 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:55:47 INFO - PROCESS | 1665 | 2016-09-27 06:55:47.207 plugin-container[1666:9191] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d03, name = 'com.apple.CFPasteboardClient' 06:55:47 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:55:47 INFO - PROCESS | 1665 | 2016-09-27 06:55:47.207 plugin-container[1666:9191] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:55:56 INFO - PROCESS | 1665 | RSS: Main: 239976448 06:55:56 INFO - PROCESS | 1665 | 06:56:46 INFO - PROCESS | 1665 | 1474984606560 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:58:58 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 06:58:59 INFO - PROCESS | 1665 | RSS: Main: 255250432 06:58:59 INFO - PROCESS | 1665 | 07:02:02 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 07:02:02 INFO - PROCESS | 1665 | RSS: Main: 267542528 07:02:02 INFO - PROCESS | 1665 | 07:05:04 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 07:05:05 INFO - PROCESS | 1665 | RSS: Main: 271241216 07:05:05 INFO - PROCESS | 1665 | 07:08:07 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 07:08:07 INFO - PROCESS | 1665 | RSS: Main: 270864384 07:08:07 INFO - PROCESS | 1665 | 07:11:10 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 07:11:11 INFO - PROCESS | 1665 | RSS: Main: 276324352 07:11:11 INFO - PROCESS | 1665 | 07:14:13 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 07:14:14 INFO - PROCESS | 1665 | RSS: Main: 278880256 07:14:14 INFO - PROCESS | 1665 | 07:14:14 INFO - PROCESS | 1665 | __start_tp_report 07:14:14 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 07:14:14 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 07:14:14 INFO - PROCESS | 1665 | |i|pagename|runs| 07:14:14 INFO - PROCESS | 1665 | |0;dojo.html;3355.479900615404;3396.405629014922;3398.4562470004803;3415.795052296862;3418.72650187985;5600.85997850054;5672.432756724325;5673.886522269552;5721.742521586528;5747.540196784258;5624.746886390112;5673.914891276634;5676.403977582357;5687.772489100431;5774.913376299359;4006.7395619284653;5169.948300517003;5274.604404669646;5311.309529761125;5347.411784703699;5232.92150617741;5328.040952628526;5335.093034184198;5348.572114230872;5372.489613486712;5121.82073627425;5158.329417175781;5158.793648254065;5196.428392876781;5233.8953220935555;4322.956770432287;4501.212287849613;5231.633785635007;5234.528892399664;5236.607254455931;5122.308488354061;5176.275321454999;5218.556422704075;5236.947630523722;5262.289590905217;5508.256385387961;5708.686022268774;5710.114932185518;5713.914291285634;5736.971315143439;6201.100840378165;6276.278228003793;6282.96858515709;6284.937150628527;6285.622862628257;6142.437386315926;6145.508359331243;6196.101565273055;6203.627782333075;6211;4902.534259245366;5803.245578074908;5813.186153938452;5852.707364631751;5859.736311865976;6187.566870319034;6296.622202667854;6302.1177035215105;6319.304876463585;6332.968335158294;6012.549058820606;6068.2111325528285;6104;6125.050617154348;6131.386861313922;6249.6875156242;6252.280987686383;6274.1843560336865;6285.2457705075685;6288.27684816252;5882.735276912464;5977.880442391215;6141.170941922784;6156.538259630545;6170.7223174957235;6211.9068213976825;6222.62664240138;6247.375262473807;6256.311805701369;6273.435390814758;4829.034193161382;4851.80592776285;4859.562639362474;4871.439784424837;4950.628702847301;4327.783610819446;4440.267355886307;4444.688871778944;4448.688591798543;4460.576245256761;4759.262314341283;5722.141678748221;5786;5835.562332825055;5846.649201047951;6117.15760190703;6171.13604095427;6177.567570270038;6284.874302513924;6295.5907865988565;5763.538916886639;5833.066709326487;5837.6497410155525;5892.734826932799;5900.852478688067;5354.036273470735;5385.138377859524;5388.137897936312;5397.892042159135;5401.891962160735;6192.845178870564;6202.627842329474;6320.462760665303;6328.6519241442165;6329.1139240505445;6149.72326245329;6198.132261483486;6217.906731398942;6273.686315684106;6325.177726895474;6304.18045654062;6311.053341998553;6311.053341998737;6322.988321868479;6410.423061924449;5983.401659833982;6212.72042758086;6220.129181914626;6221.253449586078;6229.657368844757;6132.630864714786;6152.846178845564;6191.690415479298;6219.813405597839;6228.34602366745;6148.077788331607;6196;6202.534809889366;6204.844878877883;6227.470664993526;5926.911096333472;5974.1934838796205;6112.266528016667;6209.96895015522;6219.751209951552;5745.9425405745405;5930.703464826827;5954.10688396744;5967.791127310524;5998.160257563857;6138.079288106641;6144.446999770043;6161.075838624242;6167.537434692326;6179.598326108789;5320.707361095177;5932;6044.395560443921;6046.818595442144;6065.696715164312 07:14:14 INFO - PROCESS | 1665 | |1;ext.html;467.9742614156222;472.44723673302235;490.54624472363054;535.076992188475;535.9919601205983;39012.41481377778;40453.79773101134;41745.79127104368;43237;43263.78368108163;41754.373684394755;42106.57893421065;42146.36780448296;42282.942926426775;42437.36343954843;9669.129778319968;9870.851937220947;9887.406755594651;9887.406755594688;9892.703218903445;8491.896053513035;8693.913260842395;8816.471011739284;9682;9798;9789.755256118582;9810.018998100168;9823.65617203398;9829.361091529063;9875.654352097677;9708.805823883553;9784.55969481375;9808.166305864046;9811.852822207673;9847.409155450696;9762.023797620252;9858.65494707689;9876.654317098866;9882.407055576616;9892.851607225897;39442;39742.60257397418;39847.00382490461;39931.8003409984;40044.79977600122;3310.9239497163517;3470.9479357809655;3479.165000399911;3786.1670432504807;4074.5314288856566;25359.746402535922;30457.390852183053;31099.84450077735;31118.222044448845;31162.909298174683;3022.667506574297;3076.1079287006964;3225.3710526447353;3256.0557438342853;3258.8370581471067;421523;422164.9999999969;422212;422664;423189;56639.43360566424;56646.716766415906;56983;57070.42929570651;57091.42908570944;59714.10428843571;59860;60154.097688534705;60254;60311.69844150751;15799.052056876624;15855.52433426999;15971.920140399223;16056.839431605767;16070.919645401698;12430.875691243153;12465.314407707663;12492.375381231084;12506.499740010298;12510.49958001688;12914.22514649124;15733.44932927342;16040.75938860918;16088.597785055234;16308.021518708916;3140.3248301614803;3246.707796298297;3256.413845507784;6016.789412370546;6996.300369962963;883.5052370672444;899.8470260055675;913.8857642794651;1004.9598016079275;1078.5308390850005;27278.454430911668;29787;30339.089827305215;30629;30707.692923070485;845.3744229270295;1030.0883717909703;1037.2998226197437;1039.0596510158318;1049.9265051446478;14768.63078423048;15320.540383788504;15334.156621385931;15559.14424706652;15622.609434763994;527819;531423;531478;533553;533844.9846504611;54941.72529137409;55365.52565403619;55389.44610553923;55509;55607.88784224374;1335.8530561638213;1354.512375544803;1383.73017261633;1387.4519564771858;1398.4406237504877;24222.63666045046;28414.857925711065;29320.56019159757;29944.850275748482;30287.242818929702;49283.50716492789;50003;50022.49977500179;50103.49896500989;50221.74889125531;477785;480380;481272;482059;484627.57686211343;25105.87447062753;25344.619830702923;25759;25794.226173214833;25957.870210648827;35697.929062128176;39081.21837563176;41010.79494602508;42149.946251343965;46247.537524625666;31716.524252136696;36943;37208;37436;38333.80833095816;33421;37257;37712;37829.81085094557;38218.426723599725;36371.81814090913;36443;37153.6284637161;37237.25525489421;37318.81340593279;31039.379212416075;31700.524492132176;33127.503087453224;33167;33255.833720831244;22708.631997482797;24426.63360049565;24647.630285545372;24882.129125480522;24889.50220995534 07:14:14 INFO - PROCESS | 1665 | |2;jquery.html;291.4200740526352;371.4187296880382;379.33616171699526;382.61164917608613;396.8926694522283;19838;21210.681839772416;21364.89317553414;21519.784802151993;21612.459688507795;20194.798052019476;20437.48906277344;20708.27521036764;20814.687779683278;21246.362609121712;4996.750162491879;5815.15680226368;5987.760489580412;6035.517158627321;6071.514278857703;4723.740194289313;6005.279366476029;6028.4574388305045;6066.605670631395;6089.360617135203;5672.517835983926;5876.647401155944;5906.114082887559;5918.408159184069;6013.428724271187;5697.287839020122;5895.88208235835;5900.88198236035;5916.585838991272;5928.703564821742;5116.872078198037;5155.561777248939;5158.071547121516;5165.896682066375;5169.405518365361;25344.239672809847;25665.61501577478;25673.871630641916;25963;26249.868750656315;2276.248837883511;2322.674825524428;2323.024329781479;2785.373291009527;3140.371925614886;13595.932020339935;15284.694306113926;15301.387944482207;15545.766813497807;15793.052416855026;1886.368066697658;1946.211784227376;1946.6301402733436;1949.4541528372079;1958.637652034378;88328.5583572078;111959.44020279846;114154;115262;116451;9518.857217141749;9644.710658680251;9676.225901927828;10185.33795303303;10795.946020269848;13372.063955523214;13433.731325373437;13444.193348399127;13456.730865382637;13473.461061557624;8253.669853205925;8561.44350617208;8579.785505362415;8656.307495400353;8682.175193356621;8519.659213631508;8652.221300083023;8672.78318042054;8830.77923051916;8839.955800220958;5645.23789288449;6534.183227096613;6670.166229221348;6723.66381680914;6724.327567243236;1717.6221231329087;1756.97364539532;1821.3352126473742;1827.9817201827811;1859.7024476083761;756.8486302739474;833.4915701422127;936.8220038192721;967.1875624475334;982.8525721141885;20985.580288394453;22340;22416.991235394446;22479.21322753696;22684;917.8302014127407;939.3612343606413;963.7157038673608;968.5157421289356;1005.0753306957616;10073.848892266622;11169.776604468028;11855;11857.343654108905;12012.53742982704;398003.1297965623;473476;480004;485824;486364;92438;92627.0737292632;94277;96004.51997740107;100217;973.7273563402259;1004.4626125023077;1020.1991436721989;1029.0686928329874;1038.2680210451613;19237.326693565657;19299.131539081056;19409.51476213106;19425.61148777045;19434.2226310946;46287.768561156976;48073.75963120162;50632;53063.46936530585;54090;68825;69030;70053;71811.64094179496;77110.45779084275;7526.811829704301;7693.4614576979075;7898.723544675909;8137.511749295061;8161.959190204011;9005.36962412651;12351.444185011516;12686.682832929251;13103.541376051793;13218.47126114983;10605.204609654462;10876.510557024794;10918.890811092106;11315.603953861575;11491.54033838637;4926.655134140719;7371.889421658572;10030.899691002996;10916.707491426889;10988.285761425483;9702.611895524382;9769.169620582046;11106.444677766242;11548.653540393801;11549.307041577533;6692.564983276072;7991.521881903379;8037.919620803951;8112.675492980215;8151.918480815116;8113.148119447609;9012.594433250651;10075.395476271447;10247.897521024992;10785.946070269598 07:14:14 INFO - PROCESS | 1665 | |3;mootools.html;1550.8449155084493;1572.9213539323032;1762.8237176282366;1820.5630648644321;1876.4370688793358;7893.4869233499785;8207.83584328313;8494.702685406011;9045.321600879935;9074.63701451942;8553.187447192522;8794.120587941203;8815.294776417872;8984.91015089849;8996.68511602094;2339.8596084235;2370.305231759292;2373;2385.797207237387;2390.34265576966;2341.3444235614056;2360.634101714237;2374.02664907388;2382.5711371953043;2383.392234980078;2358.9528209435803;2361.51588924271;2374.442006128558;2389.4145934246135;2390.8087353011806;2320.837541372088;2332.8483648562787;2337.672725818387;2346.085026839534;2361.3388251289666;1945.9513512162168;2334.101370972171;2339.099446713011;2340.297910626822;2342.7422983471806;8805.075467075992;8861.069587693328;8861.158189971942;8866.911330886673;8888.555572221363;5130.9230361544605;5210.895782084337;5321.73391330432;5336;5391.218273350381;3491.5460990071383;3557.217412169319;3642.7996460194677;3644.7630903991158;3660.9450858237146;1037.7301901505664;1065.169168048923;1073.581303291717;1093.5188517052472;1099.6371197504884;11438.256513326607;11489.023433008204;11527.19309648325;11552.94223528877;11563.653090407217;4513.68404211702;4616.792244348945;4778.187708089633;4782.593479554207;4815.133276010351;8367.95816020916;9840.458774767314;9951.303408761461;9969.35199212049;9988.800223995624;5251.501107394792;5275.5515781158265;5276.577873770089;5295.841124766263;5320.76056577455;4358.542353052884;4506.459224893034;4705.435347758291;4838.346823178826;4848.951510484921;3820.6943444524372;3874.7093967952515;3959.8416063357145;3962.980185099114;4044.1507283470214;1024.6004058417222;1039.9896001040045;1133.3539882267028;1187.4537712652277;1276.4000919567789;825.9256666900008;861.978450538729;904.8687940248627;915.5010519266882;930.4789317981952;5245.999403637779;5790.855228619318;5793.131030345482;5917.230760001258;5921.96365636012;778.2878666020528;850.3834719828199;939.9013103624021;948.0993056596261;964.7636329099415;3330.5004249362305;3984.2828290907337;3998.04047028711;4026.416169655384;4098.549159592442;10556.947215263874;10802.189835762349;10841.024307812335;10878.891211087946;10886.129109671207;10867.130629549618;10882.29265097766;10883.401412922207;10898.72753181161;10899.400532970603;7704.653290602048;8204.138565450661;8329.08380078191;8336.708215212439;8356;5915.970420147872;6026.885026270154;6039.6678182698615;6109.389061093855;6140.3245642978345;9680.661176858775;9729.416235025921;9939.850902236327;10095.495225238561;10157.492125393848;8964.92420909495;9626.759331016781;10175.89824101779;10180.032896874785;10265.12746416563;7052.435805135474;7628.46600737943;7636.770896873103;7696.769096927102;7753.030871141107;8275.172482751917;8349.874751878848;8363.665453381796;8398.160183981552;8413.789655258668;7331.486795924234;7417.369523590555;7529.88705169412;7602.581857997642;7680.500767450098;7181.317774811385;7272.418206543358;7422.703091876265;7543.057117860268;7590.848183036198;5977.5217982560425;7082.291770822876;7096.787096387116;7112.253213412724;7115.075040244735;4954.355933728592;4988.575971042502;5055.974720126376;5113.846584602468;5149.098907691214;4889.875328674354;4969.4782047884455;4975.278584605285;5010.974945125251;5086.593072554113 07:14:14 INFO - PROCESS | 1665 | |4;prototype.html;298.6252253421954;303.6856853156982;310.2569346415336;312.2583863324604;316.09123769163654;4980.053789779944;5223.2165175223645;5367.382750983638;5475.425080366564;5540.141278101895;3990.361542153256;4849.448176583494;5095.254987584132;5325.147976323789;5335.626506144571;3387.424137896551;3573.4639804029475;3617.385044542434;4056.5334986476564;4116.732412393199;3355.2282974915784;3761.398176291794;3954.5452272988687;4070.267351876661;4107.568705285947;3306.96693033069;4074.7555146691143;4084.652804511605;4097.303458412062;4124.9587504124875;3370.309086637258;3862.4592557041897;4097.897552561195;4120.484939382577;4121.876343709693;3598.992282160999;3602;3606.1165014571598;3618.8914332570066;3631.7457777955287;4211.7051806373565;5009.524095210949;5050.924236136461;5169.194579892669;5238.05714971305;4255.234057869582;4677.579017888406;4699.318598803155;4705.929411058837;4715.693479923794;5648.830535083954;5664.9803035454015;5670.886582268332;5739.626924249952;5754.367019627837;3337.6161741399806;3815.561210460777;3895.5130608673917;3940.6847452203756;3953.9604603954167;5773.04744717117;5911.349751527328;5948.888144708652;5982.252218472691;6005.429484198994;3619.6199399063244;3930.469386632768;3953;3961.2473630010204;3965.306071437487;3263.0700250428513;3623.2753449310244;3640.4721315409647;3766.794625719798;3996.740211886276;3874.4575759393706;4184.4141820145205;4630.6063984561015;4637.5130611286;4679.508651591602;4782.928256076161;4863.537963893425;4940.333055037596;5751.252337196222;5774.989376859033;1237.9442925068392;1291.3607764156802;1321.5991049487575;1323.3780123342015;1342.8858547023417;775.693601027591;912.7489940266347;913.9580877799314;915.2037727177399;920.5765347939889;4286.721363111388;5190.209377764665;5370.462953704677;5385.865353366119;5399.271098401666;5802.4197580241635;5806.693493963824;5810.738516766755;5813.82558523245;5818.4472475115645;4614.2617181250835;4969.086901542932;5039.722815245197;5047.939932614118;5146.408163061221;2166.718326617561;2569.357660584854;2584.974150258511;2627.671541057368;2628.51372496085;4436.957315030965;4678.836240731558;4732.006278681515;5041.319421878073;5119.030962042007;4828.227483602606;4975.517138003412;5029.949700503022;5611.242482264924;6078.331383547807;5812.041013232853;5835.862006908612;6171.9691401542705;6277.681686845814;6279.999999999909;4983.476734942778;5421.7560209791445;6062.484688801501;6063.242094738158;6078.57449978515;5606.131049687305;5675.864827034527;5714.885702285847;5858.853528661817;5884.382139875423;5196.4283928767045;5544.61187716856;5821.505172060422;6157;6172.69136543162;3705.9444108337857;3955.5648878623906;4001.8594700510216;4006.6594339480303;4023.2355852389123;4904.485029071896;5324.707141107277;5681.579605098726;5760.971195143998;5791.739371728367;5055.443901170795;5595.720213989202;5702.659874929471;5811.9538483071765;5819.214406055128;4686.133065382915;5788.710564471844;5821.679807610452;5834.474897259267;5840.474357307863;5335.73321333924;5628.774849005994;5674.858128546819;5676.290463692038;5752.338481074563;5547.0308040646605;5686.545076393962;5732.627379220337;5780.855478613068;5795.942040579709;5486.972565137149;5503.697296648723;5648.943510564842;5708.628939118944;5722 07:14:14 INFO - PROCESS | 1665 | |5;yui.html;697.2887654592313;759.8936148939149;766.1916677904815;780.8633489139401;832.5878690048427;14846;15886.920565397186;15894.046357218574;15902.045877247345;15927.124008179546;11948.462319195656;14408.35162417691;14460.060096093746;14473.49342773003;14503.05730127541;822.7613991942329;860.2515811244195;863.7192912303495;864.7665130414784;866.5797088412115;849.6091797773032;862.8403745307107;868.796716547583;870.0081906626451;872.5593575244493;908.4095338030268;910.0808183734442;910.9453432794054;912.2473958983832;913.5980168725773;888.7111688701198;897.5287973813735;900.6487469886749;903.8463461211577;906.3519583497765;665.3446355339986;673.4006734006738;674.6289540752566;675.9121314229168;676.2865177238012;15154;15168.544943651708;15193.848061519464;15251.847481525154;15263.618409539738;13779.379927903168;13849.515266965607;14017.229052402114;14045.016848820484;14171.858281417157;11780.646580602595;11812.527498900034;11863.288202707865;12085.214461060003;12104.455299511543;3678.668919797231;3726.142987112952;3735.589085200626;3750.456183853353;3874.418837174418;106620.46689766501;109144;109159;109419;112807;9996.900030999743;10797.83803242952;10807.78384432307;10819.459027048617;10836.729081773019;19901.900490497454;21700.674489882666;21853;21864;21943.341699748715;6043.667598282137;6171.6297022178815;7033.015377847106;7904.0910295315625;8088.352931765445;4322.330038843984;4370.956290437055;4384.824607015684;4407.449068866392;4624.5375462453485;3597.4244120940525;3626.0390996385977;3676.852925882988;3701.000729802938;3701.962980370162;543.714549861326;572.5419664268569;575.200471344831;666.5600703535644;688.6419062087687;607.5746977116037;647.582309410437;658.2101478226148;674.606936675763;683.1631251716707;7604.961975190088;8800.586045774897;9328.46080396727;9530.142287194185;9618.759531011641;524.9081410753103;564.4843594947579;651.9934800652028;659.0805825872881;697.4211404534225;3825.6612822183574;4211.852585159566;4454.955450445519;4598.931016034762;4704.317873908264;108916;144693.55306447012;144936;152116.2394188022;155093.2245338766;130439;133285;134326.98509522364;135351.32324338314;136439;106686;109506;113140.34298285053;114721.42639286917;115455;8882.689105881263;8902.46585204864;8924.86612700823;8985.921689397313;9104.863427048467;59674.70162649159;59908;60775.392246076975;62833.37166628275;63165.68417157885;90661;91098;92682;92758.53620731852;92978.53510732403;11708.88291117078;11711.707207319885;11723.882761172279;11976.48131990167;12150.08874334446;12513.687157821127;12845.165064270792;12859.421326040538;12966.546170883974;13487.865121349054;12000.699982500508;12057;12180.451879665614;12396.132270740962;12584;11970.341631210018;12251.203671761306;12271.447784849524;12619.242845429304;12636;11925.880741192825;12089;12192.451339689558;12359.443825027716;12524.561640342545;10199.694009179737;10308.433036183082;10550.366977981346;10597.25819192649;10903.400312982545;9459.38513996588;10474.790504190027;10576.682699519026;10659.680209593724;10793.352398855779 07:14:14 INFO - PROCESS | 1665 | __end_tp_report 07:14:14 INFO - PROCESS | 1665 | __start_cc_report 07:14:14 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,363 07:14:14 INFO - PROCESS | 1665 | __end_cc_report 07:14:14 INFO - PROCESS | 1665 | __startTimestamp1474985654062__endTimestamp 07:14:14 INFO - PROCESS | 1665 | 07:14:14 INFO - PROCESS | 1665 | ------- Summary: start ------- 07:14:14 INFO - PROCESS | 1665 | Number of tests: 6 07:14:14 INFO - PROCESS | 1665 | 07:14:14 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5723.84 Median:5967.79 stddev:667.73 (11.2%) stddev-sans-first:643.41 07:14:14 INFO - PROCESS | 1665 | Values: 3355.5 3396.4 3398.5 3415.8 3418.7 5600.9 5672.4 5673.9 5721.7 5747.5 5624.7 5673.9 5676.4 5687.8 5774.9 4006.7 5169.9 5274.6 5311.3 5347.4 5232.9 5328.0 5335.1 5348.6 5372.5 5121.8 5158.3 5158.8 5196.4 5233.9 4323.0 4501.2 5231.6 5234.5 5236.6 5122.3 5176.3 5218.6 5236.9 5262.3 5508.3 5708.7 5710.1 5713.9 5737.0 6201.1 6276.3 6283.0 6284.9 6285.6 6142.4 6145.5 6196.1 6203.6 6211.0 4902.5 5803.2 5813.2 5852.7 5859.7 6187.6 6296.6 6302.1 6319.3 6333.0 6012.5 6068.2 6104.0 6125.1 6131.4 6249.7 6252.3 6274.2 6285.2 6288.3 5882.7 5977.9 6141.2 6156.5 6170.7 6211.9 6222.6 6247.4 6256.3 6273.4 4829.0 4851.8 4859.6 4871.4 4950.6 4327.8 4440.3 4444.7 4448.7 4460.6 4759.3 5722.1 5786.0 5835.6 5846.6 6117.2 6171.1 6177.6 6284.9 6295.6 5763.5 5833.1 5837.6 5892.7 5900.9 5354.0 5385.1 5388.1 5397.9 5401.9 6192.8 6202.6 6320.5 6328.7 6329.1 6149.7 6198.1 6217.9 6273.7 6325.2 6304.2 6311.1 6311.1 6323.0 6410.4 5983.4 6212.7 6220.1 6221.3 6229.7 6132.6 6152.8 6191.7 6219.8 6228.3 6148.1 6196.0 6202.5 6204.8 6227.5 5926.9 5974.2 6112.3 6210.0 6219.8 5745.9 5930.7 5954.1 5967.8 5998.2 6138.1 6144.4 6161.1 6167.5 6179.6 5320.7 5932.0 6044.4 6046.8 6065.7 07:14:14 INFO - PROCESS | 1665 | 07:14:14 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:61805.57 Median:39261.61 stddev:127786.87 (325.5%) stddev-sans-first:128062.36 07:14:14 INFO - PROCESS | 1665 | Values: 468.0 472.4 490.5 535.1 536.0 39012.4 40453.8 41745.8 43237.0 43263.8 41754.4 42106.6 42146.4 42282.9 42437.4 9669.1 9870.9 9887.4 9887.4 9892.7 8491.9 8693.9 8816.5 9682.0 9798.0 9789.8 9810.0 9823.7 9829.4 9875.7 9708.8 9784.6 9808.2 9811.9 9847.4 9762.0 9858.7 9876.7 9882.4 9892.9 39442.0 39742.6 39847.0 39931.8 40044.8 3310.9 3470.9 3479.2 3786.2 4074.5 25359.7 30457.4 31099.8 31118.2 31162.9 3022.7 3076.1 3225.4 3256.1 3258.8 421523.0 422165.0 422212.0 422664.0 423189.0 56639.4 56646.7 56983.0 57070.4 57091.4 59714.1 59860.0 60154.1 60254.0 60311.7 15799.1 15855.5 15971.9 16056.8 16070.9 12430.9 12465.3 12492.4 12506.5 12510.5 12914.2 15733.4 16040.8 16088.6 16308.0 3140.3 3246.7 3256.4 6016.8 6996.3 883.5 899.8 913.9 1005.0 1078.5 27278.5 29787.0 30339.1 30629.0 30707.7 845.4 1030.1 1037.3 1039.1 1049.9 14768.6 15320.5 15334.2 15559.1 15622.6 527819.0 531423.0 531478.0 533553.0 533845.0 54941.7 55365.5 55389.4 55509.0 55607.9 1335.9 1354.5 1383.7 1387.5 1398.4 24222.6 28414.9 29320.6 29944.9 30287.2 49283.5 50003.0 50022.5 50103.5 50221.7 477785.0 480380.0 481272.0 482059.0 484627.6 25105.9 25344.6 25759.0 25794.2 25957.9 35697.9 39081.2 41010.8 42149.9 46247.5 31716.5 36943.0 37208.0 37436.0 38333.8 33421.0 37257.0 37712.0 37829.8 38218.4 36371.8 36443.0 37153.6 37237.3 37318.8 31039.4 31700.5 33127.5 33167.0 33255.8 22708.6 24426.6 24647.6 24882.1 24889.5 07:14:14 INFO - PROCESS | 1665 | 07:14:14 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:29989.30 Median:222145.45 stddev:77961.10 (35.1%) stddev-sans-first:78147.92 07:14:14 INFO - PROCESS | 1665 | Values: 291.4 371.4 379.3 382.6 396.9 19838.0 21210.7 21364.9 21519.8 21612.5 20194.8 20437.5 20708.3 20814.7 21246.4 4996.8 5815.2 5987.8 6035.5 6071.5 4723.7 6005.3 6028.5 6066.6 6089.4 5672.5 5876.6 5906.1 5918.4 6013.4 5697.3 5895.9 5900.9 5916.6 5928.7 5116.9 5155.6 5158.1 5165.9 5169.4 25344.2 25665.6 25673.9 25963.0 26249.9 2276.2 2322.7 2323.0 2785.4 3140.4 13595.9 15284.7 15301.4 15545.8 15793.1 1886.4 1946.2 1946.6 1949.5 1958.6 88328.6 111959.4 114154.0 115262.0 116451.0 9518.9 9644.7 9676.2 10185.3 10795.9 13372.1 13433.7 13444.2 13456.7 13473.5 8253.7 8561.4 8579.8 8656.3 8682.2 8519.7 8652.2 8672.8 8830.8 8840.0 5645.2 6534.2 6670.2 6723.7 6724.3 1717.6 1757.0 1821.3 1828.0 1859.7 756.8 833.5 936.8 967.2 982.9 20985.6 22340.0 22417.0 22479.2 22684.0 917.8 939.4 963.7 968.5 1005.1 10073.8 11169.8 11855.0 11857.3 12012.5 398003.1 473476.0 480004.0 485824.0 486364.0 92438.0 92627.1 94277.0 96004.5 100217.0 973.7 1004.5 1020.2 1029.1 1038.3 19237.3 19299.1 19409.5 19425.6 19434.2 46287.8 48073.8 50632.0 53063.5 54090.0 68825.0 69030.0 70053.0 71811.6 77110.5 7526.8 7693.5 7898.7 8137.5 8162.0 9005.4 12351.4 12686.7 13103.5 13218.5 10605.2 10876.5 10918.9 11315.6 11491.5 4926.7 7371.9 10030.9 10916.7 10988.3 9702.6 9769.2 11106.4 11548.7 11549.3 6692.6 7991.5 8037.9 8112.7 8151.9 8113.1 9012.6 10075.4 10247.9 10785.9 07:14:14 INFO - PROCESS | 1665 | 07:14:14 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5702.11 Median:5033.47 stddev:3196.25 (63.5%) stddev-sans-first:3189.99 07:14:14 INFO - PROCESS | 1665 | Values: 1550.8 1572.9 1762.8 1820.6 1876.4 7893.5 8207.8 8494.7 9045.3 9074.6 8553.2 8794.1 8815.3 8984.9 8996.7 2339.9 2370.3 2373.0 2385.8 2390.3 2341.3 2360.6 2374.0 2382.6 2383.4 2359.0 2361.5 2374.4 2389.4 2390.8 2320.8 2332.8 2337.7 2346.1 2361.3 1946.0 2334.1 2339.1 2340.3 2342.7 8805.1 8861.1 8861.2 8866.9 8888.6 5130.9 5210.9 5321.7 5336.0 5391.2 3491.5 3557.2 3642.8 3644.8 3660.9 1037.7 1065.2 1073.6 1093.5 1099.6 11438.3 11489.0 11527.2 11552.9 11563.7 4513.7 4616.8 4778.2 4782.6 4815.1 8368.0 9840.5 9951.3 9969.4 9988.8 5251.5 5275.6 5276.6 5295.8 5320.8 4358.5 4506.5 4705.4 4838.3 4849.0 3820.7 3874.7 3959.8 3963.0 4044.2 1024.6 1040.0 1133.4 1187.5 1276.4 825.9 862.0 904.9 915.5 930.5 5246.0 5790.9 5793.1 5917.2 5922.0 778.3 850.4 939.9 948.1 964.8 3330.5 3984.3 3998.0 4026.4 4098.5 10556.9 10802.2 10841.0 10878.9 10886.1 10867.1 10882.3 10883.4 10898.7 10899.4 7704.7 8204.1 8329.1 8336.7 8356.0 5916.0 6026.9 6039.7 6109.4 6140.3 9680.7 9729.4 9939.9 10095.5 10157.5 8964.9 9626.8 10175.9 10180.0 10265.1 7052.4 7628.5 7636.8 7696.8 7753.0 8275.2 8349.9 8363.7 8398.2 8413.8 7331.5 7417.4 7529.9 7602.6 7680.5 7181.3 7272.4 7422.7 7543.1 7590.8 5977.5 7082.3 7096.8 7112.3 7115.1 4954.4 4988.6 5056.0 5113.8 5149.1 4889.9 4969.5 4975.3 5011.0 5086.6 07:14:14 INFO - PROCESS | 1665 | 07:14:14 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:4536.88 Median:5040.52 stddev:1440.41 (28.6%) stddev-sans-first:1408.88 07:14:14 INFO - PROCESS | 1665 | Values: 298.6 303.7 310.3 312.3 316.1 4980.1 5223.2 5367.4 5475.4 5540.1 3990.4 4849.4 5095.3 5325.1 5335.6 3387.4 3573.5 3617.4 4056.5 4116.7 3355.2 3761.4 3954.5 4070.3 4107.6 3307.0 4074.8 4084.7 4097.3 4125.0 3370.3 3862.5 4097.9 4120.5 4121.9 3599.0 3602.0 3606.1 3618.9 3631.7 4211.7 5009.5 5050.9 5169.2 5238.1 4255.2 4677.6 4699.3 4705.9 4715.7 5648.8 5665.0 5670.9 5739.6 5754.4 3337.6 3815.6 3895.5 3940.7 3954.0 5773.0 5911.3 5948.9 5982.3 6005.4 3619.6 3930.5 3953.0 3961.2 3965.3 3263.1 3623.3 3640.5 3766.8 3996.7 3874.5 4184.4 4630.6 4637.5 4679.5 4782.9 4863.5 4940.3 5751.3 5775.0 1237.9 1291.4 1321.6 1323.4 1342.9 775.7 912.7 914.0 915.2 920.6 4286.7 5190.2 5370.5 5385.9 5399.3 5802.4 5806.7 5810.7 5813.8 5818.4 4614.3 4969.1 5039.7 5047.9 5146.4 2166.7 2569.4 2585.0 2627.7 2628.5 4437.0 4678.8 4732.0 5041.3 5119.0 4828.2 4975.5 5029.9 5611.2 6078.3 5812.0 5835.9 6172.0 6277.7 6280.0 4983.5 5421.8 6062.5 6063.2 6078.6 5606.1 5675.9 5714.9 5858.9 5884.4 5196.4 5544.6 5821.5 6157.0 6172.7 3705.9 3955.6 4001.9 4006.7 4023.2 4904.5 5324.7 5681.6 5761.0 5791.7 5055.4 5595.7 5702.7 5812.0 5819.2 4686.1 5788.7 5821.7 5834.5 5840.5 5335.7 5628.8 5674.9 5676.3 5752.3 5547.0 5686.5 5732.6 5780.9 5795.9 5487.0 5503.7 5648.9 5708.6 5722.0 07:14:14 INFO - PROCESS | 1665 | 07:14:14 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:24532.21 Median:3677.76 stddev:39576.17 (1076.1%) stddev-sans-first:39646.73 07:14:14 INFO - PROCESS | 1665 | Values: 697.3 759.9 766.2 780.9 832.6 14846.0 15886.9 15894.0 15902.0 15927.1 11948.5 14408.4 14460.1 14473.5 14503.1 822.8 860.3 863.7 864.8 866.6 849.6 862.8 868.8 870.0 872.6 908.4 910.1 910.9 912.2 913.6 888.7 897.5 900.6 903.8 906.4 665.3 673.4 674.6 675.9 676.3 15154.0 15168.5 15193.8 15251.8 15263.6 13779.4 13849.5 14017.2 14045.0 14171.9 11780.6 11812.5 11863.3 12085.2 12104.5 3678.7 3726.1 3735.6 3750.5 3874.4 106620.5 109144.0 109159.0 109419.0 112807.0 9996.9 10797.8 10807.8 10819.5 10836.7 19901.9 21700.7 21853.0 21864.0 21943.3 6043.7 6171.6 7033.0 7904.1 8088.4 4322.3 4371.0 4384.8 4407.4 4624.5 3597.4 3626.0 3676.9 3701.0 3702.0 543.7 572.5 575.2 666.6 688.6 607.6 647.6 658.2 674.6 683.2 7605.0 8800.6 9328.5 9530.1 9618.8 524.9 564.5 652.0 659.1 697.4 3825.7 4211.9 4455.0 4598.9 4704.3 108916.0 144693.6 144936.0 152116.2 155093.2 130439.0 133285.0 134327.0 135351.3 136439.0 106686.0 109506.0 113140.3 114721.4 115455.0 8882.7 8902.5 8924.9 8985.9 9104.9 59674.7 59908.0 60775.4 62833.4 63165.7 90661.0 91098.0 92682.0 92758.5 92978.5 11708.9 11711.7 11723.9 11976.5 12150.1 12513.7 12845.2 12859.4 12966.5 13487.9 12000.7 12057.0 12180.5 12396.1 12584.0 11970.3 12251.2 12271.4 12619.2 12636.0 11925.9 12089.0 12192.5 12359.4 12524.6 10199.7 10308.4 10550.4 10597.3 10903.4 9459.4 10474.8 10576.7 10659.7 10793.4 07:14:14 INFO - PROCESS | 1665 | -------- Summary: end -------- 07:14:14 INFO - PROCESS | 1665 | 07:14:14 INFO - TEST-INFO | 1665: exit 0 07:14:14 INFO - TEST-OK | dromaeo_css | took 1113187ms 07:14:14 INFO - TEST-START | kraken 07:14:14 INFO - operating with platform_type : mac_ 07:14:14 INFO - Initialising browser for kraken test... 07:14:14 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/tmpa5_qGY/profile http://localhost:49272/getInfo.html) 07:14:17 INFO - PROCESS | 1673 | 2016-09-27 07:14:17.471 plugin-container[1674:11282] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x891f, name = 'com.apple.tsm.portname' 07:14:17 INFO - PROCESS | 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:14:17 INFO - PROCESS | 1673 | 2016-09-27 07:14:17.475 plugin-container[1674:11282] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d13, name = 'com.apple.CFPasteboardClient' 07:14:17 INFO - PROCESS | 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:14:17 INFO - PROCESS | 1673 | 2016-09-27 07:14:17.475 plugin-container[1674:11282] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:14:17 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 07:14:17 INFO - PROCESS | 1673 | colorDepth:24 07:14:17 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 07:14:17 INFO - PROCESS | 1673 | __metrics 07:14:17 ERROR - PROCESS | 1673 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 07:14:18 INFO - TEST-INFO | 1673: exit 0 07:14:18 INFO - Browser initialized. 07:14:18 INFO - Running cycle 1/1 for kraken test... 07:14:18 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/tmpa5_qGY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:14:20 INFO - PROCESS | 1675 | 2016-09-27 07:14:20.669 plugin-container[1676:11397] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8923, name = 'com.apple.tsm.portname' 07:14:20 INFO - PROCESS | 1675 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:14:20 INFO - PROCESS | 1675 | 2016-09-27 07:14:20.671 plugin-container[1676:11397] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d07, name = 'com.apple.CFPasteboardClient' 07:14:20 INFO - PROCESS | 1675 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:14:20 INFO - PROCESS | 1675 | 2016-09-27 07:14:20.671 plugin-container[1676:11397] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:14:30 INFO - PROCESS | 1675 | RSS: Main: 240185344 07:14:30 INFO - PROCESS | 1675 | 07:14:33 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 07:14:34 INFO - PROCESS | 1675 | RSS: Main: 253788160 07:14:34 INFO - PROCESS | 1675 | 07:14:37 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 07:14:37 INFO - PROCESS | 1675 | RSS: Main: 261255168 07:14:37 INFO - PROCESS | 1675 | 07:14:40 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 07:14:41 INFO - PROCESS | 1675 | RSS: Main: 261963776 07:14:41 INFO - PROCESS | 1675 | 07:14:43 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 07:14:44 INFO - PROCESS | 1675 | RSS: Main: 264200192 07:14:44 INFO - PROCESS | 1675 | 07:14:46 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:14:46 INFO - PROCESS | 1675 | RSS: Main: 264814592 07:14:46 INFO - PROCESS | 1675 | 07:14:49 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 07:14:50 INFO - PROCESS | 1675 | RSS: Main: 265572352 07:14:50 INFO - PROCESS | 1675 | 07:14:53 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 07:14:53 INFO - PROCESS | 1675 | RSS: Main: 265940992 07:14:53 INFO - PROCESS | 1675 | 07:14:56 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 07:14:57 INFO - PROCESS | 1675 | RSS: Main: 265949184 07:14:57 INFO - PROCESS | 1675 | 07:14:58 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:14:59 INFO - PROCESS | 1675 | RSS: Main: 265068544 07:14:59 INFO - PROCESS | 1675 | 07:15:01 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:15:02 INFO - PROCESS | 1675 | RSS: Main: 265211904 07:15:02 INFO - PROCESS | 1675 | 07:15:04 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:15:05 INFO - PROCESS | 1675 | RSS: Main: 265125888 07:15:05 INFO - PROCESS | 1675 | 07:15:08 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:15:08 INFO - PROCESS | 1675 | RSS: Main: 265469952 07:15:08 INFO - PROCESS | 1675 | 07:15:11 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:15:12 INFO - PROCESS | 1675 | RSS: Main: 265482240 07:15:12 INFO - PROCESS | 1675 | 07:15:14 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 07:15:14 INFO - PROCESS | 1675 | RSS: Main: 267108352 07:15:14 INFO - PROCESS | 1675 | 07:15:14 INFO - PROCESS | 1675 | __start_tp_report 07:15:14 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 07:15:14 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 07:15:14 INFO - PROCESS | 1675 | |i|pagename|runs| 07:15:14 INFO - PROCESS | 1675 | |0;ai-astar;115;126;123;118;116;118;134;153;118;118 07:15:14 INFO - PROCESS | 1675 | |1;audio-beat-detection;146;113;115;234;113;110;109;115;141;111 07:15:14 INFO - PROCESS | 1675 | |2;audio-dft;206;212;226;215;199;195;198;190;195;197 07:15:14 INFO - PROCESS | 1675 | |3;audio-fft;84;60;63;85;60;61;60;61;80;61 07:15:14 INFO - PROCESS | 1675 | |4;audio-oscillator;91;63;89;106;102;104;125;72;71;88 07:15:14 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;122;89;91;122;90;88;134;86;90;86 07:15:14 INFO - PROCESS | 1675 | |6;imaging-darkroom;96;125;96;95;96;95;96;98;96;95 07:15:14 INFO - PROCESS | 1675 | |7;imaging-desaturate;94;99;92;109;129;93;93;94;93;92 07:15:14 INFO - PROCESS | 1675 | |8;json-parse-financial;58;55;57;57;58;59;57;57;56;57 07:15:14 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;68;77;71;84;78;78;68;72;73;73 07:15:14 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;92;92;89;90;88;88;94;110;113;112 07:15:14 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;143;162;149;145;180;161;163;158;176;165 07:15:14 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;172;174;169;174;170;172;172;177;238;169 07:15:14 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;63;90;62;76;88;91;75;60;90;61 07:15:14 INFO - PROCESS | 1675 | __end_tp_report 07:15:14 INFO - PROCESS | 1675 | __start_cc_report 07:15:14 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,914 07:15:14 INFO - PROCESS | 1675 | __end_cc_report 07:15:14 INFO - PROCESS | 1675 | __startTimestamp1474985714335__endTimestamp 07:15:14 INFO - PROCESS | 1675 | 07:15:14 INFO - PROCESS | 1675 | ------- Summary: start ------- 07:15:14 INFO - PROCESS | 1675 | Number of tests: 14 07:15:14 INFO - PROCESS | 1675 | 07:15:14 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:123.90 Median:120.50 stddev:11.71 (9.7%) stddev-sans-first:11.97 07:15:14 INFO - PROCESS | 1675 | Values: 115.0 126.0 123.0 118.0 116.0 118.0 134.0 153.0 118.0 118.0 07:15:14 INFO - PROCESS | 1675 | 07:15:14 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:130.70 Median:115.00 stddev:38.61 (33.6%) stddev-sans-first:40.56 07:15:14 INFO - PROCESS | 1675 | Values: 146.0 113.0 115.0 234.0 113.0 110.0 109.0 115.0 141.0 111.0 07:15:14 INFO - PROCESS | 1675 | 07:15:14 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:203.30 Median:202.50 stddev:11.24 (5.5%) stddev-sans-first:11.87 07:15:14 INFO - PROCESS | 1675 | Values: 206.0 212.0 226.0 215.0 199.0 195.0 198.0 190.0 195.0 197.0 07:15:14 INFO - PROCESS | 1675 | 07:15:14 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:67.50 Median:62.00 stddev:10.80 (17.4%) stddev-sans-first:9.67 07:15:14 INFO - PROCESS | 1675 | Values: 84.0 60.0 63.0 85.0 60.0 61.0 60.0 61.0 80.0 61.0 07:15:14 INFO - PROCESS | 1675 | 07:15:14 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:71.50 stddev:18.94 (26.5%) stddev-sans-first:20.09 07:15:14 INFO - PROCESS | 1675 | Values: 91.0 63.0 89.0 106.0 102.0 104.0 125.0 72.0 71.0 88.0 07:15:14 INFO - PROCESS | 1675 | 07:15:14 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:99.80 Median:88.50 stddev:18.44 (20.8%) stddev-sans-first:17.73 07:15:14 INFO - PROCESS | 1675 | Values: 122.0 89.0 91.0 122.0 90.0 88.0 134.0 86.0 90.0 86.0 07:15:14 INFO - PROCESS | 1675 | 07:15:14 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:98.80 Median:96.00 stddev:9.25 (9.6%) stddev-sans-first:9.75 07:15:14 INFO - PROCESS | 1675 | Values: 96.0 125.0 96.0 95.0 96.0 95.0 96.0 98.0 96.0 95.0 07:15:14 INFO - PROCESS | 1675 | 07:15:14 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:98.80 Median:93.00 stddev:11.81 (12.7%) stddev-sans-first:12.40 07:15:14 INFO - PROCESS | 1675 | Values: 94.0 99.0 92.0 109.0 129.0 93.0 93.0 94.0 93.0 92.0 07:15:14 INFO - PROCESS | 1675 | 07:15:14 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.00 stddev:1.10 (1.9%) stddev-sans-first:1.12 07:15:14 INFO - PROCESS | 1675 | Values: 58.0 55.0 57.0 57.0 58.0 59.0 57.0 57.0 56.0 57.0 07:15:14 INFO - PROCESS | 1675 | 07:15:14 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:74.20 Median:75.00 stddev:5.03 (6.7%) stddev-sans-first:4.81 07:15:14 INFO - PROCESS | 1675 | Values: 68.0 77.0 71.0 84.0 78.0 78.0 68.0 72.0 73.0 73.0 07:15:14 INFO - PROCESS | 1675 | 07:15:14 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:96.80 Median:89.50 stddev:10.45 (11.7%) stddev-sans-first:10.94 07:15:14 INFO - PROCESS | 1675 | Values: 92.0 92.0 89.0 90.0 88.0 88.0 94.0 110.0 113.0 112.0 07:15:14 INFO - PROCESS | 1675 | 07:15:14 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:160.20 Median:162.50 stddev:12.17 (7.5%) stddev-sans-first:11.21 07:15:14 INFO - PROCESS | 1675 | Values: 143.0 162.0 149.0 145.0 180.0 161.0 163.0 158.0 176.0 165.0 07:15:14 INFO - PROCESS | 1675 | 07:15:14 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.70 Median:173.00 stddev:20.98 (12.1%) stddev-sans-first:22.11 07:15:14 INFO - PROCESS | 1675 | Values: 172.0 174.0 169.0 174.0 170.0 172.0 172.0 177.0 238.0 169.0 07:15:14 INFO - PROCESS | 1675 | 07:15:14 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.60 Median:82.00 stddev:13.36 (16.3%) stddev-sans-first:13.37 07:15:14 INFO - PROCESS | 1675 | Values: 63.0 90.0 62.0 76.0 88.0 91.0 75.0 60.0 90.0 61.0 07:15:14 INFO - PROCESS | 1675 | -------- Summary: end -------- 07:15:14 INFO - PROCESS | 1675 | 07:15:15 INFO - TEST-INFO | 1675: exit 0 07:15:15 INFO - TEST-OK | kraken | took 60611ms 07:15:15 INFO - SUITE-END | took 1173s 07:15:15 INFO - Completed test suite (00:19:33) 07:15:15 INFO - javascript benchmark 07:15:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7244.055257179356, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3355.479900615404, 3396.405629014922, 3398.4562470004803, 3415.795052296862, 3418.72650187985, 5600.85997850054, 5672.432756724325, 5673.886522269552, 5721.742521586528, 5747.540196784258, 5624.746886390112, 5673.914891276634, 5676.403977582357, 5687.772489100431, 5774.913376299359, 4006.7395619284653, 5169.948300517003, 5274.604404669646, 5311.309529761125, 5347.411784703699, 5232.92150617741, 5328.040952628526, 5335.093034184198, 5348.572114230872, 5372.489613486712, 5121.82073627425, 5158.329417175781, 5158.793648254065, 5196.428392876781, 5233.8953220935555, 4322.956770432287, 4501.212287849613, 5231.633785635007, 5234.528892399664, 5236.607254455931, 5122.308488354061, 5176.275321454999, 5218.556422704075, 5236.947630523722, 5262.289590905217, 5508.256385387961, 5708.686022268774, 5710.114932185518, 5713.914291285634, 5736.971315143439, 6201.100840378165, 6276.278228003793, 6282.96858515709, 6284.937150628527, 6285.622862628257, 6142.437386315926, 6145.508359331243, 6196.101565273055, 6203.627782333075, 6211.0, 4902.534259245366, 5803.245578074908, 5813.186153938452, 5852.707364631751, 5859.736311865976, 6187.566870319034, 6296.622202667854, 6302.1177035215105, 6319.304876463585, 6332.968335158294, 6012.549058820606, 6068.2111325528285, 6104.0, 6125.050617154348, 6131.386861313922, 6249.6875156242, 6252.280987686383, 6274.1843560336865, 6285.2457705075685, 6288.27684816252, 5882.735276912464, 5977.880442391215, 6141.170941922784, 6156.538259630545, 6170.7223174957235, 6211.9068213976825, 6222.62664240138, 6247.375262473807, 6256.311805701369, 6273.435390814758, 4829.034193161382, 4851.80592776285, 4859.562639362474, 4871.439784424837, 4950.628702847301, 4327.783610819446, 4440.267355886307, 4444.688871778944, 4448.688591798543, 4460.576245256761, 4759.262314341283, 5722.141678748221, 5786.0, 5835.562332825055, 5846.649201047951, 6117.15760190703, 6171.13604095427, 6177.567570270038, 6284.874302513924, 6295.5907865988565, 5763.538916886639, 5833.066709326487, 5837.6497410155525, 5892.734826932799, 5900.852478688067, 5354.036273470735, 5385.138377859524, 5388.137897936312, 5397.892042159135, 5401.891962160735, 6192.845178870564, 6202.627842329474, 6320.462760665303, 6328.6519241442165, 6329.1139240505445, 6149.72326245329, 6198.132261483486, 6217.906731398942, 6273.686315684106, 6325.177726895474, 6304.18045654062, 6311.053341998553, 6311.053341998737, 6322.988321868479, 6410.423061924449, 5983.401659833982, 6212.72042758086, 6220.129181914626, 6221.253449586078, 6229.657368844757, 6132.630864714786, 6152.846178845564, 6191.690415479298, 6219.813405597839, 6228.34602366745, 6148.077788331607, 6196.0, 6202.534809889366, 6204.844878877883, 6227.470664993526, 5926.911096333472, 5974.1934838796205, 6112.266528016667, 6209.96895015522, 6219.751209951552, 5745.9425405745405, 5930.703464826827, 5954.10688396744, 5967.791127310524, 5998.160257563857, 6138.079288106641, 6144.446999770043, 6161.075838624242, 6167.537434692326, 6179.598326108789, 5320.707361095177, 5932.0, 6044.395560443921, 6046.818595442144, 6065.696715164312], "value": 5681.132968604753, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [467.9742614156222, 472.44723673302235, 490.54624472363054, 535.076992188475, 535.9919601205983, 39012.41481377778, 40453.79773101134, 41745.79127104368, 43237.0, 43263.78368108163, 41754.373684394755, 42106.57893421065, 42146.36780448296, 42282.942926426775, 42437.36343954843, 9669.129778319968, 9870.851937220947, 9887.406755594651, 9887.406755594688, 9892.703218903445, 8491.896053513035, 8693.913260842395, 8816.471011739284, 9682.0, 9798.0, 9789.755256118582, 9810.018998100168, 9823.65617203398, 9829.361091529063, 9875.654352097677, 9708.805823883553, 9784.55969481375, 9808.166305864046, 9811.852822207673, 9847.409155450696, 9762.023797620252, 9858.65494707689, 9876.654317098866, 9882.407055576616, 9892.851607225897, 39442.0, 39742.60257397418, 39847.00382490461, 39931.8003409984, 40044.79977600122, 3310.9239497163517, 3470.9479357809655, 3479.165000399911, 3786.1670432504807, 4074.5314288856566, 25359.746402535922, 30457.390852183053, 31099.84450077735, 31118.222044448845, 31162.909298174683, 3022.667506574297, 3076.1079287006964, 3225.3710526447353, 3256.0557438342853, 3258.8370581471067, 421523.0, 422164.9999999969, 422212.0, 422664.0, 423189.0, 56639.43360566424, 56646.716766415906, 56983.0, 57070.42929570651, 57091.42908570944, 59714.10428843571, 59860.0, 60154.097688534705, 60254.0, 60311.69844150751, 15799.052056876624, 15855.52433426999, 15971.920140399223, 16056.839431605767, 16070.919645401698, 12430.875691243153, 12465.314407707663, 12492.375381231084, 12506.499740010298, 12510.49958001688, 12914.22514649124, 15733.44932927342, 16040.75938860918, 16088.597785055234, 16308.021518708916, 3140.3248301614803, 3246.707796298297, 3256.413845507784, 6016.789412370546, 6996.300369962963, 883.5052370672444, 899.8470260055675, 913.8857642794651, 1004.9598016079275, 1078.5308390850005, 27278.454430911668, 29787.0, 30339.089827305215, 30629.0, 30707.692923070485, 845.3744229270295, 1030.0883717909703, 1037.2998226197437, 1039.0596510158318, 1049.9265051446478, 14768.63078423048, 15320.540383788504, 15334.156621385931, 15559.14424706652, 15622.609434763994, 527819.0, 531423.0, 531478.0, 533553.0, 533844.9846504611, 54941.72529137409, 55365.52565403619, 55389.44610553923, 55509.0, 55607.88784224374, 1335.8530561638213, 1354.512375544803, 1383.73017261633, 1387.4519564771858, 1398.4406237504877, 24222.63666045046, 28414.857925711065, 29320.56019159757, 29944.850275748482, 30287.242818929702, 49283.50716492789, 50003.0, 50022.49977500179, 50103.49896500989, 50221.74889125531, 477785.0, 480380.0, 481272.0, 482059.0, 484627.57686211343, 25105.87447062753, 25344.619830702923, 25759.0, 25794.226173214833, 25957.870210648827, 35697.929062128176, 39081.21837563176, 41010.79494602508, 42149.946251343965, 46247.537524625666, 31716.524252136696, 36943.0, 37208.0, 37436.0, 38333.80833095816, 33421.0, 37257.0, 37712.0, 37829.81085094557, 38218.426723599725, 36371.81814090913, 36443.0, 37153.6284637161, 37237.25525489421, 37318.81340593279, 31039.379212416075, 31700.524492132176, 33127.503087453224, 33167.0, 33255.833720831244, 22708.631997482797, 24426.63360049565, 24647.630285545372, 24882.129125480522, 24889.50220995534], "value": 18959.05407677067, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.4200740526352, 371.4187296880382, 379.33616171699526, 382.61164917608613, 396.8926694522283, 19838.0, 21210.681839772416, 21364.89317553414, 21519.784802151993, 21612.459688507795, 20194.798052019476, 20437.48906277344, 20708.27521036764, 20814.687779683278, 21246.362609121712, 4996.750162491879, 5815.15680226368, 5987.760489580412, 6035.517158627321, 6071.514278857703, 4723.740194289313, 6005.279366476029, 6028.4574388305045, 6066.605670631395, 6089.360617135203, 5672.517835983926, 5876.647401155944, 5906.114082887559, 5918.408159184069, 6013.428724271187, 5697.287839020122, 5895.88208235835, 5900.88198236035, 5916.585838991272, 5928.703564821742, 5116.872078198037, 5155.561777248939, 5158.071547121516, 5165.896682066375, 5169.405518365361, 25344.239672809847, 25665.61501577478, 25673.871630641916, 25963.0, 26249.868750656315, 2276.248837883511, 2322.674825524428, 2323.024329781479, 2785.373291009527, 3140.371925614886, 13595.932020339935, 15284.694306113926, 15301.387944482207, 15545.766813497807, 15793.052416855026, 1886.368066697658, 1946.211784227376, 1946.6301402733436, 1949.4541528372079, 1958.637652034378, 88328.5583572078, 111959.44020279846, 114154.0, 115262.0, 116451.0, 9518.857217141749, 9644.710658680251, 9676.225901927828, 10185.33795303303, 10795.946020269848, 13372.063955523214, 13433.731325373437, 13444.193348399127, 13456.730865382637, 13473.461061557624, 8253.669853205925, 8561.44350617208, 8579.785505362415, 8656.307495400353, 8682.175193356621, 8519.659213631508, 8652.221300083023, 8672.78318042054, 8830.77923051916, 8839.955800220958, 5645.23789288449, 6534.183227096613, 6670.166229221348, 6723.66381680914, 6724.327567243236, 1717.6221231329087, 1756.97364539532, 1821.3352126473742, 1827.9817201827811, 1859.7024476083761, 756.8486302739474, 833.4915701422127, 936.8220038192721, 967.1875624475334, 982.8525721141885, 20985.580288394453, 22340.0, 22416.991235394446, 22479.21322753696, 22684.0, 917.8302014127407, 939.3612343606413, 963.7157038673608, 968.5157421289356, 1005.0753306957616, 10073.848892266622, 11169.776604468028, 11855.0, 11857.343654108905, 12012.53742982704, 398003.1297965623, 473476.0, 480004.0, 485824.0, 486364.0, 92438.0, 92627.0737292632, 94277.0, 96004.51997740107, 100217.0, 973.7273563402259, 1004.4626125023077, 1020.1991436721989, 1029.0686928329874, 1038.2680210451613, 19237.326693565657, 19299.131539081056, 19409.51476213106, 19425.61148777045, 19434.2226310946, 46287.768561156976, 48073.75963120162, 50632.0, 53063.46936530585, 54090.0, 68825.0, 69030.0, 70053.0, 71811.64094179496, 77110.45779084275, 7526.811829704301, 7693.4614576979075, 7898.723544675909, 8137.511749295061, 8161.959190204011, 9005.36962412651, 12351.444185011516, 12686.682832929251, 13103.541376051793, 13218.47126114983, 10605.204609654462, 10876.510557024794, 10918.890811092106, 11315.603953861575, 11491.54033838637, 4926.655134140719, 7371.889421658572, 10030.899691002996, 10916.707491426889, 10988.285761425483, 9702.611895524382, 9769.169620582046, 11106.444677766242, 11548.653540393801, 11549.307041577533, 6692.564983276072, 7991.521881903379, 8037.919620803951, 8112.675492980215, 8151.918480815116, 8113.148119447609, 9012.594433250651, 10075.395476271447, 10247.897521024992, 10785.946070269598], "value": 9424.299298991658, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1550.8449155084493, 1572.9213539323032, 1762.8237176282366, 1820.5630648644321, 1876.4370688793358, 7893.4869233499785, 8207.83584328313, 8494.702685406011, 9045.321600879935, 9074.63701451942, 8553.187447192522, 8794.120587941203, 8815.294776417872, 8984.91015089849, 8996.68511602094, 2339.8596084235, 2370.305231759292, 2373.0, 2385.797207237387, 2390.34265576966, 2341.3444235614056, 2360.634101714237, 2374.02664907388, 2382.5711371953043, 2383.392234980078, 2358.9528209435803, 2361.51588924271, 2374.442006128558, 2389.4145934246135, 2390.8087353011806, 2320.837541372088, 2332.8483648562787, 2337.672725818387, 2346.085026839534, 2361.3388251289666, 1945.9513512162168, 2334.101370972171, 2339.099446713011, 2340.297910626822, 2342.7422983471806, 8805.075467075992, 8861.069587693328, 8861.158189971942, 8866.911330886673, 8888.555572221363, 5130.9230361544605, 5210.895782084337, 5321.73391330432, 5336.0, 5391.218273350381, 3491.5460990071383, 3557.217412169319, 3642.7996460194677, 3644.7630903991158, 3660.9450858237146, 1037.7301901505664, 1065.169168048923, 1073.581303291717, 1093.5188517052472, 1099.6371197504884, 11438.256513326607, 11489.023433008204, 11527.19309648325, 11552.94223528877, 11563.653090407217, 4513.68404211702, 4616.792244348945, 4778.187708089633, 4782.593479554207, 4815.133276010351, 8367.95816020916, 9840.458774767314, 9951.303408761461, 9969.35199212049, 9988.800223995624, 5251.501107394792, 5275.5515781158265, 5276.577873770089, 5295.841124766263, 5320.76056577455, 4358.542353052884, 4506.459224893034, 4705.435347758291, 4838.346823178826, 4848.951510484921, 3820.6943444524372, 3874.7093967952515, 3959.8416063357145, 3962.980185099114, 4044.1507283470214, 1024.6004058417222, 1039.9896001040045, 1133.3539882267028, 1187.4537712652277, 1276.4000919567789, 825.9256666900008, 861.978450538729, 904.8687940248627, 915.5010519266882, 930.4789317981952, 5245.999403637779, 5790.855228619318, 5793.131030345482, 5917.230760001258, 5921.96365636012, 778.2878666020528, 850.3834719828199, 939.9013103624021, 948.0993056596261, 964.7636329099415, 3330.5004249362305, 3984.2828290907337, 3998.04047028711, 4026.416169655384, 4098.549159592442, 10556.947215263874, 10802.189835762349, 10841.024307812335, 10878.891211087946, 10886.129109671207, 10867.130629549618, 10882.29265097766, 10883.401412922207, 10898.72753181161, 10899.400532970603, 7704.653290602048, 8204.138565450661, 8329.08380078191, 8336.708215212439, 8356.0, 5915.970420147872, 6026.885026270154, 6039.6678182698615, 6109.389061093855, 6140.3245642978345, 9680.661176858775, 9729.416235025921, 9939.850902236327, 10095.495225238561, 10157.492125393848, 8964.92420909495, 9626.759331016781, 10175.89824101779, 10180.032896874785, 10265.12746416563, 7052.435805135474, 7628.46600737943, 7636.770896873103, 7696.769096927102, 7753.030871141107, 8275.172482751917, 8349.874751878848, 8363.665453381796, 8398.160183981552, 8413.789655258668, 7331.486795924234, 7417.369523590555, 7529.88705169412, 7602.581857997642, 7680.500767450098, 7181.317774811385, 7272.418206543358, 7422.703091876265, 7543.057117860268, 7590.848183036198, 5977.5217982560425, 7082.291770822876, 7096.787096387116, 7112.253213412724, 7115.075040244735, 4954.355933728592, 4988.575971042502, 5055.974720126376, 5113.846584602468, 5149.098907691214, 4889.875328674354, 4969.4782047884455, 4975.278584605285, 5010.974945125251, 5086.593072554113], "value": 4571.554057044721, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.6252253421954, 303.6856853156982, 310.2569346415336, 312.2583863324604, 316.09123769163654, 4980.053789779944, 5223.2165175223645, 5367.382750983638, 5475.425080366564, 5540.141278101895, 3990.361542153256, 4849.448176583494, 5095.254987584132, 5325.147976323789, 5335.626506144571, 3387.424137896551, 3573.4639804029475, 3617.385044542434, 4056.5334986476564, 4116.732412393199, 3355.2282974915784, 3761.398176291794, 3954.5452272988687, 4070.267351876661, 4107.568705285947, 3306.96693033069, 4074.7555146691143, 4084.652804511605, 4097.303458412062, 4124.9587504124875, 3370.309086637258, 3862.4592557041897, 4097.897552561195, 4120.484939382577, 4121.876343709693, 3598.992282160999, 3602.0, 3606.1165014571598, 3618.8914332570066, 3631.7457777955287, 4211.7051806373565, 5009.524095210949, 5050.924236136461, 5169.194579892669, 5238.05714971305, 4255.234057869582, 4677.579017888406, 4699.318598803155, 4705.929411058837, 4715.693479923794, 5648.830535083954, 5664.9803035454015, 5670.886582268332, 5739.626924249952, 5754.367019627837, 3337.6161741399806, 3815.561210460777, 3895.5130608673917, 3940.6847452203756, 3953.9604603954167, 5773.04744717117, 5911.349751527328, 5948.888144708652, 5982.252218472691, 6005.429484198994, 3619.6199399063244, 3930.469386632768, 3953.0, 3961.2473630010204, 3965.306071437487, 3263.0700250428513, 3623.2753449310244, 3640.4721315409647, 3766.794625719798, 3996.740211886276, 3874.4575759393706, 4184.4141820145205, 4630.6063984561015, 4637.5130611286, 4679.508651591602, 4782.928256076161, 4863.537963893425, 4940.333055037596, 5751.252337196222, 5774.989376859033, 1237.9442925068392, 1291.3607764156802, 1321.5991049487575, 1323.3780123342015, 1342.8858547023417, 775.693601027591, 912.7489940266347, 913.9580877799314, 915.2037727177399, 920.5765347939889, 4286.721363111388, 5190.209377764665, 5370.462953704677, 5385.865353366119, 5399.271098401666, 5802.4197580241635, 5806.693493963824, 5810.738516766755, 5813.82558523245, 5818.4472475115645, 4614.2617181250835, 4969.086901542932, 5039.722815245197, 5047.939932614118, 5146.408163061221, 2166.718326617561, 2569.357660584854, 2584.974150258511, 2627.671541057368, 2628.51372496085, 4436.957315030965, 4678.836240731558, 4732.006278681515, 5041.319421878073, 5119.030962042007, 4828.227483602606, 4975.517138003412, 5029.949700503022, 5611.242482264924, 6078.331383547807, 5812.041013232853, 5835.862006908612, 6171.9691401542705, 6277.681686845814, 6279.999999999909, 4983.476734942778, 5421.7560209791445, 6062.484688801501, 6063.242094738158, 6078.57449978515, 5606.131049687305, 5675.864827034527, 5714.885702285847, 5858.853528661817, 5884.382139875423, 5196.4283928767045, 5544.61187716856, 5821.505172060422, 6157.0, 6172.69136543162, 3705.9444108337857, 3955.5648878623906, 4001.8594700510216, 4006.6594339480303, 4023.2355852389123, 4904.485029071896, 5324.707141107277, 5681.579605098726, 5760.971195143998, 5791.739371728367, 5055.443901170795, 5595.720213989202, 5702.659874929471, 5811.9538483071765, 5819.214406055128, 4686.133065382915, 5788.710564471844, 5821.679807610452, 5834.474897259267, 5840.474357307863, 5335.73321333924, 5628.774849005994, 5674.858128546819, 5676.290463692038, 5752.338481074563, 5547.0308040646605, 5686.545076393962, 5732.627379220337, 5780.855478613068, 5795.942040579709, 5486.972565137149, 5503.697296648723, 5648.943510564842, 5708.628939118944, 5722.0], "value": 4078.7910652993437, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.2887654592313, 759.8936148939149, 766.1916677904815, 780.8633489139401, 832.5878690048427, 14846.0, 15886.920565397186, 15894.046357218574, 15902.045877247345, 15927.124008179546, 11948.462319195656, 14408.35162417691, 14460.060096093746, 14473.49342773003, 14503.05730127541, 822.7613991942329, 860.2515811244195, 863.7192912303495, 864.7665130414784, 866.5797088412115, 849.6091797773032, 862.8403745307107, 868.796716547583, 870.0081906626451, 872.5593575244493, 908.4095338030268, 910.0808183734442, 910.9453432794054, 912.2473958983832, 913.5980168725773, 888.7111688701198, 897.5287973813735, 900.6487469886749, 903.8463461211577, 906.3519583497765, 665.3446355339986, 673.4006734006738, 674.6289540752566, 675.9121314229168, 676.2865177238012, 15154.0, 15168.544943651708, 15193.848061519464, 15251.847481525154, 15263.618409539738, 13779.379927903168, 13849.515266965607, 14017.229052402114, 14045.016848820484, 14171.858281417157, 11780.646580602595, 11812.527498900034, 11863.288202707865, 12085.214461060003, 12104.455299511543, 3678.668919797231, 3726.142987112952, 3735.589085200626, 3750.456183853353, 3874.418837174418, 106620.46689766501, 109144.0, 109159.0, 109419.0, 112807.0, 9996.900030999743, 10797.83803242952, 10807.78384432307, 10819.459027048617, 10836.729081773019, 19901.900490497454, 21700.674489882666, 21853.0, 21864.0, 21943.341699748715, 6043.667598282137, 6171.6297022178815, 7033.015377847106, 7904.0910295315625, 8088.352931765445, 4322.330038843984, 4370.956290437055, 4384.824607015684, 4407.449068866392, 4624.5375462453485, 3597.4244120940525, 3626.0390996385977, 3676.852925882988, 3701.000729802938, 3701.962980370162, 543.714549861326, 572.5419664268569, 575.200471344831, 666.5600703535644, 688.6419062087687, 607.5746977116037, 647.582309410437, 658.2101478226148, 674.606936675763, 683.1631251716707, 7604.961975190088, 8800.586045774897, 9328.46080396727, 9530.142287194185, 9618.759531011641, 524.9081410753103, 564.4843594947579, 651.9934800652028, 659.0805825872881, 697.4211404534225, 3825.6612822183574, 4211.852585159566, 4454.955450445519, 4598.931016034762, 4704.317873908264, 108916.0, 144693.55306447012, 144936.0, 152116.2394188022, 155093.2245338766, 130439.0, 133285.0, 134326.98509522364, 135351.32324338314, 136439.0, 106686.0, 109506.0, 113140.34298285053, 114721.42639286917, 115455.0, 8882.689105881263, 8902.46585204864, 8924.86612700823, 8985.921689397313, 9104.863427048467, 59674.70162649159, 59908.0, 60775.392246076975, 62833.37166628275, 63165.68417157885, 90661.0, 91098.0, 92682.0, 92758.53620731852, 92978.53510732403, 11708.88291117078, 11711.707207319885, 11723.882761172279, 11976.48131990167, 12150.08874334446, 12513.687157821127, 12845.165064270792, 12859.421326040538, 12966.546170883974, 13487.865121349054, 12000.699982500508, 12057.0, 12180.451879665614, 12396.132270740962, 12584.0, 11970.341631210018, 12251.203671761306, 12271.447784849524, 12619.242845429304, 12636.0, 11925.880741192825, 12089.0, 12192.451339689558, 12359.443825027716, 12524.561640342545, 10199.694009179737, 10308.433036183082, 10550.366977981346, 10597.25819192649, 10903.400312982545, 9459.38513996588, 10474.790504190027, 10576.682699519026, 10659.680209593724, 10793.352398855779], "value": 7633.96987114262, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1556.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 126.0, 123.0, 118.0, 116.0, 118.0, 134.0, 153.0, 118.0, 118.0], "value": 123.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 113.0, 115.0, 234.0, 113.0, 110.0, 109.0, 115.0, 141.0, 111.0], "value": 130.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [206.0, 212.0, 226.0, 215.0, 199.0, 195.0, 198.0, 190.0, 195.0, 197.0], "value": 203.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 60.0, 63.0, 85.0, 60.0, 61.0, 60.0, 61.0, 80.0, 61.0], "value": 67.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 63.0, 89.0, 106.0, 102.0, 104.0, 125.0, 72.0, 71.0, 88.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 89.0, 91.0, 122.0, 90.0, 88.0, 134.0, 86.0, 90.0, 86.0], "value": 99.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 125.0, 96.0, 95.0, 96.0, 95.0, 96.0, 98.0, 96.0, 95.0], "value": 98.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 99.0, 92.0, 109.0, 129.0, 93.0, 93.0, 94.0, 93.0, 92.0], "value": 98.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 57.0, 57.0, 58.0, 59.0, 57.0, 57.0, 56.0, 57.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 77.0, 71.0, 84.0, 78.0, 78.0, 68.0, 72.0, 73.0, 73.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 89.0, 90.0, 88.0, 88.0, 94.0, 110.0, 113.0, 112.0], "value": 96.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 162.0, 149.0, 145.0, 180.0, 161.0, 163.0, 158.0, 176.0, 165.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 174.0, 169.0, 174.0, 170.0, 172.0, 172.0, 177.0, 238.0, 169.0], "value": 178.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 90.0, 62.0, 76.0, 88.0, 91.0, 75.0, 60.0, 90.0, 61.0], "value": 75.6, "unit": "score"}]}]} 07:15:15 INFO - Return code: 0 07:15:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:15:15 ERROR - # TBPL SUCCESS # 07:15:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:15:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:15:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:15:15 INFO - 2016-09-27 07:15:15.652 screenresolution[1680:11785] starting screenresolution argv=screenresolution get 07:15:15 INFO - 2016-09-27 07:15:15.655 screenresolution[1680:11785] Display 0: 1600x1200x32@60 07:15:15 INFO - 2016-09-27 07:15:15.661 screenresolution[1681:11788] starting screenresolution argv=screenresolution list 07:15:15 INFO - Available Modes on Display 0 07:15:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:15:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:15:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:15:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:15:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:15:15 INFO - Intel Iris: 07:15:15 INFO - Chipset Model: Intel Iris 07:15:15 INFO - Type: GPU 07:15:15 INFO - Bus: Built-In 07:15:15 INFO - VRAM (Dynamic, Max): 1536 MB 07:15:15 INFO - Vendor: Intel (0x8086) 07:15:15 INFO - Device ID: 0x0a2e 07:15:15 INFO - Revision ID: 0x0009 07:15:15 INFO - Displays: 07:15:15 INFO - Display: 07:15:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:15:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:15:15 INFO - Display Serial Number: 1600x1200 60 07:15:15 INFO - Main Display: Yes 07:15:15 INFO - Mirror: Off 07:15:15 INFO - Online: Yes 07:15:15 INFO - Rotation: Supported 07:15:15 INFO - Return code: 0 07:15:15 INFO - Running post-action listener: _resource_record_post_action 07:15:15 INFO - [mozharness: 2016-09-27 14:15:15.906097Z] Finished run-tests step (success) 07:15:15 INFO - Running post-run listener: _resource_record_post_run 07:15:15 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 32731648; Write bytes: 712671232; Read time: 215; Write time: 2026 07:15:15 INFO - TinderboxPrint: CPU usage
54.5% 07:15:15 INFO - TinderboxPrint: I/O read bytes / time
32,731,648 / 215 07:15:15 INFO - TinderboxPrint: I/O write bytes / time
712,671,232 / 2,026 07:15:15 INFO - TinderboxPrint: CPU idle
2,199.3 (45.5%) 07:15:15 INFO - TinderboxPrint: CPU system
980.2 (20.3%) 07:15:15 INFO - TinderboxPrint: CPU user
1,658.2 (34.3%) 07:15:15 INFO - TinderboxPrint: Swap in / out
436,326,400 / 0 07:15:15 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 393234944; Write bytes: 387360768; Read time: 29336; Write time: 788 07:15:15 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 31789568; Write bytes: 303175680; Read time: 200; Write time: 1185 07:15:16 INFO - Running post-run listener: _upload_blobber_files 07:15:16 INFO - Blob upload gear active. 07:15:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:15:16 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 07:15:16 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'] 07:15:16 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 07:15:16 INFO - (blobuploader) - INFO - Open directory for files ... 07:15:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:15:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:15:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:18 INFO - (blobuploader) - INFO - Done attempting. 07:15:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:15:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:15:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:19 INFO - (blobuploader) - INFO - Done attempting. 07:15:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:15:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:15:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:21 INFO - (blobuploader) - INFO - Done attempting. 07:15:21 INFO - (blobuploader) - INFO - Iteration through files over. 07:15:21 INFO - Return code: 0 07:15:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:15:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:15:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/23b8434eee134056974e9a8fc933e6ce8dddd3c778ba2bf3cd1a59579e8ec9ac686ce1da023647cc7ab4ffb5ea8f34892990d711cbe4ed1cf275983129edaaf1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcd7de35db3a39fe3f74e3eb7eaa4ec6a8402520b10da297b2fb124a162effe3a2dd97e28626c355cccf174b47cad012cc4152b3963d27bb4caf89c852093134", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e83ae7e61a698e581d358d95b43b9b43a44e5472861b410df63a472a11e203ad797f71d707809bb6e41738331a10c445d383434b318c5d51b61f7d8adcab371d"} 07:15:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:15:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:15:21 INFO - Contents: 07:15:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/23b8434eee134056974e9a8fc933e6ce8dddd3c778ba2bf3cd1a59579e8ec9ac686ce1da023647cc7ab4ffb5ea8f34892990d711cbe4ed1cf275983129edaaf1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcd7de35db3a39fe3f74e3eb7eaa4ec6a8402520b10da297b2fb124a162effe3a2dd97e28626c355cccf174b47cad012cc4152b3963d27bb4caf89c852093134", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e83ae7e61a698e581d358d95b43b9b43a44e5472861b410df63a472a11e203ad797f71d707809bb6e41738331a10c445d383434b318c5d51b61f7d8adcab371d"} 07:15:21 INFO - Running post-run listener: copy_logs_to_upload_dir 07:15:21 INFO - Copying logs to upload dir... 07:15:21 INFO - mkdir: /builds/slave/test/build/upload/logs 07:15:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.276969 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-27 07:15:21.576567) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 07:15:21.580561) ========= 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.R4dQaFRrm9/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.hmZALvBxEZ/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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/23b8434eee134056974e9a8fc933e6ce8dddd3c778ba2bf3cd1a59579e8ec9ac686ce1da023647cc7ab4ffb5ea8f34892990d711cbe4ed1cf275983129edaaf1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcd7de35db3a39fe3f74e3eb7eaa4ec6a8402520b10da297b2fb124a162effe3a2dd97e28626c355cccf174b47cad012cc4152b3963d27bb4caf89c852093134", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e83ae7e61a698e581d358d95b43b9b43a44e5472861b410df63a472a11e203ad797f71d707809bb6e41738331a10c445d383434b318c5d51b61f7d8adcab371d"} build_url:https://queue.taskcluster.net/v1/task/KoVGd3pnSrScmXcGPDoVVA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010985 build_url: 'https://queue.taskcluster.net/v1/task/KoVGd3pnSrScmXcGPDoVVA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/23b8434eee134056974e9a8fc933e6ce8dddd3c778ba2bf3cd1a59579e8ec9ac686ce1da023647cc7ab4ffb5ea8f34892990d711cbe4ed1cf275983129edaaf1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcd7de35db3a39fe3f74e3eb7eaa4ec6a8402520b10da297b2fb124a162effe3a2dd97e28626c355cccf174b47cad012cc4152b3963d27bb4caf89c852093134", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e83ae7e61a698e581d358d95b43b9b43a44e5472861b410df63a472a11e203ad797f71d707809bb6e41738331a10c445d383434b318c5d51b61f7d8adcab371d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 07:15:21.616106) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 07:15:21.616560) ========= 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.R4dQaFRrm9/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.hmZALvBxEZ/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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.005240 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 07:15:21.667044) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 07:15:21.667506) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 07:15:21.668027) ========= ========= Total master_lag: 0.41 =========