builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0029 starttime: 1488208279.58 results: success (0) buildid: 20170227054908 builduid: b00cb84af8334cee9ad4e82171d90d91 revision: 75e0388a1c2ba34871f4e9b6bc3d4f372cc7fd70 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-27 07:11:19.579426) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-27 07:11:19.579930) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-27 07:11:19.580240) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-27 07:11:19.605868) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 07:11:19.606293) ========= 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.pn85YFwtDE/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.8gDlSth6nx/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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-02-27 07:11:19-- 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% 161M=0s 2017-02-27 07:11:19 (161 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.107005 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 07:11:19.737557) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 07:11:19.737932) ========= 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.pn85YFwtDE/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.8gDlSth6nx/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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.020046 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 07:11:19.786966) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-27 07:11:19.787482) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 75e0388a1c2ba34871f4e9b6bc3d4f372cc7fd70 --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-aurora --rev 75e0388a1c2ba34871f4e9b6bc3d4f372cc7fd70 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pn85YFwtDE/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.8gDlSth6nx/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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-02-27 07:11:19,848 truncating revision to first 12 chars 2017-02-27 07:11:19,849 Setting DEBUG logging. 2017-02-27 07:11:19,849 attempt 1/10 2017-02-27 07:11:19,849 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/75e0388a1c2b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-27 07:11:20,793 unpacking tar archive at: mozilla-aurora-75e0388a1c2b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.185893 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-27 07:11:20.997279) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-27 07:11:20.997580) ========= script_repo_revision: 75e0388a1c2ba34871f4e9b6bc3d4f372cc7fd70 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-27 07:11:20.997976) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-27 07:11:20.998273) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-27 07:11:21.018534) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-02-27 07:11:21.019063) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pn85YFwtDE/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.8gDlSth6nx/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 07:11:21 INFO - MultiFileLogger online at 20170227 07:11:21 in /builds/slave/test 07:11:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:11:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:11:21 INFO - {'append_to_log': False, 07:11:21 INFO - 'base_work_dir': '/builds/slave/test', 07:11:21 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:11:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:11:21 INFO - 'branch': 'Mozilla-Aurora', 07:11:21 INFO - 'buildbot_json_path': 'buildprops.json', 07:11:21 INFO - 'config_files': ('talos/mac_config.py',), 07:11:21 INFO - 'default_actions': ('clobber', 07:11:21 INFO - 'read-buildbot-config', 07:11:21 INFO - 'download-and-extract', 07:11:21 INFO - 'populate-webroot', 07:11:21 INFO - 'create-virtualenv', 07:11:21 INFO - 'install', 07:11:21 INFO - 'run-tests'), 07:11:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:11:21 INFO - 'download_minidump_stackwalk': True, 07:11:21 INFO - 'download_symbols': 'ondemand', 07:11:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:11:21 INFO - 'tooltool.py': '/tools/tooltool.py', 07:11:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:11:21 INFO - '/tools/misc-python/virtualenv.py')}, 07:11:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:11:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:11:21 INFO - 'installer_path': 'installer.exe', 07:11:21 INFO - 'log_level': 'info', 07:11:21 INFO - 'log_name': 'talos', 07:11:21 INFO - 'log_to_console': True, 07:11:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:11:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:11:21 INFO - 'opt_config_files': (), 07:11:21 INFO - 'pip_index': False, 07:11:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:11:21 INFO - 'cmd': ('bash', 07:11:21 INFO - '-c', 07:11:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:11:21 INFO - 'enabled': True, 07:11:21 INFO - 'halt_on_failure': False, 07:11:21 INFO - 'name': 'check_screen_resolution'},), 07:11:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:11:21 INFO - 'cmd': ('bash', 07:11:21 INFO - '-c', 07:11:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:11:21 INFO - 'enabled': True, 07:11:21 INFO - 'halt_on_failure': False, 07:11:21 INFO - 'name': 'check_screen_resolution'},), 07:11:21 INFO - 'run_cmd_checks_enabled': True, 07:11:21 INFO - 'sps_profile': False, 07:11:21 INFO - 'sps_profile_interval': 0, 07:11:21 INFO - 'suite': 'dromaeojs-e10s', 07:11:21 INFO - 'system_bits': '32', 07:11:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:11:21 INFO - 'title': 't-yosemite-r7-0029', 07:11:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:11:21 INFO - 'use_talos_json': True, 07:11:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:11:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:11:21 INFO - 'work_dir': 'build'} 07:11:21 INFO - [mozharness: 2017-02-27 15:11:21.207866Z] Running clobber step. 07:11:21 INFO - Running pre-action listener: _resource_record_pre_action 07:11:21 INFO - Running main action method: clobber 07:11:21 INFO - rmtree: /builds/slave/test/build 07:11:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:11:23 INFO - Running post-action listener: _resource_record_post_action 07:11:23 INFO - [mozharness: 2017-02-27 15:11:23.188478Z] Finished clobber step (success) 07:11:23 INFO - [mozharness: 2017-02-27 15:11:23.188736Z] Running read-buildbot-config step. 07:11:23 INFO - Running pre-action listener: _resource_record_pre_action 07:11:23 INFO - Running main action method: read_buildbot_config 07:11:23 INFO - Using buildbot properties: 07:11:23 INFO - { 07:11:23 INFO - "project": "", 07:11:23 INFO - "product": "firefox", 07:11:23 INFO - "script_repo_revision": "production", 07:11:23 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 07:11:23 INFO - "repository": "", 07:11:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 07:11:23 INFO - "buildid": "20170227054908", 07:11:23 INFO - "pgo_build": "False", 07:11:23 INFO - "basedir": "/builds/slave/test", 07:11:23 INFO - "buildnumber": 67, 07:11:23 INFO - "slavename": "t-yosemite-r7-0029", 07:11:23 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 07:11:23 INFO - "platform": "yosemite_r7", 07:11:23 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:11:23 INFO - "branch": "mozilla-aurora", 07:11:23 INFO - "repo_path": "releases/mozilla-aurora", 07:11:23 INFO - "revision": "75e0388a1c2ba34871f4e9b6bc3d4f372cc7fd70", 07:11:23 INFO - "stage_platform": "macosx64", 07:11:23 INFO - "builduid": "b00cb84af8334cee9ad4e82171d90d91", 07:11:23 INFO - "slavebuilddir": "test" 07:11:23 INFO - } 07:11:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/c80Cin4tTBGIv1pqjuYZUA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 07:11:23 INFO - Running post-action listener: _resource_record_post_action 07:11:23 INFO - [mozharness: 2017-02-27 15:11:23.194369Z] Finished read-buildbot-config step (success) 07:11:23 INFO - [mozharness: 2017-02-27 15:11:23.194503Z] Running download-and-extract step. 07:11:23 INFO - Running pre-action listener: _resource_record_pre_action 07:11:23 INFO - Running main action method: download_and_extract 07:11:23 INFO - mkdir: /builds/slave/test/build/tests 07:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:23 INFO - trying https://queue.taskcluster.net/v1/task/c80Cin4tTBGIv1pqjuYZUA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 07:11:23 INFO - Downloading https://queue.taskcluster.net/v1/task/c80Cin4tTBGIv1pqjuYZUA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 07:11:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c80Cin4tTBGIv1pqjuYZUA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 07:11:24 INFO - Downloaded 1199 bytes. 07:11:24 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 07:11:24 INFO - Using the following test package requirements: 07:11:24 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 07:11:24 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:11:24 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 07:11:24 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:11:24 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 07:11:24 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:11:24 INFO - u'jsshell-mac.zip'], 07:11:24 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:11:24 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 07:11:24 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 07:11:24 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:11:24 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 07:11:24 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:11:24 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 07:11:24 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:11:24 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 07:11:24 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:11:24 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 07:11:24 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:11:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c80Cin4tTBGIv1pqjuYZUA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 07:11:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c80Cin4tTBGIv1pqjuYZUA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:11:24 INFO - Fetch https://queue.taskcluster.net/v1/task/c80Cin4tTBGIv1pqjuYZUA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 07:11:25 INFO - Expected file size: 16357783 07:11:25 INFO - Obtained file size: 16357783 07:11:31 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:11:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c80Cin4tTBGIv1pqjuYZUA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 07:11:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c80Cin4tTBGIv1pqjuYZUA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:11:31 INFO - Fetch https://queue.taskcluster.net/v1/task/c80Cin4tTBGIv1pqjuYZUA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 07:11:32 INFO - Expected file size: 16357783 07:11:32 INFO - Obtained file size: 16357783 07:11:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c80Cin4tTBGIv1pqjuYZUA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 07:11:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c80Cin4tTBGIv1pqjuYZUA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:11:39 INFO - Fetch https://queue.taskcluster.net/v1/task/c80Cin4tTBGIv1pqjuYZUA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 07:11:40 INFO - Expected file size: 14403472 07:11:40 INFO - Obtained file size: 14403472 07:11:40 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')]} 07:11:40 INFO - trying https://queue.taskcluster.net/v1/task/c80Cin4tTBGIv1pqjuYZUA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 07:11:40 INFO - Downloading https://queue.taskcluster.net/v1/task/c80Cin4tTBGIv1pqjuYZUA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 07:11:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c80Cin4tTBGIv1pqjuYZUA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 07:11:42 INFO - Downloaded 73922784 bytes. 07:11:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c80Cin4tTBGIv1pqjuYZUA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 07:11:42 INFO - mkdir: /builds/slave/test/properties 07:11:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:11:42 INFO - Writing to file /builds/slave/test/properties/build_url 07:11:42 INFO - Contents: 07:11:42 INFO - build_url:https://queue.taskcluster.net/v1/task/c80Cin4tTBGIv1pqjuYZUA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 07:11:43 INFO - Running post-action listener: _resource_record_post_action 07:11:43 INFO - Running post-action listener: set_extra_try_arguments 07:11:43 INFO - [mozharness: 2017-02-27 15:11:43.466636Z] Finished download-and-extract step (success) 07:11:43 INFO - [mozharness: 2017-02-27 15:11:43.466780Z] Running populate-webroot step. 07:11:43 INFO - Running pre-action listener: _resource_record_pre_action 07:11:43 INFO - Running main action method: populate_webroot 07:11:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:11:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:11:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:11:43 INFO - '--tppagecycles', 07:11:43 INFO - '7'], 07:11:43 INFO - 'tests': ['tsvgm']}}, 07:11:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:11:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:11:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:11:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:11:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:11:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:11:43 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:11:43 INFO - 'talos_options': ['--disable-e10s'], 07:11:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:11:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:11:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:11:43 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:11:43 INFO - 'talos_options': ['--disable-e10s'], 07:11:43 INFO - 'tests': ['damp', 'tps']}, 07:11:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:11:43 INFO - 'tests': ['damp', 'tps']}, 07:11:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:11:43 INFO - 'tests': ['dromaeo_dom']}, 07:11:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:11:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:11:43 INFO - 'tests': ['basic_compositor_video']}, 07:11:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:11:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:11:43 INFO - 'tests': ['a11yr', 07:11:43 INFO - 'ts_paint', 07:11:43 INFO - 'tpaint', 07:11:43 INFO - 'sessionrestore', 07:11:43 INFO - 'sessionrestore_no_auto_restore', 07:11:43 INFO - 'tabpaint']}, 07:11:43 INFO - 'other-e10s': {'tests': ['a11yr', 07:11:43 INFO - 'ts_paint', 07:11:43 INFO - 'tpaint', 07:11:43 INFO - 'sessionrestore', 07:11:43 INFO - 'sessionrestore_no_auto_restore', 07:11:43 INFO - 'tabpaint']}, 07:11:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:11:43 INFO - 'ts_paint', 07:11:43 INFO - 'tpaint', 07:11:43 INFO - 'sessionrestore', 07:11:43 INFO - 'sessionrestore_no_auto_restore', 07:11:43 INFO - 'tabpaint']}, 07:11:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:11:43 INFO - 'ts_paint', 07:11:43 INFO - 'tpaint', 07:11:43 INFO - 'sessionrestore', 07:11:43 INFO - 'sessionrestore_no_auto_restore', 07:11:43 INFO - 'tabpaint']}, 07:11:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:11:43 INFO - 'tests': ['a11yr', 07:11:43 INFO - 'ts_paint', 07:11:43 INFO - 'tpaint', 07:11:43 INFO - 'sessionrestore', 07:11:43 INFO - 'sessionrestore_no_auto_restore', 07:11:43 INFO - 'tabpaint']}, 07:11:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:11:43 INFO - 'tests': ['a11yr', 07:11:43 INFO - 'ts_paint', 07:11:43 INFO - 'tpaint', 07:11:43 INFO - 'sessionrestore', 07:11:43 INFO - 'sessionrestore_no_auto_restore', 07:11:43 INFO - 'tabpaint']}, 07:11:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:11:43 INFO - 'tests': ['tsvgx', 07:11:43 INFO - 'tsvgr_opacity', 07:11:43 INFO - 'tart', 07:11:43 INFO - 'tscrollx', 07:11:43 INFO - 'cart', 07:11:43 INFO - 'tsvg_static']}, 07:11:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:11:43 INFO - 'tsvgr_opacity', 07:11:43 INFO - 'tart', 07:11:43 INFO - 'tscrollx', 07:11:43 INFO - 'cart', 07:11:43 INFO - 'tsvg_static']}, 07:11:43 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:11:43 INFO - 'talos_options': ['--disable-e10s'], 07:11:43 INFO - 'tests': ['tp5o']}, 07:11:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:11:43 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:11:43 INFO - 'talos_options': ['--disable-e10s', 07:11:43 INFO - '--xperf_path', 07:11:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:11:43 INFO - 'tests': ['tp5n']}, 07:11:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:11:43 INFO - 'talos_options': ['--xperf_path', 07:11:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:11:43 INFO - 'tests': ['tp5n']}}, 07:11:43 INFO - 'talos.zip': {'path': '', 07:11:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:11:43 INFO - Running post-action listener: _resource_record_post_action 07:11:43 INFO - [mozharness: 2017-02-27 15:11:43.485220Z] Finished populate-webroot step (success) 07:11:43 INFO - [mozharness: 2017-02-27 15:11:43.485334Z] Running create-virtualenv step. 07:11:43 INFO - Running pre-action listener: _resource_record_pre_action 07:11:43 INFO - Running main action method: create_virtualenv 07:11:43 INFO - Creating virtualenv /builds/slave/test/build/venv 07:11:43 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 07:11:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:11:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:11:43 INFO - Using real prefix '/tools/python27' 07:11:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:11:44 INFO - Installing distribute.............................................................................................................................................................................................done. 07:11:47 INFO - Installing pip.................done. 07:11:47 INFO - Return code: 0 07:11:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:11:47 INFO - Reading from file tmpfile_stdout 07:11:47 INFO - Output received: 07:11:47 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) 07:11:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104605b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104608768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4c8d6d290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043e3d30>, '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 0x10430adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043d8be8>, '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.pn85YFwtDE/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.8gDlSth6nx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 07:11:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:11:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pn85YFwtDE/Render', 07:11:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:11:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:11:47 INFO - 'HOME': '/Users/cltbld', 07:11:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:11:47 INFO - 'LOGNAME': 'cltbld', 07:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:47 INFO - 'MOZ_NO_REMOTE': '1', 07:11:47 INFO - 'NO_EM_RESTART': '1', 07:11:47 INFO - 'PAGER': '/bin/cat', 07:11:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:47 INFO - 'PWD': '/builds/slave/test', 07:11:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:11:47 INFO - 'SHELL': '/bin/bash', 07:11:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8gDlSth6nx/Listeners', 07:11:47 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 07:11:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:11:47 INFO - 'USER': 'cltbld', 07:11:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:11:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:47 INFO - 'XPC_FLAGS': '0x0', 07:11:47 INFO - 'XPC_SERVICE_NAME': '0', 07:11:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:47 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 07:11:47 INFO - Cleaning up... 07:11:47 INFO - Return code: 0 07:11:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104605b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104608768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4c8d6d290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043e3d30>, '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 0x10430adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043d8be8>, '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.pn85YFwtDE/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.8gDlSth6nx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 07:11:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:11:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pn85YFwtDE/Render', 07:11:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:11:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:11:47 INFO - 'HOME': '/Users/cltbld', 07:11:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:11:47 INFO - 'LOGNAME': 'cltbld', 07:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:47 INFO - 'MOZ_NO_REMOTE': '1', 07:11:47 INFO - 'NO_EM_RESTART': '1', 07:11:47 INFO - 'PAGER': '/bin/cat', 07:11:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:47 INFO - 'PWD': '/builds/slave/test', 07:11:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:11:47 INFO - 'SHELL': '/bin/bash', 07:11:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8gDlSth6nx/Listeners', 07:11:47 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 07:11:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:11:47 INFO - 'USER': 'cltbld', 07:11:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:11:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:47 INFO - 'XPC_FLAGS': '0x0', 07:11:47 INFO - 'XPC_SERVICE_NAME': '0', 07:11:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:47 INFO - Downloading/unpacking psutil>=3.1.1 07:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:11:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:11:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:11:51 INFO - Installing collected packages: psutil 07:11:51 INFO - Running setup.py install for psutil 07:11:51 INFO - building 'psutil._psutil_osx' extension 07:11:51 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 07:11:51 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 07:11:51 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 07:11:52 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 07:11:52 INFO - building 'psutil._psutil_posix' extension 07:11:52 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 07:11:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:11:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:11:52 INFO - ^ 07:11:52 INFO - 1 warning generated. 07:11:52 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 07:11:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:11:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:11:52 INFO - Successfully installed psutil 07:11:52 INFO - Cleaning up... 07:11:52 INFO - Return code: 0 07:11:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:11:52 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')]} 07:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:52 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')]} 07:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:52 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 0x104605b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104608768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4c8d6d290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043e3d30>, '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 0x10430adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043d8be8>, '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.pn85YFwtDE/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.8gDlSth6nx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 07:11:52 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 07:11:52 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 07:11:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pn85YFwtDE/Render', 07:11:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:11:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:11:52 INFO - 'HOME': '/Users/cltbld', 07:11:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:11:52 INFO - 'LOGNAME': 'cltbld', 07:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:52 INFO - 'MOZ_NO_REMOTE': '1', 07:11:52 INFO - 'NO_EM_RESTART': '1', 07:11:52 INFO - 'PAGER': '/bin/cat', 07:11:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:52 INFO - 'PWD': '/builds/slave/test', 07:11:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:11:52 INFO - 'SHELL': '/bin/bash', 07:11:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8gDlSth6nx/Listeners', 07:11:52 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 07:11:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:11:52 INFO - 'USER': 'cltbld', 07:11:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:11:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:52 INFO - 'XPC_FLAGS': '0x0', 07:11:52 INFO - 'XPC_SERVICE_NAME': '0', 07:11:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:11:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:11:55 INFO - Installing collected packages: mozsystemmonitor 07:11:55 INFO - Running setup.py install for mozsystemmonitor 07:11:55 INFO - Successfully installed mozsystemmonitor 07:11:55 INFO - Cleaning up... 07:11:55 INFO - Return code: 0 07:11:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:55 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 0x104605b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104608768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4c8d6d290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043e3d30>, '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 0x10430adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043d8be8>, '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.pn85YFwtDE/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.8gDlSth6nx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 07:11:55 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 07:11:55 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 07:11:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pn85YFwtDE/Render', 07:11:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:11:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:11:55 INFO - 'HOME': '/Users/cltbld', 07:11:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:11:55 INFO - 'LOGNAME': 'cltbld', 07:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:55 INFO - 'MOZ_NO_REMOTE': '1', 07:11:55 INFO - 'NO_EM_RESTART': '1', 07:11:55 INFO - 'PAGER': '/bin/cat', 07:11:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:55 INFO - 'PWD': '/builds/slave/test', 07:11:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:11:55 INFO - 'SHELL': '/bin/bash', 07:11:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8gDlSth6nx/Listeners', 07:11:55 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 07:11:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:11:55 INFO - 'USER': 'cltbld', 07:11:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:11:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:55 INFO - 'XPC_FLAGS': '0x0', 07:11:55 INFO - 'XPC_SERVICE_NAME': '0', 07:11:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:55 INFO - Downloading/unpacking jsonschema==2.5.1 07:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:11:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:11: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 07:11: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 07:11: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 07:11: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 07:11: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 07:11: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 07:11:58 INFO - Downloading functools32-3.2.3-2.tar.gz 07:11:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:11:58 INFO - warning: no files found matching '*.txt' 07:11:58 INFO - no previously-included directories found matching 'build' 07:11:58 INFO - no previously-included directories found matching 'dist' 07:11:58 INFO - no previously-included directories found matching '.git*' 07:11:58 INFO - Installing collected packages: jsonschema, functools32 07:11:59 INFO - Running setup.py install for functools32 07:11:59 INFO - warning: no files found matching '*.txt' 07:11:59 INFO - no previously-included directories found matching 'build' 07:11:59 INFO - no previously-included directories found matching 'dist' 07:11:59 INFO - no previously-included directories found matching '.git*' 07:11:59 INFO - Successfully installed jsonschema functools32 07:11:59 INFO - Cleaning up... 07:11:59 INFO - Return code: 0 07:11:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104605b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104608768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4c8d6d290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043e3d30>, '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 0x10430adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043d8be8>, '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.pn85YFwtDE/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.8gDlSth6nx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 07:11:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:11:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pn85YFwtDE/Render', 07:11:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:11:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:11:59 INFO - 'HOME': '/Users/cltbld', 07:11:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:11:59 INFO - 'LOGNAME': 'cltbld', 07:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:59 INFO - 'MOZ_NO_REMOTE': '1', 07:11:59 INFO - 'NO_EM_RESTART': '1', 07:11:59 INFO - 'PAGER': '/bin/cat', 07:11:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:59 INFO - 'PWD': '/builds/slave/test', 07:11:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:11:59 INFO - 'SHELL': '/bin/bash', 07:11:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8gDlSth6nx/Listeners', 07:11:59 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 07:11:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:11:59 INFO - 'USER': 'cltbld', 07:11:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:11:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:59 INFO - 'XPC_FLAGS': '0x0', 07:11:59 INFO - 'XPC_SERVICE_NAME': '0', 07:11:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:11:59 INFO - Cleaning up... 07:11:59 INFO - Return code: 0 07:11:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104605b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104608768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4c8d6d290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043e3d30>, '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 0x10430adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043d8be8>, '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.pn85YFwtDE/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.8gDlSth6nx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 07:11:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:11:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pn85YFwtDE/Render', 07:11:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:11:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:11:59 INFO - 'HOME': '/Users/cltbld', 07:11:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:11:59 INFO - 'LOGNAME': 'cltbld', 07:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:59 INFO - 'MOZ_NO_REMOTE': '1', 07:11:59 INFO - 'NO_EM_RESTART': '1', 07:11:59 INFO - 'PAGER': '/bin/cat', 07:11:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:59 INFO - 'PWD': '/builds/slave/test', 07:11:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:11:59 INFO - 'SHELL': '/bin/bash', 07:11:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8gDlSth6nx/Listeners', 07:11:59 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 07:11:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:11:59 INFO - 'USER': 'cltbld', 07:11:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:11:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:59 INFO - 'XPC_FLAGS': '0x0', 07:11:59 INFO - 'XPC_SERVICE_NAME': '0', 07:11:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:59 INFO - Downloading/unpacking blobuploader==1.2.4 07:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:02 INFO - Downloading blobuploader-1.2.4.tar.gz 07:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:12:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:12:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:03 INFO - Downloading docopt-0.6.1.tar.gz 07:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:12:03 INFO - Installing collected packages: blobuploader, requests, docopt 07:12:03 INFO - Running setup.py install for blobuploader 07:12:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:12:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:12:03 INFO - Running setup.py install for requests 07:12:04 INFO - Running setup.py install for docopt 07:12:04 INFO - Successfully installed blobuploader requests docopt 07:12:04 INFO - Cleaning up... 07:12:04 INFO - Return code: 0 07:12:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:04 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 0x104605b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104608768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4c8d6d290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043e3d30>, '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 0x10430adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043d8be8>, '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.pn85YFwtDE/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.8gDlSth6nx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 07:12:04 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 07:12:04 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 07:12:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pn85YFwtDE/Render', 07:12:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:12:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:12:04 INFO - 'HOME': '/Users/cltbld', 07:12:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:12:04 INFO - 'LOGNAME': 'cltbld', 07:12:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:04 INFO - 'MOZ_NO_REMOTE': '1', 07:12:04 INFO - 'NO_EM_RESTART': '1', 07:12:04 INFO - 'PAGER': '/bin/cat', 07:12:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:12:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:04 INFO - 'PWD': '/builds/slave/test', 07:12:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:12:04 INFO - 'SHELL': '/bin/bash', 07:12:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8gDlSth6nx/Listeners', 07:12:04 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 07:12:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:12:04 INFO - 'USER': 'cltbld', 07:12:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:12:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:12:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:04 INFO - 'XPC_FLAGS': '0x0', 07:12:04 INFO - 'XPC_SERVICE_NAME': '0', 07:12:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:12:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:12:04 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-JjUlXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:12:05 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-MZV4HB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:12:05 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-QHBlMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:12:05 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Js0NFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:12:05 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-G9UMwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:12:05 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ScMZkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:12:05 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-6RPEkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:12:05 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-BH0wO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:12:05 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-H1vJlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:12:05 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-5RQ0A5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:12:05 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-L3QPaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:12:06 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-LSGyi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:12:06 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-DcVbzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:12:06 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-mkck75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:06 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-rN4KQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:12:06 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-OzEEpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:12:06 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-l7hWcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:12:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:12:06 INFO - Running setup.py install for manifestparser 07:12:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:12:06 INFO - Running setup.py install for mozcrash 07:12:07 INFO - Running setup.py install for mozdebug 07:12:07 INFO - Running setup.py install for mozdevice 07:12:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:12:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:12:07 INFO - Running setup.py install for mozfile 07:12:07 INFO - Running setup.py install for mozhttpd 07:12:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:12:07 INFO - Running setup.py install for mozinfo 07:12:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:12:07 INFO - Running setup.py install for mozInstall 07:12:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:12:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:12:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:12:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:12:07 INFO - Running setup.py install for mozleak 07:12:08 INFO - Running setup.py install for mozlog 07:12:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:12:08 INFO - Running setup.py install for moznetwork 07:12:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:12:08 INFO - Running setup.py install for mozprocess 07:12:08 INFO - Running setup.py install for mozprofile 07:12:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:12:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:12:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:12:08 INFO - Running setup.py install for mozrunner 07:12:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:12:08 INFO - Running setup.py install for mozscreenshot 07:12:09 INFO - Running setup.py install for moztest 07:12:09 INFO - Running setup.py install for mozversion 07:12:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:12:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:12:09 INFO - Cleaning up... 07:12:09 INFO - Return code: 0 07:12:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:09 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 0x104605b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104608768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4c8d6d290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043e3d30>, '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 0x10430adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043d8be8>, '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.pn85YFwtDE/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.8gDlSth6nx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 07:12:09 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 07:12:09 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 07:12:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pn85YFwtDE/Render', 07:12:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:12:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:12:09 INFO - 'HOME': '/Users/cltbld', 07:12:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:12:09 INFO - 'LOGNAME': 'cltbld', 07:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:09 INFO - 'MOZ_NO_REMOTE': '1', 07:12:09 INFO - 'NO_EM_RESTART': '1', 07:12:09 INFO - 'PAGER': '/bin/cat', 07:12:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:09 INFO - 'PWD': '/builds/slave/test', 07:12:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:12:09 INFO - 'SHELL': '/bin/bash', 07:12:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8gDlSth6nx/Listeners', 07:12:09 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 07:12:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:12:09 INFO - 'USER': 'cltbld', 07:12:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:12:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:09 INFO - 'XPC_FLAGS': '0x0', 07:12:09 INFO - 'XPC_SERVICE_NAME': '0', 07:12:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:12:09 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-mND9Z8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:12:09 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)) 07:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:12:09 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-kER0A2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:12:09 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)) 07:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:12:09 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-jqz7Xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:12:09 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)) 07:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:12:09 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-KL3HDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:12:10 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)) 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:12:10 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-h0kcs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:12:10 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)) 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:12:10 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Pr3lVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:12:10 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)) 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:12:10 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-g1twwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:12:10 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)) 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:12:10 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-h_g5oZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:12:10 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)) 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:12:10 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-eZ74mm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:12:10 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)) 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:12:10 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-vGpHjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:12:10 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)) 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:12:10 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-NyJ3MT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:12:10 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)) 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:12:10 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Wjv25A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:12:10 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)) 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:12:10 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-vJvwIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:12:10 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-hIcFGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:12:11 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)) 07:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:11 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-tM5gZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:11 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)) 07:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:12:11 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-oPeCXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:12:11 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)) 07:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:12:11 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-x9OJF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:12:11 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)) 07:12:11 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)) 07:12:11 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)) 07:12:11 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)) 07:12:11 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)) 07:12:11 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)) 07:12:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:12:11 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 07:12:11 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 07:12:11 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 07:12:11 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 07:12:11 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 07:12:11 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 07:12:13 INFO - Downloading blessings-1.6.tar.gz 07:12:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:12:14 INFO - Installing collected packages: blessings 07:12:14 INFO - Running setup.py install for blessings 07:12:14 INFO - Successfully installed blessings 07:12:14 INFO - Cleaning up... 07:12:14 INFO - Return code: 0 07:12:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:12:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:12:14 INFO - Reading from file tmpfile_stdout 07:12:14 INFO - Current package versions: 07:12:14 INFO - blessings == 1.6 07:12:14 INFO - blobuploader == 1.2.4 07:12:14 INFO - docopt == 0.6.1 07:12:14 INFO - functools32 == 3.2.3-2 07:12:14 INFO - jsonschema == 2.5.1 07:12:14 INFO - manifestparser == 1.1 07:12:14 INFO - mozInstall == 1.12 07:12:14 INFO - mozcrash == 1.0 07:12:14 INFO - mozdebug == 0.1 07:12:14 INFO - mozdevice == 0.49 07:12:14 INFO - mozfile == 1.2 07:12:14 INFO - mozhttpd == 0.7 07:12:14 INFO - mozinfo == 0.9 07:12:14 INFO - mozleak == 0.1 07:12:14 INFO - mozlog == 3.4 07:12:14 INFO - moznetwork == 0.27 07:12:14 INFO - mozprocess == 0.24 07:12:14 INFO - mozprofile == 0.28 07:12:14 INFO - mozrunner == 6.13 07:12:14 INFO - mozscreenshot == 0.1 07:12:14 INFO - mozsystemmonitor == 0.3 07:12:14 INFO - moztest == 0.8 07:12:14 INFO - mozversion == 1.4 07:12:14 INFO - psutil == 3.1.1 07:12:14 INFO - requests == 1.2.3 07:12:14 INFO - wsgiref == 0.1.2 07:12:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12: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')]} 07:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12: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')]} 07:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:14 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 0x104605b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104608768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4c8d6d290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043e3d30>, '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 0x10430adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043d8be8>, '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.pn85YFwtDE/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.8gDlSth6nx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 07:12:14 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 07:12:14 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 07:12:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pn85YFwtDE/Render', 07:12:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:12:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:12:14 INFO - 'HOME': '/Users/cltbld', 07:12:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:12:14 INFO - 'LOGNAME': 'cltbld', 07:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:14 INFO - 'MOZ_NO_REMOTE': '1', 07:12:14 INFO - 'NO_EM_RESTART': '1', 07:12:14 INFO - 'PAGER': '/bin/cat', 07:12:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:14 INFO - 'PWD': '/builds/slave/test', 07:12:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:12:14 INFO - 'SHELL': '/bin/bash', 07:12:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8gDlSth6nx/Listeners', 07:12:14 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 07:12:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:12:14 INFO - 'USER': 'cltbld', 07:12:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:12:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:14 INFO - 'XPC_FLAGS': '0x0', 07:12:14 INFO - 'XPC_SERVICE_NAME': '0', 07:12:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:12:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12: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)) 07:12: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)) 07:12: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)) 07:12: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)) 07:12: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)) 07:12: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)) 07:12: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)) 07:12: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)) 07:12: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)) 07:12: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)) 07:12: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)) 07:12:14 INFO - Cleaning up... 07:12:14 INFO - Return code: 0 07:12:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:12: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')]} 07:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12: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')]} 07:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12: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 0x104605b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104608768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4c8d6d290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043e3d30>, '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 0x10430adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043d8be8>, '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.pn85YFwtDE/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.8gDlSth6nx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 07:12: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 07:12: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 07:12:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pn85YFwtDE/Render', 07:12:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:12:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:12:14 INFO - 'HOME': '/Users/cltbld', 07:12:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:12:14 INFO - 'LOGNAME': 'cltbld', 07:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:14 INFO - 'MOZ_NO_REMOTE': '1', 07:12:14 INFO - 'NO_EM_RESTART': '1', 07:12:14 INFO - 'PAGER': '/bin/cat', 07:12:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:14 INFO - 'PWD': '/builds/slave/test', 07:12:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:12:14 INFO - 'SHELL': '/bin/bash', 07:12:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8gDlSth6nx/Listeners', 07:12:14 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 07:12:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:12:14 INFO - 'USER': 'cltbld', 07:12:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:12:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:14 INFO - 'XPC_FLAGS': '0x0', 07:12:14 INFO - 'XPC_SERVICE_NAME': '0', 07:12:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:12:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:12:15 INFO - Cleaning up... 07:12:15 INFO - Return code: 0 07:12:15 INFO - Running post-action listener: _resource_record_post_action 07:12:15 INFO - Running post-action listener: _start_resource_monitoring 07:12:15 INFO - Starting resource monitoring. 07:12:15 INFO - [mozharness: 2017-02-27 15:12:15.168537Z] Finished create-virtualenv step (success) 07:12:15 INFO - [mozharness: 2017-02-27 15:12:15.169467Z] Running install step. 07:12:15 INFO - Running pre-action listener: _resource_record_pre_action 07:12:15 INFO - Running main action method: install 07:12:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:12:15 INFO - Reading from file tmpfile_stdout 07:12:15 INFO - Detecting whether we're running mozinstall >=1.0... 07:12:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:12:15 INFO - Reading from file tmpfile_stdout 07:12:15 INFO - Output received: 07:12:15 INFO - Usage: mozinstall [options] installer 07:12:15 INFO - Options: 07:12:15 INFO - -h, --help show this help message and exit 07:12:15 INFO - -d DEST, --destination=DEST 07:12:15 INFO - Directory to install application into. [default: 07:12:15 INFO - "/builds/slave/test"] 07:12:15 INFO - --app=APP Application being installed. [default: firefox] 07:12:15 INFO - mkdir: /builds/slave/test/build/application 07:12:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 07:12:35 INFO - Reading from file tmpfile_stdout 07:12:35 INFO - Output received: 07:12:35 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:12:35 INFO - Running post-action listener: _resource_record_post_action 07:12:35 INFO - [mozharness: 2017-02-27 15:12:35.353634Z] Finished install step (success) 07:12:35 INFO - [mozharness: 2017-02-27 15:12:35.353788Z] Running run-tests step. 07:12:35 INFO - Running pre-action listener: _resource_record_pre_action 07:12:35 INFO - Running main action method: run_tests 07:12:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:12:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:12:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:12:35 INFO - 2017-02-27 07:12:35.368 screenresolution[1900:15504] starting screenresolution argv=screenresolution get 07:12:35 INFO - 2017-02-27 07:12:35.371 screenresolution[1900:15504] Display 0: 1600x1200x32@60 07:12:35 INFO - 2017-02-27 07:12:35.376 screenresolution[1901:15507] starting screenresolution argv=screenresolution list 07:12:35 INFO - Available Modes on Display 0 07:12:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:12:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:12:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:12:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:12:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:12:35 INFO - Intel Iris: 07:12:35 INFO - Chipset Model: Intel Iris 07:12:35 INFO - Type: GPU 07:12:35 INFO - Bus: Built-In 07:12:35 INFO - VRAM (Dynamic, Max): 1536 MB 07:12:35 INFO - Vendor: Intel (0x8086) 07:12:35 INFO - Device ID: 0x0a2e 07:12:35 INFO - Revision ID: 0x0009 07:12:35 INFO - Displays: 07:12:35 INFO - Display: 07:12:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:12:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:12:35 INFO - Display Serial Number: 1600x1200 60 07:12:35 INFO - Main Display: Yes 07:12:35 INFO - Mirror: Off 07:12:35 INFO - Online: Yes 07:12:35 INFO - Rotation: Supported 07:12:35 INFO - Return code: 0 07:12:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:12:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:12:35 INFO - Python 2.7.3 07:12:35 INFO - Return code: 0 07:12:35 INFO - grabbing minidump binary from tooltool 07:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:35 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 0x1043e3d30>, '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 0x10430adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043d8be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:12:35 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 07:12:35 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 07:12:35 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 07:12:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:12:35 INFO - Return code: 0 07:12:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:12:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:12:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:12:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:12:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:12:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c80Cin4tTBGIv1pqjuYZUA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--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 07:12:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c80Cin4tTBGIv1pqjuYZUA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0029 --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 07:12:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pn85YFwtDE/Render', 07:12:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:12:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:12:35 INFO - 'HOME': '/Users/cltbld', 07:12:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:12:35 INFO - 'LOGNAME': 'cltbld', 07:12:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:12:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:35 INFO - 'MOZ_NO_REMOTE': '1', 07:12:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:12:35 INFO - 'NO_EM_RESTART': '1', 07:12:35 INFO - 'PAGER': '/bin/cat', 07:12:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:35 INFO - 'PWD': '/builds/slave/test', 07:12:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:12:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:12:35 INFO - 'SHELL': '/bin/bash', 07:12:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8gDlSth6nx/Listeners', 07:12:35 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 07:12:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:12:35 INFO - 'USER': 'cltbld', 07:12:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:12:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:35 INFO - 'XPC_FLAGS': '0x0', 07:12:35 INFO - 'XPC_SERVICE_NAME': '0', 07:12:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:12:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c80Cin4tTBGIv1pqjuYZUA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--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 07:12:35 INFO - mozversion application_buildid: 20170227054908 07:12:35 INFO - mozversion application_changeset: 75e0388a1c2ba34871f4e9b6bc3d4f372cc7fd70 07:12:35 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:12:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:12:35 INFO - mozversion application_name: Firefox 07:12:35 INFO - mozversion application_remotingname: firefox-dev 07:12:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:12:35 INFO - mozversion application_vendor: Mozilla 07:12:35 INFO - mozversion application_version: 53.0a2 07:12:35 INFO - mozversion platform_buildid: 20170227054908 07:12:35 INFO - mozversion platform_changeset: 75e0388a1c2ba34871f4e9b6bc3d4f372cc7fd70 07:12:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:12:35 INFO - mozversion platform_version: 53.0a2 07:12:35 INFO - using testdate: 1488208355 07:12:35 INFO - actual date: 1488208355 07:12:35 INFO - starting webserver on 'localhost:49376' 07:12:35 INFO - SUITE-START | Running 2 tests 07:12:35 INFO - TEST-START | dromaeo_css 07:12:35 INFO - operating with platform_type : mac_ 07:12:35 INFO - Initialising browser for dromaeo_css test... 07:12:35 INFO - TEST-INFO | started process 1911 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpc_qdiS/profile http://localhost:49376/getInfo.html) 07:12:38 INFO - PROCESS | 1911 | 2017-02-27 07:12:38.687 plugin-container[1913:15677] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4953, name = 'com.apple.tsm.portname' 07:12:38 INFO - PROCESS | 1911 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:12:38 INFO - PROCESS | 1911 | 2017-02-27 07:12:38.689 plugin-container[1913:15677] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c0b, name = 'com.apple.CFPasteboardClient' 07:12:38 INFO - PROCESS | 1911 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:12:38 INFO - PROCESS | 1911 | 2017-02-27 07:12:38.690 plugin-container[1913:15677] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:12:38 INFO - PROCESS | 1911 | __metrics Screen width/height:1600/1200 07:12:38 INFO - PROCESS | 1911 | colorDepth:24 07:12:38 INFO - PROCESS | 1911 | Browser inner width/height: 1024/689 07:12:38 INFO - PROCESS | 1911 | __metrics 07:12:38 ERROR - PROCESS | 1911 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 07:12:39 INFO - TEST-INFO | 1911: exit 0 07:12:39 INFO - Browser initialized. 07:12:39 INFO - Running cycle 1/1 for dromaeo_css test... 07:12:39 INFO - TEST-INFO | started process 1914 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpc_qdiS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:12:42 INFO - PROCESS | 1914 | 2017-02-27 07:12:42.033 plugin-container[1915:15803] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 07:12:42 INFO - PROCESS | 1914 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:12:42 INFO - PROCESS | 1914 | 2017-02-27 07:12:42.034 plugin-container[1915:15803] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0f, name = 'com.apple.CFPasteboardClient' 07:12:42 INFO - PROCESS | 1914 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:12:42 INFO - PROCESS | 1914 | 2017-02-27 07:12:42.034 plugin-container[1915:15803] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:12:51 INFO - PROCESS | 1914 | RSS: Main: 218554368 07:12:51 INFO - PROCESS | 1914 | 07:15:53 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49376/tests/dromaeo/cssquery-ext.html) 07:15:55 INFO - PROCESS | 1914 | RSS: Main: 235773952 07:15:55 INFO - PROCESS | 1914 | 07:17:39 INFO - PROCESS | 1914 | ************************* 07:17:39 INFO - PROCESS | 1914 | A coding exception was thrown and uncaught in a Task. 07:17:39 INFO - PROCESS | 1914 | 07:17:39 ERROR - PROCESS | 1914 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:17:39 INFO - PROCESS | 1914 | Full stack: 07:17:39 INFO - PROCESS | 1914 | ************************* 07:18:58 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-ext.html (next: http://localhost:49376/tests/dromaeo/cssquery-jquery.html) 07:18:58 INFO - PROCESS | 1914 | RSS: Main: 248905728 07:18:58 INFO - PROCESS | 1914 | 07:22:00 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49376/tests/dromaeo/cssquery-mootools.html) 07:22:01 INFO - PROCESS | 1914 | RSS: Main: 255488000 07:22:01 INFO - PROCESS | 1914 | 07:25:03 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49376/tests/dromaeo/cssquery-prototype.html) 07:25:03 INFO - PROCESS | 1914 | RSS: Main: 252006400 07:25:03 INFO - PROCESS | 1914 | 07:28:06 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49376/tests/dromaeo/cssquery-yui.html) 07:28:07 INFO - PROCESS | 1914 | RSS: Main: 261025792 07:28:07 INFO - PROCESS | 1914 | 07:31:09 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-yui.html (next: http://localhost:49376/tests/dromaeo/cssquery-dojo.html) 07:31:10 INFO - PROCESS | 1914 | RSS: Main: 262561792 07:31:10 INFO - PROCESS | 1914 | 07:31:10 INFO - PROCESS | 1914 | __start_tp_report 07:31:10 INFO - PROCESS | 1914 | _x_x_mozilla_page_load 07:31:10 INFO - PROCESS | 1914 | _x_x_mozilla_page_load_details 07:31:10 INFO - PROCESS | 1914 | |i|pagename|runs| 07:31:10 INFO - PROCESS | 1914 | |0;dojo.html;3011.3977204559087;3430.622631510535;3454.27460233351;3470.4273794823857;3498.9650103498975;5876.2948446186465;5890.734916928738;5929.88140237195;5955.9702201488935;5968.582199246054;5899.439553242446;5953.553483488734;5959.851003724909;5966.910496342558;6006.819795406145;5321.308229930104;5400.270963419947;5404.91892621611;5460.34475862897;5484.972575137119;5397.46025397461;5402.324709411324;5469.972650136764;5490.203920431535;5500.669959802404;5252.36971563411;5273.31446911899;5286.15421532553;5403.135498320269;5404.621676482648;4718.669693121448;5016.423111342206;5256.579473642099;5303.124984377573;5304.787808487656;5247.344081989751;5251.6061295402615;5272.92090618641;5294.470552944713;5348.91976620351;4704.6001089907395;5328.934213157345;5638.008869002408;5719.542436605062;5774.16274640179;6248.812535623939;6254.655993920333;6277.4664153547;6293.527985401068;6300.0234963580715;6337.904931426032;6354.4281014708895;6363.490920726331;6379.425851673372;6385.106085148083;5757.913631295534;6074.331823499411;6075.422834830684;6086.6348019119;6092.208012958331;6239.594426362272;6255;6387.936120638734;6397.040443933447;6410;4985.825496107619;5634.85912852182;5846.619969702041;6292.402221788922;6300.180976473029;6291.370862913764;6347.777827776005;6348.936510634927;6351.460125889351;6363.90454143179;6165.691715414211;6169.96915015422;6176.073588961602;6220.564560480813;6305;6268.561200715906;6294.779682711083;6299.0866324382705;6314.747410103544;6314.8421289467215;5129.692218466829;5131.923021154686;5133.589312854962;5141.151709967889;5149.304843846033;4468.486124095705;4519.7740112994215;4556.772161391984;4596.310553416947;4648.465426475931;5947.910781338283;5958.880822383528;6011.909821352683;6068.393160683896;6072.878542429126;6213.099100630383;6266.530010249158;6309.179806625201;6312.715927783261;6317.4946004319545;5986.820395388146;6049.122877182784;6065.575409721366;6082.939170608237;6143.201383820075;5617.354004289559;5627.746751396197;5630.634008789416;5631.774729010794;5634.7182640867795;5483.479069488392;6566;6588.769393071219;6614.470842332602;6650.20197576294;6171.47542458896;6173.259208894961;6190.226221722285;6208.441240288395;6262.248530176408;6355.078513615592;6390.360963903572;6397.424231819158;6406.391392817675;6421.743130274924;6224.906626400517;6236.282827474898;6242;6243;6244;5795.420457954171;6184.81445556634;6227.595206311576;6265.091561723616;6287.497000240061;6114.449699527064;6194.38056194377;6241.594296370721;6255.40573645503;6259.311475737574;6228.128062071404;6229.2524897012645;6240.438360547572;6264.906026409516;6295.055741638791;5032.698038117578;6052.515798736003;6080.908786368296;6124.112003759519;6180.165677633462;6147.708981114016;6227.0970709246;6236.688165591611;6249.6562689052535;6276.843078923063;6173.907391389043;6185.443310102112;6196.783112591038;6197.318294987638;6218.06728990655 07:31:10 INFO - PROCESS | 1914 | |1;ext.html;448.8586095379955;475.16845520339405;504.87378155461136;552.6822077305548;555.2199160179944;24144.637830432537;39816.20367592647;39937;39979.20041599166;40003;41788.791056044756;42523.14953700932;42571;42583.935401614974;42704.78647606765;8455.74632761018;8687.30501559877;9115.908840911588;9378.0621937806;11236.438178091104;11231.831522527169;11463.541458341657;11512.079033677328;11537.596184133557;11548.133889958244;11410.20128590999;11524.078073754079;11551;11553.133514986368;11565.190436669394;11290.322580645188;11438.599649012245;11465.885341146564;11498.482568284448;11547.191696581243;11456.713582160513;11502.194846360759;11552.826707599394;11574.710632234177;11577.247478913843;39305.803470982464;39681;40282.99292517681;40483.19033619341;40650.18699625991;3933;3970.622790834866;4000.19996000801;4005.8998525036814;4145.129522800215;29344.559831602543;29951.850240748874;30546.389072218655;31334;31446.842765786023;3146.9842650786827;3173.222560472676;3231.2245061185145;3236.01301603011;3317.883874064396;492557;493063;496071;499486;500801;52787;61906.45233869099;63200;63333;63465;63409;63445.36554634487;63900;63992;64072.35927640757;16145.919270403572;16628.916855415886;16694.749578756328;16700.914440561326;16759.916200419164;11650.70873228176;11975.940120299343;12811.423485943154;12884.291363975071;13237.93381033108;16399.262033208535;16691.91654041722;16694;16723.247453864606;16726.498205053867;6858.5199036067;7123.9314102883945;7533.472656914073;7552.320291173821;7660.004199454147;687.9518433709592;819.0008190008181;819.1685439279137;871.8648609465542;899.6806133822399;28341.71658283432;29677.554836677467;30185.69814301829;30187.849060754557;30872;977.7848873247874;982.9973427104313;1033.9247182929819;1044.7597052677927;1048.8007278617038;13218.81030707241;13915.30423478822;14448.349824257934;14570.4900328488;14677.119372837664;557468;635196;638227;639693;641807;42611.36082958758;51293.7435312821;51359;51602.48397516052;51668.74165629223;1391.5338361648758;1412.2938530734632;1435.382785402287;1437.3747419872388;1439.9496017639333;26377;27246.863765681046;27436.862815685792;27590;27744.861275693493;45560.316595250435;45815.54184458246;45994.99999999866;45999.54000459953;46004.30993535033;540631;541114;542376;543518;544856;24613.13854015101;25038;25671.358216044748;25711.871440642677;26550.86724566365;42734;43028.56971430246;43682.78158609186;44076.779616103;44096.33855492106;35081;35629.46555801717;35656.82171589125;35787;36868.446973294886;35232.11919702028;35632;36391;36443.45334819927;36756.44865327076;27489;33706.157346066546;34503.827480862434;35314;35482.93551193468;29767.25581860384;31981.6801831988;32186.03441896747;32258.35483290368;32479;23877.64183537283;23901.163459278843;24243.87878060669;24502.387440314134;24709.88805503721 07:31:10 INFO - PROCESS | 1914 | |2;jquery.html;371.5058971567815;397.7076848516338;401.57633696450245;404.54690746364076;428.96191217254244;16709.83290167098;19730.309439169614;20597.691034634492;21184;21220;21217.045232964516;21460.678089828663;21630.89184554075;21830.017649205784;22098.779012209874;5653.717314134287;5881.67650779207;5929.436703513181;5949.524038076965;5963.61236519627;5680.375158732536;5822;5857.941420585804;5889.263842019747;5928.525717942554;5833.7083145842535;5842.795502157425;5846.736896839631;5848.561357898154;5854.619449735754;4845.53967373099;5253.921191182097;5635.182898479718;5851.79518716845;5853.5902486825935;4101.835926562934;5121.871953201163;5179.896402071975;5229.947700522984;5231.163013917793;25282.241532754048;25307.367315817068;25793.87103064473;26300.947962081493;26583.202503924913;2336.520551347324;2721.482918245527;2748.491529067129;2748.958765618517;2793.385455199873;12648.810267845989;14985;15686.9215653921;15996.680066398607;16031.758681835394;1670.5322509697305;1730.6241537977212;1805.8284462975996;1814.872958892878;1832.221305944968;116315.41842290819;116559;116670;117016.41491792572;117520;9718.319717619699;11683.824742628698;11793.646190614296;11838.763224735458;12027.518899243933;13099.476020959055;13847.584572462642;14945.775813362809;15179.316930738143;15181.240937953058;8526.23263906239;8751.124887511198;8970;9026.232770214605;9131.086891310815;8715.738527844174;8846.823063538694;8874.467531948103;9029.41308814925;9048.954755226181;6046.788362407295;6193.597416167935;7523.586202758791;7614.314711675976;7628.504147230412;1979.2775636892432;2029.2086086426305;2034.5829105033433;2035.297822251321;2039.8780670631093;383.9404892241707;424.07974694911496;1013.6502906497246;1032.6437379104198;1064.80301144287;8748.69379571712;8870.334724895658;8884.822303554021;8994.730158095268;9103.271738260923;441.66212847171295;441.9094085712421;443.98890027748917;446.13449907179967;459.21245064714174;4530.161920044802;4544.341070544752;4569.109023740339;4579.107074120515;4668.439787225555;708800;737878;750804;772539.1373043099;777521;119131;123834;148917;153324;154885.2255738714;446.95530446955695;452.2515237282303;456.45453682848677;457.13829431522487;457.80543269110495;8278.586070696321;8375.371847111614;8448.788780280542;8684.869726954226;8796.60415281301;56266.71866640641;56977.71511142418;57634;58086.7095664519;58340.83318333525;83840.58079709562;85117;85688;86125;88055;6015.368386319374;6299.338569450142;7519.812004699927;7524.360429363565;7783.649735762017;9527.333086683866;12031.4585843639;12290.75418491643;12478.126531142732;12661.48062232538;11132.554697811996;11139.220254582102;11143.944280278547;11642.476088575864;11703.824442633537;9377.578008989749;10735.892641073802;11239.494222759831;11409.429528523706;11499.195056345976;11202.15983801202;11230.382328971658;11326.603568875049;11492.195546311677;11791.705207369885;7238;7505.849883002418;7607.847843043219;7812.921870781447;8639.913600864162;9827.55775990068;11069;11133.721656958642;11373.260738052;11433.714157146138 07:31:10 INFO - PROCESS | 1914 | |3;mootools.html;1243.8445194350707;1435.6052085676438;1449.253634378296;1453.9636509087272;1468.5520916120581;7165.964170179148;7553;7806.258405451473;8008.759737207879;8598.74203773887;6990.510664253505;8109.148539403352;8392.118827523114;8478.703245386412;8489.320854331654;2322.5587138443643;2365.325882123595;2375.6555299481565;2387.1525608409024;2390.6414037894283;2095.277129390358;2100.348891843526;2172.0877231562704;2257.679257634286;2394.4013996500876;2254.49273913369;2275.1354485295565;2350.5063936573342;2352.1532248390567;2356.528694261146;2337.4273303040777;2340.648902664597;2347.859128452298;2368.301351101412;2369.845960012594;2283.4748007958265;2296.311106667993;2327.290176496168;2379.131616959797;2383.976160238393;8429.4942303462;8516.148385161496;8569.185927336894;8573.442726222838;8576.313894888457;5110.5400513953555;5279.102552566073;5279.445658205871;5284.365876094855;5286.04851126797;3355.3828014149003;3566.892993210208;3601.9099522511883;3651.4157734762575;3663.505426767379;1070.8019016481976;1200.789861774186;1231.150506150762;1268.1123213750411;1289.013904363163;10754.247202695815;10903.345799252149;10912.563497460093;10952.945235273852;10960.835587466194;3982.4424580558743;4636.165490211794;4719.858404247878;4724.740139292372;4796.784144713426;9516.95241523788;9662.613495460102;9667.661631842851;9710.660126895666;9737.367071140496;5233.869153271199;5301.5493683037375;5309.522143007148;5323.467653234646;5324.094903866352;4721.905561888743;4753.691010084333;4827.541383568555;4853.684510506806;4913.287573301923;3848.634379733921;3972.880813575597;3986;4014.237294913957;4081.7142800003717;1177.4112943528237;1237.5173682263924;1275.5599318235195;1299.636101891472;1303.0748168800258;859.621766422772;881.5151666583354;883.1918794303269;899.1413200393608;902.6073657958809;5489.34127904654;5500.119980803132;5555.74995625981;5574.247476590608;5680.062789639664;962.153305091515;982.8771403574553;983.842585186381;987.0474991633108;1006.5068116622948;3620.71034317254;3686.391745362039;3705.7591256568235;3716.6283371662616;3832.0419895026243;9812.65655702047;10146.340487868265;10150.847737283946;10180.592776289013;10189.337693049929;9990.950045249727;10059.346142500714;10101.5454304555;10115.443650599287;10131.341462804894;6490.513211509061;7843.098043725045;7879.763607091796;7899.802504937307;7918.841623167505;4523.32150177476;5212.843614691414;5269.604779641619;5431.212474191141;5472.91790623149;7767.650455729618;9005.054469280893;9319.440833550008;9364.859527107235;9389.154976052188;7810.609469526615;9034.819303614022;9189.908100919172;9336.439813611205;9513.762155946157;6715.127033485615;6745.12313399255;7101.82245443868;7291.708331666674;7302.634868256672;6590.868182636416;7803.492772969739;7841.137474877873;7881.330086942674;7900.644470998934;4959.801607935642;7136.643167841691;7350.926490735238;7384.778456646309;7477.513961592479;6250.687465626791;7142;7145.321194486515;7291.270872912666;7520.210377910459;5419.891602167856;5767.826965191051;6264.2796078451565;6313.936860631518;6427.6786160690845;4821.276808478616;4877.244027175793;4881.365422495053;4972.5027497249985;5122.436531981404;4820.156472617208;4918.581920536794;4955.20716685343;4994.076095922266;5014.924776128434 07:31:10 INFO - PROCESS | 1914 | |4;prototype.html;303.8511129546522;359.5667220998696;362.94374371972356;369.39603747872223;371.9628037196281;4954;5272.971770504753;5428.864278393042;5602.5237854782345;5620.494155526002;4351.891202719934;4365.738055716659;5153.943441594473;5419.8374048778505;5469.15228139639;3661.505696730947;3734.972882457319;4039.212353591051;4185.162967406515;4245.469316335458;4262.211490874182;4270.732889339658;4277.230098582254;4298.656107511391;4307.267764480031;3719.5865571083086;4278.930267433142;4302.548232435596;4312.849050283241;4347.043650396923;3900.684418244498;4076.1290258141535;4310.633596144332;4329.264025115738;4329.67527435442;3362.6132994705677;3754.718396120302;3756.3050835595504;3761.924761504782;3774.5093137892172;5304.283921670563;5362.8123015694655;5381.946180538183;5390.353157621072;5407.351117865842;4395.604395604411;4943.283223932545;4968.6025117990475;5001.699898006132;5009.5491405773655;5118.820841270538;5558.499735023827;5796.536277097822;5860.912086318709;5861.355250922437;3407.437772767515;3631.400818864884;4003.3594624860175;4163.23062698352;4179.561146079648;4859.538343857328;5709.62887412321;5721.570882183812;6020.916235077684;6160.1991741073825;3290.407726609233;3383.796972181677;3675;4185.581441855851;4297.484301883794;3808.5146792750847;4272.727272727273;4310.224159651293;4320.25029862906;4326.6538676905775;4341.609255166987;4846.733429661403;4989.825356112518;4990;4996.425411077773;5272.6836389816735;5785.479306862402;5927.2590926134235;5933.762649493972;5962.403759624003;1174.653477224221;1225.7681030564227;1243.5150291386367;1395.323268214915;1399.9650008749863;902.6389444222232;917.8347897378536;982.8820541535061;986.8798913233531;1005.587709039305;4641.721496710208;4931.112399768004;5200.763671621164;5202.271681964528;5209.76994263559;5194.623494728381;5340.198970154508;5445.9108178363695;5500.202470641734;5839.416058394127;4311.20242755085;4379.934300985487;4413.3159360299205;4834.685745426536;4902.910451097575;2730.0581299451655;2786.414852880918;2849.430113977213;3015.8492075396143;3055.786094973375;5364.946350536445;5701.7631437072205;5754.482096611325;5759.264349433985;5969.224000879858;5492.286002819608;5870.442307980735;6221.657808820468;6232.501399887998;6235.844103897348;5535.612507124462;5811.389804070596;6251.9687401563615;6301.842453938505;6304.275008374096;5671.943280567141;5880.26496687914;5964.761409543569;6055.091736239599;6125.601835880653;4666.859994200044;5952.107183922446;5964.747403045409;5966.373530779206;5983.252093488314;5993.61041532299;6139.72371243304;6217.3628427368685;6266.997280435108;6306.180196574416;3772.43413487979;3938.3501722215515;3956.208758248304;3958.2083583282883;3964.156667149674;5010.415469845197;5328.866778330573;5570.910908409346;5928.762849486145;6083.422074902877;4635.559621835921;5197.4282828889545;5499.450054994469;5823.272090988627;5917.822465326047;5129.256257842518;5845.690952073992;5870.033538764562;5871.442212989759;5872.677002764889;4527.818887244473;4886.144924638103;5312.309399778004;5710.685912274865;5801.883962320814;4952.851414457572;5158.3294171758935;5431.701256430934;5848.152017957457;5869.354371019099;5751.367349591458;5764.250647415809;5772.249607550992;5773.249477568057;5841.707914604338 07:31:10 INFO - PROCESS | 1914 | |5;yui.html;702.84888748919;708.3730898155131;774.9460733402572;822.9920931134048;826.8702959299053;14797.778033329496;15519.456819011337;15596.532104036869;15688.980216285934;15707.214639268033;13814.930925345385;14509.274536273171;14582.489612863552;14601.050931689433;14616.926915365408;841.4236248169992;853.1212850763724;855.2815634866711;856.1267507142711;858.1675774498726;667.5093806052547;685.7222824755956;831.4429332347341;849.0405841399211;852.8336974290016;876.9210771030606;901.369041670833;902.4179404284233;906.5240748607001;909.708893154191;894.3515950935584;897.4032268541412;899.3479727197795;901.121406628532;902.8149229407989;665.0722242471774;670.4602794750224;671.8286836856619;672.1228796420669;672.3377473188905;12372.690682732913;15329.156896370696;15544.689106217813;15587.376504939788;15712.764308535381;14485.42058317666;14873.107613543221;14920.701585968329;14952.40190392383;15048.548543543711;11669.241499302603;11721.70695732605;11723.472443740053;11835.881641183563;11933.761324773455;3619.6199399063244;3723.925521489555;3764.3036038333;3868.477755502999;3874.2638898609175;114345;115804.42097789541;116955;120170.39914800458;120295;11030.613928512463;11045.447727613588;11094.445277736242;11412.543498259976;11422.885771142182;23465.413364665677;23559.88220058923;23719.525609487715;23774.88112559426;23997.040118395067;7497.700091996259;7502;7511.774646760606;7550.169481357156;7736.303732664087;4172.874813755592;4209.158168366339;4276.807543660543;4425.446819147606;4468.664850136188;3434.587849458081;3446.138465383654;3503.9474407883904;3513;3533;510.67572091722025;671.6540981394586;672.1329484964439;683.1070416784912;711.121764620693;654.3423859021748;677.4648028057877;690.9930900690929;693.5873155472486;725.7060890339421;9637.871938800967;10175.135113515285;10225.437600931871;10363.32638378503;10400.739981500372;670.2191946382508;687.88993760998;696.0916004613927;712.6365553567717;713.2831504338106;3739.869104581381;4738.597219236403;4922.064807686528;4943.456219815817;4954.281629163823;104660.47669761603;108239.45880270549;108797.45601271943;109663;112235;69769;88652.5567372172;94471;95221;98761.50619246857;57996.2601121967;81388.52363119967;82064;84197.15802842016;85878;7693.384529237759;9638;9674.177694896012;9734.123928846439;9748.853767193355;54296.91406171933;54610.726946365015;54767.45232547623;56076;56111.71944140253;69568.6521567389;71181.6440917792;72673;75690;77956.61021694855;11415.429228538706;11597.304161750322;11598.478068487108;11841.171118022;11903.758951358914;11603.6518904433;12855.035872309427;12919.935400322938;13032.54386096482;13033.491588655346;11822.2722720228;11840.526378944745;12004.519819207484;12141.332226727614;12431.93784031074;11691.181617286707;11798.764024719629;12029.45867435985;12127.75744485123;12485.0636202287;11448.929233269619;11603.245789024024;11908.642740717793;11929.582464613697;12064.819027714766;9696.272779541703;9770.951145244228;9817.77649505879;10089.89910100919;10438.164946804389;9226.677066302647;9997.850032249667;10002.749931251778;10027.949860250652;10067.244956628136 07:31:10 INFO - PROCESS | 1914 | __end_tp_report 07:31:10 INFO - PROCESS | 1914 | __start_cc_report 07:31:10 INFO - PROCESS | 1914 | _x_x_mozilla_cycle_collect,390 07:31:10 INFO - PROCESS | 1914 | __end_cc_report 07:31:10 INFO - PROCESS | 1914 | __startTimestamp1488209470111__endTimestamp 07:31:10 INFO - PROCESS | 1914 | 07:31:10 INFO - PROCESS | 1914 | ------- Summary: start ------- 07:31:10 INFO - PROCESS | 1914 | Number of tests: 6 07:31:10 INFO - PROCESS | 1914 | 07:31:10 INFO - PROCESS | 1914 | [#0] dojo.html Cycles:165 Average:5841.37 Median:6114.45 stddev:654.01 (10.7%) stddev-sans-first:617.19 07:31:10 INFO - PROCESS | 1914 | Values: 3011.4 3430.6 3454.3 3470.4 3499.0 5876.3 5890.7 5929.9 5956.0 5968.6 5899.4 5953.6 5959.9 5966.9 6006.8 5321.3 5400.3 5404.9 5460.3 5485.0 5397.5 5402.3 5470.0 5490.2 5500.7 5252.4 5273.3 5286.2 5403.1 5404.6 4718.7 5016.4 5256.6 5303.1 5304.8 5247.3 5251.6 5272.9 5294.5 5348.9 4704.6 5328.9 5638.0 5719.5 5774.2 6248.8 6254.7 6277.5 6293.5 6300.0 6337.9 6354.4 6363.5 6379.4 6385.1 5757.9 6074.3 6075.4 6086.6 6092.2 6239.6 6255.0 6387.9 6397.0 6410.0 4985.8 5634.9 5846.6 6292.4 6300.2 6291.4 6347.8 6348.9 6351.5 6363.9 6165.7 6170.0 6176.1 6220.6 6305.0 6268.6 6294.8 6299.1 6314.7 6314.8 5129.7 5131.9 5133.6 5141.2 5149.3 4468.5 4519.8 4556.8 4596.3 4648.5 5947.9 5958.9 6011.9 6068.4 6072.9 6213.1 6266.5 6309.2 6312.7 6317.5 5986.8 6049.1 6065.6 6082.9 6143.2 5617.4 5627.7 5630.6 5631.8 5634.7 5483.5 6566.0 6588.8 6614.5 6650.2 6171.5 6173.3 6190.2 6208.4 6262.2 6355.1 6390.4 6397.4 6406.4 6421.7 6224.9 6236.3 6242.0 6243.0 6244.0 5795.4 6184.8 6227.6 6265.1 6287.5 6114.4 6194.4 6241.6 6255.4 6259.3 6228.1 6229.3 6240.4 6264.9 6295.1 5032.7 6052.5 6080.9 6124.1 6180.2 6147.7 6227.1 6236.7 6249.7 6276.8 6173.9 6185.4 6196.8 6197.3 6218.1 07:31:10 INFO - PROCESS | 1914 | 07:31:10 INFO - PROCESS | 1914 | [#1] ext.html Cycles:180 Average:68122.59 Median:35398.47 stddev:148682.51 (420.0%) stddev-sans-first:149012.79 07:31:10 INFO - PROCESS | 1914 | Values: 448.9 475.2 504.9 552.7 555.2 24144.6 39816.2 39937.0 39979.2 40003.0 41788.8 42523.1 42571.0 42583.9 42704.8 8455.7 8687.3 9115.9 9378.1 11236.4 11231.8 11463.5 11512.1 11537.6 11548.1 11410.2 11524.1 11551.0 11553.1 11565.2 11290.3 11438.6 11465.9 11498.5 11547.2 11456.7 11502.2 11552.8 11574.7 11577.2 39305.8 39681.0 40283.0 40483.2 40650.2 3933.0 3970.6 4000.2 4005.9 4145.1 29344.6 29951.9 30546.4 31334.0 31446.8 3147.0 3173.2 3231.2 3236.0 3317.9 492557.0 493063.0 496071.0 499486.0 500801.0 52787.0 61906.5 63200.0 63333.0 63465.0 63409.0 63445.4 63900.0 63992.0 64072.4 16145.9 16628.9 16694.7 16700.9 16759.9 11650.7 11975.9 12811.4 12884.3 13237.9 16399.3 16691.9 16694.0 16723.2 16726.5 6858.5 7123.9 7533.5 7552.3 7660.0 688.0 819.0 819.2 871.9 899.7 28341.7 29677.6 30185.7 30187.8 30872.0 977.8 983.0 1033.9 1044.8 1048.8 13218.8 13915.3 14448.3 14570.5 14677.1 557468.0 635196.0 638227.0 639693.0 641807.0 42611.4 51293.7 51359.0 51602.5 51668.7 1391.5 1412.3 1435.4 1437.4 1439.9 26377.0 27246.9 27436.9 27590.0 27744.9 45560.3 45815.5 45995.0 45999.5 46004.3 540631.0 541114.0 542376.0 543518.0 544856.0 24613.1 25038.0 25671.4 25711.9 26550.9 42734.0 43028.6 43682.8 44076.8 44096.3 35081.0 35629.5 35656.8 35787.0 36868.4 35232.1 35632.0 36391.0 36443.5 36756.4 27489.0 33706.2 34503.8 35314.0 35482.9 29767.3 31981.7 32186.0 32258.4 32479.0 23877.6 23901.2 24243.9 24502.4 24709.9 07:31:10 INFO - PROCESS | 1914 | 07:31:10 INFO - PROCESS | 1914 | [#2] jquery.html Cycles:180 Average:39234.09 Median:446.54 stddev:124456.83 (27871.1%) stddev-sans-first:124771.76 07:31:10 INFO - PROCESS | 1914 | Values: 371.5 397.7 401.6 404.5 429.0 16709.8 19730.3 20597.7 21184.0 21220.0 21217.0 21460.7 21630.9 21830.0 22098.8 5653.7 5881.7 5929.4 5949.5 5963.6 5680.4 5822.0 5857.9 5889.3 5928.5 5833.7 5842.8 5846.7 5848.6 5854.6 4845.5 5253.9 5635.2 5851.8 5853.6 4101.8 5121.9 5179.9 5229.9 5231.2 25282.2 25307.4 25793.9 26300.9 26583.2 2336.5 2721.5 2748.5 2749.0 2793.4 12648.8 14985.0 15686.9 15996.7 16031.8 1670.5 1730.6 1805.8 1814.9 1832.2 116315.4 116559.0 116670.0 117016.4 117520.0 9718.3 11683.8 11793.6 11838.8 12027.5 13099.5 13847.6 14945.8 15179.3 15181.2 8526.2 8751.1 8970.0 9026.2 9131.1 8715.7 8846.8 8874.5 9029.4 9049.0 6046.8 6193.6 7523.6 7614.3 7628.5 1979.3 2029.2 2034.6 2035.3 2039.9 383.9 424.1 1013.7 1032.6 1064.8 8748.7 8870.3 8884.8 8994.7 9103.3 441.7 441.9 444.0 446.1 459.2 4530.2 4544.3 4569.1 4579.1 4668.4 708800.0 737878.0 750804.0 772539.1 777521.0 119131.0 123834.0 148917.0 153324.0 154885.2 447.0 452.3 456.5 457.1 457.8 8278.6 8375.4 8448.8 8684.9 8796.6 56266.7 56977.7 57634.0 58086.7 58340.8 83840.6 85117.0 85688.0 86125.0 88055.0 6015.4 6299.3 7519.8 7524.4 7783.6 9527.3 12031.5 12290.8 12478.1 12661.5 11132.6 11139.2 11143.9 11642.5 11703.8 9377.6 10735.9 11239.5 11409.4 11499.2 11202.2 11230.4 11326.6 11492.2 11791.7 7238.0 7505.8 7607.8 7812.9 8639.9 9827.6 11069.0 11133.7 11373.3 11433.7 07:31:10 INFO - PROCESS | 1914 | 07:31:10 INFO - PROCESS | 1914 | [#3] mootools.html Cycles:180 Average:5402.20 Median:5116.49 stddev:2942.11 (57.5%) stddev-sans-first:2933.76 07:31:10 INFO - PROCESS | 1914 | Values: 1243.8 1435.6 1449.3 1454.0 1468.6 7166.0 7553.0 7806.3 8008.8 8598.7 6990.5 8109.1 8392.1 8478.7 8489.3 2322.6 2365.3 2375.7 2387.2 2390.6 2095.3 2100.3 2172.1 2257.7 2394.4 2254.5 2275.1 2350.5 2352.2 2356.5 2337.4 2340.6 2347.9 2368.3 2369.8 2283.5 2296.3 2327.3 2379.1 2384.0 8429.5 8516.1 8569.2 8573.4 8576.3 5110.5 5279.1 5279.4 5284.4 5286.0 3355.4 3566.9 3601.9 3651.4 3663.5 1070.8 1200.8 1231.2 1268.1 1289.0 10754.2 10903.3 10912.6 10952.9 10960.8 3982.4 4636.2 4719.9 4724.7 4796.8 9517.0 9662.6 9667.7 9710.7 9737.4 5233.9 5301.5 5309.5 5323.5 5324.1 4721.9 4753.7 4827.5 4853.7 4913.3 3848.6 3972.9 3986.0 4014.2 4081.7 1177.4 1237.5 1275.6 1299.6 1303.1 859.6 881.5 883.2 899.1 902.6 5489.3 5500.1 5555.7 5574.2 5680.1 962.2 982.9 983.8 987.0 1006.5 3620.7 3686.4 3705.8 3716.6 3832.0 9812.7 10146.3 10150.8 10180.6 10189.3 9991.0 10059.3 10101.5 10115.4 10131.3 6490.5 7843.1 7879.8 7899.8 7918.8 4523.3 5212.8 5269.6 5431.2 5472.9 7767.7 9005.1 9319.4 9364.9 9389.2 7810.6 9034.8 9189.9 9336.4 9513.8 6715.1 6745.1 7101.8 7291.7 7302.6 6590.9 7803.5 7841.1 7881.3 7900.6 4959.8 7136.6 7350.9 7384.8 7477.5 6250.7 7142.0 7145.3 7291.3 7520.2 5419.9 5767.8 6264.3 6313.9 6427.7 4821.3 4877.2 4881.4 4972.5 5122.4 4820.2 4918.6 4955.2 4994.1 5014.9 07:31:10 INFO - PROCESS | 1914 | 07:31:10 INFO - PROCESS | 1914 | [#4] prototype.html Cycles:180 Average:4665.01 Median:5156.14 stddev:1434.14 (27.8%) stddev-sans-first:1400.31 07:31:10 INFO - PROCESS | 1914 | Values: 303.9 359.6 362.9 369.4 372.0 4954.0 5273.0 5428.9 5602.5 5620.5 4351.9 4365.7 5153.9 5419.8 5469.2 3661.5 3735.0 4039.2 4185.2 4245.5 4262.2 4270.7 4277.2 4298.7 4307.3 3719.6 4278.9 4302.5 4312.8 4347.0 3900.7 4076.1 4310.6 4329.3 4329.7 3362.6 3754.7 3756.3 3761.9 3774.5 5304.3 5362.8 5381.9 5390.4 5407.4 4395.6 4943.3 4968.6 5001.7 5009.5 5118.8 5558.5 5796.5 5860.9 5861.4 3407.4 3631.4 4003.4 4163.2 4179.6 4859.5 5709.6 5721.6 6020.9 6160.2 3290.4 3383.8 3675.0 4185.6 4297.5 3808.5 4272.7 4310.2 4320.3 4326.7 4341.6 4846.7 4989.8 4990.0 4996.4 5272.7 5785.5 5927.3 5933.8 5962.4 1174.7 1225.8 1243.5 1395.3 1400.0 902.6 917.8 982.9 986.9 1005.6 4641.7 4931.1 5200.8 5202.3 5209.8 5194.6 5340.2 5445.9 5500.2 5839.4 4311.2 4379.9 4413.3 4834.7 4902.9 2730.1 2786.4 2849.4 3015.8 3055.8 5364.9 5701.8 5754.5 5759.3 5969.2 5492.3 5870.4 6221.7 6232.5 6235.8 5535.6 5811.4 6252.0 6301.8 6304.3 5671.9 5880.3 5964.8 6055.1 6125.6 4666.9 5952.1 5964.7 5966.4 5983.3 5993.6 6139.7 6217.4 6267.0 6306.2 3772.4 3938.4 3956.2 3958.2 3964.2 5010.4 5328.9 5570.9 5928.8 6083.4 4635.6 5197.4 5499.5 5823.3 5917.8 5129.3 5845.7 5870.0 5871.4 5872.7 4527.8 4886.1 5312.3 5710.7 5801.9 4952.9 5158.3 5431.7 5848.2 5869.4 5751.4 5764.3 5772.2 5773.2 5841.7 07:31:10 INFO - PROCESS | 1914 | 07:31:10 INFO - PROCESS | 1914 | [#5] yui.html Cycles:180 Average:21084.18 Median:4191.02 stddev:31434.03 (750.0%) stddev-sans-first:31484.96 07:31:10 INFO - PROCESS | 1914 | Values: 702.8 708.4 774.9 823.0 826.9 14797.8 15519.5 15596.5 15689.0 15707.2 13814.9 14509.3 14582.5 14601.1 14616.9 841.4 853.1 855.3 856.1 858.2 667.5 685.7 831.4 849.0 852.8 876.9 901.4 902.4 906.5 909.7 894.4 897.4 899.3 901.1 902.8 665.1 670.5 671.8 672.1 672.3 12372.7 15329.2 15544.7 15587.4 15712.8 14485.4 14873.1 14920.7 14952.4 15048.5 11669.2 11721.7 11723.5 11835.9 11933.8 3619.6 3723.9 3764.3 3868.5 3874.3 114345.0 115804.4 116955.0 120170.4 120295.0 11030.6 11045.4 11094.4 11412.5 11422.9 23465.4 23559.9 23719.5 23774.9 23997.0 7497.7 7502.0 7511.8 7550.2 7736.3 4172.9 4209.2 4276.8 4425.4 4468.7 3434.6 3446.1 3503.9 3513.0 3533.0 510.7 671.7 672.1 683.1 711.1 654.3 677.5 691.0 693.6 725.7 9637.9 10175.1 10225.4 10363.3 10400.7 670.2 687.9 696.1 712.6 713.3 3739.9 4738.6 4922.1 4943.5 4954.3 104660.5 108239.5 108797.5 109663.0 112235.0 69769.0 88652.6 94471.0 95221.0 98761.5 57996.3 81388.5 82064.0 84197.2 85878.0 7693.4 9638.0 9674.2 9734.1 9748.9 54296.9 54610.7 54767.5 56076.0 56111.7 69568.7 71181.6 72673.0 75690.0 77956.6 11415.4 11597.3 11598.5 11841.2 11903.8 11603.7 12855.0 12919.9 13032.5 13033.5 11822.3 11840.5 12004.5 12141.3 12431.9 11691.2 11798.8 12029.5 12127.8 12485.1 11448.9 11603.2 11908.6 11929.6 12064.8 9696.3 9771.0 9817.8 10089.9 10438.2 9226.7 9997.9 10002.7 10027.9 10067.2 07:31:10 INFO - PROCESS | 1914 | -------- Summary: end -------- 07:31:10 INFO - PROCESS | 1914 | 07:31:10 INFO - TEST-INFO | 1914: exit 0 07:31:10 INFO - TEST-OK | dromaeo_css | took 1114808ms 07:31:10 INFO - TEST-START | kraken 07:31:10 INFO - operating with platform_type : mac_ 07:31:10 INFO - Initialising browser for kraken test... 07:31:10 INFO - TEST-INFO | started process 1922 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpqv1I1Q/profile http://localhost:49376/getInfo.html) 07:31:13 INFO - PROCESS | 1922 | 2017-02-27 07:31:13.370 plugin-container[1923:17778] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 07:31:13 INFO - PROCESS | 1922 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:31:13 INFO - PROCESS | 1922 | 2017-02-27 07:31:13.374 plugin-container[1923:17778] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 07:31:13 INFO - PROCESS | 1922 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:31:13 INFO - PROCESS | 1922 | 2017-02-27 07:31:13.374 plugin-container[1923:17778] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:31:13 INFO - PROCESS | 1922 | __metrics Screen width/height:1600/1200 07:31:13 INFO - PROCESS | 1922 | colorDepth:24 07:31:13 INFO - PROCESS | 1922 | Browser inner width/height: 1024/689 07:31:13 INFO - PROCESS | 1922 | __metrics 07:31:13 ERROR - PROCESS | 1922 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 07:31:14 INFO - TEST-INFO | 1922: exit 0 07:31:14 INFO - Browser initialized. 07:31:14 INFO - Running cycle 1/1 for kraken test... 07:31:14 INFO - TEST-INFO | started process 1924 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpqv1I1Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:31:16 INFO - PROCESS | 1924 | 2017-02-27 07:31:16.712 plugin-container[1925:17905] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x882f, name = 'com.apple.tsm.portname' 07:31:16 INFO - PROCESS | 1924 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:31:16 INFO - PROCESS | 1924 | 2017-02-27 07:31:16.713 plugin-container[1925:17905] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 07:31:16 INFO - PROCESS | 1924 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:31:16 INFO - PROCESS | 1924 | 2017-02-27 07:31:16.713 plugin-container[1925:17905] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:31:26 INFO - PROCESS | 1924 | RSS: Main: 218427392 07:31:26 INFO - PROCESS | 1924 | 07:31:29 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49376/tests/kraken/driver.html?testName=audio-beat-detection) 07:31:30 INFO - PROCESS | 1924 | RSS: Main: 232968192 07:31:30 INFO - PROCESS | 1924 | 07:31:33 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49376/tests/kraken/driver.html?testName=audio-dft) 07:31:33 INFO - PROCESS | 1924 | RSS: Main: 241778688 07:31:33 INFO - PROCESS | 1924 | 07:31:37 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49376/tests/kraken/driver.html?testName=audio-fft) 07:31:37 INFO - PROCESS | 1924 | RSS: Main: 245100544 07:31:37 INFO - PROCESS | 1924 | 07:31:39 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49376/tests/kraken/driver.html?testName=audio-oscillator) 07:31:40 INFO - PROCESS | 1924 | RSS: Main: 245530624 07:31:40 INFO - PROCESS | 1924 | 07:31:42 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49376/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:31:42 INFO - PROCESS | 1924 | RSS: Main: 245624832 07:31:42 INFO - PROCESS | 1924 | 07:31:45 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49376/tests/kraken/driver.html?testName=imaging-darkroom) 07:31:46 INFO - PROCESS | 1924 | RSS: Main: 249602048 07:31:46 INFO - PROCESS | 1924 | 07:31:49 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49376/tests/kraken/driver.html?testName=imaging-desaturate) 07:31:49 INFO - PROCESS | 1924 | RSS: Main: 249131008 07:31:49 INFO - PROCESS | 1924 | 07:31:52 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49376/tests/kraken/driver.html?testName=json-parse-financial) 07:31:53 INFO - PROCESS | 1924 | RSS: Main: 249294848 07:31:53 INFO - PROCESS | 1924 | 07:31:55 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49376/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:31:55 INFO - PROCESS | 1924 | RSS: Main: 248733696 07:31:55 INFO - PROCESS | 1924 | 07:31:57 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:31:58 INFO - PROCESS | 1924 | RSS: Main: 248688640 07:31:58 INFO - PROCESS | 1924 | 07:32:00 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:32:01 INFO - PROCESS | 1924 | RSS: Main: 248700928 07:32:01 INFO - PROCESS | 1924 | 07:32:04 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:32:04 INFO - PROCESS | 1924 | RSS: Main: 249069568 07:32:04 INFO - PROCESS | 1924 | 07:32:07 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:32:08 INFO - PROCESS | 1924 | RSS: Main: 249020416 07:32:08 INFO - PROCESS | 1924 | 07:32:10 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49376/tests/kraken/driver.html?testName=ai-astar) 07:32:10 INFO - PROCESS | 1924 | RSS: Main: 250851328 07:32:10 INFO - PROCESS | 1924 | 07:32:10 INFO - PROCESS | 1924 | __start_tp_report 07:32:10 INFO - PROCESS | 1924 | _x_x_mozilla_page_load 07:32:10 INFO - PROCESS | 1924 | _x_x_mozilla_page_load_details 07:32:10 INFO - PROCESS | 1924 | |i|pagename|runs| 07:32:10 INFO - PROCESS | 1924 | |0;ai-astar;107;118;120;129;175;164;117;119;118;119 07:32:10 INFO - PROCESS | 1924 | |1;audio-beat-detection;148;116;150;151;113;111;120;101;154;148 07:32:10 INFO - PROCESS | 1924 | |2;audio-dft;203;200;199;200;265;249;198;199;195;197 07:32:10 INFO - PROCESS | 1924 | |3;audio-fft;84;61;63;88;60;61;57;58;72;59 07:32:10 INFO - PROCESS | 1924 | |4;audio-oscillator;88;71;85;74;71;71;82;69;71;81 07:32:10 INFO - PROCESS | 1924 | |5;imaging-gaussian-blur;97;86;88;85;96;99;89;87;89;85 07:32:10 INFO - PROCESS | 1924 | |6;imaging-darkroom;99;98;99;99;122;123;101;100;164;98 07:32:10 INFO - PROCESS | 1924 | |7;imaging-desaturate;90;147;93;93;92;93;110;143;92;92 07:32:10 INFO - PROCESS | 1924 | |8;json-parse-financial;60;59;60;62;68;63;54;62;86;97 07:32:10 INFO - PROCESS | 1924 | |9;json-stringify-tinderbox;69;73;80;74;77;73;69;69;71;72 07:32:10 INFO - PROCESS | 1924 | |10;stanford-crypto-aes;83;83;86;89;83;84;86;87;83;89 07:32:10 INFO - PROCESS | 1924 | |11;stanford-crypto-ccm;153;136;157;158;154;154;148;152;188;148 07:32:10 INFO - PROCESS | 1924 | |12;stanford-crypto-pbkdf2;170;214;173;169;172;170;168;173;171;175 07:32:10 INFO - PROCESS | 1924 | |13;stanford-crypto-sha256-iterative;69;69;67;66;69;73;85;93;88;73 07:32:10 INFO - PROCESS | 1924 | __end_tp_report 07:32:10 INFO - PROCESS | 1924 | __start_cc_report 07:32:10 INFO - PROCESS | 1924 | _x_x_mozilla_cycle_collect,970 07:32:10 INFO - PROCESS | 1924 | __end_cc_report 07:32:10 INFO - PROCESS | 1924 | __startTimestamp1488209530478__endTimestamp 07:32:10 INFO - PROCESS | 1924 | 07:32:10 INFO - PROCESS | 1924 | ------- Summary: start ------- 07:32:10 INFO - PROCESS | 1924 | Number of tests: 14 07:32:10 INFO - PROCESS | 1924 | 07:32:10 INFO - PROCESS | 1924 | [#0] ai-astar Cycles:10 Average:128.60 Median:119.50 stddev:22.34 (18.7%) stddev-sans-first:22.28 07:32:10 INFO - PROCESS | 1924 | Values: 107.0 118.0 120.0 129.0 175.0 164.0 117.0 119.0 118.0 119.0 07:32:10 INFO - PROCESS | 1924 | 07:32:10 INFO - PROCESS | 1924 | [#1] audio-beat-detection Cycles:10 Average:131.20 Median:148.00 stddev:20.65 (14.0%) stddev-sans-first:20.99 07:32:10 INFO - PROCESS | 1924 | Values: 148.0 116.0 150.0 151.0 113.0 111.0 120.0 101.0 154.0 148.0 07:32:10 INFO - PROCESS | 1924 | 07:32:10 INFO - PROCESS | 1924 | [#2] audio-dft Cycles:10 Average:210.50 Median:200.00 stddev:24.88 (12.4%) stddev-sans-first:26.24 07:32:10 INFO - PROCESS | 1924 | Values: 203.0 200.0 199.0 200.0 265.0 249.0 198.0 199.0 195.0 197.0 07:32:10 INFO - PROCESS | 1924 | 07:32:10 INFO - PROCESS | 1924 | [#3] audio-fft Cycles:10 Average:66.30 Median:62.00 stddev:11.22 (18.1%) stddev-sans-first:9.90 07:32:10 INFO - PROCESS | 1924 | Values: 84.0 61.0 63.0 88.0 60.0 61.0 57.0 58.0 72.0 59.0 07:32:10 INFO - PROCESS | 1924 | 07:32:10 INFO - PROCESS | 1924 | [#4] audio-oscillator Cycles:10 Average:76.30 Median:77.50 stddev:6.98 (9.0%) stddev-sans-first:5.98 07:32:10 INFO - PROCESS | 1924 | Values: 88.0 71.0 85.0 74.0 71.0 71.0 82.0 69.0 71.0 81.0 07:32:10 INFO - PROCESS | 1924 | 07:32:10 INFO - PROCESS | 1924 | [#5] imaging-gaussian-blur Cycles:10 Average:90.10 Median:89.00 stddev:5.24 (5.9%) stddev-sans-first:4.92 07:32:10 INFO - PROCESS | 1924 | Values: 97.0 86.0 88.0 85.0 96.0 99.0 89.0 87.0 89.0 85.0 07:32:10 INFO - PROCESS | 1924 | 07:32:10 INFO - PROCESS | 1924 | [#6] imaging-darkroom Cycles:10 Average:110.30 Median:98.00 stddev:21.24 (21.7%) stddev-sans-first:22.13 07:32:10 INFO - PROCESS | 1924 | Values: 99.0 98.0 99.0 99.0 122.0 123.0 101.0 100.0 164.0 98.0 07:32:10 INFO - PROCESS | 1924 | 07:32:10 INFO - PROCESS | 1924 | [#7] imaging-desaturate Cycles:10 Average:104.50 Median:92.00 stddev:22.10 (24.0%) stddev-sans-first:22.81 07:32:10 INFO - PROCESS | 1924 | Values: 90.0 147.0 93.0 93.0 92.0 93.0 110.0 143.0 92.0 92.0 07:32:10 INFO - PROCESS | 1924 | 07:32:10 INFO - PROCESS | 1924 | [#8] json-parse-financial Cycles:10 Average:67.10 Median:62.50 stddev:13.58 (21.7%) stddev-sans-first:14.15 07:32:10 INFO - PROCESS | 1924 | Values: 60.0 59.0 60.0 62.0 68.0 63.0 54.0 62.0 86.0 97.0 07:32:10 INFO - PROCESS | 1924 | 07:32:10 INFO - PROCESS | 1924 | [#9] json-stringify-tinderbox Cycles:10 Average:72.70 Median:73.00 stddev:3.62 (5.0%) stddev-sans-first:3.59 07:32:10 INFO - PROCESS | 1924 | Values: 69.0 73.0 80.0 74.0 77.0 73.0 69.0 69.0 71.0 72.0 07:32:10 INFO - PROCESS | 1924 | 07:32:10 INFO - PROCESS | 1924 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:86.00 stddev:2.45 (2.9%) stddev-sans-first:2.46 07:32:10 INFO - PROCESS | 1924 | Values: 83.0 83.0 86.0 89.0 83.0 84.0 86.0 87.0 83.0 89.0 07:32:10 INFO - PROCESS | 1924 | 07:32:10 INFO - PROCESS | 1924 | [#11] stanford-crypto-ccm Cycles:10 Average:154.80 Median:154.00 stddev:13.23 (8.6%) stddev-sans-first:14.02 07:32:10 INFO - PROCESS | 1924 | Values: 153.0 136.0 157.0 158.0 154.0 154.0 148.0 152.0 188.0 148.0 07:32:10 INFO - PROCESS | 1924 | 07:32:10 INFO - PROCESS | 1924 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.50 Median:172.50 stddev:13.69 (7.9%) stddev-sans-first:14.37 07:32:10 INFO - PROCESS | 1924 | Values: 170.0 214.0 173.0 169.0 172.0 170.0 168.0 173.0 171.0 175.0 07:32:10 INFO - PROCESS | 1924 | 07:32:10 INFO - PROCESS | 1924 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.20 Median:73.00 stddev:9.74 (13.3%) stddev-sans-first:10.07 07:32:10 INFO - PROCESS | 1924 | Values: 69.0 69.0 67.0 66.0 69.0 73.0 85.0 93.0 88.0 73.0 07:32:10 INFO - PROCESS | 1924 | -------- Summary: end -------- 07:32:10 INFO - PROCESS | 1924 | 07:32:11 INFO - TEST-INFO | 1924: exit 0 07:32:11 INFO - TEST-OK | kraken | took 60560ms 07:32:11 INFO - SUITE-END | took 1175s 07:32:11 INFO - Completed test suite (00:19:35) 07:32:11 INFO - javascript benchmark 07:32:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7199.252566376749, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3011.3977204559087, 3430.622631510535, 3454.27460233351, 3470.4273794823857, 3498.9650103498975, 5876.2948446186465, 5890.734916928738, 5929.88140237195, 5955.9702201488935, 5968.582199246054, 5899.439553242446, 5953.553483488734, 5959.851003724909, 5966.910496342558, 6006.819795406145, 5321.308229930104, 5400.270963419947, 5404.91892621611, 5460.34475862897, 5484.972575137119, 5397.46025397461, 5402.324709411324, 5469.972650136764, 5490.203920431535, 5500.669959802404, 5252.36971563411, 5273.31446911899, 5286.15421532553, 5403.135498320269, 5404.621676482648, 4718.669693121448, 5016.423111342206, 5256.579473642099, 5303.124984377573, 5304.787808487656, 5247.344081989751, 5251.6061295402615, 5272.92090618641, 5294.470552944713, 5348.91976620351, 4704.6001089907395, 5328.934213157345, 5638.008869002408, 5719.542436605062, 5774.16274640179, 6248.812535623939, 6254.655993920333, 6277.4664153547, 6293.527985401068, 6300.0234963580715, 6337.904931426032, 6354.4281014708895, 6363.490920726331, 6379.425851673372, 6385.106085148083, 5757.913631295534, 6074.331823499411, 6075.422834830684, 6086.6348019119, 6092.208012958331, 6239.594426362272, 6255.0, 6387.936120638734, 6397.040443933447, 6410.0, 4985.825496107619, 5634.85912852182, 5846.619969702041, 6292.402221788922, 6300.180976473029, 6291.370862913764, 6347.777827776005, 6348.936510634927, 6351.460125889351, 6363.90454143179, 6165.691715414211, 6169.96915015422, 6176.073588961602, 6220.564560480813, 6305.0, 6268.561200715906, 6294.779682711083, 6299.0866324382705, 6314.747410103544, 6314.8421289467215, 5129.692218466829, 5131.923021154686, 5133.589312854962, 5141.151709967889, 5149.304843846033, 4468.486124095705, 4519.7740112994215, 4556.772161391984, 4596.310553416947, 4648.465426475931, 5947.910781338283, 5958.880822383528, 6011.909821352683, 6068.393160683896, 6072.878542429126, 6213.099100630383, 6266.530010249158, 6309.179806625201, 6312.715927783261, 6317.4946004319545, 5986.820395388146, 6049.122877182784, 6065.575409721366, 6082.939170608237, 6143.201383820075, 5617.354004289559, 5627.746751396197, 5630.634008789416, 5631.774729010794, 5634.7182640867795, 5483.479069488392, 6566.0, 6588.769393071219, 6614.470842332602, 6650.20197576294, 6171.47542458896, 6173.259208894961, 6190.226221722285, 6208.441240288395, 6262.248530176408, 6355.078513615592, 6390.360963903572, 6397.424231819158, 6406.391392817675, 6421.743130274924, 6224.906626400517, 6236.282827474898, 6242.0, 6243.0, 6244.0, 5795.420457954171, 6184.81445556634, 6227.595206311576, 6265.091561723616, 6287.497000240061, 6114.449699527064, 6194.38056194377, 6241.594296370721, 6255.40573645503, 6259.311475737574, 6228.128062071404, 6229.2524897012645, 6240.438360547572, 6264.906026409516, 6295.055741638791, 5032.698038117578, 6052.515798736003, 6080.908786368296, 6124.112003759519, 6180.165677633462, 6147.708981114016, 6227.0970709246, 6236.688165591611, 6249.6562689052535, 6276.843078923063, 6173.907391389043, 6185.443310102112, 6196.783112591038, 6197.318294987638, 6218.06728990655], "value": 5800.262409897615, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [448.8586095379955, 475.16845520339405, 504.87378155461136, 552.6822077305548, 555.2199160179944, 24144.637830432537, 39816.20367592647, 39937.0, 39979.20041599166, 40003.0, 41788.791056044756, 42523.14953700932, 42571.0, 42583.935401614974, 42704.78647606765, 8455.74632761018, 8687.30501559877, 9115.908840911588, 9378.0621937806, 11236.438178091104, 11231.831522527169, 11463.541458341657, 11512.079033677328, 11537.596184133557, 11548.133889958244, 11410.20128590999, 11524.078073754079, 11551.0, 11553.133514986368, 11565.190436669394, 11290.322580645188, 11438.599649012245, 11465.885341146564, 11498.482568284448, 11547.191696581243, 11456.713582160513, 11502.194846360759, 11552.826707599394, 11574.710632234177, 11577.247478913843, 39305.803470982464, 39681.0, 40282.99292517681, 40483.19033619341, 40650.18699625991, 3933.0, 3970.622790834866, 4000.19996000801, 4005.8998525036814, 4145.129522800215, 29344.559831602543, 29951.850240748874, 30546.389072218655, 31334.0, 31446.842765786023, 3146.9842650786827, 3173.222560472676, 3231.2245061185145, 3236.01301603011, 3317.883874064396, 492557.0, 493063.0, 496071.0, 499486.0, 500801.0, 52787.0, 61906.45233869099, 63200.0, 63333.0, 63465.0, 63409.0, 63445.36554634487, 63900.0, 63992.0, 64072.35927640757, 16145.919270403572, 16628.916855415886, 16694.749578756328, 16700.914440561326, 16759.916200419164, 11650.70873228176, 11975.940120299343, 12811.423485943154, 12884.291363975071, 13237.93381033108, 16399.262033208535, 16691.91654041722, 16694.0, 16723.247453864606, 16726.498205053867, 6858.5199036067, 7123.9314102883945, 7533.472656914073, 7552.320291173821, 7660.004199454147, 687.9518433709592, 819.0008190008181, 819.1685439279137, 871.8648609465542, 899.6806133822399, 28341.71658283432, 29677.554836677467, 30185.69814301829, 30187.849060754557, 30872.0, 977.7848873247874, 982.9973427104313, 1033.9247182929819, 1044.7597052677927, 1048.8007278617038, 13218.81030707241, 13915.30423478822, 14448.349824257934, 14570.4900328488, 14677.119372837664, 557468.0, 635196.0, 638227.0, 639693.0, 641807.0, 42611.36082958758, 51293.7435312821, 51359.0, 51602.48397516052, 51668.74165629223, 1391.5338361648758, 1412.2938530734632, 1435.382785402287, 1437.3747419872388, 1439.9496017639333, 26377.0, 27246.863765681046, 27436.862815685792, 27590.0, 27744.861275693493, 45560.316595250435, 45815.54184458246, 45994.99999999866, 45999.54000459953, 46004.30993535033, 540631.0, 541114.0, 542376.0, 543518.0, 544856.0, 24613.13854015101, 25038.0, 25671.358216044748, 25711.871440642677, 26550.86724566365, 42734.0, 43028.56971430246, 43682.78158609186, 44076.779616103, 44096.33855492106, 35081.0, 35629.46555801717, 35656.82171589125, 35787.0, 36868.446973294886, 35232.11919702028, 35632.0, 36391.0, 36443.45334819927, 36756.44865327076, 27489.0, 33706.157346066546, 34503.827480862434, 35314.0, 35482.93551193468, 29767.25581860384, 31981.6801831988, 32186.03441896747, 32258.35483290368, 32479.0, 23877.64183537283, 23901.163459278843, 24243.87878060669, 24502.387440314134, 24709.88805503721], "value": 19687.814884375, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.5058971567815, 397.7076848516338, 401.57633696450245, 404.54690746364076, 428.96191217254244, 16709.83290167098, 19730.309439169614, 20597.691034634492, 21184.0, 21220.0, 21217.045232964516, 21460.678089828663, 21630.89184554075, 21830.017649205784, 22098.779012209874, 5653.717314134287, 5881.67650779207, 5929.436703513181, 5949.524038076965, 5963.61236519627, 5680.375158732536, 5822.0, 5857.941420585804, 5889.263842019747, 5928.525717942554, 5833.7083145842535, 5842.795502157425, 5846.736896839631, 5848.561357898154, 5854.619449735754, 4845.53967373099, 5253.921191182097, 5635.182898479718, 5851.79518716845, 5853.5902486825935, 4101.835926562934, 5121.871953201163, 5179.896402071975, 5229.947700522984, 5231.163013917793, 25282.241532754048, 25307.367315817068, 25793.87103064473, 26300.947962081493, 26583.202503924913, 2336.520551347324, 2721.482918245527, 2748.491529067129, 2748.958765618517, 2793.385455199873, 12648.810267845989, 14985.0, 15686.9215653921, 15996.680066398607, 16031.758681835394, 1670.5322509697305, 1730.6241537977212, 1805.8284462975996, 1814.872958892878, 1832.221305944968, 116315.41842290819, 116559.0, 116670.0, 117016.41491792572, 117520.0, 9718.319717619699, 11683.824742628698, 11793.646190614296, 11838.763224735458, 12027.518899243933, 13099.476020959055, 13847.584572462642, 14945.775813362809, 15179.316930738143, 15181.240937953058, 8526.23263906239, 8751.124887511198, 8970.0, 9026.232770214605, 9131.086891310815, 8715.738527844174, 8846.823063538694, 8874.467531948103, 9029.41308814925, 9048.954755226181, 6046.788362407295, 6193.597416167935, 7523.586202758791, 7614.314711675976, 7628.504147230412, 1979.2775636892432, 2029.2086086426305, 2034.5829105033433, 2035.297822251321, 2039.8780670631093, 383.9404892241707, 424.07974694911496, 1013.6502906497246, 1032.6437379104198, 1064.80301144287, 8748.69379571712, 8870.334724895658, 8884.822303554021, 8994.730158095268, 9103.271738260923, 441.66212847171295, 441.9094085712421, 443.98890027748917, 446.13449907179967, 459.21245064714174, 4530.161920044802, 4544.341070544752, 4569.109023740339, 4579.107074120515, 4668.439787225555, 708800.0, 737878.0, 750804.0, 772539.1373043099, 777521.0, 119131.0, 123834.0, 148917.0, 153324.0, 154885.2255738714, 446.95530446955695, 452.2515237282303, 456.45453682848677, 457.13829431522487, 457.80543269110495, 8278.586070696321, 8375.371847111614, 8448.788780280542, 8684.869726954226, 8796.60415281301, 56266.71866640641, 56977.71511142418, 57634.0, 58086.7095664519, 58340.83318333525, 83840.58079709562, 85117.0, 85688.0, 86125.0, 88055.0, 6015.368386319374, 6299.338569450142, 7519.812004699927, 7524.360429363565, 7783.649735762017, 9527.333086683866, 12031.4585843639, 12290.75418491643, 12478.126531142732, 12661.48062232538, 11132.554697811996, 11139.220254582102, 11143.944280278547, 11642.476088575864, 11703.824442633537, 9377.578008989749, 10735.892641073802, 11239.494222759831, 11409.429528523706, 11499.195056345976, 11202.15983801202, 11230.382328971658, 11326.603568875049, 11492.195546311677, 11791.705207369885, 7238.0, 7505.849883002418, 7607.847843043219, 7812.921870781447, 8639.913600864162, 9827.55775990068, 11069.0, 11133.721656958642, 11373.260738052, 11433.714157146138], "value": 8816.574441593906, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1243.8445194350707, 1435.6052085676438, 1449.253634378296, 1453.9636509087272, 1468.5520916120581, 7165.964170179148, 7553.0, 7806.258405451473, 8008.759737207879, 8598.74203773887, 6990.510664253505, 8109.148539403352, 8392.118827523114, 8478.703245386412, 8489.320854331654, 2322.5587138443643, 2365.325882123595, 2375.6555299481565, 2387.1525608409024, 2390.6414037894283, 2095.277129390358, 2100.348891843526, 2172.0877231562704, 2257.679257634286, 2394.4013996500876, 2254.49273913369, 2275.1354485295565, 2350.5063936573342, 2352.1532248390567, 2356.528694261146, 2337.4273303040777, 2340.648902664597, 2347.859128452298, 2368.301351101412, 2369.845960012594, 2283.4748007958265, 2296.311106667993, 2327.290176496168, 2379.131616959797, 2383.976160238393, 8429.4942303462, 8516.148385161496, 8569.185927336894, 8573.442726222838, 8576.313894888457, 5110.5400513953555, 5279.102552566073, 5279.445658205871, 5284.365876094855, 5286.04851126797, 3355.3828014149003, 3566.892993210208, 3601.9099522511883, 3651.4157734762575, 3663.505426767379, 1070.8019016481976, 1200.789861774186, 1231.150506150762, 1268.1123213750411, 1289.013904363163, 10754.247202695815, 10903.345799252149, 10912.563497460093, 10952.945235273852, 10960.835587466194, 3982.4424580558743, 4636.165490211794, 4719.858404247878, 4724.740139292372, 4796.784144713426, 9516.95241523788, 9662.613495460102, 9667.661631842851, 9710.660126895666, 9737.367071140496, 5233.869153271199, 5301.5493683037375, 5309.522143007148, 5323.467653234646, 5324.094903866352, 4721.905561888743, 4753.691010084333, 4827.541383568555, 4853.684510506806, 4913.287573301923, 3848.634379733921, 3972.880813575597, 3986.0, 4014.237294913957, 4081.7142800003717, 1177.4112943528237, 1237.5173682263924, 1275.5599318235195, 1299.636101891472, 1303.0748168800258, 859.621766422772, 881.5151666583354, 883.1918794303269, 899.1413200393608, 902.6073657958809, 5489.34127904654, 5500.119980803132, 5555.74995625981, 5574.247476590608, 5680.062789639664, 962.153305091515, 982.8771403574553, 983.842585186381, 987.0474991633108, 1006.5068116622948, 3620.71034317254, 3686.391745362039, 3705.7591256568235, 3716.6283371662616, 3832.0419895026243, 9812.65655702047, 10146.340487868265, 10150.847737283946, 10180.592776289013, 10189.337693049929, 9990.950045249727, 10059.346142500714, 10101.5454304555, 10115.443650599287, 10131.341462804894, 6490.513211509061, 7843.098043725045, 7879.763607091796, 7899.802504937307, 7918.841623167505, 4523.32150177476, 5212.843614691414, 5269.604779641619, 5431.212474191141, 5472.91790623149, 7767.650455729618, 9005.054469280893, 9319.440833550008, 9364.859527107235, 9389.154976052188, 7810.609469526615, 9034.819303614022, 9189.908100919172, 9336.439813611205, 9513.762155946157, 6715.127033485615, 6745.12313399255, 7101.82245443868, 7291.708331666674, 7302.634868256672, 6590.868182636416, 7803.492772969739, 7841.137474877873, 7881.330086942674, 7900.644470998934, 4959.801607935642, 7136.643167841691, 7350.926490735238, 7384.778456646309, 7477.513961592479, 6250.687465626791, 7142.0, 7145.321194486515, 7291.270872912666, 7520.210377910459, 5419.891602167856, 5767.826965191051, 6264.2796078451565, 6313.936860631518, 6427.6786160690845, 4821.276808478616, 4877.244027175793, 4881.365422495053, 4972.5027497249985, 5122.436531981404, 4820.156472617208, 4918.581920536794, 4955.20716685343, 4994.076095922266, 5014.924776128434], "value": 4409.037070779398, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.8511129546522, 359.5667220998696, 362.94374371972356, 369.39603747872223, 371.9628037196281, 4954.0, 5272.971770504753, 5428.864278393042, 5602.5237854782345, 5620.494155526002, 4351.891202719934, 4365.738055716659, 5153.943441594473, 5419.8374048778505, 5469.15228139639, 3661.505696730947, 3734.972882457319, 4039.212353591051, 4185.162967406515, 4245.469316335458, 4262.211490874182, 4270.732889339658, 4277.230098582254, 4298.656107511391, 4307.267764480031, 3719.5865571083086, 4278.930267433142, 4302.548232435596, 4312.849050283241, 4347.043650396923, 3900.684418244498, 4076.1290258141535, 4310.633596144332, 4329.264025115738, 4329.67527435442, 3362.6132994705677, 3754.718396120302, 3756.3050835595504, 3761.924761504782, 3774.5093137892172, 5304.283921670563, 5362.8123015694655, 5381.946180538183, 5390.353157621072, 5407.351117865842, 4395.604395604411, 4943.283223932545, 4968.6025117990475, 5001.699898006132, 5009.5491405773655, 5118.820841270538, 5558.499735023827, 5796.536277097822, 5860.912086318709, 5861.355250922437, 3407.437772767515, 3631.400818864884, 4003.3594624860175, 4163.23062698352, 4179.561146079648, 4859.538343857328, 5709.62887412321, 5721.570882183812, 6020.916235077684, 6160.1991741073825, 3290.407726609233, 3383.796972181677, 3675.0, 4185.581441855851, 4297.484301883794, 3808.5146792750847, 4272.727272727273, 4310.224159651293, 4320.25029862906, 4326.6538676905775, 4341.609255166987, 4846.733429661403, 4989.825356112518, 4990.0, 4996.425411077773, 5272.6836389816735, 5785.479306862402, 5927.2590926134235, 5933.762649493972, 5962.403759624003, 1174.653477224221, 1225.7681030564227, 1243.5150291386367, 1395.323268214915, 1399.9650008749863, 902.6389444222232, 917.8347897378536, 982.8820541535061, 986.8798913233531, 1005.587709039305, 4641.721496710208, 4931.112399768004, 5200.763671621164, 5202.271681964528, 5209.76994263559, 5194.623494728381, 5340.198970154508, 5445.9108178363695, 5500.202470641734, 5839.416058394127, 4311.20242755085, 4379.934300985487, 4413.3159360299205, 4834.685745426536, 4902.910451097575, 2730.0581299451655, 2786.414852880918, 2849.430113977213, 3015.8492075396143, 3055.786094973375, 5364.946350536445, 5701.7631437072205, 5754.482096611325, 5759.264349433985, 5969.224000879858, 5492.286002819608, 5870.442307980735, 6221.657808820468, 6232.501399887998, 6235.844103897348, 5535.612507124462, 5811.389804070596, 6251.9687401563615, 6301.842453938505, 6304.275008374096, 5671.943280567141, 5880.26496687914, 5964.761409543569, 6055.091736239599, 6125.601835880653, 4666.859994200044, 5952.107183922446, 5964.747403045409, 5966.373530779206, 5983.252093488314, 5993.61041532299, 6139.72371243304, 6217.3628427368685, 6266.997280435108, 6306.180196574416, 3772.43413487979, 3938.3501722215515, 3956.208758248304, 3958.2083583282883, 3964.156667149674, 5010.415469845197, 5328.866778330573, 5570.910908409346, 5928.762849486145, 6083.422074902877, 4635.559621835921, 5197.4282828889545, 5499.450054994469, 5823.272090988627, 5917.822465326047, 5129.256257842518, 5845.690952073992, 5870.033538764562, 5871.442212989759, 5872.677002764889, 4527.818887244473, 4886.144924638103, 5312.309399778004, 5710.685912274865, 5801.883962320814, 4952.851414457572, 5158.3294171758935, 5431.701256430934, 5848.152017957457, 5869.354371019099, 5751.367349591458, 5764.250647415809, 5772.249607550992, 5773.249477568057, 5841.707914604338], "value": 4220.6399773842, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.84888748919, 708.3730898155131, 774.9460733402572, 822.9920931134048, 826.8702959299053, 14797.778033329496, 15519.456819011337, 15596.532104036869, 15688.980216285934, 15707.214639268033, 13814.930925345385, 14509.274536273171, 14582.489612863552, 14601.050931689433, 14616.926915365408, 841.4236248169992, 853.1212850763724, 855.2815634866711, 856.1267507142711, 858.1675774498726, 667.5093806052547, 685.7222824755956, 831.4429332347341, 849.0405841399211, 852.8336974290016, 876.9210771030606, 901.369041670833, 902.4179404284233, 906.5240748607001, 909.708893154191, 894.3515950935584, 897.4032268541412, 899.3479727197795, 901.121406628532, 902.8149229407989, 665.0722242471774, 670.4602794750224, 671.8286836856619, 672.1228796420669, 672.3377473188905, 12372.690682732913, 15329.156896370696, 15544.689106217813, 15587.376504939788, 15712.764308535381, 14485.42058317666, 14873.107613543221, 14920.701585968329, 14952.40190392383, 15048.548543543711, 11669.241499302603, 11721.70695732605, 11723.472443740053, 11835.881641183563, 11933.761324773455, 3619.6199399063244, 3723.925521489555, 3764.3036038333, 3868.477755502999, 3874.2638898609175, 114345.0, 115804.42097789541, 116955.0, 120170.39914800458, 120295.0, 11030.613928512463, 11045.447727613588, 11094.445277736242, 11412.543498259976, 11422.885771142182, 23465.413364665677, 23559.88220058923, 23719.525609487715, 23774.88112559426, 23997.040118395067, 7497.700091996259, 7502.0, 7511.774646760606, 7550.169481357156, 7736.303732664087, 4172.874813755592, 4209.158168366339, 4276.807543660543, 4425.446819147606, 4468.664850136188, 3434.587849458081, 3446.138465383654, 3503.9474407883904, 3513.0, 3533.0, 510.67572091722025, 671.6540981394586, 672.1329484964439, 683.1070416784912, 711.121764620693, 654.3423859021748, 677.4648028057877, 690.9930900690929, 693.5873155472486, 725.7060890339421, 9637.871938800967, 10175.135113515285, 10225.437600931871, 10363.32638378503, 10400.739981500372, 670.2191946382508, 687.88993760998, 696.0916004613927, 712.6365553567717, 713.2831504338106, 3739.869104581381, 4738.597219236403, 4922.064807686528, 4943.456219815817, 4954.281629163823, 104660.47669761603, 108239.45880270549, 108797.45601271943, 109663.0, 112235.0, 69769.0, 88652.5567372172, 94471.0, 95221.0, 98761.50619246857, 57996.2601121967, 81388.52363119967, 82064.0, 84197.15802842016, 85878.0, 7693.384529237759, 9638.0, 9674.177694896012, 9734.123928846439, 9748.853767193355, 54296.91406171933, 54610.726946365015, 54767.45232547623, 56076.0, 56111.71944140253, 69568.6521567389, 71181.6440917792, 72673.0, 75690.0, 77956.61021694855, 11415.429228538706, 11597.304161750322, 11598.478068487108, 11841.171118022, 11903.758951358914, 11603.6518904433, 12855.035872309427, 12919.935400322938, 13032.54386096482, 13033.491588655346, 11822.2722720228, 11840.526378944745, 12004.519819207484, 12141.332226727614, 12431.93784031074, 11691.181617286707, 11798.764024719629, 12029.45867435985, 12127.75744485123, 12485.0636202287, 11448.929233269619, 11603.245789024024, 11908.642740717793, 11929.582464613697, 12064.819027714766, 9696.272779541703, 9770.951145244228, 9817.77649505879, 10089.89910100919, 10438.164946804389, 9226.677066302647, 9997.850032249667, 10002.749931251778, 10027.949860250652, 10067.244956628136], "value": 7430.418663230494, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 118.0, 120.0, 129.0, 175.0, 164.0, 117.0, 119.0, 118.0, 119.0], "value": 128.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 116.0, 150.0, 151.0, 113.0, 111.0, 120.0, 101.0, 154.0, 148.0], "value": 131.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 200.0, 199.0, 200.0, 265.0, 249.0, 198.0, 199.0, 195.0, 197.0], "value": 210.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 61.0, 63.0, 88.0, 60.0, 61.0, 57.0, 58.0, 72.0, 59.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 85.0, 74.0, 71.0, 71.0, 82.0, 69.0, 71.0, 81.0], "value": 76.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 86.0, 88.0, 85.0, 96.0, 99.0, 89.0, 87.0, 89.0, 85.0], "value": 90.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 98.0, 99.0, 99.0, 122.0, 123.0, 101.0, 100.0, 164.0, 98.0], "value": 110.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 147.0, 93.0, 93.0, 92.0, 93.0, 110.0, 143.0, 92.0, 92.0], "value": 104.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 60.0, 62.0, 68.0, 63.0, 54.0, 62.0, 86.0, 97.0], "value": 67.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 80.0, 74.0, 77.0, 73.0, 69.0, 69.0, 71.0, 72.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 86.0, 89.0, 83.0, 84.0, 86.0, 87.0, 83.0, 89.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 136.0, 157.0, 158.0, 154.0, 154.0, 148.0, 152.0, 188.0, 148.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 214.0, 173.0, 169.0, 172.0, 170.0, 168.0, 173.0, 171.0, 175.0], "value": 175.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 67.0, 66.0, 69.0, 73.0, 85.0, 93.0, 88.0, 73.0], "value": 75.2, "unit": "score"}]}]} 07:32:11 INFO - Return code: 0 07:32:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:32:11 ERROR - # TBPL SUCCESS # 07:32:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:32:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:32:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:32:11 INFO - 2017-02-27 07:32:11.780 screenresolution[1929:18278] starting screenresolution argv=screenresolution get 07:32:11 INFO - 2017-02-27 07:32:11.783 screenresolution[1929:18278] Display 0: 1600x1200x32@60 07:32:11 INFO - 2017-02-27 07:32:11.789 screenresolution[1930:18281] starting screenresolution argv=screenresolution list 07:32:11 INFO - Available Modes on Display 0 07:32:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:32:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:32:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:32:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:32:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:32:12 INFO - Intel Iris: 07:32:12 INFO - Chipset Model: Intel Iris 07:32:12 INFO - Type: GPU 07:32:12 INFO - Bus: Built-In 07:32:12 INFO - VRAM (Dynamic, Max): 1536 MB 07:32:12 INFO - Vendor: Intel (0x8086) 07:32:12 INFO - Device ID: 0x0a2e 07:32:12 INFO - Revision ID: 0x0009 07:32:12 INFO - Displays: 07:32:12 INFO - Display: 07:32:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:32:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:32:12 INFO - Display Serial Number: 1600x1200 60 07:32:12 INFO - Main Display: Yes 07:32:12 INFO - Mirror: Off 07:32:12 INFO - Online: Yes 07:32:12 INFO - Rotation: Supported 07:32:12 INFO - Return code: 0 07:32:12 INFO - Running post-action listener: _resource_record_post_action 07:32:12 INFO - [mozharness: 2017-02-27 15:32:12.023834Z] Finished run-tests step (success) 07:32:12 INFO - Running post-run listener: _resource_record_post_run 07:32:12 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 1253376; Write bytes: 510148096; Read time: 16; Write time: 1473 07:32:12 INFO - TinderboxPrint: CPU usage
54.1% 07:32:12 INFO - TinderboxPrint: I/O read bytes / time
1,253,376 / 16 07:32:12 INFO - TinderboxPrint: I/O write bytes / time
510,148,096 / 1,473 07:32:12 INFO - TinderboxPrint: CPU idle
2,194.5 (45.9%) 07:32:12 INFO - TinderboxPrint: CPU system
961.4 (20.1%) 07:32:12 INFO - TinderboxPrint: CPU user
1,629.8 (34.1%) 07:32:12 INFO - TinderboxPrint: Swap in / out
209,879,040 / 0 07:32:12 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207481344; Write bytes: 200093696; Read time: 15979; Write time: 385 07:32:12 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 1101824; Write bytes: 298878976; Read time: 14; Write time: 1045 07:32:12 INFO - Running post-run listener: _upload_blobber_files 07:32:12 INFO - Blob upload gear active. 07:32:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:32:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:32:12 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:32:12 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:32:12 INFO - (blobuploader) - INFO - Open directory for files ... 07:32:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:32:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:32:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:32:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:32:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:32:14 INFO - (blobuploader) - INFO - Done attempting. 07:32:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:32:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:32:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:32:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:32:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:32:14 INFO - (blobuploader) - INFO - Done attempting. 07:32:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:32:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:32:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:32:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:32:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:32:16 INFO - (blobuploader) - INFO - Done attempting. 07:32:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:32:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:32:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:32:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:32:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:32:18 INFO - (blobuploader) - INFO - Done attempting. 07:32:18 INFO - (blobuploader) - INFO - Iteration through files over. 07:32:18 INFO - Return code: 0 07:32:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:32:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:32:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a37a143393b0ff931d173dea127544c48f95e2ed89b22811ec620bd6bc9616e8d541077dda793808f9138af4fb94d57ffea983271e3701b8c06f943633baa776", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c9445a16765b3d69479dcceb8f8548d5c7cc65b0c73dbc4a8e88e402d1a2a48a587d0f932b01356b6d44df2d6da500a8cb20cdac2b92f8d73757d7161faff7fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52df0988c046992dd2f56f9ea3b1aaa4c116eff6c9d1ffca54bf5c1e6c3d7fb846190b62ecd16bb7187d451a78f4e511b0dd3874e9f31277186156c239983d2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a74f03581f3f18cde8ecb33527f9ea7d386ed32b6fa7511196defee72e7210063409c821490774b4020194619177c1713eea24957b5289371d8d9096ea6455e9"} 07:32:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:32:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:32:18 INFO - Contents: 07:32:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a37a143393b0ff931d173dea127544c48f95e2ed89b22811ec620bd6bc9616e8d541077dda793808f9138af4fb94d57ffea983271e3701b8c06f943633baa776", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c9445a16765b3d69479dcceb8f8548d5c7cc65b0c73dbc4a8e88e402d1a2a48a587d0f932b01356b6d44df2d6da500a8cb20cdac2b92f8d73757d7161faff7fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52df0988c046992dd2f56f9ea3b1aaa4c116eff6c9d1ffca54bf5c1e6c3d7fb846190b62ecd16bb7187d451a78f4e511b0dd3874e9f31277186156c239983d2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a74f03581f3f18cde8ecb33527f9ea7d386ed32b6fa7511196defee72e7210063409c821490774b4020194619177c1713eea24957b5289371d8d9096ea6455e9"} 07:32:18 INFO - Running post-run listener: copy_logs_to_upload_dir 07:32:18 INFO - Copying logs to upload dir... 07:32:18 INFO - mkdir: /builds/slave/test/build/upload/logs 07:32:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.959643 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-02-27 07:32:19.070500) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-27 07:32:19.078479) ========= 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.pn85YFwtDE/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.8gDlSth6nx/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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-Aurora/sha512/a37a143393b0ff931d173dea127544c48f95e2ed89b22811ec620bd6bc9616e8d541077dda793808f9138af4fb94d57ffea983271e3701b8c06f943633baa776", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c9445a16765b3d69479dcceb8f8548d5c7cc65b0c73dbc4a8e88e402d1a2a48a587d0f932b01356b6d44df2d6da500a8cb20cdac2b92f8d73757d7161faff7fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52df0988c046992dd2f56f9ea3b1aaa4c116eff6c9d1ffca54bf5c1e6c3d7fb846190b62ecd16bb7187d451a78f4e511b0dd3874e9f31277186156c239983d2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a74f03581f3f18cde8ecb33527f9ea7d386ed32b6fa7511196defee72e7210063409c821490774b4020194619177c1713eea24957b5289371d8d9096ea6455e9"} build_url:https://queue.taskcluster.net/v1/task/c80Cin4tTBGIv1pqjuYZUA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010718 build_url: 'https://queue.taskcluster.net/v1/task/c80Cin4tTBGIv1pqjuYZUA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a37a143393b0ff931d173dea127544c48f95e2ed89b22811ec620bd6bc9616e8d541077dda793808f9138af4fb94d57ffea983271e3701b8c06f943633baa776", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c9445a16765b3d69479dcceb8f8548d5c7cc65b0c73dbc4a8e88e402d1a2a48a587d0f932b01356b6d44df2d6da500a8cb20cdac2b92f8d73757d7161faff7fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52df0988c046992dd2f56f9ea3b1aaa4c116eff6c9d1ffca54bf5c1e6c3d7fb846190b62ecd16bb7187d451a78f4e511b0dd3874e9f31277186156c239983d2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a74f03581f3f18cde8ecb33527f9ea7d386ed32b6fa7511196defee72e7210063409c821490774b4020194619177c1713eea24957b5289371d8d9096ea6455e9"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-27 07:32:19.120585) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 07:32:19.124271) ========= 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.pn85YFwtDE/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.8gDlSth6nx/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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.005121 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 07:32:19.173362) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-27 07:32:19.173675) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-27 07:32:19.177196) ========= ========= Total master_lag: 0.24 =========