builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0392 starttime: 1464218314.78 results: success (0) buildid: 20160525152143 builduid: 8654ccbbea454f27b451ee4808dca30e revision: 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 16:18:34.781475) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 16:18:34.781921) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 16:18:34.782195) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 16:18:34.803590) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 16:18:34.804006) ========= 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.oW7fHwegwP/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.XSfUjLzxC1/Listeners TMPDIR=/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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-05-25 16:18:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.1M=0.001s 2016-05-25 16:18:34 (19.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088196 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 16:18:34.912118) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 16:18:34.912575) ========= 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.oW7fHwegwP/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.XSfUjLzxC1/Listeners TMPDIR=/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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.020312 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 16:18:34.961840) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-25 16:18:34.962199) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 --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 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oW7fHwegwP/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.XSfUjLzxC1/Listeners TMPDIR=/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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-05-25 16:18:35,034 truncating revision to first 12 chars 2016-05-25 16:18:35,035 Setting DEBUG logging. 2016-05-25 16:18:35,035 attempt 1/10 2016-05-25 16:18:35,035 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4f7c3a2567f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 16:18:36,320 unpacking tar archive at: mozilla-aurora-4f7c3a2567f8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.536723 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-25 16:18:36.519022) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 16:18:36.519503) ========= script_repo_revision: 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 16:18:36.519981) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 16:18:36.520245) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 16:18:36.537065) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-05-25 16:18:36.537506) ========= /tools/buildbot/bin/python 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', '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.oW7fHwegwP/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.XSfUjLzxC1/Listeners TMPDIR=/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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 16:18:36 INFO - MultiFileLogger online at 20160525 16:18:36 in /builds/slave/test 16:18:36 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 16:18:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:18:36 INFO - {'append_to_log': False, 16:18:36 INFO - 'base_work_dir': '/builds/slave/test', 16:18:36 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:18:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:18:36 INFO - 'branch': 'Mozilla-Aurora', 16:18:36 INFO - 'buildbot_json_path': 'buildprops.json', 16:18:36 INFO - 'config_files': ('talos/mac_config.py',), 16:18:36 INFO - 'default_actions': ('clobber', 16:18:36 INFO - 'read-buildbot-config', 16:18:36 INFO - 'download-and-extract', 16:18:36 INFO - 'populate-webroot', 16:18:36 INFO - 'create-virtualenv', 16:18:36 INFO - 'install', 16:18:36 INFO - 'run-tests'), 16:18:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:18:36 INFO - 'download_minidump_stackwalk': True, 16:18:36 INFO - 'download_symbols': 'ondemand', 16:18:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:18:36 INFO - 'tooltool.py': '/tools/tooltool.py', 16:18:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:18:36 INFO - '/tools/misc-python/virtualenv.py')}, 16:18:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:18:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:18:36 INFO - 'installer_path': 'installer.exe', 16:18:36 INFO - 'log_level': 'info', 16:18:36 INFO - 'log_name': 'talos', 16:18:36 INFO - 'log_to_console': True, 16:18:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:18:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:18:36 INFO - 'opt_config_files': (), 16:18:36 INFO - 'pip_index': False, 16:18:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:18:36 INFO - 'cmd': ('bash', 16:18:36 INFO - '-c', 16:18:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:18:36 INFO - 'enabled': True, 16:18:36 INFO - 'halt_on_failure': False, 16:18:36 INFO - 'name': 'check_screen_resolution'},), 16:18:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:18:36 INFO - 'cmd': ('bash', 16:18:36 INFO - '-c', 16:18:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:18:36 INFO - 'enabled': True, 16:18:36 INFO - 'halt_on_failure': False, 16:18:36 INFO - 'name': 'check_screen_resolution'},), 16:18:36 INFO - 'run_cmd_checks_enabled': True, 16:18:36 INFO - 'sps_profile': False, 16:18:36 INFO - 'sps_profile_interval': 0, 16:18:36 INFO - 'suite': 'dromaeojs-e10s', 16:18:36 INFO - 'system_bits': '32', 16:18:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:18:36 INFO - 'title': 't-yosemite-r7-0392', 16:18:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:18:36 INFO - 'use_talos_json': True, 16:18:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:18:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:18:36 INFO - 'work_dir': 'build'} 16:18:36 INFO - ##### 16:18:36 INFO - ##### Running clobber step. 16:18:36 INFO - ##### 16:18:36 INFO - Running pre-action listener: _resource_record_pre_action 16:18:36 INFO - Running main action method: clobber 16:18:36 INFO - rmtree: /builds/slave/test/build 16:18:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:18:37 INFO - Running post-action listener: _resource_record_post_action 16:18:37 INFO - ##### 16:18:37 INFO - ##### Running read-buildbot-config step. 16:18:37 INFO - ##### 16:18:37 INFO - Running pre-action listener: _resource_record_pre_action 16:18:37 INFO - Running main action method: read_buildbot_config 16:18:37 INFO - Using buildbot properties: 16:18:37 INFO - { 16:18:37 INFO - "project": "", 16:18:37 INFO - "product": "firefox", 16:18:37 INFO - "script_repo_revision": "production", 16:18:37 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 16:18:37 INFO - "repository": "", 16:18:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 16:18:37 INFO - "buildid": "20160525152143", 16:18:37 INFO - "pgo_build": "False", 16:18:37 INFO - "basedir": "/builds/slave/test", 16:18:37 INFO - "buildnumber": 11, 16:18:37 INFO - "slavename": "t-yosemite-r7-0392", 16:18:37 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 16:18:37 INFO - "platform": "yosemite_r7", 16:18:37 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:18:37 INFO - "branch": "mozilla-aurora", 16:18:37 INFO - "repo_path": "releases/mozilla-aurora", 16:18:37 INFO - "revision": "4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3", 16:18:37 INFO - "stage_platform": "macosx64", 16:18:37 INFO - "builduid": "8654ccbbea454f27b451ee4808dca30e", 16:18:37 INFO - "slavebuilddir": "test" 16:18:37 INFO - } 16:18:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 16:18:37 INFO - Running post-action listener: _resource_record_post_action 16:18:37 INFO - ##### 16:18:37 INFO - ##### Running download-and-extract step. 16:18:37 INFO - ##### 16:18:37 INFO - Running pre-action listener: _resource_record_pre_action 16:18:37 INFO - Running main action method: download_and_extract 16:18:37 INFO - mkdir: /builds/slave/test/build/tests 16:18: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:37 INFO - https://queue.taskcluster.net/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:18:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 16:18:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 16:18:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 16:18:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json'}, attempt #1 16:18:39 INFO - Downloaded 1199 bytes. 16:18:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 16:18:39 INFO - Using the following test package requirements: 16:18:39 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 16:18:39 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 16:18:39 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 16:18:39 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 16:18:39 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 16:18:39 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 16:18:39 INFO - u'jsshell-mac.zip'], 16:18:39 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 16:18:39 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 16:18:39 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 16:18:39 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 16:18:39 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 16:18:39 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 16:18:39 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 16:18:39 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 16:18:39 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 16:18:39 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 16:18:39 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 16:18:39 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:39 INFO - https://queue.taskcluster.net/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:18:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 16:18:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 16:18:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 16:18:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:18:40 INFO - Downloaded 18425352 bytes. 16:18:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:18:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:18:43 INFO - Return code: 0 16:18:43 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip', u'firefox-48.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 16:18:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:43 INFO - https://queue.taskcluster.net/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:18:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 16:18:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 16:18:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 16:18:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:18:44 INFO - Downloaded 18425352 bytes. 16:18:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:18:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:18:47 INFO - Return code: 0 16:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:47 INFO - https://queue.taskcluster.net/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:18:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 16:18:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 16:18:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip 16:18:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip'}, attempt #1 16:18:49 INFO - Downloaded 10840145 bytes. 16:18:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:18:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 16:18:49 INFO - Return code: 0 16:18:49 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:49 INFO - https://queue.taskcluster.net/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 16:18:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 16:18:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 16:18:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 16:18:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg'}, attempt #1 16:18:52 INFO - Downloaded 114138629 bytes. 16:18:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 16:18:52 INFO - mkdir: /builds/slave/test/properties 16:18:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:18:52 INFO - Writing to file /builds/slave/test/properties/build_url 16:18:52 INFO - Contents: 16:18:52 INFO - build_url:https://queue.taskcluster.net/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 16:18:53 INFO - Running post-action listener: _resource_record_post_action 16:18:53 INFO - Running post-action listener: set_extra_try_arguments 16:18:53 INFO - ##### 16:18:53 INFO - ##### Running populate-webroot step. 16:18:53 INFO - ##### 16:18:53 INFO - Running pre-action listener: _resource_record_pre_action 16:18:53 INFO - Running main action method: populate_webroot 16:18:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:18:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:18:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:18:53 INFO - '--tppagecycles', 16:18:53 INFO - '7'], 16:18:53 INFO - 'tests': ['tsvgm']}}, 16:18:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:18:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:18:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:18:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:18:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:18:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:18:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:53 INFO - 'talos_options': ['--disable-e10s'], 16:18:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:18:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:18:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:53 INFO - 'talos_options': ['--disable-e10s'], 16:18:53 INFO - 'tests': ['damp', 'tps']}, 16:18:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:53 INFO - 'tests': ['damp', 'tps']}, 16:18:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:18:53 INFO - 'tests': ['dromaeo_dom']}, 16:18:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:18:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:18:53 INFO - 'tests': ['a11yr', 16:18:53 INFO - 'ts_paint', 16:18:53 INFO - 'tpaint', 16:18:53 INFO - 'sessionrestore', 16:18:53 INFO - 'sessionrestore_no_auto_restore', 16:18:53 INFO - 'tabpaint']}, 16:18:53 INFO - 'other-e10s': {'tests': ['a11yr', 16:18:53 INFO - 'ts_paint', 16:18:53 INFO - 'tpaint', 16:18:53 INFO - 'sessionrestore', 16:18:53 INFO - 'sessionrestore_no_auto_restore', 16:18:53 INFO - 'tabpaint']}, 16:18:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:18:53 INFO - 'ts_paint', 16:18:53 INFO - 'tpaint', 16:18:53 INFO - 'sessionrestore', 16:18:53 INFO - 'sessionrestore_no_auto_restore', 16:18:53 INFO - 'tabpaint']}, 16:18:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:18:53 INFO - 'ts_paint', 16:18:53 INFO - 'tpaint', 16:18:53 INFO - 'sessionrestore', 16:18:53 INFO - 'sessionrestore_no_auto_restore', 16:18:53 INFO - 'tabpaint']}, 16:18:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:18:53 INFO - 'tests': ['a11yr', 16:18:53 INFO - 'ts_paint', 16:18:53 INFO - 'tpaint', 16:18:53 INFO - 'sessionrestore', 16:18:53 INFO - 'sessionrestore_no_auto_restore', 16:18:53 INFO - 'tabpaint']}, 16:18:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:18:53 INFO - 'tests': ['a11yr', 16:18:53 INFO - 'ts_paint', 16:18:53 INFO - 'tpaint', 16:18:53 INFO - 'sessionrestore', 16:18:53 INFO - 'sessionrestore_no_auto_restore', 16:18:53 INFO - 'tabpaint']}, 16:18:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:18:53 INFO - 'tests': ['tsvgx', 16:18:53 INFO - 'tsvgr_opacity', 16:18:53 INFO - 'tart', 16:18:54 INFO - 'tscrollx', 16:18:54 INFO - 'cart']}, 16:18:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:18:54 INFO - 'tsvgr_opacity', 16:18:54 INFO - 'tart', 16:18:54 INFO - 'tscrollx', 16:18:54 INFO - 'cart']}, 16:18:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:54 INFO - 'talos_options': ['--disable-e10s'], 16:18:54 INFO - 'tests': ['tp5o']}, 16:18:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:54 INFO - 'tests': ['tp5o']}, 16:18:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:54 INFO - 'talos_options': ['--disable-e10s', 16:18:54 INFO - '--xperf_path', 16:18:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:18:54 INFO - 'tests': ['tp5n']}, 16:18:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:54 INFO - 'talos_options': ['--xperf_path', 16:18:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:18:54 INFO - 'tests': ['tp5n']}}, 16:18:54 INFO - 'talos.zip': {'path': '', 16:18:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:18:54 INFO - Running post-action listener: _resource_record_post_action 16:18:54 INFO - ##### 16:18:54 INFO - ##### Running create-virtualenv step. 16:18:54 INFO - ##### 16:18:54 INFO - Running pre-action listener: _resource_record_pre_action 16:18:54 INFO - Running main action method: create_virtualenv 16:18:54 INFO - Creating virtualenv /builds/slave/test/build/venv 16:18:54 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 16:18:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:18:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:18:54 INFO - Using real prefix '/tools/python27' 16:18:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:18:54 INFO - Installing distribute.............................................................................................................................................................................................done. 16:18:57 INFO - Installing pip.................done. 16:18:57 INFO - Return code: 0 16:18:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10929aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc432d775e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109139e00>, '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 0x108fa2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109134b20>, '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.oW7fHwegwP/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.XSfUjLzxC1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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 16:18:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:18:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oW7fHwegwP/Render', 16:18:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:18:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:18:57 INFO - 'HOME': '/Users/cltbld', 16:18:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:18:57 INFO - 'LOGNAME': 'cltbld', 16:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:57 INFO - 'MOZ_NO_REMOTE': '1', 16:18:57 INFO - 'NO_EM_RESTART': '1', 16:18:57 INFO - 'PAGER': '/bin/cat', 16:18:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:57 INFO - 'PWD': '/builds/slave/test', 16:18:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:18:57 INFO - 'SHELL': '/bin/bash', 16:18:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XSfUjLzxC1/Listeners', 16:18:57 INFO - 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/', 16:18:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:18:57 INFO - 'USER': 'cltbld', 16:18:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:18:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:57 INFO - 'XPC_FLAGS': '0x0', 16:18:57 INFO - 'XPC_SERVICE_NAME': '0', 16:18:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:57 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 16:18:57 INFO - Cleaning up... 16:18:57 INFO - Return code: 0 16:18:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10929aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc432d775e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109139e00>, '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 0x108fa2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109134b20>, '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.oW7fHwegwP/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.XSfUjLzxC1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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 16:18:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:18:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oW7fHwegwP/Render', 16:18:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:18:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:18:57 INFO - 'HOME': '/Users/cltbld', 16:18:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:18:57 INFO - 'LOGNAME': 'cltbld', 16:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:57 INFO - 'MOZ_NO_REMOTE': '1', 16:18:57 INFO - 'NO_EM_RESTART': '1', 16:18:57 INFO - 'PAGER': '/bin/cat', 16:18:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:57 INFO - 'PWD': '/builds/slave/test', 16:18:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:18:57 INFO - 'SHELL': '/bin/bash', 16:18:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XSfUjLzxC1/Listeners', 16:18:57 INFO - 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/', 16:18:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:18:57 INFO - 'USER': 'cltbld', 16:18:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:18:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:57 INFO - 'XPC_FLAGS': '0x0', 16:18:57 INFO - 'XPC_SERVICE_NAME': '0', 16:18:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:58 INFO - Downloading/unpacking psutil>=0.7.1 16:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:19:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:19:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:19:00 INFO - Installing collected packages: psutil 16:19:00 INFO - Running setup.py install for psutil 16:19:00 INFO - building 'psutil._psutil_osx' extension 16:19:00 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 16:19:01 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 16:19:01 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 16:19:01 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 16:19:01 INFO - building 'psutil._psutil_posix' extension 16:19:01 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 16:19:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:19:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:19:01 INFO - ^ 16:19:01 INFO - 1 warning generated. 16:19:01 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 16:19:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:19:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:19:01 INFO - Successfully installed psutil 16:19:01 INFO - Cleaning up... 16:19:01 INFO - Return code: 0 16:19:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:19:01 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:01 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:01 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10929aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc432d775e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109139e00>, '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 0x108fa2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109134b20>, '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.oW7fHwegwP/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.XSfUjLzxC1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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 16:19:01 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.0.0'] in /builds/slave/test/build 16:19:01 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.0.0 16:19:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oW7fHwegwP/Render', 16:19:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:01 INFO - 'HOME': '/Users/cltbld', 16:19:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:01 INFO - 'LOGNAME': 'cltbld', 16:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:01 INFO - 'MOZ_NO_REMOTE': '1', 16:19:01 INFO - 'NO_EM_RESTART': '1', 16:19:01 INFO - 'PAGER': '/bin/cat', 16:19:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:01 INFO - 'PWD': '/builds/slave/test', 16:19:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:01 INFO - 'SHELL': '/bin/bash', 16:19:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XSfUjLzxC1/Listeners', 16:19:01 INFO - 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/', 16:19:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:01 INFO - 'USER': 'cltbld', 16:19:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:01 INFO - 'XPC_FLAGS': '0x0', 16:19:01 INFO - 'XPC_SERVICE_NAME': '0', 16:19:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:19:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:19:04 INFO - Installing collected packages: mozsystemmonitor 16:19:04 INFO - Running setup.py install for mozsystemmonitor 16:19:04 INFO - Successfully installed mozsystemmonitor 16:19:04 INFO - Cleaning up... 16:19:04 INFO - Return code: 0 16:19:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:04 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 0x10929aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc432d775e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109139e00>, '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 0x108fa2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109134b20>, '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.oW7fHwegwP/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.XSfUjLzxC1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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 16:19:04 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 16:19:04 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 16:19:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oW7fHwegwP/Render', 16:19:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:04 INFO - 'HOME': '/Users/cltbld', 16:19:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:04 INFO - 'LOGNAME': 'cltbld', 16:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:04 INFO - 'MOZ_NO_REMOTE': '1', 16:19:04 INFO - 'NO_EM_RESTART': '1', 16:19:04 INFO - 'PAGER': '/bin/cat', 16:19:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:04 INFO - 'PWD': '/builds/slave/test', 16:19:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:04 INFO - 'SHELL': '/bin/bash', 16:19:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XSfUjLzxC1/Listeners', 16:19:04 INFO - 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/', 16:19:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:04 INFO - 'USER': 'cltbld', 16:19:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:04 INFO - 'XPC_FLAGS': '0x0', 16:19:04 INFO - 'XPC_SERVICE_NAME': '0', 16:19:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:04 INFO - Downloading/unpacking blobuploader==1.2.4 16:19:04 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 16:19:04 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 16:19:04 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 16:19:04 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 16:19:04 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 16:19:04 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 16:19:07 INFO - Downloading blobuploader-1.2.4.tar.gz 16:19:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:19:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:19:07 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 16:19:07 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 16:19:07 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 16:19:07 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 16:19:07 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 16:19:07 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 16:19:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:19:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:19:08 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 16:19:08 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 16:19:08 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 16:19:08 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 16:19:08 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 16:19:08 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 16:19:08 INFO - Downloading docopt-0.6.1.tar.gz 16:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:19:08 INFO - Installing collected packages: blobuploader, requests, docopt 16:19:08 INFO - Running setup.py install for blobuploader 16:19:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:19:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:19:08 INFO - Running setup.py install for requests 16:19:09 INFO - Running setup.py install for docopt 16:19:09 INFO - Successfully installed blobuploader requests docopt 16:19:09 INFO - Cleaning up... 16:19:09 INFO - Return code: 0 16:19:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:09 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 0x10929aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc432d775e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109139e00>, '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 0x108fa2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109134b20>, '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.oW7fHwegwP/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.XSfUjLzxC1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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 16:19:09 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 16:19:09 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 16:19:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oW7fHwegwP/Render', 16:19:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:09 INFO - 'HOME': '/Users/cltbld', 16:19:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:09 INFO - 'LOGNAME': 'cltbld', 16:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:09 INFO - 'MOZ_NO_REMOTE': '1', 16:19:09 INFO - 'NO_EM_RESTART': '1', 16:19:09 INFO - 'PAGER': '/bin/cat', 16:19:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:09 INFO - 'PWD': '/builds/slave/test', 16:19:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:09 INFO - 'SHELL': '/bin/bash', 16:19:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XSfUjLzxC1/Listeners', 16:19:09 INFO - 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/', 16:19:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:09 INFO - 'USER': 'cltbld', 16:19:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:09 INFO - 'XPC_FLAGS': '0x0', 16:19:09 INFO - 'XPC_SERVICE_NAME': '0', 16:19:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:19:09 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-tC3irC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:19:09 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-an5Bbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:19:09 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-c63ohK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:19:10 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-ImsPcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:19:10 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-pirGC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:19:10 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-5w1Mil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:19:10 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-N3ZZnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:19:10 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-W_ssTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:19:10 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-qGofl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:19:10 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-IU46F_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:19:10 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-09sfk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:19:10 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-LfHH5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:19:10 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-jveTKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:19:11 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-yd9ezi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:11 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-PZZYGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:19:11 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-kQsd37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:19:11 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-UwNayx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:19:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:19:11 INFO - Running setup.py install for manifestparser 16:19:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:19:11 INFO - Running setup.py install for mozcrash 16:19:11 INFO - Running setup.py install for mozdebug 16:19:11 INFO - Running setup.py install for mozdevice 16:19:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:19:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:19:12 INFO - Running setup.py install for mozfile 16:19:12 INFO - Running setup.py install for mozhttpd 16:19:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:19:12 INFO - Running setup.py install for mozinfo 16:19:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:19:12 INFO - Running setup.py install for mozInstall 16:19:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:19:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:19:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:19:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:19:12 INFO - Running setup.py install for mozleak 16:19:12 INFO - Running setup.py install for mozlog 16:19:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:19:12 INFO - Running setup.py install for moznetwork 16:19:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:19:13 INFO - Running setup.py install for mozprocess 16:19:13 INFO - Running setup.py install for mozprofile 16:19:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:19:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:19:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:19:13 INFO - Running setup.py install for mozrunner 16:19:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:19:13 INFO - Running setup.py install for mozscreenshot 16:19:13 INFO - Running setup.py install for moztest 16:19:13 INFO - Running setup.py install for mozversion 16:19:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:19:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:19:14 INFO - Cleaning up... 16:19:14 INFO - Return code: 0 16:19:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:14 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 0x10929aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc432d775e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109139e00>, '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 0x108fa2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109134b20>, '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.oW7fHwegwP/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.XSfUjLzxC1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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 16:19:14 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 16:19:14 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 16:19:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oW7fHwegwP/Render', 16:19:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:14 INFO - 'HOME': '/Users/cltbld', 16:19:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:14 INFO - 'LOGNAME': 'cltbld', 16:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:14 INFO - 'MOZ_NO_REMOTE': '1', 16:19:14 INFO - 'NO_EM_RESTART': '1', 16:19:14 INFO - 'PAGER': '/bin/cat', 16:19:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:14 INFO - 'PWD': '/builds/slave/test', 16:19:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:14 INFO - 'SHELL': '/bin/bash', 16:19:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XSfUjLzxC1/Listeners', 16:19:14 INFO - 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/', 16:19:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:14 INFO - 'USER': 'cltbld', 16:19:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:14 INFO - 'XPC_FLAGS': '0x0', 16:19:14 INFO - 'XPC_SERVICE_NAME': '0', 16:19:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:19:14 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-D3jSPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:19:14 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)) 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:19:14 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-WtZhWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:19:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:19:14 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-Zlx7GQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:19:14 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)) 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:19:14 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-NG1tqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:19:14 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)) 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:19:14 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-rGJpeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:19:14 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)) 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:19:14 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-U7VSC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:19:14 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)) 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:19:14 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-MFVI3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:19:15 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)) 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:19:15 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-_DkuvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:19:15 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)) 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:19:15 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-d1GPBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:19:15 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)) 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:19:15 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-VNFquq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:19:15 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-KRpaHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:19:15 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)) 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:19:15 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-vEuy_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:19:15 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-JWE3Nd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:19:15 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)) 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:19:15 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-AIf_6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:15 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-Kgbkfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:15 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)) 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:19:15 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-BaOmOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:19:16 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)) 16:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:19:16 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-rrYH17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:19:16 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)) 16:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:19:16 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)) 16:19:16 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)) 16:19:16 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)) 16:19:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:19:16 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 16:19:16 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 16:19:16 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 16:19:16 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 16:19:16 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 16:19:16 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 16:19:18 INFO - Downloading blessings-1.6.tar.gz 16:19:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:19:18 INFO - Installing collected packages: blessings 16:19:18 INFO - Running setup.py install for blessings 16:19:18 INFO - Successfully installed blessings 16:19:18 INFO - Cleaning up... 16:19:18 INFO - Return code: 0 16:19:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:19:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:19:19 INFO - Reading from file tmpfile_stdout 16:19:19 INFO - Current package versions: 16:19:19 INFO - blessings == 1.6 16:19:19 INFO - blobuploader == 1.2.4 16:19:19 INFO - docopt == 0.6.1 16:19:19 INFO - manifestparser == 1.1 16:19:19 INFO - mozInstall == 1.12 16:19:19 INFO - mozcrash == 0.17 16:19:19 INFO - mozdebug == 0.1 16:19:19 INFO - mozdevice == 0.48 16:19:19 INFO - mozfile == 1.2 16:19:19 INFO - mozhttpd == 0.7 16:19:19 INFO - mozinfo == 0.9 16:19:19 INFO - mozleak == 0.1 16:19:19 INFO - mozlog == 3.1 16:19:19 INFO - moznetwork == 0.27 16:19:19 INFO - mozprocess == 0.22 16:19:19 INFO - mozprofile == 0.28 16:19:19 INFO - mozrunner == 6.11 16:19:19 INFO - mozscreenshot == 0.1 16:19:19 INFO - mozsystemmonitor == 0.0 16:19:19 INFO - moztest == 0.7 16:19:19 INFO - mozversion == 1.4 16:19:19 INFO - psutil == 3.1.1 16:19:19 INFO - requests == 1.2.3 16:19:19 INFO - wsgiref == 0.1.2 16:19:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19:19 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:19 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:19 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 0x10929aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc432d775e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109139e00>, '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 0x108fa2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109134b20>, '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.oW7fHwegwP/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.XSfUjLzxC1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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 16:19:19 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 16:19:19 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 16:19:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oW7fHwegwP/Render', 16:19:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:19 INFO - 'HOME': '/Users/cltbld', 16:19:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:19 INFO - 'LOGNAME': 'cltbld', 16:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:19 INFO - 'MOZ_NO_REMOTE': '1', 16:19:19 INFO - 'NO_EM_RESTART': '1', 16:19:19 INFO - 'PAGER': '/bin/cat', 16:19:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:19 INFO - 'PWD': '/builds/slave/test', 16:19:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:19 INFO - 'SHELL': '/bin/bash', 16:19:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XSfUjLzxC1/Listeners', 16:19:19 INFO - 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/', 16:19:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:19 INFO - 'USER': 'cltbld', 16:19:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:19 INFO - 'XPC_FLAGS': '0x0', 16:19:19 INFO - 'XPC_SERVICE_NAME': '0', 16:19:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:19 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)) 16:19:19 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)) 16:19:19 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)) 16:19:19 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)) 16:19:19 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)) 16:19:19 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)) 16:19:19 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)) 16:19:19 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)) 16:19:19 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)) 16:19:19 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)) 16:19:19 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)) 16:19:19 INFO - Cleaning up... 16:19:19 INFO - Return code: 0 16:19:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:19:19 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:19 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:19 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 0x10929aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc432d775e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109139e00>, '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 0x108fa2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109134b20>, '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.oW7fHwegwP/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.XSfUjLzxC1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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 16:19:19 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 16:19:19 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 16:19:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oW7fHwegwP/Render', 16:19:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:19 INFO - 'HOME': '/Users/cltbld', 16:19:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:19 INFO - 'LOGNAME': 'cltbld', 16:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:19 INFO - 'MOZ_NO_REMOTE': '1', 16:19:19 INFO - 'NO_EM_RESTART': '1', 16:19:19 INFO - 'PAGER': '/bin/cat', 16:19:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:19 INFO - 'PWD': '/builds/slave/test', 16:19:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:19 INFO - 'SHELL': '/bin/bash', 16:19:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XSfUjLzxC1/Listeners', 16:19:19 INFO - 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/', 16:19:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:19 INFO - 'USER': 'cltbld', 16:19:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:19 INFO - 'XPC_FLAGS': '0x0', 16:19:19 INFO - 'XPC_SERVICE_NAME': '0', 16:19:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:19 INFO - Downloading/unpacking jsonschema 16:19:19 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 16:19:19 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 16:19:19 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 16:19:19 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 16:19:19 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 16:19:19 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 16:19:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:19:22 INFO - Downloading/unpacking functools32 (from jsonschema) 16:19:22 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 16:19:22 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 16:19:22 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 16:19:22 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 16:19:22 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 16:19:22 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 16:19:22 INFO - Downloading functools32-3.2.3-2.tar.gz 16:19:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:19:22 INFO - warning: no files found matching '*.txt' 16:19:22 INFO - no previously-included directories found matching 'build' 16:19:22 INFO - no previously-included directories found matching 'dist' 16:19:22 INFO - no previously-included directories found matching '.git*' 16:19:22 INFO - Installing collected packages: jsonschema, functools32 16:19:22 INFO - Running setup.py install for functools32 16:19:22 INFO - warning: no files found matching '*.txt' 16:19:22 INFO - no previously-included directories found matching 'build' 16:19:22 INFO - no previously-included directories found matching 'dist' 16:19:22 INFO - no previously-included directories found matching '.git*' 16:19:22 INFO - Successfully installed jsonschema functools32 16:19:22 INFO - Cleaning up... 16:19:22 INFO - Return code: 0 16:19:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:22 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10929aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc432d775e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109139e00>, '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 0x108fa2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109134b20>, '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.oW7fHwegwP/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.XSfUjLzxC1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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 16:19:22 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', 'flake8'] in /builds/slave/test/build 16:19:22 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 flake8 16:19:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oW7fHwegwP/Render', 16:19:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:22 INFO - 'HOME': '/Users/cltbld', 16:19:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:22 INFO - 'LOGNAME': 'cltbld', 16:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:22 INFO - 'MOZ_NO_REMOTE': '1', 16:19:22 INFO - 'NO_EM_RESTART': '1', 16:19:22 INFO - 'PAGER': '/bin/cat', 16:19:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:22 INFO - 'PWD': '/builds/slave/test', 16:19:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:22 INFO - 'SHELL': '/bin/bash', 16:19:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XSfUjLzxC1/Listeners', 16:19:22 INFO - 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/', 16:19:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:22 INFO - 'USER': 'cltbld', 16:19:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:22 INFO - 'XPC_FLAGS': '0x0', 16:19:22 INFO - 'XPC_SERVICE_NAME': '0', 16:19:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:23 INFO - Downloading/unpacking flake8 16:19:23 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 16:19:23 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 16:19:23 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 16:19:23 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 16:19:23 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 16:19:23 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 16:19:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:19:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:19:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:19:26 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 16:19:26 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 16:19:26 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 16:19:26 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 16:19:26 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 16:19:26 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 16:19:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:19:26 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 16:19:26 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 16:19:26 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 16:19:26 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 16:19:26 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 16:19:26 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 16:19:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:19:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:19:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:19:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:19:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:19:26 INFO - no previously-included directories found matching 'docs/_build' 16:19:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:19:27 INFO - Running setup.py install for pep8 16:19:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:19:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:19:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:19:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:19:27 INFO - no previously-included directories found matching 'docs/_build' 16:19:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:19:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:19:27 INFO - Cleaning up... 16:19:27 INFO - Return code: 0 16:19:27 INFO - Running post-action listener: _resource_record_post_action 16:19:27 INFO - Running post-action listener: _start_resource_monitoring 16:19:27 INFO - Starting resource monitoring. 16:19:27 INFO - ##### 16:19:27 INFO - ##### Running install step. 16:19:27 INFO - ##### 16:19:27 INFO - Running pre-action listener: _resource_record_pre_action 16:19:27 INFO - Running main action method: install 16:19:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:19:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:19:27 INFO - Reading from file tmpfile_stdout 16:19:27 INFO - Detecting whether we're running mozinstall >=1.0... 16:19:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:19:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:19:27 INFO - Reading from file tmpfile_stdout 16:19:27 INFO - Output received: 16:19:27 INFO - Usage: mozinstall [options] installer 16:19:27 INFO - Options: 16:19:27 INFO - -h, --help show this help message and exit 16:19:27 INFO - -d DEST, --destination=DEST 16:19:27 INFO - Directory to install application into. [default: 16:19:27 INFO - "/builds/slave/test"] 16:19:27 INFO - --app=APP Application being installed. [default: firefox] 16:19:27 INFO - mkdir: /builds/slave/test/build/application 16:19:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:19:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 16:19:59 INFO - Reading from file tmpfile_stdout 16:19:59 INFO - Output received: 16:19:59 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:19:59 INFO - Running post-action listener: _resource_record_post_action 16:19:59 INFO - ##### 16:19:59 INFO - ##### Running run-tests step. 16:19:59 INFO - ##### 16:19:59 INFO - Running pre-action listener: _resource_record_pre_action 16:19:59 INFO - Running main action method: run_tests 16:19:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:19:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:19:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:19:59 INFO - 2016-05-25 16:19:59.470 screenresolution[1993:13629] starting screenresolution argv=screenresolution get 16:19:59 INFO - 2016-05-25 16:19:59.473 screenresolution[1993:13629] Display 0: 1600x1200x32@60 16:19:59 INFO - 2016-05-25 16:19:59.479 screenresolution[1994:13632] starting screenresolution argv=screenresolution list 16:19:59 INFO - Available Modes on Display 0 16:19:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:19:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:19:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:19:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:19:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:19:59 INFO - Intel Iris: 16:19:59 INFO - Chipset Model: Intel Iris 16:19:59 INFO - Type: GPU 16:19:59 INFO - Bus: Built-In 16:19:59 INFO - VRAM (Dynamic, Max): 1536 MB 16:19:59 INFO - Vendor: Intel (0x8086) 16:19:59 INFO - Device ID: 0x0a2e 16:19:59 INFO - Revision ID: 0x0009 16:19:59 INFO - Displays: 16:19:59 INFO - Display: 16:19:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:19:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:19:59 INFO - Display Serial Number: 1600x1200 60 16:19:59 INFO - Main Display: Yes 16:19:59 INFO - Mirror: Off 16:19:59 INFO - Online: Yes 16:19:59 INFO - Rotation: Supported 16:19:59 INFO - Return code: 0 16:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:19:59 INFO - Python 2.7.3 16:19:59 INFO - Return code: 0 16:19:59 INFO - grabbing minidump binary from tooltool 16:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:59 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109139e00>, '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 0x108fa2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109134b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:19:59 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 16:19:59 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 16:19:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:19:59 INFO - Return code: 0 16:19:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:19:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:19:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:19:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:19:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:20:00 INFO - Return code: 0 16:20:00 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/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0392', '--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 16:20:00 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/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0392 --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 16:20:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oW7fHwegwP/Render', 16:20:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:20:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:20:00 INFO - 'HOME': '/Users/cltbld', 16:20:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:20:00 INFO - 'LOGNAME': 'cltbld', 16:20:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:20:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:00 INFO - 'MOZ_NO_REMOTE': '1', 16:20:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:20:00 INFO - 'NO_EM_RESTART': '1', 16:20:00 INFO - 'PAGER': '/bin/cat', 16:20:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:00 INFO - 'PWD': '/builds/slave/test', 16:20:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:20:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:20:00 INFO - 'SHELL': '/bin/bash', 16:20:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XSfUjLzxC1/Listeners', 16:20:00 INFO - 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/', 16:20:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:20:00 INFO - 'USER': 'cltbld', 16:20:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:20:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:00 INFO - 'XPC_FLAGS': '0x0', 16:20:00 INFO - 'XPC_SERVICE_NAME': '0', 16:20:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:20:00 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/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0392', '--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 16:20:01 INFO - mozversion application_buildid: 20160525152143 16:20:01 INFO - mozversion application_changeset: 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 16:20:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:20:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:20:01 INFO - mozversion application_name: Firefox 16:20:01 INFO - mozversion application_remotingname: firefox-dev 16:20:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:20:01 INFO - mozversion application_vendor: Mozilla 16:20:01 INFO - mozversion application_version: 48.0a2 16:20:01 INFO - mozversion platform_buildid: 20160525152143 16:20:01 INFO - mozversion platform_changeset: 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 16:20:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:20:01 INFO - mozversion platform_version: 48.0a2 16:20:01 INFO - using testdate: 1464218401 16:20:01 INFO - actual date: 1464218401 16:20:01 INFO - starting webserver on 'localhost:51354' 16:20:01 INFO - SUITE-START | Running 2 tests 16:20:01 INFO - TEST-START | dromaeo_css 16:20:01 INFO - operating with platform_type : mac_ 16:20:01 INFO - Initialising browser for dromaeo_css test... 16:20:01 INFO - TEST-INFO | started process 2012 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/tmp8mpiAz/profile http://localhost:51354/getInfo.html) 16:20:03 INFO - PROCESS | 2012 | __metrics Screen width/height:1600/1200 16:20:03 INFO - PROCESS | 2012 | colorDepth:24 16:20:03 INFO - PROCESS | 2012 | Browser inner width/height: 1024/689 16:20:03 INFO - PROCESS | 2012 | __metrics 16:20:03 ERROR - PROCESS | 2012 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 16:20:04 INFO - TEST-INFO | 2012: exit 0 16:20:04 INFO - Browser initialized. 16:20:04 INFO - Running cycle 1/1 for dromaeo_css test... 16:20:04 INFO - TEST-INFO | started process 2015 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/tmp8mpiAz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:20:16 INFO - PROCESS | 2015 | RSS: Main: 221605888 16:20:16 INFO - PROCESS | 2015 | 16:21:06 INFO - PROCESS | 2015 | 1464218466144 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] 16:23:17 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:51354/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51354/tests/dromaeo/cssquery-ext.html) 16:23:19 INFO - PROCESS | 2015 | RSS: Main: 231411712 16:23:19 INFO - PROCESS | 2015 | 16:26:21 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:51354/tests/dromaeo/cssquery-ext.html (next: http://localhost:51354/tests/dromaeo/cssquery-jquery.html) 16:26:21 INFO - PROCESS | 2015 | RSS: Main: 243752960 16:26:21 INFO - PROCESS | 2015 | 16:29:23 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:51354/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51354/tests/dromaeo/cssquery-mootools.html) 16:29:24 INFO - PROCESS | 2015 | RSS: Main: 245669888 16:29:24 INFO - PROCESS | 2015 | 16:32:26 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:51354/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51354/tests/dromaeo/cssquery-prototype.html) 16:32:26 INFO - PROCESS | 2015 | RSS: Main: 247398400 16:32:26 INFO - PROCESS | 2015 | 16:35:29 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:51354/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51354/tests/dromaeo/cssquery-yui.html) 16:35:29 INFO - PROCESS | 2015 | RSS: Main: 250265600 16:35:29 INFO - PROCESS | 2015 | 16:38:32 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:51354/tests/dromaeo/cssquery-yui.html (next: http://localhost:51354/tests/dromaeo/cssquery-dojo.html) 16:38:32 INFO - PROCESS | 2015 | RSS: Main: 251199488 16:38:32 INFO - PROCESS | 2015 | 16:38:32 INFO - PROCESS | 2015 | __start_tp_report 16:38:32 INFO - PROCESS | 2015 | _x_x_mozilla_page_load 16:38:32 INFO - PROCESS | 2015 | _x_x_mozilla_page_load_details 16:38:32 INFO - PROCESS | 2015 | |i|pagename|runs| 16:38:32 INFO - PROCESS | 2015 | |0;dojo.html;2948.307147820262;3110.191350248935;3473.8957831265056;3513.982430087852;3571.2143328467746;5300.999999999995;5459.235707001023;5686.919485297801;5819.388964158766;5831.4751672349485;4249.532551419341;4619.399478067855;5116.797552575142;5841.445062719045;5847.561432892539;5311.920321195185;5331.813386531472;5384.730763461831;5410.756515956791;5435.864103397407;5166.715830629314;5404.756785944623;5407.188921661743;5472.72636368182;5521.889562208753;5287.947120528784;5296.443873393296;5297.258383826267;5304.310439642841;5309.283246761695;5191.532762051434;5269.710165940872;5279.841604751864;5287.947120528784;5308.654937429054;5103.795848166069;5225.163973764217;5236.057509648262;5245.370555533323;5389.407165211824;5052.317937078484;5235.764390602432;5645.350784659735;5835.941640583582;5856.736446859859;6105.481034112106;6210.596311239755;6241.063840423927;6244.781432649881;6281.057841323838;6131.651934473353;6188.721507532172;6209.627422354673;6296.96851515744;6300.747970081191;5038;5786.103154011093;5949.375315591887;5974.641521508724;5974.940250597482;6439.259485159173;6454.2577603575255;6460.030995350641;6462.967685161544;6463;6128.509719222451;6131.499004853489;6171.783987560414;6209.782657607052;6242.375762423812;5773.5958482906635;5858.794942177004;6341.904871426932;6341.936580634135;6349.206349206349;6245.500359971192;6248.187735594343;6303.180586523814;6310.905336419957;6322.9051564226575;6180.5673602848265;6203.7828675996125;6228.096925945712;6298.527610429236;6304.968475157595;5001.924971125436;5013.172826483589;5013.89972200554;5015.423226328946;5023.673461225008;4394.648428125743;4409.492908315585;4484.394606728115;4493.73037617744;4508.301213311942;5853.560982926298;5854.121881717691;5874.794382196603;5893.734781934823;5970.671613061237;6274.968625156845;6278.372162783777;6279.748810047547;6296.244450665858;6306;5694.886102277931;5850.444207800338;5908.645481271052;5909.970450147722;5955.821325360246;5386.111291636915;5428.240046393508;5470.179473078991;5486;5516.586256030814;6473.28793832678;6538.607683538908;6544.246728375374;6545.672716364163;6559.508036897157;6194.907076393768;6238.251409830667;6300.71646775887;6327.17746692927;6331.620102793847;6430;6483.546151769519;6535.673216339069;6540.247871494839;6568.211814582281;6236.438720515175;6238.344973777688;6251.3123556407845;6261.843453913689;6266.154069200599;6118.296395914527;6190;6251.749930002749;6270.905936410866;6278.466330361788;6188.81433556994;6200.193974783249;6202.596831205957;6208.81373558794;6218.720157592828;5221.590170653826;6204.72078756448;6208.81373558794;6209.068639704081;6229.972054610938;5955.5235581154275;6012.969935150296;6029.125776762433;6083.391660833881;6159.19930409044;6153.261608606996;6209.59637623553;6211.378862113753;6214.40963108504;6237.594556353823;6097.847553811191;6105.572609917263;6109.7861574844665;6116.2660480740815;6117.082437634391 16:38:32 INFO - PROCESS | 2015 | |1;ext.html;478.4569513602063;522.3861962194421;523.884745356022;576.9211574355955;584.8274758946109;30279;40766.79616601913;40799.79600101995;40918.181636367255;41015.79492102543;41863.37204941928;42542.14915701692;42696.786516067456;42722.7863860681;42803.785981070054;9569.665061722824;9893.060159284856;9926;9942.204623630092;9955.701328960107;9807.41155530667;9929.602815887356;9939.2545559083;9963.601455941789;9963.850542241873;9890.85163722541;9939.453330066843;9946.751331216705;9958.900410995906;10112.443815590139;9814.75463113428;9881.752956176082;9885.159761420253;9944.055314745088;9956.35283706564;9745.805083898353;9856.112949834549;9866.901330986742;9867.506624668738;9881.90118098817;40826.591734082576;41471;41509.79245103785;41633;41828.372574411405;2870.641169853768;3114.299282661406;3194.8242846643657;3218.452863013293;3307.7849939753837;22262.55474890493;26615;27053.594196087073;27477.76350064232;27570.448591028067;2683.1145721911917;2715.4161855201028;2718.877650505732;2816.0143949617673;2826.901058462944;245127.77436112883;321271;325850.37074814475;328459;329404;30366.84816575903;35050.474242886376;36248.63751362506;37226.99999999946;37414.81292593574;35567.82216088903;36316.27367452636;36562;36790;36804.44793328102;15730;15883.444079457164;15921.681566368608;15923.203839807964;15992;11358.864113588575;13215.933920330337;13289.734205315839;13378.264195469148;13393.397297121459;8263.380246481418;8336;8354.28988535969;8463.407561470638;8490.490570565786;3032.757379409642;3429.605595356516;3447.5345828313357;3464.4283693190846;3499.4051011328133;1003.7039073473343;1027.173125633857;1073.5276478349501;1104.2932523185168;1120.910327173824;28687.71312286892;30298.545521817192;30322.69677303243;30653.38693226123;30665.84667076695;1112.2881355932209;1113.1762495753246;1124.2074337591978;1144.799660059503;1194.6953526850598;14977.176255306063;15010.24948752558;15029;15234;15356;464047;503607;513236;517783;520072.39963800693;59653.10520342198;59682;60092.798144036875;60596.697016515514;60598.48503787441;1451.9637009074859;1478.5859959211439;1498.90257133286;1500.6923580665937;1502.1662977047843;25522.617160742975;29074.85462572758;29317;29901.252468688457;30241.697583023888;55104.72447637736;55314.44685553254;55665.72167139138;55781.442185579246;56025.59936001633;530148;548310.2584487052;576208;577677;581040;27451.038826223794;27662;27784.305392364546;28612.141635750962;28682;47125.52874471348;47616.04767904553;48393.75803120962;49272;49559.46917279754;35027;39360.80319598383;39665;39963.2007359857;40097.59902400939;30338;39147.608523915536;39433.605663942995;39662.405063923485;40041;32894;37539.24921501609;37627;39298;39327.213455730154;28395.43209135847;30547.083587492412;33533.71811208516;34201.486977694854;34356.48465272973;20680.379588612366;22774.886125569265;25264;26486.867565662047;26499.60250596204 16:38:32 INFO - PROCESS | 2015 | |2;jquery.html;401.1715806858836;404.1129720264022;405.8944674384661;406.1592503517718;412.7853516171591;15035.248237588132;20360.490987725294;20763.58472830546;21077.789222107756;21084.57830843384;17470.340317669834;19448.027598620083;19792.30726924558;20077.59844803103;20420.285290014854;5622.240997465351;5643.8024669136585;5919.822405327847;5928.49607783339;5940.019896717036;5899.469047785698;5908.615939963888;5934.5845790794665;5940.138679891413;5963.493103086243;5847.99401943683;6006.8798624027495;6186.133941248228;6227.968860155715;6381.680915954207;6110.938890611082;6114.908276375858;6162.322144564095;6165.938340616626;6169.81490555284;5337.786488540453;5606.915896261559;5614.438556144353;5616.747246373923;5648.124540696199;13284.667883302995;14154.150750954976;21748.89125554378;23411.595304281796;25466.745332546623;2089.5507465894907;2312.167619656922;2428.732839387666;2505.248425472351;2673.9705213492944;9681.177099946513;9837.704868853945;10049.497525123788;10061.69814905554;13501;1707.1890851845399;1715.1167148918316;1730.3857130718666;1748.1783561726095;1756.771619689445;85152.6135539837;109267;120404.19393709101;133239.33380333037;135283.64716352907;22167.667484987738;22432;22476.775232247794;22536.098556057575;23128.306150815166;36320.910372688864;36964.81517592449;37654;37683.81158094192;37759.62240377616;11161.83257251142;11368.431578421212;11567.826482602768;11678.6496405108;11744;8135.227153420416;9658.855117173249;9660.178884794872;9667.661631842851;9674.322797404255;10267.254566723675;10284.691459256233;10327;10352.223583231287;10472.633457829092;3950.3481925481974;3991.7006224532697;4035.8183881725395;4123.484564429446;4224.577542245812;755.4636208292064;838.8884727735774;953.8712273843081;998.2912132385942;1040.0171837613534;20366.083526241353;20581.07385167671;20860.687089693667;21073.157073717186;21085.47286317824;988.3526290279879;994.3387647214666;1018.6994836523244;1028.4600584692946;1030.2118879057527;8259.95870020646;10970.177236707279;11179.776404471864;11206.38364889939;11224.66326010221;547785;552329;555262;556609;624962;118483;119025.40487297508;119786.4010679941;126529;129520;1011.4841430870309;1014.6245889020962;1017.9134773544332;1028.1825948371063;1030.314840630987;18191.18139683691;18209.544761381072;18331.54171145732;18432.723509147643;18887.90556047211;49145.75427122841;50744.731381715756;51482;52121.478785211664;54615;76078;77098.22901771135;77462.6126869362;79682;80249.19750802417;8251.669933202606;8267.090620031911;8328.333733301442;8450.816885636139;8478;8817.603207855791;11068.723281917695;12305.753884922073;12497.18768280059;12587.748245034865;10636.84044739345;10654.8401773975;10808.783824323313;11032.834507482234;11050.613228536962;10149.64476243328;10616.628418005641;10728.785424291627;10739.677809665722;11008.944955275172;10655.733606659896;10896.346219226873;11206.215564910379;11208.83186752183;11244.831327530257;8054.395920305883;8132.715354962548;8259.587020648823;8330;8423.241908228289;9388.859167112361;10289.84565231507;10537.315074520438;10835.187360947803;10881.673549793519 16:38:32 INFO - PROCESS | 2015 | |3;mootools.html;1454.2147240490135;1605.9518214453567;1816.2916462579587;1874.7469091672629;1973.4868934077135;7839.647215875285;7886.777549479825;8740.606672699729;8976.596053177607;8998.010218875927;7693.769186924387;8646.265067469272;8653.61058752356;8772.649094036247;8841.3643475957;2420.2013335599254;2421.055788242578;2421.624648179526;2425.6361545768186;2442.767937045987;2411.710594728635;2424.866632335221;2457.348802567321;2460.766227208412;2463.8275320727557;2432.7080750309988;2447.21689059501;2449.9755002450015;2450.987745061272;2471.8393304435244;2420.7942324902315;2437.2079074300923;2441.7314095449487;2467.037855236459;2472.7156377016513;2439.353571303606;2443.8655873926928;2468.9506209875703;2477.7274499805008;2478.368016155887;7993.520388776692;8584.785380365478;8801.647934082694;8802.823943521094;8965.596548155349;5332.706701131437;5344.599155063386;5458.317710286215;5476;5490.752916118784;3534.204803919123;3617.113807117247;3639.5268615080136;3671.3208056509366;3713.498677678506;864.2783275964578;1044.1385856668278;1047.5809676129609;1073.7315671082229;1074.0226393981518;10216.89783102167;12027.879721202764;12212.206206596631;12222.472190976128;12261.509539618404;4263.59495847894;4758.119747846659;4790.377250957423;4821.373221481185;4875.658703890694;10077.093061624342;10151.98480151979;10198.031187037219;10302.381857088598;10360.585576576852;5358.705271210043;5425.186222066643;5436.864078398072;5437.157240627709;5450;4397.142557201315;4817.590504807131;4881.023795240895;4922.778474968635;4953.950460495421;3606.549181352331;4146.91706165875;4148.543660197376;4215.852445164466;4217.768022758778;1186.2408058842348;1370.5271681269946;1380.475419340644;1392.3595146232847;1400.4258254115764;821.34292565947;832.0597724571196;849.8980122385229;892.4110087342452;955.47926380123;5918.763249469973;5959.28488581373;6033.607815491979;6048.36492168316;6262.185915830913;919.4896832258161;934.8223837470858;982.0474140084107;984.2077127912099;1028.5885645741764;3854.3447613905705;3916.921661566753;3975.6819454444153;3985.880423587297;4016.49793775778;10535.157187424988;10904.727381815517;10910.854360292215;10915.399653019002;10969.561217551209;10455.68632941013;10557.419341936115;10694.091002264739;10803.297785643908;10924.344539327507;8441.36689748259;8481.957590212132;8497.490150590984;8549.187827156411;8595.355348348774;5696.601237913306;5781.161731548986;5807.883842323215;5866.5893387462465;5883.323417806836;9578.13796758295;9671.854922176313;9733.221342292458;9805.117539421486;9884.406935583887;9264.258859291105;9638.95180524093;9656.034396560288;9966.451845148586;10089.949550252202;6756.594604323756;7190.604516751419;7417.480776345604;7428.73999410018;7594.544327340377;8163.102058773649;8173.673053078048;8195.139510351328;8197.877031844408;8211.302039326485;7163.570185788869;7324.670389832364;7354.301341372561;7357.374623157091;7455.440841936768;5878.911816322673;7201.171865235356;7315.268473152642;7327.4246037102275;7345.77962661121;6976.5814051157095;7034.085568876013;7068.68190931399;7072.469564782559;7077.716891324495;4036.677065834785;4763.285507173951;4805.663603547858;4832.6561617616135;4904.141775189399;4118.217538667644;4985.925211121764;4986.501349864984;4987.725675087905;5076.847694569169 16:38:32 INFO - PROCESS | 2015 | |4;prototype.html;319.77775446064993;324.1087010720519;332.12981987193547;332.1381016262797;333.83975691667985;5554.722263886804;6529.771457998971;6644.269130395659;6656.633885136328;6722.865542689149;5310.867228319294;5955.583109182359;6034.672372078136;6676.332366763333;6695.799126026215;4589;4887.193613053842;5012.949870501303;5015.648904576681;5019.54824065834;4989.825356112537;5005.849824505252;5008.749562521877;5018.84943451697;5025.522575355335;4961.585948004819;4972.5276098770555;4973.154563724158;4995.100881841267;5002.624803139761;4449.087936972913;4719.575238228559;4770.356001939728;4966.230234313687;4989.650724449272;4223.957760422387;4248.766317852517;4250.659947204216;4269.338252570826;4269.743815371056;5527.806526771584;6411;6496.058071579641;6505.577137486048;6510.93489065108;5828.41715828418;5894.528437724972;5904.5571582131515;5915.1718759373725;5924.14099955504;5931.73307201177;7203.89194162088;7204.955281484155;7223.566586004857;7240.746573869889;4565.452145742499;4741.928871066937;4742.620590352763;4755.548222918817;4777.856664300077;7603.809904752426;7624.199459056775;7627.360117574693;7679.2704693054075;7689.038870141232;4836.105320515716;4859.1496488114435;4864.367632207861;4877.829275975324;4881.316615673809;4961.05739909416;4964.652474326835;4966.031623833318;4967.3542439482635;4981.4769449207315;4729.787159577827;5889.116632505158;5921.289445266596;5924.5852790305125;5934.43622855828;6980.511364204457;7254.782356529313;7261;7282;7299.598522081336;1688.662267546471;1703.948881533556;1710.8973461592345;1716.3048965169125;1723.448496481114;1085.0505807418508;1088.472091035847;1110.5169251375678;1112.477135746198;1116.7822274656364;6389.297177310492;6461.8061458156335;6647.135872336566;6669.7332106715185;6680.198376194888;7541.849163016709;7584.08990921093;7587.848243035219;7597.088349397997;7626.199249078878;6596.340365963365;6600.669966501656;6662.167229096363;6668.399844014062;6675.699593518303;3234.75739319552;3938.369860822255;3976.025873660914;3993.101552150801;4016.6585840203325;7123.394511466583;7492.363149132276;7930.048394192619;7951.443398962017;7972.880406793903;6910.170779506491;7166.856662866713;7727.729529466442;7799.766007019798;7824.726134585262;6465.870682586322;7873.291403773688;7937.325327347125;7944.364450844034;7953.164917683675;7201.13586369618;7512.098548174254;7525.586092764732;7528;7544.132424771002;7376.188619251985;7423.2512581146175;7441.218672039575;7452.217517160837;7453.739119130804;7900.328472079707;7905.56519391439;7944.602769861368;7946.086200086833;7957.204279571996;4669.719816811003;4704.270838020112;4709.434867815884;4724.456687480846;4729.645276604199;5973.5519836013345;6324.683765811783;7210.819729506804;7492.475526713078;7542.962285188759;6060.757569697163;6986.196587392515;7220.1696804866015;7246.96376518114;7267.418606511572;5828.6502809831545;7207.603581803051;7233.565986040854;7241.746538871114;7260.201377848538;7049.682764275517;7075.575465472089;7080.2919708028785;7087.468439867133;7116.750913717995;6989.33601307875;7240.98626192323;7279.672414741243;7343.41252699772;7358.926410735824;5970.432808883149;6724.125863637696;6890.483213758888;7109.0047393366;7110.537815042006 16:38:32 INFO - PROCESS | 2015 | |5;yui.html;695.4123765418221;708.2917082917081;749.4192001199074;764.4992529892922;775.4688038693496;14499;14584.562463126096;14695.33870975806;14709.92645036776;14748.33632486538;13995.93002034991;14024;14043.578692639237;14074;14112;720.3480849830911;898.8876390451194;902.823949329881;917.0966597901046;927.8469052606312;891.1177933845479;911.7219248129318;919.0487845080344;923.8198551282469;924.5839372282467;955.6750704760381;980.7499087732618;986.1272773595384;989.4360214677637;992.1764935103846;944.211583327922;944.4003058058148;958.1711819276345;977.1108291454742;980.8185485685135;693.9514234003622;696.7944456385378;710.5488015110391;717.8564287142592;721.12383454103;15007;15111.54665360041;15218.315175817115;15236.771448428282;15266.78631598423;12656.873431265662;12673.556425525063;12843.743125137538;12881.935590322082;13073.673158171026;9873.753156171082;9890.653827116088;9926.90804011558;9941.950290248575;10118.595256189743;3463.6709512596262;3488.284901595167;3510.947335789965;3536.5756109267054;3545.8936231913085;77482.61258693671;78164.99999999943;78668.60665696635;78889;79586;9317.068293170629;9397.154256116846;9496.857547136799;9515.666951656798;9701.07839755222;20628.278010269867;20748.58502829935;20801.479963000744;20803.79196208049;20909.581808363746;7433;7491.438142139361;7572.697092116364;7576.507527010726;7629.580373079423;4086.40747091676;4140.792960351971;4141.151064031867;4153.003279212967;4229.598188172119;2969.272528230554;3589.9102522436624;3633.981830090833;3647.398179300386;3658.9634103658623;646.8835609590225;649.8537828988534;651.2347991110427;655.6262930129875;658.8287045368143;530.830327775327;538.4265756968815;600.6306121735101;604.1183554445272;617.4227097663698;8307;8333.458325208841;8413.495190288602;8473.237408633253;8497.66009359631;509.8597885581495;568.5678884048153;599.5203836930439;610.914471973924;617.3332800575457;3194.2653189766484;3734.1971476132762;3864.2078373933277;3887.1730286765173;4127.2570937231585;55423.722881385336;70143.64928175327;82167.589162055;94524.52737736267;94700;74684;75401.6229918847;75995.24004759881;76042.23957760462;77311;45433.772831136295;50399.748001260494;68289.65855170792;70314.64842675754;72394.27605723875;8371.204735550113;8518.190771876662;8562.52906090171;8728.650853966024;8761.211490965588;44916.427925022464;45551;46437;46770;48817.02365952732;62640;64511;65899.34100658933;68424;68474;10924;11144.609938652433;11243.60647377338;11298;11594.94202528982;11860;12016.279023258632;12127.45426455794;12170.14808963364;12604.432800523815;11122.499487523242;11294.04000659953;11327.207095503236;11603.5358585659;12105.394730263275;11320.435332423809;11377.43112844371;11483.655490335303;11587.362695051854;12125.27248365101;8369.665213391396;11177.217594768288;11400.828987565359;11697.06423486136;11974.880251197377;9433.538699458786;9503.619855205714;9516.68188417747;9687.079727425884;9972.800543989224;8604.225619694258;8965.686200982935;9627.374220675634;9753.304622737853;9791.363561368487 16:38:32 INFO - PROCESS | 2015 | __end_tp_report 16:38:32 INFO - PROCESS | 2015 | __start_cc_report 16:38:32 INFO - PROCESS | 2015 | _x_x_mozilla_cycle_collect,425 16:38:32 INFO - PROCESS | 2015 | __end_cc_report 16:38:32 INFO - PROCESS | 2015 | __startTimestamp1464219512467__endTimestamp 16:38:32 INFO - PROCESS | 2015 | 16:38:32 INFO - PROCESS | 2015 | ------- Summary: start ------- 16:38:32 INFO - PROCESS | 2015 | Number of tests: 6 16:38:32 INFO - PROCESS | 2015 | 16:38:32 INFO - PROCESS | 2015 | [#0] dojo.html Cycles:165 Average:5788.10 Median:6097.85 stddev:684.35 (11.2%) stddev-sans-first:649.18 16:38:32 INFO - PROCESS | 2015 | Values: 2948.3 3110.2 3473.9 3514.0 3571.2 5301.0 5459.2 5686.9 5819.4 5831.5 4249.5 4619.4 5116.8 5841.4 5847.6 5311.9 5331.8 5384.7 5410.8 5435.9 5166.7 5404.8 5407.2 5472.7 5521.9 5287.9 5296.4 5297.3 5304.3 5309.3 5191.5 5269.7 5279.8 5287.9 5308.7 5103.8 5225.2 5236.1 5245.4 5389.4 5052.3 5235.8 5645.4 5835.9 5856.7 6105.5 6210.6 6241.1 6244.8 6281.1 6131.7 6188.7 6209.6 6297.0 6300.7 5038.0 5786.1 5949.4 5974.6 5974.9 6439.3 6454.3 6460.0 6463.0 6463.0 6128.5 6131.5 6171.8 6209.8 6242.4 5773.6 5858.8 6341.9 6341.9 6349.2 6245.5 6248.2 6303.2 6310.9 6322.9 6180.6 6203.8 6228.1 6298.5 6305.0 5001.9 5013.2 5013.9 5015.4 5023.7 4394.6 4409.5 4484.4 4493.7 4508.3 5853.6 5854.1 5874.8 5893.7 5970.7 6275.0 6278.4 6279.7 6296.2 6306.0 5694.9 5850.4 5908.6 5910.0 5955.8 5386.1 5428.2 5470.2 5486.0 5516.6 6473.3 6538.6 6544.2 6545.7 6559.5 6194.9 6238.3 6300.7 6327.2 6331.6 6430.0 6483.5 6535.7 6540.2 6568.2 6236.4 6238.3 6251.3 6261.8 6266.2 6118.3 6190.0 6251.7 6270.9 6278.5 6188.8 6200.2 6202.6 6208.8 6218.7 5221.6 6204.7 6208.8 6209.1 6230.0 5955.5 6013.0 6029.1 6083.4 6159.2 6153.3 6209.6 6211.4 6214.4 6237.6 6097.8 6105.6 6109.8 6116.3 6117.1 16:38:32 INFO - PROCESS | 2015 | 16:38:32 INFO - PROCESS | 2015 | [#1] ext.html Cycles:180 Average:59273.80 Median:36676.00 stddev:126071.63 (343.7%) stddev-sans-first:126348.01 16:38:32 INFO - PROCESS | 2015 | Values: 478.5 522.4 523.9 576.9 584.8 30279.0 40766.8 40799.8 40918.2 41015.8 41863.4 42542.1 42696.8 42722.8 42803.8 9569.7 9893.1 9926.0 9942.2 9955.7 9807.4 9929.6 9939.3 9963.6 9963.9 9890.9 9939.5 9946.8 9958.9 10112.4 9814.8 9881.8 9885.2 9944.1 9956.4 9745.8 9856.1 9866.9 9867.5 9881.9 40826.6 41471.0 41509.8 41633.0 41828.4 2870.6 3114.3 3194.8 3218.5 3307.8 22262.6 26615.0 27053.6 27477.8 27570.4 2683.1 2715.4 2718.9 2816.0 2826.9 245127.8 321271.0 325850.4 328459.0 329404.0 30366.8 35050.5 36248.6 37227.0 37414.8 35567.8 36316.3 36562.0 36790.0 36804.4 15730.0 15883.4 15921.7 15923.2 15992.0 11358.9 13215.9 13289.7 13378.3 13393.4 8263.4 8336.0 8354.3 8463.4 8490.5 3032.8 3429.6 3447.5 3464.4 3499.4 1003.7 1027.2 1073.5 1104.3 1120.9 28687.7 30298.5 30322.7 30653.4 30665.8 1112.3 1113.2 1124.2 1144.8 1194.7 14977.2 15010.2 15029.0 15234.0 15356.0 464047.0 503607.0 513236.0 517783.0 520072.4 59653.1 59682.0 60092.8 60596.7 60598.5 1452.0 1478.6 1498.9 1500.7 1502.2 25522.6 29074.9 29317.0 29901.3 30241.7 55104.7 55314.4 55665.7 55781.4 56025.6 530148.0 548310.3 576208.0 577677.0 581040.0 27451.0 27662.0 27784.3 28612.1 28682.0 47125.5 47616.0 48393.8 49272.0 49559.5 35027.0 39360.8 39665.0 39963.2 40097.6 30338.0 39147.6 39433.6 39662.4 40041.0 32894.0 37539.2 37627.0 39298.0 39327.2 28395.4 30547.1 33533.7 34201.5 34356.5 20680.4 22774.9 25264.0 26486.9 26499.6 16:38:32 INFO - PROCESS | 2015 | 16:38:32 INFO - PROCESS | 2015 | [#2] jquery.html Cycles:180 Average:34964.15 Median:12424.13 stddev:94822.51 (763.2%) stddev-sans-first:95053.00 16:38:32 INFO - PROCESS | 2015 | Values: 401.2 404.1 405.9 406.2 412.8 15035.2 20360.5 20763.6 21077.8 21084.6 17470.3 19448.0 19792.3 20077.6 20420.3 5622.2 5643.8 5919.8 5928.5 5940.0 5899.5 5908.6 5934.6 5940.1 5963.5 5848.0 6006.9 6186.1 6228.0 6381.7 6110.9 6114.9 6162.3 6165.9 6169.8 5337.8 5606.9 5614.4 5616.7 5648.1 13284.7 14154.2 21748.9 23411.6 25466.7 2089.6 2312.2 2428.7 2505.2 2674.0 9681.2 9837.7 10049.5 10061.7 13501.0 1707.2 1715.1 1730.4 1748.2 1756.8 85152.6 109267.0 120404.2 133239.3 135283.6 22167.7 22432.0 22476.8 22536.1 23128.3 36320.9 36964.8 37654.0 37683.8 37759.6 11161.8 11368.4 11567.8 11678.6 11744.0 8135.2 9658.9 9660.2 9667.7 9674.3 10267.3 10284.7 10327.0 10352.2 10472.6 3950.3 3991.7 4035.8 4123.5 4224.6 755.5 838.9 953.9 998.3 1040.0 20366.1 20581.1 20860.7 21073.2 21085.5 988.4 994.3 1018.7 1028.5 1030.2 8260.0 10970.2 11179.8 11206.4 11224.7 547785.0 552329.0 555262.0 556609.0 624962.0 118483.0 119025.4 119786.4 126529.0 129520.0 1011.5 1014.6 1017.9 1028.2 1030.3 18191.2 18209.5 18331.5 18432.7 18887.9 49145.8 50744.7 51482.0 52121.5 54615.0 76078.0 77098.2 77462.6 79682.0 80249.2 8251.7 8267.1 8328.3 8450.8 8478.0 8817.6 11068.7 12305.8 12497.2 12587.7 10636.8 10654.8 10808.8 11032.8 11050.6 10149.6 10616.6 10728.8 10739.7 11008.9 10655.7 10896.3 11206.2 11208.8 11244.8 8054.4 8132.7 8259.6 8330.0 8423.2 9388.9 10289.8 10537.3 10835.2 10881.7 16:38:32 INFO - PROCESS | 2015 | 16:38:32 INFO - PROCESS | 2015 | [#3] mootools.html Cycles:180 Average:5709.18 Median:4938.36 stddev:3169.73 (64.2%) stddev-sans-first:3162.49 16:38:32 INFO - PROCESS | 2015 | Values: 1454.2 1606.0 1816.3 1874.7 1973.5 7839.6 7886.8 8740.6 8976.6 8998.0 7693.8 8646.3 8653.6 8772.6 8841.4 2420.2 2421.1 2421.6 2425.6 2442.8 2411.7 2424.9 2457.3 2460.8 2463.8 2432.7 2447.2 2450.0 2451.0 2471.8 2420.8 2437.2 2441.7 2467.0 2472.7 2439.4 2443.9 2469.0 2477.7 2478.4 7993.5 8584.8 8801.6 8802.8 8965.6 5332.7 5344.6 5458.3 5476.0 5490.8 3534.2 3617.1 3639.5 3671.3 3713.5 864.3 1044.1 1047.6 1073.7 1074.0 10216.9 12027.9 12212.2 12222.5 12261.5 4263.6 4758.1 4790.4 4821.4 4875.7 10077.1 10152.0 10198.0 10302.4 10360.6 5358.7 5425.2 5436.9 5437.2 5450.0 4397.1 4817.6 4881.0 4922.8 4954.0 3606.5 4146.9 4148.5 4215.9 4217.8 1186.2 1370.5 1380.5 1392.4 1400.4 821.3 832.1 849.9 892.4 955.5 5918.8 5959.3 6033.6 6048.4 6262.2 919.5 934.8 982.0 984.2 1028.6 3854.3 3916.9 3975.7 3985.9 4016.5 10535.2 10904.7 10910.9 10915.4 10969.6 10455.7 10557.4 10694.1 10803.3 10924.3 8441.4 8482.0 8497.5 8549.2 8595.4 5696.6 5781.2 5807.9 5866.6 5883.3 9578.1 9671.9 9733.2 9805.1 9884.4 9264.3 9639.0 9656.0 9966.5 10089.9 6756.6 7190.6 7417.5 7428.7 7594.5 8163.1 8173.7 8195.1 8197.9 8211.3 7163.6 7324.7 7354.3 7357.4 7455.4 5878.9 7201.2 7315.3 7327.4 7345.8 6976.6 7034.1 7068.7 7072.5 7077.7 4036.7 4763.3 4805.7 4832.7 4904.1 4118.2 4985.9 4986.5 4987.7 5076.8 16:38:32 INFO - PROCESS | 2015 | 16:38:32 INFO - PROCESS | 2015 | [#4] prototype.html Cycles:180 Average:5853.76 Median:6500.82 stddev:1871.07 (28.8%) stddev-sans-first:1829.63 16:38:32 INFO - PROCESS | 2015 | Values: 319.8 324.1 332.1 332.1 333.8 5554.7 6529.8 6644.3 6656.6 6722.9 5310.9 5955.6 6034.7 6676.3 6695.8 4589.0 4887.2 5012.9 5015.6 5019.5 4989.8 5005.8 5008.7 5018.8 5025.5 4961.6 4972.5 4973.2 4995.1 5002.6 4449.1 4719.6 4770.4 4966.2 4989.7 4224.0 4248.8 4250.7 4269.3 4269.7 5527.8 6411.0 6496.1 6505.6 6510.9 5828.4 5894.5 5904.6 5915.2 5924.1 5931.7 7203.9 7205.0 7223.6 7240.7 4565.5 4741.9 4742.6 4755.5 4777.9 7603.8 7624.2 7627.4 7679.3 7689.0 4836.1 4859.1 4864.4 4877.8 4881.3 4961.1 4964.7 4966.0 4967.4 4981.5 4729.8 5889.1 5921.3 5924.6 5934.4 6980.5 7254.8 7261.0 7282.0 7299.6 1688.7 1703.9 1710.9 1716.3 1723.4 1085.1 1088.5 1110.5 1112.5 1116.8 6389.3 6461.8 6647.1 6669.7 6680.2 7541.8 7584.1 7587.8 7597.1 7626.2 6596.3 6600.7 6662.2 6668.4 6675.7 3234.8 3938.4 3976.0 3993.1 4016.7 7123.4 7492.4 7930.0 7951.4 7972.9 6910.2 7166.9 7727.7 7799.8 7824.7 6465.9 7873.3 7937.3 7944.4 7953.2 7201.1 7512.1 7525.6 7528.0 7544.1 7376.2 7423.3 7441.2 7452.2 7453.7 7900.3 7905.6 7944.6 7946.1 7957.2 4669.7 4704.3 4709.4 4724.5 4729.6 5973.6 6324.7 7210.8 7492.5 7543.0 6060.8 6986.2 7220.2 7247.0 7267.4 5828.7 7207.6 7233.6 7241.7 7260.2 7049.7 7075.6 7080.3 7087.5 7116.8 6989.3 7241.0 7279.7 7343.4 7358.9 5970.4 6724.1 6890.5 7109.0 7110.5 16:38:32 INFO - PROCESS | 2015 | 16:38:32 INFO - PROCESS | 2015 | [#5] yui.html Cycles:180 Average:17427.79 Median:648.37 stddev:23913.78 (3688.3%) stddev-sans-first:23947.86 16:38:32 INFO - PROCESS | 2015 | Values: 695.4 708.3 749.4 764.5 775.5 14499.0 14584.6 14695.3 14709.9 14748.3 13995.9 14024.0 14043.6 14074.0 14112.0 720.3 898.9 902.8 917.1 927.8 891.1 911.7 919.0 923.8 924.6 955.7 980.7 986.1 989.4 992.2 944.2 944.4 958.2 977.1 980.8 694.0 696.8 710.5 717.9 721.1 15007.0 15111.5 15218.3 15236.8 15266.8 12656.9 12673.6 12843.7 12881.9 13073.7 9873.8 9890.7 9926.9 9942.0 10118.6 3463.7 3488.3 3510.9 3536.6 3545.9 77482.6 78165.0 78668.6 78889.0 79586.0 9317.1 9397.2 9496.9 9515.7 9701.1 20628.3 20748.6 20801.5 20803.8 20909.6 7433.0 7491.4 7572.7 7576.5 7629.6 4086.4 4140.8 4141.2 4153.0 4229.6 2969.3 3589.9 3634.0 3647.4 3659.0 646.9 649.9 651.2 655.6 658.8 530.8 538.4 600.6 604.1 617.4 8307.0 8333.5 8413.5 8473.2 8497.7 509.9 568.6 599.5 610.9 617.3 3194.3 3734.2 3864.2 3887.2 4127.3 55423.7 70143.6 82167.6 94524.5 94700.0 74684.0 75401.6 75995.2 76042.2 77311.0 45433.8 50399.7 68289.7 70314.6 72394.3 8371.2 8518.2 8562.5 8728.7 8761.2 44916.4 45551.0 46437.0 46770.0 48817.0 62640.0 64511.0 65899.3 68424.0 68474.0 10924.0 11144.6 11243.6 11298.0 11594.9 11860.0 12016.3 12127.5 12170.1 12604.4 11122.5 11294.0 11327.2 11603.5 12105.4 11320.4 11377.4 11483.7 11587.4 12125.3 8369.7 11177.2 11400.8 11697.1 11974.9 9433.5 9503.6 9516.7 9687.1 9972.8 8604.2 8965.7 9627.4 9753.3 9791.4 16:38:32 INFO - PROCESS | 2015 | -------- Summary: end -------- 16:38:32 INFO - PROCESS | 2015 | 16:38:32 INFO - TEST-INFO | 2015: exit 0 16:38:32 INFO - TEST-OK | dromaeo_css | took 1111900ms 16:38:32 INFO - TEST-START | kraken 16:38:32 INFO - operating with platform_type : mac_ 16:38:32 INFO - Initialising browser for kraken test... 16:38:33 INFO - TEST-INFO | started process 2023 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/tmpkL4LdK/profile http://localhost:51354/getInfo.html) 16:38:35 INFO - PROCESS | 2023 | __metrics Screen width/height:1600/1200 16:38:35 INFO - PROCESS | 2023 | colorDepth:24 16:38:35 INFO - PROCESS | 2023 | Browser inner width/height: 1024/689 16:38:35 INFO - PROCESS | 2023 | __metrics 16:38:35 ERROR - PROCESS | 2023 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 16:38:36 INFO - TEST-INFO | 2023: exit 0 16:38:36 INFO - Browser initialized. 16:38:36 INFO - Running cycle 1/1 for kraken test... 16:38:36 INFO - TEST-INFO | started process 2026 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/tmpkL4LdK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:38:48 INFO - PROCESS | 2026 | RSS: Main: 221413376 16:38:48 INFO - PROCESS | 2026 | 16:38:51 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51354/tests/kraken/driver.html?testName=audio-beat-detection) 16:38:52 INFO - PROCESS | 2026 | RSS: Main: 233000960 16:38:52 INFO - PROCESS | 2026 | 16:38:54 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51354/tests/kraken/driver.html?testName=audio-dft) 16:38:55 INFO - PROCESS | 2026 | RSS: Main: 241901568 16:38:55 INFO - PROCESS | 2026 | 16:38:58 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51354/tests/kraken/driver.html?testName=audio-fft) 16:38:59 INFO - PROCESS | 2026 | RSS: Main: 245747712 16:38:59 INFO - PROCESS | 2026 | 16:39:01 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51354/tests/kraken/driver.html?testName=audio-oscillator) 16:39:01 INFO - PROCESS | 2026 | RSS: Main: 247275520 16:39:01 INFO - PROCESS | 2026 | 16:39:03 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51354/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:39:04 INFO - PROCESS | 2026 | RSS: Main: 247750656 16:39:04 INFO - PROCESS | 2026 | 16:39:07 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51354/tests/kraken/driver.html?testName=imaging-darkroom) 16:39:08 INFO - PROCESS | 2026 | RSS: Main: 248340480 16:39:08 INFO - PROCESS | 2026 | 16:39:10 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51354/tests/kraken/driver.html?testName=imaging-desaturate) 16:39:11 INFO - PROCESS | 2026 | RSS: Main: 247996416 16:39:11 INFO - PROCESS | 2026 | 16:39:14 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51354/tests/kraken/driver.html?testName=json-parse-financial) 16:39:15 INFO - PROCESS | 2026 | RSS: Main: 248393728 16:39:15 INFO - PROCESS | 2026 | 16:39:16 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51354/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:39:17 INFO - PROCESS | 2026 | RSS: Main: 247492608 16:39:17 INFO - PROCESS | 2026 | 16:39:19 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51354/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:39:20 INFO - PROCESS | 2026 | RSS: Main: 247529472 16:39:20 INFO - PROCESS | 2026 | 16:39:22 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51354/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:39:22 INFO - PROCESS | 2026 | RSS: Main: 247631872 16:39:22 INFO - PROCESS | 2026 | 16:39:25 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51354/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:39:26 INFO - PROCESS | 2026 | RSS: Main: 247721984 16:39:26 INFO - PROCESS | 2026 | 16:39:29 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51354/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:39:29 INFO - PROCESS | 2026 | RSS: Main: 247717888 16:39:29 INFO - PROCESS | 2026 | 16:39:31 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51354/tests/kraken/driver.html?testName=ai-astar) 16:39:31 INFO - PROCESS | 2026 | RSS: Main: 249634816 16:39:31 INFO - PROCESS | 2026 | 16:39:31 INFO - PROCESS | 2026 | __start_tp_report 16:39:31 INFO - PROCESS | 2026 | _x_x_mozilla_page_load 16:39:31 INFO - PROCESS | 2026 | _x_x_mozilla_page_load_details 16:39:31 INFO - PROCESS | 2026 | |i|pagename|runs| 16:39:31 INFO - PROCESS | 2026 | |0;ai-astar;114;121;107;117;119;116;108;116;117;115 16:39:31 INFO - PROCESS | 2026 | |1;audio-beat-detection;151;124;148;164;122;152;132;154;207;156 16:39:31 INFO - PROCESS | 2026 | |2;audio-dft;196;203;199;198;208;199;202;198;200;194 16:39:31 INFO - PROCESS | 2026 | |3;audio-fft;67;80;76;143;59;56;56;60;127;59 16:39:32 INFO - PROCESS | 2026 | |4;audio-oscillator;77;82;125;108;80;81;117;82;83;117 16:39:32 INFO - PROCESS | 2026 | |5;imaging-gaussian-blur;88;88;88;86;89;85;90;86;106;131 16:39:32 INFO - PROCESS | 2026 | |6;imaging-darkroom;95;99;94;95;107;95;99;140;150;117 16:39:32 INFO - PROCESS | 2026 | |7;imaging-desaturate;90;137;148;97;92;90;92;91;126;88 16:39:32 INFO - PROCESS | 2026 | |8;json-parse-financial;60;65;66;66;67;65;65;83;65;61 16:39:32 INFO - PROCESS | 2026 | |9;json-stringify-tinderbox;66;69;71;70;74;103;94;68;68;69 16:39:32 INFO - PROCESS | 2026 | |10;stanford-crypto-aes;84;81;83;81;83;82;84;84;87;88 16:39:32 INFO - PROCESS | 2026 | |11;stanford-crypto-ccm;130;139;145;147;130;130;130;131;147;148 16:39:32 INFO - PROCESS | 2026 | |12;stanford-crypto-pbkdf2;226;235;182;169;182;225;222;167;163;168 16:39:32 INFO - PROCESS | 2026 | |13;stanford-crypto-sha256-iterative;70;70;71;71;73;88;99;100;106;71 16:39:32 INFO - PROCESS | 2026 | __end_tp_report 16:39:32 INFO - PROCESS | 2026 | __start_cc_report 16:39:32 INFO - PROCESS | 2026 | _x_x_mozilla_cycle_collect,1101 16:39:32 INFO - PROCESS | 2026 | __end_cc_report 16:39:32 INFO - PROCESS | 2026 | __startTimestamp1464219571997__endTimestamp 16:39:32 INFO - PROCESS | 2026 | 16:39:32 INFO - PROCESS | 2026 | ------- Summary: start ------- 16:39:32 INFO - PROCESS | 2026 | Number of tests: 14 16:39:32 INFO - PROCESS | 2026 | 16:39:32 INFO - PROCESS | 2026 | [#0] ai-astar Cycles:10 Average:115.00 Median:116.50 stddev:4.42 (3.8%) stddev-sans-first:4.68 16:39:32 INFO - PROCESS | 2026 | Values: 114.0 121.0 107.0 117.0 119.0 116.0 108.0 116.0 117.0 115.0 16:39:32 INFO - PROCESS | 2026 | 16:39:32 INFO - PROCESS | 2026 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:153.00 stddev:24.22 (15.8%) stddev-sans-first:25.69 16:39:32 INFO - PROCESS | 2026 | Values: 151.0 124.0 148.0 164.0 122.0 152.0 132.0 154.0 207.0 156.0 16:39:32 INFO - PROCESS | 2026 | 16:39:32 INFO - PROCESS | 2026 | [#2] audio-dft Cycles:10 Average:199.70 Median:199.50 stddev:3.92 (2.0%) stddev-sans-first:3.92 16:39:32 INFO - PROCESS | 2026 | Values: 196.0 203.0 199.0 198.0 208.0 199.0 202.0 198.0 200.0 194.0 16:39:32 INFO - PROCESS | 2026 | 16:39:32 INFO - PROCESS | 2026 | [#3] audio-fft Cycles:10 Average:78.30 Median:59.50 stddev:31.21 (52.5%) stddev-sans-first:32.84 16:39:32 INFO - PROCESS | 2026 | Values: 67.0 80.0 76.0 143.0 59.0 56.0 56.0 60.0 127.0 59.0 16:39:32 INFO - PROCESS | 2026 | 16:39:32 INFO - PROCESS | 2026 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:80.50 stddev:19.04 (23.7%) stddev-sans-first:19.02 16:39:32 INFO - PROCESS | 2026 | Values: 77.0 82.0 125.0 108.0 80.0 81.0 117.0 82.0 83.0 117.0 16:39:32 INFO - PROCESS | 2026 | 16:39:32 INFO - PROCESS | 2026 | [#5] imaging-gaussian-blur Cycles:10 Average:93.70 Median:88.00 stddev:14.41 (16.4%) stddev-sans-first:15.14 16:39:32 INFO - PROCESS | 2026 | Values: 88.0 88.0 88.0 86.0 89.0 85.0 90.0 86.0 106.0 131.0 16:39:32 INFO - PROCESS | 2026 | 16:39:32 INFO - PROCESS | 2026 | [#6] imaging-darkroom Cycles:10 Average:109.10 Median:95.00 stddev:20.34 (21.4%) stddev-sans-first:20.92 16:39:32 INFO - PROCESS | 2026 | Values: 95.0 99.0 94.0 95.0 107.0 95.0 99.0 140.0 150.0 117.0 16:39:32 INFO - PROCESS | 2026 | 16:39:32 INFO - PROCESS | 2026 | [#7] imaging-desaturate Cycles:10 Average:105.10 Median:90.50 stddev:22.73 (25.1%) stddev-sans-first:23.45 16:39:32 INFO - PROCESS | 2026 | Values: 90.0 137.0 148.0 97.0 92.0 90.0 92.0 91.0 126.0 88.0 16:39:32 INFO - PROCESS | 2026 | 16:39:32 INFO - PROCESS | 2026 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:65.50 stddev:6.27 (9.6%) stddev-sans-first:6.22 16:39:32 INFO - PROCESS | 2026 | Values: 60.0 65.0 66.0 66.0 67.0 65.0 65.0 83.0 65.0 61.0 16:39:32 INFO - PROCESS | 2026 | 16:39:32 INFO - PROCESS | 2026 | [#9] json-stringify-tinderbox Cycles:10 Average:75.20 Median:69.50 stddev:12.64 (18.2%) stddev-sans-first:12.96 16:39:32 INFO - PROCESS | 2026 | Values: 66.0 69.0 71.0 70.0 74.0 103.0 94.0 68.0 68.0 69.0 16:39:32 INFO - PROCESS | 2026 | 16:39:32 INFO - PROCESS | 2026 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:2.31 (2.8%) stddev-sans-first:2.45 16:39:32 INFO - PROCESS | 2026 | Values: 84.0 81.0 83.0 81.0 83.0 82.0 84.0 84.0 87.0 88.0 16:39:32 INFO - PROCESS | 2026 | 16:39:32 INFO - PROCESS | 2026 | [#11] stanford-crypto-ccm Cycles:10 Average:137.70 Median:142.00 stddev:8.27 (5.8%) stddev-sans-first:8.29 16:39:32 INFO - PROCESS | 2026 | Values: 130.0 139.0 145.0 147.0 130.0 130.0 130.0 131.0 147.0 148.0 16:39:32 INFO - PROCESS | 2026 | 16:39:32 INFO - PROCESS | 2026 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.90 Median:202.00 stddev:29.30 (14.5%) stddev-sans-first:28.69 16:39:32 INFO - PROCESS | 2026 | Values: 226.0 235.0 182.0 169.0 182.0 225.0 222.0 167.0 163.0 168.0 16:39:32 INFO - PROCESS | 2026 | 16:39:32 INFO - PROCESS | 2026 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.90 Median:71.00 stddev:14.75 (20.8%) stddev-sans-first:15.00 16:39:32 INFO - PROCESS | 2026 | Values: 70.0 70.0 71.0 71.0 73.0 88.0 99.0 100.0 106.0 71.0 16:39:32 INFO - PROCESS | 2026 | -------- Summary: end -------- 16:39:32 INFO - PROCESS | 2026 | 16:39:32 INFO - TEST-INFO | 2026: exit 0 16:39:32 INFO - TEST-OK | kraken | took 59749ms 16:39:32 INFO - SUITE-END | took 1171s 16:39:33 INFO - Completed test suite (00:19:32) 16:39:33 INFO - javascript benchmark 16:39:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2948.307147820262, 3110.191350248935, 3473.8957831265056, 3513.982430087852, 3571.2143328467746, 5300.999999999995, 5459.235707001023, 5686.919485297801, 5819.388964158766, 5831.4751672349485, 4249.532551419341, 4619.399478067855, 5116.797552575142, 5841.445062719045, 5847.561432892539, 5311.920321195185, 5331.813386531472, 5384.730763461831, 5410.756515956791, 5435.864103397407, 5166.715830629314, 5404.756785944623, 5407.188921661743, 5472.72636368182, 5521.889562208753, 5287.947120528784, 5296.443873393296, 5297.258383826267, 5304.310439642841, 5309.283246761695, 5191.532762051434, 5269.710165940872, 5279.841604751864, 5287.947120528784, 5308.654937429054, 5103.795848166069, 5225.163973764217, 5236.057509648262, 5245.370555533323, 5389.407165211824, 5052.317937078484, 5235.764390602432, 5645.350784659735, 5835.941640583582, 5856.736446859859, 6105.481034112106, 6210.596311239755, 6241.063840423927, 6244.781432649881, 6281.057841323838, 6131.651934473353, 6188.721507532172, 6209.627422354673, 6296.96851515744, 6300.747970081191, 5038.0, 5786.103154011093, 5949.375315591887, 5974.641521508724, 5974.940250597482, 6439.259485159173, 6454.2577603575255, 6460.030995350641, 6462.967685161544, 6463.0, 6128.509719222451, 6131.499004853489, 6171.783987560414, 6209.782657607052, 6242.375762423812, 5773.5958482906635, 5858.794942177004, 6341.904871426932, 6341.936580634135, 6349.206349206349, 6245.500359971192, 6248.187735594343, 6303.180586523814, 6310.905336419957, 6322.9051564226575, 6180.5673602848265, 6203.7828675996125, 6228.096925945712, 6298.527610429236, 6304.968475157595, 5001.924971125436, 5013.172826483589, 5013.89972200554, 5015.423226328946, 5023.673461225008, 4394.648428125743, 4409.492908315585, 4484.394606728115, 4493.73037617744, 4508.301213311942, 5853.560982926298, 5854.121881717691, 5874.794382196603, 5893.734781934823, 5970.671613061237, 6274.968625156845, 6278.372162783777, 6279.748810047547, 6296.244450665858, 6306.0, 5694.886102277931, 5850.444207800338, 5908.645481271052, 5909.970450147722, 5955.821325360246, 5386.111291636915, 5428.240046393508, 5470.179473078991, 5486.0, 5516.586256030814, 6473.28793832678, 6538.607683538908, 6544.246728375374, 6545.672716364163, 6559.508036897157, 6194.907076393768, 6238.251409830667, 6300.71646775887, 6327.17746692927, 6331.620102793847, 6430.0, 6483.546151769519, 6535.673216339069, 6540.247871494839, 6568.211814582281, 6236.438720515175, 6238.344973777688, 6251.3123556407845, 6261.843453913689, 6266.154069200599, 6118.296395914527, 6190.0, 6251.749930002749, 6270.905936410866, 6278.466330361788, 6188.81433556994, 6200.193974783249, 6202.596831205957, 6208.81373558794, 6218.720157592828, 5221.590170653826, 6204.72078756448, 6208.81373558794, 6209.068639704081, 6229.972054610938, 5955.5235581154275, 6012.969935150296, 6029.125776762433, 6083.391660833881, 6159.19930409044, 6153.261608606996, 6209.59637623553, 6211.378862113753, 6214.40963108504, 6237.594556353823, 6097.847553811191, 6105.572609917263, 6109.7861574844665, 6116.2660480740815, 6117.082437634391], "value": 5743.401168313378, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.4569513602063, 522.3861962194421, 523.884745356022, 576.9211574355955, 584.8274758946109, 30279.0, 40766.79616601913, 40799.79600101995, 40918.181636367255, 41015.79492102543, 41863.37204941928, 42542.14915701692, 42696.786516067456, 42722.7863860681, 42803.785981070054, 9569.665061722824, 9893.060159284856, 9926.0, 9942.204623630092, 9955.701328960107, 9807.41155530667, 9929.602815887356, 9939.2545559083, 9963.601455941789, 9963.850542241873, 9890.85163722541, 9939.453330066843, 9946.751331216705, 9958.900410995906, 10112.443815590139, 9814.75463113428, 9881.752956176082, 9885.159761420253, 9944.055314745088, 9956.35283706564, 9745.805083898353, 9856.112949834549, 9866.901330986742, 9867.506624668738, 9881.90118098817, 40826.591734082576, 41471.0, 41509.79245103785, 41633.0, 41828.372574411405, 2870.641169853768, 3114.299282661406, 3194.8242846643657, 3218.452863013293, 3307.7849939753837, 22262.55474890493, 26615.0, 27053.594196087073, 27477.76350064232, 27570.448591028067, 2683.1145721911917, 2715.4161855201028, 2718.877650505732, 2816.0143949617673, 2826.901058462944, 245127.77436112883, 321271.0, 325850.37074814475, 328459.0, 329404.0, 30366.84816575903, 35050.474242886376, 36248.63751362506, 37226.99999999946, 37414.81292593574, 35567.82216088903, 36316.27367452636, 36562.0, 36790.0, 36804.44793328102, 15730.0, 15883.444079457164, 15921.681566368608, 15923.203839807964, 15992.0, 11358.864113588575, 13215.933920330337, 13289.734205315839, 13378.264195469148, 13393.397297121459, 8263.380246481418, 8336.0, 8354.28988535969, 8463.407561470638, 8490.490570565786, 3032.757379409642, 3429.605595356516, 3447.5345828313357, 3464.4283693190846, 3499.4051011328133, 1003.7039073473343, 1027.173125633857, 1073.5276478349501, 1104.2932523185168, 1120.910327173824, 28687.71312286892, 30298.545521817192, 30322.69677303243, 30653.38693226123, 30665.84667076695, 1112.2881355932209, 1113.1762495753246, 1124.2074337591978, 1144.799660059503, 1194.6953526850598, 14977.176255306063, 15010.24948752558, 15029.0, 15234.0, 15356.0, 464047.0, 503607.0, 513236.0, 517783.0, 520072.39963800693, 59653.10520342198, 59682.0, 60092.798144036875, 60596.697016515514, 60598.48503787441, 1451.9637009074859, 1478.5859959211439, 1498.90257133286, 1500.6923580665937, 1502.1662977047843, 25522.617160742975, 29074.85462572758, 29317.0, 29901.252468688457, 30241.697583023888, 55104.72447637736, 55314.44685553254, 55665.72167139138, 55781.442185579246, 56025.59936001633, 530148.0, 548310.2584487052, 576208.0, 577677.0, 581040.0, 27451.038826223794, 27662.0, 27784.305392364546, 28612.141635750962, 28682.0, 47125.52874471348, 47616.04767904553, 48393.75803120962, 49272.0, 49559.46917279754, 35027.0, 39360.80319598383, 39665.0, 39963.2007359857, 40097.59902400939, 30338.0, 39147.608523915536, 39433.605663942995, 39662.405063923485, 40041.0, 32894.0, 37539.24921501609, 37627.0, 39298.0, 39327.213455730154, 28395.43209135847, 30547.083587492412, 33533.71811208516, 34201.486977694854, 34356.48465272973, 20680.379588612366, 22774.886125569265, 25264.0, 26486.867565662047, 26499.60250596204], "value": 18218.720338844287, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.1715806858836, 404.1129720264022, 405.8944674384661, 406.1592503517718, 412.7853516171591, 15035.248237588132, 20360.490987725294, 20763.58472830546, 21077.789222107756, 21084.57830843384, 17470.340317669834, 19448.027598620083, 19792.30726924558, 20077.59844803103, 20420.285290014854, 5622.240997465351, 5643.8024669136585, 5919.822405327847, 5928.49607783339, 5940.019896717036, 5899.469047785698, 5908.615939963888, 5934.5845790794665, 5940.138679891413, 5963.493103086243, 5847.99401943683, 6006.8798624027495, 6186.133941248228, 6227.968860155715, 6381.680915954207, 6110.938890611082, 6114.908276375858, 6162.322144564095, 6165.938340616626, 6169.81490555284, 5337.786488540453, 5606.915896261559, 5614.438556144353, 5616.747246373923, 5648.124540696199, 13284.667883302995, 14154.150750954976, 21748.89125554378, 23411.595304281796, 25466.745332546623, 2089.5507465894907, 2312.167619656922, 2428.732839387666, 2505.248425472351, 2673.9705213492944, 9681.177099946513, 9837.704868853945, 10049.497525123788, 10061.69814905554, 13501.0, 1707.1890851845399, 1715.1167148918316, 1730.3857130718666, 1748.1783561726095, 1756.771619689445, 85152.6135539837, 109267.0, 120404.19393709101, 133239.33380333037, 135283.64716352907, 22167.667484987738, 22432.0, 22476.775232247794, 22536.098556057575, 23128.306150815166, 36320.910372688864, 36964.81517592449, 37654.0, 37683.81158094192, 37759.62240377616, 11161.83257251142, 11368.431578421212, 11567.826482602768, 11678.6496405108, 11744.0, 8135.227153420416, 9658.855117173249, 9660.178884794872, 9667.661631842851, 9674.322797404255, 10267.254566723675, 10284.691459256233, 10327.0, 10352.223583231287, 10472.633457829092, 3950.3481925481974, 3991.7006224532697, 4035.8183881725395, 4123.484564429446, 4224.577542245812, 755.4636208292064, 838.8884727735774, 953.8712273843081, 998.2912132385942, 1040.0171837613534, 20366.083526241353, 20581.07385167671, 20860.687089693667, 21073.157073717186, 21085.47286317824, 988.3526290279879, 994.3387647214666, 1018.6994836523244, 1028.4600584692946, 1030.2118879057527, 8259.95870020646, 10970.177236707279, 11179.776404471864, 11206.38364889939, 11224.66326010221, 547785.0, 552329.0, 555262.0, 556609.0, 624962.0, 118483.0, 119025.40487297508, 119786.4010679941, 126529.0, 129520.0, 1011.4841430870309, 1014.6245889020962, 1017.9134773544332, 1028.1825948371063, 1030.314840630987, 18191.18139683691, 18209.544761381072, 18331.54171145732, 18432.723509147643, 18887.90556047211, 49145.75427122841, 50744.731381715756, 51482.0, 52121.478785211664, 54615.0, 76078.0, 77098.22901771135, 77462.6126869362, 79682.0, 80249.19750802417, 8251.669933202606, 8267.090620031911, 8328.333733301442, 8450.816885636139, 8478.0, 8817.603207855791, 11068.723281917695, 12305.753884922073, 12497.18768280059, 12587.748245034865, 10636.84044739345, 10654.8401773975, 10808.783824323313, 11032.834507482234, 11050.613228536962, 10149.64476243328, 10616.628418005641, 10728.785424291627, 10739.677809665722, 11008.944955275172, 10655.733606659896, 10896.346219226873, 11206.215564910379, 11208.83186752183, 11244.831327530257, 8054.395920305883, 8132.715354962548, 8259.587020648823, 8330.0, 8423.241908228289, 9388.859167112361, 10289.84565231507, 10537.315074520438, 10835.187360947803, 10881.673549793519], "value": 10449.593621841776, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1454.2147240490135, 1605.9518214453567, 1816.2916462579587, 1874.7469091672629, 1973.4868934077135, 7839.647215875285, 7886.777549479825, 8740.606672699729, 8976.596053177607, 8998.010218875927, 7693.769186924387, 8646.265067469272, 8653.61058752356, 8772.649094036247, 8841.3643475957, 2420.2013335599254, 2421.055788242578, 2421.624648179526, 2425.6361545768186, 2442.767937045987, 2411.710594728635, 2424.866632335221, 2457.348802567321, 2460.766227208412, 2463.8275320727557, 2432.7080750309988, 2447.21689059501, 2449.9755002450015, 2450.987745061272, 2471.8393304435244, 2420.7942324902315, 2437.2079074300923, 2441.7314095449487, 2467.037855236459, 2472.7156377016513, 2439.353571303606, 2443.8655873926928, 2468.9506209875703, 2477.7274499805008, 2478.368016155887, 7993.520388776692, 8584.785380365478, 8801.647934082694, 8802.823943521094, 8965.596548155349, 5332.706701131437, 5344.599155063386, 5458.317710286215, 5476.0, 5490.752916118784, 3534.204803919123, 3617.113807117247, 3639.5268615080136, 3671.3208056509366, 3713.498677678506, 864.2783275964578, 1044.1385856668278, 1047.5809676129609, 1073.7315671082229, 1074.0226393981518, 10216.89783102167, 12027.879721202764, 12212.206206596631, 12222.472190976128, 12261.509539618404, 4263.59495847894, 4758.119747846659, 4790.377250957423, 4821.373221481185, 4875.658703890694, 10077.093061624342, 10151.98480151979, 10198.031187037219, 10302.381857088598, 10360.585576576852, 5358.705271210043, 5425.186222066643, 5436.864078398072, 5437.157240627709, 5450.0, 4397.142557201315, 4817.590504807131, 4881.023795240895, 4922.778474968635, 4953.950460495421, 3606.549181352331, 4146.91706165875, 4148.543660197376, 4215.852445164466, 4217.768022758778, 1186.2408058842348, 1370.5271681269946, 1380.475419340644, 1392.3595146232847, 1400.4258254115764, 821.34292565947, 832.0597724571196, 849.8980122385229, 892.4110087342452, 955.47926380123, 5918.763249469973, 5959.28488581373, 6033.607815491979, 6048.36492168316, 6262.185915830913, 919.4896832258161, 934.8223837470858, 982.0474140084107, 984.2077127912099, 1028.5885645741764, 3854.3447613905705, 3916.921661566753, 3975.6819454444153, 3985.880423587297, 4016.49793775778, 10535.157187424988, 10904.727381815517, 10910.854360292215, 10915.399653019002, 10969.561217551209, 10455.68632941013, 10557.419341936115, 10694.091002264739, 10803.297785643908, 10924.344539327507, 8441.36689748259, 8481.957590212132, 8497.490150590984, 8549.187827156411, 8595.355348348774, 5696.601237913306, 5781.161731548986, 5807.883842323215, 5866.5893387462465, 5883.323417806836, 9578.13796758295, 9671.854922176313, 9733.221342292458, 9805.117539421486, 9884.406935583887, 9264.258859291105, 9638.95180524093, 9656.034396560288, 9966.451845148586, 10089.949550252202, 6756.594604323756, 7190.604516751419, 7417.480776345604, 7428.73999410018, 7594.544327340377, 8163.102058773649, 8173.673053078048, 8195.139510351328, 8197.877031844408, 8211.302039326485, 7163.570185788869, 7324.670389832364, 7354.301341372561, 7357.374623157091, 7455.440841936768, 5878.911816322673, 7201.171865235356, 7315.268473152642, 7327.4246037102275, 7345.77962661121, 6976.5814051157095, 7034.085568876013, 7068.68190931399, 7072.469564782559, 7077.716891324495, 4036.677065834785, 4763.285507173951, 4805.663603547858, 4832.6561617616135, 4904.141775189399, 4118.217538667644, 4985.925211121764, 4986.501349864984, 4987.725675087905, 5076.847694569169], "value": 4616.836679096415, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.77775446064993, 324.1087010720519, 332.12981987193547, 332.1381016262797, 333.83975691667985, 5554.722263886804, 6529.771457998971, 6644.269130395659, 6656.633885136328, 6722.865542689149, 5310.867228319294, 5955.583109182359, 6034.672372078136, 6676.332366763333, 6695.799126026215, 4589.0, 4887.193613053842, 5012.949870501303, 5015.648904576681, 5019.54824065834, 4989.825356112537, 5005.849824505252, 5008.749562521877, 5018.84943451697, 5025.522575355335, 4961.585948004819, 4972.5276098770555, 4973.154563724158, 4995.100881841267, 5002.624803139761, 4449.087936972913, 4719.575238228559, 4770.356001939728, 4966.230234313687, 4989.650724449272, 4223.957760422387, 4248.766317852517, 4250.659947204216, 4269.338252570826, 4269.743815371056, 5527.806526771584, 6411.0, 6496.058071579641, 6505.577137486048, 6510.93489065108, 5828.41715828418, 5894.528437724972, 5904.5571582131515, 5915.1718759373725, 5924.14099955504, 5931.73307201177, 7203.89194162088, 7204.955281484155, 7223.566586004857, 7240.746573869889, 4565.452145742499, 4741.928871066937, 4742.620590352763, 4755.548222918817, 4777.856664300077, 7603.809904752426, 7624.199459056775, 7627.360117574693, 7679.2704693054075, 7689.038870141232, 4836.105320515716, 4859.1496488114435, 4864.367632207861, 4877.829275975324, 4881.316615673809, 4961.05739909416, 4964.652474326835, 4966.031623833318, 4967.3542439482635, 4981.4769449207315, 4729.787159577827, 5889.116632505158, 5921.289445266596, 5924.5852790305125, 5934.43622855828, 6980.511364204457, 7254.782356529313, 7261.0, 7282.0, 7299.598522081336, 1688.662267546471, 1703.948881533556, 1710.8973461592345, 1716.3048965169125, 1723.448496481114, 1085.0505807418508, 1088.472091035847, 1110.5169251375678, 1112.477135746198, 1116.7822274656364, 6389.297177310492, 6461.8061458156335, 6647.135872336566, 6669.7332106715185, 6680.198376194888, 7541.849163016709, 7584.08990921093, 7587.848243035219, 7597.088349397997, 7626.199249078878, 6596.340365963365, 6600.669966501656, 6662.167229096363, 6668.399844014062, 6675.699593518303, 3234.75739319552, 3938.369860822255, 3976.025873660914, 3993.101552150801, 4016.6585840203325, 7123.394511466583, 7492.363149132276, 7930.048394192619, 7951.443398962017, 7972.880406793903, 6910.170779506491, 7166.856662866713, 7727.729529466442, 7799.766007019798, 7824.726134585262, 6465.870682586322, 7873.291403773688, 7937.325327347125, 7944.364450844034, 7953.164917683675, 7201.13586369618, 7512.098548174254, 7525.586092764732, 7528.0, 7544.132424771002, 7376.188619251985, 7423.2512581146175, 7441.218672039575, 7452.217517160837, 7453.739119130804, 7900.328472079707, 7905.56519391439, 7944.602769861368, 7946.086200086833, 7957.204279571996, 4669.719816811003, 4704.270838020112, 4709.434867815884, 4724.456687480846, 4729.645276604199, 5973.5519836013345, 6324.683765811783, 7210.819729506804, 7492.475526713078, 7542.962285188759, 6060.757569697163, 6986.196587392515, 7220.1696804866015, 7246.96376518114, 7267.418606511572, 5828.6502809831545, 7207.603581803051, 7233.565986040854, 7241.746538871114, 7260.201377848538, 7049.682764275517, 7075.575465472089, 7080.2919708028785, 7087.468439867133, 7116.750913717995, 6989.33601307875, 7240.98626192323, 7279.672414741243, 7343.41252699772, 7358.926410735824, 5970.432808883149, 6724.125863637696, 6890.483213758888, 7109.0047393366, 7110.537815042006], "value": 5232.97363941116, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.4123765418221, 708.2917082917081, 749.4192001199074, 764.4992529892922, 775.4688038693496, 14499.0, 14584.562463126096, 14695.33870975806, 14709.92645036776, 14748.33632486538, 13995.93002034991, 14024.0, 14043.578692639237, 14074.0, 14112.0, 720.3480849830911, 898.8876390451194, 902.823949329881, 917.0966597901046, 927.8469052606312, 891.1177933845479, 911.7219248129318, 919.0487845080344, 923.8198551282469, 924.5839372282467, 955.6750704760381, 980.7499087732618, 986.1272773595384, 989.4360214677637, 992.1764935103846, 944.211583327922, 944.4003058058148, 958.1711819276345, 977.1108291454742, 980.8185485685135, 693.9514234003622, 696.7944456385378, 710.5488015110391, 717.8564287142592, 721.12383454103, 15007.0, 15111.54665360041, 15218.315175817115, 15236.771448428282, 15266.78631598423, 12656.873431265662, 12673.556425525063, 12843.743125137538, 12881.935590322082, 13073.673158171026, 9873.753156171082, 9890.653827116088, 9926.90804011558, 9941.950290248575, 10118.595256189743, 3463.6709512596262, 3488.284901595167, 3510.947335789965, 3536.5756109267054, 3545.8936231913085, 77482.61258693671, 78164.99999999943, 78668.60665696635, 78889.0, 79586.0, 9317.068293170629, 9397.154256116846, 9496.857547136799, 9515.666951656798, 9701.07839755222, 20628.278010269867, 20748.58502829935, 20801.479963000744, 20803.79196208049, 20909.581808363746, 7433.0, 7491.438142139361, 7572.697092116364, 7576.507527010726, 7629.580373079423, 4086.40747091676, 4140.792960351971, 4141.151064031867, 4153.003279212967, 4229.598188172119, 2969.272528230554, 3589.9102522436624, 3633.981830090833, 3647.398179300386, 3658.9634103658623, 646.8835609590225, 649.8537828988534, 651.2347991110427, 655.6262930129875, 658.8287045368143, 530.830327775327, 538.4265756968815, 600.6306121735101, 604.1183554445272, 617.4227097663698, 8307.0, 8333.458325208841, 8413.495190288602, 8473.237408633253, 8497.66009359631, 509.8597885581495, 568.5678884048153, 599.5203836930439, 610.914471973924, 617.3332800575457, 3194.2653189766484, 3734.1971476132762, 3864.2078373933277, 3887.1730286765173, 4127.2570937231585, 55423.722881385336, 70143.64928175327, 82167.589162055, 94524.52737736267, 94700.0, 74684.0, 75401.6229918847, 75995.24004759881, 76042.23957760462, 77311.0, 45433.772831136295, 50399.748001260494, 68289.65855170792, 70314.64842675754, 72394.27605723875, 8371.204735550113, 8518.190771876662, 8562.52906090171, 8728.650853966024, 8761.211490965588, 44916.427925022464, 45551.0, 46437.0, 46770.0, 48817.02365952732, 62640.0, 64511.0, 65899.34100658933, 68424.0, 68474.0, 10924.0, 11144.609938652433, 11243.60647377338, 11298.0, 11594.94202528982, 11860.0, 12016.279023258632, 12127.45426455794, 12170.14808963364, 12604.432800523815, 11122.499487523242, 11294.04000659953, 11327.207095503236, 11603.5358585659, 12105.394730263275, 11320.435332423809, 11377.43112844371, 11483.655490335303, 11587.362695051854, 12125.27248365101, 8369.665213391396, 11177.217594768288, 11400.828987565359, 11697.06423486136, 11974.880251197377, 9433.538699458786, 9503.619855205714, 9516.68188417747, 9687.079727425884, 9972.800543989224, 8604.225619694258, 8965.686200982935, 9627.374220675634, 9753.304622737853, 9791.363561368487], "value": 6837.206829683076, "unit": "score"}], "name": "dromaeo_css", "value": 7518.517253818694, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 121.0, 107.0, 117.0, 119.0, 116.0, 108.0, 116.0, 117.0, 115.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 148.0, 164.0, 122.0, 152.0, 132.0, 154.0, 207.0, 156.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 203.0, 199.0, 198.0, 208.0, 199.0, 202.0, 198.0, 200.0, 194.0], "value": 199.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 80.0, 76.0, 143.0, 59.0, 56.0, 56.0, 60.0, 127.0, 59.0], "value": 78.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 82.0, 125.0, 108.0, 80.0, 81.0, 117.0, 82.0, 83.0, 117.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 86.0, 89.0, 85.0, 90.0, 86.0, 106.0, 131.0], "value": 93.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 99.0, 94.0, 95.0, 107.0, 95.0, 99.0, 140.0, 150.0, 117.0], "value": 109.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 137.0, 148.0, 97.0, 92.0, 90.0, 92.0, 91.0, 126.0, 88.0], "value": 105.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 65.0, 66.0, 66.0, 67.0, 65.0, 65.0, 83.0, 65.0, 61.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 71.0, 70.0, 74.0, 103.0, 94.0, 68.0, 68.0, 69.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 83.0, 81.0, 83.0, 82.0, 84.0, 84.0, 87.0, 88.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 139.0, 145.0, 147.0, 130.0, 130.0, 130.0, 131.0, 147.0, 148.0], "value": 137.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [226.0, 235.0, 182.0, 169.0, 182.0, 225.0, 222.0, 167.0, 163.0, 168.0], "value": 193.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 71.0, 71.0, 73.0, 88.0, 99.0, 100.0, 106.0, 71.0], "value": 81.9, "unit": "score"}], "name": "kraken", "value": 1585.8000000000004, "alertThreshold": 2.0}]} 16:39:33 INFO - Return code: 0 16:39:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:39:33 ERROR - # TBPL SUCCESS # 16:39:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:39:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:39:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:39:33 INFO - 2016-05-25 16:39:33.315 screenresolution[2031:16358] starting screenresolution argv=screenresolution get 16:39:33 INFO - 2016-05-25 16:39:33.318 screenresolution[2031:16358] Display 0: 1600x1200x32@60 16:39:33 INFO - 2016-05-25 16:39:33.324 screenresolution[2032:16360] starting screenresolution argv=screenresolution list 16:39:33 INFO - Available Modes on Display 0 16:39:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:39:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:39:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:39:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:39:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:39:33 INFO - Intel Iris: 16:39:33 INFO - Chipset Model: Intel Iris 16:39:33 INFO - Type: GPU 16:39:33 INFO - Bus: Built-In 16:39:33 INFO - VRAM (Dynamic, Max): 1536 MB 16:39:33 INFO - Vendor: Intel (0x8086) 16:39:33 INFO - Device ID: 0x0a2e 16:39:33 INFO - Revision ID: 0x0009 16:39:33 INFO - Displays: 16:39:33 INFO - Display: 16:39:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:39:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:39:33 INFO - Display Serial Number: 1600x1200 60 16:39:33 INFO - Main Display: Yes 16:39:33 INFO - Mirror: Off 16:39:33 INFO - Online: Yes 16:39:33 INFO - Rotation: Supported 16:39:33 INFO - Return code: 0 16:39:33 INFO - Running post-action listener: _resource_record_post_action 16:39:33 INFO - Running post-run listener: _resource_record_post_run 16:39:34 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 942592; Write bytes: 653438464; Read time: 11; Write time: 1878 16:39:34 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 352956928; Write bytes: 346711552; Read time: 27857; Write time: 725 16:39:34 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 942592; Write bytes: 296982528; Read time: 11; Write time: 1117 16:39:34 INFO - Running post-run listener: _upload_blobber_files 16:39:34 INFO - Blob upload gear active. 16:39:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:39:34 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 16:39:34 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'] 16:39:34 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 16:39:35 INFO - (blobuploader) - INFO - Open directory for files ... 16:39:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:39:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:39:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:36 INFO - (blobuploader) - INFO - Done attempting. 16:39:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:39:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:39:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:39 INFO - (blobuploader) - INFO - Done attempting. 16:39:39 INFO - (blobuploader) - INFO - Iteration through files over. 16:39:39 INFO - Return code: 0 16:39:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:39:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:39:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/12084cbed748b3e07d35d291324e632e2dd37b359540bda342e644d0dd8224aaea4eb724ff809fb2553ceef5f5b4718e4e2159a8e9074d5cd9a3aefd02af58cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3054d1a9bab1d73970964bc2ed3854420b83fac365499d499cfe7fd650ecc39bd6381a2f22759fb5a5b4694ddc6ce96b9a203d3eea3e699f1a80a898ad4f0bd7"} 16:39:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:39:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:39:39 INFO - Contents: 16:39:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/12084cbed748b3e07d35d291324e632e2dd37b359540bda342e644d0dd8224aaea4eb724ff809fb2553ceef5f5b4718e4e2159a8e9074d5cd9a3aefd02af58cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3054d1a9bab1d73970964bc2ed3854420b83fac365499d499cfe7fd650ecc39bd6381a2f22759fb5a5b4694ddc6ce96b9a203d3eea3e699f1a80a898ad4f0bd7"} 16:39:39 INFO - Running post-run listener: copy_logs_to_upload_dir 16:39:39 INFO - Copying logs to upload dir... 16:39:39 INFO - mkdir: /builds/slave/test/build/upload/logs 16:39:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.807041 ========= master_lag: 0.33 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-05-25 16:39:39.674337) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 16:39:39.677922) ========= 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.oW7fHwegwP/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.XSfUjLzxC1/Listeners TMPDIR=/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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/12084cbed748b3e07d35d291324e632e2dd37b359540bda342e644d0dd8224aaea4eb724ff809fb2553ceef5f5b4718e4e2159a8e9074d5cd9a3aefd02af58cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3054d1a9bab1d73970964bc2ed3854420b83fac365499d499cfe7fd650ecc39bd6381a2f22759fb5a5b4694ddc6ce96b9a203d3eea3e699f1a80a898ad4f0bd7"} build_url:https://queue.taskcluster.net/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011184 build_url: 'https://queue.taskcluster.net/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/12084cbed748b3e07d35d291324e632e2dd37b359540bda342e644d0dd8224aaea4eb724ff809fb2553ceef5f5b4718e4e2159a8e9074d5cd9a3aefd02af58cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3054d1a9bab1d73970964bc2ed3854420b83fac365499d499cfe7fd650ecc39bd6381a2f22759fb5a5b4694ddc6ce96b9a203d3eea3e699f1a80a898ad4f0bd7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 16:39:39.708725) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 16:39:39.709040) ========= 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.oW7fHwegwP/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.XSfUjLzxC1/Listeners TMPDIR=/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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.005178 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 16:39:39.759563) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 16:39:39.760112) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 16:39:39.760896) ========= ========= Total master_lag: 0.46 =========