builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0307 starttime: 1480262519.38 results: success (0) buildid: 20161127062019 builduid: 2805ce11bfd340a3a0860e2a3d8fff33 revision: d8e4710b55d980cb3a63f8bae224595d7ef256a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-27 08:01:59.382390) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-27 08:01:59.382770) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-27 08:01:59.383074) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-27 08:01:59.408112) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 08:01:59.408494) ========= 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.OPLBTwsAqC/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.KA1LPEC7G6/Listeners TMPDIR=/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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-27 08:01:59-- 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% 8.22M=0.001s 2016-11-27 08:01:59 (8.22 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.489798 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 08:01:59.926954) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 08:01:59.927237) ========= 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.OPLBTwsAqC/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.KA1LPEC7G6/Listeners TMPDIR=/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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.020782 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 08:01:59.991405) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-27 08:01:59.991791) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d8e4710b55d980cb3a63f8bae224595d7ef256a0 --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 d8e4710b55d980cb3a63f8bae224595d7ef256a0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OPLBTwsAqC/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.KA1LPEC7G6/Listeners TMPDIR=/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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-27 08:02:00,081 truncating revision to first 12 chars 2016-11-27 08:02:00,081 Setting DEBUG logging. 2016-11-27 08:02:00,081 attempt 1/10 2016-11-27 08:02:00,081 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d8e4710b55d9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-27 08:02:01,160 unpacking tar archive at: mozilla-aurora-d8e4710b55d9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.340111 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-27 08:02:01.361441) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-27 08:02:01.361805) ========= script_repo_revision: d8e4710b55d980cb3a63f8bae224595d7ef256a0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-27 08:02:01.362210) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-27 08:02:01.362473) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-27 08:02:01.382635) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-11-27 08:02:01.383093) ========= /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.OPLBTwsAqC/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.KA1LPEC7G6/Listeners TMPDIR=/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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 08:02:01 INFO - MultiFileLogger online at 20161127 08:02:01 in /builds/slave/test 08:02:01 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 08:02:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:02:01 INFO - {'append_to_log': False, 08:02:01 INFO - 'base_work_dir': '/builds/slave/test', 08:02:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:02:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:02:01 INFO - 'branch': 'Mozilla-Aurora', 08:02:01 INFO - 'buildbot_json_path': 'buildprops.json', 08:02:01 INFO - 'config_files': ('talos/mac_config.py',), 08:02:01 INFO - 'default_actions': ('clobber', 08:02:01 INFO - 'read-buildbot-config', 08:02:01 INFO - 'download-and-extract', 08:02:01 INFO - 'populate-webroot', 08:02:01 INFO - 'create-virtualenv', 08:02:01 INFO - 'install', 08:02:01 INFO - 'run-tests'), 08:02:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:02:01 INFO - 'download_minidump_stackwalk': True, 08:02:01 INFO - 'download_symbols': 'ondemand', 08:02:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:02:01 INFO - 'tooltool.py': '/tools/tooltool.py', 08:02:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:02:01 INFO - '/tools/misc-python/virtualenv.py')}, 08:02:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:02:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:02:01 INFO - 'installer_path': 'installer.exe', 08:02:01 INFO - 'log_level': 'info', 08:02:01 INFO - 'log_name': 'talos', 08:02:01 INFO - 'log_to_console': True, 08:02:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:02:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:02:01 INFO - 'opt_config_files': (), 08:02:01 INFO - 'pip_index': False, 08:02:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:02:01 INFO - 'cmd': ('bash', 08:02:01 INFO - '-c', 08:02:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:02:01 INFO - 'enabled': True, 08:02:01 INFO - 'halt_on_failure': False, 08:02:01 INFO - 'name': 'check_screen_resolution'},), 08:02:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:02:01 INFO - 'cmd': ('bash', 08:02:01 INFO - '-c', 08:02:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:02:01 INFO - 'enabled': True, 08:02:01 INFO - 'halt_on_failure': False, 08:02:01 INFO - 'name': 'check_screen_resolution'},), 08:02:01 INFO - 'run_cmd_checks_enabled': True, 08:02:01 INFO - 'sps_profile': False, 08:02:01 INFO - 'sps_profile_interval': 0, 08:02:01 INFO - 'suite': 'dromaeojs-e10s', 08:02:01 INFO - 'system_bits': '32', 08:02:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:02:01 INFO - 'title': 't-yosemite-r7-0307', 08:02:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:02:01 INFO - 'use_talos_json': True, 08:02:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:02:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:02:01 INFO - 'work_dir': 'build'} 08:02:01 INFO - [mozharness: 2016-11-27 16:02:01.587847Z] Running clobber step. 08:02:01 INFO - Running pre-action listener: _resource_record_pre_action 08:02:01 INFO - Running main action method: clobber 08:02:01 INFO - rmtree: /builds/slave/test/build 08:02:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:02:02 INFO - Running post-action listener: _resource_record_post_action 08:02:02 INFO - [mozharness: 2016-11-27 16:02:02.795604Z] Finished clobber step (success) 08:02:02 INFO - [mozharness: 2016-11-27 16:02:02.795889Z] Running read-buildbot-config step. 08:02:02 INFO - Running pre-action listener: _resource_record_pre_action 08:02:02 INFO - Running main action method: read_buildbot_config 08:02:02 INFO - Using buildbot properties: 08:02:02 INFO - { 08:02:02 INFO - "project": "", 08:02:02 INFO - "product": "firefox", 08:02:02 INFO - "script_repo_revision": "production", 08:02:02 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 08:02:02 INFO - "repository": "", 08:02:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 08:02:02 INFO - "buildid": "20161127062019", 08:02:02 INFO - "pgo_build": "False", 08:02:02 INFO - "basedir": "/builds/slave/test", 08:02:02 INFO - "buildnumber": 38, 08:02:02 INFO - "slavename": "t-yosemite-r7-0307", 08:02:02 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 08:02:02 INFO - "platform": "yosemite_r7", 08:02:02 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:02:02 INFO - "branch": "mozilla-aurora", 08:02:02 INFO - "repo_path": "releases/mozilla-aurora", 08:02:02 INFO - "revision": "d8e4710b55d980cb3a63f8bae224595d7ef256a0", 08:02:02 INFO - "stage_platform": "macosx64", 08:02:02 INFO - "builduid": "2805ce11bfd340a3a0860e2a3d8fff33", 08:02:02 INFO - "slavebuilddir": "test" 08:02:02 INFO - } 08:02:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/YkcB_iyAQaCz6jyl7d4McA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 08:02:02 INFO - Running post-action listener: _resource_record_post_action 08:02:02 INFO - [mozharness: 2016-11-27 16:02:02.801886Z] Finished read-buildbot-config step (success) 08:02:02 INFO - [mozharness: 2016-11-27 16:02:02.802061Z] Running download-and-extract step. 08:02:02 INFO - Running pre-action listener: _resource_record_pre_action 08:02:02 INFO - Running main action method: download_and_extract 08:02:02 INFO - mkdir: /builds/slave/test/build/tests 08:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:02 INFO - trying https://queue.taskcluster.net/v1/task/YkcB_iyAQaCz6jyl7d4McA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 08:02:02 INFO - Downloading https://queue.taskcluster.net/v1/task/YkcB_iyAQaCz6jyl7d4McA/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 08:02:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YkcB_iyAQaCz6jyl7d4McA/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 08:02:03 INFO - Downloaded 1199 bytes. 08:02:03 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:02:03 INFO - Using the following test package requirements: 08:02:03 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:02:03 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:02:03 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 08:02:03 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:02:03 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 08:02:03 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:02:03 INFO - u'jsshell-mac.zip'], 08:02:03 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:02:03 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 08:02:03 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:02:03 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:02:03 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 08:02:03 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:02:03 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 08:02:03 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:02:03 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 08:02:03 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:02:03 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 08:02:03 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:02:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YkcB_iyAQaCz6jyl7d4McA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:02:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YkcB_iyAQaCz6jyl7d4McA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:02:03 INFO - Fetch https://queue.taskcluster.net/v1/task/YkcB_iyAQaCz6jyl7d4McA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:02:04 INFO - Http code: 200 08:02:04 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 08:02:04 INFO - x-amz-cf-id: 0jTZ_iNElnqE0vGt2MH_BqyRoaDrgkRTJyM-ohVCNHSOxMB6-Q5rPg== 08:02:04 INFO - x-amz-version-id: vmwgPm21fucaJuZvTD2Wir_UI2bXi5Vq 08:02:04 INFO - Expected file size: 16278964 08:02:04 INFO - Obtained file size: 16278964 08:02:11 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 08:02:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YkcB_iyAQaCz6jyl7d4McA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:02:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YkcB_iyAQaCz6jyl7d4McA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:02:11 INFO - Fetch https://queue.taskcluster.net/v1/task/YkcB_iyAQaCz6jyl7d4McA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:02:11 INFO - Http code: 200 08:02:11 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 08:02:11 INFO - x-amz-cf-id: _xfY1RKD6_JQ4DXu5ZvLEw8QgtENrfSKYnLHvDoPnuV3BKLOZVaGkA== 08:02:11 INFO - x-amz-version-id: vmwgPm21fucaJuZvTD2Wir_UI2bXi5Vq 08:02:12 INFO - Expected file size: 16278964 08:02:12 INFO - Obtained file size: 16278964 08:02:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YkcB_iyAQaCz6jyl7d4McA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 08:02:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YkcB_iyAQaCz6jyl7d4McA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:02:18 INFO - Fetch https://queue.taskcluster.net/v1/task/YkcB_iyAQaCz6jyl7d4McA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 08:02:19 INFO - Http code: 200 08:02:19 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 08:02:19 INFO - x-amz-cf-id: rRoRlPoR5OxzD1I5DXm7Lj8F7qz437n78BnUJjAqNOZIq2Vg-EkQNA== 08:02:19 INFO - x-amz-version-id: jJCkugbfv3TWY2w2lkUHdZt0lFdmeOgm 08:02:20 INFO - Expected file size: 14409038 08:02:20 INFO - Obtained file size: 14409038 08:02:20 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')]} 08:02:20 INFO - trying https://queue.taskcluster.net/v1/task/YkcB_iyAQaCz6jyl7d4McA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:02:20 INFO - Downloading https://queue.taskcluster.net/v1/task/YkcB_iyAQaCz6jyl7d4McA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 08:02:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YkcB_iyAQaCz6jyl7d4McA/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 08:02:24 INFO - Downloaded 109739337 bytes. 08:02:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YkcB_iyAQaCz6jyl7d4McA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:02:24 INFO - mkdir: /builds/slave/test/properties 08:02:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:02:24 INFO - Writing to file /builds/slave/test/properties/build_url 08:02:24 INFO - Contents: 08:02:24 INFO - build_url:https://queue.taskcluster.net/v1/task/YkcB_iyAQaCz6jyl7d4McA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:02:25 INFO - Running post-action listener: _resource_record_post_action 08:02:25 INFO - Running post-action listener: set_extra_try_arguments 08:02:25 INFO - [mozharness: 2016-11-27 16:02:25.059297Z] Finished download-and-extract step (success) 08:02:25 INFO - [mozharness: 2016-11-27 16:02:25.059449Z] Running populate-webroot step. 08:02:25 INFO - Running pre-action listener: _resource_record_pre_action 08:02:25 INFO - Running main action method: populate_webroot 08:02:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:02:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:02:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:02:25 INFO - '--tppagecycles', 08:02:25 INFO - '7'], 08:02:25 INFO - 'tests': ['tsvgm']}}, 08:02:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:02:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:02:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:02:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:02:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:02:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:02:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:25 INFO - 'talos_options': ['--disable-e10s'], 08:02:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:02:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:02:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:25 INFO - 'talos_options': ['--disable-e10s'], 08:02:25 INFO - 'tests': ['damp', 'tps']}, 08:02:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:25 INFO - 'tests': ['damp', 'tps']}, 08:02:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:02:25 INFO - 'tests': ['dromaeo_dom']}, 08:02:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:02:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:02:25 INFO - 'tests': ['basic_compositor_video']}, 08:02:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:02:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:02:25 INFO - 'tests': ['a11yr', 08:02:25 INFO - 'ts_paint', 08:02:25 INFO - 'tpaint', 08:02:25 INFO - 'sessionrestore', 08:02:25 INFO - 'sessionrestore_no_auto_restore', 08:02:25 INFO - 'tabpaint']}, 08:02:25 INFO - 'other-e10s': {'tests': ['a11yr', 08:02:25 INFO - 'ts_paint', 08:02:25 INFO - 'tpaint', 08:02:25 INFO - 'sessionrestore', 08:02:25 INFO - 'sessionrestore_no_auto_restore', 08:02:25 INFO - 'tabpaint']}, 08:02:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:02:25 INFO - 'ts_paint', 08:02:25 INFO - 'tpaint', 08:02:25 INFO - 'sessionrestore', 08:02:25 INFO - 'sessionrestore_no_auto_restore', 08:02:25 INFO - 'tabpaint']}, 08:02:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:02:25 INFO - 'ts_paint', 08:02:25 INFO - 'tpaint', 08:02:25 INFO - 'sessionrestore', 08:02:25 INFO - 'sessionrestore_no_auto_restore', 08:02:25 INFO - 'tabpaint']}, 08:02:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:02:25 INFO - 'tests': ['a11yr', 08:02:25 INFO - 'ts_paint', 08:02:25 INFO - 'tpaint', 08:02:25 INFO - 'sessionrestore', 08:02:25 INFO - 'sessionrestore_no_auto_restore', 08:02:25 INFO - 'tabpaint']}, 08:02:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:02:25 INFO - 'tests': ['a11yr', 08:02:25 INFO - 'ts_paint', 08:02:25 INFO - 'tpaint', 08:02:25 INFO - 'sessionrestore', 08:02:25 INFO - 'sessionrestore_no_auto_restore', 08:02:25 INFO - 'tabpaint']}, 08:02:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:02:25 INFO - 'tests': ['tsvgx', 08:02:25 INFO - 'tsvgr_opacity', 08:02:25 INFO - 'tart', 08:02:25 INFO - 'tscrollx', 08:02:25 INFO - 'cart']}, 08:02:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:02:25 INFO - 'tsvgr_opacity', 08:02:25 INFO - 'tart', 08:02:25 INFO - 'tscrollx', 08:02:25 INFO - 'cart']}, 08:02:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:25 INFO - 'talos_options': ['--disable-e10s'], 08:02:25 INFO - 'tests': ['tp5o']}, 08:02:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:25 INFO - 'tests': ['tp5o']}, 08:02:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:25 INFO - 'talos_options': ['--disable-e10s', 08:02:25 INFO - '--xperf_path', 08:02:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:02:25 INFO - 'tests': ['tp5n']}, 08:02:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:25 INFO - 'talos_options': ['--xperf_path', 08:02:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:02:25 INFO - 'tests': ['tp5n']}}, 08:02:25 INFO - 'talos.zip': {'path': '', 08:02:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:02:25 INFO - Running post-action listener: _resource_record_post_action 08:02:25 INFO - [mozharness: 2016-11-27 16:02:25.077921Z] Finished populate-webroot step (success) 08:02:25 INFO - [mozharness: 2016-11-27 16:02:25.078071Z] Running create-virtualenv step. 08:02:25 INFO - Running pre-action listener: _resource_record_pre_action 08:02:25 INFO - Running main action method: create_virtualenv 08:02:25 INFO - Creating virtualenv /builds/slave/test/build/venv 08:02:25 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 08:02:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:02:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:02:25 INFO - Using real prefix '/tools/python27' 08:02:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:02:25 INFO - Installing distribute.............................................................................................................................................................................................done. 08:02:28 INFO - Installing pip.................done. 08:02:28 INFO - Return code: 0 08:02:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:02:29 INFO - Reading from file tmpfile_stdout 08:02:29 INFO - Output received: 08:02:29 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) 08:02:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:29 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 0x10b580490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa410d5ec40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b394d30>, '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 0x10b1fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b38cb20>, '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.OPLBTwsAqC/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.KA1LPEC7G6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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 08:02:29 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 08:02:29 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 08:02:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OPLBTwsAqC/Render', 08:02:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:29 INFO - 'HOME': '/Users/cltbld', 08:02:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:29 INFO - 'LOGNAME': 'cltbld', 08:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:29 INFO - 'MOZ_NO_REMOTE': '1', 08:02:29 INFO - 'NO_EM_RESTART': '1', 08:02:29 INFO - 'PAGER': '/bin/cat', 08:02:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:29 INFO - 'PWD': '/builds/slave/test', 08:02:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:29 INFO - 'SHELL': '/bin/bash', 08:02:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KA1LPEC7G6/Listeners', 08:02:29 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 08:02:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:29 INFO - 'USER': 'cltbld', 08:02:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:29 INFO - 'XPC_FLAGS': '0x0', 08:02:29 INFO - 'XPC_SERVICE_NAME': '0', 08:02:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:29 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 08:02:29 INFO - Cleaning up... 08:02:29 INFO - Return code: 0 08:02:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:29 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 0x10b580490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa410d5ec40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b394d30>, '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 0x10b1fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b38cb20>, '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.OPLBTwsAqC/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.KA1LPEC7G6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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 08:02:29 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 08:02:29 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 08:02:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OPLBTwsAqC/Render', 08:02:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:29 INFO - 'HOME': '/Users/cltbld', 08:02:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:29 INFO - 'LOGNAME': 'cltbld', 08:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:29 INFO - 'MOZ_NO_REMOTE': '1', 08:02:29 INFO - 'NO_EM_RESTART': '1', 08:02:29 INFO - 'PAGER': '/bin/cat', 08:02:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:29 INFO - 'PWD': '/builds/slave/test', 08:02:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:29 INFO - 'SHELL': '/bin/bash', 08:02:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KA1LPEC7G6/Listeners', 08:02:29 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 08:02:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:29 INFO - 'USER': 'cltbld', 08:02:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:29 INFO - 'XPC_FLAGS': '0x0', 08:02:29 INFO - 'XPC_SERVICE_NAME': '0', 08:02:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:29 INFO - Downloading/unpacking psutil>=3.1.1 08:02:29 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 08:02:29 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 08:02:29 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 08:02:29 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 08:02:29 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 08:02:29 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 08:02:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:02:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:02:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:02:33 INFO - Installing collected packages: psutil 08:02:33 INFO - Running setup.py install for psutil 08:02:33 INFO - building 'psutil._psutil_osx' extension 08:02:33 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 08:02:33 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 08:02:33 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 08:02:34 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 08:02:34 INFO - building 'psutil._psutil_posix' extension 08:02:34 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 08:02:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:02:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:02:34 INFO - ^ 08:02:34 INFO - 1 warning generated. 08:02:34 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 08:02:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:02:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:02:34 INFO - Successfully installed psutil 08:02:34 INFO - Cleaning up... 08:02:34 INFO - Return code: 0 08:02:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:02: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')]} 08:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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')]} 08:02:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:34 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 0x10b580490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa410d5ec40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b394d30>, '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 0x10b1fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b38cb20>, '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.OPLBTwsAqC/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.KA1LPEC7G6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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 08:02:34 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 08:02:34 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 08:02:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OPLBTwsAqC/Render', 08:02:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:34 INFO - 'HOME': '/Users/cltbld', 08:02:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:34 INFO - 'LOGNAME': 'cltbld', 08:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:34 INFO - 'MOZ_NO_REMOTE': '1', 08:02:34 INFO - 'NO_EM_RESTART': '1', 08:02:34 INFO - 'PAGER': '/bin/cat', 08:02:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:34 INFO - 'PWD': '/builds/slave/test', 08:02:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:34 INFO - 'SHELL': '/bin/bash', 08:02:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KA1LPEC7G6/Listeners', 08:02:34 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 08:02:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:34 INFO - 'USER': 'cltbld', 08:02:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:34 INFO - 'XPC_FLAGS': '0x0', 08:02:34 INFO - 'XPC_SERVICE_NAME': '0', 08:02:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:02:34 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 08:02:34 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 08:02:34 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 08:02:34 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 08:02:34 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 08:02:34 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 08:02:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:02:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:02:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:02:37 INFO - Installing collected packages: mozsystemmonitor 08:02:37 INFO - Running setup.py install for mozsystemmonitor 08:02:37 INFO - Successfully installed mozsystemmonitor 08:02:37 INFO - Cleaning up... 08:02:37 INFO - Return code: 0 08:02:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:02:37 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')]} 08:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:37 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')]} 08:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:37 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 0x10b580490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa410d5ec40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b394d30>, '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 0x10b1fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b38cb20>, '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.OPLBTwsAqC/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.KA1LPEC7G6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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 08:02:37 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 08:02:37 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 08:02:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OPLBTwsAqC/Render', 08:02:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:37 INFO - 'HOME': '/Users/cltbld', 08:02:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:37 INFO - 'LOGNAME': 'cltbld', 08:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:37 INFO - 'MOZ_NO_REMOTE': '1', 08:02:37 INFO - 'NO_EM_RESTART': '1', 08:02:37 INFO - 'PAGER': '/bin/cat', 08:02:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:37 INFO - 'PWD': '/builds/slave/test', 08:02:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:37 INFO - 'SHELL': '/bin/bash', 08:02:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KA1LPEC7G6/Listeners', 08:02:37 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 08:02:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:37 INFO - 'USER': 'cltbld', 08:02:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:37 INFO - 'XPC_FLAGS': '0x0', 08:02:37 INFO - 'XPC_SERVICE_NAME': '0', 08:02:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:37 INFO - Downloading/unpacking jsonschema==2.5.1 08:02:37 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 08:02:37 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 08:02:37 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 08:02:37 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 08:02:37 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 08:02:37 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 08:02:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:02:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:02:40 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 08:02:40 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 08:02:40 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 08:02:40 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 08:02:40 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 08:02:40 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 08:02:40 INFO - Downloading functools32-3.2.3-2.tar.gz 08:02:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:02:40 INFO - warning: no files found matching '*.txt' 08:02:40 INFO - no previously-included directories found matching 'build' 08:02:40 INFO - no previously-included directories found matching 'dist' 08:02:40 INFO - no previously-included directories found matching '.git*' 08:02:40 INFO - Installing collected packages: jsonschema, functools32 08:02:40 INFO - Running setup.py install for functools32 08:02:40 INFO - warning: no files found matching '*.txt' 08:02:40 INFO - no previously-included directories found matching 'build' 08:02:40 INFO - no previously-included directories found matching 'dist' 08:02:40 INFO - no previously-included directories found matching '.git*' 08:02:40 INFO - Successfully installed jsonschema functools32 08:02:40 INFO - Cleaning up... 08:02:41 INFO - Return code: 0 08:02:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:02: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')]} 08:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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')]} 08:02:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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', '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 0x10b580490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa410d5ec40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b394d30>, '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 0x10b1fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b38cb20>, '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.OPLBTwsAqC/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.KA1LPEC7G6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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 08:02: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:02: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 functools32==3.2.3-2 08:02:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OPLBTwsAqC/Render', 08:02:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:41 INFO - 'HOME': '/Users/cltbld', 08:02:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:41 INFO - 'LOGNAME': 'cltbld', 08:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:41 INFO - 'MOZ_NO_REMOTE': '1', 08:02:41 INFO - 'NO_EM_RESTART': '1', 08:02:41 INFO - 'PAGER': '/bin/cat', 08:02:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:41 INFO - 'PWD': '/builds/slave/test', 08:02:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:41 INFO - 'SHELL': '/bin/bash', 08:02:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KA1LPEC7G6/Listeners', 08:02:41 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 08:02:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:41 INFO - 'USER': 'cltbld', 08:02:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:41 INFO - 'XPC_FLAGS': '0x0', 08:02:41 INFO - 'XPC_SERVICE_NAME': '0', 08:02:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:02:41 INFO - Cleaning up... 08:02:41 INFO - Return code: 0 08:02:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:02: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')]} 08:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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')]} 08:02:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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', '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 0x10b580490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa410d5ec40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b394d30>, '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 0x10b1fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b38cb20>, '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.OPLBTwsAqC/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.KA1LPEC7G6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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 08:02: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:02: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 blobuploader==1.2.4 08:02:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OPLBTwsAqC/Render', 08:02:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:41 INFO - 'HOME': '/Users/cltbld', 08:02:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:41 INFO - 'LOGNAME': 'cltbld', 08:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:41 INFO - 'MOZ_NO_REMOTE': '1', 08:02:41 INFO - 'NO_EM_RESTART': '1', 08:02:41 INFO - 'PAGER': '/bin/cat', 08:02:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:41 INFO - 'PWD': '/builds/slave/test', 08:02:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:41 INFO - 'SHELL': '/bin/bash', 08:02:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KA1LPEC7G6/Listeners', 08:02:41 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 08:02:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:41 INFO - 'USER': 'cltbld', 08:02:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:41 INFO - 'XPC_FLAGS': '0x0', 08:02:41 INFO - 'XPC_SERVICE_NAME': '0', 08:02:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:41 INFO - Downloading/unpacking blobuploader==1.2.4 08:02:41 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 08:02:41 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 08:02:41 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 08:02:41 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 08:02:41 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 08:02:41 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 08:02:44 INFO - Downloading blobuploader-1.2.4.tar.gz 08:02:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:02:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:02:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:45 INFO - Downloading docopt-0.6.1.tar.gz 08:02:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:02:45 INFO - Installing collected packages: blobuploader, requests, docopt 08:02:45 INFO - Running setup.py install for blobuploader 08:02:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:02:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:02:45 INFO - Running setup.py install for requests 08:02:46 INFO - Running setup.py install for docopt 08:02:46 INFO - Successfully installed blobuploader requests docopt 08:02:46 INFO - Cleaning up... 08:02:46 INFO - Return code: 0 08:02:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:46 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')]} 08:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:46 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')]} 08:02:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:46 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 0x10b580490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa410d5ec40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b394d30>, '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 0x10b1fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b38cb20>, '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.OPLBTwsAqC/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.KA1LPEC7G6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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 08:02:46 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 08:02:46 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 08:02:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OPLBTwsAqC/Render', 08:02:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:46 INFO - 'HOME': '/Users/cltbld', 08:02:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:46 INFO - 'LOGNAME': 'cltbld', 08:02:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:46 INFO - 'MOZ_NO_REMOTE': '1', 08:02:46 INFO - 'NO_EM_RESTART': '1', 08:02:46 INFO - 'PAGER': '/bin/cat', 08:02:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:46 INFO - 'PWD': '/builds/slave/test', 08:02:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:46 INFO - 'SHELL': '/bin/bash', 08:02:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KA1LPEC7G6/Listeners', 08:02:46 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 08:02:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:46 INFO - 'USER': 'cltbld', 08:02:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:46 INFO - 'XPC_FLAGS': '0x0', 08:02:46 INFO - 'XPC_SERVICE_NAME': '0', 08:02:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:02:46 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-cyXi0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:02:46 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-j687FI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:02:46 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-BLt0Pk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:02:46 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-RKFAAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:02:47 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-zKu4vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:02:47 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-VX2EjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:02:47 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-5H5dEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:02:47 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-8DOUnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:02:47 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-LatUqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:02:47 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-AX4XlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:02:47 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-itf8Qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:02:47 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-eje7uA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:02:47 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-GAuOjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:02:48 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-hL0bjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:48 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-Pdd2b_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:02:48 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-lHWAOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:02:48 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-mjfupD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:02:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:02:48 INFO - Running setup.py install for manifestparser 08:02:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:02:48 INFO - Running setup.py install for mozcrash 08:02:48 INFO - Running setup.py install for mozdebug 08:02:48 INFO - Running setup.py install for mozdevice 08:02:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:02:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:02:49 INFO - Running setup.py install for mozfile 08:02:49 INFO - Running setup.py install for mozhttpd 08:02:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:02:49 INFO - Running setup.py install for mozinfo 08:02:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:02:49 INFO - Running setup.py install for mozInstall 08:02:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:02:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:02:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:02:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:02:49 INFO - Running setup.py install for mozleak 08:02:49 INFO - Running setup.py install for mozlog 08:02:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:02:49 INFO - Running setup.py install for moznetwork 08:02:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:02:50 INFO - Running setup.py install for mozprocess 08:02:50 INFO - Running setup.py install for mozprofile 08:02:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:02:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:02:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:02:50 INFO - Running setup.py install for mozrunner 08:02:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:02:50 INFO - Running setup.py install for mozscreenshot 08:02:50 INFO - Running setup.py install for moztest 08:02:50 INFO - Running setup.py install for mozversion 08:02:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:02:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:02:51 INFO - Cleaning up... 08:02:51 INFO - Return code: 0 08:02:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:51 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 0x10b580490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa410d5ec40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b394d30>, '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 0x10b1fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b38cb20>, '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.OPLBTwsAqC/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.KA1LPEC7G6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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 08:02:51 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 08:02:51 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 08:02:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OPLBTwsAqC/Render', 08:02:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:51 INFO - 'HOME': '/Users/cltbld', 08:02:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:51 INFO - 'LOGNAME': 'cltbld', 08:02:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:51 INFO - 'MOZ_NO_REMOTE': '1', 08:02:51 INFO - 'NO_EM_RESTART': '1', 08:02:51 INFO - 'PAGER': '/bin/cat', 08:02:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:51 INFO - 'PWD': '/builds/slave/test', 08:02:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:51 INFO - 'SHELL': '/bin/bash', 08:02:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KA1LPEC7G6/Listeners', 08:02:51 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 08:02:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:51 INFO - 'USER': 'cltbld', 08:02:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:51 INFO - 'XPC_FLAGS': '0x0', 08:02:51 INFO - 'XPC_SERVICE_NAME': '0', 08:02:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:02:51 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-gidYSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:02:51 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)) 08:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:02:51 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-b5KLyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:02:51 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)) 08:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:02:51 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-aPBMbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:02:51 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)) 08:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:02:51 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-5KDfCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:02:51 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)) 08:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:02:51 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-oxjMV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:02:51 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)) 08:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:02:51 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-rsKtmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:02:51 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)) 08:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:02:51 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-mOEsPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:02:52 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)) 08:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:02:52 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-RN92ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:02:52 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)) 08:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:02:52 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-eVit4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:02:52 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)) 08:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:02:52 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-oIp8P4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:02:52 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)) 08:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:02:52 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-xd9Y4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:02:52 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)) 08:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:02:52 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-JStok4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:02:52 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)) 08:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:02:52 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-j9WS4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:02:52 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)) 08:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:02:52 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-4tX_nz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:02:52 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)) 08:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:52 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-1Cq3SJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:52 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)) 08:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:02:52 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-eNQgMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:02:53 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)) 08:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:02:53 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-MilnDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:02:53 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)) 08:02:53 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)) 08:02:53 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)) 08:02:53 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)) 08:02:53 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)) 08:02:53 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)) 08:02:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:55 INFO - Downloading blessings-1.6.tar.gz 08:02:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:02:55 INFO - Installing collected packages: blessings 08:02:55 INFO - Running setup.py install for blessings 08:02:55 INFO - Successfully installed blessings 08:02:55 INFO - Cleaning up... 08:02:56 INFO - Return code: 0 08:02:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:02:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:02:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:02:56 INFO - Reading from file tmpfile_stdout 08:02:56 INFO - Current package versions: 08:02:56 INFO - blessings == 1.6 08:02:56 INFO - blobuploader == 1.2.4 08:02:56 INFO - docopt == 0.6.1 08:02:56 INFO - functools32 == 3.2.3-2 08:02:56 INFO - jsonschema == 2.5.1 08:02:56 INFO - manifestparser == 1.1 08:02:56 INFO - mozInstall == 1.12 08:02:56 INFO - mozcrash == 1.0 08:02:56 INFO - mozdebug == 0.1 08:02:56 INFO - mozdevice == 0.48 08:02:56 INFO - mozfile == 1.2 08:02:56 INFO - mozhttpd == 0.7 08:02:56 INFO - mozinfo == 0.9 08:02:56 INFO - mozleak == 0.1 08:02:56 INFO - mozlog == 3.4 08:02:56 INFO - moznetwork == 0.27 08:02:56 INFO - mozprocess == 0.23 08:02:56 INFO - mozprofile == 0.28 08:02:56 INFO - mozrunner == 6.13 08:02:56 INFO - mozscreenshot == 0.1 08:02:56 INFO - mozsystemmonitor == 0.3 08:02:56 INFO - moztest == 0.7 08:02:56 INFO - mozversion == 1.4 08:02:56 INFO - psutil == 3.1.1 08:02:56 INFO - requests == 1.2.3 08:02:56 INFO - wsgiref == 0.1.2 08:02:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:56 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 0x10b580490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa410d5ec40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b394d30>, '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 0x10b1fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b38cb20>, '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.OPLBTwsAqC/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.KA1LPEC7G6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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 08:02:56 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 08:02:56 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 08:02:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OPLBTwsAqC/Render', 08:02:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:56 INFO - 'HOME': '/Users/cltbld', 08:02:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:56 INFO - 'LOGNAME': 'cltbld', 08:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:56 INFO - 'MOZ_NO_REMOTE': '1', 08:02:56 INFO - 'NO_EM_RESTART': '1', 08:02:56 INFO - 'PAGER': '/bin/cat', 08:02:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:56 INFO - 'PWD': '/builds/slave/test', 08:02:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:56 INFO - 'SHELL': '/bin/bash', 08:02:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KA1LPEC7G6/Listeners', 08:02:56 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 08:02:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:56 INFO - 'USER': 'cltbld', 08:02:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:56 INFO - 'XPC_FLAGS': '0x0', 08:02:56 INFO - 'XPC_SERVICE_NAME': '0', 08:02:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:56 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)) 08:02:56 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)) 08:02:56 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)) 08:02:56 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)) 08:02:56 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)) 08:02:56 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)) 08:02:56 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)) 08:02:56 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)) 08:02:56 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)) 08:02:56 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)) 08:02:56 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)) 08:02:56 INFO - Cleaning up... 08:02:56 INFO - Return code: 0 08:02:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b580490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa410d5ec40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b394d30>, '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 0x10b1fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b38cb20>, '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.OPLBTwsAqC/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.KA1LPEC7G6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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 08:02:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:02:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:02:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OPLBTwsAqC/Render', 08:02:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:56 INFO - 'HOME': '/Users/cltbld', 08:02:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:56 INFO - 'LOGNAME': 'cltbld', 08:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:56 INFO - 'MOZ_NO_REMOTE': '1', 08:02:56 INFO - 'NO_EM_RESTART': '1', 08:02:56 INFO - 'PAGER': '/bin/cat', 08:02:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:56 INFO - 'PWD': '/builds/slave/test', 08:02:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:56 INFO - 'SHELL': '/bin/bash', 08:02:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KA1LPEC7G6/Listeners', 08:02:56 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 08:02:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:56 INFO - 'USER': 'cltbld', 08:02:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:56 INFO - 'XPC_FLAGS': '0x0', 08:02:56 INFO - 'XPC_SERVICE_NAME': '0', 08:02:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:02:56 INFO - Cleaning up... 08:02:56 INFO - Return code: 0 08:02:56 INFO - Running post-action listener: _resource_record_post_action 08:02:56 INFO - Running post-action listener: _start_resource_monitoring 08:02:56 INFO - Starting resource monitoring. 08:02:56 INFO - [mozharness: 2016-11-27 16:02:56.939282Z] Finished create-virtualenv step (success) 08:02:56 INFO - [mozharness: 2016-11-27 16:02:56.940278Z] Running install step. 08:02:56 INFO - Running pre-action listener: _resource_record_pre_action 08:02:56 INFO - Running main action method: install 08:02:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:02:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:02:57 INFO - Reading from file tmpfile_stdout 08:02:57 INFO - Detecting whether we're running mozinstall >=1.0... 08:02:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:02:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:02:57 INFO - Reading from file tmpfile_stdout 08:02:57 INFO - Output received: 08:02:57 INFO - Usage: mozinstall [options] installer 08:02:57 INFO - Options: 08:02:57 INFO - -h, --help show this help message and exit 08:02:57 INFO - -d DEST, --destination=DEST 08:02:57 INFO - Directory to install application into. [default: 08:02:57 INFO - "/builds/slave/test"] 08:02:57 INFO - --app=APP Application being installed. [default: firefox] 08:02:57 INFO - mkdir: /builds/slave/test/build/application 08:02:57 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'] 08:02:57 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 08:03:29 INFO - Reading from file tmpfile_stdout 08:03:29 INFO - Output received: 08:03:29 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:03:29 INFO - Running post-action listener: _resource_record_post_action 08:03:29 INFO - [mozharness: 2016-11-27 16:03:29.211017Z] Finished install step (success) 08:03:29 INFO - [mozharness: 2016-11-27 16:03:29.211158Z] Running run-tests step. 08:03:29 INFO - Running pre-action listener: _resource_record_pre_action 08:03:29 INFO - Running main action method: run_tests 08:03:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:03:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:03:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:03:29 INFO - 2016-11-27 08:03:29.225 screenresolution[1909:29627] starting screenresolution argv=screenresolution get 08:03:29 INFO - 2016-11-27 08:03:29.228 screenresolution[1909:29627] Display 0: 1600x1200x32@60 08:03:29 INFO - 2016-11-27 08:03:29.234 screenresolution[1910:29630] starting screenresolution argv=screenresolution list 08:03:29 INFO - Available Modes on Display 0 08:03:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:03:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:03:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:03:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:03:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:03:29 INFO - Intel Iris: 08:03:29 INFO - Chipset Model: Intel Iris 08:03:29 INFO - Type: GPU 08:03:29 INFO - Bus: Built-In 08:03:29 INFO - VRAM (Dynamic, Max): 1536 MB 08:03:29 INFO - Vendor: Intel (0x8086) 08:03:29 INFO - Device ID: 0x0a2e 08:03:29 INFO - Revision ID: 0x0009 08:03:29 INFO - Displays: 08:03:29 INFO - Display: 08:03:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:03:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:03:29 INFO - Display Serial Number: 1600x1200 60 08:03:29 INFO - Main Display: Yes 08:03:29 INFO - Mirror: Off 08:03:29 INFO - Online: Yes 08:03:29 INFO - Rotation: Supported 08:03:29 INFO - Return code: 0 08:03:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:03:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:03:29 INFO - Python 2.7.3 08:03:29 INFO - Return code: 0 08:03:29 INFO - grabbing minidump binary from tooltool 08:03:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b394d30>, '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 0x10b1fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b38cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:03:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:03:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:03:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:03:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:03:29 INFO - Return code: 0 08:03:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:03:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:03:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:03:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:03:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:03:29 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/YkcB_iyAQaCz6jyl7d4McA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0307', '--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 08:03:29 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/YkcB_iyAQaCz6jyl7d4McA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0307 --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 08:03:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OPLBTwsAqC/Render', 08:03:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:29 INFO - 'HOME': '/Users/cltbld', 08:03:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:29 INFO - 'LOGNAME': 'cltbld', 08:03:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:03:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:03:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:29 INFO - 'MOZ_NO_REMOTE': '1', 08:03:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:03:29 INFO - 'NO_EM_RESTART': '1', 08:03:29 INFO - 'PAGER': '/bin/cat', 08:03:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:29 INFO - 'PWD': '/builds/slave/test', 08:03:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:03:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:29 INFO - 'SHELL': '/bin/bash', 08:03:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KA1LPEC7G6/Listeners', 08:03:29 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 08:03:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:29 INFO - 'USER': 'cltbld', 08:03:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:29 INFO - 'XPC_FLAGS': '0x0', 08:03:29 INFO - 'XPC_SERVICE_NAME': '0', 08:03:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:29 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/YkcB_iyAQaCz6jyl7d4McA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0307', '--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 08:03:29 INFO - mozversion application_buildid: 20161127062019 08:03:29 INFO - mozversion application_changeset: d8e4710b55d980cb3a63f8bae224595d7ef256a0 08:03:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:03:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:03:29 INFO - mozversion application_name: Firefox 08:03:29 INFO - mozversion application_remotingname: firefox-dev 08:03:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:03:29 INFO - mozversion application_vendor: Mozilla 08:03:29 INFO - mozversion application_version: 52.0a2 08:03:29 INFO - mozversion platform_buildid: 20161127062019 08:03:29 INFO - mozversion platform_changeset: d8e4710b55d980cb3a63f8bae224595d7ef256a0 08:03:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:03:29 INFO - mozversion platform_version: 52.0a2 08:03:29 INFO - using testdate: 1480262609 08:03:29 INFO - actual date: 1480262609 08:03:29 INFO - starting webserver on 'localhost:49620' 08:03:29 INFO - SUITE-START | Running 2 tests 08:03:29 INFO - TEST-START | dromaeo_css 08:03:29 INFO - operating with platform_type : mac_ 08:03:29 INFO - Initialising browser for dromaeo_css test... 08:03:29 INFO - TEST-INFO | started process 1920 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/tmpkriLrZ/profile http://localhost:49620/getInfo.html) 08:03:32 INFO - PROCESS | 1920 | __metrics Screen width/height:1600/1200 08:03:32 INFO - PROCESS | 1920 | colorDepth:24 08:03:32 INFO - PROCESS | 1920 | Browser inner width/height: 1024/689 08:03:32 INFO - PROCESS | 1920 | __metrics 08:03:32 ERROR - PROCESS | 1920 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 08:03:33 INFO - TEST-INFO | 1920: exit 0 08:03:33 INFO - Browser initialized. 08:03:33 INFO - Running cycle 1/1 for dromaeo_css test... 08:03:33 INFO - TEST-INFO | started process 1924 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/tmpkriLrZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:03:45 INFO - PROCESS | 1924 | RSS: Main: 229916672 08:03:45 INFO - PROCESS | 1924 | 08:04:35 INFO - PROCESS | 1924 | 1480262675643 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] 08:06:49 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49620/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49620/tests/dromaeo/cssquery-ext.html) 08:06:51 INFO - PROCESS | 1924 | RSS: Main: 234356736 08:06:51 INFO - PROCESS | 1924 | 08:09:53 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49620/tests/dromaeo/cssquery-ext.html (next: http://localhost:49620/tests/dromaeo/cssquery-jquery.html) 08:09:54 INFO - PROCESS | 1924 | RSS: Main: 244011008 08:09:54 INFO - PROCESS | 1924 | 08:12:56 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49620/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49620/tests/dromaeo/cssquery-mootools.html) 08:12:57 INFO - PROCESS | 1924 | RSS: Main: 246726656 08:12:57 INFO - PROCESS | 1924 | 08:15:58 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49620/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49620/tests/dromaeo/cssquery-prototype.html) 08:15:59 INFO - PROCESS | 1924 | RSS: Main: 245911552 08:15:59 INFO - PROCESS | 1924 | 08:19:02 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49620/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49620/tests/dromaeo/cssquery-yui.html) 08:19:02 INFO - PROCESS | 1924 | RSS: Main: 249319424 08:19:02 INFO - PROCESS | 1924 | 08:22:05 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49620/tests/dromaeo/cssquery-yui.html (next: http://localhost:49620/tests/dromaeo/cssquery-dojo.html) 08:22:05 INFO - PROCESS | 1924 | RSS: Main: 250753024 08:22:05 INFO - PROCESS | 1924 | 08:22:05 INFO - PROCESS | 1924 | __start_tp_report 08:22:05 INFO - PROCESS | 1924 | _x_x_mozilla_page_load 08:22:05 INFO - PROCESS | 1924 | _x_x_mozilla_page_load_details 08:22:05 INFO - PROCESS | 1924 | |i|pagename|runs| 08:22:05 INFO - PROCESS | 1924 | |0;dojo.html;3052.7863049586526;3209.828412629391;3370.52812606235;3376.3584918865413;3419.247765491592;5144.893847822717;5343.358796944367;5459.672419654824;5703.600747947646;5814.74982878681;4490.618297444721;5039.949600504003;5795.362510123883;5856.297244330675;5931.88136237275;3908.589598092202;4968.9565191309775;5163.457836927125;5381.219723140142;5386.676799392029;4786.89901322696;4924.729139897304;5341.839744807662;5388.272583201257;5401.3248343957;5216.400113986902;5216.452272511388;5320.600954928376;5376.623636345457;5380.704061276629;4780.426348838144;5319.946800531984;5331.786728530854;5338.359396872381;5345.518903298683;5145.948540514584;5268.973655131738;5269;5277.525022747971;5277.86805329866;5811.6803575803315;5915.467607915265;5976.103584462322;6040.063790112496;6055;6055.757769689207;6217.937820621781;6220.03589443637;6228.159198508189;6254.21822272216;6157.261128664544;6209.130721698965;6215.627062376272;6235.127082208494;6252.187215661935;5818.679972601505;5843.503302219359;5849.151872978395;5857.912131318034;5861.70691465425;6162.291336496271;6169.691515424301;6192.752289908353;6303.2751233607805;6345.714442850082;6144.477719393902;6219.533534984804;6221.3778622138325;6231.937680623227;6251.28110267316;6129.570930034944;6231.844203894939;6252.343503932113;6258.687065646699;6260.373962603703;6134.528431832413;6145.279321789906;6187.412195841388;6202.038684003896;6226.782062627786;6157.538184636171;6198.349173336825;6217.813465596039;6231.657258850807;6234.875302493925;4978.153713868651;4987.725675087832;4989.326440930428;4993.251012348104;5015.949840501621;4336.674749393745;4366.104948485553;4375.846845360397;4382.956170438319;4431.62331201845;5805.564582656318;5974.820755377345;6033.909491357633;6048;6084.5132389408745;6216.751329946842;6221.5333849961435;6248.375162483715;6252.218472690914;6267.40459656341;5732.254806875079;5770.451807078321;5790.652560846363;5910.113482977502;6038.849028774316;5336.813211537577;5403.378611459654;5408.513233808976;5425.972870135624;5495.175723641406;6155.4767844731905;6204.751809927733;6356.77751278703;6370.649614271167;6395.5842870212355;6153.692315384303;6175.752969881334;6181.81454556364;6195.690215489118;6272.717727702356;6150.907736383869;6157.815265542041;6216.285127210429;6393.073004414427;6437.645929473737;4691.7184968901975;4981.003799240094;5490.890182196254;5869.826034792973;6228.906566401598;6220.595661282002;6221.5333849960525;6232.968835155976;6241.656708881055;6324;5794.275715535558;6164.630122192682;6185.103160041679;6191.19514463117;6223.097650840512;5837.29952405714;6134.620279381683;6137.263528376623;6156.507479401726;6177.660228687465;4408.6693497987135;6032.849178770566;6122.081687746873;6136.846578835565;6146.446819786241;6127.295361033538;6187.690615469299;6235.438810507076;6241.188645476059;6252.124702541739;4512;4665.6734028617675;5985.6408615483215;6008.8798224036145;6079.1185278133535 08:22:05 INFO - PROCESS | 1924 | |1;ext.html;483.93534224705655;503.9244113382993;519.3741541442562;538.1309185665152;540.4541413172697;32455.67544324556;40021;40593.98515037122;43229.7838510807;43863.78068109663;41592.79203603986;42096.57903420965;42502.78748606252;42598.787006065;42772;9304.627814887397;9421.387609805375;9494.38286511378;9498.762530936747;9521.143097121258;9441.716748497522;9493.430394176337;9537.380070295443;9574.617015319414;9587.376820506679;9482;9483.762905927339;9534.09426104519;9578.75476188098;9588.137067663909;9350.57922393494;9478.146966772989;9543.713688589354;9562.378445401027;9566.426014439086;9282.72151835446;9292.303077269233;9341.065893410672;9435.395982682892;9438.480883551401;39984.80007599943;40324.79837600793;40367.19265614671;40369.39445908314;40506.1898762026;3204.2630195055035;3419.743519236042;3518.5777706675362;3657.1954170082804;3899.3566061600086;27849;28930.27674308138;29287.560686589717;29300.827966881297;29316.560251596242;3122.469180239365;3180.793248438844;3213.4858422652264;3308.801471911693;3355.7818741781707;501200;504298;508222;508991.4550427261;510550.4472477651;61235.38764612386;61490.69254653787;61881.38118618756;61908.76182476325;62247;65728.68542629217;66382.33617663762;66444;66464.66767666131;66500.66749666221;16284.75572866408;16538.50384488467;16540.172991350624;16546;16578.419755308747;12453.066020048533;12627.11610187278;12639.620811375673;12671.176373535875;12671.936640316739;17813.990804752488;18952;18970.52573685669;19046.714299285522;19105.522361941064;7415.814604634819;7565.243475652391;7761.72833950809;7796.142424333319;7817.765467035884;885.9025507194203;957.2294303086082;1005.5575546759402;1071.3357718214756;1074.8710154781477;29370.853145734134;29713;29755.85122074419;30376.392472150434;30612.693873060984;927.7958849053198;1040.70339953113;1054.146141625286;1073.431081526792;1097.6542389147394;11963.581274655346;15110.244487775568;15390.153541555099;15400.998935069185;15648.94588478167;649666;660740;666033;673786;674213;57989.4201057984;58325.416745832;58437;58569.12146317809;58636.41363586309;1352.2089577597217;1353.9729205416033;1377;1382.5506710319187;1385.0996852046048;29037.564436533048;29529.81880724747;29733;30120.69879301179;30497;51016.724581884264;51734.482655172964;51881;51885.740571296905;52008.95982080413;505942.4702876462;509978;510661;510765;599375;20054.398368048984;25701;25975;26082.86958565195;26723.06469273566;43012.13975720405;43669.944591424406;44324;44371.77814110909;44415;35842;37411.62588374082;37533;38432.847014589606;39100.6089939097;29575;37144.628553714116;37346.626533734314;37418.251634967695;37668.62331376651;37065.81467092647;37350.8132459336;37404.625953741204;38752.80623596864;39533.80233098816;27307.453850922473;33064.50403244001;35000.29999399947;35159;35315.64684353226;25926.87036564805;26099.956001759718;26108.955641774875;26323.868380657976;26408.433195763053 08:22:05 INFO - PROCESS | 1924 | |2;jquery.html;362.0730928822215;368.6147975365741;376.6515972725229;376.89569561185715;393.46292310995483;18419.35532256371;18898.622027559442;19644.312449064284;19673.409797706074;19860.70208946867;11233.887661123386;11889.989350905184;11904.16670833042;11915.225510341821;11924.403779811018;5320.388155362135;5952.375000624937;5982.611130276518;5997.280326360821;6015.608985415955;3841.865534706286;4050.939235911449;4673.299005149221;5876.853078673046;5987.730552125143;5950.910736338937;6056.091586262052;6065.909011364833;6078.17944577483;6096.055111457731;6006.8498287542725;6044.335123136451;6552.7378904843745;6627.635480048595;6642.900356494656;5622.662640241558;5719.170720245541;5727.914081288784;5847.824565263007;5896;22829.88585057064;23805.880970595037;24057;24365.878170609034;24700.876495617405;2146.173723116611;2194.7037149984867;2197.143114185469;2582.21242521031;2750.009996401314;9408.341416100875;9735.490998895182;9894;10030.899691003142;10340.482975851177;1593.9760903586455;1863.450282166764;1873.878197917131;1875.0530981854213;1935.3710044235538;117350;118342;119141.21288180684;119410;122929.99999999911;11420.600278990361;11516.827247591293;11643.126765492452;11647.475863586158;11853.762924741457;11826.763464730657;13417.597472075853;14673.559793206008;14710.117392956457;14740.557783266304;7244.38422734063;8015.238552337519;8513.361497887683;8515.957420212859;8627.741167764978;6640.169978752656;7139.750108746272;8318.500889946623;8374.246317831425;8521.829563408697;3936.3111455495173;4407.992871595119;4511.751853648016;4569.451665800125;4643.814247430065;1675.9413420530466;1763.6737203617372;1853.3698542495615;1915;1982.7521559805025;860.2257967828879;902.9006809250977;906.7461110888962;915.4187091197005;969.5297780576415;16719.49841504757;19715.014249287477;19772.604547908963;20635.484112896997;20664.690029649566;836.8744688296804;930.8650245714468;949.5062567464879;965.8020105878278;990.4651488196438;10159.9492002541;10716.517756700967;10745.623903163352;10791.946040269906;10799.136069114453;541814;597985;601120;613575;615035;99505.50247248718;112594;130455;131769.34115329362;134501;935.504182783126;1004.8844382895915;1010.7321559786516;1048.224314007629;1079.9622013229657;18337.899726016483;18837.717434238224;18970.241190352783;19002.524936876136;19224.173703498145;45754.54245457503;52293.47706522886;54580.45419545754;54599.18101228564;56435;69874.60250794854;72037.6398118006;79169;79229;79832.60083699544;6393.936060639334;7413.481056326221;7909;8138.430309878252;8226.012878454623;11668.299902005907;12084.274943503418;12808.935955320536;12832;12868.391451068617;10402.895971040192;10554.683359499228;10774.892251077703;10811.405372704578;10954.178436617127;8554.059053504234;10321.432321222404;10539.94730026345;10831.404272764757;11701.414929253673;10902.400367979837;11031;11269.042131418593;11366.772664546828;11374.20380573352;7020.719171233093;7269.45479089081;7485;7504.249575042452;7586.393088553013;5366.792471693838;5416.322959630046;9127.315451341308;10971.451427428437;10998.480486244325 08:22:05 INFO - PROCESS | 1924 | |3;mootools.html;1396.1274203622736;1456.0171883978314;1615.9334839006258;1750.501107184452;1750.6936286149937;7609.54342739436;7879.330256928168;8300.91699083009;8675.826483470335;8707.477551346923;8120.878186827203;8427.15728427157;8462.323014158868;8541.871871921927;8560.957195214016;2313.1325752842686;2359.681443005198;2361.811055115595;2363.4918492524102;2365.9826274701873;2302.781235782598;2334.871582062986;2348.9295321140394;2356.2460012795914;2359.3511784259294;2326.7324257710325;2341.262502311766;2349.800266977309;2364.4443555764383;2365.0303375616;2321.5124823787023;2323.7560056194193;2325.813934885205;2351.482673811767;2352.1179557665873;2347.8591284522813;2365.349528879555;2369.478714682767;2370.620700687899;2375.5367703297866;8473.915260847374;8522.659093636246;8589.527575983318;8614.138586141398;8628.180322869317;4898.265260210961;5240.764165612519;5244.685318880879;5252.107141785906;5267.315249017642;3245.2860370718404;3446.879359222415;3553.5202747628996;3569.3396721606327;3578.248567800765;937.7608709779031;1017.9326461297771;1029.613894789454;1084.1056128693858;1085.066842515436;11014.06380457662;11035.792841431747;11038.17213708975;11120.99911008013;11150.832737508943;4546.636269098464;4615.515370886076;4707.599854012379;4712.88217794551;4756.1438940990265;9494.382865113745;9561.330706850455;9662.903370966342;9669.419834809934;9708.320417570843;5229.633925625246;5242.898991211889;5247.9737601311745;5254.0805359062015;5259.815906443333;4219.51475580306;4226.070264541796;4753.762311884392;4809.350737650442;4815.686980346266;3453.1712389026957;3783.4703141560203;3870.2259548090497;3915.1190982028816;3953.584873588289;1286.3632501911613;1297.8831905128584;1303.687115092371;1305.4060402516832;1307.1830106183636;873.9774463877279;883.4936433381198;886.592167602897;886.796036911514;905.0270958719403;5500.119980803052;5588.329400471969;5661.264035675335;5711.571632127607;5718.027935251017;423.57642357642357;432.15082363156546;433.50872996891223;435.1796862913368;437.21738088820655;3767.907306880974;3773.415120656303;3802.2585595809105;3837.597052309523;3852.4397618964363;9968.053034961813;10119.190464762802;10269;10340.793184136426;10358.585656573803;10017.348872323275;10191.337563058378;10246.897531024595;10271;10343.586256549805;7825.37397008238;7901.328387087162;7947.046354437504;7990.480618759878;7997.920020799834;5399.379071406838;5482.451754824486;5604.3835178131185;5629.0712032514175;5649.548036157015;8569.014563325298;9024.909750902407;9393.060693930825;9519.286053545873;9521.095495927875;9461.858072128785;9574.234061275221;9606.66376676813;9689.370190937567;9706.107309074663;6686.9331306688255;6865.313468653295;7052.224255332012;7225.421966242583;7317.524360916524;7913.683452661829;8191.262786349257;8191.426600137933;8199.22107399796;8199.549024803693;6227.750889964351;7159.427245820426;7306.890396644161;7400.703971841066;7466.626668666654;7018.789436316919;7232.783016509513;7239.384652304402;7242.094738157731;7353.7058517660835;6724.159480064992;6889.242183359726;6902.516823822284;6905.102336696398;6907.827304317231;4731.195696731633;4816.397950256218;4827.08285425768;4834.709917404967;4907.852764417074;4833.468318484894;4849.345338379274;4881.73150476713;4936.75316234194;4955.1576232039915 08:22:05 INFO - PROCESS | 1924 | |4;prototype.html;300.4861686516059;301.4799470912676;304.61314131053575;309.3302999007149;313.7803537523734;5310.522053015228;5409.864753381163;5518.172274158873;5530.944690553093;5545.556355491561;5014.358846297915;5040.8576355049145;5241.39723931748;5431.158170483572;5460.208269800876;3654.926901461976;4177.227212965611;4215.831366745327;4222.261104306749;4225.830966761326;3772.736133395302;3873.2253549290253;3927;4165.83336666533;4201;3489.476578513218;3581.3553560359123;3768.6419790119894;4117.732347397425;4144.523379811315;4108.5686002969705;4136.317507611256;4161.3978618232195;4169.374593810922;4176.665866730655;3573.7855728656364;3588.4437912123403;3589.964100358989;3599.0822340303316;3619.4570814378053;4571.634269258451;5065.772040258197;5355.491228333302;5377.541795077999;5406.729663516848;3974.82113304902;4167.9583204167875;4707.835225767081;4736.928946065812;4743.126465046287;5223.555997740196;5747.942520574783;5773.740181691834;5793.681347525884;5821.330546987108;3294.7528935329947;3423.8801641942414;3775.4714339992424;3904.6876249899938;3937.5274967003857;5259.36887573486;5294.470552944713;5862.622283763312;6029.60807547508;6086.60437071589;3616.5298511193378;3797.240551889633;3944.7041471889147;3957;3976.548559775661;3590.240782016845;3848.499695039627;3895.2988462076532;4029.194161167778;4055.7566546007333;4713.9764301178275;4722.409698787652;4729.172394830891;4768.427788665383;4790.898093438529;4548.931766023512;5303.628745987744;5337.226102215157;5786.652800831964;5889.96537371893;1236.3076677060874;1259.8992080633711;1267.2776517385187;1311.8229039079793;1322.5371120108077;722.6134018300185;727.6398182899499;767.9808004799925;835.1481488881307;878.6529320918202;3999.040470169596;4494.10117976406;4595.885102872388;4852.369192005087;5187;5323.733813309319;5614.550835933115;5624;5624.465675760796;5651.57613179005;4588.541145885451;5121.6427646673665;5124.5131712487255;5133.047553383948;5141.305923700253;2362.433016076129;2555.47612739388;2750.587411888233;2944.278651730297;2988.8206707597615;5542.445755424506;5608.074667679869;5757.510611598061;5766.270118964294;5807.01280782268;5328.280682107943;5631;5759.515493126682;5810.651360918274;5816.418358164235;5444.495532055299;5768.730879206568;5823.854403639943;5874;5883.794067207627;4629.699069560468;5125.897482050413;5531.944680553304;5639.351474580476;5648.971755141198;4830.420349557935;5291.708956007456;5557.749901254534;5588.776448941997;5618.8253636695135;5068.467810879952;5211.895762084813;5726.828195154152;5816.534677225727;5855.599204326206;3320.8746402302063;3618.7285953554115;3710.777353358807;3807.4098514730263;3812;5201.947980520146;5553.028220061554;5572.93801293524;5621.353544342453;5622.943770562406;4915.95084049155;5174.97412512935;5212.113940630178;5313.521783039545;5494.80768173128;5858.179854820414;5869.4717475427415;5897.790952854741;5909.379515151019;5909.497692695997;5293.602979776455;5389.487998640123;5599.704121310243;5707.800226992035;5770.942290577208;4657.998530315998;5486.670799752028;5851.678157701367;5901.675407852609;5914.2311499504785;4878.731669758055;4994.32576602154;5562.721863906708;5666.603337766317;5693.772249110155 08:22:05 INFO - PROCESS | 1924 | |5;yui.html;669.4978765925555;691.664542696792;707.6603230449383;720.6288761287938;778.3850757901258;13899.166050036993;14634;14651.706965860676;14671.779923301146;14795.112293262398;12875.420606072727;12941.676458088552;13048.673783155402;13049.73900521989;13100.41048152833;803.0203152154362;803.409494021895;820.1347578304886;829.274384913201;840.0968958369747;777.4014009212902;803.5459965119718;804.4288555125868;806.1615919443801;807.1605530248535;837.7109897085526;848.3510114762181;849.0829903704016;849.2144766091371;849.4903058165082;819.7171975668415;832.1013305629936;840.8192238668715;841.6380956188837;843.7763992541951;609.7073404765692;627.425905296653;627.7865525721277;627.8650090230623;628.9937100628981;14009.789853152211;14105.647358816112;14230.146191228456;14237.216953067576;14242.07426517273;13052.412641431158;13073.934630326883;13163.670908227276;13241.668958276025;13258.40337184829;10782.353058816418;11052.557897684082;11132.443377831076;11223.719407014809;11414.42927853604;3056.2970516781043;3611.4402267648557;3654.049947013769;3772.320982223199;3778.735488515805;73835.89246161311;75790.86313705244;85059.72410413848;87711.56144219238;88681;9288.582013809395;9933.50332483373;10115.645952391778;10147.137493313152;10352;19521.902390487958;19671.311504097575;19701.62088653809;19846.801531984784;19872;7319.451041171933;7329.8900516492295;7364.042520412802;7424.183339832614;7494.962525187449;4034.9798251008556;4091.85678501251;4120.196561670506;4225.3239481683395;4287.035417031143;3126.218445388653;3204.230984563688;3231.0629917323713;3232.369687910882;3237.5953005874267;569.8888716700204;608.7869245763948;613.160518444666;618.0698049435571;623.0063049436142;551.6924888015349;611.6452457574596;650.7397041183565;654.6857508395901;658.344946777959;7933.642986065525;8522.78693032679;9027.45835249887;9122.36143469964;9136.177744002938;537.6693333599808;663.2405895249912;663.7477758451757;669.9800102690392;673.7776533743853;3732.9440058399146;4269.5516970718245;4416.646668266531;4488.618467430239;4498.1003799239625;64937.67531162314;111550;116231;116657.66684666429;118029.4098529519;48079;101043;101439.97120057706;101489;104701.95298047074;87351.56324218465;87652;89007.55496222478;91855;93372;8494.74515764528;8665.43674661145;8686.261667758059;8757.320099255583;8862.86705699402;42769.572304277805;53238.93522129613;55091.17363239475;56732.43267567272;57490;62888;69982.2504437393;71079.28920710934;79381.60309198417;81631;10525;10882.673519794418;10984.835227471434;10997.230193886351;11018.228723989565;11870.762584748429;11970.341631210367;12077;12142.575009874612;12312.891839734468;11262.493187806405;11873.346965916957;11910.642680719593;11982.161248712506;12122.75754484923;11537;11686.70783230392;11701.122415819018;11994.880051199376;11998.700032499257;11001.17491188148;11220.719482013015;11672.299662020307;11872.46573904159;11948.402579871146;9699.369540979813;9814.263930205121;9968.152707019695;10187;10288.742781430225;9772.413655180711;10016.549255283675;10082.495875206358;10103.797924041624;10139.898601013896 08:22:05 INFO - PROCESS | 1924 | __end_tp_report 08:22:05 INFO - PROCESS | 1924 | __start_cc_report 08:22:05 INFO - PROCESS | 1924 | _x_x_mozilla_cycle_collect,367 08:22:05 INFO - PROCESS | 1924 | __end_cc_report 08:22:05 INFO - PROCESS | 1924 | __startTimestamp1480263725542__endTimestamp 08:22:05 INFO - PROCESS | 1924 | 08:22:05 INFO - PROCESS | 1924 | ------- Summary: start ------- 08:22:05 INFO - PROCESS | 1924 | Number of tests: 6 08:22:05 INFO - PROCESS | 1924 | 08:22:05 INFO - PROCESS | 1924 | [#0] dojo.html Cycles:165 Average:5707.28 Median:6038.85 stddev:702.01 (11.6%) stddev-sans-first:672.57 08:22:05 INFO - PROCESS | 1924 | Values: 3052.8 3209.8 3370.5 3376.4 3419.2 5144.9 5343.4 5459.7 5703.6 5814.7 4490.6 5039.9 5795.4 5856.3 5931.9 3908.6 4969.0 5163.5 5381.2 5386.7 4786.9 4924.7 5341.8 5388.3 5401.3 5216.4 5216.5 5320.6 5376.6 5380.7 4780.4 5319.9 5331.8 5338.4 5345.5 5145.9 5269.0 5269.0 5277.5 5277.9 5811.7 5915.5 5976.1 6040.1 6055.0 6055.8 6217.9 6220.0 6228.2 6254.2 6157.3 6209.1 6215.6 6235.1 6252.2 5818.7 5843.5 5849.2 5857.9 5861.7 6162.3 6169.7 6192.8 6303.3 6345.7 6144.5 6219.5 6221.4 6231.9 6251.3 6129.6 6231.8 6252.3 6258.7 6260.4 6134.5 6145.3 6187.4 6202.0 6226.8 6157.5 6198.3 6217.8 6231.7 6234.9 4978.2 4987.7 4989.3 4993.3 5015.9 4336.7 4366.1 4375.8 4383.0 4431.6 5805.6 5974.8 6033.9 6048.0 6084.5 6216.8 6221.5 6248.4 6252.2 6267.4 5732.3 5770.5 5790.7 5910.1 6038.8 5336.8 5403.4 5408.5 5426.0 5495.2 6155.5 6204.8 6356.8 6370.6 6395.6 6153.7 6175.8 6181.8 6195.7 6272.7 6150.9 6157.8 6216.3 6393.1 6437.6 4691.7 4981.0 5490.9 5869.8 6228.9 6220.6 6221.5 6233.0 6241.7 6324.0 5794.3 6164.6 6185.1 6191.2 6223.1 5837.3 6134.6 6137.3 6156.5 6177.7 4408.7 6032.8 6122.1 6136.8 6146.4 6127.3 6187.7 6235.4 6241.2 6252.1 4512.0 4665.7 5985.6 6008.9 6079.1 08:22:05 INFO - PROCESS | 1924 | 08:22:05 INFO - PROCESS | 1924 | [#1] ext.html Cycles:180 Average:69900.97 Median:40346.00 stddev:152663.47 (378.4%) stddev-sans-first:153002.76 08:22:05 INFO - PROCESS | 1924 | Values: 483.9 503.9 519.4 538.1 540.5 32455.7 40021.0 40594.0 43229.8 43863.8 41592.8 42096.6 42502.8 42598.8 42772.0 9304.6 9421.4 9494.4 9498.8 9521.1 9441.7 9493.4 9537.4 9574.6 9587.4 9482.0 9483.8 9534.1 9578.8 9588.1 9350.6 9478.1 9543.7 9562.4 9566.4 9282.7 9292.3 9341.1 9435.4 9438.5 39984.8 40324.8 40367.2 40369.4 40506.2 3204.3 3419.7 3518.6 3657.2 3899.4 27849.0 28930.3 29287.6 29300.8 29316.6 3122.5 3180.8 3213.5 3308.8 3355.8 501200.0 504298.0 508222.0 508991.5 510550.4 61235.4 61490.7 61881.4 61908.8 62247.0 65728.7 66382.3 66444.0 66464.7 66500.7 16284.8 16538.5 16540.2 16546.0 16578.4 12453.1 12627.1 12639.6 12671.2 12671.9 17814.0 18952.0 18970.5 19046.7 19105.5 7415.8 7565.2 7761.7 7796.1 7817.8 885.9 957.2 1005.6 1071.3 1074.9 29370.9 29713.0 29755.9 30376.4 30612.7 927.8 1040.7 1054.1 1073.4 1097.7 11963.6 15110.2 15390.2 15401.0 15648.9 649666.0 660740.0 666033.0 673786.0 674213.0 57989.4 58325.4 58437.0 58569.1 58636.4 1352.2 1354.0 1377.0 1382.6 1385.1 29037.6 29529.8 29733.0 30120.7 30497.0 51016.7 51734.5 51881.0 51885.7 52009.0 505942.5 509978.0 510661.0 510765.0 599375.0 20054.4 25701.0 25975.0 26082.9 26723.1 43012.1 43669.9 44324.0 44371.8 44415.0 35842.0 37411.6 37533.0 38432.8 39100.6 29575.0 37144.6 37346.6 37418.3 37668.6 37065.8 37350.8 37404.6 38752.8 39533.8 27307.5 33064.5 35000.3 35159.0 35315.6 25926.9 26100.0 26109.0 26323.9 26408.4 08:22:05 INFO - PROCESS | 1924 | 08:22:05 INFO - PROCESS | 1924 | [#2] jquery.html Cycles:180 Average:34166.06 Median:1556.04 stddev:99254.96 (6378.7%) stddev-sans-first:99500.94 08:22:05 INFO - PROCESS | 1924 | Values: 362.1 368.6 376.7 376.9 393.5 18419.4 18898.6 19644.3 19673.4 19860.7 11233.9 11890.0 11904.2 11915.2 11924.4 5320.4 5952.4 5982.6 5997.3 6015.6 3841.9 4050.9 4673.3 5876.9 5987.7 5950.9 6056.1 6065.9 6078.2 6096.1 6006.8 6044.3 6552.7 6627.6 6642.9 5622.7 5719.2 5727.9 5847.8 5896.0 22829.9 23805.9 24057.0 24365.9 24700.9 2146.2 2194.7 2197.1 2582.2 2750.0 9408.3 9735.5 9894.0 10030.9 10340.5 1594.0 1863.5 1873.9 1875.1 1935.4 117350.0 118342.0 119141.2 119410.0 122930.0 11420.6 11516.8 11643.1 11647.5 11853.8 11826.8 13417.6 14673.6 14710.1 14740.6 7244.4 8015.2 8513.4 8516.0 8627.7 6640.2 7139.8 8318.5 8374.2 8521.8 3936.3 4408.0 4511.8 4569.5 4643.8 1675.9 1763.7 1853.4 1915.0 1982.8 860.2 902.9 906.7 915.4 969.5 16719.5 19715.0 19772.6 20635.5 20664.7 836.9 930.9 949.5 965.8 990.5 10159.9 10716.5 10745.6 10791.9 10799.1 541814.0 597985.0 601120.0 613575.0 615035.0 99505.5 112594.0 130455.0 131769.3 134501.0 935.5 1004.9 1010.7 1048.2 1080.0 18337.9 18837.7 18970.2 19002.5 19224.2 45754.5 52293.5 54580.5 54599.2 56435.0 69874.6 72037.6 79169.0 79229.0 79832.6 6393.9 7413.5 7909.0 8138.4 8226.0 11668.3 12084.3 12808.9 12832.0 12868.4 10402.9 10554.7 10774.9 10811.4 10954.2 8554.1 10321.4 10539.9 10831.4 11701.4 10902.4 11031.0 11269.0 11366.8 11374.2 7020.7 7269.5 7485.0 7504.2 7586.4 5366.8 5416.3 9127.3 10971.5 10998.5 08:22:05 INFO - PROCESS | 1924 | 08:22:05 INFO - PROCESS | 1924 | [#3] mootools.html Cycles:180 Average:5502.24 Median:4903.06 stddev:3054.03 (62.3%) stddev-sans-first:3047.01 08:22:05 INFO - PROCESS | 1924 | Values: 1396.1 1456.0 1615.9 1750.5 1750.7 7609.5 7879.3 8300.9 8675.8 8707.5 8120.9 8427.2 8462.3 8541.9 8561.0 2313.1 2359.7 2361.8 2363.5 2366.0 2302.8 2334.9 2348.9 2356.2 2359.4 2326.7 2341.3 2349.8 2364.4 2365.0 2321.5 2323.8 2325.8 2351.5 2352.1 2347.9 2365.3 2369.5 2370.6 2375.5 8473.9 8522.7 8589.5 8614.1 8628.2 4898.3 5240.8 5244.7 5252.1 5267.3 3245.3 3446.9 3553.5 3569.3 3578.2 937.8 1017.9 1029.6 1084.1 1085.1 11014.1 11035.8 11038.2 11121.0 11150.8 4546.6 4615.5 4707.6 4712.9 4756.1 9494.4 9561.3 9662.9 9669.4 9708.3 5229.6 5242.9 5248.0 5254.1 5259.8 4219.5 4226.1 4753.8 4809.4 4815.7 3453.2 3783.5 3870.2 3915.1 3953.6 1286.4 1297.9 1303.7 1305.4 1307.2 874.0 883.5 886.6 886.8 905.0 5500.1 5588.3 5661.3 5711.6 5718.0 423.6 432.2 433.5 435.2 437.2 3767.9 3773.4 3802.3 3837.6 3852.4 9968.1 10119.2 10269.0 10340.8 10358.6 10017.3 10191.3 10246.9 10271.0 10343.6 7825.4 7901.3 7947.0 7990.5 7997.9 5399.4 5482.5 5604.4 5629.1 5649.5 8569.0 9024.9 9393.1 9519.3 9521.1 9461.9 9574.2 9606.7 9689.4 9706.1 6686.9 6865.3 7052.2 7225.4 7317.5 7913.7 8191.3 8191.4 8199.2 8199.5 6227.8 7159.4 7306.9 7400.7 7466.6 7018.8 7232.8 7239.4 7242.1 7353.7 6724.2 6889.2 6902.5 6905.1 6907.8 4731.2 4816.4 4827.1 4834.7 4907.9 4833.5 4849.3 4881.7 4936.8 4955.2 08:22:05 INFO - PROCESS | 1924 | 08:22:05 INFO - PROCESS | 1924 | [#4] prototype.html Cycles:180 Average:4535.96 Median:5137.18 stddev:1411.52 (27.5%) stddev-sans-first:1379.22 08:22:05 INFO - PROCESS | 1924 | Values: 300.5 301.5 304.6 309.3 313.8 5310.5 5409.9 5518.2 5530.9 5545.6 5014.4 5040.9 5241.4 5431.2 5460.2 3654.9 4177.2 4215.8 4222.3 4225.8 3772.7 3873.2 3927.0 4165.8 4201.0 3489.5 3581.4 3768.6 4117.7 4144.5 4108.6 4136.3 4161.4 4169.4 4176.7 3573.8 3588.4 3590.0 3599.1 3619.5 4571.6 5065.8 5355.5 5377.5 5406.7 3974.8 4168.0 4707.8 4736.9 4743.1 5223.6 5747.9 5773.7 5793.7 5821.3 3294.8 3423.9 3775.5 3904.7 3937.5 5259.4 5294.5 5862.6 6029.6 6086.6 3616.5 3797.2 3944.7 3957.0 3976.5 3590.2 3848.5 3895.3 4029.2 4055.8 4714.0 4722.4 4729.2 4768.4 4790.9 4548.9 5303.6 5337.2 5786.7 5890.0 1236.3 1259.9 1267.3 1311.8 1322.5 722.6 727.6 768.0 835.1 878.7 3999.0 4494.1 4595.9 4852.4 5187.0 5323.7 5614.6 5624.0 5624.5 5651.6 4588.5 5121.6 5124.5 5133.0 5141.3 2362.4 2555.5 2750.6 2944.3 2988.8 5542.4 5608.1 5757.5 5766.3 5807.0 5328.3 5631.0 5759.5 5810.7 5816.4 5444.5 5768.7 5823.9 5874.0 5883.8 4629.7 5125.9 5531.9 5639.4 5649.0 4830.4 5291.7 5557.7 5588.8 5618.8 5068.5 5211.9 5726.8 5816.5 5855.6 3320.9 3618.7 3710.8 3807.4 3812.0 5201.9 5553.0 5572.9 5621.4 5622.9 4916.0 5175.0 5212.1 5313.5 5494.8 5858.2 5869.5 5897.8 5909.4 5909.5 5293.6 5389.5 5599.7 5707.8 5770.9 4658.0 5486.7 5851.7 5901.7 5914.2 4878.7 4994.3 5562.7 5666.6 5693.8 08:22:05 INFO - PROCESS | 1924 | 08:22:05 INFO - PROCESS | 1924 | [#5] yui.html Cycles:180 Average:19869.52 Median:4452.63 stddev:29781.42 (668.8%) stddev-sans-first:29830.07 08:22:05 INFO - PROCESS | 1924 | Values: 669.5 691.7 707.7 720.6 778.4 13899.2 14634.0 14651.7 14671.8 14795.1 12875.4 12941.7 13048.7 13049.7 13100.4 803.0 803.4 820.1 829.3 840.1 777.4 803.5 804.4 806.2 807.2 837.7 848.4 849.1 849.2 849.5 819.7 832.1 840.8 841.6 843.8 609.7 627.4 627.8 627.9 629.0 14009.8 14105.6 14230.1 14237.2 14242.1 13052.4 13073.9 13163.7 13241.7 13258.4 10782.4 11052.6 11132.4 11223.7 11414.4 3056.3 3611.4 3654.0 3772.3 3778.7 73835.9 75790.9 85059.7 87711.6 88681.0 9288.6 9933.5 10115.6 10147.1 10352.0 19521.9 19671.3 19701.6 19846.8 19872.0 7319.5 7329.9 7364.0 7424.2 7495.0 4035.0 4091.9 4120.2 4225.3 4287.0 3126.2 3204.2 3231.1 3232.4 3237.6 569.9 608.8 613.2 618.1 623.0 551.7 611.6 650.7 654.7 658.3 7933.6 8522.8 9027.5 9122.4 9136.2 537.7 663.2 663.7 670.0 673.8 3732.9 4269.6 4416.6 4488.6 4498.1 64937.7 111550.0 116231.0 116657.7 118029.4 48079.0 101043.0 101440.0 101489.0 104702.0 87351.6 87652.0 89007.6 91855.0 93372.0 8494.7 8665.4 8686.3 8757.3 8862.9 42769.6 53238.9 55091.2 56732.4 57490.0 62888.0 69982.3 71079.3 79381.6 81631.0 10525.0 10882.7 10984.8 10997.2 11018.2 11870.8 11970.3 12077.0 12142.6 12312.9 11262.5 11873.3 11910.6 11982.2 12122.8 11537.0 11686.7 11701.1 11994.9 11998.7 11001.2 11220.7 11672.3 11872.5 11948.4 9699.4 9814.3 9968.2 10187.0 10288.7 9772.4 10016.5 10082.5 10103.8 10139.9 08:22:05 INFO - PROCESS | 1924 | -------- Summary: end -------- 08:22:05 INFO - PROCESS | 1924 | 08:22:06 INFO - TEST-INFO | 1924: exit 0 08:22:06 INFO - TEST-OK | dromaeo_css | took 1116379ms 08:22:06 INFO - TEST-START | kraken 08:22:06 INFO - operating with platform_type : mac_ 08:22:06 INFO - Initialising browser for kraken test... 08:22:06 INFO - TEST-INFO | started process 1930 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/tmp8FKQug/profile http://localhost:49620/getInfo.html) 08:22:08 INFO - PROCESS | 1930 | __metrics Screen width/height:1600/1200 08:22:08 INFO - PROCESS | 1930 | colorDepth:24 08:22:08 INFO - PROCESS | 1930 | Browser inner width/height: 1024/689 08:22:08 INFO - PROCESS | 1930 | __metrics 08:22:09 ERROR - PROCESS | 1930 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 08:22:09 INFO - TEST-INFO | 1930: exit 0 08:22:09 INFO - Browser initialized. 08:22:09 INFO - Running cycle 1/1 for kraken test... 08:22:09 INFO - TEST-INFO | started process 1932 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/tmp8FKQug/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:22:21 INFO - PROCESS | 1932 | RSS: Main: 229928960 08:22:21 INFO - PROCESS | 1932 | 08:22:24 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49620/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49620/tests/kraken/driver.html?testName=audio-beat-detection) 08:22:25 INFO - PROCESS | 1932 | RSS: Main: 241774592 08:22:25 INFO - PROCESS | 1932 | 08:22:28 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49620/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49620/tests/kraken/driver.html?testName=audio-dft) 08:22:29 INFO - PROCESS | 1932 | RSS: Main: 249163776 08:22:29 INFO - PROCESS | 1932 | 08:22:32 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49620/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49620/tests/kraken/driver.html?testName=audio-fft) 08:22:32 INFO - PROCESS | 1932 | RSS: Main: 252952576 08:22:32 INFO - PROCESS | 1932 | 08:22:34 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49620/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49620/tests/kraken/driver.html?testName=audio-oscillator) 08:22:35 INFO - PROCESS | 1932 | RSS: Main: 254300160 08:22:35 INFO - PROCESS | 1932 | 08:22:37 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49620/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49620/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:22:38 INFO - PROCESS | 1932 | RSS: Main: 254390272 08:22:38 INFO - PROCESS | 1932 | 08:22:41 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49620/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49620/tests/kraken/driver.html?testName=imaging-darkroom) 08:22:41 INFO - PROCESS | 1932 | RSS: Main: 259375104 08:22:41 INFO - PROCESS | 1932 | 08:22:44 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49620/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49620/tests/kraken/driver.html?testName=imaging-desaturate) 08:22:45 INFO - PROCESS | 1932 | RSS: Main: 258359296 08:22:45 INFO - PROCESS | 1932 | 08:22:48 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49620/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49620/tests/kraken/driver.html?testName=json-parse-financial) 08:22:49 INFO - PROCESS | 1932 | RSS: Main: 258469888 08:22:49 INFO - PROCESS | 1932 | 08:22:50 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49620/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49620/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:22:51 INFO - PROCESS | 1932 | RSS: Main: 257429504 08:22:51 INFO - PROCESS | 1932 | 08:22:53 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49620/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49620/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:22:53 INFO - PROCESS | 1932 | RSS: Main: 257531904 08:22:53 INFO - PROCESS | 1932 | 08:22:55 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49620/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49620/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:22:56 INFO - PROCESS | 1932 | RSS: Main: 257544192 08:22:56 INFO - PROCESS | 1932 | 08:22:59 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49620/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:23:00 INFO - PROCESS | 1932 | RSS: Main: 257884160 08:23:00 INFO - PROCESS | 1932 | 08:23:03 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:23:04 INFO - PROCESS | 1932 | RSS: Main: 257933312 08:23:04 INFO - PROCESS | 1932 | 08:23:05 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49620/tests/kraken/driver.html?testName=ai-astar) 08:23:06 INFO - PROCESS | 1932 | RSS: Main: 259944448 08:23:06 INFO - PROCESS | 1932 | 08:23:06 INFO - PROCESS | 1932 | __start_tp_report 08:23:06 INFO - PROCESS | 1932 | _x_x_mozilla_page_load 08:23:06 INFO - PROCESS | 1932 | _x_x_mozilla_page_load_details 08:23:06 INFO - PROCESS | 1932 | |i|pagename|runs| 08:23:06 INFO - PROCESS | 1932 | |0;ai-astar;107;119;120;119;118;120;116;120;118;119 08:23:06 INFO - PROCESS | 1932 | |1;audio-beat-detection;145;112;115;145;115;158;151;146;128;140 08:23:06 INFO - PROCESS | 1932 | |2;audio-dft;198;196;197;197;194;194;196;198;196;197 08:23:06 INFO - PROCESS | 1932 | |3;audio-fft;87;73;69;111;87;65;59;60;78;58 08:23:06 INFO - PROCESS | 1932 | |4;audio-oscillator;86;67;91;71;69;71;96;70;66;99 08:23:06 INFO - PROCESS | 1932 | |5;imaging-gaussian-blur;77;112;82;117;137;94;78;123;136;100 08:23:06 INFO - PROCESS | 1932 | |6;imaging-darkroom;119;123;97;98;98;97;118;98;97;98 08:23:06 INFO - PROCESS | 1932 | |7;imaging-desaturate;87;87;92;86;118;85;144;140;118;92 08:23:06 INFO - PROCESS | 1932 | |8;json-parse-financial;56;55;56;57;60;59;59;59;58;58 08:23:06 INFO - PROCESS | 1932 | |9;json-stringify-tinderbox;67;74;72;81;75;73;70;69;71;73 08:23:06 INFO - PROCESS | 1932 | |10;stanford-crypto-aes;83;87;83;85;87;85;83;95;85;86 08:23:06 INFO - PROCESS | 1932 | |11;stanford-crypto-ccm;148;149;145;159;160;173;148;171;223;180 08:23:06 INFO - PROCESS | 1932 | |12;stanford-crypto-pbkdf2;172;173;169;171;170;168;220;188;172;171 08:23:06 INFO - PROCESS | 1932 | |13;stanford-crypto-sha256-iterative;67;66;69;79;76;90;85;92;90;58 08:23:06 INFO - PROCESS | 1932 | __end_tp_report 08:23:06 INFO - PROCESS | 1932 | __start_cc_report 08:23:06 INFO - PROCESS | 1932 | _x_x_mozilla_cycle_collect,976 08:23:06 INFO - PROCESS | 1932 | __end_cc_report 08:23:06 INFO - PROCESS | 1932 | __startTimestamp1480263786086__endTimestamp 08:23:06 INFO - PROCESS | 1932 | 08:23:06 INFO - PROCESS | 1932 | ------- Summary: start ------- 08:23:06 INFO - PROCESS | 1932 | Number of tests: 14 08:23:06 INFO - PROCESS | 1932 | 08:23:06 INFO - PROCESS | 1932 | [#0] ai-astar Cycles:10 Average:117.60 Median:119.00 stddev:3.92 (3.3%) stddev-sans-first:1.30 08:23:06 INFO - PROCESS | 1932 | Values: 107.0 119.0 120.0 119.0 118.0 120.0 116.0 120.0 118.0 119.0 08:23:06 INFO - PROCESS | 1932 | 08:23:06 INFO - PROCESS | 1932 | [#1] audio-beat-detection Cycles:10 Average:135.50 Median:145.00 stddev:16.69 (11.5%) stddev-sans-first:17.34 08:23:06 INFO - PROCESS | 1932 | Values: 145.0 112.0 115.0 145.0 115.0 158.0 151.0 146.0 128.0 140.0 08:23:06 INFO - PROCESS | 1932 | 08:23:06 INFO - PROCESS | 1932 | [#2] audio-dft Cycles:10 Average:196.30 Median:197.00 stddev:1.42 (0.7%) stddev-sans-first:1.36 08:23:06 INFO - PROCESS | 1932 | Values: 198.0 196.0 197.0 197.0 194.0 194.0 196.0 198.0 196.0 197.0 08:23:06 INFO - PROCESS | 1932 | 08:23:06 INFO - PROCESS | 1932 | [#3] audio-fft Cycles:10 Average:74.70 Median:71.00 stddev:16.67 (23.5%) stddev-sans-first:17.08 08:23:06 INFO - PROCESS | 1932 | Values: 87.0 73.0 69.0 111.0 87.0 65.0 59.0 60.0 78.0 58.0 08:23:06 INFO - PROCESS | 1932 | 08:23:06 INFO - PROCESS | 1932 | [#4] audio-oscillator Cycles:10 Average:78.60 Median:78.50 stddev:12.92 (16.5%) stddev-sans-first:13.42 08:23:06 INFO - PROCESS | 1932 | Values: 86.0 67.0 91.0 71.0 69.0 71.0 96.0 70.0 66.0 99.0 08:23:06 INFO - PROCESS | 1932 | 08:23:06 INFO - PROCESS | 1932 | [#5] imaging-gaussian-blur Cycles:10 Average:105.60 Median:107.00 stddev:22.82 (21.3%) stddev-sans-first:21.73 08:23:06 INFO - PROCESS | 1932 | Values: 77.0 112.0 82.0 117.0 137.0 94.0 78.0 123.0 136.0 100.0 08:23:06 INFO - PROCESS | 1932 | 08:23:06 INFO - PROCESS | 1932 | [#6] imaging-darkroom Cycles:10 Average:104.30 Median:97.50 stddev:10.91 (11.2%) stddev-sans-first:10.20 08:23:06 INFO - PROCESS | 1932 | Values: 119.0 123.0 97.0 98.0 98.0 97.0 118.0 98.0 97.0 98.0 08:23:06 INFO - PROCESS | 1932 | 08:23:06 INFO - PROCESS | 1932 | [#7] imaging-desaturate Cycles:10 Average:104.90 Median:86.50 stddev:23.17 (26.8%) stddev-sans-first:23.65 08:23:06 INFO - PROCESS | 1932 | Values: 87.0 87.0 92.0 86.0 118.0 85.0 144.0 140.0 118.0 92.0 08:23:06 INFO - PROCESS | 1932 | 08:23:06 INFO - PROCESS | 1932 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:58.50 stddev:1.64 (2.8%) stddev-sans-first:1.62 08:23:06 INFO - PROCESS | 1932 | Values: 56.0 55.0 56.0 57.0 60.0 59.0 59.0 59.0 58.0 58.0 08:23:06 INFO - PROCESS | 1932 | 08:23:06 INFO - PROCESS | 1932 | [#9] json-stringify-tinderbox Cycles:10 Average:72.50 Median:73.00 stddev:3.84 (5.3%) stddev-sans-first:3.52 08:23:06 INFO - PROCESS | 1932 | Values: 67.0 74.0 72.0 81.0 75.0 73.0 70.0 69.0 71.0 73.0 08:23:06 INFO - PROCESS | 1932 | 08:23:06 INFO - PROCESS | 1932 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.50 stddev:3.54 (4.1%) stddev-sans-first:3.60 08:23:06 INFO - PROCESS | 1932 | Values: 83.0 87.0 83.0 85.0 87.0 85.0 83.0 95.0 85.0 86.0 08:23:06 INFO - PROCESS | 1932 | 08:23:06 INFO - PROCESS | 1932 | [#11] stanford-crypto-ccm Cycles:10 Average:165.60 Median:165.50 stddev:23.52 (14.2%) stddev-sans-first:24.07 08:23:06 INFO - PROCESS | 1932 | Values: 148.0 149.0 145.0 159.0 160.0 173.0 148.0 171.0 223.0 180.0 08:23:06 INFO - PROCESS | 1932 | 08:23:06 INFO - PROCESS | 1932 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.40 Median:172.00 stddev:15.99 (9.3%) stddev-sans-first:16.84 08:23:06 INFO - PROCESS | 1932 | Values: 172.0 173.0 169.0 171.0 170.0 168.0 220.0 188.0 172.0 171.0 08:23:06 INFO - PROCESS | 1932 | 08:23:06 INFO - PROCESS | 1932 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.20 Median:82.00 stddev:11.91 (14.5%) stddev-sans-first:12.05 08:23:06 INFO - PROCESS | 1932 | Values: 67.0 66.0 69.0 79.0 76.0 90.0 85.0 92.0 90.0 58.0 08:23:06 INFO - PROCESS | 1932 | -------- Summary: end -------- 08:23:06 INFO - PROCESS | 1932 | 08:23:07 INFO - TEST-INFO | 1932: exit 0 08:23:07 INFO - TEST-OK | kraken | took 60947ms 08:23:07 INFO - SUITE-END | took 1177s 08:23:07 INFO - Completed test suite (00:19:37) 08:23:07 INFO - javascript benchmark 08:23:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7101.632126146238, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3052.7863049586526, 3209.828412629391, 3370.52812606235, 3376.3584918865413, 3419.247765491592, 5144.893847822717, 5343.358796944367, 5459.672419654824, 5703.600747947646, 5814.74982878681, 4490.618297444721, 5039.949600504003, 5795.362510123883, 5856.297244330675, 5931.88136237275, 3908.589598092202, 4968.9565191309775, 5163.457836927125, 5381.219723140142, 5386.676799392029, 4786.89901322696, 4924.729139897304, 5341.839744807662, 5388.272583201257, 5401.3248343957, 5216.400113986902, 5216.452272511388, 5320.600954928376, 5376.623636345457, 5380.704061276629, 4780.426348838144, 5319.946800531984, 5331.786728530854, 5338.359396872381, 5345.518903298683, 5145.948540514584, 5268.973655131738, 5269.0, 5277.525022747971, 5277.86805329866, 5811.6803575803315, 5915.467607915265, 5976.103584462322, 6040.063790112496, 6055.0, 6055.757769689207, 6217.937820621781, 6220.03589443637, 6228.159198508189, 6254.21822272216, 6157.261128664544, 6209.130721698965, 6215.627062376272, 6235.127082208494, 6252.187215661935, 5818.679972601505, 5843.503302219359, 5849.151872978395, 5857.912131318034, 5861.70691465425, 6162.291336496271, 6169.691515424301, 6192.752289908353, 6303.2751233607805, 6345.714442850082, 6144.477719393902, 6219.533534984804, 6221.3778622138325, 6231.937680623227, 6251.28110267316, 6129.570930034944, 6231.844203894939, 6252.343503932113, 6258.687065646699, 6260.373962603703, 6134.528431832413, 6145.279321789906, 6187.412195841388, 6202.038684003896, 6226.782062627786, 6157.538184636171, 6198.349173336825, 6217.813465596039, 6231.657258850807, 6234.875302493925, 4978.153713868651, 4987.725675087832, 4989.326440930428, 4993.251012348104, 5015.949840501621, 4336.674749393745, 4366.104948485553, 4375.846845360397, 4382.956170438319, 4431.62331201845, 5805.564582656318, 5974.820755377345, 6033.909491357633, 6048.0, 6084.5132389408745, 6216.751329946842, 6221.5333849961435, 6248.375162483715, 6252.218472690914, 6267.40459656341, 5732.254806875079, 5770.451807078321, 5790.652560846363, 5910.113482977502, 6038.849028774316, 5336.813211537577, 5403.378611459654, 5408.513233808976, 5425.972870135624, 5495.175723641406, 6155.4767844731905, 6204.751809927733, 6356.77751278703, 6370.649614271167, 6395.5842870212355, 6153.692315384303, 6175.752969881334, 6181.81454556364, 6195.690215489118, 6272.717727702356, 6150.907736383869, 6157.815265542041, 6216.285127210429, 6393.073004414427, 6437.645929473737, 4691.7184968901975, 4981.003799240094, 5490.890182196254, 5869.826034792973, 6228.906566401598, 6220.595661282002, 6221.5333849960525, 6232.968835155976, 6241.656708881055, 6324.0, 5794.275715535558, 6164.630122192682, 6185.103160041679, 6191.19514463117, 6223.097650840512, 5837.29952405714, 6134.620279381683, 6137.263528376623, 6156.507479401726, 6177.660228687465, 4408.6693497987135, 6032.849178770566, 6122.081687746873, 6136.846578835565, 6146.446819786241, 6127.295361033538, 6187.690615469299, 6235.438810507076, 6241.188645476059, 6252.124702541739, 4512.0, 4665.6734028617675, 5985.6408615483215, 6008.8798224036145, 6079.1185278133535], "value": 5663.166798784256, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.93534224705655, 503.9244113382993, 519.3741541442562, 538.1309185665152, 540.4541413172697, 32455.67544324556, 40021.0, 40593.98515037122, 43229.7838510807, 43863.78068109663, 41592.79203603986, 42096.57903420965, 42502.78748606252, 42598.787006065, 42772.0, 9304.627814887397, 9421.387609805375, 9494.38286511378, 9498.762530936747, 9521.143097121258, 9441.716748497522, 9493.430394176337, 9537.380070295443, 9574.617015319414, 9587.376820506679, 9482.0, 9483.762905927339, 9534.09426104519, 9578.75476188098, 9588.137067663909, 9350.57922393494, 9478.146966772989, 9543.713688589354, 9562.378445401027, 9566.426014439086, 9282.72151835446, 9292.303077269233, 9341.065893410672, 9435.395982682892, 9438.480883551401, 39984.80007599943, 40324.79837600793, 40367.19265614671, 40369.39445908314, 40506.1898762026, 3204.2630195055035, 3419.743519236042, 3518.5777706675362, 3657.1954170082804, 3899.3566061600086, 27849.0, 28930.27674308138, 29287.560686589717, 29300.827966881297, 29316.560251596242, 3122.469180239365, 3180.793248438844, 3213.4858422652264, 3308.801471911693, 3355.7818741781707, 501200.0, 504298.0, 508222.0, 508991.4550427261, 510550.4472477651, 61235.38764612386, 61490.69254653787, 61881.38118618756, 61908.76182476325, 62247.0, 65728.68542629217, 66382.33617663762, 66444.0, 66464.66767666131, 66500.66749666221, 16284.75572866408, 16538.50384488467, 16540.172991350624, 16546.0, 16578.419755308747, 12453.066020048533, 12627.11610187278, 12639.620811375673, 12671.176373535875, 12671.936640316739, 17813.990804752488, 18952.0, 18970.52573685669, 19046.714299285522, 19105.522361941064, 7415.814604634819, 7565.243475652391, 7761.72833950809, 7796.142424333319, 7817.765467035884, 885.9025507194203, 957.2294303086082, 1005.5575546759402, 1071.3357718214756, 1074.8710154781477, 29370.853145734134, 29713.0, 29755.85122074419, 30376.392472150434, 30612.693873060984, 927.7958849053198, 1040.70339953113, 1054.146141625286, 1073.431081526792, 1097.6542389147394, 11963.581274655346, 15110.244487775568, 15390.153541555099, 15400.998935069185, 15648.94588478167, 649666.0, 660740.0, 666033.0, 673786.0, 674213.0, 57989.4201057984, 58325.416745832, 58437.0, 58569.12146317809, 58636.41363586309, 1352.2089577597217, 1353.9729205416033, 1377.0, 1382.5506710319187, 1385.0996852046048, 29037.564436533048, 29529.81880724747, 29733.0, 30120.69879301179, 30497.0, 51016.724581884264, 51734.482655172964, 51881.0, 51885.740571296905, 52008.95982080413, 505942.4702876462, 509978.0, 510661.0, 510765.0, 599375.0, 20054.398368048984, 25701.0, 25975.0, 26082.86958565195, 26723.06469273566, 43012.13975720405, 43669.944591424406, 44324.0, 44371.77814110909, 44415.0, 35842.0, 37411.62588374082, 37533.0, 38432.847014589606, 39100.6089939097, 29575.0, 37144.628553714116, 37346.626533734314, 37418.251634967695, 37668.62331376651, 37065.81467092647, 37350.8132459336, 37404.625953741204, 38752.80623596864, 39533.80233098816, 27307.453850922473, 33064.50403244001, 35000.29999399947, 35159.0, 35315.64684353226, 25926.87036564805, 26099.956001759718, 26108.955641774875, 26323.868380657976, 26408.433195763053], "value": 19863.92198096226, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.0730928822215, 368.6147975365741, 376.6515972725229, 376.89569561185715, 393.46292310995483, 18419.35532256371, 18898.622027559442, 19644.312449064284, 19673.409797706074, 19860.70208946867, 11233.887661123386, 11889.989350905184, 11904.16670833042, 11915.225510341821, 11924.403779811018, 5320.388155362135, 5952.375000624937, 5982.611130276518, 5997.280326360821, 6015.608985415955, 3841.865534706286, 4050.939235911449, 4673.299005149221, 5876.853078673046, 5987.730552125143, 5950.910736338937, 6056.091586262052, 6065.909011364833, 6078.17944577483, 6096.055111457731, 6006.8498287542725, 6044.335123136451, 6552.7378904843745, 6627.635480048595, 6642.900356494656, 5622.662640241558, 5719.170720245541, 5727.914081288784, 5847.824565263007, 5896.0, 22829.88585057064, 23805.880970595037, 24057.0, 24365.878170609034, 24700.876495617405, 2146.173723116611, 2194.7037149984867, 2197.143114185469, 2582.21242521031, 2750.009996401314, 9408.341416100875, 9735.490998895182, 9894.0, 10030.899691003142, 10340.482975851177, 1593.9760903586455, 1863.450282166764, 1873.878197917131, 1875.0530981854213, 1935.3710044235538, 117350.0, 118342.0, 119141.21288180684, 119410.0, 122929.99999999911, 11420.600278990361, 11516.827247591293, 11643.126765492452, 11647.475863586158, 11853.762924741457, 11826.763464730657, 13417.597472075853, 14673.559793206008, 14710.117392956457, 14740.557783266304, 7244.38422734063, 8015.238552337519, 8513.361497887683, 8515.957420212859, 8627.741167764978, 6640.169978752656, 7139.750108746272, 8318.500889946623, 8374.246317831425, 8521.829563408697, 3936.3111455495173, 4407.992871595119, 4511.751853648016, 4569.451665800125, 4643.814247430065, 1675.9413420530466, 1763.6737203617372, 1853.3698542495615, 1915.0, 1982.7521559805025, 860.2257967828879, 902.9006809250977, 906.7461110888962, 915.4187091197005, 969.5297780576415, 16719.49841504757, 19715.014249287477, 19772.604547908963, 20635.484112896997, 20664.690029649566, 836.8744688296804, 930.8650245714468, 949.5062567464879, 965.8020105878278, 990.4651488196438, 10159.9492002541, 10716.517756700967, 10745.623903163352, 10791.946040269906, 10799.136069114453, 541814.0, 597985.0, 601120.0, 613575.0, 615035.0, 99505.50247248718, 112594.0, 130455.0, 131769.34115329362, 134501.0, 935.504182783126, 1004.8844382895915, 1010.7321559786516, 1048.224314007629, 1079.9622013229657, 18337.899726016483, 18837.717434238224, 18970.241190352783, 19002.524936876136, 19224.173703498145, 45754.54245457503, 52293.47706522886, 54580.45419545754, 54599.18101228564, 56435.0, 69874.60250794854, 72037.6398118006, 79169.0, 79229.0, 79832.60083699544, 6393.936060639334, 7413.481056326221, 7909.0, 8138.430309878252, 8226.012878454623, 11668.299902005907, 12084.274943503418, 12808.935955320536, 12832.0, 12868.391451068617, 10402.895971040192, 10554.683359499228, 10774.892251077703, 10811.405372704578, 10954.178436617127, 8554.059053504234, 10321.432321222404, 10539.94730026345, 10831.404272764757, 11701.414929253673, 10902.400367979837, 11031.0, 11269.042131418593, 11366.772664546828, 11374.20380573352, 7020.719171233093, 7269.45479089081, 7485.0, 7504.249575042452, 7586.393088553013, 5366.792471693838, 5416.322959630046, 9127.315451341308, 10971.451427428437, 10998.480486244325], "value": 9144.640128367068, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1396.1274203622736, 1456.0171883978314, 1615.9334839006258, 1750.501107184452, 1750.6936286149937, 7609.54342739436, 7879.330256928168, 8300.91699083009, 8675.826483470335, 8707.477551346923, 8120.878186827203, 8427.15728427157, 8462.323014158868, 8541.871871921927, 8560.957195214016, 2313.1325752842686, 2359.681443005198, 2361.811055115595, 2363.4918492524102, 2365.9826274701873, 2302.781235782598, 2334.871582062986, 2348.9295321140394, 2356.2460012795914, 2359.3511784259294, 2326.7324257710325, 2341.262502311766, 2349.800266977309, 2364.4443555764383, 2365.0303375616, 2321.5124823787023, 2323.7560056194193, 2325.813934885205, 2351.482673811767, 2352.1179557665873, 2347.8591284522813, 2365.349528879555, 2369.478714682767, 2370.620700687899, 2375.5367703297866, 8473.915260847374, 8522.659093636246, 8589.527575983318, 8614.138586141398, 8628.180322869317, 4898.265260210961, 5240.764165612519, 5244.685318880879, 5252.107141785906, 5267.315249017642, 3245.2860370718404, 3446.879359222415, 3553.5202747628996, 3569.3396721606327, 3578.248567800765, 937.7608709779031, 1017.9326461297771, 1029.613894789454, 1084.1056128693858, 1085.066842515436, 11014.06380457662, 11035.792841431747, 11038.17213708975, 11120.99911008013, 11150.832737508943, 4546.636269098464, 4615.515370886076, 4707.599854012379, 4712.88217794551, 4756.1438940990265, 9494.382865113745, 9561.330706850455, 9662.903370966342, 9669.419834809934, 9708.320417570843, 5229.633925625246, 5242.898991211889, 5247.9737601311745, 5254.0805359062015, 5259.815906443333, 4219.51475580306, 4226.070264541796, 4753.762311884392, 4809.350737650442, 4815.686980346266, 3453.1712389026957, 3783.4703141560203, 3870.2259548090497, 3915.1190982028816, 3953.584873588289, 1286.3632501911613, 1297.8831905128584, 1303.687115092371, 1305.4060402516832, 1307.1830106183636, 873.9774463877279, 883.4936433381198, 886.592167602897, 886.796036911514, 905.0270958719403, 5500.119980803052, 5588.329400471969, 5661.264035675335, 5711.571632127607, 5718.027935251017, 423.57642357642357, 432.15082363156546, 433.50872996891223, 435.1796862913368, 437.21738088820655, 3767.907306880974, 3773.415120656303, 3802.2585595809105, 3837.597052309523, 3852.4397618964363, 9968.053034961813, 10119.190464762802, 10269.0, 10340.793184136426, 10358.585656573803, 10017.348872323275, 10191.337563058378, 10246.897531024595, 10271.0, 10343.586256549805, 7825.37397008238, 7901.328387087162, 7947.046354437504, 7990.480618759878, 7997.920020799834, 5399.379071406838, 5482.451754824486, 5604.3835178131185, 5629.0712032514175, 5649.548036157015, 8569.014563325298, 9024.909750902407, 9393.060693930825, 9519.286053545873, 9521.095495927875, 9461.858072128785, 9574.234061275221, 9606.66376676813, 9689.370190937567, 9706.107309074663, 6686.9331306688255, 6865.313468653295, 7052.224255332012, 7225.421966242583, 7317.524360916524, 7913.683452661829, 8191.262786349257, 8191.426600137933, 8199.22107399796, 8199.549024803693, 6227.750889964351, 7159.427245820426, 7306.890396644161, 7400.703971841066, 7466.626668666654, 7018.789436316919, 7232.783016509513, 7239.384652304402, 7242.094738157731, 7353.7058517660835, 6724.159480064992, 6889.242183359726, 6902.516823822284, 6905.102336696398, 6907.827304317231, 4731.195696731633, 4816.397950256218, 4827.08285425768, 4834.709917404967, 4907.852764417074, 4833.468318484894, 4849.345338379274, 4881.73150476713, 4936.75316234194, 4955.1576232039915], "value": 4374.00543584647, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.4861686516059, 301.4799470912676, 304.61314131053575, 309.3302999007149, 313.7803537523734, 5310.522053015228, 5409.864753381163, 5518.172274158873, 5530.944690553093, 5545.556355491561, 5014.358846297915, 5040.8576355049145, 5241.39723931748, 5431.158170483572, 5460.208269800876, 3654.926901461976, 4177.227212965611, 4215.831366745327, 4222.261104306749, 4225.830966761326, 3772.736133395302, 3873.2253549290253, 3927.0, 4165.83336666533, 4201.0, 3489.476578513218, 3581.3553560359123, 3768.6419790119894, 4117.732347397425, 4144.523379811315, 4108.5686002969705, 4136.317507611256, 4161.3978618232195, 4169.374593810922, 4176.665866730655, 3573.7855728656364, 3588.4437912123403, 3589.964100358989, 3599.0822340303316, 3619.4570814378053, 4571.634269258451, 5065.772040258197, 5355.491228333302, 5377.541795077999, 5406.729663516848, 3974.82113304902, 4167.9583204167875, 4707.835225767081, 4736.928946065812, 4743.126465046287, 5223.555997740196, 5747.942520574783, 5773.740181691834, 5793.681347525884, 5821.330546987108, 3294.7528935329947, 3423.8801641942414, 3775.4714339992424, 3904.6876249899938, 3937.5274967003857, 5259.36887573486, 5294.470552944713, 5862.622283763312, 6029.60807547508, 6086.60437071589, 3616.5298511193378, 3797.240551889633, 3944.7041471889147, 3957.0, 3976.548559775661, 3590.240782016845, 3848.499695039627, 3895.2988462076532, 4029.194161167778, 4055.7566546007333, 4713.9764301178275, 4722.409698787652, 4729.172394830891, 4768.427788665383, 4790.898093438529, 4548.931766023512, 5303.628745987744, 5337.226102215157, 5786.652800831964, 5889.96537371893, 1236.3076677060874, 1259.8992080633711, 1267.2776517385187, 1311.8229039079793, 1322.5371120108077, 722.6134018300185, 727.6398182899499, 767.9808004799925, 835.1481488881307, 878.6529320918202, 3999.040470169596, 4494.10117976406, 4595.885102872388, 4852.369192005087, 5187.0, 5323.733813309319, 5614.550835933115, 5624.0, 5624.465675760796, 5651.57613179005, 4588.541145885451, 5121.6427646673665, 5124.5131712487255, 5133.047553383948, 5141.305923700253, 2362.433016076129, 2555.47612739388, 2750.587411888233, 2944.278651730297, 2988.8206707597615, 5542.445755424506, 5608.074667679869, 5757.510611598061, 5766.270118964294, 5807.01280782268, 5328.280682107943, 5631.0, 5759.515493126682, 5810.651360918274, 5816.418358164235, 5444.495532055299, 5768.730879206568, 5823.854403639943, 5874.0, 5883.794067207627, 4629.699069560468, 5125.897482050413, 5531.944680553304, 5639.351474580476, 5648.971755141198, 4830.420349557935, 5291.708956007456, 5557.749901254534, 5588.776448941997, 5618.8253636695135, 5068.467810879952, 5211.895762084813, 5726.828195154152, 5816.534677225727, 5855.599204326206, 3320.8746402302063, 3618.7285953554115, 3710.777353358807, 3807.4098514730263, 3812.0, 5201.947980520146, 5553.028220061554, 5572.93801293524, 5621.353544342453, 5622.943770562406, 4915.95084049155, 5174.97412512935, 5212.113940630178, 5313.521783039545, 5494.80768173128, 5858.179854820414, 5869.4717475427415, 5897.790952854741, 5909.379515151019, 5909.497692695997, 5293.602979776455, 5389.487998640123, 5599.704121310243, 5707.800226992035, 5770.942290577208, 4657.998530315998, 5486.670799752028, 5851.678157701367, 5901.675407852609, 5914.2311499504785, 4878.731669758055, 4994.32576602154, 5562.721863906708, 5666.603337766317, 5693.772249110155], "value": 4073.9397829982336, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.4978765925555, 691.664542696792, 707.6603230449383, 720.6288761287938, 778.3850757901258, 13899.166050036993, 14634.0, 14651.706965860676, 14671.779923301146, 14795.112293262398, 12875.420606072727, 12941.676458088552, 13048.673783155402, 13049.73900521989, 13100.41048152833, 803.0203152154362, 803.409494021895, 820.1347578304886, 829.274384913201, 840.0968958369747, 777.4014009212902, 803.5459965119718, 804.4288555125868, 806.1615919443801, 807.1605530248535, 837.7109897085526, 848.3510114762181, 849.0829903704016, 849.2144766091371, 849.4903058165082, 819.7171975668415, 832.1013305629936, 840.8192238668715, 841.6380956188837, 843.7763992541951, 609.7073404765692, 627.425905296653, 627.7865525721277, 627.8650090230623, 628.9937100628981, 14009.789853152211, 14105.647358816112, 14230.146191228456, 14237.216953067576, 14242.07426517273, 13052.412641431158, 13073.934630326883, 13163.670908227276, 13241.668958276025, 13258.40337184829, 10782.353058816418, 11052.557897684082, 11132.443377831076, 11223.719407014809, 11414.42927853604, 3056.2970516781043, 3611.4402267648557, 3654.049947013769, 3772.320982223199, 3778.735488515805, 73835.89246161311, 75790.86313705244, 85059.72410413848, 87711.56144219238, 88681.0, 9288.582013809395, 9933.50332483373, 10115.645952391778, 10147.137493313152, 10352.0, 19521.902390487958, 19671.311504097575, 19701.62088653809, 19846.801531984784, 19872.0, 7319.451041171933, 7329.8900516492295, 7364.042520412802, 7424.183339832614, 7494.962525187449, 4034.9798251008556, 4091.85678501251, 4120.196561670506, 4225.3239481683395, 4287.035417031143, 3126.218445388653, 3204.230984563688, 3231.0629917323713, 3232.369687910882, 3237.5953005874267, 569.8888716700204, 608.7869245763948, 613.160518444666, 618.0698049435571, 623.0063049436142, 551.6924888015349, 611.6452457574596, 650.7397041183565, 654.6857508395901, 658.344946777959, 7933.642986065525, 8522.78693032679, 9027.45835249887, 9122.36143469964, 9136.177744002938, 537.6693333599808, 663.2405895249912, 663.7477758451757, 669.9800102690392, 673.7776533743853, 3732.9440058399146, 4269.5516970718245, 4416.646668266531, 4488.618467430239, 4498.1003799239625, 64937.67531162314, 111550.0, 116231.0, 116657.66684666429, 118029.4098529519, 48079.0, 101043.0, 101439.97120057706, 101489.0, 104701.95298047074, 87351.56324218465, 87652.0, 89007.55496222478, 91855.0, 93372.0, 8494.74515764528, 8665.43674661145, 8686.261667758059, 8757.320099255583, 8862.86705699402, 42769.572304277805, 53238.93522129613, 55091.17363239475, 56732.43267567272, 57490.0, 62888.0, 69982.2504437393, 71079.28920710934, 79381.60309198417, 81631.0, 10525.0, 10882.673519794418, 10984.835227471434, 10997.230193886351, 11018.228723989565, 11870.762584748429, 11970.341631210367, 12077.0, 12142.575009874612, 12312.891839734468, 11262.493187806405, 11873.346965916957, 11910.642680719593, 11982.161248712506, 12122.75754484923, 11537.0, 11686.70783230392, 11701.122415819018, 11994.880051199376, 11998.700032499257, 11001.17491188148, 11220.719482013015, 11672.299662020307, 11872.46573904159, 11948.402579871146, 9699.369540979813, 9814.263930205121, 9968.152707019695, 10187.0, 10288.742781430225, 9772.413655180711, 10016.549255283675, 10082.495875206358, 10103.797924041624, 10139.898601013896], "value": 6997.083659329879, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 119.0, 120.0, 119.0, 118.0, 120.0, 116.0, 120.0, 118.0, 119.0], "value": 117.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 112.0, 115.0, 145.0, 115.0, 158.0, 151.0, 146.0, 128.0, 140.0], "value": 135.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 196.0, 197.0, 197.0, 194.0, 194.0, 196.0, 198.0, 196.0, 197.0], "value": 196.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 73.0, 69.0, 111.0, 87.0, 65.0, 59.0, 60.0, 78.0, 58.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 67.0, 91.0, 71.0, 69.0, 71.0, 96.0, 70.0, 66.0, 99.0], "value": 78.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 112.0, 82.0, 117.0, 137.0, 94.0, 78.0, 123.0, 136.0, 100.0], "value": 105.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 123.0, 97.0, 98.0, 98.0, 97.0, 118.0, 98.0, 97.0, 98.0], "value": 104.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 92.0, 86.0, 118.0, 85.0, 144.0, 140.0, 118.0, 92.0], "value": 104.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 57.0, 60.0, 59.0, 59.0, 59.0, 58.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 74.0, 72.0, 81.0, 75.0, 73.0, 70.0, 69.0, 71.0, 73.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 83.0, 85.0, 87.0, 85.0, 83.0, 95.0, 85.0, 86.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 145.0, 159.0, 160.0, 173.0, 148.0, 171.0, 223.0, 180.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 169.0, 171.0, 170.0, 168.0, 220.0, 188.0, 172.0, 171.0], "value": 177.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 69.0, 79.0, 76.0, 90.0, 85.0, 92.0, 90.0, 58.0], "value": 77.2, "unit": "score"}]}]} 08:23:07 INFO - Return code: 0 08:23:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:23:07 ERROR - # TBPL SUCCESS # 08:23:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:23:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:23:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:23:07 INFO - 2016-11-27 08:23:07.449 screenresolution[1937:32808] starting screenresolution argv=screenresolution get 08:23:07 INFO - 2016-11-27 08:23:07.452 screenresolution[1937:32808] Display 0: 1600x1200x32@60 08:23:07 INFO - 2016-11-27 08:23:07.458 screenresolution[1938:32811] starting screenresolution argv=screenresolution list 08:23:07 INFO - Available Modes on Display 0 08:23:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:23:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:23:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:23:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:23:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:23:07 INFO - Intel Iris: 08:23:07 INFO - Chipset Model: Intel Iris 08:23:07 INFO - Type: GPU 08:23:07 INFO - Bus: Built-In 08:23:07 INFO - VRAM (Dynamic, Max): 1536 MB 08:23:07 INFO - Vendor: Intel (0x8086) 08:23:07 INFO - Device ID: 0x0a2e 08:23:07 INFO - Revision ID: 0x0009 08:23:07 INFO - Displays: 08:23:07 INFO - Display: 08:23:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:23:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:23:07 INFO - Display Serial Number: 1600x1200 60 08:23:07 INFO - Main Display: Yes 08:23:07 INFO - Mirror: Off 08:23:07 INFO - Online: Yes 08:23:07 INFO - Rotation: Supported 08:23:07 INFO - Return code: 0 08:23:07 INFO - Running post-action listener: _resource_record_post_action 08:23:07 INFO - [mozharness: 2016-11-27 16:23:07.699208Z] Finished run-tests step (success) 08:23:07 INFO - Running post-run listener: _resource_record_post_run 08:23:07 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 1343488; Write bytes: 662961152; Read time: 8; Write time: 1953 08:23:07 INFO - TinderboxPrint: CPU usage
54.5% 08:23:07 INFO - TinderboxPrint: I/O read bytes / time
1,343,488 / 8 08:23:07 INFO - TinderboxPrint: I/O write bytes / time
662,961,152 / 1,953 08:23:07 INFO - TinderboxPrint: CPU idle
2,204.9 (45.5%) 08:23:07 INFO - TinderboxPrint: CPU system
978.8 (20.2%) 08:23:07 INFO - TinderboxPrint: CPU user
1,658.1 (34.2%) 08:23:07 INFO - TinderboxPrint: Swap in / out
349,286,400 / 0 08:23:07 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 347451904; Write bytes: 346301952; Read time: 28051; Write time: 729 08:23:07 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 364544; Write bytes: 309409280; Read time: 4; Write time: 1197 08:23:08 INFO - Running post-run listener: _upload_blobber_files 08:23:08 INFO - Blob upload gear active. 08:23:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:23:08 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 08:23:08 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'] 08:23:08 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 08:23:08 INFO - (blobuploader) - INFO - Open directory for files ... 08:23:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:23:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:23:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:23:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:23:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:23:09 INFO - (blobuploader) - INFO - Done attempting. 08:23:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:23:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:23:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:23:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:23:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:23:10 INFO - (blobuploader) - INFO - Done attempting. 08:23:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:23:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:23:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:23:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:23:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:23:12 INFO - (blobuploader) - INFO - Done attempting. 08:23:12 INFO - (blobuploader) - INFO - Iteration through files over. 08:23:12 INFO - Return code: 0 08:23:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:23:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:23:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb55c1fe63a5ae521d8cb7b9e0cbfdfc7364a8c57aa0312bbe6ff370cf997554f64b8a38510574c65002c55a13a0bb4bd8a9325c6cb0adcbd84347c4c8e9b308", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/896bff2c64d27b80032f4cb03d160560f0aecf5f08e0c640cc907a42e6fdd8c54cf13b39b046fe4543ce7deb90e33a12f88b96e6e96edc9ea26975a215dd69c2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03058e6670b15365bbb90ff5ea61f8466e46922e8561aa4239c317fc7539af6ff31cb148e507e69089a5b7c8c2af77c1101dbeb78802d30455601d0f13eb2c51"} 08:23:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:23:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:23:12 INFO - Contents: 08:23:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb55c1fe63a5ae521d8cb7b9e0cbfdfc7364a8c57aa0312bbe6ff370cf997554f64b8a38510574c65002c55a13a0bb4bd8a9325c6cb0adcbd84347c4c8e9b308", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/896bff2c64d27b80032f4cb03d160560f0aecf5f08e0c640cc907a42e6fdd8c54cf13b39b046fe4543ce7deb90e33a12f88b96e6e96edc9ea26975a215dd69c2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03058e6670b15365bbb90ff5ea61f8466e46922e8561aa4239c317fc7539af6ff31cb148e507e69089a5b7c8c2af77c1101dbeb78802d30455601d0f13eb2c51"} 08:23:12 INFO - Running post-run listener: copy_logs_to_upload_dir 08:23:12 INFO - Copying logs to upload dir... 08:23:12 INFO - mkdir: /builds/slave/test/build/upload/logs 08:23:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.318081 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-11-27 08:23:12.741949) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-27 08:23:12.747445) ========= 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.OPLBTwsAqC/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.KA1LPEC7G6/Listeners TMPDIR=/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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/bb55c1fe63a5ae521d8cb7b9e0cbfdfc7364a8c57aa0312bbe6ff370cf997554f64b8a38510574c65002c55a13a0bb4bd8a9325c6cb0adcbd84347c4c8e9b308", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/896bff2c64d27b80032f4cb03d160560f0aecf5f08e0c640cc907a42e6fdd8c54cf13b39b046fe4543ce7deb90e33a12f88b96e6e96edc9ea26975a215dd69c2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03058e6670b15365bbb90ff5ea61f8466e46922e8561aa4239c317fc7539af6ff31cb148e507e69089a5b7c8c2af77c1101dbeb78802d30455601d0f13eb2c51"} build_url:https://queue.taskcluster.net/v1/task/YkcB_iyAQaCz6jyl7d4McA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011383 build_url: 'https://queue.taskcluster.net/v1/task/YkcB_iyAQaCz6jyl7d4McA/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/bb55c1fe63a5ae521d8cb7b9e0cbfdfc7364a8c57aa0312bbe6ff370cf997554f64b8a38510574c65002c55a13a0bb4bd8a9325c6cb0adcbd84347c4c8e9b308", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/896bff2c64d27b80032f4cb03d160560f0aecf5f08e0c640cc907a42e6fdd8c54cf13b39b046fe4543ce7deb90e33a12f88b96e6e96edc9ea26975a215dd69c2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03058e6670b15365bbb90ff5ea61f8466e46922e8561aa4239c317fc7539af6ff31cb148e507e69089a5b7c8c2af77c1101dbeb78802d30455601d0f13eb2c51"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-27 08:23:12.781941) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 08:23:12.782308) ========= 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.OPLBTwsAqC/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.KA1LPEC7G6/Listeners TMPDIR=/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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.005393 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 08:23:12.831180) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-27 08:23:12.831562) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-27 08:23:12.831891) ========= ========= Total master_lag: 0.21 =========