builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0185 starttime: 1479404922.17 results: success (0) buildid: 20161117071828 builduid: 01ff11ce07094d3287adcc597025b992 revision: 97f55b49a6d74b9e871a4cc0a8b3d793a5e9a27e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 09:48:42.166891) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 09:48:42.167365) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 09:48:42.167644) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 09:48:42.195134) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 09:48:42.195509) ========= 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.wY3ovUFa2C/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.IJQSZAJE7Z/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-17 09:48:42-- 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% 9.40M=0.001s 2016-11-17 09:48:42 (9.40 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092862 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 09:48:42.312831) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 09:48:42.313161) ========= 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.wY3ovUFa2C/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.IJQSZAJE7Z/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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.026272 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 09:48:42.361684) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-17 09:48:42.364083) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 97f55b49a6d74b9e871a4cc0a8b3d793a5e9a27e --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 97f55b49a6d74b9e871a4cc0a8b3d793a5e9a27e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wY3ovUFa2C/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.IJQSZAJE7Z/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-17 09:48:42,458 truncating revision to first 12 chars 2016-11-17 09:48:42,458 Setting DEBUG logging. 2016-11-17 09:48:42,458 attempt 1/10 2016-11-17 09:48:42,459 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/97f55b49a6d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-17 09:48:44,609 unpacking tar archive at: mozilla-aurora-97f55b49a6d7/testing/mozharness/ program finished with exit code 0 elapsedTime=2.411341 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-17 09:48:44.797378) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 09:48:44.797699) ========= script_repo_revision: 97f55b49a6d74b9e871a4cc0a8b3d793a5e9a27e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 09:48:44.798091) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 09:48:44.798357) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 09:48:44.816285) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-11-17 09:48:44.816556) ========= /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.wY3ovUFa2C/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.IJQSZAJE7Z/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 09:48:45 INFO - MultiFileLogger online at 20161117 09:48:45 in /builds/slave/test 09:48:45 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 09:48:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:48:45 INFO - {'append_to_log': False, 09:48:45 INFO - 'base_work_dir': '/builds/slave/test', 09:48:45 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:48:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:48:45 INFO - 'branch': 'Mozilla-Aurora', 09:48:45 INFO - 'buildbot_json_path': 'buildprops.json', 09:48:45 INFO - 'config_files': ('talos/mac_config.py',), 09:48:45 INFO - 'default_actions': ('clobber', 09:48:45 INFO - 'read-buildbot-config', 09:48:45 INFO - 'download-and-extract', 09:48:45 INFO - 'populate-webroot', 09:48:45 INFO - 'create-virtualenv', 09:48:45 INFO - 'install', 09:48:45 INFO - 'run-tests'), 09:48:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:48:45 INFO - 'download_minidump_stackwalk': True, 09:48:45 INFO - 'download_symbols': 'ondemand', 09:48:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:48:45 INFO - 'tooltool.py': '/tools/tooltool.py', 09:48:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:48:45 INFO - '/tools/misc-python/virtualenv.py')}, 09:48:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:48:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:48:45 INFO - 'installer_path': 'installer.exe', 09:48:45 INFO - 'log_level': 'info', 09:48:45 INFO - 'log_name': 'talos', 09:48:45 INFO - 'log_to_console': True, 09:48:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:48:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:48:45 INFO - 'opt_config_files': (), 09:48:45 INFO - 'pip_index': False, 09:48:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:48:45 INFO - 'cmd': ('bash', 09:48:45 INFO - '-c', 09:48:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:48:45 INFO - 'enabled': True, 09:48:45 INFO - 'halt_on_failure': False, 09:48:45 INFO - 'name': 'check_screen_resolution'},), 09:48:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:48:45 INFO - 'cmd': ('bash', 09:48:45 INFO - '-c', 09:48:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:48:45 INFO - 'enabled': True, 09:48:45 INFO - 'halt_on_failure': False, 09:48:45 INFO - 'name': 'check_screen_resolution'},), 09:48:45 INFO - 'run_cmd_checks_enabled': True, 09:48:45 INFO - 'sps_profile': False, 09:48:45 INFO - 'sps_profile_interval': 0, 09:48:45 INFO - 'suite': 'dromaeojs-e10s', 09:48:45 INFO - 'system_bits': '32', 09:48:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:48:45 INFO - 'title': 't-yosemite-r7-0185', 09:48:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:48:45 INFO - 'use_talos_json': True, 09:48:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:48:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:48:45 INFO - 'work_dir': 'build'} 09:48:45 INFO - [mozharness: 2016-11-17 17:48:45.018964Z] Running clobber step. 09:48:45 INFO - Running pre-action listener: _resource_record_pre_action 09:48:45 INFO - Running main action method: clobber 09:48:45 INFO - rmtree: /builds/slave/test/build 09:48:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:48:47 INFO - Running post-action listener: _resource_record_post_action 09:48:47 INFO - [mozharness: 2016-11-17 17:48:47.200347Z] Finished clobber step (success) 09:48:47 INFO - [mozharness: 2016-11-17 17:48:47.200470Z] Running read-buildbot-config step. 09:48:47 INFO - Running pre-action listener: _resource_record_pre_action 09:48:47 INFO - Running main action method: read_buildbot_config 09:48:47 INFO - Using buildbot properties: 09:48:47 INFO - { 09:48:47 INFO - "project": "", 09:48:47 INFO - "product": "firefox", 09:48:47 INFO - "script_repo_revision": "production", 09:48:47 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 09:48:47 INFO - "repository": "", 09:48:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 09:48:47 INFO - "buildid": "20161117071828", 09:48:47 INFO - "pgo_build": "False", 09:48:47 INFO - "basedir": "/builds/slave/test", 09:48:47 INFO - "buildnumber": 18, 09:48:47 INFO - "slavename": "t-yosemite-r7-0185", 09:48:47 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 09:48:47 INFO - "platform": "yosemite_r7", 09:48:47 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:48:47 INFO - "branch": "mozilla-aurora", 09:48:47 INFO - "repo_path": "releases/mozilla-aurora", 09:48:47 INFO - "revision": "97f55b49a6d74b9e871a4cc0a8b3d793a5e9a27e", 09:48:47 INFO - "stage_platform": "macosx64", 09:48:47 INFO - "builduid": "01ff11ce07094d3287adcc597025b992", 09:48:47 INFO - "slavebuilddir": "test" 09:48:47 INFO - } 09:48:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/VL7YjAIOT3un8Cf23IFaEA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 09:48:47 INFO - Running post-action listener: _resource_record_post_action 09:48:47 INFO - [mozharness: 2016-11-17 17:48:47.203946Z] Finished read-buildbot-config step (success) 09:48:47 INFO - [mozharness: 2016-11-17 17:48:47.204084Z] Running download-and-extract step. 09:48:47 INFO - Running pre-action listener: _resource_record_pre_action 09:48:47 INFO - Running main action method: download_and_extract 09:48:47 INFO - mkdir: /builds/slave/test/build/tests 09:48: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')]} 09:48:47 INFO - trying https://queue.taskcluster.net/v1/task/VL7YjAIOT3un8Cf23IFaEA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 09:48:47 INFO - Downloading https://queue.taskcluster.net/v1/task/VL7YjAIOT3un8Cf23IFaEA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 09:48:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VL7YjAIOT3un8Cf23IFaEA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 09:48:48 INFO - Downloaded 1199 bytes. 09:48:48 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 09:48:48 INFO - Using the following test package requirements: 09:48:48 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 09:48:48 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:48:48 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 09:48:48 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:48:48 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 09:48:48 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:48:48 INFO - u'jsshell-mac.zip'], 09:48:48 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:48:48 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 09:48:48 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 09:48:48 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:48:48 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 09:48:48 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:48:48 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 09:48:48 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:48:48 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 09:48:48 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:48:48 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 09:48:48 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:48:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VL7YjAIOT3un8Cf23IFaEA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 09:48:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VL7YjAIOT3un8Cf23IFaEA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:48:48 INFO - Fetch https://queue.taskcluster.net/v1/task/VL7YjAIOT3un8Cf23IFaEA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 09:48:49 INFO - Http code: 200 09:48:49 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 09:48:49 INFO - x-amz-cf-id: -5DUlHqSVA5n9BF308tgyvYzGJrUOHnGyQjuLfgx5pRwp-6O4eLRIg== 09:48:49 INFO - x-amz-version-id: 7KlDgdNBQMvjk_WvDlAi17qmAYC5hvhg 09:48:49 INFO - Expected file size: 16327839 09:48:49 INFO - Obtained file size: 16327839 09:48:56 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:48:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VL7YjAIOT3un8Cf23IFaEA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 09:48:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VL7YjAIOT3un8Cf23IFaEA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:48:56 INFO - Fetch https://queue.taskcluster.net/v1/task/VL7YjAIOT3un8Cf23IFaEA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 09:48:56 INFO - Http code: 200 09:48:56 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 09:48:56 INFO - x-amz-cf-id: 7VS7YcHH31addqeygig59AaT-TMVMvxEvkGIQoMN_Imbib-i7wHewg== 09:48:56 INFO - x-amz-version-id: 7KlDgdNBQMvjk_WvDlAi17qmAYC5hvhg 09:48:57 INFO - Expected file size: 16327839 09:48:57 INFO - Obtained file size: 16327839 09:49:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VL7YjAIOT3un8Cf23IFaEA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 09:49:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VL7YjAIOT3un8Cf23IFaEA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:49:03 INFO - Fetch https://queue.taskcluster.net/v1/task/VL7YjAIOT3un8Cf23IFaEA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 09:49:04 INFO - Http code: 200 09:49:04 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 09:49:04 INFO - x-amz-cf-id: Fv-1GwxMnJghCDNyk_tVyvL9qzcRiDtLKh53T3c0dXGzwD-dyyhuFg== 09:49:04 INFO - x-amz-version-id: cDmN7Uwo7HKmqdBRHk9NxVXYPz_POGD9 09:49:04 INFO - Expected file size: 14409038 09:49:04 INFO - Obtained file size: 14409038 09:49: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')]} 09:49:04 INFO - trying https://queue.taskcluster.net/v1/task/VL7YjAIOT3un8Cf23IFaEA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 09:49:04 INFO - Downloading https://queue.taskcluster.net/v1/task/VL7YjAIOT3un8Cf23IFaEA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 09:49:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VL7YjAIOT3un8Cf23IFaEA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 09:49:08 INFO - Downloaded 114362106 bytes. 09:49:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VL7YjAIOT3un8Cf23IFaEA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 09:49:08 INFO - mkdir: /builds/slave/test/properties 09:49:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:49:08 INFO - Writing to file /builds/slave/test/properties/build_url 09:49:08 INFO - Contents: 09:49:08 INFO - build_url:https://queue.taskcluster.net/v1/task/VL7YjAIOT3un8Cf23IFaEA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 09:49:08 INFO - Running post-action listener: _resource_record_post_action 09:49:08 INFO - Running post-action listener: set_extra_try_arguments 09:49:08 INFO - [mozharness: 2016-11-17 17:49:08.925639Z] Finished download-and-extract step (success) 09:49:08 INFO - [mozharness: 2016-11-17 17:49:08.925802Z] Running populate-webroot step. 09:49:08 INFO - Running pre-action listener: _resource_record_pre_action 09:49:08 INFO - Running main action method: populate_webroot 09:49:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:49:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:49:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:49:08 INFO - '--tppagecycles', 09:49:08 INFO - '7'], 09:49:08 INFO - 'tests': ['tsvgm']}}, 09:49:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:49:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:49:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:49:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:49:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:49:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:49:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:08 INFO - 'talos_options': ['--disable-e10s'], 09:49:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:49:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:49:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:08 INFO - 'talos_options': ['--disable-e10s'], 09:49:08 INFO - 'tests': ['damp', 'tps']}, 09:49:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:08 INFO - 'tests': ['damp', 'tps']}, 09:49:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:49:08 INFO - 'tests': ['dromaeo_dom']}, 09:49:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:49:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:49:08 INFO - 'tests': ['basic_compositor_video']}, 09:49:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:49:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:49:08 INFO - 'tests': ['a11yr', 09:49:08 INFO - 'ts_paint', 09:49:08 INFO - 'tpaint', 09:49:08 INFO - 'sessionrestore', 09:49:08 INFO - 'sessionrestore_no_auto_restore', 09:49:08 INFO - 'tabpaint']}, 09:49:08 INFO - 'other-e10s': {'tests': ['a11yr', 09:49:08 INFO - 'ts_paint', 09:49:08 INFO - 'tpaint', 09:49:08 INFO - 'sessionrestore', 09:49:08 INFO - 'sessionrestore_no_auto_restore', 09:49:08 INFO - 'tabpaint']}, 09:49:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:49:08 INFO - 'ts_paint', 09:49:08 INFO - 'tpaint', 09:49:08 INFO - 'sessionrestore', 09:49:08 INFO - 'sessionrestore_no_auto_restore', 09:49:08 INFO - 'tabpaint']}, 09:49:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:49:08 INFO - 'ts_paint', 09:49:08 INFO - 'tpaint', 09:49:08 INFO - 'sessionrestore', 09:49:08 INFO - 'sessionrestore_no_auto_restore', 09:49:08 INFO - 'tabpaint']}, 09:49:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:49:08 INFO - 'tests': ['a11yr', 09:49:08 INFO - 'ts_paint', 09:49:08 INFO - 'tpaint', 09:49:08 INFO - 'sessionrestore', 09:49:08 INFO - 'sessionrestore_no_auto_restore', 09:49:08 INFO - 'tabpaint']}, 09:49:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:49:08 INFO - 'tests': ['a11yr', 09:49:08 INFO - 'ts_paint', 09:49:08 INFO - 'tpaint', 09:49:08 INFO - 'sessionrestore', 09:49:08 INFO - 'sessionrestore_no_auto_restore', 09:49:08 INFO - 'tabpaint']}, 09:49:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:49:08 INFO - 'tests': ['tsvgx', 09:49:08 INFO - 'tsvgr_opacity', 09:49:08 INFO - 'tart', 09:49:08 INFO - 'tscrollx', 09:49:08 INFO - 'cart']}, 09:49:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:49:08 INFO - 'tsvgr_opacity', 09:49:08 INFO - 'tart', 09:49:08 INFO - 'tscrollx', 09:49:08 INFO - 'cart']}, 09:49:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:08 INFO - 'talos_options': ['--disable-e10s'], 09:49:08 INFO - 'tests': ['tp5o']}, 09:49:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:08 INFO - 'tests': ['tp5o']}, 09:49:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:08 INFO - 'talos_options': ['--disable-e10s', 09:49:08 INFO - '--xperf_path', 09:49:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:49:08 INFO - 'tests': ['tp5n']}, 09:49:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:08 INFO - 'talos_options': ['--xperf_path', 09:49:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:49:08 INFO - 'tests': ['tp5n']}}, 09:49:08 INFO - 'talos.zip': {'path': '', 09:49:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:49:08 INFO - Running post-action listener: _resource_record_post_action 09:49:08 INFO - [mozharness: 2016-11-17 17:49:08.944683Z] Finished populate-webroot step (success) 09:49:08 INFO - [mozharness: 2016-11-17 17:49:08.944818Z] Running create-virtualenv step. 09:49:08 INFO - Running pre-action listener: _resource_record_pre_action 09:49:08 INFO - Running main action method: create_virtualenv 09:49:08 INFO - Creating virtualenv /builds/slave/test/build/venv 09:49:08 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 09:49:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:49:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:49:09 INFO - Using real prefix '/tools/python27' 09:49:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:49:09 INFO - Installing distribute.............................................................................................................................................................................................done. 09:49:12 INFO - Installing pip.................done. 09:49:12 INFO - Return code: 0 09:49:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:49:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:49:12 INFO - Reading from file tmpfile_stdout 09:49:12 INFO - Output received: 09:49:12 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) 09:49:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:12 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 0x1082f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10826c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcaa05aa0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810ad30>, '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 0x107f70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108102b20>, '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.wY3ovUFa2C/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.IJQSZAJE7Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 09:49:12 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 09:49:12 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 09:49:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wY3ovUFa2C/Render', 09:49:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:12 INFO - 'HOME': '/Users/cltbld', 09:49:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:12 INFO - 'LOGNAME': 'cltbld', 09:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:12 INFO - 'MOZ_NO_REMOTE': '1', 09:49:12 INFO - 'NO_EM_RESTART': '1', 09:49:12 INFO - 'PAGER': '/bin/cat', 09:49:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:12 INFO - 'PWD': '/builds/slave/test', 09:49:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:12 INFO - 'SHELL': '/bin/bash', 09:49:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJQSZAJE7Z/Listeners', 09:49:12 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 09:49:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:12 INFO - 'USER': 'cltbld', 09:49:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:12 INFO - 'XPC_FLAGS': '0x0', 09:49:12 INFO - 'XPC_SERVICE_NAME': '0', 09:49:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:13 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 09:49:13 INFO - Cleaning up... 09:49:13 INFO - Return code: 0 09:49:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1082f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10826c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcaa05aa0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810ad30>, '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 0x107f70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108102b20>, '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.wY3ovUFa2C/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.IJQSZAJE7Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 09:49:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:49:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:49:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wY3ovUFa2C/Render', 09:49:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:13 INFO - 'HOME': '/Users/cltbld', 09:49:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:13 INFO - 'LOGNAME': 'cltbld', 09:49:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:13 INFO - 'MOZ_NO_REMOTE': '1', 09:49:13 INFO - 'NO_EM_RESTART': '1', 09:49:13 INFO - 'PAGER': '/bin/cat', 09:49:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:13 INFO - 'PWD': '/builds/slave/test', 09:49:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:13 INFO - 'SHELL': '/bin/bash', 09:49:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJQSZAJE7Z/Listeners', 09:49:13 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 09:49:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:13 INFO - 'USER': 'cltbld', 09:49:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:13 INFO - 'XPC_FLAGS': '0x0', 09:49:13 INFO - 'XPC_SERVICE_NAME': '0', 09:49:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:13 INFO - Downloading/unpacking psutil>=3.1.1 09:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:49:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:17 INFO - Installing collected packages: psutil 09:49:17 INFO - Running setup.py install for psutil 09:49:17 INFO - building 'psutil._psutil_osx' extension 09:49:17 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 09:49:17 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 09:49:17 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 09:49:17 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 09:49:17 INFO - building 'psutil._psutil_posix' extension 09:49:17 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 09:49:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:49:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:49:17 INFO - ^ 09:49:18 INFO - 1 warning generated. 09:49:18 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 09:49:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:18 INFO - Successfully installed psutil 09:49:18 INFO - Cleaning up... 09:49:18 INFO - Return code: 0 09:49:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:49:18 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')]} 09:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:18 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')]} 09:49:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:18 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 0x1082f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10826c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcaa05aa0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810ad30>, '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 0x107f70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108102b20>, '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.wY3ovUFa2C/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.IJQSZAJE7Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 09:49:18 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 09:49:18 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 09:49:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wY3ovUFa2C/Render', 09:49:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:18 INFO - 'HOME': '/Users/cltbld', 09:49:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:18 INFO - 'LOGNAME': 'cltbld', 09:49:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:18 INFO - 'MOZ_NO_REMOTE': '1', 09:49:18 INFO - 'NO_EM_RESTART': '1', 09:49:18 INFO - 'PAGER': '/bin/cat', 09:49:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:18 INFO - 'PWD': '/builds/slave/test', 09:49:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:18 INFO - 'SHELL': '/bin/bash', 09:49:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJQSZAJE7Z/Listeners', 09:49:18 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 09:49:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:18 INFO - 'USER': 'cltbld', 09:49:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:18 INFO - 'XPC_FLAGS': '0x0', 09:49:18 INFO - 'XPC_SERVICE_NAME': '0', 09:49:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:49:18 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 09:49:18 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 09:49:18 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 09:49:18 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 09:49:18 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 09:49:18 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 09:49:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:49:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:49:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:49:21 INFO - Installing collected packages: mozsystemmonitor 09:49:21 INFO - Running setup.py install for mozsystemmonitor 09:49:21 INFO - Successfully installed mozsystemmonitor 09:49:21 INFO - Cleaning up... 09:49:21 INFO - Return code: 0 09:49:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:49:21 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')]} 09:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:21 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')]} 09:49:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:21 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 0x1082f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10826c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcaa05aa0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810ad30>, '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 0x107f70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108102b20>, '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.wY3ovUFa2C/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.IJQSZAJE7Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 09:49:21 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 09:49:21 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 09:49:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wY3ovUFa2C/Render', 09:49:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:21 INFO - 'HOME': '/Users/cltbld', 09:49:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:21 INFO - 'LOGNAME': 'cltbld', 09:49:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:21 INFO - 'MOZ_NO_REMOTE': '1', 09:49:21 INFO - 'NO_EM_RESTART': '1', 09:49:21 INFO - 'PAGER': '/bin/cat', 09:49:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:21 INFO - 'PWD': '/builds/slave/test', 09:49:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:21 INFO - 'SHELL': '/bin/bash', 09:49:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJQSZAJE7Z/Listeners', 09:49:21 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 09:49:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:21 INFO - 'USER': 'cltbld', 09:49:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:21 INFO - 'XPC_FLAGS': '0x0', 09:49:21 INFO - 'XPC_SERVICE_NAME': '0', 09:49:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:21 INFO - Downloading/unpacking jsonschema==2.5.1 09:49:21 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 09:49:21 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 09:49:21 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 09:49:21 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 09:49:21 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 09:49:21 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 09:49:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:49:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:49:24 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 09:49:24 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 09:49:24 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 09:49:24 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 09:49:24 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 09:49:24 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 09:49:24 INFO - Downloading functools32-3.2.3-2.tar.gz 09:49:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:49:24 INFO - warning: no files found matching '*.txt' 09:49:24 INFO - no previously-included directories found matching 'build' 09:49:24 INFO - no previously-included directories found matching 'dist' 09:49:24 INFO - no previously-included directories found matching '.git*' 09:49:24 INFO - Installing collected packages: jsonschema, functools32 09:49:24 INFO - Running setup.py install for functools32 09:49:24 INFO - warning: no files found matching '*.txt' 09:49:24 INFO - no previously-included directories found matching 'build' 09:49:24 INFO - no previously-included directories found matching 'dist' 09:49:24 INFO - no previously-included directories found matching '.git*' 09:49:25 INFO - Successfully installed jsonschema functools32 09:49:25 INFO - Cleaning up... 09:49:25 INFO - Return code: 0 09:49:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:49:25 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')]} 09:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:25 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')]} 09:49:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:25 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 0x1082f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10826c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcaa05aa0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810ad30>, '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 0x107f70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108102b20>, '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.wY3ovUFa2C/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.IJQSZAJE7Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 09:49:25 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 09:49:25 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 09:49:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wY3ovUFa2C/Render', 09:49:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:25 INFO - 'HOME': '/Users/cltbld', 09:49:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:25 INFO - 'LOGNAME': 'cltbld', 09:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:25 INFO - 'MOZ_NO_REMOTE': '1', 09:49:25 INFO - 'NO_EM_RESTART': '1', 09:49:25 INFO - 'PAGER': '/bin/cat', 09:49:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:25 INFO - 'PWD': '/builds/slave/test', 09:49:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:25 INFO - 'SHELL': '/bin/bash', 09:49:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJQSZAJE7Z/Listeners', 09:49:25 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 09:49:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:25 INFO - 'USER': 'cltbld', 09:49:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:25 INFO - 'XPC_FLAGS': '0x0', 09:49:25 INFO - 'XPC_SERVICE_NAME': '0', 09:49:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:49:25 INFO - Cleaning up... 09:49:25 INFO - Return code: 0 09:49:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:49:25 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')]} 09:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:25 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')]} 09:49:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:25 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 0x1082f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10826c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcaa05aa0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810ad30>, '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 0x107f70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108102b20>, '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.wY3ovUFa2C/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.IJQSZAJE7Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 09:49:25 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 09:49:25 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 09:49:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wY3ovUFa2C/Render', 09:49:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:25 INFO - 'HOME': '/Users/cltbld', 09:49:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:25 INFO - 'LOGNAME': 'cltbld', 09:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:25 INFO - 'MOZ_NO_REMOTE': '1', 09:49:25 INFO - 'NO_EM_RESTART': '1', 09:49:25 INFO - 'PAGER': '/bin/cat', 09:49:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:25 INFO - 'PWD': '/builds/slave/test', 09:49:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:25 INFO - 'SHELL': '/bin/bash', 09:49:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJQSZAJE7Z/Listeners', 09:49:25 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 09:49:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:25 INFO - 'USER': 'cltbld', 09:49:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:25 INFO - 'XPC_FLAGS': '0x0', 09:49:25 INFO - 'XPC_SERVICE_NAME': '0', 09:49:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:25 INFO - Downloading/unpacking blobuploader==1.2.4 09:49:25 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 09:49:25 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 09:49:25 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 09:49:25 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 09:49:25 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 09:49:25 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 09:49:28 INFO - Downloading blobuploader-1.2.4.tar.gz 09:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:49:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:49:28 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 09:49:28 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 09:49:28 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 09:49:28 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 09:49:28 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 09:49:28 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 09:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:49:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:49:28 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 09:49:28 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 09:49:28 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 09:49:28 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 09:49:28 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 09:49:28 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 09:49:29 INFO - Downloading docopt-0.6.1.tar.gz 09:49:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:49:29 INFO - Installing collected packages: blobuploader, requests, docopt 09:49:29 INFO - Running setup.py install for blobuploader 09:49:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:49:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:49:29 INFO - Running setup.py install for requests 09:49:30 INFO - Running setup.py install for docopt 09:49:30 INFO - Successfully installed blobuploader requests docopt 09:49:30 INFO - Cleaning up... 09:49:30 INFO - Return code: 0 09:49:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:30 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 0x1082f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10826c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcaa05aa0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810ad30>, '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 0x107f70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108102b20>, '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.wY3ovUFa2C/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.IJQSZAJE7Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 09:49:30 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 09:49:30 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 09:49:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wY3ovUFa2C/Render', 09:49:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:30 INFO - 'HOME': '/Users/cltbld', 09:49:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:30 INFO - 'LOGNAME': 'cltbld', 09:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:30 INFO - 'MOZ_NO_REMOTE': '1', 09:49:30 INFO - 'NO_EM_RESTART': '1', 09:49:30 INFO - 'PAGER': '/bin/cat', 09:49:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:30 INFO - 'PWD': '/builds/slave/test', 09:49:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:30 INFO - 'SHELL': '/bin/bash', 09:49:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJQSZAJE7Z/Listeners', 09:49:30 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 09:49:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:30 INFO - 'USER': 'cltbld', 09:49:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:30 INFO - 'XPC_FLAGS': '0x0', 09:49:30 INFO - 'XPC_SERVICE_NAME': '0', 09:49:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:49:30 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-nK1TMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:49:30 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-xUOPGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:49:30 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-ikD_HU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:49:30 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-KCvmfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:49:30 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-Ijdpgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:49:31 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-NkxeFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:49:31 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-TfcMew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:49:31 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-KBmJOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:49:31 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-V2wL0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:49:31 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-SMLHsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:49:31 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-21wmsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:49:31 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-4jufXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:49:31 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-lAD7TS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:49:31 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-0TcoXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:31 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-3AGACD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:49:32 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-l_1xrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:49:32 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-9FjMqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:49:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:49:32 INFO - Running setup.py install for manifestparser 09:49:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:49:32 INFO - Running setup.py install for mozcrash 09:49:32 INFO - Running setup.py install for mozdebug 09:49:32 INFO - Running setup.py install for mozdevice 09:49:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:49:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:49:32 INFO - Running setup.py install for mozfile 09:49:33 INFO - Running setup.py install for mozhttpd 09:49:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:49:33 INFO - Running setup.py install for mozinfo 09:49:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:49:33 INFO - Running setup.py install for mozInstall 09:49:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:49:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:49:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:49:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:49:33 INFO - Running setup.py install for mozleak 09:49:33 INFO - Running setup.py install for mozlog 09:49:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:49:33 INFO - Running setup.py install for moznetwork 09:49:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:49:33 INFO - Running setup.py install for mozprocess 09:49:34 INFO - Running setup.py install for mozprofile 09:49:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:49:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:49:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:49:34 INFO - Running setup.py install for mozrunner 09:49:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:49:34 INFO - Running setup.py install for mozscreenshot 09:49:34 INFO - Running setup.py install for moztest 09:49:34 INFO - Running setup.py install for mozversion 09:49:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:49:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:49:34 INFO - Cleaning up... 09:49:34 INFO - Return code: 0 09:49:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:34 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 0x1082f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10826c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcaa05aa0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810ad30>, '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 0x107f70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108102b20>, '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.wY3ovUFa2C/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.IJQSZAJE7Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 09:49:34 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 09:49:34 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 09:49:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wY3ovUFa2C/Render', 09:49:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:34 INFO - 'HOME': '/Users/cltbld', 09:49:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:34 INFO - 'LOGNAME': 'cltbld', 09:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:34 INFO - 'MOZ_NO_REMOTE': '1', 09:49:34 INFO - 'NO_EM_RESTART': '1', 09:49:34 INFO - 'PAGER': '/bin/cat', 09:49:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:34 INFO - 'PWD': '/builds/slave/test', 09:49:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:34 INFO - 'SHELL': '/bin/bash', 09:49:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJQSZAJE7Z/Listeners', 09:49:34 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 09:49:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:34 INFO - 'USER': 'cltbld', 09:49:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:34 INFO - 'XPC_FLAGS': '0x0', 09:49:34 INFO - 'XPC_SERVICE_NAME': '0', 09:49:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:49:35 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-eGegI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:49:35 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)) 09:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:49:35 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-ffQX0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:49:35 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)) 09:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:49:35 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-tNZXst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:49:35 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)) 09:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:49:35 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-nMshGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:49:35 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-SCHR82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:49:35 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)) 09:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:49:35 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-UMUWRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:49:35 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)) 09:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:49:35 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-Mi8hVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:49:35 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)) 09:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:49:35 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-gWDN70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:49:35 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)) 09:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:49:35 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-6TidIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:49:36 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)) 09:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:49:36 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-ZNPR4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:49:36 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)) 09:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:49:36 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-O5LF0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:49:36 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)) 09:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:49:36 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-H_HRfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:49:36 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-XsrO4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:49:36 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)) 09:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:49:36 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-g83Cfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:49:36 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)) 09:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:36 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-s683e2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:36 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)) 09:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:49:36 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-YflTqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:49:36 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-OClWiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:49:36 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)) 09:49:36 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)) 09:49:36 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)) 09:49:36 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)) 09:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:49:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:49:36 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 09:49:36 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 09:49:36 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 09:49:36 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 09:49:36 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 09:49:36 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 09:49:39 INFO - Downloading blessings-1.6.tar.gz 09:49:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:49:39 INFO - Installing collected packages: blessings 09:49:39 INFO - Running setup.py install for blessings 09:49:39 INFO - Successfully installed blessings 09:49:39 INFO - Cleaning up... 09:49:39 INFO - Return code: 0 09:49:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:49:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:49:40 INFO - Reading from file tmpfile_stdout 09:49:40 INFO - Current package versions: 09:49:40 INFO - blessings == 1.6 09:49:40 INFO - blobuploader == 1.2.4 09:49:40 INFO - docopt == 0.6.1 09:49:40 INFO - functools32 == 3.2.3-2 09:49:40 INFO - jsonschema == 2.5.1 09:49:40 INFO - manifestparser == 1.1 09:49:40 INFO - mozInstall == 1.12 09:49:40 INFO - mozcrash == 1.0 09:49:40 INFO - mozdebug == 0.1 09:49:40 INFO - mozdevice == 0.48 09:49:40 INFO - mozfile == 1.2 09:49:40 INFO - mozhttpd == 0.7 09:49:40 INFO - mozinfo == 0.9 09:49:40 INFO - mozleak == 0.1 09:49:40 INFO - mozlog == 3.4 09:49:40 INFO - moznetwork == 0.27 09:49:40 INFO - mozprocess == 0.23 09:49:40 INFO - mozprofile == 0.28 09:49:40 INFO - mozrunner == 6.13 09:49:40 INFO - mozscreenshot == 0.1 09:49:40 INFO - mozsystemmonitor == 0.3 09:49:40 INFO - moztest == 0.7 09:49:40 INFO - mozversion == 1.4 09:49:40 INFO - psutil == 3.1.1 09:49:40 INFO - requests == 1.2.3 09:49:40 INFO - wsgiref == 0.1.2 09:49:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49: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')]} 09:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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')]} 09:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:40 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 0x1082f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10826c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcaa05aa0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810ad30>, '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 0x107f70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108102b20>, '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.wY3ovUFa2C/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.IJQSZAJE7Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 09:49:40 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 09:49:40 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 09:49:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wY3ovUFa2C/Render', 09:49:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:40 INFO - 'HOME': '/Users/cltbld', 09:49:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:40 INFO - 'LOGNAME': 'cltbld', 09:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:40 INFO - 'MOZ_NO_REMOTE': '1', 09:49:40 INFO - 'NO_EM_RESTART': '1', 09:49:40 INFO - 'PAGER': '/bin/cat', 09:49:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:40 INFO - 'PWD': '/builds/slave/test', 09:49:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:40 INFO - 'SHELL': '/bin/bash', 09:49:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJQSZAJE7Z/Listeners', 09:49:40 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 09:49:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:40 INFO - 'USER': 'cltbld', 09:49:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:40 INFO - 'XPC_FLAGS': '0x0', 09:49:40 INFO - 'XPC_SERVICE_NAME': '0', 09:49:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:41 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)) 09:49:41 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)) 09:49:41 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)) 09:49:41 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)) 09:49:41 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)) 09:49:41 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)) 09:49:41 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)) 09:49:41 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)) 09:49:41 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)) 09:49:41 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)) 09:49:41 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)) 09:49:41 INFO - Cleaning up... 09:49:41 INFO - Return code: 0 09:49:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:41 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 0x1082f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10826c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcaa05aa0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810ad30>, '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 0x107f70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108102b20>, '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.wY3ovUFa2C/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.IJQSZAJE7Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 09:49:41 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 09:49:41 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 09:49:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wY3ovUFa2C/Render', 09:49:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:41 INFO - 'HOME': '/Users/cltbld', 09:49:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:41 INFO - 'LOGNAME': 'cltbld', 09:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:41 INFO - 'MOZ_NO_REMOTE': '1', 09:49:41 INFO - 'NO_EM_RESTART': '1', 09:49:41 INFO - 'PAGER': '/bin/cat', 09:49:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:41 INFO - 'PWD': '/builds/slave/test', 09:49:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:41 INFO - 'SHELL': '/bin/bash', 09:49:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJQSZAJE7Z/Listeners', 09:49:41 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 09:49:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:41 INFO - 'USER': 'cltbld', 09:49:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:41 INFO - 'XPC_FLAGS': '0x0', 09:49:41 INFO - 'XPC_SERVICE_NAME': '0', 09:49:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:49:41 INFO - Cleaning up... 09:49:41 INFO - Return code: 0 09:49:41 INFO - Running post-action listener: _resource_record_post_action 09:49:41 INFO - Running post-action listener: _start_resource_monitoring 09:49:41 INFO - Starting resource monitoring. 09:49:41 INFO - [mozharness: 2016-11-17 17:49:41.912963Z] Finished create-virtualenv step (success) 09:49:41 INFO - [mozharness: 2016-11-17 17:49:41.913923Z] Running install step. 09:49:41 INFO - Running pre-action listener: _resource_record_pre_action 09:49:41 INFO - Running main action method: install 09:49:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:49:42 INFO - Reading from file tmpfile_stdout 09:49:42 INFO - Detecting whether we're running mozinstall >=1.0... 09:49:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:49:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:49:42 INFO - Reading from file tmpfile_stdout 09:49:42 INFO - Output received: 09:49:42 INFO - Usage: mozinstall [options] installer 09:49:42 INFO - Options: 09:49:42 INFO - -h, --help show this help message and exit 09:49:42 INFO - -d DEST, --destination=DEST 09:49:42 INFO - Directory to install application into. [default: 09:49:42 INFO - "/builds/slave/test"] 09:49:42 INFO - --app=APP Application being installed. [default: firefox] 09:49:42 INFO - mkdir: /builds/slave/test/build/application 09:49:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:49:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:50:14 INFO - Reading from file tmpfile_stdout 09:50:14 INFO - Output received: 09:50:14 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:50:14 INFO - Running post-action listener: _resource_record_post_action 09:50:14 INFO - [mozharness: 2016-11-17 17:50:14.032040Z] Finished install step (success) 09:50:14 INFO - [mozharness: 2016-11-17 17:50:14.032154Z] Running run-tests step. 09:50:14 INFO - Running pre-action listener: _resource_record_pre_action 09:50:14 INFO - Running main action method: run_tests 09:50:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:50:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:50:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:50:14 INFO - 2016-11-17 09:50:14.046 screenresolution[1621:7396] starting screenresolution argv=screenresolution get 09:50:14 INFO - 2016-11-17 09:50:14.049 screenresolution[1621:7396] Display 0: 1600x1200x32@60 09:50:14 INFO - 2016-11-17 09:50:14.055 screenresolution[1622:7398] starting screenresolution argv=screenresolution list 09:50:14 INFO - Available Modes on Display 0 09:50:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:50:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:50:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:50:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:50:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:50:14 INFO - Intel Iris: 09:50:14 INFO - Chipset Model: Intel Iris 09:50:14 INFO - Type: GPU 09:50:14 INFO - Bus: Built-In 09:50:14 INFO - VRAM (Dynamic, Max): 1536 MB 09:50:14 INFO - Vendor: Intel (0x8086) 09:50:14 INFO - Device ID: 0x0a2e 09:50:14 INFO - Revision ID: 0x0009 09:50:14 INFO - Displays: 09:50:14 INFO - Display: 09:50:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:50:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:50:14 INFO - Display Serial Number: 1600x1200 60 09:50:14 INFO - Main Display: Yes 09:50:14 INFO - Mirror: Off 09:50:14 INFO - Online: Yes 09:50:14 INFO - Rotation: Supported 09:50:14 INFO - Return code: 0 09:50:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:50:14 INFO - Python 2.7.3 09:50:14 INFO - Return code: 0 09:50:14 INFO - grabbing minidump binary from tooltool 09:50: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')]} 09:50:14 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 0x10810ad30>, '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 0x107f70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108102b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:50:14 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 09:50:14 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 09:50:14 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 09:50:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:50:14 INFO - Return code: 0 09:50:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:50:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:50:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:50:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:50:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:50:14 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/VL7YjAIOT3un8Cf23IFaEA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0185', '--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 09:50:14 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/VL7YjAIOT3un8Cf23IFaEA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0185 --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 09:50:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wY3ovUFa2C/Render', 09:50:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:14 INFO - 'HOME': '/Users/cltbld', 09:50:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:14 INFO - 'LOGNAME': 'cltbld', 09:50:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:50:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:50:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:14 INFO - 'MOZ_NO_REMOTE': '1', 09:50:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:50:14 INFO - 'NO_EM_RESTART': '1', 09:50:14 INFO - 'PAGER': '/bin/cat', 09:50:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:14 INFO - 'PWD': '/builds/slave/test', 09:50:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:50:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:14 INFO - 'SHELL': '/bin/bash', 09:50:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJQSZAJE7Z/Listeners', 09:50:14 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 09:50:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:14 INFO - 'USER': 'cltbld', 09:50:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:14 INFO - 'XPC_FLAGS': '0x0', 09:50:14 INFO - 'XPC_SERVICE_NAME': '0', 09:50:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:14 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/VL7YjAIOT3un8Cf23IFaEA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0185', '--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 09:50:14 INFO - mozversion application_buildid: 20161117071828 09:50:14 INFO - mozversion application_changeset: 97f55b49a6d74b9e871a4cc0a8b3d793a5e9a27e 09:50:14 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:50:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:50:14 INFO - mozversion application_name: Firefox 09:50:14 INFO - mozversion application_remotingname: firefox-dev 09:50:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:50:14 INFO - mozversion application_vendor: Mozilla 09:50:14 INFO - mozversion application_version: 52.0a2 09:50:14 INFO - mozversion platform_buildid: 20161117071828 09:50:14 INFO - mozversion platform_changeset: 97f55b49a6d74b9e871a4cc0a8b3d793a5e9a27e 09:50:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:50:14 INFO - mozversion platform_version: 52.0a2 09:50:14 INFO - using testdate: 1479405014 09:50:14 INFO - actual date: 1479405014 09:50:14 INFO - starting webserver on 'localhost:49246' 09:50:14 INFO - SUITE-START | Running 2 tests 09:50:14 INFO - TEST-START | dromaeo_css 09:50:14 INFO - operating with platform_type : mac_ 09:50:14 INFO - Initialising browser for dromaeo_css test... 09:50:14 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpr7KwrT/profile http://localhost:49246/getInfo.html) 09:50:16 ERROR - PROCESS | 1632 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 09:50:17 INFO - PROCESS | 1632 | __metrics Screen width/height:1600/1200 09:50:17 INFO - PROCESS | 1632 | colorDepth:24 09:50:17 INFO - PROCESS | 1632 | Browser inner width/height: 1024/689 09:50:17 INFO - PROCESS | 1632 | __metrics 09:50:17 ERROR - PROCESS | 1632 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 09:50:18 INFO - TEST-INFO | 1632: exit 0 09:50:18 INFO - Browser initialized. 09:50:18 INFO - Running cycle 1/1 for dromaeo_css test... 09:50:18 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpr7KwrT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:50:30 INFO - PROCESS | 1635 | RSS: Main: 223764480 09:50:30 INFO - PROCESS | 1635 | 09:51:20 INFO - PROCESS | 1635 | 1479405080228 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:53:32 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 09:53:35 INFO - PROCESS | 1635 | RSS: Main: 236527616 09:53:35 INFO - PROCESS | 1635 | 09:56:37 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 09:56:37 INFO - PROCESS | 1635 | RSS: Main: 244670464 09:56:37 INFO - PROCESS | 1635 | 09:59:39 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 09:59:40 INFO - PROCESS | 1635 | RSS: Main: 247746560 09:59:40 INFO - PROCESS | 1635 | 10:02:42 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 10:02:43 INFO - PROCESS | 1635 | RSS: Main: 246931456 10:02:43 INFO - PROCESS | 1635 | 10:05:45 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 10:05:46 INFO - PROCESS | 1635 | RSS: Main: 250368000 10:05:46 INFO - PROCESS | 1635 | 10:08:49 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 10:08:49 INFO - PROCESS | 1635 | RSS: Main: 251629568 10:08:49 INFO - PROCESS | 1635 | 10:08:49 INFO - PROCESS | 1635 | __start_tp_report 10:08:49 INFO - PROCESS | 1635 | _x_x_mozilla_page_load 10:08:49 INFO - PROCESS | 1635 | _x_x_mozilla_page_load_details 10:08:49 INFO - PROCESS | 1635 | |i|pagename|runs| 10:08:49 INFO - PROCESS | 1635 | |0;dojo.html;2702.7162147974473;2842.8010039297246;3365.663433656634;3367.444371678673;3399.796012239264;5584.329880414351;5618.297712785902;5638.661680299175;5648.576356773238;5649.6327738697055;5631.1271752878265;5634.549236061115;5636.633618814774;5646.604737668365;5653.265075540185;5128.794733237705;5129.230615407681;5157.149070403398;5189.355526803509;5262.131748261551;5145.897082058356;5179.559737422323;5190.636655434121;5205.895882082356;5239.711815850127;5073.289739436482;5078.542931136197;5199.896002079956;5200.583953283747;5242.266082748418;5111.846644600668;5114.079465696192;5175.120229560946;5239.21411788231;5280.894382112375;5144.305518754958;5166.483351664841;5177.559907407875;5183.896322073538;5183.948160518422;5483.616146869721;5618.185363122325;5629.183768353607;5691.943080569225;5696.487316141525;6066.726997285133;6083.057126145454;6102.481289090432;6113.567524283673;6125.540694081788;6123.740204357194;6144.678894037804;6178.5366097542865;6200.224971878515;6252.968735156341;5819.098039803837;5834.708264586754;5846.123081537761;5846.766129354778;5861.413858614147;6086.1175129606845;6111.98679349419;6126.417990290915;6165.5375846810775;6200.56596038282;6002.159697642333;6037.366076561985;6042.033274676119;6073.997790364629;6121.96939015311;6179.69101544921;6180.002698691132;6181.289151747516;6200.596961197508;6203.069539569011;5960.970195148997;6144.262688477322;6160;6166.506679465632;6175.289841668266;6080.543959203077;6115.635867915819;6119.015143218386;6125.876495711566;6150.569460137747;3977.8607748728655;4850.83022094225;4861.781219845045;4870.172070747982;4890.877728056756;3649.379605467077;3680.705543556509;3811.294910441577;4409.625181859514;4445.51099379068;5231.476852314738;5727.599068065196;5760.971195144081;5932.644041357532;5938.346781853993;4990.2764099205415;6126.30393285589;6132.264128304543;6169.383061693885;6178.104174894615;5678.318601767732;5889.4699477046415;5904.852378690567;5921.496672782861;5943.762249510058;4436.245838207513;5252.1596544552685;5314.893702125936;5320.388155362106;5338.092524270884;6139.829471381323;6140.416660417253;6142.253225532511;6149.108379285068;6151.6001459904965;6161.938380616137;6223.128761973237;6229;6240.095186197885;6246.718897649525;6112.0171844544475;6131.325554189125;6139.154842350836;6150.507959363151;6216.595921265103;4958.628102892226;6149.2620885494025;6154.076888466587;6164.599301045418;6171.9074213887725;6209.720562574605;6211.16149319836;6226.470749986302;6226.813195604139;6228.096925945803;5543.417941116125;5850.678212698343;5942.138389933349;6023.337432882292;6039.486643635164;5992.13114098462;6006.429389208019;6009.87980240384;6015.909761353496;6030.005049166838;5753.71231438418;5791.160281759206;5836.795712150054;5866.706664666664;5883.882322353615;5947.31605865331;5979.402059793986;5998.130271110577;6000.699965001645;6109.053096770008;5906.055031194988;5925.733341999534;5933.881322373615;5960.046392577166;5965.701714914324 10:08:49 INFO - PROCESS | 1635 | |1;ext.html;475.5221002892093;480.2316293929713;481.57621293261934;481.79282908349404;530.7770736290757;31771;36765.44851827225;39536.802315988454;39576.60423395765;39604.60395396045;39619.811405657805;40159.79520614379;40202.19595608086;40234.59765402345;40261.798691006574;7952.840943181133;9199.080091990798;9355.345125841193;9388.530573471333;9410.52947352633;9339.626414943394;9363.57863896123;9372.062793720608;9430.811383772321;9452.57463414148;9412.105849944244;9436.292278079138;9442.716718498456;9448.716538503855;9456;9368.2973776967;9428.245740340824;9441.386309889835;9444.952775236148;9462.57418416173;9215.815683686289;9253.6298548058;9296.116868897443;9334.486603236819;9337.29970252227;38592.80703596464;38726.80636596799;38754.8373548794;38890.61109388898;38955.22089558193;3360.1095709636966;3477.374072666919;3482.89551313461;3522.8766993155373;3712.0905378182247;29087;29729.851350743324;29945.550816737767;30131.945381911526;30691.846540767376;2522.7225005249593;3156.6527681954967;3164.5727826743555;3227.2738633807207;3240.96759032409;443100;495303;516366;521067;524669;62372;63766;63903;63908.721825563225;64059;69117.65441172762;69156.30843691499;69396;69582;69826;16459.094749788877;16686.49940501787;16714.832851671326;16714.83285167157;16747.413840515524;12566.434510447052;12692.682682933;12696.492140314283;12703.872961270454;12726.618201453972;18535.35126270601;20114;20116.19535218604;20138.798612013692;20180.89005104704;8295.792605184919;8378.958105209435;8381.119982401882;8428.873566896502;8454.788630284169;860.3805260212637;968.9612415503301;970.8009857979098;1007.6573964851985;1069.2889228663007;29654.851725741664;29830.40339193204;30066;30302.69697303043;32091.839540802146;920.636348642296;1015.5176291261591;1048.7063622185801;1080.206048554312;1116.4808364110727;12680.873191268154;14380;15006.099634021994;15174.848251517564;15465.845341546665;709273;713422;716611;717187;718323;55107.897842042934;55286.723566382716;55583.722081390144;55600.721996390566;55661.88676226453;1350.6960933790015;1354.2619272496513;1354.3972932045342;1377.0360747476807;1378.8138601288697;26962.32594185161;28564.57153142663;29315.472496264294;29455;29768.255793604465;49123;49972.75013624909;49999.75000124976;50156;50185.24722129244;639409;639533;640352;640921;641828;25881;26464.0737574184;26763.464730705666;26768.59847102334;26845.597316039883;44178.55821441745;44231.33652995272;44472.11055778931;44758.55241447674;45124.77437612791;36902.26195476129;37167.25665486729;37233.25533489261;38150.42774358443;38301;27295.72704272932;35424.46863297001;35664.465033024004;37015.629843701216;37139.88580342594;31159.221019474695;33532.664673352956;34700.65299346974;36553.81723091367;36668.81665591655;31384.529232061082;32066;33510.66489335075;33598.49602255919;33627;22190.889045554668;22538.549229015654;24848.751512485367;25397.492050159264;25497.49005019852 10:08:49 INFO - PROCESS | 1635 | |2;jquery.html;378.1095520050283;378.9564200116987;386.6442872557248;390.52551150352315;405.30085602335976;18406.44780656579;20076.698849517234;20082.799172008275;20088.899555502237;20201.59596808063;19729.30947416837;20233.797662023375;20425.795742042574;20610.48473788156;20871.582568348626;5174.870628234286;5566.276384070085;5704.914426283609;5941.257342832146;6018.729157187937;5868;5916.497097746696;5935.554833387491;5936.317323507808;5947.197128387677;5650.321961364642;5873.765049398019;5904.7047647617665;5913.763449462016;5917.408259174092;5642.181883626851;5872.324682661484;5896.204012458306;5931.199288096095;5939.4654481096695;5024.949750502485;5078.7460626968505;5091.5672167865405;5094.566961808251;5121.334226550562;18661.440156795317;21734.673979890315;22114.88942555277;22181.77818221813;24487.632685509732;2211.635080211763;2212.5021870079263;2285.8628482291115;2440.4386990991993;2825.2513084032544;15441.30514126867;15462.072275663384;15536.766948495782;15901.443449479213;16054.438094666748;1568.5294411676452;1757.79785324688;1801.8198180182007;1892.7823300320501;1935.4677463697456;87165.56417217937;91826.5408672959;112124.4393778034;112358;113056.30415543774;8748.69379571712;10878.292910960763;10974.615888443866;11365.488553015135;11384.316940983568;13892.374843132084;13923.094998825043;13963.65090872716;14041.087329323562;14092.718145637235;8516.531590762568;8655.6970506032;8667.4366166199;8751.256143227769;8779.956100219459;8617.267532259702;8617.267532259702;8647.048824629286;8699.652013919498;8719.302455803521;5585.3297604287745;6649.567778094409;6738.561993470506;6740.427063699641;6799.762008329685;1745.598512342143;1840.3650740494509;1863.4689113602558;1863.7390765292869;1864.9813501865078;906.6781292641149;914.2640174659463;925.4863550729275;1030.3560274828233;1035.6271742172812;16430.83569164317;21134.365969020953;21350.78649213519;21570.892145539172;21690.566188676137;926.754410081329;952.2857856607544;968.3560432312574;970.3110791338088;1019.6889948565611;10294.691159265234;10770.407627580558;11513.827292590451;11561.30632162073;11623.476943537562;622688;626138;632675;635030;637680;70915;72430.63784681042;96528;110220;117274.41362793303;959.4866746290841;989.7030890732751;1013.1388319928002;1015.2892974917587;1015.8577799108131;15989.401059893917;17662;19059.523511912314;19099.522511937314;19215.32746353871;36410.907672769856;43735;53731.731341343046;54153.729231353595;54250.101246456186;73320;78754.60622696849;80206.59896700479;80711;81528.77706834521;6849.315068493111;7886.68453261886;7913.248241417056;8074.475159114639;8166.060902995994;10354.792904142025;11641;12353.505859765508;12690.302033387883;12741.426635801596;10422.478876056015;10713.946430267799;10913.454327283445;10988.120950324115;11168.162387820783;10450.843237351293;10770.353778773298;10885.945570272099;10968.945155274172;11048.779024419628;10714.624988125379;10826.56693732242;11313.377764223047;11348;11404.885951140383;7921.089074756246;8024.638891250024;8098.75703728889;8164.020317561931;8338.207870252316;8816.779580510538;10533.789324213627;10793.244472887136;11018.228723989243;11058.778824423305 10:08:49 INFO - PROCESS | 1635 | |3;mootools.html;1375.972480550389;1475.9631009224768;1495.7457232270515;1771.7962434320057;1787.9642407151857;7534.698612055525;7772.922270777304;8044;8463.4075614707;8505.702300419487;7917.881231781528;8206.91793082069;8246.46397984132;8382.161783821615;8390.62242199101;2281.3954302109914;2316.224064938248;2320.535892821434;2323.6514522821544;2328.906843726249;2333.789958903707;2347.753485883983;2373.086361750721;2376.120835290945;2379.821513386494;1925.682262426698;2307.9423014424688;2320.0255892525097;2327.627579587258;2346.038124369009;2273.2498275569105;2275.0785931697524;2298.092253559851;2298.804601608865;2301.160076572056;1903.4004288649032;1925.8555608329432;2339.169594793858;2347.507023525062;2351.8005817033263;8290.08809031006;8329.875051874227;8390.958045209796;8396.664133434655;8420.073791882887;5035.395752509722;5181.637285389987;5193.246979187997;5195.532402083831;5200.76596553156;3247.6752324767335;3332.916677083068;3576.0344706929245;3578.248567800765;3579.977312818249;1053.4469403563191;1054.6308791922843;1092.9234953553255;1104.436737263993;1109.9334039957628;10843.295185812896;10853.34879907208;10860.67417977462;10952.945235273774;10966.835497467544;3670.7063434925144;4536.97731511347;4643.419572553431;4646.001109761418;4669.929951050737;8646.962364516172;9355.578998945064;9385.671501497414;9386.296027797805;9443.716688499357;5116.053530096944;5124.282600435942;5150.407703114115;5158.716270605078;5164.018836421068;4269;4389.714668546534;4538.795754191069;4732.95267047332;4749.667523273407;3831.731778775459;3851.114243723959;3909.198614284065;3950.6049395060263;3980.641742243212;1249.775040492702;1278.0925542864484;1279.9168054076456;1290.4386591832583;1293.9870601293867;762.2529920677656;850.3069997951774;897.6633762339122;907.8138981508774;918.8805455290903;5469.535089517435;5475.233467314579;5540.085885828874;5702.486776190163;5852.853678658068;965;984.389678399397;998.7253505286104;1029.8558201851747;1050.4117694091333;3787.394016957274;3852.556955950102;3861.2663593917064;3898.688104951597;3917.5886531914307;9779.217662586976;10018.849717254247;10110.443925584164;10122.949385253174;10149.035841595036;10039.34744241622;10082.143017843418;10108.595656173818;10130.290879638354;10202.234832387601;7573.697052117964;7646.120696119906;7707.152213256537;7819.335356494762;7843.294103530824;5475.288212532505;5487.6158668892795;5506.614536982533;5685.744141513559;5688.800891968761;9166.220871225754;9207;9228.307876909394;9290.256779457763;9304.72085837426;9345.719628411158;9369.625214991323;9410.070935458078;9422.670206542738;9492.335536512377;6269.62382257066;6475.1582294303325;6605.966970165118;6698.966505167443;6875;6402.807915762348;6776.593404395752;7800.648970796215;7994.120646728971;8039.638216280165;6995.545289556366;7083.397911177608;7102.289771022856;7132.536385134949;7162.964185179041;6691.698873550605;6948.687309071003;6984.511084224056;6996.860062798613;7044.647767611701;5836.854078648068;6641.136652235178;6737.046256585535;6770.255271920183;6781.457483401217;4123.670106391542;4887.266909963534;4911.63162762787;4933.802647894044;4947.678400904074;4671.602913752233;4877;4891;5043.646944713835;5111.309973153577 10:08:49 INFO - PROCESS | 1635 | |4;prototype.html;294.50229112799366;304.4246374352473;308.8702744847164;313.9121046107091;316.0770549994017;4401.427814384129;5122.001209764088;5211.166213405856;5250.632455728091;5482.094489920339;4962.578180854623;5072.797088116471;5141.485851414866;5282.022825777234;5352.197170424438;4099.61053699898;4102.3436250199975;4104.958950410502;4111.52717437494;4125.525564560069;3076.7846250762454;3616.8064538702165;4099.713020088595;4101.646456669292;4135.483064616923;4067.3288907330257;4070.982254436391;4076.5515793262716;4088.693347998897;4090.877273681794;3407.6146697311733;4037.3338399164395;4064.6748260139416;4068.7151899367054;4088.5707000765087;3118.98632944294;3198.3763166182603;3284.310294838087;3518.340925437542;3588.766730162557;4890.853274401774;5111.718855462948;5163.66436181647;5169.172932330809;5206.609504287194;3960.3069462844173;4648.395708557866;4675.929861052087;4697.929531057037;4708.4820669726305;4649.604783593399;4706.9764651176865;5600;5628.915566266509;5675.347335056439;3735.8505659773577;3800.6815842336155;3873.3996230584303;3898.1813819098024;3930.508686414198;5428.96849598579;5578.665280083167;5582.804601838916;5890.676012819294;5890.852728681817;3988.840446382112;3994.6404823566018;3999.340108882002;4003.7197396181987;4014.835697647708;2899.9855000725283;3910.4720862683175;4015.5783642717092;4066.8169932352525;4075.2460794753065;3649.8540058397366;3959.5050618672667;4671.925457144807;4687.460941991646;4709.387779588632;4402.25161722508;5470;5665.12190610456;5667.971660141673;5704.572157088235;1130.6947124276564;1135.7614900870744;1283.9422225999851;1301.290796515901;1352.2022007015908;798.1180795221313;903.3134817538718;920.6547544670749;920.6731610278255;929.7489677786959;4624.815007399667;4713.222318317439;4906.1659517881335;5010.423801262901;5034.974825125851;4996.826380524483;5202.479752024768;5379.405418364935;5474.178873168977;5499.725013749377;3966.861159859449;4052.959470405317;4355.738655680606;4840.636952228597;4884.291777692215;2296.0713001079175;2834.9871591170086;2867.9283017924304;2875.252434367038;2957.8020901534915;4859.371539653999;5094.465081166498;5610.579206559524;5660.29246344207;5765.9621268171295;4931.186354251508;5239.729620359395;5338.412774594792;5626.409227031185;5755.129582885579;5282.498162674539;5669.379455743556;5712.172104926383;5774.015929009054;5775.653460792366;5185.403678577012;5368.758405871667;5485.862853428696;5857.414258574108;5875.823725288248;4563.612092972135;5877.29558428051;5893.6463812171405;5913.610301579211;5926;5802.564807639359;5883.588148829541;6026.427489388501;6118.785842495491;6189.783357582463;3890.5914878937306;3927.5286965564314;3937.3109705801944;3970.980145099256;3988.74073185242;5352.571794256528;5899.587028908107;5912.320083190488;5916.792912248051;5931.1530465376;4518.68369214165;5183.792648294177;5550.38945715979;5750.568707347049;5756.94243057564;5227.790888364423;5674.546036317167;5692.914606280826;5703.916255911364;5753.597248192586;4738.336632871332;5172.017316709813;5369.758360873692;5373.408925018167;5603.747831347518;4953.603711702983;5386.676799392049;5689.800856969986;5693.5160511357;5733.655980641175;4921.680090794087;5207.0366982108435;5302.276760053075;5339.839804805862;5651.6043876928225 10:08:49 INFO - PROCESS | 1635 | |5;yui.html;696.2028477393382;711.9466040046998;713.2795876165073;739.511922131393;754.3098065270278;12319.384030798468;12443.440045197965;14209.928950355234;14793.556193314218;15728.370865165409;14958.17730024851;15380.69238615227;15397.84602153978;15510.30203640836;15573.688526229469;799.936005119592;825.9132791056943;826.7643721539363;832.3549249331786;832.7793134819278;792.7582087463321;815.5759005317261;824.583585289428;833.3083540661237;834.6744769539885;862.0302160069921;868.8653258744873;879.885614870066;881.4711173296004;886.162576365335;841.2344766262702;853.0531110467376;874.0472884555801;877.714742708619;879.2570278114982;647.5661306924325;649.4933951517777;650.8730797494491;652.282489261813;654.2933631677824;14053;14555.708885822225;14575.416983320654;14587.927060364736;14612.561623151323;12884.714397828493;13383.732325353438;13456.865431345659;13509.256990865597;13593.59219223425;11256.155788315828;11445.027172690332;11516.884831151665;11542.94228528852;11824.231424957436;3564.946525802115;3657.780533167992;3684.5762737285286;3708.8516459341595;3709.7588656737225;87989.56005219997;89443;90508;91217.54391228067;92753.0724692758;10078.949605251926;10238.436885971343;10276.948615256875;10306;10417.583296668048;19623;19807.504812379517;19933.700994485094;19957.501062473264;19963.700544491843;7436.9256307436235;7511.436642251853;7609.619519024027;7712.7300544481795;7854.332381747501;4181.372794080851;4212;4270.0605866709275;4305.268104422255;4407.911841763147;3362.6637336266176;3421.23022319981;3447.8276086196092;3470.7396945229207;3476.704480119168;649.4966401039138;649.6459429610874;658.3876994395258;684.226823689228;712.975045873392;555.3406915974973;598.6617561077977;619.3682443907189;652.518782364031;659.2550418027694;8309;9019.503927283931;9189.340086340164;9266.397684150508;9438.622455101857;544.9128139497741;599.2658992733866;661.1999480628493;661.4476911778719;676.3439463720183;4077.89805254871;4212.873613791591;4450.732956022649;4528.207563676409;4553.726776393427;61485.77028459495;62105.689471553254;62368.68815655893;106445.40331895028;110115.44942275237;51694.48305516897;83756.90607734855;92614;96916.54625180628;97620.51189744005;88253;88431.55784221167;90279.54860225788;90423.54788226148;91187.08812911787;9161.954190229006;9690.273229507675;9732.12410883024;9773.609055637695;9800.950995244979;54516.90966180734;55580.16629750638;56135.719321404766;56277.718611408316;58310.12534811896;72394;77202;79261;80686;85203.14796851952;10006.349587276804;11886.227395219283;12208.145429819828;12654.873451265737;13009.934950325567;11889.524419023488;12199.207051541622;12515.873571378255;14267.64330891736;14464.783028254795;12606.558770443356;12947.352632368533;13143.802842957171;13307.86692133105;13627.659308517366;11469.79567145471;13380.732385352434;13911.721765564835;13983.161010339412;14170.504032358818;12853.871461285267;13069.607911762663;13285.933570332472;13663.863361366259;13715.451381944611;10520;11077.289768354276;11218.382988935688;11385.886141138482;11835.644930652094;11177.888221117684;11483.46760365992;11514.712132196762;11631.6510504685;11640 10:08:49 INFO - PROCESS | 1635 | __end_tp_report 10:08:49 INFO - PROCESS | 1635 | __start_cc_report 10:08:49 INFO - PROCESS | 1635 | _x_x_mozilla_cycle_collect,379 10:08:49 INFO - PROCESS | 1635 | __end_cc_report 10:08:49 INFO - PROCESS | 1635 | __startTimestamp1479406129385__endTimestamp 10:08:49 INFO - PROCESS | 1635 | 10:08:49 INFO - PROCESS | 1635 | ------- Summary: start ------- 10:08:49 INFO - PROCESS | 1635 | Number of tests: 6 10:08:49 INFO - PROCESS | 1635 | 10:08:49 INFO - PROCESS | 1635 | [#0] dojo.html Cycles:165 Average:5645.29 Median:5925.73 stddev:694.96 (11.7%) stddev-sans-first:657.64 10:08:49 INFO - PROCESS | 1635 | Values: 2702.7 2842.8 3365.7 3367.4 3399.8 5584.3 5618.3 5638.7 5648.6 5649.6 5631.1 5634.5 5636.6 5646.6 5653.3 5128.8 5129.2 5157.1 5189.4 5262.1 5145.9 5179.6 5190.6 5205.9 5239.7 5073.3 5078.5 5199.9 5200.6 5242.3 5111.8 5114.1 5175.1 5239.2 5280.9 5144.3 5166.5 5177.6 5183.9 5183.9 5483.6 5618.2 5629.2 5691.9 5696.5 6066.7 6083.1 6102.5 6113.6 6125.5 6123.7 6144.7 6178.5 6200.2 6253.0 5819.1 5834.7 5846.1 5846.8 5861.4 6086.1 6112.0 6126.4 6165.5 6200.6 6002.2 6037.4 6042.0 6074.0 6122.0 6179.7 6180.0 6181.3 6200.6 6203.1 5961.0 6144.3 6160.0 6166.5 6175.3 6080.5 6115.6 6119.0 6125.9 6150.6 3977.9 4850.8 4861.8 4870.2 4890.9 3649.4 3680.7 3811.3 4409.6 4445.5 5231.5 5727.6 5761.0 5932.6 5938.3 4990.3 6126.3 6132.3 6169.4 6178.1 5678.3 5889.5 5904.9 5921.5 5943.8 4436.2 5252.2 5314.9 5320.4 5338.1 6139.8 6140.4 6142.3 6149.1 6151.6 6161.9 6223.1 6229.0 6240.1 6246.7 6112.0 6131.3 6139.2 6150.5 6216.6 4958.6 6149.3 6154.1 6164.6 6171.9 6209.7 6211.2 6226.5 6226.8 6228.1 5543.4 5850.7 5942.1 6023.3 6039.5 5992.1 6006.4 6009.9 6015.9 6030.0 5753.7 5791.2 5836.8 5866.7 5883.9 5947.3 5979.4 5998.1 6000.7 6109.1 5906.1 5925.7 5933.9 5960.0 5965.7 10:08:49 INFO - PROCESS | 1635 | 10:08:49 INFO - PROCESS | 1635 | [#1] ext.html Cycles:180 Average:73972.85 Median:38822.72 stddev:167688.23 (431.9%) stddev-sans-first:168067.84 10:08:49 INFO - PROCESS | 1635 | Values: 475.5 480.2 481.6 481.8 530.8 31771.0 36765.4 39536.8 39576.6 39604.6 39619.8 40159.8 40202.2 40234.6 40261.8 7952.8 9199.1 9355.3 9388.5 9410.5 9339.6 9363.6 9372.1 9430.8 9452.6 9412.1 9436.3 9442.7 9448.7 9456.0 9368.3 9428.2 9441.4 9445.0 9462.6 9215.8 9253.6 9296.1 9334.5 9337.3 38592.8 38726.8 38754.8 38890.6 38955.2 3360.1 3477.4 3482.9 3522.9 3712.1 29087.0 29729.9 29945.6 30131.9 30691.8 2522.7 3156.7 3164.6 3227.3 3241.0 443100.0 495303.0 516366.0 521067.0 524669.0 62372.0 63766.0 63903.0 63908.7 64059.0 69117.7 69156.3 69396.0 69582.0 69826.0 16459.1 16686.5 16714.8 16714.8 16747.4 12566.4 12692.7 12696.5 12703.9 12726.6 18535.4 20114.0 20116.2 20138.8 20180.9 8295.8 8379.0 8381.1 8428.9 8454.8 860.4 969.0 970.8 1007.7 1069.3 29654.9 29830.4 30066.0 30302.7 32091.8 920.6 1015.5 1048.7 1080.2 1116.5 12680.9 14380.0 15006.1 15174.8 15465.8 709273.0 713422.0 716611.0 717187.0 718323.0 55107.9 55286.7 55583.7 55600.7 55661.9 1350.7 1354.3 1354.4 1377.0 1378.8 26962.3 28564.6 29315.5 29455.0 29768.3 49123.0 49972.8 49999.8 50156.0 50185.2 639409.0 639533.0 640352.0 640921.0 641828.0 25881.0 26464.1 26763.5 26768.6 26845.6 44178.6 44231.3 44472.1 44758.6 45124.8 36902.3 37167.3 37233.3 38150.4 38301.0 27295.7 35424.5 35664.5 37015.6 37139.9 31159.2 33532.7 34700.7 36553.8 36668.8 31384.5 32066.0 33510.7 33598.5 33627.0 22190.9 22538.5 24848.8 25397.5 25497.5 10:08:49 INFO - PROCESS | 1635 | 10:08:49 INFO - PROCESS | 1635 | [#2] jquery.html Cycles:180 Average:34437.03 Median:2363.15 stddev:104060.93 (4403.5%) stddev-sans-first:104321.43 10:08:49 INFO - PROCESS | 1635 | Values: 378.1 379.0 386.6 390.5 405.3 18406.4 20076.7 20082.8 20088.9 20201.6 19729.3 20233.8 20425.8 20610.5 20871.6 5174.9 5566.3 5704.9 5941.3 6018.7 5868.0 5916.5 5935.6 5936.3 5947.2 5650.3 5873.8 5904.7 5913.8 5917.4 5642.2 5872.3 5896.2 5931.2 5939.5 5024.9 5078.7 5091.6 5094.6 5121.3 18661.4 21734.7 22114.9 22181.8 24487.6 2211.6 2212.5 2285.9 2440.4 2825.3 15441.3 15462.1 15536.8 15901.4 16054.4 1568.5 1757.8 1801.8 1892.8 1935.5 87165.6 91826.5 112124.4 112358.0 113056.3 8748.7 10878.3 10974.6 11365.5 11384.3 13892.4 13923.1 13963.7 14041.1 14092.7 8516.5 8655.7 8667.4 8751.3 8780.0 8617.3 8617.3 8647.0 8699.7 8719.3 5585.3 6649.6 6738.6 6740.4 6799.8 1745.6 1840.4 1863.5 1863.7 1865.0 906.7 914.3 925.5 1030.4 1035.6 16430.8 21134.4 21350.8 21570.9 21690.6 926.8 952.3 968.4 970.3 1019.7 10294.7 10770.4 11513.8 11561.3 11623.5 622688.0 626138.0 632675.0 635030.0 637680.0 70915.0 72430.6 96528.0 110220.0 117274.4 959.5 989.7 1013.1 1015.3 1015.9 15989.4 17662.0 19059.5 19099.5 19215.3 36410.9 43735.0 53731.7 54153.7 54250.1 73320.0 78754.6 80206.6 80711.0 81528.8 6849.3 7886.7 7913.2 8074.5 8166.1 10354.8 11641.0 12353.5 12690.3 12741.4 10422.5 10713.9 10913.5 10988.1 11168.2 10450.8 10770.4 10885.9 10968.9 11048.8 10714.6 10826.6 11313.4 11348.0 11404.9 7921.1 8024.6 8098.8 8164.0 8338.2 8816.8 10533.8 10793.2 11018.2 11058.8 10:08:49 INFO - PROCESS | 1635 | 10:08:49 INFO - PROCESS | 1635 | [#3] mootools.html Cycles:180 Average:5401.19 Median:5077.48 stddev:2951.48 (58.1%) stddev-sans-first:2944.25 10:08:49 INFO - PROCESS | 1635 | Values: 1376.0 1476.0 1495.7 1771.8 1788.0 7534.7 7772.9 8044.0 8463.4 8505.7 7917.9 8206.9 8246.5 8382.2 8390.6 2281.4 2316.2 2320.5 2323.7 2328.9 2333.8 2347.8 2373.1 2376.1 2379.8 1925.7 2307.9 2320.0 2327.6 2346.0 2273.2 2275.1 2298.1 2298.8 2301.2 1903.4 1925.9 2339.2 2347.5 2351.8 8290.1 8329.9 8391.0 8396.7 8420.1 5035.4 5181.6 5193.2 5195.5 5200.8 3247.7 3332.9 3576.0 3578.2 3580.0 1053.4 1054.6 1092.9 1104.4 1109.9 10843.3 10853.3 10860.7 10952.9 10966.8 3670.7 4537.0 4643.4 4646.0 4669.9 8647.0 9355.6 9385.7 9386.3 9443.7 5116.1 5124.3 5150.4 5158.7 5164.0 4269.0 4389.7 4538.8 4733.0 4749.7 3831.7 3851.1 3909.2 3950.6 3980.6 1249.8 1278.1 1279.9 1290.4 1294.0 762.3 850.3 897.7 907.8 918.9 5469.5 5475.2 5540.1 5702.5 5852.9 965.0 984.4 998.7 1029.9 1050.4 3787.4 3852.6 3861.3 3898.7 3917.6 9779.2 10018.8 10110.4 10122.9 10149.0 10039.3 10082.1 10108.6 10130.3 10202.2 7573.7 7646.1 7707.2 7819.3 7843.3 5475.3 5487.6 5506.6 5685.7 5688.8 9166.2 9207.0 9228.3 9290.3 9304.7 9345.7 9369.6 9410.1 9422.7 9492.3 6269.6 6475.2 6606.0 6699.0 6875.0 6402.8 6776.6 7800.6 7994.1 8039.6 6995.5 7083.4 7102.3 7132.5 7163.0 6691.7 6948.7 6984.5 6996.9 7044.6 5836.9 6641.1 6737.0 6770.3 6781.5 4123.7 4887.3 4911.6 4933.8 4947.7 4671.6 4877.0 4891.0 5043.6 5111.3 10:08:49 INFO - PROCESS | 1635 | 10:08:49 INFO - PROCESS | 1635 | [#4] prototype.html Cycles:180 Average:4488.97 Median:4979.70 stddev:1389.26 (27.9%) stddev-sans-first:1357.02 10:08:49 INFO - PROCESS | 1635 | Values: 294.5 304.4 308.9 313.9 316.1 4401.4 5122.0 5211.2 5250.6 5482.1 4962.6 5072.8 5141.5 5282.0 5352.2 4099.6 4102.3 4105.0 4111.5 4125.5 3076.8 3616.8 4099.7 4101.6 4135.5 4067.3 4071.0 4076.6 4088.7 4090.9 3407.6 4037.3 4064.7 4068.7 4088.6 3119.0 3198.4 3284.3 3518.3 3588.8 4890.9 5111.7 5163.7 5169.2 5206.6 3960.3 4648.4 4675.9 4697.9 4708.5 4649.6 4707.0 5600.0 5628.9 5675.3 3735.9 3800.7 3873.4 3898.2 3930.5 5429.0 5578.7 5582.8 5890.7 5890.9 3988.8 3994.6 3999.3 4003.7 4014.8 2900.0 3910.5 4015.6 4066.8 4075.2 3649.9 3959.5 4671.9 4687.5 4709.4 4402.3 5470.0 5665.1 5668.0 5704.6 1130.7 1135.8 1283.9 1301.3 1352.2 798.1 903.3 920.7 920.7 929.7 4624.8 4713.2 4906.2 5010.4 5035.0 4996.8 5202.5 5379.4 5474.2 5499.7 3966.9 4053.0 4355.7 4840.6 4884.3 2296.1 2835.0 2867.9 2875.3 2957.8 4859.4 5094.5 5610.6 5660.3 5766.0 4931.2 5239.7 5338.4 5626.4 5755.1 5282.5 5669.4 5712.2 5774.0 5775.7 5185.4 5368.8 5485.9 5857.4 5875.8 4563.6 5877.3 5893.6 5913.6 5926.0 5802.6 5883.6 6026.4 6118.8 6189.8 3890.6 3927.5 3937.3 3971.0 3988.7 5352.6 5899.6 5912.3 5916.8 5931.2 4518.7 5183.8 5550.4 5750.6 5756.9 5227.8 5674.5 5692.9 5703.9 5753.6 4738.3 5172.0 5369.8 5373.4 5603.7 4953.6 5386.7 5689.8 5693.5 5733.7 4921.7 5207.0 5302.3 5339.8 5651.6 10:08:49 INFO - PROCESS | 1635 | 10:08:49 INFO - PROCESS | 1635 | [#5] yui.html Cycles:180 Average:19867.81 Median:4540.97 stddev:28317.94 (623.6%) stddev-sans-first:28360.79 10:08:49 INFO - PROCESS | 1635 | Values: 696.2 711.9 713.3 739.5 754.3 12319.4 12443.4 14209.9 14793.6 15728.4 14958.2 15380.7 15397.8 15510.3 15573.7 799.9 825.9 826.8 832.4 832.8 792.8 815.6 824.6 833.3 834.7 862.0 868.9 879.9 881.5 886.2 841.2 853.1 874.0 877.7 879.3 647.6 649.5 650.9 652.3 654.3 14053.0 14555.7 14575.4 14587.9 14612.6 12884.7 13383.7 13456.9 13509.3 13593.6 11256.2 11445.0 11516.9 11542.9 11824.2 3564.9 3657.8 3684.6 3708.9 3709.8 87989.6 89443.0 90508.0 91217.5 92753.1 10078.9 10238.4 10276.9 10306.0 10417.6 19623.0 19807.5 19933.7 19957.5 19963.7 7436.9 7511.4 7609.6 7712.7 7854.3 4181.4 4212.0 4270.1 4305.3 4407.9 3362.7 3421.2 3447.8 3470.7 3476.7 649.5 649.6 658.4 684.2 713.0 555.3 598.7 619.4 652.5 659.3 8309.0 9019.5 9189.3 9266.4 9438.6 544.9 599.3 661.2 661.4 676.3 4077.9 4212.9 4450.7 4528.2 4553.7 61485.8 62105.7 62368.7 106445.4 110115.4 51694.5 83756.9 92614.0 96916.5 97620.5 88253.0 88431.6 90279.5 90423.5 91187.1 9162.0 9690.3 9732.1 9773.6 9801.0 54516.9 55580.2 56135.7 56277.7 58310.1 72394.0 77202.0 79261.0 80686.0 85203.1 10006.3 11886.2 12208.1 12654.9 13009.9 11889.5 12199.2 12515.9 14267.6 14464.8 12606.6 12947.4 13143.8 13307.9 13627.7 11469.8 13380.7 13911.7 13983.2 14170.5 12853.9 13069.6 13285.9 13663.9 13715.5 10520.0 11077.3 11218.4 11385.9 11835.6 11177.9 11483.5 11514.7 11631.7 11640.0 10:08:49 INFO - PROCESS | 1635 | -------- Summary: end -------- 10:08:49 INFO - PROCESS | 1635 | 10:08:49 INFO - TEST-INFO | 1635: exit 0 10:08:49 INFO - TEST-OK | dromaeo_css | took 1115341ms 10:08:49 INFO - TEST-START | kraken 10:08:49 INFO - operating with platform_type : mac_ 10:08:49 INFO - Initialising browser for kraken test... 10:08:49 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpiAGtvz/profile http://localhost:49246/getInfo.html) 10:08:51 ERROR - PROCESS | 1646 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 10:08:52 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 10:08:52 INFO - PROCESS | 1646 | colorDepth:24 10:08:52 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 10:08:52 INFO - PROCESS | 1646 | __metrics 10:08:52 ERROR - PROCESS | 1646 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 10:08:53 INFO - TEST-INFO | 1646: exit 0 10:08:53 INFO - Browser initialized. 10:08:53 INFO - Running cycle 1/1 for kraken test... 10:08:53 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpiAGtvz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:09:05 INFO - PROCESS | 1648 | RSS: Main: 224092160 10:09:05 INFO - PROCESS | 1648 | 10:09:08 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 10:09:09 INFO - PROCESS | 1648 | RSS: Main: 236802048 10:09:09 INFO - PROCESS | 1648 | 10:09:12 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 10:09:12 INFO - PROCESS | 1648 | RSS: Main: 244260864 10:09:12 INFO - PROCESS | 1648 | 10:09:16 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 10:09:16 INFO - PROCESS | 1648 | RSS: Main: 247963648 10:09:16 INFO - PROCESS | 1648 | 10:09:18 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 10:09:19 INFO - PROCESS | 1648 | RSS: Main: 249303040 10:09:19 INFO - PROCESS | 1648 | 10:09:21 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:09:22 INFO - PROCESS | 1648 | RSS: Main: 249307136 10:09:22 INFO - PROCESS | 1648 | 10:09:25 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 10:09:25 INFO - PROCESS | 1648 | RSS: Main: 253427712 10:09:25 INFO - PROCESS | 1648 | 10:09:28 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 10:09:29 INFO - PROCESS | 1648 | RSS: Main: 252841984 10:09:29 INFO - PROCESS | 1648 | 10:09:32 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 10:09:32 INFO - PROCESS | 1648 | RSS: Main: 252874752 10:09:32 INFO - PROCESS | 1648 | 10:09:34 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:09:35 INFO - PROCESS | 1648 | RSS: Main: 252080128 10:09:35 INFO - PROCESS | 1648 | 10:09:37 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:09:37 INFO - PROCESS | 1648 | RSS: Main: 252420096 10:09:37 INFO - PROCESS | 1648 | 10:09:39 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:09:40 INFO - PROCESS | 1648 | RSS: Main: 252215296 10:09:40 INFO - PROCESS | 1648 | 10:09:43 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:09:44 INFO - PROCESS | 1648 | RSS: Main: 252342272 10:09:44 INFO - PROCESS | 1648 | 10:09:47 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:09:47 INFO - PROCESS | 1648 | RSS: Main: 252497920 10:09:47 INFO - PROCESS | 1648 | 10:09:49 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 10:09:49 INFO - PROCESS | 1648 | RSS: Main: 253984768 10:09:49 INFO - PROCESS | 1648 | 10:09:49 INFO - PROCESS | 1648 | __start_tp_report 10:09:49 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 10:09:49 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 10:09:49 INFO - PROCESS | 1648 | |i|pagename|runs| 10:09:49 INFO - PROCESS | 1648 | |0;ai-astar;107;120;118;120;97;170;174;118;118;118 10:09:49 INFO - PROCESS | 1648 | |1;audio-beat-detection;184;123;135;188;107;134;147;119;142;103 10:09:49 INFO - PROCESS | 1648 | |2;audio-dft;196;201;195;198;193;195;201;195;200;197 10:09:49 INFO - PROCESS | 1648 | |3;audio-fft;81;60;60;85;59;58;56;60;80;59 10:09:49 INFO - PROCESS | 1648 | |4;audio-oscillator;89;71;91;71;69;87;104;95;102;127 10:09:49 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;91;89;79;133;90;96;85;133;124;88 10:09:49 INFO - PROCESS | 1648 | |6;imaging-darkroom;133;113;99;94;98;154;154;95;94;98 10:09:49 INFO - PROCESS | 1648 | |7;imaging-desaturate;136;143;86;88;96;87;94;91;88;91 10:09:49 INFO - PROCESS | 1648 | |8;json-parse-financial;55;56;55;54;60;59;60;60;60;60 10:09:49 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;66;75;76;78;74;67;68;68;70;70 10:09:49 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;87;91;86;80;85;86;89;85;91;85 10:09:49 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;174;155;165;163;157;154;158;149;191;169 10:09:50 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;225;174;173;172;170;173;224;229;169;168 10:09:50 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;68;69;66;68;72;92;86;64;86;66 10:09:50 INFO - PROCESS | 1648 | __end_tp_report 10:09:50 INFO - PROCESS | 1648 | __start_cc_report 10:09:50 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,988 10:09:50 INFO - PROCESS | 1648 | __end_cc_report 10:09:50 INFO - PROCESS | 1648 | __startTimestamp1479406189993__endTimestamp 10:09:50 INFO - PROCESS | 1648 | 10:09:50 INFO - PROCESS | 1648 | ------- Summary: start ------- 10:09:50 INFO - PROCESS | 1648 | Number of tests: 14 10:09:50 INFO - PROCESS | 1648 | 10:09:50 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:126.00 Median:120.00 stddev:25.32 (21.1%) stddev-sans-first:25.91 10:09:50 INFO - PROCESS | 1648 | Values: 107.0 120.0 118.0 120.0 97.0 170.0 174.0 118.0 118.0 118.0 10:09:50 INFO - PROCESS | 1648 | 10:09:50 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:138.20 Median:138.50 stddev:28.89 (20.9%) stddev-sans-first:25.44 10:09:50 INFO - PROCESS | 1648 | Values: 184.0 123.0 135.0 188.0 107.0 134.0 147.0 119.0 142.0 103.0 10:09:50 INFO - PROCESS | 1648 | 10:09:50 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:197.10 Median:197.50 stddev:2.81 (1.4%) stddev-sans-first:2.95 10:09:50 INFO - PROCESS | 1648 | Values: 196.0 201.0 195.0 198.0 193.0 195.0 201.0 195.0 200.0 197.0 10:09:50 INFO - PROCESS | 1648 | 10:09:50 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:65.80 Median:60.00 stddev:11.31 (18.9%) stddev-sans-first:10.58 10:09:50 INFO - PROCESS | 1648 | Values: 81.0 60.0 60.0 85.0 59.0 58.0 56.0 60.0 80.0 59.0 10:09:50 INFO - PROCESS | 1648 | 10:09:50 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:79.00 stddev:17.96 (22.7%) stddev-sans-first:19.04 10:09:50 INFO - PROCESS | 1648 | Values: 89.0 71.0 91.0 71.0 69.0 87.0 104.0 95.0 102.0 127.0 10:09:50 INFO - PROCESS | 1648 | 10:09:50 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:100.80 Median:88.50 stddev:20.75 (23.4%) stddev-sans-first:21.71 10:09:50 INFO - PROCESS | 1648 | Values: 91.0 89.0 79.0 133.0 90.0 96.0 85.0 133.0 124.0 88.0 10:09:50 INFO - PROCESS | 1648 | 10:09:50 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:113.20 Median:94.50 stddev:24.62 (26.0%) stddev-sans-first:25.04 10:09:50 INFO - PROCESS | 1648 | Values: 133.0 113.0 99.0 94.0 98.0 154.0 154.0 95.0 94.0 98.0 10:09:50 INFO - PROCESS | 1648 | 10:09:50 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:100.00 Median:89.50 stddev:21.11 (23.6%) stddev-sans-first:17.93 10:09:50 INFO - PROCESS | 1648 | Values: 136.0 143.0 86.0 88.0 96.0 87.0 94.0 91.0 88.0 91.0 10:09:50 INFO - PROCESS | 1648 | 10:09:50 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:60.00 stddev:2.56 (4.3%) stddev-sans-first:2.49 10:09:50 INFO - PROCESS | 1648 | Values: 55.0 56.0 55.0 54.0 60.0 59.0 60.0 60.0 60.0 60.0 10:09:50 INFO - PROCESS | 1648 | 10:09:50 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:72.00 stddev:4.21 (5.8%) stddev-sans-first:4.02 10:09:50 INFO - PROCESS | 1648 | Values: 66.0 75.0 76.0 78.0 74.0 67.0 68.0 68.0 70.0 70.0 10:09:50 INFO - PROCESS | 1648 | 10:09:50 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.50 stddev:3.27 (3.8%) stddev-sans-first:3.47 10:09:50 INFO - PROCESS | 1648 | Values: 87.0 91.0 86.0 80.0 85.0 86.0 89.0 85.0 91.0 85.0 10:09:50 INFO - PROCESS | 1648 | 10:09:50 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:163.50 Median:164.00 stddev:12.22 (7.5%) stddev-sans-first:12.36 10:09:50 INFO - PROCESS | 1648 | Values: 174.0 155.0 165.0 163.0 157.0 154.0 158.0 149.0 191.0 169.0 10:09:50 INFO - PROCESS | 1648 | 10:09:50 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.70 Median:173.50 stddev:26.52 (15.3%) stddev-sans-first:24.46 10:09:50 INFO - PROCESS | 1648 | Values: 225.0 174.0 173.0 172.0 170.0 173.0 224.0 229.0 169.0 168.0 10:09:50 INFO - PROCESS | 1648 | 10:09:50 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.70 Median:70.50 stddev:10.22 (14.5%) stddev-sans-first:10.63 10:09:50 INFO - PROCESS | 1648 | Values: 68.0 69.0 66.0 68.0 72.0 92.0 86.0 64.0 86.0 66.0 10:09:50 INFO - PROCESS | 1648 | -------- Summary: end -------- 10:09:50 INFO - PROCESS | 1648 | 10:09:50 INFO - TEST-INFO | 1648: exit 0 10:09:50 INFO - TEST-OK | kraken | took 60860ms 10:09:50 INFO - SUITE-END | took 1176s 10:09:51 INFO - Completed test suite (00:19:36) 10:09:51 INFO - javascript benchmark 10:09:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7176.3992482824715, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2702.7162147974473, 2842.8010039297246, 3365.663433656634, 3367.444371678673, 3399.796012239264, 5584.329880414351, 5618.297712785902, 5638.661680299175, 5648.576356773238, 5649.6327738697055, 5631.1271752878265, 5634.549236061115, 5636.633618814774, 5646.604737668365, 5653.265075540185, 5128.794733237705, 5129.230615407681, 5157.149070403398, 5189.355526803509, 5262.131748261551, 5145.897082058356, 5179.559737422323, 5190.636655434121, 5205.895882082356, 5239.711815850127, 5073.289739436482, 5078.542931136197, 5199.896002079956, 5200.583953283747, 5242.266082748418, 5111.846644600668, 5114.079465696192, 5175.120229560946, 5239.21411788231, 5280.894382112375, 5144.305518754958, 5166.483351664841, 5177.559907407875, 5183.896322073538, 5183.948160518422, 5483.616146869721, 5618.185363122325, 5629.183768353607, 5691.943080569225, 5696.487316141525, 6066.726997285133, 6083.057126145454, 6102.481289090432, 6113.567524283673, 6125.540694081788, 6123.740204357194, 6144.678894037804, 6178.5366097542865, 6200.224971878515, 6252.968735156341, 5819.098039803837, 5834.708264586754, 5846.123081537761, 5846.766129354778, 5861.413858614147, 6086.1175129606845, 6111.98679349419, 6126.417990290915, 6165.5375846810775, 6200.56596038282, 6002.159697642333, 6037.366076561985, 6042.033274676119, 6073.997790364629, 6121.96939015311, 6179.69101544921, 6180.002698691132, 6181.289151747516, 6200.596961197508, 6203.069539569011, 5960.970195148997, 6144.262688477322, 6160.0, 6166.506679465632, 6175.289841668266, 6080.543959203077, 6115.635867915819, 6119.015143218386, 6125.876495711566, 6150.569460137747, 3977.8607748728655, 4850.83022094225, 4861.781219845045, 4870.172070747982, 4890.877728056756, 3649.379605467077, 3680.705543556509, 3811.294910441577, 4409.625181859514, 4445.51099379068, 5231.476852314738, 5727.599068065196, 5760.971195144081, 5932.644041357532, 5938.346781853993, 4990.2764099205415, 6126.30393285589, 6132.264128304543, 6169.383061693885, 6178.104174894615, 5678.318601767732, 5889.4699477046415, 5904.852378690567, 5921.496672782861, 5943.762249510058, 4436.245838207513, 5252.1596544552685, 5314.893702125936, 5320.388155362106, 5338.092524270884, 6139.829471381323, 6140.416660417253, 6142.253225532511, 6149.108379285068, 6151.6001459904965, 6161.938380616137, 6223.128761973237, 6229.0, 6240.095186197885, 6246.718897649525, 6112.0171844544475, 6131.325554189125, 6139.154842350836, 6150.507959363151, 6216.595921265103, 4958.628102892226, 6149.2620885494025, 6154.076888466587, 6164.599301045418, 6171.9074213887725, 6209.720562574605, 6211.16149319836, 6226.470749986302, 6226.813195604139, 6228.096925945803, 5543.417941116125, 5850.678212698343, 5942.138389933349, 6023.337432882292, 6039.486643635164, 5992.13114098462, 6006.429389208019, 6009.87980240384, 6015.909761353496, 6030.005049166838, 5753.71231438418, 5791.160281759206, 5836.795712150054, 5866.706664666664, 5883.882322353615, 5947.31605865331, 5979.402059793986, 5998.130271110577, 6000.699965001645, 6109.053096770008, 5906.055031194988, 5925.733341999534, 5933.881322373615, 5960.046392577166, 5965.701714914324], "value": 5596.342065400988, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.5221002892093, 480.2316293929713, 481.57621293261934, 481.79282908349404, 530.7770736290757, 31771.0, 36765.44851827225, 39536.802315988454, 39576.60423395765, 39604.60395396045, 39619.811405657805, 40159.79520614379, 40202.19595608086, 40234.59765402345, 40261.798691006574, 7952.840943181133, 9199.080091990798, 9355.345125841193, 9388.530573471333, 9410.52947352633, 9339.626414943394, 9363.57863896123, 9372.062793720608, 9430.811383772321, 9452.57463414148, 9412.105849944244, 9436.292278079138, 9442.716718498456, 9448.716538503855, 9456.0, 9368.2973776967, 9428.245740340824, 9441.386309889835, 9444.952775236148, 9462.57418416173, 9215.815683686289, 9253.6298548058, 9296.116868897443, 9334.486603236819, 9337.29970252227, 38592.80703596464, 38726.80636596799, 38754.8373548794, 38890.61109388898, 38955.22089558193, 3360.1095709636966, 3477.374072666919, 3482.89551313461, 3522.8766993155373, 3712.0905378182247, 29087.0, 29729.851350743324, 29945.550816737767, 30131.945381911526, 30691.846540767376, 2522.7225005249593, 3156.6527681954967, 3164.5727826743555, 3227.2738633807207, 3240.96759032409, 443100.0, 495303.0, 516366.0, 521067.0, 524669.0, 62372.0, 63766.0, 63903.0, 63908.721825563225, 64059.0, 69117.65441172762, 69156.30843691499, 69396.0, 69582.0, 69826.0, 16459.094749788877, 16686.49940501787, 16714.832851671326, 16714.83285167157, 16747.413840515524, 12566.434510447052, 12692.682682933, 12696.492140314283, 12703.872961270454, 12726.618201453972, 18535.35126270601, 20114.0, 20116.19535218604, 20138.798612013692, 20180.89005104704, 8295.792605184919, 8378.958105209435, 8381.119982401882, 8428.873566896502, 8454.788630284169, 860.3805260212637, 968.9612415503301, 970.8009857979098, 1007.6573964851985, 1069.2889228663007, 29654.851725741664, 29830.40339193204, 30066.0, 30302.69697303043, 32091.839540802146, 920.636348642296, 1015.5176291261591, 1048.7063622185801, 1080.206048554312, 1116.4808364110727, 12680.873191268154, 14380.0, 15006.099634021994, 15174.848251517564, 15465.845341546665, 709273.0, 713422.0, 716611.0, 717187.0, 718323.0, 55107.897842042934, 55286.723566382716, 55583.722081390144, 55600.721996390566, 55661.88676226453, 1350.6960933790015, 1354.2619272496513, 1354.3972932045342, 1377.0360747476807, 1378.8138601288697, 26962.32594185161, 28564.57153142663, 29315.472496264294, 29455.0, 29768.255793604465, 49123.0, 49972.75013624909, 49999.75000124976, 50156.0, 50185.24722129244, 639409.0, 639533.0, 640352.0, 640921.0, 641828.0, 25881.0, 26464.0737574184, 26763.464730705666, 26768.59847102334, 26845.597316039883, 44178.55821441745, 44231.33652995272, 44472.11055778931, 44758.55241447674, 45124.77437612791, 36902.26195476129, 37167.25665486729, 37233.25533489261, 38150.42774358443, 38301.0, 27295.72704272932, 35424.46863297001, 35664.465033024004, 37015.629843701216, 37139.88580342594, 31159.221019474695, 33532.664673352956, 34700.65299346974, 36553.81723091367, 36668.81665591655, 31384.529232061082, 32066.0, 33510.66489335075, 33598.49602255919, 33627.0, 22190.889045554668, 22538.549229015654, 24848.751512485367, 25397.492050159264, 25497.49005019852], "value": 19787.670886325177, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.1095520050283, 378.9564200116987, 386.6442872557248, 390.52551150352315, 405.30085602335976, 18406.44780656579, 20076.698849517234, 20082.799172008275, 20088.899555502237, 20201.59596808063, 19729.30947416837, 20233.797662023375, 20425.795742042574, 20610.48473788156, 20871.582568348626, 5174.870628234286, 5566.276384070085, 5704.914426283609, 5941.257342832146, 6018.729157187937, 5868.0, 5916.497097746696, 5935.554833387491, 5936.317323507808, 5947.197128387677, 5650.321961364642, 5873.765049398019, 5904.7047647617665, 5913.763449462016, 5917.408259174092, 5642.181883626851, 5872.324682661484, 5896.204012458306, 5931.199288096095, 5939.4654481096695, 5024.949750502485, 5078.7460626968505, 5091.5672167865405, 5094.566961808251, 5121.334226550562, 18661.440156795317, 21734.673979890315, 22114.88942555277, 22181.77818221813, 24487.632685509732, 2211.635080211763, 2212.5021870079263, 2285.8628482291115, 2440.4386990991993, 2825.2513084032544, 15441.30514126867, 15462.072275663384, 15536.766948495782, 15901.443449479213, 16054.438094666748, 1568.5294411676452, 1757.79785324688, 1801.8198180182007, 1892.7823300320501, 1935.4677463697456, 87165.56417217937, 91826.5408672959, 112124.4393778034, 112358.0, 113056.30415543774, 8748.69379571712, 10878.292910960763, 10974.615888443866, 11365.488553015135, 11384.316940983568, 13892.374843132084, 13923.094998825043, 13963.65090872716, 14041.087329323562, 14092.718145637235, 8516.531590762568, 8655.6970506032, 8667.4366166199, 8751.256143227769, 8779.956100219459, 8617.267532259702, 8617.267532259702, 8647.048824629286, 8699.652013919498, 8719.302455803521, 5585.3297604287745, 6649.567778094409, 6738.561993470506, 6740.427063699641, 6799.762008329685, 1745.598512342143, 1840.3650740494509, 1863.4689113602558, 1863.7390765292869, 1864.9813501865078, 906.6781292641149, 914.2640174659463, 925.4863550729275, 1030.3560274828233, 1035.6271742172812, 16430.83569164317, 21134.365969020953, 21350.78649213519, 21570.892145539172, 21690.566188676137, 926.754410081329, 952.2857856607544, 968.3560432312574, 970.3110791338088, 1019.6889948565611, 10294.691159265234, 10770.407627580558, 11513.827292590451, 11561.30632162073, 11623.476943537562, 622688.0, 626138.0, 632675.0, 635030.0, 637680.0, 70915.0, 72430.63784681042, 96528.0, 110220.0, 117274.41362793303, 959.4866746290841, 989.7030890732751, 1013.1388319928002, 1015.2892974917587, 1015.8577799108131, 15989.401059893917, 17662.0, 19059.523511912314, 19099.522511937314, 19215.32746353871, 36410.907672769856, 43735.0, 53731.731341343046, 54153.729231353595, 54250.101246456186, 73320.0, 78754.60622696849, 80206.59896700479, 80711.0, 81528.77706834521, 6849.315068493111, 7886.68453261886, 7913.248241417056, 8074.475159114639, 8166.060902995994, 10354.792904142025, 11641.0, 12353.505859765508, 12690.302033387883, 12741.426635801596, 10422.478876056015, 10713.946430267799, 10913.454327283445, 10988.120950324115, 11168.162387820783, 10450.843237351293, 10770.353778773298, 10885.945570272099, 10968.945155274172, 11048.779024419628, 10714.624988125379, 10826.56693732242, 11313.377764223047, 11348.0, 11404.885951140383, 7921.089074756246, 8024.638891250024, 8098.75703728889, 8164.020317561931, 8338.207870252316, 8816.779580510538, 10533.789324213627, 10793.244472887136, 11018.228723989243, 11058.778824423305], "value": 9515.309707650122, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1375.972480550389, 1475.9631009224768, 1495.7457232270515, 1771.7962434320057, 1787.9642407151857, 7534.698612055525, 7772.922270777304, 8044.0, 8463.4075614707, 8505.702300419487, 7917.881231781528, 8206.91793082069, 8246.46397984132, 8382.161783821615, 8390.62242199101, 2281.3954302109914, 2316.224064938248, 2320.535892821434, 2323.6514522821544, 2328.906843726249, 2333.789958903707, 2347.753485883983, 2373.086361750721, 2376.120835290945, 2379.821513386494, 1925.682262426698, 2307.9423014424688, 2320.0255892525097, 2327.627579587258, 2346.038124369009, 2273.2498275569105, 2275.0785931697524, 2298.092253559851, 2298.804601608865, 2301.160076572056, 1903.4004288649032, 1925.8555608329432, 2339.169594793858, 2347.507023525062, 2351.8005817033263, 8290.08809031006, 8329.875051874227, 8390.958045209796, 8396.664133434655, 8420.073791882887, 5035.395752509722, 5181.637285389987, 5193.246979187997, 5195.532402083831, 5200.76596553156, 3247.6752324767335, 3332.916677083068, 3576.0344706929245, 3578.248567800765, 3579.977312818249, 1053.4469403563191, 1054.6308791922843, 1092.9234953553255, 1104.436737263993, 1109.9334039957628, 10843.295185812896, 10853.34879907208, 10860.67417977462, 10952.945235273774, 10966.835497467544, 3670.7063434925144, 4536.97731511347, 4643.419572553431, 4646.001109761418, 4669.929951050737, 8646.962364516172, 9355.578998945064, 9385.671501497414, 9386.296027797805, 9443.716688499357, 5116.053530096944, 5124.282600435942, 5150.407703114115, 5158.716270605078, 5164.018836421068, 4269.0, 4389.714668546534, 4538.795754191069, 4732.95267047332, 4749.667523273407, 3831.731778775459, 3851.114243723959, 3909.198614284065, 3950.6049395060263, 3980.641742243212, 1249.775040492702, 1278.0925542864484, 1279.9168054076456, 1290.4386591832583, 1293.9870601293867, 762.2529920677656, 850.3069997951774, 897.6633762339122, 907.8138981508774, 918.8805455290903, 5469.535089517435, 5475.233467314579, 5540.085885828874, 5702.486776190163, 5852.853678658068, 965.0, 984.389678399397, 998.7253505286104, 1029.8558201851747, 1050.4117694091333, 3787.394016957274, 3852.556955950102, 3861.2663593917064, 3898.688104951597, 3917.5886531914307, 9779.217662586976, 10018.849717254247, 10110.443925584164, 10122.949385253174, 10149.035841595036, 10039.34744241622, 10082.143017843418, 10108.595656173818, 10130.290879638354, 10202.234832387601, 7573.697052117964, 7646.120696119906, 7707.152213256537, 7819.335356494762, 7843.294103530824, 5475.288212532505, 5487.6158668892795, 5506.614536982533, 5685.744141513559, 5688.800891968761, 9166.220871225754, 9207.0, 9228.307876909394, 9290.256779457763, 9304.72085837426, 9345.719628411158, 9369.625214991323, 9410.070935458078, 9422.670206542738, 9492.335536512377, 6269.62382257066, 6475.1582294303325, 6605.966970165118, 6698.966505167443, 6875.0, 6402.807915762348, 6776.593404395752, 7800.648970796215, 7994.120646728971, 8039.638216280165, 6995.545289556366, 7083.397911177608, 7102.289771022856, 7132.536385134949, 7162.964185179041, 6691.698873550605, 6948.687309071003, 6984.511084224056, 6996.860062798613, 7044.647767611701, 5836.854078648068, 6641.136652235178, 6737.046256585535, 6770.255271920183, 6781.457483401217, 4123.670106391542, 4887.266909963534, 4911.63162762787, 4933.802647894044, 4947.678400904074, 4671.602913752233, 4877.0, 4891.0, 5043.646944713835, 5111.309973153577], "value": 4397.241201198691, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.50229112799366, 304.4246374352473, 308.8702744847164, 313.9121046107091, 316.0770549994017, 4401.427814384129, 5122.001209764088, 5211.166213405856, 5250.632455728091, 5482.094489920339, 4962.578180854623, 5072.797088116471, 5141.485851414866, 5282.022825777234, 5352.197170424438, 4099.61053699898, 4102.3436250199975, 4104.958950410502, 4111.52717437494, 4125.525564560069, 3076.7846250762454, 3616.8064538702165, 4099.713020088595, 4101.646456669292, 4135.483064616923, 4067.3288907330257, 4070.982254436391, 4076.5515793262716, 4088.693347998897, 4090.877273681794, 3407.6146697311733, 4037.3338399164395, 4064.6748260139416, 4068.7151899367054, 4088.5707000765087, 3118.98632944294, 3198.3763166182603, 3284.310294838087, 3518.340925437542, 3588.766730162557, 4890.853274401774, 5111.718855462948, 5163.66436181647, 5169.172932330809, 5206.609504287194, 3960.3069462844173, 4648.395708557866, 4675.929861052087, 4697.929531057037, 4708.4820669726305, 4649.604783593399, 4706.9764651176865, 5600.0, 5628.915566266509, 5675.347335056439, 3735.8505659773577, 3800.6815842336155, 3873.3996230584303, 3898.1813819098024, 3930.508686414198, 5428.96849598579, 5578.665280083167, 5582.804601838916, 5890.676012819294, 5890.852728681817, 3988.840446382112, 3994.6404823566018, 3999.340108882002, 4003.7197396181987, 4014.835697647708, 2899.9855000725283, 3910.4720862683175, 4015.5783642717092, 4066.8169932352525, 4075.2460794753065, 3649.8540058397366, 3959.5050618672667, 4671.925457144807, 4687.460941991646, 4709.387779588632, 4402.25161722508, 5470.0, 5665.12190610456, 5667.971660141673, 5704.572157088235, 1130.6947124276564, 1135.7614900870744, 1283.9422225999851, 1301.290796515901, 1352.2022007015908, 798.1180795221313, 903.3134817538718, 920.6547544670749, 920.6731610278255, 929.7489677786959, 4624.815007399667, 4713.222318317439, 4906.1659517881335, 5010.423801262901, 5034.974825125851, 4996.826380524483, 5202.479752024768, 5379.405418364935, 5474.178873168977, 5499.725013749377, 3966.861159859449, 4052.959470405317, 4355.738655680606, 4840.636952228597, 4884.291777692215, 2296.0713001079175, 2834.9871591170086, 2867.9283017924304, 2875.252434367038, 2957.8020901534915, 4859.371539653999, 5094.465081166498, 5610.579206559524, 5660.29246344207, 5765.9621268171295, 4931.186354251508, 5239.729620359395, 5338.412774594792, 5626.409227031185, 5755.129582885579, 5282.498162674539, 5669.379455743556, 5712.172104926383, 5774.015929009054, 5775.653460792366, 5185.403678577012, 5368.758405871667, 5485.862853428696, 5857.414258574108, 5875.823725288248, 4563.612092972135, 5877.29558428051, 5893.6463812171405, 5913.610301579211, 5926.0, 5802.564807639359, 5883.588148829541, 6026.427489388501, 6118.785842495491, 6189.783357582463, 3890.5914878937306, 3927.5286965564314, 3937.3109705801944, 3970.980145099256, 3988.74073185242, 5352.571794256528, 5899.587028908107, 5912.320083190488, 5916.792912248051, 5931.1530465376, 4518.68369214165, 5183.792648294177, 5550.38945715979, 5750.568707347049, 5756.94243057564, 5227.790888364423, 5674.546036317167, 5692.914606280826, 5703.916255911364, 5753.597248192586, 4738.336632871332, 5172.017316709813, 5369.758360873692, 5373.408925018167, 5603.747831347518, 4953.603711702983, 5386.676799392049, 5689.800856969986, 5693.5160511357, 5733.655980641175, 4921.680090794087, 5207.0366982108435, 5302.276760053075, 5339.839804805862, 5651.6043876928225], "value": 4047.5686901195586, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.2028477393382, 711.9466040046998, 713.2795876165073, 739.511922131393, 754.3098065270278, 12319.384030798468, 12443.440045197965, 14209.928950355234, 14793.556193314218, 15728.370865165409, 14958.17730024851, 15380.69238615227, 15397.84602153978, 15510.30203640836, 15573.688526229469, 799.936005119592, 825.9132791056943, 826.7643721539363, 832.3549249331786, 832.7793134819278, 792.7582087463321, 815.5759005317261, 824.583585289428, 833.3083540661237, 834.6744769539885, 862.0302160069921, 868.8653258744873, 879.885614870066, 881.4711173296004, 886.162576365335, 841.2344766262702, 853.0531110467376, 874.0472884555801, 877.714742708619, 879.2570278114982, 647.5661306924325, 649.4933951517777, 650.8730797494491, 652.282489261813, 654.2933631677824, 14053.0, 14555.708885822225, 14575.416983320654, 14587.927060364736, 14612.561623151323, 12884.714397828493, 13383.732325353438, 13456.865431345659, 13509.256990865597, 13593.59219223425, 11256.155788315828, 11445.027172690332, 11516.884831151665, 11542.94228528852, 11824.231424957436, 3564.946525802115, 3657.780533167992, 3684.5762737285286, 3708.8516459341595, 3709.7588656737225, 87989.56005219997, 89443.0, 90508.0, 91217.54391228067, 92753.0724692758, 10078.949605251926, 10238.436885971343, 10276.948615256875, 10306.0, 10417.583296668048, 19623.0, 19807.504812379517, 19933.700994485094, 19957.501062473264, 19963.700544491843, 7436.9256307436235, 7511.436642251853, 7609.619519024027, 7712.7300544481795, 7854.332381747501, 4181.372794080851, 4212.0, 4270.0605866709275, 4305.268104422255, 4407.911841763147, 3362.6637336266176, 3421.23022319981, 3447.8276086196092, 3470.7396945229207, 3476.704480119168, 649.4966401039138, 649.6459429610874, 658.3876994395258, 684.226823689228, 712.975045873392, 555.3406915974973, 598.6617561077977, 619.3682443907189, 652.518782364031, 659.2550418027694, 8309.0, 9019.503927283931, 9189.340086340164, 9266.397684150508, 9438.622455101857, 544.9128139497741, 599.2658992733866, 661.1999480628493, 661.4476911778719, 676.3439463720183, 4077.89805254871, 4212.873613791591, 4450.732956022649, 4528.207563676409, 4553.726776393427, 61485.77028459495, 62105.689471553254, 62368.68815655893, 106445.40331895028, 110115.44942275237, 51694.48305516897, 83756.90607734855, 92614.0, 96916.54625180628, 97620.51189744005, 88253.0, 88431.55784221167, 90279.54860225788, 90423.54788226148, 91187.08812911787, 9161.954190229006, 9690.273229507675, 9732.12410883024, 9773.609055637695, 9800.950995244979, 54516.90966180734, 55580.16629750638, 56135.719321404766, 56277.718611408316, 58310.12534811896, 72394.0, 77202.0, 79261.0, 80686.0, 85203.14796851952, 10006.349587276804, 11886.227395219283, 12208.145429819828, 12654.873451265737, 13009.934950325567, 11889.524419023488, 12199.207051541622, 12515.873571378255, 14267.64330891736, 14464.783028254795, 12606.558770443356, 12947.352632368533, 13143.802842957171, 13307.86692133105, 13627.659308517366, 11469.79567145471, 13380.732385352434, 13911.721765564835, 13983.161010339412, 14170.504032358818, 12853.871461285267, 13069.607911762663, 13285.933570332472, 13663.863361366259, 13715.451381944611, 10520.0, 11077.289768354276, 11218.382988935688, 11385.886141138482, 11835.644930652094, 11177.888221117684, 11483.46760365992, 11514.712132196762, 11631.6510504685, 11640.0], "value": 7282.750028797668, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1572.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 120.0, 118.0, 120.0, 97.0, 170.0, 174.0, 118.0, 118.0, 118.0], "value": 126.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 123.0, 135.0, 188.0, 107.0, 134.0, 147.0, 119.0, 142.0, 103.0], "value": 138.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 201.0, 195.0, 198.0, 193.0, 195.0, 201.0, 195.0, 200.0, 197.0], "value": 197.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 60.0, 85.0, 59.0, 58.0, 56.0, 60.0, 80.0, 59.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 91.0, 71.0, 69.0, 87.0, 104.0, 95.0, 102.0, 127.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 79.0, 133.0, 90.0, 96.0, 85.0, 133.0, 124.0, 88.0], "value": 100.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 113.0, 99.0, 94.0, 98.0, 154.0, 154.0, 95.0, 94.0, 98.0], "value": 113.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 143.0, 86.0, 88.0, 96.0, 87.0, 94.0, 91.0, 88.0, 91.0], "value": 100.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 54.0, 60.0, 59.0, 60.0, 60.0, 60.0, 60.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 75.0, 76.0, 78.0, 74.0, 67.0, 68.0, 68.0, 70.0, 70.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 91.0, 86.0, 80.0, 85.0, 86.0, 89.0, 85.0, 91.0, 85.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 155.0, 165.0, 163.0, 157.0, 154.0, 158.0, 149.0, 191.0, 169.0], "value": 163.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [225.0, 174.0, 173.0, 172.0, 170.0, 173.0, 224.0, 229.0, 169.0, 168.0], "value": 187.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 66.0, 68.0, 72.0, 92.0, 86.0, 64.0, 86.0, 66.0], "value": 73.7, "unit": "score"}]}]} 10:09:51 INFO - Return code: 0 10:09:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:09:51 ERROR - # TBPL SUCCESS # 10:09:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:09:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:09:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:09:51 INFO - 2016-11-17 10:09:51.312 screenresolution[1653:10547] starting screenresolution argv=screenresolution get 10:09:51 INFO - 2016-11-17 10:09:51.314 screenresolution[1653:10547] Display 0: 1600x1200x32@60 10:09:51 INFO - 2016-11-17 10:09:51.320 screenresolution[1654:10550] starting screenresolution argv=screenresolution list 10:09:51 INFO - Available Modes on Display 0 10:09:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:09:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:09:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:09:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:09:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:09:51 INFO - Intel Iris: 10:09:51 INFO - Chipset Model: Intel Iris 10:09:51 INFO - Type: GPU 10:09:51 INFO - Bus: Built-In 10:09:51 INFO - VRAM (Dynamic, Max): 1536 MB 10:09:51 INFO - Vendor: Intel (0x8086) 10:09:51 INFO - Device ID: 0x0a2e 10:09:51 INFO - Revision ID: 0x0009 10:09:51 INFO - Displays: 10:09:51 INFO - Display: 10:09:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:09:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:09:51 INFO - Display Serial Number: 1600x1200 60 10:09:51 INFO - Main Display: Yes 10:09:51 INFO - Mirror: Off 10:09:51 INFO - Online: Yes 10:09:51 INFO - Rotation: Supported 10:09:51 INFO - Return code: 0 10:09:51 INFO - Running post-action listener: _resource_record_post_action 10:09:51 INFO - [mozharness: 2016-11-17 18:09:51.559538Z] Finished run-tests step (success) 10:09:51 INFO - Running post-run listener: _resource_record_post_run 10:09:51 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 38196224; Write bytes: 654525952; Read time: 373; Write time: 1940 10:09:51 INFO - TinderboxPrint: CPU usage
54.3% 10:09:51 INFO - TinderboxPrint: I/O read bytes / time
38,196,224 / 373 10:09:51 INFO - TinderboxPrint: I/O write bytes / time
654,525,952 / 1,940 10:09:51 INFO - TinderboxPrint: CPU idle
2,209.8 (45.7%) 10:09:51 INFO - TinderboxPrint: CPU system
974.2 (20.1%) 10:09:51 INFO - TinderboxPrint: CPU user
1,653.6 (34.2%) 10:09:51 INFO - TinderboxPrint: Swap in / out
391,122,944 / 0 10:09:51 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 354142720; Write bytes: 354702848; Read time: 27611; Write time: 633 10:09:51 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 34419712; Write bytes: 298332160; Read time: 343; Write time: 1300 10:09:52 INFO - Running post-run listener: _upload_blobber_files 10:09:52 INFO - Blob upload gear active. 10:09:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:09:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:09:52 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'] 10:09:52 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 10:09:52 INFO - (blobuploader) - INFO - Open directory for files ... 10:09:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:09:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:09:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:53 INFO - (blobuploader) - INFO - Done attempting. 10:09:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:09:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:09:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:54 INFO - (blobuploader) - INFO - Done attempting. 10:09:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:09:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:09:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:56 INFO - (blobuploader) - INFO - Done attempting. 10:09:56 INFO - (blobuploader) - INFO - Iteration through files over. 10:09:56 INFO - Return code: 0 10:09:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:09:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:09:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/345cb78ceef4d41f7a38e7c860055704f6045a414f801a51a803cdf3785b1f6243101fd0839fd176e9b7ff910104c5411c3276638379755b7bf39ae6c70c696f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4cda6b285c139c4db892c81b6632b345a491b6f7618d55a1a38e105cb411b530153e4d4b9c45f2be5a3615ce4e80c328d5e356f17c5fca774f2c4cbe6a6a531c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbdce0a0a7722e6004f935f692026fbb47ae32832f859c32503233c8826be61b4929583c2ff344757bff7de7cca29a3474b2b6a8a668819eb40663389f220714"} 10:09:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:09:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:09:56 INFO - Contents: 10:09:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/345cb78ceef4d41f7a38e7c860055704f6045a414f801a51a803cdf3785b1f6243101fd0839fd176e9b7ff910104c5411c3276638379755b7bf39ae6c70c696f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4cda6b285c139c4db892c81b6632b345a491b6f7618d55a1a38e105cb411b530153e4d4b9c45f2be5a3615ce4e80c328d5e356f17c5fca774f2c4cbe6a6a531c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbdce0a0a7722e6004f935f692026fbb47ae32832f859c32503233c8826be61b4929583c2ff344757bff7de7cca29a3474b2b6a8a668819eb40663389f220714"} 10:09:56 INFO - Running post-run listener: copy_logs_to_upload_dir 10:09:56 INFO - Copying logs to upload dir... 10:09:56 INFO - mkdir: /builds/slave/test/build/upload/logs 10:09:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.904642 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-11-17 10:09:56.756989) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 10:09:56.760251) ========= 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.wY3ovUFa2C/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.IJQSZAJE7Z/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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/345cb78ceef4d41f7a38e7c860055704f6045a414f801a51a803cdf3785b1f6243101fd0839fd176e9b7ff910104c5411c3276638379755b7bf39ae6c70c696f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4cda6b285c139c4db892c81b6632b345a491b6f7618d55a1a38e105cb411b530153e4d4b9c45f2be5a3615ce4e80c328d5e356f17c5fca774f2c4cbe6a6a531c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbdce0a0a7722e6004f935f692026fbb47ae32832f859c32503233c8826be61b4929583c2ff344757bff7de7cca29a3474b2b6a8a668819eb40663389f220714"} build_url:https://queue.taskcluster.net/v1/task/VL7YjAIOT3un8Cf23IFaEA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011228 build_url: 'https://queue.taskcluster.net/v1/task/VL7YjAIOT3un8Cf23IFaEA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/345cb78ceef4d41f7a38e7c860055704f6045a414f801a51a803cdf3785b1f6243101fd0839fd176e9b7ff910104c5411c3276638379755b7bf39ae6c70c696f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4cda6b285c139c4db892c81b6632b345a491b6f7618d55a1a38e105cb411b530153e4d4b9c45f2be5a3615ce4e80c328d5e356f17c5fca774f2c4cbe6a6a531c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbdce0a0a7722e6004f935f692026fbb47ae32832f859c32503233c8826be61b4929583c2ff344757bff7de7cca29a3474b2b6a8a668819eb40663389f220714"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 10:09:56.793716) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 10:09:56.794058) ========= 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.wY3ovUFa2C/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.IJQSZAJE7Z/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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.005049 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 10:09:56.842875) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 10:09:56.843199) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 10:09:56.843523) ========= ========= Total master_lag: 0.17 =========