builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0272 starttime: 1491949997.4 results: success (0) buildid: 20170411135808 builduid: 845bc46cad9b47cca6c350f044471e7a revision: 50e40d6c3f09c736a076c3d9e864e67a175ec633 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-11 15:33:17.397244) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-11 15:33:17.397779) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-11 15:33:17.398083) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-11 15:33:17.571628) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 15:33:17.572143) ========= 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.sxUnQfdWx0/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.menHQznOfK/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 --2017-04-11 15:33:17-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 10.8M=0.001s 2017-04-11 15:33:18 (10.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.592537 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 15:33:18.189067) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 15:33:18.189418) ========= 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.sxUnQfdWx0/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.menHQznOfK/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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.036840 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 15:33:18.249369) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-11 15:33:18.249928) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 50e40d6c3f09c736a076c3d9e864e67a175ec633 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 50e40d6c3f09c736a076c3d9e864e67a175ec633 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sxUnQfdWx0/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.menHQznOfK/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 2017-04-11 15:33:18,360 truncating revision to first 12 chars 2017-04-11 15:33:18,361 Setting DEBUG logging. 2017-04-11 15:33:18,361 attempt 1/10 2017-04-11 15:33:18,361 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/50e40d6c3f09?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-11 15:33:19,324 unpacking tar archive at: mozilla-beta-50e40d6c3f09/testing/mozharness/ program finished with exit code 0 elapsedTime=1.262420 ========= master_lag: 0.62 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-11 15:33:20.134894) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-11 15:33:20.135189) ========= script_repo_revision: 50e40d6c3f09c736a076c3d9e864e67a175ec633 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-11 15:33:20.135568) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-11 15:33:20.135845) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-11 15:33:20.156580) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-04-11 15:33:20.156954) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sxUnQfdWx0/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.menHQznOfK/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 15:33:20 INFO - MultiFileLogger online at 20170411 15:33:20 in /builds/slave/test 15:33:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:33:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:33:20 INFO - {'append_to_log': False, 15:33:20 INFO - 'base_work_dir': '/builds/slave/test', 15:33:20 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:33:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:33:20 INFO - 'branch': 'Mozilla-Beta', 15:33:20 INFO - 'buildbot_json_path': 'buildprops.json', 15:33:20 INFO - 'config_files': ('talos/mac_config.py',), 15:33:20 INFO - 'default_actions': ('clobber', 15:33:20 INFO - 'read-buildbot-config', 15:33:20 INFO - 'download-and-extract', 15:33:20 INFO - 'populate-webroot', 15:33:20 INFO - 'create-virtualenv', 15:33:20 INFO - 'install', 15:33:20 INFO - 'run-tests'), 15:33:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:33:20 INFO - 'download_minidump_stackwalk': True, 15:33:20 INFO - 'download_symbols': 'ondemand', 15:33:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:33:20 INFO - 'tooltool.py': '/tools/tooltool.py', 15:33:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:33:20 INFO - '/tools/misc-python/virtualenv.py')}, 15:33:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:33:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:33:20 INFO - 'installer_path': 'installer.exe', 15:33:20 INFO - 'log_level': 'info', 15:33:20 INFO - 'log_name': 'talos', 15:33:20 INFO - 'log_to_console': True, 15:33:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:33:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:33:20 INFO - 'opt_config_files': (), 15:33:20 INFO - 'pip_index': False, 15:33:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:33:20 INFO - 'cmd': ('bash', 15:33:20 INFO - '-c', 15:33:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:33:20 INFO - 'enabled': True, 15:33:20 INFO - 'halt_on_failure': False, 15:33:20 INFO - 'name': 'check_screen_resolution'},), 15:33:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:33:20 INFO - 'cmd': ('bash', 15:33:20 INFO - '-c', 15:33:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:33:20 INFO - 'enabled': True, 15:33:20 INFO - 'halt_on_failure': False, 15:33:20 INFO - 'name': 'check_screen_resolution'},), 15:33:20 INFO - 'run_cmd_checks_enabled': True, 15:33:20 INFO - 'sps_profile': False, 15:33:20 INFO - 'sps_profile_interval': 0, 15:33:20 INFO - 'suite': 'dromaeojs-e10s', 15:33:20 INFO - 'system_bits': '32', 15:33:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:33:20 INFO - 'title': 't-yosemite-r7-0272', 15:33:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:33:20 INFO - 'use_talos_json': True, 15:33:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:33:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:33:20 INFO - 'work_dir': 'build'} 15:33:20 INFO - [mozharness: 2017-04-11 22:33:20.370440Z] Running clobber step. 15:33:20 INFO - Running pre-action listener: _resource_record_pre_action 15:33:20 INFO - Running main action method: clobber 15:33:20 INFO - rmtree: /builds/slave/test/build 15:33:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:33:22 INFO - Running post-action listener: _resource_record_post_action 15:33:22 INFO - [mozharness: 2017-04-11 22:33:22.722348Z] Finished clobber step (success) 15:33:22 INFO - [mozharness: 2017-04-11 22:33:22.722478Z] Running read-buildbot-config step. 15:33:22 INFO - Running pre-action listener: _resource_record_pre_action 15:33:22 INFO - Running main action method: read_buildbot_config 15:33:22 INFO - Using buildbot properties: 15:33:22 INFO - { 15:33:22 INFO - "project": "", 15:33:22 INFO - "product": "firefox", 15:33:22 INFO - "script_repo_revision": "production", 15:33:22 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 15:33:22 INFO - "repository": "", 15:33:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 15:33:22 INFO - "buildid": "20170411135808", 15:33:22 INFO - "pgo_build": "False", 15:33:22 INFO - "basedir": "/builds/slave/test", 15:33:22 INFO - "buildnumber": 0, 15:33:22 INFO - "slavename": "t-yosemite-r7-0272", 15:33:22 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:33:22 INFO - "platform": "yosemite_r7", 15:33:22 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 15:33:22 INFO - "branch": "mozilla-beta", 15:33:22 INFO - "repo_path": "releases/mozilla-beta", 15:33:22 INFO - "revision": "50e40d6c3f09c736a076c3d9e864e67a175ec633", 15:33:22 INFO - "stage_platform": "macosx64", 15:33:22 INFO - "builduid": "845bc46cad9b47cca6c350f044471e7a", 15:33:22 INFO - "slavebuilddir": "test" 15:33:22 INFO - } 15:33:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 15:33:22 INFO - Running post-action listener: _resource_record_post_action 15:33:22 INFO - [mozharness: 2017-04-11 22:33:22.725944Z] Finished read-buildbot-config step (success) 15:33:22 INFO - [mozharness: 2017-04-11 22:33:22.726088Z] Running download-and-extract step. 15:33:22 INFO - Running pre-action listener: _resource_record_pre_action 15:33:22 INFO - Running main action method: download_and_extract 15:33:22 INFO - mkdir: /builds/slave/test/build/tests 15:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:22 INFO - trying https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 15:33:22 INFO - Downloading https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 15:33:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 15:33:23 INFO - Downloaded 1165 bytes. 15:33:23 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 15:33:23 INFO - Using the following test package requirements: 15:33:23 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 15:33:23 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:33:23 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 15:33:23 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:33:23 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 15:33:23 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 15:33:23 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:33:23 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 15:33:23 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 15:33:23 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:33:23 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 15:33:23 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:33:23 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 15:33:23 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:33:23 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 15:33:23 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:33:23 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 15:33:23 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 15:33:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 15:33:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 15:33:23 INFO - Fetch https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 15:33:24 INFO - Expected file size: 16116600 15:33:24 INFO - Obtained file size: 16116600 15:33:30 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 15:33:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 15:33:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 15:33:30 INFO - Fetch https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 15:33:31 INFO - Expected file size: 16116600 15:33:31 INFO - Obtained file size: 16116600 15:33:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 15:33:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 15:33:38 INFO - Fetch https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 15:33:38 INFO - Expected file size: 14403650 15:33:38 INFO - Obtained file size: 14403650 15:33:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:39 INFO - trying https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:33:39 INFO - Downloading https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 15:33:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 15:33:40 INFO - Downloaded 58457927 bytes. 15:33:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:33:40 INFO - mkdir: /builds/slave/test/properties 15:33:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:33:40 INFO - Writing to file /builds/slave/test/properties/build_url 15:33:40 INFO - Contents: 15:33:40 INFO - build_url:https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:33:41 INFO - Running post-action listener: _resource_record_post_action 15:33:41 INFO - Running post-action listener: set_extra_try_arguments 15:33:41 INFO - [mozharness: 2017-04-11 22:33:41.664788Z] Finished download-and-extract step (success) 15:33:41 INFO - [mozharness: 2017-04-11 22:33:41.664942Z] Running populate-webroot step. 15:33:41 INFO - Running pre-action listener: _resource_record_pre_action 15:33:41 INFO - Running main action method: populate_webroot 15:33:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:33:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:33:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:33:41 INFO - '--tppagecycles', 15:33:41 INFO - '7'], 15:33:41 INFO - 'tests': ['tsvgm']}}, 15:33:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:33:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:33:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:33:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:33:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:33:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:33:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:33:41 INFO - 'talos_options': ['--disable-e10s'], 15:33:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:33:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:33:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:33:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:33:41 INFO - 'talos_options': ['--disable-e10s'], 15:33:41 INFO - 'tests': ['damp', 'tps']}, 15:33:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:33:41 INFO - 'tests': ['damp', 'tps']}, 15:33:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:33:41 INFO - 'tests': ['dromaeo_dom']}, 15:33:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:33:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:33:41 INFO - 'tests': ['basic_compositor_video']}, 15:33:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:33:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:33:41 INFO - 'tests': ['a11yr', 15:33:41 INFO - 'ts_paint', 15:33:41 INFO - 'tpaint', 15:33:41 INFO - 'sessionrestore', 15:33:41 INFO - 'sessionrestore_no_auto_restore', 15:33:41 INFO - 'tabpaint']}, 15:33:41 INFO - 'other-e10s': {'tests': ['a11yr', 15:33:41 INFO - 'ts_paint', 15:33:41 INFO - 'tpaint', 15:33:41 INFO - 'sessionrestore', 15:33:41 INFO - 'sessionrestore_no_auto_restore', 15:33:41 INFO - 'tabpaint']}, 15:33:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:33:41 INFO - 'ts_paint', 15:33:41 INFO - 'tpaint', 15:33:41 INFO - 'sessionrestore', 15:33:41 INFO - 'sessionrestore_no_auto_restore', 15:33:41 INFO - 'tabpaint']}, 15:33:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:33:41 INFO - 'ts_paint', 15:33:41 INFO - 'tpaint', 15:33:41 INFO - 'sessionrestore', 15:33:41 INFO - 'sessionrestore_no_auto_restore', 15:33:41 INFO - 'tabpaint']}, 15:33:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:33:41 INFO - 'tests': ['a11yr', 15:33:41 INFO - 'ts_paint', 15:33:41 INFO - 'tpaint', 15:33:41 INFO - 'sessionrestore', 15:33:41 INFO - 'sessionrestore_no_auto_restore', 15:33:41 INFO - 'tabpaint']}, 15:33:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:33:41 INFO - 'tests': ['a11yr', 15:33:41 INFO - 'ts_paint', 15:33:41 INFO - 'tpaint', 15:33:41 INFO - 'sessionrestore', 15:33:41 INFO - 'sessionrestore_no_auto_restore', 15:33:41 INFO - 'tabpaint']}, 15:33:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:33:41 INFO - 'tests': ['tsvgx', 15:33:41 INFO - 'tsvgr_opacity', 15:33:41 INFO - 'tart', 15:33:41 INFO - 'tscrollx', 15:33:41 INFO - 'cart', 15:33:41 INFO - 'tsvg_static']}, 15:33:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:33:41 INFO - 'tsvgr_opacity', 15:33:41 INFO - 'tart', 15:33:41 INFO - 'tscrollx', 15:33:41 INFO - 'cart', 15:33:41 INFO - 'tsvg_static']}, 15:33:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:33:41 INFO - 'talos_options': ['--disable-e10s'], 15:33:41 INFO - 'tests': ['tp5o']}, 15:33:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:33:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:33:41 INFO - 'talos_options': ['--disable-e10s', 15:33:41 INFO - '--xperf_path', 15:33:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:33:41 INFO - 'tests': ['tp5n']}, 15:33:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:33:41 INFO - 'talos_options': ['--xperf_path', 15:33:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:33:41 INFO - 'tests': ['tp5n']}}, 15:33:41 INFO - 'talos.zip': {'path': '', 15:33:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:33:41 INFO - Running post-action listener: _resource_record_post_action 15:33:41 INFO - [mozharness: 2017-04-11 22:33:41.683235Z] Finished populate-webroot step (success) 15:33:41 INFO - [mozharness: 2017-04-11 22:33:41.683371Z] Running create-virtualenv step. 15:33:41 INFO - Running pre-action listener: _resource_record_pre_action 15:33:41 INFO - Running main action method: create_virtualenv 15:33:41 INFO - Creating virtualenv /builds/slave/test/build/venv 15:33:41 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 15:33:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:33:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:33:41 INFO - Using real prefix '/tools/python27' 15:33:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:33:42 INFO - Installing distribute.............................................................................................................................................................................................done. 15:33:45 INFO - Installing pip.................done. 15:33:45 INFO - Return code: 0 15:33:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:33:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:33:45 INFO - Reading from file tmpfile_stdout 15:33:45 INFO - Output received: 15:33:45 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) 15:33:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b9edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb693db6540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7cbd30>, '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 0x10b6f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7c0be8>, '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.sxUnQfdWx0/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.menHQznOfK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 15:33:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:33:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:33:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sxUnQfdWx0/Render', 15:33:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:45 INFO - 'HOME': '/Users/cltbld', 15:33:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:45 INFO - 'LOGNAME': 'cltbld', 15:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:45 INFO - 'MOZ_NO_REMOTE': '1', 15:33:45 INFO - 'NO_EM_RESTART': '1', 15:33:45 INFO - 'PAGER': '/bin/cat', 15:33:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:45 INFO - 'PWD': '/builds/slave/test', 15:33:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:45 INFO - 'SHELL': '/bin/bash', 15:33:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.menHQznOfK/Listeners', 15:33:45 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 15:33:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:45 INFO - 'USER': 'cltbld', 15:33:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:45 INFO - 'XPC_FLAGS': '0x0', 15:33:45 INFO - 'XPC_SERVICE_NAME': '0', 15:33:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:45 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 15:33:45 INFO - Cleaning up... 15:33:45 INFO - Return code: 0 15:33:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b9edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb693db6540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7cbd30>, '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 0x10b6f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7c0be8>, '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.sxUnQfdWx0/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.menHQznOfK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 15:33:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:33:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:33:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sxUnQfdWx0/Render', 15:33:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:45 INFO - 'HOME': '/Users/cltbld', 15:33:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:45 INFO - 'LOGNAME': 'cltbld', 15:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:45 INFO - 'MOZ_NO_REMOTE': '1', 15:33:45 INFO - 'NO_EM_RESTART': '1', 15:33:45 INFO - 'PAGER': '/bin/cat', 15:33:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:45 INFO - 'PWD': '/builds/slave/test', 15:33:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:45 INFO - 'SHELL': '/bin/bash', 15:33:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.menHQznOfK/Listeners', 15:33:45 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 15:33:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:45 INFO - 'USER': 'cltbld', 15:33:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:45 INFO - 'XPC_FLAGS': '0x0', 15:33:45 INFO - 'XPC_SERVICE_NAME': '0', 15:33:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:46 INFO - Downloading/unpacking psutil>=3.1.1 15:33:46 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 15:33:46 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 15:33:46 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 15:33:46 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 15:33:46 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 15:33:46 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 15:33:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:33:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:33:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:33:49 INFO - Installing collected packages: psutil 15:33:49 INFO - Running setup.py install for psutil 15:33:49 INFO - building 'psutil._psutil_osx' extension 15:33:49 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 15:33:50 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 15:33:50 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 15:33:50 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 15:33:50 INFO - building 'psutil._psutil_posix' extension 15:33:50 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 15:33:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:33:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:33:50 INFO - ^ 15:33:50 INFO - 1 warning generated. 15:33:50 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 15:33:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:33:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:33:50 INFO - Successfully installed psutil 15:33:50 INFO - Cleaning up... 15:33:50 INFO - Return code: 0 15:33:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:33: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')]} 15:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33: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')]} 15:33:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b9edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb693db6540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7cbd30>, '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 0x10b6f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7c0be8>, '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.sxUnQfdWx0/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.menHQznOfK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 15:33: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:33: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 mozsystemmonitor==0.3 15:33:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sxUnQfdWx0/Render', 15:33:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:50 INFO - 'HOME': '/Users/cltbld', 15:33:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:50 INFO - 'LOGNAME': 'cltbld', 15:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:50 INFO - 'MOZ_NO_REMOTE': '1', 15:33:50 INFO - 'NO_EM_RESTART': '1', 15:33:50 INFO - 'PAGER': '/bin/cat', 15:33:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:50 INFO - 'PWD': '/builds/slave/test', 15:33:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:50 INFO - 'SHELL': '/bin/bash', 15:33:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.menHQznOfK/Listeners', 15:33:50 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 15:33:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:50 INFO - 'USER': 'cltbld', 15:33:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:50 INFO - 'XPC_FLAGS': '0x0', 15:33:50 INFO - 'XPC_SERVICE_NAME': '0', 15:33:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:33:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:33:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:33:53 INFO - Installing collected packages: mozsystemmonitor 15:33:53 INFO - Running setup.py install for mozsystemmonitor 15:33:53 INFO - Successfully installed mozsystemmonitor 15:33:53 INFO - Cleaning up... 15:33:53 INFO - Return code: 0 15:33:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:33:53 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')]} 15:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:53 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')]} 15:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:53 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 0x10b9edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb693db6540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7cbd30>, '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 0x10b6f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7c0be8>, '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.sxUnQfdWx0/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.menHQznOfK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 15:33:53 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 15:33:53 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 15:33:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sxUnQfdWx0/Render', 15:33:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:53 INFO - 'HOME': '/Users/cltbld', 15:33:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:53 INFO - 'LOGNAME': 'cltbld', 15:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:53 INFO - 'MOZ_NO_REMOTE': '1', 15:33:53 INFO - 'NO_EM_RESTART': '1', 15:33:53 INFO - 'PAGER': '/bin/cat', 15:33:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:53 INFO - 'PWD': '/builds/slave/test', 15:33:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:53 INFO - 'SHELL': '/bin/bash', 15:33:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.menHQznOfK/Listeners', 15:33:53 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 15:33:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:53 INFO - 'USER': 'cltbld', 15:33:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:53 INFO - 'XPC_FLAGS': '0x0', 15:33:53 INFO - 'XPC_SERVICE_NAME': '0', 15:33:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:54 INFO - Downloading/unpacking jsonschema==2.5.1 15:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:33:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:57 INFO - Downloading functools32-3.2.3-2.tar.gz 15:33:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:33:57 INFO - warning: no files found matching '*.txt' 15:33:57 INFO - no previously-included directories found matching 'build' 15:33:57 INFO - no previously-included directories found matching 'dist' 15:33:57 INFO - no previously-included directories found matching '.git*' 15:33:57 INFO - Installing collected packages: jsonschema, functools32 15:33:57 INFO - Running setup.py install for functools32 15:33:57 INFO - warning: no files found matching '*.txt' 15:33:57 INFO - no previously-included directories found matching 'build' 15:33:57 INFO - no previously-included directories found matching 'dist' 15:33:57 INFO - no previously-included directories found matching '.git*' 15:33:57 INFO - Successfully installed jsonschema functools32 15:33:57 INFO - Cleaning up... 15:33:57 INFO - Return code: 0 15:33:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:33:57 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')]} 15:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:57 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')]} 15:33:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:57 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 0x10b9edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb693db6540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7cbd30>, '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 0x10b6f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7c0be8>, '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.sxUnQfdWx0/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.menHQznOfK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 15:33:57 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 15:33:57 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 15:33:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sxUnQfdWx0/Render', 15:33:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:57 INFO - 'HOME': '/Users/cltbld', 15:33:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:57 INFO - 'LOGNAME': 'cltbld', 15:33:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:57 INFO - 'MOZ_NO_REMOTE': '1', 15:33:57 INFO - 'NO_EM_RESTART': '1', 15:33:57 INFO - 'PAGER': '/bin/cat', 15:33:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:57 INFO - 'PWD': '/builds/slave/test', 15:33:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:57 INFO - 'SHELL': '/bin/bash', 15:33:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.menHQznOfK/Listeners', 15:33:57 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 15:33:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:57 INFO - 'USER': 'cltbld', 15:33:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:57 INFO - 'XPC_FLAGS': '0x0', 15:33:57 INFO - 'XPC_SERVICE_NAME': '0', 15:33:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:33:57 INFO - Cleaning up... 15:33:57 INFO - Return code: 0 15:33:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:33:57 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')]} 15:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:57 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')]} 15:33:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:57 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 0x10b9edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb693db6540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7cbd30>, '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 0x10b6f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7c0be8>, '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.sxUnQfdWx0/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.menHQznOfK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 15:33:57 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 15:33:57 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 15:33:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sxUnQfdWx0/Render', 15:33:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:57 INFO - 'HOME': '/Users/cltbld', 15:33:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:57 INFO - 'LOGNAME': 'cltbld', 15:33:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:57 INFO - 'MOZ_NO_REMOTE': '1', 15:33:57 INFO - 'NO_EM_RESTART': '1', 15:33:57 INFO - 'PAGER': '/bin/cat', 15:33:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:57 INFO - 'PWD': '/builds/slave/test', 15:33:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:57 INFO - 'SHELL': '/bin/bash', 15:33:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.menHQznOfK/Listeners', 15:33:57 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 15:33:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:57 INFO - 'USER': 'cltbld', 15:33:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:57 INFO - 'XPC_FLAGS': '0x0', 15:33:57 INFO - 'XPC_SERVICE_NAME': '0', 15:33:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:58 INFO - Downloading/unpacking blobuploader==1.2.4 15:33:58 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 15:33:58 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 15:33:58 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 15:33:58 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 15:33:58 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 15:33:58 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 15:34:00 INFO - Downloading blobuploader-1.2.4.tar.gz 15:34:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:34:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:34:00 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 15:34:00 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 15:34:00 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 15:34:00 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 15:34:00 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 15:34:00 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 15:34:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:34:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:01 INFO - Downloading docopt-0.6.1.tar.gz 15:34:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:34:01 INFO - Installing collected packages: blobuploader, requests, docopt 15:34:01 INFO - Running setup.py install for blobuploader 15:34:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:34:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:34:02 INFO - Running setup.py install for requests 15:34:02 INFO - Running setup.py install for docopt 15:34:02 INFO - Successfully installed blobuploader requests docopt 15:34:02 INFO - Cleaning up... 15:34:02 INFO - Return code: 0 15:34:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:02 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 0x10b9edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb693db6540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7cbd30>, '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 0x10b6f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7c0be8>, '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.sxUnQfdWx0/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.menHQznOfK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 15:34:02 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 15:34:02 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 15:34:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sxUnQfdWx0/Render', 15:34:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:34:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:34:02 INFO - 'HOME': '/Users/cltbld', 15:34:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:34:02 INFO - 'LOGNAME': 'cltbld', 15:34:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:02 INFO - 'MOZ_NO_REMOTE': '1', 15:34:02 INFO - 'NO_EM_RESTART': '1', 15:34:02 INFO - 'PAGER': '/bin/cat', 15:34:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:34:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:02 INFO - 'PWD': '/builds/slave/test', 15:34:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:34:02 INFO - 'SHELL': '/bin/bash', 15:34:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.menHQznOfK/Listeners', 15:34:02 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 15:34:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:34:02 INFO - 'USER': 'cltbld', 15:34:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:34:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:34:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:02 INFO - 'XPC_FLAGS': '0x0', 15:34:02 INFO - 'XPC_SERVICE_NAME': '0', 15:34:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:34:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:34:03 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-7XoJ24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:34:03 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-LFxkyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:34:03 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-pkNshy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:34:03 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-_Y3Maz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:34:03 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-S7wFMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:34:03 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-Qxkl97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:34:03 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-qReFtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:34:03 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-toeHAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:34:03 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-EWhfHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:34:04 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-fX1mup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:34:04 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-qEoc_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:34:04 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-unV6W_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:34:04 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-C_znGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:34:04 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-gTooNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:04 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-HvU_rT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:34:04 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-aIIiNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:34:04 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-JbuhiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:34:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:34:04 INFO - Running setup.py install for manifestparser 15:34:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:34:04 INFO - Running setup.py install for mozcrash 15:34:05 INFO - Running setup.py install for mozdebug 15:34:05 INFO - Running setup.py install for mozdevice 15:34:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:34:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:34:05 INFO - Running setup.py install for mozfile 15:34:05 INFO - Running setup.py install for mozhttpd 15:34:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:34:05 INFO - Running setup.py install for mozinfo 15:34:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:34:05 INFO - Running setup.py install for mozInstall 15:34:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:34:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:34:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:34:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:34:05 INFO - Running setup.py install for mozleak 15:34:06 INFO - Running setup.py install for mozlog 15:34:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:34:06 INFO - Running setup.py install for moznetwork 15:34:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:34:06 INFO - Running setup.py install for mozprocess 15:34:06 INFO - Running setup.py install for mozprofile 15:34:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:34:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:34:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:34:06 INFO - Running setup.py install for mozrunner 15:34:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:34:06 INFO - Running setup.py install for mozscreenshot 15:34:07 INFO - Running setup.py install for moztest 15:34:07 INFO - Running setup.py install for mozversion 15:34:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:34:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:34:07 INFO - Cleaning up... 15:34:07 INFO - Return code: 0 15:34:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34:07 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')]} 15:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:07 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')]} 15:34:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:07 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 0x10b9edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb693db6540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7cbd30>, '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 0x10b6f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7c0be8>, '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.sxUnQfdWx0/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.menHQznOfK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 15:34:07 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 15:34:07 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 15:34:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sxUnQfdWx0/Render', 15:34:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:34:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:34:07 INFO - 'HOME': '/Users/cltbld', 15:34:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:34:07 INFO - 'LOGNAME': 'cltbld', 15:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:07 INFO - 'MOZ_NO_REMOTE': '1', 15:34:07 INFO - 'NO_EM_RESTART': '1', 15:34:07 INFO - 'PAGER': '/bin/cat', 15:34:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:07 INFO - 'PWD': '/builds/slave/test', 15:34:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:34:07 INFO - 'SHELL': '/bin/bash', 15:34:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.menHQznOfK/Listeners', 15:34:07 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 15:34:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:34:07 INFO - 'USER': 'cltbld', 15:34:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:34:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:07 INFO - 'XPC_FLAGS': '0x0', 15:34:07 INFO - 'XPC_SERVICE_NAME': '0', 15:34:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:34:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:34:07 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-NtKLQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:34:07 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)) 15:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:34:07 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-G4QvFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 15:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:34:07 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-lpnexf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:34:07 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)) 15:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:34:08 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-lZVpRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 15:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:34:08 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-KyjzKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:34:08 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)) 15:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:34:08 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-Pa_xjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:34:08 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)) 15:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:34:08 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-JbAPdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:34:08 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)) 15:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:34:08 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-bEJeGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:34:08 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)) 15:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:34:08 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-eZyzBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:34:08 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)) 15:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:34:08 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-Yp6d0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:34:08 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)) 15:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:34:08 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-6E33pT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:34:08 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)) 15:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:34:08 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-IQ_0aC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 15:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:34:08 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-y9BPwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:34:09 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)) 15:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:34:09 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-w6YCU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 15:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:09 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-yhgBLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:09 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)) 15:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:34:09 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-KteM_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 15:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:34:09 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-9cRoHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:34:09 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)) 15:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:34:09 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)) 15:34:09 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:34:09 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:34:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:12 INFO - Downloading blessings-1.6.tar.gz 15:34:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:34:12 INFO - Installing collected packages: blessings 15:34:12 INFO - Running setup.py install for blessings 15:34:12 INFO - Successfully installed blessings 15:34:12 INFO - Cleaning up... 15:34:12 INFO - Return code: 0 15:34:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:34:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:34:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:34:12 INFO - Reading from file tmpfile_stdout 15:34:12 INFO - Current package versions: 15:34:12 INFO - blessings == 1.6 15:34:12 INFO - blobuploader == 1.2.4 15:34:12 INFO - docopt == 0.6.1 15:34:12 INFO - functools32 == 3.2.3-2 15:34:12 INFO - jsonschema == 2.5.1 15:34:12 INFO - manifestparser == 1.1 15:34:12 INFO - mozInstall == 1.12 15:34:12 INFO - mozcrash == 1.0 15:34:12 INFO - mozdebug == 0.1 15:34:12 INFO - mozdevice == 0.49 15:34:12 INFO - mozfile == 1.2 15:34:12 INFO - mozhttpd == 0.7 15:34:12 INFO - mozinfo == 0.9 15:34:12 INFO - mozleak == 0.1 15:34:12 INFO - mozlog == 3.4 15:34:12 INFO - moznetwork == 0.27 15:34:12 INFO - mozprocess == 0.24 15:34:12 INFO - mozprofile == 0.28 15:34:12 INFO - mozrunner == 6.13 15:34:12 INFO - mozscreenshot == 0.1 15:34:12 INFO - mozsystemmonitor == 0.3 15:34:12 INFO - moztest == 0.8 15:34:12 INFO - mozversion == 1.4 15:34:12 INFO - psutil == 3.1.1 15:34:12 INFO - requests == 1.2.3 15:34:12 INFO - wsgiref == 0.1.2 15:34:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34:12 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')]} 15:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34: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')]} 15:34:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b9edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb693db6540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7cbd30>, '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 0x10b6f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7c0be8>, '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.sxUnQfdWx0/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.menHQznOfK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 15:34:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:34:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:34:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sxUnQfdWx0/Render', 15:34:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:34:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:34:13 INFO - 'HOME': '/Users/cltbld', 15:34:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:34:13 INFO - 'LOGNAME': 'cltbld', 15:34:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:13 INFO - 'MOZ_NO_REMOTE': '1', 15:34:13 INFO - 'NO_EM_RESTART': '1', 15:34:13 INFO - 'PAGER': '/bin/cat', 15:34:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:34:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:13 INFO - 'PWD': '/builds/slave/test', 15:34:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:34:13 INFO - 'SHELL': '/bin/bash', 15:34:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.menHQznOfK/Listeners', 15:34:13 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 15:34:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:34:13 INFO - 'USER': 'cltbld', 15:34:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:34:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:34:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:13 INFO - 'XPC_FLAGS': '0x0', 15:34:13 INFO - 'XPC_SERVICE_NAME': '0', 15:34:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:14 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)) 15:34:14 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)) 15:34:14 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)) 15:34:14 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)) 15:34:14 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)) 15:34:14 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)) 15:34:14 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)) 15:34:14 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)) 15:34:14 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)) 15:34:14 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)) 15:34:14 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)) 15:34:14 INFO - Cleaning up... 15:34:14 INFO - Return code: 0 15:34:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:34:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:14 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 0x10b9edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb693db6540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7cbd30>, '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 0x10b6f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7c0be8>, '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.sxUnQfdWx0/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.menHQznOfK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 15:34:14 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 15:34:14 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 15:34:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sxUnQfdWx0/Render', 15:34:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:34:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:34:14 INFO - 'HOME': '/Users/cltbld', 15:34:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:34:14 INFO - 'LOGNAME': 'cltbld', 15:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:14 INFO - 'MOZ_NO_REMOTE': '1', 15:34:14 INFO - 'NO_EM_RESTART': '1', 15:34:14 INFO - 'PAGER': '/bin/cat', 15:34:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:14 INFO - 'PWD': '/builds/slave/test', 15:34:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:34:14 INFO - 'SHELL': '/bin/bash', 15:34:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.menHQznOfK/Listeners', 15:34:14 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 15:34:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:34:14 INFO - 'USER': 'cltbld', 15:34:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:34:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:14 INFO - 'XPC_FLAGS': '0x0', 15:34:14 INFO - 'XPC_SERVICE_NAME': '0', 15:34:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:34:14 INFO - Cleaning up... 15:34:14 INFO - Return code: 0 15:34:14 INFO - Running post-action listener: _resource_record_post_action 15:34:14 INFO - Running post-action listener: _start_resource_monitoring 15:34:14 INFO - Starting resource monitoring. 15:34:14 INFO - [mozharness: 2017-04-11 22:34:14.707206Z] Finished create-virtualenv step (success) 15:34:14 INFO - [mozharness: 2017-04-11 22:34:14.708124Z] Running install step. 15:34:14 INFO - Running pre-action listener: _resource_record_pre_action 15:34:14 INFO - Running main action method: install 15:34:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:34:14 INFO - Reading from file tmpfile_stdout 15:34:14 INFO - Detecting whether we're running mozinstall >=1.0... 15:34:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:34:15 INFO - Reading from file tmpfile_stdout 15:34:15 INFO - Output received: 15:34:15 INFO - Usage: mozinstall [options] installer 15:34:15 INFO - Options: 15:34:15 INFO - -h, --help show this help message and exit 15:34:15 INFO - -d DEST, --destination=DEST 15:34:15 INFO - Directory to install application into. [default: 15:34:15 INFO - "/builds/slave/test"] 15:34:15 INFO - --app=APP Application being installed. [default: firefox] 15:34:15 INFO - mkdir: /builds/slave/test/build/application 15:34:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 15:34:29 INFO - Reading from file tmpfile_stdout 15:34:29 INFO - Output received: 15:34:29 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:34:29 INFO - Running post-action listener: _resource_record_post_action 15:34:29 INFO - [mozharness: 2017-04-11 22:34:29.596088Z] Finished install step (success) 15:34:29 INFO - [mozharness: 2017-04-11 22:34:29.596219Z] Running run-tests step. 15:34:29 INFO - Running pre-action listener: _resource_record_pre_action 15:34:29 INFO - Running main action method: run_tests 15:34:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:34:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:34:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:34:29 INFO - 2017-04-11 15:34:29.610 screenresolution[1626:7370] starting screenresolution argv=screenresolution get 15:34:29 INFO - 2017-04-11 15:34:29.613 screenresolution[1626:7370] Display 0: 1600x1200x32@60 15:34:29 INFO - 2017-04-11 15:34:29.619 screenresolution[1627:7372] starting screenresolution argv=screenresolution list 15:34:29 INFO - Available Modes on Display 0 15:34:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:34:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:34:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:34:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:34:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:34:29 INFO - Intel Iris: 15:34:29 INFO - Chipset Model: Intel Iris 15:34:29 INFO - Type: GPU 15:34:29 INFO - Bus: Built-In 15:34:29 INFO - VRAM (Dynamic, Max): 1536 MB 15:34:29 INFO - Vendor: Intel (0x8086) 15:34:29 INFO - Device ID: 0x0a2e 15:34:29 INFO - Revision ID: 0x0009 15:34:29 INFO - Displays: 15:34:29 INFO - Display: 15:34:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:34:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:34:29 INFO - Display Serial Number: 1600x1200 60 15:34:29 INFO - Main Display: Yes 15:34:29 INFO - Mirror: Off 15:34:29 INFO - Online: Yes 15:34:29 INFO - Rotation: Supported 15:34:29 INFO - Return code: 0 15:34:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:34:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:34:29 INFO - Python 2.7.3 15:34:29 INFO - Return code: 0 15:34:29 INFO - grabbing minidump binary from tooltool 15:34:29 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')]} 15:34:29 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 0x10b7cbd30>, '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 0x10b6f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7c0be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:34:29 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 15:34:29 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 15:34:29 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 15:34:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:34:29 INFO - Return code: 0 15:34:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:34:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:34:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:34:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:34:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:34:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0272', '--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 15:34:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0272 --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 15:34:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sxUnQfdWx0/Render', 15:34:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:34:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:34:29 INFO - 'HOME': '/Users/cltbld', 15:34:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:34:29 INFO - 'LOGNAME': 'cltbld', 15:34:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:34:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:29 INFO - 'MOZ_NO_REMOTE': '1', 15:34:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:34:29 INFO - 'NO_EM_RESTART': '1', 15:34:29 INFO - 'PAGER': '/bin/cat', 15:34:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:29 INFO - 'PWD': '/builds/slave/test', 15:34:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:34:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:34:29 INFO - 'SHELL': '/bin/bash', 15:34:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.menHQznOfK/Listeners', 15:34:29 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 15:34:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:34:29 INFO - 'USER': 'cltbld', 15:34:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:34:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:29 INFO - 'XPC_FLAGS': '0x0', 15:34:29 INFO - 'XPC_SERVICE_NAME': '0', 15:34:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:34:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0272', '--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 15:34:30 INFO - mozversion application_buildid: 20170411135808 15:34:30 INFO - mozversion application_changeset: 50e40d6c3f09c736a076c3d9e864e67a175ec633 15:34:30 INFO - mozversion application_display_name: Firefox 15:34:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:34:30 INFO - mozversion application_name: Firefox 15:34:30 INFO - mozversion application_remotingname: firefox 15:34:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:34:30 INFO - mozversion application_vendor: Mozilla 15:34:30 INFO - mozversion application_version: 53.0 15:34:30 INFO - mozversion platform_buildid: 20170411135808 15:34:30 INFO - mozversion platform_changeset: 50e40d6c3f09c736a076c3d9e864e67a175ec633 15:34:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:34:30 INFO - mozversion platform_version: 53.0 15:34:30 INFO - using testdate: 1491950070 15:34:30 INFO - actual date: 1491950070 15:34:30 INFO - starting webserver on 'localhost:49244' 15:34:30 INFO - SUITE-START | Running 2 tests 15:34:30 INFO - TEST-START | dromaeo_css 15:34:30 INFO - operating with platform_type : mac_ 15:34:30 INFO - Initialising browser for dromaeo_css test... 15:34:30 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/tmpOBQxcO/profile http://localhost:49244/getInfo.html) 15:34:33 INFO - PROCESS | 1637 | 2017-04-11 15:34:33.118 plugin-container[1640:7530] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b3f, name = 'com.apple.tsm.portname' 15:34:33 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:34:33 INFO - PROCESS | 1637 | 2017-04-11 15:34:33.119 plugin-container[1640:7530] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 15:34:33 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:34:33 INFO - PROCESS | 1637 | 2017-04-11 15:34:33.119 plugin-container[1640:7530] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:34:33 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 15:34:33 INFO - PROCESS | 1637 | colorDepth:24 15:34:33 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 15:34:33 INFO - PROCESS | 1637 | __metrics 15:34:33 ERROR - PROCESS | 1637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 15:34:33 INFO - TEST-INFO | 1637: exit 0 15:34:33 INFO - Browser initialized. 15:34:33 INFO - Running cycle 1/1 for dromaeo_css test... 15:34:33 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/tmpOBQxcO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:34:36 INFO - PROCESS | 1641 | 2017-04-11 15:34:36.304 plugin-container[1642:7670] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4243, name = 'com.apple.tsm.portname' 15:34:36 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:34:36 INFO - PROCESS | 1641 | 2017-04-11 15:34:36.304 plugin-container[1642:7670] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x460b, name = 'com.apple.CFPasteboardClient' 15:34:36 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:34:36 INFO - PROCESS | 1641 | 2017-04-11 15:34:36.304 plugin-container[1642:7670] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:34:45 INFO - PROCESS | 1641 | RSS: Main: 173113344 15:34:45 INFO - PROCESS | 1641 | 15:37:47 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 15:37:48 INFO - PROCESS | 1641 | RSS: Main: 192540672 15:37:48 INFO - PROCESS | 1641 | 15:40:51 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 15:40:52 INFO - PROCESS | 1641 | RSS: Main: 203587584 15:40:52 INFO - PROCESS | 1641 | 15:43:53 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 15:43:54 INFO - PROCESS | 1641 | RSS: Main: 205463552 15:43:54 INFO - PROCESS | 1641 | 15:46:56 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 15:46:56 INFO - PROCESS | 1641 | RSS: Main: 208506880 15:46:56 INFO - PROCESS | 1641 | 15:49:59 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 15:50:00 INFO - PROCESS | 1641 | RSS: Main: 209715200 15:50:00 INFO - PROCESS | 1641 | 15:53:03 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 15:53:03 INFO - PROCESS | 1641 | RSS: Main: 210010112 15:53:03 INFO - PROCESS | 1641 | 15:53:03 INFO - PROCESS | 1641 | __start_tp_report 15:53:03 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 15:53:03 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 15:53:03 INFO - PROCESS | 1641 | |i|pagename|runs| 15:53:03 INFO - PROCESS | 1641 | |0;dojo.html;3005.5191169412883;3077.95383069254;3328.868184817162;3464.688178063974;3486.163320803005;5766.596338256324;5776.393478684736;5793.420657934204;5797.739101740422;5835;5793.565482588812;5803.216565763621;5843.065109582468;5849.853753656161;5880.882382352361;4820.542048505386;5087.389513258414;5241.135212689911;5291.100512912795;5338.27933229013;4216.156768646268;4569.840055598055;5253.739102615364;5375.032494151052;5394.8921021579545;4554.24854898943;5317.973410132944;5322.893542129155;5396.271503347037;5446.373667028302;4390.319500477431;5271.235670827708;5331.44019877915;5353.330833645775;5371.435999220084;5231.346081739783;5290.55030322423;5294.947050529484;5380.488853558905;5414.512693857532;4916.459189489154;5989.580729348947;6028.186194863725;6044.425779550936;6087.178230938811;6223.346548612421;6267.686615669244;6276.654783986879;6280.089387038854;6292.905606415908;6174.938250617482;6208.50331973441;6244.625322480666;6348.413146572172;6366.363363663643;6033.034714445712;6049.485793707496;6051.757929682807;6055.545834062463;6092.390760923872;6288.874222515524;6468.256150542654;6496.675166241669;6529.95520716683;6575.276719560845;6129.387061293835;6150.077488376779;6154.261488621394;6154.969225153935;6167.074938759132;6295.779647712308;6298.118263443122;6308.558400911892;6330.873382532415;6338;6171.84570385735;6209.720562574695;6240.251169859646;6254.21822272216;6261.499080073583;6190;6195.132681424604;6199.039148931833;6270.592411493239;6272.780452684226;5005.399352077774;5085.7202853842655;5114.565261952701;5121.436641969381;5151.974240128776;4519.276915693474;4530.161920044802;4530.433695788027;4582.243929751554;4586.6789324747615;6107.938920610737;6108;6137.294211165684;6143.56995010345;6179.598326108879;5809.912851307234;5824.3302020267365;6165.8458538536;6203.751849925952;6241.438270555581;6130.52043589939;6165.445109940127;6170.10533472644;6173.536984726164;6183.474404675563;5539.279893613804;5655.575831812548;5663.801766938137;5665.631733937281;5685.488306052475;6329.145565348711;6375;6427.485801135991;6447.9032814508755;6521.739130434729;6281.340459251713;6310.5267104968225;6314.715837787402;6320.936790632035;6356.9046464304;6514.315996820455;6522.641254731036;6546.0508226305965;6565;6586.8353291168105;6212.627242365473;6236.906446403398;6264.874702505833;6265.874682506415;6265.937340626535;6178.907316390348;6238.719257633326;6245.906311405423;6273.52948528853;6278.15244941927;6227.408396202353;6236;6248.4376406123665;6274.968625156845;6277.874442511215;6064.909026364519;6171.537134714825;6219.595726277958;6248.4688801452385;6250.624962502265;5135.2297155425495;5934;6116.694165291807;6131.264248290234;6143.723532440961;5410.323709536308;5514.5864060194845;6231.376862313732;6248.094026366242;6268.216472940882;6095.603785753912;6096.939030609815;6122.489639783254;6231.688415579293;6290.716917738804 15:53:03 INFO - PROCESS | 1641 | |1;ext.html;492.3378056513988;540.2005032551825;542.4494138449475;543.3479824210948;545.6480570032327;41451;43307;43422.56577434225;45385.546144538544;45433;44789;44792.552074479245;45058.54941450585;45088.77455612725;45271.86820329494;9563.521823908794;9780.510974451285;9782.461964591945;11165.995060444558;11562.07503399726;11337.489812958396;11461.942690286536;11475;11488.942555287213;11493.080553555737;11417.54329826806;11460.48427820746;11492.080633549296;11498.827517587242;11507.827382589227;11226.32642041476;11269.718257043558;11292.09663226948;11312.208145429824;11323.603673871416;11407.600733974272;11436;11454.541818327258;11458.713532161679;11476.598319058876;31962.840185798923;38157.046073848374;38401;38422.23155536874;38501.229975400616;4032.2338755636333;4051.8379264829373;4060.4315395844606;4138.627523522868;4142.378643203544;28202.858985705145;28666.856665716747;28952.42095158085;28952.8552357239;30295;3265.2163480764684;3297.505374193866;3332.4668053111627;3390.133105869747;3525.5240542526685;519692;519764.4011779993;521524;521838;523151;59289.703551481965;59713.701431493435;59746.701266493386;59761;59871.70064149739;61429;61701.691491543155;61754.69122654448;61785.69107154435;61801.38198618046;16498.58753531171;16952.83047169537;17131.828681713025;17149.314027439013;17162.22769975354;11868.465919033664;12139.878601213875;13054.673633159247;13271.66820829487;13294.933525332312;18633.347832825784;18693.252269909324;18716;18842.15210315539;18846.811531884505;8168.305694015957;8261.793455163668;8293.382790355943;8307.507747675672;8350.916490835014;721.8123287945172;851.5444237332997;872.912708729122;904.1726819959795;930.3255140023429;30255.546166807515;30860.84569577138;30935.845320773704;30965.690343096732;31561.526577101362;1069.6790962711154;1076.321917192164;1095.3592148593002;1105.7733164701378;1142.1548054439654;12716.364181790874;15858.44495442677;15970.920145399432;16139.757903631455;16395;603334;620519;621026;621080;621125;62384.68807656023;63061.68469157625;63133.68433157805;63143.73712525816;63257;1358.2801115408652;1463.9194844283666;1480.5410322799967;1502.7520459124123;1515.371120984779;26933.730662693124;27595.758190881057;30673.233169170948;30822.845885770428;30919.381612368077;47703.52296476991;52083;52568.47431525636;52588.21117683161;52600.473995259556;503584;507520;509281;510834;513416;24622.015119395022;25317.367065823502;27307.498087604577;27416.725832742217;27876.16371508858;45397.31904021376;49507.7524612389;49743;49837.750811245714;50188.07626269253;33281.83359083286;33316.66683333136;33438.49842252417;33484.665153348156;34224.486632700035;33423.66576334303;33671.32657346888;34271.828640856635;34291.65708342884;34418.7953421639;39427;40009.599904000585;40034;40152;40278.39582406208;27639;33231.501527477594;33317;33453.33093338071;34447.655523444446;24516.565987560316;24924.37689057788;25446.618300725873;25504.342217755788;26560.734392655828 15:53:03 INFO - PROCESS | 1641 | |2;jquery.html;344.52283587231693;375.92669429461256;403.15337790639677;410.587359703498;433.53178567147484;18004.369847055357;20628.587428251427;21175.894120529414;21948.341549753513;21999.890000549996;21926.122955081817;22116.668249976265;22130.4467388315;22222.222222222226;22435.55128897421;5767.826965191051;5994.550408719363;6020.337762846083;6032.517398608101;6038.667873266969;5684.8294551163535;5902.321233058189;5963.970180149093;5973.641581505102;5978.043513037915;5864.706764661772;5881.558883083764;5894.58737888348;5911.793087241947;5920.674362910038;5644.153376993463;5744.827655170331;5817.534597232211;5820.912686309709;5830.154627578999;5104.617153713486;5147.871303217412;5187.455317191679;5187.922181167285;5195.68825870449;23061.884690576608;26267.21198364052;26587.73412265872;26775.86612066927;27105.457890842074;2682.490326837914;2773.2650847525424;2779.8471084090365;2785.234060633322;2832.405194909051;15389.615259618487;15838.049717017017;16067.598310042342;16219.675606487923;16449.342026318933;1876.8217019383274;1905.6760350740408;2023.271622216001;2039.3881835449306;2055.8149766521083;143842.28078859643;146392.2680386602;151619.24190379088;152040;152903.41289761325;12078.335691536875;12179.634610961686;12239.919213733687;12282.754344913052;12324.260544367367;12255.387230638433;14318.140911545132;15939.681206376039;16157.272922718506;16199.947003444739;8624.094470080676;8953.820923581492;8955.238804701674;9037.593308301011;9218.723438296862;7596.658150383246;8903.421277617064;9038.593263303168;9048.366614337065;9214.262858971266;4284.528701842794;4819.012102518976;4879.268109783561;4929.901401971941;4996.325496058058;1860.3488778927538;2026.2705426046612;2048.6107639548736;2074.927377541809;2087.102545905245;882.4484697064335;890.1276748786096;911.1207684584408;916.7662246127195;926.2034650200821;21594.460138496663;22224.33070826831;22497.43756406103;22538.887305563367;22745.658815117786;924.2282693950492;935.9906400936039;944.9338546301693;954.117441366733;956.6077908057663;9356.812863742824;11210.383428911487;11478.93830058172;11649.708757281136;11699.590514332127;688303;711113;711360;749328;753101;122819.38590306991;139774;144535.5546444543;149282;150112;982.6167794560128;984.2077127911956;998.1665309466531;1004.5680357446222;1009.4498498318287;16116.355345786038;16153.4346297879;18461.630767384846;19422;19601.31395401154;45657;55413.44586554083;57924;58411.4158858406;60083;81524;81974.59012704898;83526;83984.74022889539;85031;7502.587357695379;8531.95734021326;8555.657773688983;8984.550772461482;9045.819083618158;11714.941425292818;13399.732005359643;13580.93209533946;13838.031337806256;13874.722505549631;11406.372649504025;11493.425328733698;11576.826347604961;11587.826182607436;11683.123765717775;10468.371897686164;10533.052025317758;10558.366498010144;11163.609273675382;11212;11528.423578821194;11738.41307934617;11921.821172682243;12126;12158.331291778682;6758.831029224309;7477.065366829146;7728.884066739116;8012.318952888837;8038.63826127814;8430.45202061864;11289.661310160709;11695.12286578493;11708.765824683289;12057.397130143283 15:53:03 INFO - PROCESS | 1641 | |3;mootools.html;1325.940332685029;1446.8553144685538;1491.3587157522268;1494.521753039028;1498.535454009257;7643.57960312184;7894.842103157934;8158.959205203973;8593.097724738898;8614.095519970399;8080.676772929076;8372.120927302636;8381.497110173379;8508.276796472308;8515.957420212906;2375.2636682628354;2381.583222935988;2392.5334559760854;2414.130912871365;2419.2863105383867;2409.6024156014323;2423.8303318767607;2427.5509030829267;2434.0263894442187;2454.9631755523683;2343.8007769339542;2356.7878890899815;2392.437777122375;2401.0275838285525;2417.9637305440433;1986.5927484865567;2015.798420157987;2034.8066933641355;2037.8573499855015;2038.9898050509653;2360.1503458754833;2394.1381102802975;2395.7843794058617;2403.3871362802374;2432.428379330856;8484.278836298921;8522.87215691765;8533.658653653847;8537.445066070686;8551.102134275874;5175.922361164586;5283.603729720248;5300.893982120375;5313.362396512404;5351.759170837322;3175.158582975513;3254.1539199807985;3412.3004784019217;3419.4357930941364;3423.4693622488553;1133.5465813674514;1167.7956357637465;1169.1465230381868;1188.3345326617036;1196.3958201108471;10874.803771585119;10957.12343012565;10968.23222374434;11018;11023.118150548016;4700.8588575152435;4722.6221902247735;4779.044191161782;4840.273958906122;4860.975695121501;9475.857862132074;9578.13796758295;9664.420134791935;9672.95163524192;9681.080297371738;5347.983883062206;5348.411674715778;5351.598630102758;5351.86620334487;5365.141577347684;4364.127174565099;4446.399736035659;4844.394450693663;4888.437829649564;4891.095147397743;3994.820233089518;4014.3376342903093;4080.9387859182134;4102.835886564504;4118.155778065489;1288.4781663426327;1307.1176955554963;1318.815365848782;1324.8012798080365;1332.7134666046848;925.8010875915705;939.6429356844355;947.2706016367358;951.1059603972244;990.9207263418909;5679.375268720438;5791.189233507313;5900.20347253124;6057.515398768088;6105.572609917352;589.0398650200146;593.66623647374;594.8631814682648;598.3418239936035;604.4952464691944;3906.3945088511327;3909.1204478992;3917.666998305119;3968.523777146761;4039.9192016159514;9663.661771838093;9928.602855885829;10010.54952527138;10020.549075291628;10047.598096076075;9899.653512127185;9951.80096398068;9993.000699930095;9996.450195239186;10002.949985250027;7570.394368450511;7902.407319451064;7925.167857375008;7983.640736166886;8062.919370806334;5325.041492531382;5970.3432622412365;5985.281766187911;6001.099835024606;6059.818205453844;8024.759257222293;9351.39215950961;9451.763705907408;9482.762930926781;9500.762480938032;9338.719838404859;9429.905700943178;9500.42997420157;9539.046095390406;9622.230221582397;6189.226346706661;6990.475714321345;7071.328223818729;7136.4647651427385;7345.045144131229;8142.674293028213;8176.713815016446;8178.1821817817745;8184.386171037077;8194.38542109356;6882.483813714091;6998.230194678683;7017.333353331425;7050.5769653820935;7077.752278670222;6811.795646130624;6866.622335771381;6867.175938887365;6892.827679308058;6941.722331106901;5666.546676265806;6405.775797847053;6659.400653940975;6679.899801503078;6689.1972963244725;5085.542301192911;5094.108531006985;5126.743662816919;5171.612129090258;5176.611754118531;4994.925076123934;5017.222330538772;5071.492850714899;5124.180131178993;5236.528712415901 15:53:03 INFO - PROCESS | 1641 | |4;prototype.html;330.8147437435036;369.1969965325417;371.78993868464323;384.4828705391248;386.72735721316474;4488.371627972087;5502.174673798932;5547.751755854931;5614.691191984439;5671.8014869479575;5054.469280725526;5216.008958297921;5395.244665746789;5422.701751403672;5535.944640553604;3587.2736720092785;3705.925881482369;3968.9007774805573;4323.1137616788565;4365.148795984785;3592.92814143717;3672.265546890619;3828.4257361395735;4361.302191649337;4397.208502469554;3938.6214824811373;3972.940405893914;4306.676999225055;4324.437823082995;4364.912701745963;3616.987243571804;4301.956980430203;4312.180685669713;4326.480822301312;4342.32693932441;3831.088372836636;3838.251540949516;3855.2096820152083;3864.516935383077;3886.844526218948;5111.897762044739;5139.948600514022;5316.20256961455;5408.8377348679605;5481.601407127607;4084.6323830855367;4850.345203397532;4851.029794041206;4853.626729423017;4886.267059941002;5869.8239052828485;5904.645721256696;5905.6751878646655;5916.26046744157;5918.319393269786;3535.275268569937;3754.9861537384754;3949.5978927480905;3975.840966361342;4020.9195816083807;5869.826034793015;5941.435563621492;6087.269527656666;6103.1455596216565;6207.689615519206;3488.66857648523;4024.0945787197647;4079.673626109904;4083.2037752638544;4098.405731169023;3486.459598762196;3513.5959364672876;3650.543682039745;3878.146807702301;4128.8348466061025;4576.656750743641;4822.132016237041;4836.661433699607;4836.830710925101;4860.80556777732;5229.561870485647;5898.764049437975;5952.583319167703;5958.888367026738;5960.880782384328;1143.8904262865008;1335.5592654424017;1350.9932450337685;1427.3514091224652;1439.9856001440062;1002.7693630465034;1021.2493817044466;1024.5645600619707;1029.1663752360612;1035.2701345551368;4763.261694437368;4814.975925120352;5199.454057324002;5302.867428314323;5349.362433545149;4591.242444996538;5053.393592768891;5730.656160630292;5773.307203135567;5795.536357091422;4613.800411892932;4672.392588963481;4792.2332426811545;4977.477364876709;5277;2547.3824121682865;2654.66816647919;3021.881903695603;3043.7564994800805;3045.421369939704;4984.750762461862;5435.728213589305;5634.126710359901;5658.321001479849;5663.518600918886;4713;5301.496357845998;5941.029485257372;5999.820005399758;6009.579329446984;5473.616846820684;5499.120140777456;5527;5584.4921871094575;6060.545459090586;4397.909943752341;5020.974895125501;5445.40100588927;5810.883782324415;5860.472557469848;4917.606591472745;5737;5746.798862039808;5762.567807414377;5806.983777838776;5269.656237659372;6063.939360606338;6072.939270607238;6081.604695694766;6143.447089761943;3341.431956567341;3799.2903193562456;4069.1454794492306;4160.500739911109;4207.747535147901;5154.433012368561;5689.91891540606;5799.594028417971;5808.273965754281;6126;4908.901821963612;5778.624389414675;5870.530357571299;5886.117082437669;5895.351511333835;5194.948050519598;5406.621536492565;5826.970865145647;5862.589618726648;5923.674197918984;5370.436104209158;5680.460356266148;5718.51392631631;5719.656820590778;5732;4964.702117872939;5185.481451854785;5781.248437703071;5877;5893.6463812171405;5581;5744.511716504144;5747.48272655463;5792.7103644818435;5806.883862322815 15:53:03 INFO - PROCESS | 1641 | |5;yui.html;742.8774252248379;746.2201998911137;787.5589669784918;869.9826003479931;882.7131182365731;15020.624484387896;15500.84499155008;15930.840691593081;15966.521004369859;16158.596035099128;14521.636959076002;14853.480128195515;14867.628309292273;14978.400863965428;15000.849991500081;758.7951253161657;821.6138414944967;910.5401772105077;916.0930678628143;917.9816403671922;861.2507118806647;884.8274586455643;893.4907102951321;909.5452273863068;913.2876356441986;920.3327587499076;951.4291425144893;955.5795450002012;958.9520523973773;967.6516454076527;905.5245995852165;933.869258303838;947.8720372749659;948.1229862377273;948.1419315519466;678.8913773796219;698.3714656808862;701.3232230897208;712.9358357747827;713.0480808121165;13123.934380328134;15011.924940375338;15967.201639918074;16004.279807408695;16090.75863862043;12501.874981250163;12841.871581284255;13257.138286011379;13949;14211;11702.063834893188;11707.121965852595;11815.645530634009;11885.394745352067;11912.523499060115;3798.392257238856;3839.2897313997;3854.768713877176;3881.2819628368843;3888.5528164260904;101844.49077754638;104728.47635761849;105978;108278;109470;11181;11191.44042797873;11342.603008894814;11443;11677.941610291895;22387;22641.433964151027;22672.8663566821;22998.77001229966;23006.654900176512;7992.240737129963;8021.037475502861;8035.196480351918;8117.715879944174;8226.259636632733;4357.128574285156;4422.137683151819;4490.146872094291;4522.276435770261;4522.751248681288;3589.5333606631493;3683.37382644951;3688.207035487383;3697.2790305890094;3700.40793473043;649.4025496543192;650.3009265040101;654.8559316950359;656.5896314803248;689.4243306838746;694.4826104552141;710.6340234779093;710.9075820143348;712.7086417168828;735.6395366270596;9855.457949812686;10450.16398688103;10463.581456741797;10592.894071059345;10641.574337026432;665.254616509051;675.3516624040976;700.1318365227183;721.3219573600799;725.3906718356606;5041.369828771403;5111.233315002779;5122.590192784568;5129.333186685782;5130.640855140105;108801;109026;111266.44366778115;111431;112558.87441125484;88520.5573972139;90471.09528904626;91288;92779.53610231906;92792.0720792797;80393;82384.58807705923;84028.57985710033;84657;84836.57581712052;9534.417910000406;9929.957354477965;9944.751381215527;9946.104850563484;9954.303198776017;49973.75013124911;53049.734751325996;55034;55979.44020559742;56618.716906415204;50918.981620368126;51676.22485662643;57890.4210957885;58515.829683405245;71523;12980.610581682564;13261.469541218628;13452.798208026692;13480.73038539204;13725;13510.93244533771;14903.850961490247;15055;15338.233088345762;15755.212239387756;13233.669158271121;13767.793483097561;13814.792778108538;14325.21211333345;14349.713005740035;12459.501619935101;13568.93215533916;13813.447462101403;14230.430782768573;14261;13867.514636987657;13916.834172107654;14024.439022438988;14027.859721402656;14028.368723407268;10058.446785426579;10277.126444252022;10311;10573.62992295266;10607.522661480407;10937.617183398543;11378.146639001943;11450.828237576276;11489.253198542068;11541.826872597087 15:53:03 INFO - PROCESS | 1641 | __end_tp_report 15:53:03 INFO - PROCESS | 1641 | __start_cc_report 15:53:03 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,369 15:53:03 INFO - PROCESS | 1641 | __end_cc_report 15:53:03 INFO - PROCESS | 1641 | __startTimestamp1491951183380__endTimestamp 15:53:03 INFO - PROCESS | 1641 | 15:53:03 INFO - PROCESS | 1641 | ------- Summary: start ------- 15:53:03 INFO - PROCESS | 1641 | Number of tests: 6 15:53:03 INFO - PROCESS | 1641 | 15:53:03 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5828.46 Median:6143.57 stddev:695.40 (11.3%) stddev-sans-first:661.33 15:53:03 INFO - PROCESS | 1641 | Values: 3005.5 3078.0 3328.9 3464.7 3486.2 5766.6 5776.4 5793.4 5797.7 5835.0 5793.6 5803.2 5843.1 5849.9 5880.9 4820.5 5087.4 5241.1 5291.1 5338.3 4216.2 4569.8 5253.7 5375.0 5394.9 4554.2 5318.0 5322.9 5396.3 5446.4 4390.3 5271.2 5331.4 5353.3 5371.4 5231.3 5290.6 5294.9 5380.5 5414.5 4916.5 5989.6 6028.2 6044.4 6087.2 6223.3 6267.7 6276.7 6280.1 6292.9 6174.9 6208.5 6244.6 6348.4 6366.4 6033.0 6049.5 6051.8 6055.5 6092.4 6288.9 6468.3 6496.7 6530.0 6575.3 6129.4 6150.1 6154.3 6155.0 6167.1 6295.8 6298.1 6308.6 6330.9 6338.0 6171.8 6209.7 6240.3 6254.2 6261.5 6190.0 6195.1 6199.0 6270.6 6272.8 5005.4 5085.7 5114.6 5121.4 5152.0 4519.3 4530.2 4530.4 4582.2 4586.7 6107.9 6108.0 6137.3 6143.6 6179.6 5809.9 5824.3 6165.8 6203.8 6241.4 6130.5 6165.4 6170.1 6173.5 6183.5 5539.3 5655.6 5663.8 5665.6 5685.5 6329.1 6375.0 6427.5 6447.9 6521.7 6281.3 6310.5 6314.7 6320.9 6356.9 6514.3 6522.6 6546.1 6565.0 6586.8 6212.6 6236.9 6264.9 6265.9 6265.9 6178.9 6238.7 6245.9 6273.5 6278.2 6227.4 6236.0 6248.4 6275.0 6277.9 6064.9 6171.5 6219.6 6248.5 6250.6 5135.2 5934.0 6116.7 6131.3 6143.7 5410.3 5514.6 6231.4 6248.1 6268.2 6095.6 6096.9 6122.5 6231.7 6290.7 15:53:03 INFO - PROCESS | 1641 | 15:53:03 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:68860.78 Median:18530.73 stddev:147004.89 (793.3%) stddev-sans-first:147327.66 15:53:03 INFO - PROCESS | 1641 | Values: 492.3 540.2 542.4 543.3 545.6 41451.0 43307.0 43422.6 45385.5 45433.0 44789.0 44792.6 45058.5 45088.8 45271.9 9563.5 9780.5 9782.5 11166.0 11562.1 11337.5 11461.9 11475.0 11488.9 11493.1 11417.5 11460.5 11492.1 11498.8 11507.8 11226.3 11269.7 11292.1 11312.2 11323.6 11407.6 11436.0 11454.5 11458.7 11476.6 31962.8 38157.0 38401.0 38422.2 38501.2 4032.2 4051.8 4060.4 4138.6 4142.4 28202.9 28666.9 28952.4 28952.9 30295.0 3265.2 3297.5 3332.5 3390.1 3525.5 519692.0 519764.4 521524.0 521838.0 523151.0 59289.7 59713.7 59746.7 59761.0 59871.7 61429.0 61701.7 61754.7 61785.7 61801.4 16498.6 16952.8 17131.8 17149.3 17162.2 11868.5 12139.9 13054.7 13271.7 13294.9 18633.3 18693.3 18716.0 18842.2 18846.8 8168.3 8261.8 8293.4 8307.5 8350.9 721.8 851.5 872.9 904.2 930.3 30255.5 30860.8 30935.8 30965.7 31561.5 1069.7 1076.3 1095.4 1105.8 1142.2 12716.4 15858.4 15970.9 16139.8 16395.0 603334.0 620519.0 621026.0 621080.0 621125.0 62384.7 63061.7 63133.7 63143.7 63257.0 1358.3 1463.9 1480.5 1502.8 1515.4 26933.7 27595.8 30673.2 30822.8 30919.4 47703.5 52083.0 52568.5 52588.2 52600.5 503584.0 507520.0 509281.0 510834.0 513416.0 24622.0 25317.4 27307.5 27416.7 27876.2 45397.3 49507.8 49743.0 49837.8 50188.1 33281.8 33316.7 33438.5 33484.7 34224.5 33423.7 33671.3 34271.8 34291.7 34418.8 39427.0 40009.6 40034.0 40152.0 40278.4 27639.0 33231.5 33317.0 33453.3 34447.7 24516.6 24924.4 25446.6 25504.3 26560.7 15:53:03 INFO - PROCESS | 1641 | 15:53:03 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:40314.25 Median:14939.36 stddev:120647.89 (807.6%) stddev-sans-first:120949.01 15:53:03 INFO - PROCESS | 1641 | Values: 344.5 375.9 403.2 410.6 433.5 18004.4 20628.6 21175.9 21948.3 21999.9 21926.1 22116.7 22130.4 22222.2 22435.6 5767.8 5994.6 6020.3 6032.5 6038.7 5684.8 5902.3 5964.0 5973.6 5978.0 5864.7 5881.6 5894.6 5911.8 5920.7 5644.2 5744.8 5817.5 5820.9 5830.2 5104.6 5147.9 5187.5 5187.9 5195.7 23061.9 26267.2 26587.7 26775.9 27105.5 2682.5 2773.3 2779.8 2785.2 2832.4 15389.6 15838.0 16067.6 16219.7 16449.3 1876.8 1905.7 2023.3 2039.4 2055.8 143842.3 146392.3 151619.2 152040.0 152903.4 12078.3 12179.6 12239.9 12282.8 12324.3 12255.4 14318.1 15939.7 16157.3 16199.9 8624.1 8953.8 8955.2 9037.6 9218.7 7596.7 8903.4 9038.6 9048.4 9214.3 4284.5 4819.0 4879.3 4929.9 4996.3 1860.3 2026.3 2048.6 2074.9 2087.1 882.4 890.1 911.1 916.8 926.2 21594.5 22224.3 22497.4 22538.9 22745.7 924.2 936.0 944.9 954.1 956.6 9356.8 11210.4 11478.9 11649.7 11699.6 688303.0 711113.0 711360.0 749328.0 753101.0 122819.4 139774.0 144535.6 149282.0 150112.0 982.6 984.2 998.2 1004.6 1009.4 16116.4 16153.4 18461.6 19422.0 19601.3 45657.0 55413.4 57924.0 58411.4 60083.0 81524.0 81974.6 83526.0 83984.7 85031.0 7502.6 8532.0 8555.7 8984.6 9045.8 11714.9 13399.7 13580.9 13838.0 13874.7 11406.4 11493.4 11576.8 11587.8 11683.1 10468.4 10533.1 10558.4 11163.6 11212.0 11528.4 11738.4 11921.8 12126.0 12158.3 6758.8 7477.1 7728.9 8012.3 8038.6 8430.5 11289.7 11695.1 11708.8 12057.4 15:53:03 INFO - PROCESS | 1641 | 15:53:03 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5502.38 Median:5350.01 stddev:2991.07 (55.9%) stddev-sans-first:2982.99 15:53:03 INFO - PROCESS | 1641 | Values: 1325.9 1446.9 1491.4 1494.5 1498.5 7643.6 7894.8 8159.0 8593.1 8614.1 8080.7 8372.1 8381.5 8508.3 8516.0 2375.3 2381.6 2392.5 2414.1 2419.3 2409.6 2423.8 2427.6 2434.0 2455.0 2343.8 2356.8 2392.4 2401.0 2418.0 1986.6 2015.8 2034.8 2037.9 2039.0 2360.2 2394.1 2395.8 2403.4 2432.4 8484.3 8522.9 8533.7 8537.4 8551.1 5175.9 5283.6 5300.9 5313.4 5351.8 3175.2 3254.2 3412.3 3419.4 3423.5 1133.5 1167.8 1169.1 1188.3 1196.4 10874.8 10957.1 10968.2 11018.0 11023.1 4700.9 4722.6 4779.0 4840.3 4861.0 9475.9 9578.1 9664.4 9673.0 9681.1 5348.0 5348.4 5351.6 5351.9 5365.1 4364.1 4446.4 4844.4 4888.4 4891.1 3994.8 4014.3 4080.9 4102.8 4118.2 1288.5 1307.1 1318.8 1324.8 1332.7 925.8 939.6 947.3 951.1 990.9 5679.4 5791.2 5900.2 6057.5 6105.6 589.0 593.7 594.9 598.3 604.5 3906.4 3909.1 3917.7 3968.5 4039.9 9663.7 9928.6 10010.5 10020.5 10047.6 9899.7 9951.8 9993.0 9996.5 10002.9 7570.4 7902.4 7925.2 7983.6 8062.9 5325.0 5970.3 5985.3 6001.1 6059.8 8024.8 9351.4 9451.8 9482.8 9500.8 9338.7 9429.9 9500.4 9539.0 9622.2 6189.2 6990.5 7071.3 7136.5 7345.0 8142.7 8176.7 8178.2 8184.4 8194.4 6882.5 6998.2 7017.3 7050.6 7077.8 6811.8 6866.6 6867.2 6892.8 6941.7 5666.5 6405.8 6659.4 6679.9 6689.2 5085.5 5094.1 5126.7 5171.6 5176.6 4994.9 5017.2 5071.5 5124.2 5236.5 15:53:03 INFO - PROCESS | 1641 | 15:53:03 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4645.83 Median:5053.93 stddev:1414.00 (28.0%) stddev-sans-first:1380.38 15:53:03 INFO - PROCESS | 1641 | Values: 330.8 369.2 371.8 384.5 386.7 4488.4 5502.2 5547.8 5614.7 5671.8 5054.5 5216.0 5395.2 5422.7 5535.9 3587.3 3705.9 3968.9 4323.1 4365.1 3592.9 3672.3 3828.4 4361.3 4397.2 3938.6 3972.9 4306.7 4324.4 4364.9 3617.0 4302.0 4312.2 4326.5 4342.3 3831.1 3838.3 3855.2 3864.5 3886.8 5111.9 5139.9 5316.2 5408.8 5481.6 4084.6 4850.3 4851.0 4853.6 4886.3 5869.8 5904.6 5905.7 5916.3 5918.3 3535.3 3755.0 3949.6 3975.8 4020.9 5869.8 5941.4 6087.3 6103.1 6207.7 3488.7 4024.1 4079.7 4083.2 4098.4 3486.5 3513.6 3650.5 3878.1 4128.8 4576.7 4822.1 4836.7 4836.8 4860.8 5229.6 5898.8 5952.6 5958.9 5960.9 1143.9 1335.6 1351.0 1427.4 1440.0 1002.8 1021.2 1024.6 1029.2 1035.3 4763.3 4815.0 5199.5 5302.9 5349.4 4591.2 5053.4 5730.7 5773.3 5795.5 4613.8 4672.4 4792.2 4977.5 5277.0 2547.4 2654.7 3021.9 3043.8 3045.4 4984.8 5435.7 5634.1 5658.3 5663.5 4713.0 5301.5 5941.0 5999.8 6009.6 5473.6 5499.1 5527.0 5584.5 6060.5 4397.9 5021.0 5445.4 5810.9 5860.5 4917.6 5737.0 5746.8 5762.6 5807.0 5269.7 6063.9 6072.9 6081.6 6143.4 3341.4 3799.3 4069.1 4160.5 4207.7 5154.4 5689.9 5799.6 5808.3 6126.0 4908.9 5778.6 5870.5 5886.1 5895.4 5194.9 5406.6 5827.0 5862.6 5923.7 5370.4 5680.5 5718.5 5719.7 5732.0 4964.7 5185.5 5781.2 5877.0 5893.6 5581.0 5744.5 5747.5 5792.7 5806.9 15:53:03 INFO - PROCESS | 1641 | 15:53:03 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:20906.13 Median:3847.03 stddev:30179.67 (784.5%) stddev-sans-first:30226.36 15:53:03 INFO - PROCESS | 1641 | Values: 742.9 746.2 787.6 870.0 882.7 15020.6 15500.8 15930.8 15966.5 16158.6 14521.6 14853.5 14867.6 14978.4 15000.8 758.8 821.6 910.5 916.1 918.0 861.3 884.8 893.5 909.5 913.3 920.3 951.4 955.6 959.0 967.7 905.5 933.9 947.9 948.1 948.1 678.9 698.4 701.3 712.9 713.0 13123.9 15011.9 15967.2 16004.3 16090.8 12501.9 12841.9 13257.1 13949.0 14211.0 11702.1 11707.1 11815.6 11885.4 11912.5 3798.4 3839.3 3854.8 3881.3 3888.6 101844.5 104728.5 105978.0 108278.0 109470.0 11181.0 11191.4 11342.6 11443.0 11677.9 22387.0 22641.4 22672.9 22998.8 23006.7 7992.2 8021.0 8035.2 8117.7 8226.3 4357.1 4422.1 4490.1 4522.3 4522.8 3589.5 3683.4 3688.2 3697.3 3700.4 649.4 650.3 654.9 656.6 689.4 694.5 710.6 710.9 712.7 735.6 9855.5 10450.2 10463.6 10592.9 10641.6 665.3 675.4 700.1 721.3 725.4 5041.4 5111.2 5122.6 5129.3 5130.6 108801.0 109026.0 111266.4 111431.0 112558.9 88520.6 90471.1 91288.0 92779.5 92792.1 80393.0 82384.6 84028.6 84657.0 84836.6 9534.4 9930.0 9944.8 9946.1 9954.3 49973.8 53049.7 55034.0 55979.4 56618.7 50919.0 51676.2 57890.4 58515.8 71523.0 12980.6 13261.5 13452.8 13480.7 13725.0 13510.9 14903.9 15055.0 15338.2 15755.2 13233.7 13767.8 13814.8 14325.2 14349.7 12459.5 13568.9 13813.4 14230.4 14261.0 13867.5 13916.8 14024.4 14027.9 14028.4 10058.4 10277.1 10311.0 10573.6 10607.5 10937.6 11378.1 11450.8 11489.3 11541.8 15:53:03 INFO - PROCESS | 1641 | -------- Summary: end -------- 15:53:03 INFO - PROCESS | 1641 | 15:53:04 INFO - TEST-INFO | 1641: exit 0 15:53:04 INFO - TEST-OK | dromaeo_css | took 1113838ms 15:53:04 INFO - TEST-START | kraken 15:53:04 INFO - operating with platform_type : mac_ 15:53:04 INFO - Initialising browser for kraken test... 15:53:04 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/tmpFNtZkF/profile http://localhost:49244/getInfo.html) 15:53:06 INFO - PROCESS | 1652 | 2017-04-11 15:53:06.583 plugin-container[1654:9914] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4247, name = 'com.apple.tsm.portname' 15:53:06 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:53:06 INFO - PROCESS | 1652 | 2017-04-11 15:53:06.583 plugin-container[1654:9914] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843b, name = 'com.apple.CFPasteboardClient' 15:53:06 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:53:06 INFO - PROCESS | 1652 | 2017-04-11 15:53:06.583 plugin-container[1654:9914] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:53:06 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 15:53:06 INFO - PROCESS | 1652 | colorDepth:24 15:53:06 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 15:53:06 INFO - PROCESS | 1652 | __metrics 15:53:06 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 15:53:07 INFO - TEST-INFO | 1652: exit 0 15:53:07 INFO - Browser initialized. 15:53:07 INFO - Running cycle 1/1 for kraken test... 15:53:07 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/tmpFNtZkF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:53:09 INFO - PROCESS | 1655 | 2017-04-11 15:53:09.802 plugin-container[1656:10029] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 15:53:09 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:53:09 INFO - PROCESS | 1655 | 2017-04-11 15:53:09.803 plugin-container[1656:10029] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x890b, name = 'com.apple.CFPasteboardClient' 15:53:09 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:53:09 INFO - PROCESS | 1655 | 2017-04-11 15:53:09.803 plugin-container[1656:10029] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:53:19 INFO - PROCESS | 1655 | RSS: Main: 173228032 15:53:19 INFO - PROCESS | 1655 | 15:53:22 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 15:53:23 INFO - PROCESS | 1655 | RSS: Main: 186339328 15:53:23 INFO - PROCESS | 1655 | 15:53:25 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 15:53:26 INFO - PROCESS | 1655 | RSS: Main: 194179072 15:53:26 INFO - PROCESS | 1655 | 15:53:29 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 15:53:30 INFO - PROCESS | 1655 | RSS: Main: 197902336 15:53:30 INFO - PROCESS | 1655 | 15:53:32 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 15:53:32 INFO - PROCESS | 1655 | RSS: Main: 198496256 15:53:32 INFO - PROCESS | 1655 | 15:53:34 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:53:35 INFO - PROCESS | 1655 | RSS: Main: 199618560 15:53:35 INFO - PROCESS | 1655 | 15:53:38 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 15:53:39 INFO - PROCESS | 1655 | RSS: Main: 203923456 15:53:39 INFO - PROCESS | 1655 | 15:53:42 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 15:53:42 INFO - PROCESS | 1655 | RSS: Main: 202842112 15:53:42 INFO - PROCESS | 1655 | 15:53:45 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 15:53:46 INFO - PROCESS | 1655 | RSS: Main: 203091968 15:53:46 INFO - PROCESS | 1655 | 15:53:47 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:53:48 INFO - PROCESS | 1655 | RSS: Main: 202063872 15:53:48 INFO - PROCESS | 1655 | 15:53:50 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:53:51 INFO - PROCESS | 1655 | RSS: Main: 202149888 15:53:51 INFO - PROCESS | 1655 | 15:53:53 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:53:53 INFO - PROCESS | 1655 | RSS: Main: 202014720 15:53:53 INFO - PROCESS | 1655 | 15:53:56 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:53:57 INFO - PROCESS | 1655 | RSS: Main: 202059776 15:53:57 INFO - PROCESS | 1655 | 15:54:00 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:54:01 INFO - PROCESS | 1655 | RSS: Main: 202412032 15:54:01 INFO - PROCESS | 1655 | 15:54:02 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 15:54:03 INFO - PROCESS | 1655 | RSS: Main: 204144640 15:54:03 INFO - PROCESS | 1655 | 15:54:03 INFO - PROCESS | 1655 | __start_tp_report 15:54:03 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 15:54:03 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 15:54:03 INFO - PROCESS | 1655 | |i|pagename|runs| 15:54:03 INFO - PROCESS | 1655 | |0;ai-astar;103;118;118;117;117;118;122;120;117;117 15:54:03 INFO - PROCESS | 1655 | |1;audio-beat-detection;135;109;111;138;92;123;134;92;150;137 15:54:03 INFO - PROCESS | 1655 | |2;audio-dft;189;198;210;195;192;192;196;196;217;216 15:54:03 INFO - PROCESS | 1655 | |3;audio-fft;82;58;60;92;74;54;80;82;90;77 15:54:03 INFO - PROCESS | 1655 | |4;audio-oscillator;81;97;110;74;95;56;76;80;98;107 15:54:03 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;88;87;88;114;132;89;113;128;88;87 15:54:03 INFO - PROCESS | 1655 | |6;imaging-darkroom;98;146;147;96;94;104;96;95;95;96 15:54:03 INFO - PROCESS | 1655 | |7;imaging-desaturate;93;94;94;90;95;92;90;94;76;139 15:54:03 INFO - PROCESS | 1655 | |8;json-parse-financial;57;58;59;61;62;63;61;70;66;63 15:54:03 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;72;67;68;77;87;85;60;97;100;98 15:54:03 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;88;84;84;84;83;83;84;86;84;81 15:54:03 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;151;157;161;143;165;145;138;147;201;158 15:54:03 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;167;173;212;220;170;162;164;162;164;164 15:54:03 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;66;65;67;61;62;66;65;65;65;63 15:54:03 INFO - PROCESS | 1655 | __end_tp_report 15:54:03 INFO - PROCESS | 1655 | __start_cc_report 15:54:03 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,915 15:54:03 INFO - PROCESS | 1655 | __end_cc_report 15:54:03 INFO - PROCESS | 1655 | __startTimestamp1491951243134__endTimestamp 15:54:03 INFO - PROCESS | 1655 | 15:54:03 INFO - PROCESS | 1655 | ------- Summary: start ------- 15:54:03 INFO - PROCESS | 1655 | Number of tests: 14 15:54:03 INFO - PROCESS | 1655 | 15:54:03 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:116.70 Median:118.00 stddev:5.08 (4.3%) stddev-sans-first:1.72 15:54:03 INFO - PROCESS | 1655 | Values: 103.0 118.0 118.0 117.0 117.0 118.0 122.0 120.0 117.0 117.0 15:54:03 INFO - PROCESS | 1655 | 15:54:03 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:122.10 Median:137.50 stddev:20.19 (14.7%) stddev-sans-first:20.87 15:54:03 INFO - PROCESS | 1655 | Values: 135.0 109.0 111.0 138.0 92.0 123.0 134.0 92.0 150.0 137.0 15:54:03 INFO - PROCESS | 1655 | 15:54:03 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:200.10 Median:197.00 stddev:10.30 (5.2%) stddev-sans-first:10.11 15:54:03 INFO - PROCESS | 1655 | Values: 189.0 198.0 210.0 195.0 192.0 192.0 196.0 196.0 217.0 216.0 15:54:03 INFO - PROCESS | 1655 | 15:54:03 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:74.90 Median:81.00 stddev:13.32 (16.4%) stddev-sans-first:13.88 15:54:03 INFO - PROCESS | 1655 | Values: 82.0 58.0 60.0 92.0 74.0 54.0 80.0 82.0 90.0 77.0 15:54:03 INFO - PROCESS | 1655 | 15:54:03 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:87.40 Median:80.50 stddev:16.83 (20.9%) stddev-sans-first:17.69 15:54:03 INFO - PROCESS | 1655 | Values: 81.0 97.0 110.0 74.0 95.0 56.0 76.0 80.0 98.0 107.0 15:54:03 INFO - PROCESS | 1655 | 15:54:03 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:101.40 Median:87.50 stddev:18.39 (21.0%) stddev-sans-first:18.86 15:54:03 INFO - PROCESS | 1655 | Values: 88.0 87.0 88.0 114.0 132.0 89.0 113.0 128.0 88.0 87.0 15:54:03 INFO - PROCESS | 1655 | 15:54:03 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:106.70 Median:95.50 stddev:21.16 (22.2%) stddev-sans-first:22.21 15:54:03 INFO - PROCESS | 1655 | Values: 98.0 146.0 147.0 96.0 94.0 104.0 96.0 95.0 95.0 96.0 15:54:03 INFO - PROCESS | 1655 | 15:54:03 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:93.50 stddev:16.19 (17.3%) stddev-sans-first:17.14 15:54:03 INFO - PROCESS | 1655 | Values: 93.0 94.0 94.0 90.0 95.0 92.0 90.0 94.0 76.0 139.0 15:54:03 INFO - PROCESS | 1655 | 15:54:03 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:62.00 Median:62.50 stddev:3.86 (6.2%) stddev-sans-first:3.64 15:54:03 INFO - PROCESS | 1655 | Values: 57.0 58.0 59.0 61.0 62.0 63.0 61.0 70.0 66.0 63.0 15:54:03 INFO - PROCESS | 1655 | 15:54:03 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:81.10 Median:81.00 stddev:14.38 (17.8%) stddev-sans-first:14.87 15:54:03 INFO - PROCESS | 1655 | Values: 72.0 67.0 68.0 77.0 87.0 85.0 60.0 97.0 100.0 98.0 15:54:03 INFO - PROCESS | 1655 | 15:54:03 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.00 stddev:1.85 (2.2%) stddev-sans-first:1.32 15:54:03 INFO - PROCESS | 1655 | Values: 88.0 84.0 84.0 84.0 83.0 83.0 84.0 86.0 84.0 81.0 15:54:03 INFO - PROCESS | 1655 | 15:54:03 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:156.60 Median:157.50 stddev:17.80 (11.3%) stddev-sans-first:18.77 15:54:03 INFO - PROCESS | 1655 | Values: 151.0 157.0 161.0 143.0 165.0 145.0 138.0 147.0 201.0 158.0 15:54:03 INFO - PROCESS | 1655 | 15:54:03 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.80 Median:168.50 stddev:21.56 (12.8%) stddev-sans-first:22.63 15:54:03 INFO - PROCESS | 1655 | Values: 167.0 173.0 212.0 220.0 170.0 162.0 164.0 162.0 164.0 164.0 15:54:03 INFO - PROCESS | 1655 | 15:54:03 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.00 stddev:1.90 (2.9%) stddev-sans-first:1.94 15:54:03 INFO - PROCESS | 1655 | Values: 66.0 65.0 67.0 61.0 62.0 66.0 65.0 65.0 65.0 63.0 15:54:03 INFO - PROCESS | 1655 | -------- Summary: end -------- 15:54:03 INFO - PROCESS | 1655 | 15:54:03 INFO - TEST-INFO | 1655: exit 0 15:54:03 INFO - TEST-OK | kraken | took 59913ms 15:54:03 INFO - SUITE-END | took 1173s 15:54:04 INFO - Completed test suite (00:19:34) 15:54:04 INFO - javascript benchmark 15:54:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7460.696644683588, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3005.5191169412883, 3077.95383069254, 3328.868184817162, 3464.688178063974, 3486.163320803005, 5766.596338256324, 5776.393478684736, 5793.420657934204, 5797.739101740422, 5835.0, 5793.565482588812, 5803.216565763621, 5843.065109582468, 5849.853753656161, 5880.882382352361, 4820.542048505386, 5087.389513258414, 5241.135212689911, 5291.100512912795, 5338.27933229013, 4216.156768646268, 4569.840055598055, 5253.739102615364, 5375.032494151052, 5394.8921021579545, 4554.24854898943, 5317.973410132944, 5322.893542129155, 5396.271503347037, 5446.373667028302, 4390.319500477431, 5271.235670827708, 5331.44019877915, 5353.330833645775, 5371.435999220084, 5231.346081739783, 5290.55030322423, 5294.947050529484, 5380.488853558905, 5414.512693857532, 4916.459189489154, 5989.580729348947, 6028.186194863725, 6044.425779550936, 6087.178230938811, 6223.346548612421, 6267.686615669244, 6276.654783986879, 6280.089387038854, 6292.905606415908, 6174.938250617482, 6208.50331973441, 6244.625322480666, 6348.413146572172, 6366.363363663643, 6033.034714445712, 6049.485793707496, 6051.757929682807, 6055.545834062463, 6092.390760923872, 6288.874222515524, 6468.256150542654, 6496.675166241669, 6529.95520716683, 6575.276719560845, 6129.387061293835, 6150.077488376779, 6154.261488621394, 6154.969225153935, 6167.074938759132, 6295.779647712308, 6298.118263443122, 6308.558400911892, 6330.873382532415, 6338.0, 6171.84570385735, 6209.720562574695, 6240.251169859646, 6254.21822272216, 6261.499080073583, 6190.0, 6195.132681424604, 6199.039148931833, 6270.592411493239, 6272.780452684226, 5005.399352077774, 5085.7202853842655, 5114.565261952701, 5121.436641969381, 5151.974240128776, 4519.276915693474, 4530.161920044802, 4530.433695788027, 4582.243929751554, 4586.6789324747615, 6107.938920610737, 6108.0, 6137.294211165684, 6143.56995010345, 6179.598326108879, 5809.912851307234, 5824.3302020267365, 6165.8458538536, 6203.751849925952, 6241.438270555581, 6130.52043589939, 6165.445109940127, 6170.10533472644, 6173.536984726164, 6183.474404675563, 5539.279893613804, 5655.575831812548, 5663.801766938137, 5665.631733937281, 5685.488306052475, 6329.145565348711, 6375.0, 6427.485801135991, 6447.9032814508755, 6521.739130434729, 6281.340459251713, 6310.5267104968225, 6314.715837787402, 6320.936790632035, 6356.9046464304, 6514.315996820455, 6522.641254731036, 6546.0508226305965, 6565.0, 6586.8353291168105, 6212.627242365473, 6236.906446403398, 6264.874702505833, 6265.874682506415, 6265.937340626535, 6178.907316390348, 6238.719257633326, 6245.906311405423, 6273.52948528853, 6278.15244941927, 6227.408396202353, 6236.0, 6248.4376406123665, 6274.968625156845, 6277.874442511215, 6064.909026364519, 6171.537134714825, 6219.595726277958, 6248.4688801452385, 6250.624962502265, 5135.2297155425495, 5934.0, 6116.694165291807, 6131.264248290234, 6143.723532440961, 5410.323709536308, 5514.5864060194845, 6231.376862313732, 6248.094026366242, 6268.216472940882, 6095.603785753912, 6096.939030609815, 6122.489639783254, 6231.688415579293, 6290.716917738804], "value": 5781.981404426791, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.3378056513988, 540.2005032551825, 542.4494138449475, 543.3479824210948, 545.6480570032327, 41451.0, 43307.0, 43422.56577434225, 45385.546144538544, 45433.0, 44789.0, 44792.552074479245, 45058.54941450585, 45088.77455612725, 45271.86820329494, 9563.521823908794, 9780.510974451285, 9782.461964591945, 11165.995060444558, 11562.07503399726, 11337.489812958396, 11461.942690286536, 11475.0, 11488.942555287213, 11493.080553555737, 11417.54329826806, 11460.48427820746, 11492.080633549296, 11498.827517587242, 11507.827382589227, 11226.32642041476, 11269.718257043558, 11292.09663226948, 11312.208145429824, 11323.603673871416, 11407.600733974272, 11436.0, 11454.541818327258, 11458.713532161679, 11476.598319058876, 31962.840185798923, 38157.046073848374, 38401.0, 38422.23155536874, 38501.229975400616, 4032.2338755636333, 4051.8379264829373, 4060.4315395844606, 4138.627523522868, 4142.378643203544, 28202.858985705145, 28666.856665716747, 28952.42095158085, 28952.8552357239, 30295.0, 3265.2163480764684, 3297.505374193866, 3332.4668053111627, 3390.133105869747, 3525.5240542526685, 519692.0, 519764.4011779993, 521524.0, 521838.0, 523151.0, 59289.703551481965, 59713.701431493435, 59746.701266493386, 59761.0, 59871.70064149739, 61429.0, 61701.691491543155, 61754.69122654448, 61785.69107154435, 61801.38198618046, 16498.58753531171, 16952.83047169537, 17131.828681713025, 17149.314027439013, 17162.22769975354, 11868.465919033664, 12139.878601213875, 13054.673633159247, 13271.66820829487, 13294.933525332312, 18633.347832825784, 18693.252269909324, 18716.0, 18842.15210315539, 18846.811531884505, 8168.305694015957, 8261.793455163668, 8293.382790355943, 8307.507747675672, 8350.916490835014, 721.8123287945172, 851.5444237332997, 872.912708729122, 904.1726819959795, 930.3255140023429, 30255.546166807515, 30860.84569577138, 30935.845320773704, 30965.690343096732, 31561.526577101362, 1069.6790962711154, 1076.321917192164, 1095.3592148593002, 1105.7733164701378, 1142.1548054439654, 12716.364181790874, 15858.44495442677, 15970.920145399432, 16139.757903631455, 16395.0, 603334.0, 620519.0, 621026.0, 621080.0, 621125.0, 62384.68807656023, 63061.68469157625, 63133.68433157805, 63143.73712525816, 63257.0, 1358.2801115408652, 1463.9194844283666, 1480.5410322799967, 1502.7520459124123, 1515.371120984779, 26933.730662693124, 27595.758190881057, 30673.233169170948, 30822.845885770428, 30919.381612368077, 47703.52296476991, 52083.0, 52568.47431525636, 52588.21117683161, 52600.473995259556, 503584.0, 507520.0, 509281.0, 510834.0, 513416.0, 24622.015119395022, 25317.367065823502, 27307.498087604577, 27416.725832742217, 27876.16371508858, 45397.31904021376, 49507.7524612389, 49743.0, 49837.750811245714, 50188.07626269253, 33281.83359083286, 33316.66683333136, 33438.49842252417, 33484.665153348156, 34224.486632700035, 33423.66576334303, 33671.32657346888, 34271.828640856635, 34291.65708342884, 34418.7953421639, 39427.0, 40009.599904000585, 40034.0, 40152.0, 40278.39582406208, 27639.0, 33231.501527477594, 33317.0, 33453.33093338071, 34447.655523444446, 24516.565987560316, 24924.37689057788, 25446.618300725873, 25504.342217755788, 26560.734392655828], "value": 20506.497002691256, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.52283587231693, 375.92669429461256, 403.15337790639677, 410.587359703498, 433.53178567147484, 18004.369847055357, 20628.587428251427, 21175.894120529414, 21948.341549753513, 21999.890000549996, 21926.122955081817, 22116.668249976265, 22130.4467388315, 22222.222222222226, 22435.55128897421, 5767.826965191051, 5994.550408719363, 6020.337762846083, 6032.517398608101, 6038.667873266969, 5684.8294551163535, 5902.321233058189, 5963.970180149093, 5973.641581505102, 5978.043513037915, 5864.706764661772, 5881.558883083764, 5894.58737888348, 5911.793087241947, 5920.674362910038, 5644.153376993463, 5744.827655170331, 5817.534597232211, 5820.912686309709, 5830.154627578999, 5104.617153713486, 5147.871303217412, 5187.455317191679, 5187.922181167285, 5195.68825870449, 23061.884690576608, 26267.21198364052, 26587.73412265872, 26775.86612066927, 27105.457890842074, 2682.490326837914, 2773.2650847525424, 2779.8471084090365, 2785.234060633322, 2832.405194909051, 15389.615259618487, 15838.049717017017, 16067.598310042342, 16219.675606487923, 16449.342026318933, 1876.8217019383274, 1905.6760350740408, 2023.271622216001, 2039.3881835449306, 2055.8149766521083, 143842.28078859643, 146392.2680386602, 151619.24190379088, 152040.0, 152903.41289761325, 12078.335691536875, 12179.634610961686, 12239.919213733687, 12282.754344913052, 12324.260544367367, 12255.387230638433, 14318.140911545132, 15939.681206376039, 16157.272922718506, 16199.947003444739, 8624.094470080676, 8953.820923581492, 8955.238804701674, 9037.593308301011, 9218.723438296862, 7596.658150383246, 8903.421277617064, 9038.593263303168, 9048.366614337065, 9214.262858971266, 4284.528701842794, 4819.012102518976, 4879.268109783561, 4929.901401971941, 4996.325496058058, 1860.3488778927538, 2026.2705426046612, 2048.6107639548736, 2074.927377541809, 2087.102545905245, 882.4484697064335, 890.1276748786096, 911.1207684584408, 916.7662246127195, 926.2034650200821, 21594.460138496663, 22224.33070826831, 22497.43756406103, 22538.887305563367, 22745.658815117786, 924.2282693950492, 935.9906400936039, 944.9338546301693, 954.117441366733, 956.6077908057663, 9356.812863742824, 11210.383428911487, 11478.93830058172, 11649.708757281136, 11699.590514332127, 688303.0, 711113.0, 711360.0, 749328.0, 753101.0, 122819.38590306991, 139774.0, 144535.5546444543, 149282.0, 150112.0, 982.6167794560128, 984.2077127911956, 998.1665309466531, 1004.5680357446222, 1009.4498498318287, 16116.355345786038, 16153.4346297879, 18461.630767384846, 19422.0, 19601.31395401154, 45657.0, 55413.44586554083, 57924.0, 58411.4158858406, 60083.0, 81524.0, 81974.59012704898, 83526.0, 83984.74022889539, 85031.0, 7502.587357695379, 8531.95734021326, 8555.657773688983, 8984.550772461482, 9045.819083618158, 11714.941425292818, 13399.732005359643, 13580.93209533946, 13838.031337806256, 13874.722505549631, 11406.372649504025, 11493.425328733698, 11576.826347604961, 11587.826182607436, 11683.123765717775, 10468.371897686164, 10533.052025317758, 10558.366498010144, 11163.609273675382, 11212.0, 11528.423578821194, 11738.41307934617, 11921.821172682243, 12126.0, 12158.331291778682, 6758.831029224309, 7477.065366829146, 7728.884066739116, 8012.318952888837, 8038.63826127814, 8430.45202061864, 11289.661310160709, 11695.12286578493, 11708.765824683289, 12057.397130143283], "value": 10080.105835407981, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1325.940332685029, 1446.8553144685538, 1491.3587157522268, 1494.521753039028, 1498.535454009257, 7643.57960312184, 7894.842103157934, 8158.959205203973, 8593.097724738898, 8614.095519970399, 8080.676772929076, 8372.120927302636, 8381.497110173379, 8508.276796472308, 8515.957420212906, 2375.2636682628354, 2381.583222935988, 2392.5334559760854, 2414.130912871365, 2419.2863105383867, 2409.6024156014323, 2423.8303318767607, 2427.5509030829267, 2434.0263894442187, 2454.9631755523683, 2343.8007769339542, 2356.7878890899815, 2392.437777122375, 2401.0275838285525, 2417.9637305440433, 1986.5927484865567, 2015.798420157987, 2034.8066933641355, 2037.8573499855015, 2038.9898050509653, 2360.1503458754833, 2394.1381102802975, 2395.7843794058617, 2403.3871362802374, 2432.428379330856, 8484.278836298921, 8522.87215691765, 8533.658653653847, 8537.445066070686, 8551.102134275874, 5175.922361164586, 5283.603729720248, 5300.893982120375, 5313.362396512404, 5351.759170837322, 3175.158582975513, 3254.1539199807985, 3412.3004784019217, 3419.4357930941364, 3423.4693622488553, 1133.5465813674514, 1167.7956357637465, 1169.1465230381868, 1188.3345326617036, 1196.3958201108471, 10874.803771585119, 10957.12343012565, 10968.23222374434, 11018.0, 11023.118150548016, 4700.8588575152435, 4722.6221902247735, 4779.044191161782, 4840.273958906122, 4860.975695121501, 9475.857862132074, 9578.13796758295, 9664.420134791935, 9672.95163524192, 9681.080297371738, 5347.983883062206, 5348.411674715778, 5351.598630102758, 5351.86620334487, 5365.141577347684, 4364.127174565099, 4446.399736035659, 4844.394450693663, 4888.437829649564, 4891.095147397743, 3994.820233089518, 4014.3376342903093, 4080.9387859182134, 4102.835886564504, 4118.155778065489, 1288.4781663426327, 1307.1176955554963, 1318.815365848782, 1324.8012798080365, 1332.7134666046848, 925.8010875915705, 939.6429356844355, 947.2706016367358, 951.1059603972244, 990.9207263418909, 5679.375268720438, 5791.189233507313, 5900.20347253124, 6057.515398768088, 6105.572609917352, 589.0398650200146, 593.66623647374, 594.8631814682648, 598.3418239936035, 604.4952464691944, 3906.3945088511327, 3909.1204478992, 3917.666998305119, 3968.523777146761, 4039.9192016159514, 9663.661771838093, 9928.602855885829, 10010.54952527138, 10020.549075291628, 10047.598096076075, 9899.653512127185, 9951.80096398068, 9993.000699930095, 9996.450195239186, 10002.949985250027, 7570.394368450511, 7902.407319451064, 7925.167857375008, 7983.640736166886, 8062.919370806334, 5325.041492531382, 5970.3432622412365, 5985.281766187911, 6001.099835024606, 6059.818205453844, 8024.759257222293, 9351.39215950961, 9451.763705907408, 9482.762930926781, 9500.762480938032, 9338.719838404859, 9429.905700943178, 9500.42997420157, 9539.046095390406, 9622.230221582397, 6189.226346706661, 6990.475714321345, 7071.328223818729, 7136.4647651427385, 7345.045144131229, 8142.674293028213, 8176.713815016446, 8178.1821817817745, 8184.386171037077, 8194.38542109356, 6882.483813714091, 6998.230194678683, 7017.333353331425, 7050.5769653820935, 7077.752278670222, 6811.795646130624, 6866.622335771381, 6867.175938887365, 6892.827679308058, 6941.722331106901, 5666.546676265806, 6405.775797847053, 6659.400653940975, 6679.899801503078, 6689.1972963244725, 5085.542301192911, 5094.108531006985, 5126.743662816919, 5171.612129090258, 5176.611754118531, 4994.925076123934, 5017.222330538772, 5071.492850714899, 5124.180131178993, 5236.528712415901], "value": 4434.079316531156, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.8147437435036, 369.1969965325417, 371.78993868464323, 384.4828705391248, 386.72735721316474, 4488.371627972087, 5502.174673798932, 5547.751755854931, 5614.691191984439, 5671.8014869479575, 5054.469280725526, 5216.008958297921, 5395.244665746789, 5422.701751403672, 5535.944640553604, 3587.2736720092785, 3705.925881482369, 3968.9007774805573, 4323.1137616788565, 4365.148795984785, 3592.92814143717, 3672.265546890619, 3828.4257361395735, 4361.302191649337, 4397.208502469554, 3938.6214824811373, 3972.940405893914, 4306.676999225055, 4324.437823082995, 4364.912701745963, 3616.987243571804, 4301.956980430203, 4312.180685669713, 4326.480822301312, 4342.32693932441, 3831.088372836636, 3838.251540949516, 3855.2096820152083, 3864.516935383077, 3886.844526218948, 5111.897762044739, 5139.948600514022, 5316.20256961455, 5408.8377348679605, 5481.601407127607, 4084.6323830855367, 4850.345203397532, 4851.029794041206, 4853.626729423017, 4886.267059941002, 5869.8239052828485, 5904.645721256696, 5905.6751878646655, 5916.26046744157, 5918.319393269786, 3535.275268569937, 3754.9861537384754, 3949.5978927480905, 3975.840966361342, 4020.9195816083807, 5869.826034793015, 5941.435563621492, 6087.269527656666, 6103.1455596216565, 6207.689615519206, 3488.66857648523, 4024.0945787197647, 4079.673626109904, 4083.2037752638544, 4098.405731169023, 3486.459598762196, 3513.5959364672876, 3650.543682039745, 3878.146807702301, 4128.8348466061025, 4576.656750743641, 4822.132016237041, 4836.661433699607, 4836.830710925101, 4860.80556777732, 5229.561870485647, 5898.764049437975, 5952.583319167703, 5958.888367026738, 5960.880782384328, 1143.8904262865008, 1335.5592654424017, 1350.9932450337685, 1427.3514091224652, 1439.9856001440062, 1002.7693630465034, 1021.2493817044466, 1024.5645600619707, 1029.1663752360612, 1035.2701345551368, 4763.261694437368, 4814.975925120352, 5199.454057324002, 5302.867428314323, 5349.362433545149, 4591.242444996538, 5053.393592768891, 5730.656160630292, 5773.307203135567, 5795.536357091422, 4613.800411892932, 4672.392588963481, 4792.2332426811545, 4977.477364876709, 5277.0, 2547.3824121682865, 2654.66816647919, 3021.881903695603, 3043.7564994800805, 3045.421369939704, 4984.750762461862, 5435.728213589305, 5634.126710359901, 5658.321001479849, 5663.518600918886, 4713.0, 5301.496357845998, 5941.029485257372, 5999.820005399758, 6009.579329446984, 5473.616846820684, 5499.120140777456, 5527.0, 5584.4921871094575, 6060.545459090586, 4397.909943752341, 5020.974895125501, 5445.40100588927, 5810.883782324415, 5860.472557469848, 4917.606591472745, 5737.0, 5746.798862039808, 5762.567807414377, 5806.983777838776, 5269.656237659372, 6063.939360606338, 6072.939270607238, 6081.604695694766, 6143.447089761943, 3341.431956567341, 3799.2903193562456, 4069.1454794492306, 4160.500739911109, 4207.747535147901, 5154.433012368561, 5689.91891540606, 5799.594028417971, 5808.273965754281, 6126.0, 4908.901821963612, 5778.624389414675, 5870.530357571299, 5886.117082437669, 5895.351511333835, 5194.948050519598, 5406.621536492565, 5826.970865145647, 5862.589618726648, 5923.674197918984, 5370.436104209158, 5680.460356266148, 5718.51392631631, 5719.656820590778, 5732.0, 4964.702117872939, 5185.481451854785, 5781.248437703071, 5877.0, 5893.6463812171405, 5581.0, 5744.511716504144, 5747.48272655463, 5792.7103644818435, 5806.883862322815], "value": 4218.8179279633705, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.8774252248379, 746.2201998911137, 787.5589669784918, 869.9826003479931, 882.7131182365731, 15020.624484387896, 15500.84499155008, 15930.840691593081, 15966.521004369859, 16158.596035099128, 14521.636959076002, 14853.480128195515, 14867.628309292273, 14978.400863965428, 15000.849991500081, 758.7951253161657, 821.6138414944967, 910.5401772105077, 916.0930678628143, 917.9816403671922, 861.2507118806647, 884.8274586455643, 893.4907102951321, 909.5452273863068, 913.2876356441986, 920.3327587499076, 951.4291425144893, 955.5795450002012, 958.9520523973773, 967.6516454076527, 905.5245995852165, 933.869258303838, 947.8720372749659, 948.1229862377273, 948.1419315519466, 678.8913773796219, 698.3714656808862, 701.3232230897208, 712.9358357747827, 713.0480808121165, 13123.934380328134, 15011.924940375338, 15967.201639918074, 16004.279807408695, 16090.75863862043, 12501.874981250163, 12841.871581284255, 13257.138286011379, 13949.0, 14211.0, 11702.063834893188, 11707.121965852595, 11815.645530634009, 11885.394745352067, 11912.523499060115, 3798.392257238856, 3839.2897313997, 3854.768713877176, 3881.2819628368843, 3888.5528164260904, 101844.49077754638, 104728.47635761849, 105978.0, 108278.0, 109470.0, 11181.0, 11191.44042797873, 11342.603008894814, 11443.0, 11677.941610291895, 22387.0, 22641.433964151027, 22672.8663566821, 22998.77001229966, 23006.654900176512, 7992.240737129963, 8021.037475502861, 8035.196480351918, 8117.715879944174, 8226.259636632733, 4357.128574285156, 4422.137683151819, 4490.146872094291, 4522.276435770261, 4522.751248681288, 3589.5333606631493, 3683.37382644951, 3688.207035487383, 3697.2790305890094, 3700.40793473043, 649.4025496543192, 650.3009265040101, 654.8559316950359, 656.5896314803248, 689.4243306838746, 694.4826104552141, 710.6340234779093, 710.9075820143348, 712.7086417168828, 735.6395366270596, 9855.457949812686, 10450.16398688103, 10463.581456741797, 10592.894071059345, 10641.574337026432, 665.254616509051, 675.3516624040976, 700.1318365227183, 721.3219573600799, 725.3906718356606, 5041.369828771403, 5111.233315002779, 5122.590192784568, 5129.333186685782, 5130.640855140105, 108801.0, 109026.0, 111266.44366778115, 111431.0, 112558.87441125484, 88520.5573972139, 90471.09528904626, 91288.0, 92779.53610231906, 92792.0720792797, 80393.0, 82384.58807705923, 84028.57985710033, 84657.0, 84836.57581712052, 9534.417910000406, 9929.957354477965, 9944.751381215527, 9946.104850563484, 9954.303198776017, 49973.75013124911, 53049.734751325996, 55034.0, 55979.44020559742, 56618.716906415204, 50918.981620368126, 51676.22485662643, 57890.4210957885, 58515.829683405245, 71523.0, 12980.610581682564, 13261.469541218628, 13452.798208026692, 13480.73038539204, 13725.0, 13510.93244533771, 14903.850961490247, 15055.0, 15338.233088345762, 15755.212239387756, 13233.669158271121, 13767.793483097561, 13814.792778108538, 14325.21211333345, 14349.713005740035, 12459.501619935101, 13568.93215533916, 13813.447462101403, 14230.430782768573, 14261.0, 13867.514636987657, 13916.834172107654, 14024.439022438988, 14027.859721402656, 14028.368723407268, 10058.446785426579, 10277.126444252022, 10311.0, 10573.62992295266, 10607.522661480407, 10937.617183398543, 11378.146639001943, 11450.828237576276, 11489.253198542068, 11541.826872597087], "value": 7712.612220443076, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 118.0, 118.0, 117.0, 117.0, 118.0, 122.0, 120.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 109.0, 111.0, 138.0, 92.0, 123.0, 134.0, 92.0, 150.0, 137.0], "value": 122.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 198.0, 210.0, 195.0, 192.0, 192.0, 196.0, 196.0, 217.0, 216.0], "value": 200.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 60.0, 92.0, 74.0, 54.0, 80.0, 82.0, 90.0, 77.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 97.0, 110.0, 74.0, 95.0, 56.0, 76.0, 80.0, 98.0, 107.0], "value": 87.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 88.0, 114.0, 132.0, 89.0, 113.0, 128.0, 88.0, 87.0], "value": 101.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 146.0, 147.0, 96.0, 94.0, 104.0, 96.0, 95.0, 95.0, 96.0], "value": 106.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 90.0, 95.0, 92.0, 90.0, 94.0, 76.0, 139.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 59.0, 61.0, 62.0, 63.0, 61.0, 70.0, 66.0, 63.0], "value": 62.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 68.0, 77.0, 87.0, 85.0, 60.0, 97.0, 100.0, 98.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 84.0, 84.0, 83.0, 83.0, 84.0, 86.0, 84.0, 81.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 157.0, 161.0, 143.0, 165.0, 145.0, 138.0, 147.0, 201.0, 158.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 173.0, 212.0, 220.0, 170.0, 162.0, 164.0, 162.0, 164.0, 164.0], "value": 175.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 61.0, 62.0, 66.0, 65.0, 65.0, 65.0, 63.0], "value": 64.5, "unit": "score"}]}]} 15:54:04 INFO - Return code: 0 15:54:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:54:04 ERROR - # TBPL SUCCESS # 15:54:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:54:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:54:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:54:04 INFO - 2017-04-11 15:54:04.466 screenresolution[1660:10417] starting screenresolution argv=screenresolution get 15:54:04 INFO - 2017-04-11 15:54:04.469 screenresolution[1660:10417] Display 0: 1600x1200x32@60 15:54:04 INFO - 2017-04-11 15:54:04.475 screenresolution[1661:10420] starting screenresolution argv=screenresolution list 15:54:04 INFO - Available Modes on Display 0 15:54:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:54:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:54:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:54:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:54:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:54:04 INFO - Intel Iris: 15:54:04 INFO - Chipset Model: Intel Iris 15:54:04 INFO - Type: GPU 15:54:04 INFO - Bus: Built-In 15:54:04 INFO - VRAM (Dynamic, Max): 1536 MB 15:54:04 INFO - Vendor: Intel (0x8086) 15:54:04 INFO - Device ID: 0x0a2e 15:54:04 INFO - Revision ID: 0x0009 15:54:04 INFO - Displays: 15:54:04 INFO - Display: 15:54:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:54:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:54:04 INFO - Display Serial Number: 1600x1200 60 15:54:04 INFO - Main Display: Yes 15:54:04 INFO - Mirror: Off 15:54:04 INFO - Online: Yes 15:54:04 INFO - Rotation: Supported 15:54:04 INFO - Return code: 0 15:54:04 INFO - Running post-action listener: _resource_record_post_action 15:54:04 INFO - [mozharness: 2017-04-11 22:54:04.711323Z] Finished run-tests step (success) 15:54:04 INFO - Running post-run listener: _resource_record_post_run 15:54:04 INFO - Total resource usage - Wall time: 1189s; CPU: 54.0%; Read bytes: 39368704; Write bytes: 423829504; Read time: 246; Write time: 1416 15:54:04 INFO - TinderboxPrint: CPU usage
54.4% 15:54:04 INFO - TinderboxPrint: I/O read bytes / time
39,368,704 / 246 15:54:04 INFO - TinderboxPrint: I/O write bytes / time
423,829,504 / 1,416 15:54:04 INFO - TinderboxPrint: CPU idle
2,167.3 (45.6%) 15:54:04 INFO - TinderboxPrint: CPU system
956.6 (20.1%) 15:54:04 INFO - TinderboxPrint: CPU user
1,633.8 (34.3%) 15:54:04 INFO - TinderboxPrint: Swap in / out
160,563,200 / 0 15:54:04 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 111866368; Write bytes: 106174464; Read time: 10008; Write time: 231 15:54:04 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 38438912; Write bytes: 299997184; Read time: 235; Write time: 1131 15:54:05 INFO - Running post-run listener: _upload_blobber_files 15:54:05 INFO - Blob upload gear active. 15:54:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:54:05 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 15:54:05 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:54:05 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:54:05 INFO - (blobuploader) - INFO - Open directory for files ... 15:54:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:54:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:54:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:06 INFO - (blobuploader) - INFO - Done attempting. 15:54:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:54:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:54:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:07 INFO - (blobuploader) - INFO - Done attempting. 15:54:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:54:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:54:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:08 INFO - (blobuploader) - INFO - Done attempting. 15:54:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:54:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:54:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:10 INFO - (blobuploader) - INFO - Done attempting. 15:54:10 INFO - (blobuploader) - INFO - Iteration through files over. 15:54:10 INFO - Return code: 0 15:54:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:54:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:54:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9b9b3004026a3c8f37cfa22b409fc5d9ba484f6760532574340ceff1b2781739329a0ce039a4c4b1b4382a2d9a830bf4feb004e516df76b9bc2ce7da882c8a8f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f1f34a645781cf702b8c90620d78e0d6a024dd0b2458f8d98fbdc755a1049cd32928b4c94431de11f3be58d2b06f7220424046ee63c7185440736fd5afbc9a13", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0a0bcbf6e32528b6c20b1f08ed2b366f77abc1fb40423870a1bb16d0ad33d53c733c8c244391033fd616ef0a3ce5fe09829df882a75037e6f0a1fe9be20421f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58b190df5d431991b156c10b49b531929040ba680f2549702821f91d219363bd3d96271a9c9ba7089bdfe8a9b70389b7a715d8a746eb1153834a57870183a69e"} 15:54:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:54:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:54:10 INFO - Contents: 15:54:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9b9b3004026a3c8f37cfa22b409fc5d9ba484f6760532574340ceff1b2781739329a0ce039a4c4b1b4382a2d9a830bf4feb004e516df76b9bc2ce7da882c8a8f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f1f34a645781cf702b8c90620d78e0d6a024dd0b2458f8d98fbdc755a1049cd32928b4c94431de11f3be58d2b06f7220424046ee63c7185440736fd5afbc9a13", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0a0bcbf6e32528b6c20b1f08ed2b366f77abc1fb40423870a1bb16d0ad33d53c733c8c244391033fd616ef0a3ce5fe09829df882a75037e6f0a1fe9be20421f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58b190df5d431991b156c10b49b531929040ba680f2549702821f91d219363bd3d96271a9c9ba7089bdfe8a9b70389b7a715d8a746eb1153834a57870183a69e"} 15:54:10 INFO - Running post-run listener: copy_logs_to_upload_dir 15:54:10 INFO - Copying logs to upload dir... 15:54:10 INFO - mkdir: /builds/slave/test/build/upload/logs 15:54:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.669030 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-04-11 15:54:10.867526) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-11 15:54:10.871418) ========= 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.sxUnQfdWx0/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.menHQznOfK/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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/Mozilla-Beta/sha512/9b9b3004026a3c8f37cfa22b409fc5d9ba484f6760532574340ceff1b2781739329a0ce039a4c4b1b4382a2d9a830bf4feb004e516df76b9bc2ce7da882c8a8f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f1f34a645781cf702b8c90620d78e0d6a024dd0b2458f8d98fbdc755a1049cd32928b4c94431de11f3be58d2b06f7220424046ee63c7185440736fd5afbc9a13", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0a0bcbf6e32528b6c20b1f08ed2b366f77abc1fb40423870a1bb16d0ad33d53c733c8c244391033fd616ef0a3ce5fe09829df882a75037e6f0a1fe9be20421f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58b190df5d431991b156c10b49b531929040ba680f2549702821f91d219363bd3d96271a9c9ba7089bdfe8a9b70389b7a715d8a746eb1153834a57870183a69e"} build_url:https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010999 build_url: 'https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9b9b3004026a3c8f37cfa22b409fc5d9ba484f6760532574340ceff1b2781739329a0ce039a4c4b1b4382a2d9a830bf4feb004e516df76b9bc2ce7da882c8a8f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f1f34a645781cf702b8c90620d78e0d6a024dd0b2458f8d98fbdc755a1049cd32928b4c94431de11f3be58d2b06f7220424046ee63c7185440736fd5afbc9a13", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0a0bcbf6e32528b6c20b1f08ed2b366f77abc1fb40423870a1bb16d0ad33d53c733c8c244391033fd616ef0a3ce5fe09829df882a75037e6f0a1fe9be20421f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58b190df5d431991b156c10b49b531929040ba680f2549702821f91d219363bd3d96271a9c9ba7089bdfe8a9b70389b7a715d8a746eb1153834a57870183a69e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-11 15:54:10.905465) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 15:54:10.905800) ========= 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.sxUnQfdWx0/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.menHQznOfK/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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.005104 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 15:54:10.954791) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-11 15:54:10.955172) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-11 15:54:10.955538) ========= ========= Total master_lag: 0.78 =========