builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0098 starttime: 1467288147.23 results: success (0) buildid: 20160630025528 builduid: 7c2474b8f06e4e13acbdaf7b1377d375 revision: d700dc054751333e0735f975fce3d3adf153c62a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 05:02:27.228419) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 05:02:27.228912) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 05:02:27.229227) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 05:02:27.367412) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:02:27.367818) ========= 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.rdOfFhqB3h/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.Xlr8TujcwX/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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-06-30 05:02:27-- 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% 14.8M=0.001s 2016-06-30 05:02:27 (14.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133457 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:02:27.567324) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:02:27.567625) ========= 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.rdOfFhqB3h/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.Xlr8TujcwX/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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.028175 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:02:27.646540) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 05:02:27.647110) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d700dc054751333e0735f975fce3d3adf153c62a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d700dc054751333e0735f975fce3d3adf153c62a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rdOfFhqB3h/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.Xlr8TujcwX/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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-06-30 05:02:27,727 truncating revision to first 12 chars 2016-06-30 05:02:27,727 Setting DEBUG logging. 2016-06-30 05:02:27,727 attempt 1/10 2016-06-30 05:02:27,727 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d700dc054751?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 05:02:28,495 unpacking tar archive at: mozilla-central-d700dc054751/testing/mozharness/ program finished with exit code 0 elapsedTime=1.020768 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 05:02:28.693234) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 05:02:28.693554) ========= script_repo_revision: d700dc054751333e0735f975fce3d3adf153c62a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 05:02:28.693950) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 05:02:28.694213) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 05:02:28.712768) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-06-30 05:02:28.713173) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rdOfFhqB3h/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.Xlr8TujcwX/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 05:02:28 INFO - MultiFileLogger online at 20160630 05:02:28 in /builds/slave/test 05:02:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:02:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:02:28 INFO - {'append_to_log': False, 05:02:28 INFO - 'base_work_dir': '/builds/slave/test', 05:02:28 INFO - 'blob_upload_branch': 'Firefox', 05:02:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:02:28 INFO - 'branch': 'Firefox', 05:02:28 INFO - 'buildbot_json_path': 'buildprops.json', 05:02:28 INFO - 'config_files': ('talos/mac_config.py',), 05:02:28 INFO - 'default_actions': ('clobber', 05:02:28 INFO - 'read-buildbot-config', 05:02:28 INFO - 'download-and-extract', 05:02:28 INFO - 'populate-webroot', 05:02:28 INFO - 'create-virtualenv', 05:02:28 INFO - 'install', 05:02:28 INFO - 'run-tests'), 05:02:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:02:28 INFO - 'download_minidump_stackwalk': True, 05:02:28 INFO - 'download_symbols': 'ondemand', 05:02:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:02:28 INFO - 'tooltool.py': '/tools/tooltool.py', 05:02:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:02:28 INFO - '/tools/misc-python/virtualenv.py')}, 05:02:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:02:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:02:28 INFO - 'installer_path': 'installer.exe', 05:02:28 INFO - 'log_level': 'info', 05:02:28 INFO - 'log_name': 'talos', 05:02:28 INFO - 'log_to_console': True, 05:02:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:02:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:02:28 INFO - 'opt_config_files': (), 05:02:28 INFO - 'pip_index': False, 05:02:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:02:28 INFO - 'cmd': ('bash', 05:02:28 INFO - '-c', 05:02:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:02:28 INFO - 'enabled': True, 05:02:28 INFO - 'halt_on_failure': False, 05:02:28 INFO - 'name': 'check_screen_resolution'},), 05:02:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:02:28 INFO - 'cmd': ('bash', 05:02:28 INFO - '-c', 05:02:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:02:28 INFO - 'enabled': True, 05:02:28 INFO - 'halt_on_failure': False, 05:02:28 INFO - 'name': 'check_screen_resolution'},), 05:02:28 INFO - 'run_cmd_checks_enabled': True, 05:02:28 INFO - 'sps_profile': False, 05:02:28 INFO - 'sps_profile_interval': 0, 05:02:28 INFO - 'suite': 'dromaeojs-e10s', 05:02:28 INFO - 'system_bits': '32', 05:02:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:02:28 INFO - 'title': 't-yosemite-r7-0098', 05:02:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:02:28 INFO - 'use_talos_json': True, 05:02:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:02:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:02:28 INFO - 'work_dir': 'build'} 05:02:28 INFO - ##### 05:02:28 INFO - ##### Running clobber step. 05:02:28 INFO - ##### 05:02:28 INFO - Running pre-action listener: _resource_record_pre_action 05:02:28 INFO - Running main action method: clobber 05:02:28 INFO - rmtree: /builds/slave/test/build 05:02:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:02:30 INFO - Running post-action listener: _resource_record_post_action 05:02:30 INFO - ##### 05:02:30 INFO - ##### Finished clobber step (success) 05:02:30 INFO - ##### 05:02:30 INFO - ##### 05:02:30 INFO - ##### Running read-buildbot-config step. 05:02:30 INFO - ##### 05:02:30 INFO - Running pre-action listener: _resource_record_pre_action 05:02:30 INFO - Running main action method: read_buildbot_config 05:02:30 INFO - Using buildbot properties: 05:02:30 INFO - { 05:02:30 INFO - "project": "", 05:02:30 INFO - "product": "firefox", 05:02:30 INFO - "script_repo_revision": "production", 05:02:30 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:02:30 INFO - "repository": "", 05:02:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:02:30 INFO - "buildid": "20160630025528", 05:02:30 INFO - "pgo_build": "False", 05:02:30 INFO - "basedir": "/builds/slave/test", 05:02:30 INFO - "buildnumber": 29, 05:02:30 INFO - "slavename": "t-yosemite-r7-0098", 05:02:30 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 05:02:30 INFO - "platform": "yosemite_r7", 05:02:30 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:02:30 INFO - "branch": "mozilla-central", 05:02:30 INFO - "repo_path": "mozilla-central", 05:02:30 INFO - "revision": "d700dc054751333e0735f975fce3d3adf153c62a", 05:02:30 INFO - "stage_platform": "macosx64", 05:02:30 INFO - "builduid": "7c2474b8f06e4e13acbdaf7b1377d375", 05:02:30 INFO - "slavebuilddir": "test" 05:02:30 INFO - } 05:02:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 05:02:30 INFO - Running post-action listener: _resource_record_post_action 05:02:30 INFO - ##### 05:02:30 INFO - ##### Finished read-buildbot-config step (success) 05:02:30 INFO - ##### 05:02:30 INFO - ##### 05:02:30 INFO - ##### Running download-and-extract step. 05:02:30 INFO - ##### 05:02:30 INFO - Running pre-action listener: _resource_record_pre_action 05:02:30 INFO - Running main action method: download_and_extract 05:02:30 INFO - mkdir: /builds/slave/test/build/tests 05:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:02:30 INFO - https://queue.taskcluster.net/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:02:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 05:02:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 05:02:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 05:02:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 05:02:49 INFO - Downloaded 1199 bytes. 05:02:49 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 05:02:49 INFO - Using the following test package requirements: 05:02:49 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 05:02:49 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:02:49 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 05:02:49 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:02:49 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 05:02:49 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:02:49 INFO - u'jsshell-mac.zip'], 05:02:49 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:02:49 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 05:02:49 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 05:02:49 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:02:49 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 05:02:49 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:02:49 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 05:02:49 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:02:49 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 05:02:49 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:02:49 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 05:02:49 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:02: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')]} 05:02:49 INFO - https://queue.taskcluster.net/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:02:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:02:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:02:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:02:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:02:55 INFO - Downloaded 18788522 bytes. 05:02:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:02:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:02:58 INFO - Return code: 0 05:02:58 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:02:58 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')]} 05:02:58 INFO - https://queue.taskcluster.net/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:02:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:02:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:02:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:02:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:03:06 INFO - Downloaded 18788522 bytes. 05:03:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:03:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:03:10 INFO - Return code: 0 05:03:10 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')]} 05:03:10 INFO - https://queue.taskcluster.net/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:03:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 05:03:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 05:03:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 05:03:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:03:11 INFO - Downloaded 14405245 bytes. 05:03:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:03:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:03:11 INFO - Return code: 0 05:03:11 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')]} 05:03:11 INFO - https://queue.taskcluster.net/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:03:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:03:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:03:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 05:03:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 05:03:14 INFO - Downloaded 112478531 bytes. 05:03:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:03:14 INFO - mkdir: /builds/slave/test/properties 05:03:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:03:14 INFO - Writing to file /builds/slave/test/properties/build_url 05:03:14 INFO - Contents: 05:03:14 INFO - build_url:https://queue.taskcluster.net/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:03:15 INFO - Running post-action listener: _resource_record_post_action 05:03:15 INFO - Running post-action listener: set_extra_try_arguments 05:03:15 INFO - ##### 05:03:15 INFO - ##### Finished download-and-extract step (success) 05:03:15 INFO - ##### 05:03:15 INFO - ##### 05:03:15 INFO - ##### Running populate-webroot step. 05:03:15 INFO - ##### 05:03:15 INFO - Running pre-action listener: _resource_record_pre_action 05:03:15 INFO - Running main action method: populate_webroot 05:03:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:03:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:03:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:03:15 INFO - '--tppagecycles', 05:03:15 INFO - '7'], 05:03:15 INFO - 'tests': ['tsvgm']}}, 05:03:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:03:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:03:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:03:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:03:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:03:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:03:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:15 INFO - 'talos_options': ['--disable-e10s'], 05:03:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:15 INFO - 'talos_options': ['--disable-e10s'], 05:03:15 INFO - 'tests': ['damp', 'tps']}, 05:03:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:15 INFO - 'tests': ['damp', 'tps']}, 05:03:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:03:15 INFO - 'tests': ['dromaeo_dom']}, 05:03:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:03:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:03:15 INFO - 'tests': ['basic_compositor_video']}, 05:03:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:03:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:03:15 INFO - 'tests': ['a11yr', 05:03:15 INFO - 'ts_paint', 05:03:15 INFO - 'tpaint', 05:03:15 INFO - 'sessionrestore', 05:03:15 INFO - 'sessionrestore_no_auto_restore', 05:03:15 INFO - 'tabpaint']}, 05:03:15 INFO - 'other-e10s': {'tests': ['a11yr', 05:03:15 INFO - 'ts_paint', 05:03:15 INFO - 'tpaint', 05:03:15 INFO - 'sessionrestore', 05:03:15 INFO - 'sessionrestore_no_auto_restore', 05:03:15 INFO - 'tabpaint']}, 05:03:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:03:15 INFO - 'ts_paint', 05:03:15 INFO - 'tpaint', 05:03:15 INFO - 'sessionrestore', 05:03:15 INFO - 'sessionrestore_no_auto_restore', 05:03:15 INFO - 'tabpaint']}, 05:03:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:03:15 INFO - 'ts_paint', 05:03:15 INFO - 'tpaint', 05:03:15 INFO - 'sessionrestore', 05:03:15 INFO - 'sessionrestore_no_auto_restore', 05:03:15 INFO - 'tabpaint']}, 05:03:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:03:15 INFO - 'tests': ['a11yr', 05:03:15 INFO - 'ts_paint', 05:03:15 INFO - 'tpaint', 05:03:15 INFO - 'sessionrestore', 05:03:15 INFO - 'sessionrestore_no_auto_restore', 05:03:15 INFO - 'tabpaint']}, 05:03:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:03:15 INFO - 'tests': ['a11yr', 05:03:15 INFO - 'ts_paint', 05:03:15 INFO - 'tpaint', 05:03:15 INFO - 'sessionrestore', 05:03:15 INFO - 'sessionrestore_no_auto_restore', 05:03:15 INFO - 'tabpaint']}, 05:03:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:03:15 INFO - 'tests': ['tsvgx', 05:03:15 INFO - 'tsvgr_opacity', 05:03:15 INFO - 'tart', 05:03:15 INFO - 'tscrollx', 05:03:15 INFO - 'cart']}, 05:03:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:03:15 INFO - 'tsvgr_opacity', 05:03:15 INFO - 'tart', 05:03:15 INFO - 'tscrollx', 05:03:15 INFO - 'cart']}, 05:03:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:15 INFO - 'talos_options': ['--disable-e10s'], 05:03:15 INFO - 'tests': ['tp5o']}, 05:03:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:15 INFO - 'tests': ['tp5o']}, 05:03:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:15 INFO - 'talos_options': ['--disable-e10s', 05:03:15 INFO - '--xperf_path', 05:03:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:15 INFO - 'tests': ['tp5n']}, 05:03:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:15 INFO - 'talos_options': ['--xperf_path', 05:03:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:15 INFO - 'tests': ['tp5n']}}, 05:03:15 INFO - 'talos.zip': {'path': '', 05:03:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:03:15 INFO - Running post-action listener: _resource_record_post_action 05:03:15 INFO - ##### 05:03:15 INFO - ##### Finished populate-webroot step (success) 05:03:15 INFO - ##### 05:03:15 INFO - ##### 05:03:15 INFO - ##### Running create-virtualenv step. 05:03:15 INFO - ##### 05:03:15 INFO - Running pre-action listener: _resource_record_pre_action 05:03:15 INFO - Running main action method: create_virtualenv 05:03:15 INFO - Creating virtualenv /builds/slave/test/build/venv 05:03:15 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 05:03:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:03:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:03:15 INFO - Using real prefix '/tools/python27' 05:03:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:03:16 INFO - Installing distribute.............................................................................................................................................................................................done. 05:03:19 INFO - Installing pip.................done. 05:03:19 INFO - Return code: 0 05:03:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:03: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')]} 05:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03: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')]} 05:03:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108f92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109027618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb894c5f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ef6d30>, '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 0x108c5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108eeeb20>, '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.rdOfFhqB3h/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.Xlr8TujcwX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 05:03: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', 'pip>=1.5'] in /builds/slave/test/build 05:03: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 pip>=1.5 05:03:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rdOfFhqB3h/Render', 05:03:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:19 INFO - 'HOME': '/Users/cltbld', 05:03:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:19 INFO - 'LOGNAME': 'cltbld', 05:03:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:19 INFO - 'MOZ_NO_REMOTE': '1', 05:03:19 INFO - 'NO_EM_RESTART': '1', 05:03:19 INFO - 'PAGER': '/bin/cat', 05:03:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:19 INFO - 'PWD': '/builds/slave/test', 05:03:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:19 INFO - 'SHELL': '/bin/bash', 05:03:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xlr8TujcwX/Listeners', 05:03:19 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 05:03:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:19 INFO - 'USER': 'cltbld', 05:03:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:19 INFO - 'XPC_FLAGS': '0x0', 05:03:19 INFO - 'XPC_SERVICE_NAME': '0', 05:03:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:19 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 05:03:19 INFO - Cleaning up... 05:03:19 INFO - Return code: 0 05:03:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:03: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')]} 05:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03: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')]} 05:03:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03: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', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108f92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109027618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb894c5f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ef6d30>, '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 0x108c5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108eeeb20>, '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.rdOfFhqB3h/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.Xlr8TujcwX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 05:03: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:03: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 psutil>=3.1.1 05:03:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rdOfFhqB3h/Render', 05:03:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:19 INFO - 'HOME': '/Users/cltbld', 05:03:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:19 INFO - 'LOGNAME': 'cltbld', 05:03:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:19 INFO - 'MOZ_NO_REMOTE': '1', 05:03:19 INFO - 'NO_EM_RESTART': '1', 05:03:19 INFO - 'PAGER': '/bin/cat', 05:03:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:19 INFO - 'PWD': '/builds/slave/test', 05:03:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:19 INFO - 'SHELL': '/bin/bash', 05:03:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xlr8TujcwX/Listeners', 05:03:19 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 05:03:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:19 INFO - 'USER': 'cltbld', 05:03:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:19 INFO - 'XPC_FLAGS': '0x0', 05:03:19 INFO - 'XPC_SERVICE_NAME': '0', 05:03:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:19 INFO - Downloading/unpacking psutil>=3.1.1 05:03: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 05:03: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 05:03: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 05:03: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 05:03: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 05:03: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 05:03:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:03:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:03:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:03:23 INFO - Installing collected packages: psutil 05:03:23 INFO - Running setup.py install for psutil 05:03:23 INFO - building 'psutil._psutil_osx' extension 05:03:23 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 05:03:23 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 05:03:23 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 05:03:23 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 05:03:24 INFO - building 'psutil._psutil_posix' extension 05:03:24 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 05:03:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:03:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:03:24 INFO - ^ 05:03:24 INFO - 1 warning generated. 05:03:24 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 05:03:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:03:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:03:24 INFO - Successfully installed psutil 05:03:24 INFO - Cleaning up... 05:03:24 INFO - Return code: 0 05:03:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:03:24 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')]} 05:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:24 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')]} 05:03:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108f92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109027618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb894c5f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ef6d30>, '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 0x108c5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108eeeb20>, '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.rdOfFhqB3h/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.Xlr8TujcwX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 05:03:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:03:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rdOfFhqB3h/Render', 05:03:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:24 INFO - 'HOME': '/Users/cltbld', 05:03:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:24 INFO - 'LOGNAME': 'cltbld', 05:03:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:24 INFO - 'MOZ_NO_REMOTE': '1', 05:03:24 INFO - 'NO_EM_RESTART': '1', 05:03:24 INFO - 'PAGER': '/bin/cat', 05:03:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:24 INFO - 'PWD': '/builds/slave/test', 05:03:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:24 INFO - 'SHELL': '/bin/bash', 05:03:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xlr8TujcwX/Listeners', 05:03:24 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 05:03:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:24 INFO - 'USER': 'cltbld', 05:03:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:24 INFO - 'XPC_FLAGS': '0x0', 05:03:24 INFO - 'XPC_SERVICE_NAME': '0', 05:03:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:03:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:03:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:03:27 INFO - Installing collected packages: mozsystemmonitor 05:03:27 INFO - Running setup.py install for mozsystemmonitor 05:03:27 INFO - Successfully installed mozsystemmonitor 05:03:27 INFO - Cleaning up... 05:03:27 INFO - Return code: 0 05:03:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:03:27 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')]} 05:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:27 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')]} 05:03:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108f92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109027618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb894c5f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ef6d30>, '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 0x108c5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108eeeb20>, '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.rdOfFhqB3h/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.Xlr8TujcwX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 05:03:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:03:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:03:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rdOfFhqB3h/Render', 05:03:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:27 INFO - 'HOME': '/Users/cltbld', 05:03:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:27 INFO - 'LOGNAME': 'cltbld', 05:03:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:27 INFO - 'MOZ_NO_REMOTE': '1', 05:03:27 INFO - 'NO_EM_RESTART': '1', 05:03:27 INFO - 'PAGER': '/bin/cat', 05:03:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:27 INFO - 'PWD': '/builds/slave/test', 05:03:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:27 INFO - 'SHELL': '/bin/bash', 05:03:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xlr8TujcwX/Listeners', 05:03:27 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 05:03:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:27 INFO - 'USER': 'cltbld', 05:03:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:27 INFO - 'XPC_FLAGS': '0x0', 05:03:27 INFO - 'XPC_SERVICE_NAME': '0', 05:03:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:27 INFO - Downloading/unpacking jsonschema==2.5.1 05:03:27 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 05:03:27 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 05:03:27 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 05:03:27 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 05:03:27 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 05:03:27 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 05:03:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:03:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:30 INFO - Downloading functools32-3.2.3-2.tar.gz 05:03:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:03:30 INFO - warning: no files found matching '*.txt' 05:03:30 INFO - no previously-included directories found matching 'build' 05:03:30 INFO - no previously-included directories found matching 'dist' 05:03:30 INFO - no previously-included directories found matching '.git*' 05:03:30 INFO - Installing collected packages: jsonschema, functools32 05:03:30 INFO - Running setup.py install for functools32 05:03:30 INFO - warning: no files found matching '*.txt' 05:03:30 INFO - no previously-included directories found matching 'build' 05:03:30 INFO - no previously-included directories found matching 'dist' 05:03:30 INFO - no previously-included directories found matching '.git*' 05:03:30 INFO - Successfully installed jsonschema functools32 05:03:30 INFO - Cleaning up... 05:03:30 INFO - Return code: 0 05:03:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:03:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:30 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 0x108f92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109027618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb894c5f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ef6d30>, '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 0x108c5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108eeeb20>, '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.rdOfFhqB3h/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.Xlr8TujcwX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 05:03:30 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 05:03:30 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 05:03:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rdOfFhqB3h/Render', 05:03:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:30 INFO - 'HOME': '/Users/cltbld', 05:03:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:30 INFO - 'LOGNAME': 'cltbld', 05:03:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:30 INFO - 'MOZ_NO_REMOTE': '1', 05:03:30 INFO - 'NO_EM_RESTART': '1', 05:03:30 INFO - 'PAGER': '/bin/cat', 05:03:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:30 INFO - 'PWD': '/builds/slave/test', 05:03:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:30 INFO - 'SHELL': '/bin/bash', 05:03:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xlr8TujcwX/Listeners', 05:03:30 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 05:03:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:30 INFO - 'USER': 'cltbld', 05:03:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:30 INFO - 'XPC_FLAGS': '0x0', 05:03:30 INFO - 'XPC_SERVICE_NAME': '0', 05:03:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:30 INFO - Downloading/unpacking blobuploader==1.2.4 05:03:30 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 05:03:30 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 05:03:30 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 05:03:30 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 05:03:30 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 05:03:30 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 05:03:33 INFO - Downloading blobuploader-1.2.4.tar.gz 05:03:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:03:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:03:33 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 05:03:33 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 05:03:33 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 05:03:33 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 05:03:33 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 05:03:33 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 05:03:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:03:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:34 INFO - Downloading docopt-0.6.1.tar.gz 05:03:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:03:34 INFO - Installing collected packages: blobuploader, requests, docopt 05:03:34 INFO - Running setup.py install for blobuploader 05:03:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:03:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:03:34 INFO - Running setup.py install for requests 05:03:35 INFO - Running setup.py install for docopt 05:03:35 INFO - Successfully installed blobuploader requests docopt 05:03:35 INFO - Cleaning up... 05:03:35 INFO - Return code: 0 05:03:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:03:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:03:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:35 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 0x108f92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109027618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb894c5f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ef6d30>, '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 0x108c5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108eeeb20>, '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.rdOfFhqB3h/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.Xlr8TujcwX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 05:03:35 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 05:03:35 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 05:03:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rdOfFhqB3h/Render', 05:03:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:35 INFO - 'HOME': '/Users/cltbld', 05:03:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:35 INFO - 'LOGNAME': 'cltbld', 05:03:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:35 INFO - 'MOZ_NO_REMOTE': '1', 05:03:35 INFO - 'NO_EM_RESTART': '1', 05:03:35 INFO - 'PAGER': '/bin/cat', 05:03:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:35 INFO - 'PWD': '/builds/slave/test', 05:03:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:35 INFO - 'SHELL': '/bin/bash', 05:03:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xlr8TujcwX/Listeners', 05:03:35 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 05:03:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:35 INFO - 'USER': 'cltbld', 05:03:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:35 INFO - 'XPC_FLAGS': '0x0', 05:03:35 INFO - 'XPC_SERVICE_NAME': '0', 05:03:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:03:36 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-k8BcFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:03:36 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-lzDKWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:03:36 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-9Vdrsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:03:36 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-exV5Kx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:03:36 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-RBTKy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:03:36 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-ULCKMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:03:36 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-YKOyhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:03:36 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-SInrYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:03:37 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-NJIR37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:03:37 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-ExPzRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:03:37 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-8MDraQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:03:37 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-3eP2xe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:03:37 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-aySLOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:03:37 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-kN7h8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:37 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-V2cGYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:03:37 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-zPDqnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:03:37 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-YHzvl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:03:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:03:38 INFO - Running setup.py install for manifestparser 05:03:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:03:38 INFO - Running setup.py install for mozcrash 05:03:38 INFO - Running setup.py install for mozdebug 05:03:38 INFO - Running setup.py install for mozdevice 05:03:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:03:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:03:38 INFO - Running setup.py install for mozfile 05:03:38 INFO - Running setup.py install for mozhttpd 05:03:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:03:38 INFO - Running setup.py install for mozinfo 05:03:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:03:39 INFO - Running setup.py install for mozInstall 05:03:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:03:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:03:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:03:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:03:39 INFO - Running setup.py install for mozleak 05:03:39 INFO - Running setup.py install for mozlog 05:03:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:03:39 INFO - Running setup.py install for moznetwork 05:03:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:03:39 INFO - Running setup.py install for mozprocess 05:03:39 INFO - Running setup.py install for mozprofile 05:03:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:03:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:03:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:03:40 INFO - Running setup.py install for mozrunner 05:03:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:03:40 INFO - Running setup.py install for mozscreenshot 05:03:40 INFO - Running setup.py install for moztest 05:03:40 INFO - Running setup.py install for mozversion 05:03:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:03:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:03:40 INFO - Cleaning up... 05:03:40 INFO - Return code: 0 05:03:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:03:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:40 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 0x108f92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109027618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb894c5f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ef6d30>, '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 0x108c5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108eeeb20>, '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.rdOfFhqB3h/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.Xlr8TujcwX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 05:03:40 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 05:03:40 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 05:03:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rdOfFhqB3h/Render', 05:03:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:40 INFO - 'HOME': '/Users/cltbld', 05:03:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:40 INFO - 'LOGNAME': 'cltbld', 05:03:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:40 INFO - 'MOZ_NO_REMOTE': '1', 05:03:40 INFO - 'NO_EM_RESTART': '1', 05:03:40 INFO - 'PAGER': '/bin/cat', 05:03:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:40 INFO - 'PWD': '/builds/slave/test', 05:03:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:40 INFO - 'SHELL': '/bin/bash', 05:03:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xlr8TujcwX/Listeners', 05:03:40 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 05:03:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:40 INFO - 'USER': 'cltbld', 05:03:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:40 INFO - 'XPC_FLAGS': '0x0', 05:03:40 INFO - 'XPC_SERVICE_NAME': '0', 05:03:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:03:40 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-sjW8Us-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:03:41 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)) 05:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:03:41 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-MvIfEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:03:41 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)) 05:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:03:41 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-RGhBvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:03:41 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)) 05:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:03:41 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-njCY0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:03:41 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)) 05:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:03:41 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-d62Dim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:03:41 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)) 05:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:03:41 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-hFJUwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:03:41 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)) 05:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:03:41 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-1UrA7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:03:41 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)) 05:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:03:41 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-5UAGSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:03:41 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)) 05:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:03:41 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-_zh1OP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:03:41 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)) 05:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:03:41 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-pAxSXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 05:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:03:41 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-g6DaE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:03:42 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)) 05:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:03:42 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-QI2D_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:03:42 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)) 05:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:03:42 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-3Ms1uU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:03:42 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)) 05:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:03:42 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-4qbZPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:03:42 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)) 05:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:42 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-JvrABG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:42 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)) 05:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:03:42 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-AesdLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:03:42 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)) 05:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:03:42 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-HGlPyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:03:42 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)) 05:03:42 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)) 05:03:42 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)) 05:03:42 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)) 05:03:42 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)) 05:03:42 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)) 05:03:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:03:42 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 05:03:42 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 05:03:42 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 05:03:42 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 05:03:42 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 05:03:42 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 05:03:45 INFO - Downloading blessings-1.6.tar.gz 05:03:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:03:45 INFO - Installing collected packages: blessings 05:03:45 INFO - Running setup.py install for blessings 05:03:45 INFO - Successfully installed blessings 05:03:45 INFO - Cleaning up... 05:03:45 INFO - Return code: 0 05:03:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:03:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:03:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:03:45 INFO - Reading from file tmpfile_stdout 05:03:45 INFO - Current package versions: 05:03:45 INFO - blessings == 1.6 05:03:45 INFO - blobuploader == 1.2.4 05:03:45 INFO - docopt == 0.6.1 05:03:45 INFO - functools32 == 3.2.3-2 05:03:45 INFO - jsonschema == 2.5.1 05:03:45 INFO - manifestparser == 1.1 05:03:45 INFO - mozInstall == 1.12 05:03:45 INFO - mozcrash == 0.17 05:03:45 INFO - mozdebug == 0.1 05:03:45 INFO - mozdevice == 0.48 05:03:45 INFO - mozfile == 1.2 05:03:45 INFO - mozhttpd == 0.7 05:03:45 INFO - mozinfo == 0.9 05:03:45 INFO - mozleak == 0.1 05:03:45 INFO - mozlog == 3.2 05:03:45 INFO - moznetwork == 0.27 05:03:45 INFO - mozprocess == 0.22 05:03:45 INFO - mozprofile == 0.28 05:03:45 INFO - mozrunner == 6.11 05:03:45 INFO - mozscreenshot == 0.1 05:03:45 INFO - mozsystemmonitor == 0.3 05:03:45 INFO - moztest == 0.7 05:03:45 INFO - mozversion == 1.4 05:03:45 INFO - psutil == 3.1.1 05:03:45 INFO - requests == 1.2.3 05:03:45 INFO - wsgiref == 0.1.2 05:03:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:45 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 0x108f92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109027618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb894c5f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ef6d30>, '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 0x108c5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108eeeb20>, '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.rdOfFhqB3h/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.Xlr8TujcwX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 05:03:45 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 05:03:45 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 05:03:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rdOfFhqB3h/Render', 05:03:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:45 INFO - 'HOME': '/Users/cltbld', 05:03:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:45 INFO - 'LOGNAME': 'cltbld', 05:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:45 INFO - 'MOZ_NO_REMOTE': '1', 05:03:45 INFO - 'NO_EM_RESTART': '1', 05:03:45 INFO - 'PAGER': '/bin/cat', 05:03:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:45 INFO - 'PWD': '/builds/slave/test', 05:03:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:45 INFO - 'SHELL': '/bin/bash', 05:03:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xlr8TujcwX/Listeners', 05:03:45 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 05:03:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:45 INFO - 'USER': 'cltbld', 05:03:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:45 INFO - 'XPC_FLAGS': '0x0', 05:03:45 INFO - 'XPC_SERVICE_NAME': '0', 05:03:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:46 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)) 05:03:46 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)) 05:03:46 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)) 05:03:46 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)) 05:03:46 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)) 05:03:46 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)) 05:03:46 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)) 05:03:46 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)) 05:03:46 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)) 05:03:46 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)) 05:03:46 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)) 05:03:46 INFO - Cleaning up... 05:03:46 INFO - Return code: 0 05:03:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:03:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:03:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:46 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 0x108f92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109027618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb894c5f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ef6d30>, '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 0x108c5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108eeeb20>, '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.rdOfFhqB3h/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.Xlr8TujcwX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 05:03:46 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 05:03:46 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 05:03:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rdOfFhqB3h/Render', 05:03:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:46 INFO - 'HOME': '/Users/cltbld', 05:03:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:46 INFO - 'LOGNAME': 'cltbld', 05:03:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:46 INFO - 'MOZ_NO_REMOTE': '1', 05:03:46 INFO - 'NO_EM_RESTART': '1', 05:03:46 INFO - 'PAGER': '/bin/cat', 05:03:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:46 INFO - 'PWD': '/builds/slave/test', 05:03:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:46 INFO - 'SHELL': '/bin/bash', 05:03:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xlr8TujcwX/Listeners', 05:03:46 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 05:03:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:46 INFO - 'USER': 'cltbld', 05:03:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:46 INFO - 'XPC_FLAGS': '0x0', 05:03:46 INFO - 'XPC_SERVICE_NAME': '0', 05:03:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:03:46 INFO - Cleaning up... 05:03:46 INFO - Return code: 0 05:03:46 INFO - Running post-action listener: _resource_record_post_action 05:03:46 INFO - Running post-action listener: _start_resource_monitoring 05:03:46 INFO - Starting resource monitoring. 05:03:46 INFO - ##### 05:03:46 INFO - ##### Finished create-virtualenv step (success) 05:03:46 INFO - ##### 05:03:46 INFO - ##### 05:03:46 INFO - ##### Running install step. 05:03:46 INFO - ##### 05:03:46 INFO - Running pre-action listener: _resource_record_pre_action 05:03:46 INFO - Running main action method: install 05:03:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:03:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:03:46 INFO - Reading from file tmpfile_stdout 05:03:46 INFO - Detecting whether we're running mozinstall >=1.0... 05:03:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:03:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:03:46 INFO - Reading from file tmpfile_stdout 05:03:46 INFO - Output received: 05:03:46 INFO - Usage: mozinstall [options] installer 05:03:46 INFO - Options: 05:03:46 INFO - -h, --help show this help message and exit 05:03:46 INFO - -d DEST, --destination=DEST 05:03:46 INFO - Directory to install application into. [default: 05:03:46 INFO - "/builds/slave/test"] 05:03:46 INFO - --app=APP Application being installed. [default: firefox] 05:03:46 INFO - mkdir: /builds/slave/test/build/application 05:03:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:03:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:04:21 INFO - Reading from file tmpfile_stdout 05:04:21 INFO - Output received: 05:04:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:04:21 INFO - Running post-action listener: _resource_record_post_action 05:04:21 INFO - ##### 05:04:21 INFO - ##### Finished install step (success) 05:04:21 INFO - ##### 05:04:21 INFO - ##### 05:04:21 INFO - ##### Running run-tests step. 05:04:21 INFO - ##### 05:04:21 INFO - Running pre-action listener: _resource_record_pre_action 05:04:21 INFO - Running main action method: run_tests 05:04:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:04:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:04:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:04:21 INFO - 2016-06-30 05:04:21.381 screenresolution[1642:8534] starting screenresolution argv=screenresolution get 05:04:21 INFO - 2016-06-30 05:04:21.383 screenresolution[1642:8534] Display 0: 1600x1200x32@60 05:04:21 INFO - 2016-06-30 05:04:21.389 screenresolution[1643:8536] starting screenresolution argv=screenresolution list 05:04:21 INFO - Available Modes on Display 0 05:04:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:04:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:04:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:04:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:04:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:04:21 INFO - Intel Iris: 05:04:21 INFO - Chipset Model: Intel Iris 05:04:21 INFO - Type: GPU 05:04:21 INFO - Bus: Built-In 05:04:21 INFO - VRAM (Dynamic, Max): 1536 MB 05:04:21 INFO - Vendor: Intel (0x8086) 05:04:21 INFO - Device ID: 0x0a2e 05:04:21 INFO - Revision ID: 0x0009 05:04:21 INFO - Displays: 05:04:21 INFO - Display: 05:04:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:04:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:04:21 INFO - Display Serial Number: 1600x1200 60 05:04:21 INFO - Main Display: Yes 05:04:21 INFO - Mirror: Off 05:04:21 INFO - Online: Yes 05:04:21 INFO - Rotation: Supported 05:04:21 INFO - Return code: 0 05:04:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:04:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:04:21 INFO - Python 2.7.3 05:04:21 INFO - Return code: 0 05:04:21 INFO - grabbing minidump binary from tooltool 05:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:04:21 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ef6d30>, '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 0x108c5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108eeeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:04:21 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 05:04:21 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 05:04:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:04:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:04:21 INFO - Return code: 0 05:04:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:04:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:04:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:04:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:04:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:04:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0098', '--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 05:04:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0098 --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 05:04:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rdOfFhqB3h/Render', 05:04:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:04:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:04:21 INFO - 'HOME': '/Users/cltbld', 05:04:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:04:21 INFO - 'LOGNAME': 'cltbld', 05:04:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:04:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:21 INFO - 'MOZ_NO_REMOTE': '1', 05:04:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:04:21 INFO - 'NO_EM_RESTART': '1', 05:04:21 INFO - 'PAGER': '/bin/cat', 05:04:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:21 INFO - 'PWD': '/builds/slave/test', 05:04:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:04:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:04:21 INFO - 'SHELL': '/bin/bash', 05:04:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xlr8TujcwX/Listeners', 05:04:21 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 05:04:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:04:21 INFO - 'USER': 'cltbld', 05:04:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:04:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:21 INFO - 'XPC_FLAGS': '0x0', 05:04:21 INFO - 'XPC_SERVICE_NAME': '0', 05:04:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:04:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0098', '--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 05:04:21 INFO - mozversion application_buildid: 20160630025528 05:04:21 INFO - mozversion application_changeset: d700dc054751333e0735f975fce3d3adf153c62a 05:04:21 INFO - mozversion application_display_name: Nightly 05:04:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:04:21 INFO - mozversion application_name: Firefox 05:04:21 INFO - mozversion application_remotingname: firefox 05:04:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:04:21 INFO - mozversion application_vendor: Mozilla 05:04:21 INFO - mozversion application_version: 50.0a1 05:04:21 INFO - mozversion platform_buildid: 20160630025528 05:04:21 INFO - mozversion platform_changeset: d700dc054751333e0735f975fce3d3adf153c62a 05:04:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:04:21 INFO - mozversion platform_version: 50.0a1 05:04:21 INFO - using testdate: 1467288261 05:04:21 INFO - actual date: 1467288261 05:04:21 INFO - starting webserver on 'localhost:49266' 05:04:21 INFO - SUITE-START | Running 2 tests 05:04:21 INFO - TEST-START | dromaeo_css 05:04:21 INFO - operating with platform_type : mac_ 05:04:21 INFO - Initialising browser for dromaeo_css test... 05:04:22 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmp945f8n/profile http://localhost:49266/getInfo.html) 05:04:25 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 05:04:25 INFO - PROCESS | 1653 | colorDepth:24 05:04:25 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 05:04:25 INFO - PROCESS | 1653 | __metrics 05:04:25 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:04:26 INFO - TEST-INFO | 1653: exit 0 05:04:26 INFO - Browser initialized. 05:04:26 INFO - Running cycle 1/1 for dromaeo_css test... 05:04:26 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmp945f8n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:04:38 INFO - PROCESS | 1657 | RSS: Main: 255614976 05:04:38 INFO - PROCESS | 1657 | 05:05:27 INFO - PROCESS | 1657 | 1467288327721 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] 05:07:38 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 05:07:39 INFO - PROCESS | 1657 | RSS: Main: 268464128 05:07:39 INFO - PROCESS | 1657 | 05:10:41 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 05:10:42 INFO - PROCESS | 1657 | RSS: Main: 276934656 05:10:42 INFO - PROCESS | 1657 | 05:13:44 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 05:13:44 INFO - PROCESS | 1657 | RSS: Main: 281538560 05:13:44 INFO - PROCESS | 1657 | 05:16:46 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 05:16:47 INFO - PROCESS | 1657 | RSS: Main: 280223744 05:16:47 INFO - PROCESS | 1657 | 05:19:50 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 05:19:50 INFO - PROCESS | 1657 | RSS: Main: 283901952 05:19:50 INFO - PROCESS | 1657 | 05:22:53 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 05:22:54 INFO - PROCESS | 1657 | RSS: Main: 284278784 05:22:54 INFO - PROCESS | 1657 | 05:22:54 INFO - PROCESS | 1657 | __start_tp_report 05:22:54 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 05:22:54 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 05:22:54 INFO - PROCESS | 1657 | |i|pagename|runs| 05:22:54 INFO - PROCESS | 1657 | |0;dojo.html;2782.65216847894;3407.710344620707;3471.756977011609;3472.756907016508;3488.2674638325934;5897.233359663243;5912.674802885845;5947.524198064155;6029.216201893759;6053.6065155764845;5750.7699692012375;5886.705664716768;5934.88130237395;5971.940280597193;6040.788572399967;5290.259363689087;5326.121190003664;5411.431799661018;5439.265699130626;5452.963936851986;135.95487053603037;5337;5410.513053825155;5424.674519528841;5457.426970168135;4624.44506659203;4872.537108974641;5383.784648614051;5400.540954018894;5507.834764957058;5252.921206181911;5372.973135134299;5411.512963833274;5450.781968721247;5468.28912241406;4383.956160438419;4443.400140980959;5252.606054545924;5328.6269961102735;5333.093374126369;4475.440569928759;5355.839324820262;5413.729313534347;5905;5929.495992840613;4360.280553708634;6262.812115636492;6323.7786677466065;6341.2707538633185;6348.0477928310665;6290;6392.584482008655;6417.005364168562;6418.19772528434;6423.100765892778;5605.915911261334;5613;6114.5064001751625;6118.556367312526;6141.877162456771;6248.562600618004;6335.3981371769605;6385.584936979081;6490.318516555788;6497.480201583862;6240.937590624127;6257.906131408033;6258.874822503524;6262.6868656566985;6273.807976484453;6310.968445157745;6325.652089135142;6341.968290158519;6375.936240637534;6390.297067322591;6157.9384206158265;6247.187865577536;6254.186955695822;6299.370062993664;6331.081993110973;6178.165947597106;6207.751689932352;6236.251649802053;6248.843778905563;6275.6862156891975;5086.313347698014;5115.437301896788;5125.15434953236;5125.897482050413;5131.692098474104;4544.136614043321;4560.201964656172;4560.293154561048;4664.230401983635;4685.0395668887795;6057.3336932937345;6113.602615829956;6134;6147.508199344042;6148.1392605035335;6395.648239346788;6405.935940640534;6410.55126141175;6411.198600174978;6417.582857114273;5905.350411454737;6026.397360264026;6049.485793707584;6107.114468402056;6154.692265386713;5555;5628.859278517988;5629.4652008059165;5644.407337229614;5648.068068768607;6263.4362907338555;6544.607323560602;6606.471482281406;6607.669616519155;6610.843102457051;6253.812385628438;6271.9686401569525;6319.873602527831;6405.391487808651;6416.550841441054;6494.740210391531;6557.868842623217;6560.40956313934;6588.4399826013405;6594.505412094208;6200.56596038273;6228.875422491616;6334.429901308904;6346.238451385863;6354.332795056453;6238.282597501346;6245.687715614292;6374.458171055512;6379.266384365857;6389.616623002635;5755.568332375173;6130.816075517741;6164.3835616438;6290.937090629035;6291.307956124914;5002.974985125051;6142.775043102407;6191.535634827316;6260.311365749672;6290.685465726604;5981.3420523743225;6069.635821850703;6114.969425152845;6131.0296614402;6148.985417406078;5256.369235691742;6188.876222475616;6201.790495983396;6206.627602343874;6242.656653883898;6074.058520929263;6116.8776624468155;6120.20334290948;6144.477719393902;6175.413335733098 05:22:54 INFO - PROCESS | 1657 | |1;ext.html;474.3833017077798;514.4855144855145;516.161237988269;518.134715025907;519.1252739134559;38146.61853381465;39830.40254396179;40999.18001639969;41058.79470602646;41144.58855411445;41525.58474415263;41817.58182418175;41853.372199417034;42242.57757422425;42334;9623.855642165374;9662.661806836762;9773.951130244339;9780.364276322052;9800.558974846113;9627.229821614254;9666.854997175013;9708;9717.757056073584;9753.122219000288;9700;9721;9730.951345243264;9738.318317717763;9762.170215531689;9631.711048668587;9638.566264518078;9688.321817472779;9708.854367184498;9713.70858874235;9534.570944307523;9601.615935362646;9623.56693948774;9647.276454265959;9722.805543889082;39288.8213353597;39888.20223595512;40183;40277.99305017369;40522.59477405217;2882.437924604703;2895.5946167536563;3156.2425017995515;3389.13842384648;3478.339115568034;29141.41717165645;29312.03894439168;30510.84744576285;30547.389052219052;31707.84146079278;3160.5575219469292;3169.5087261474278;3173.3177366866003;3184.7611429142676;3278.1476816027766;453731;455119.7244013792;458493.9999999967;459541;459763;32418.837905810793;33118.006459806245;33500.83249583736;33509.32981340408;33626;34437.65562344395;34651.78718744832;34907.650923490946;35381.82309088438;35852.46221306682;16502;16562;16688.499345019667;16693.83306166923;16702.91648541774;12515.749685006249;12650.240985540897;12666.556670516671;12732.490700372067;12768.553100641433;18957.43127706171;19364.225430982886;19370.56649015897;19403.320883769;19577.216911323387;6529.15121034272;6588.637624930579;6729.966350168218;7613.885791713129;7747.573883436352;866.7399780065955;973.4791886340915;1063.1919740996898;1079.4440862955585;1133.070881876853;29001.709982900324;30393.24016899595;30560;31119.222019449244;31219.84390078035;1044.1333693034762;1045.7019749371393;1127.4757237884423;1134.773045390925;1140.1676775953601;15910.124943128008;15944.123073231083;16067;16254.837451625568;16322.939008964378;588520;684395;690107;691902.161956758;698988;50035.24947125796;59734;59837;60555;60591.69704151539;1091.3670071358592;1355.8508564057945;1357.728454309142;1358.7690092684268;1361.4418088583634;30440.695593043787;30624.468776560636;30659.846700766353;31113.844430777703;31265.374692505568;44709.776451117534;45835.77082114568;45956.7702161487;46031.38890138829;46311.536884630725;593627.0318648379;596669;597111;597573;598225;27205.72794272032;27596;27844.721552784213;28866.711332886403;28893.711062889102;47699.284510731675;48829.51170488392;49073.75463122661;49075;49203;39970;40567.1886562273;41029.1794164121;41143;41215.79392103021;40663.1867362657;40721.38917916174;40854.1829163421;41411.1717765637;41751.79124104482;38090.42864357092;39236.80381598074;39244.80377598094;39376.606233937295;39476.81569552918;33262;34586.654133458345;35344.82327588346;35407;35462.82268588641;25614;25841.966321346936;25961.350966225997;26185.476290474464;26409.20772376832 05:22:54 INFO - PROCESS | 1657 | |2;jquery.html;374.9239682112338;377.2022173103885;384.1241968312248;394.57583098169437;400.85969910531315;17374.47876563702;18506.53733656659;21391.786082139173;21402.357929262107;21436.785632143674;20380.490487737814;20493.282735104276;21381.251656192035;21461.67807482885;21534.89232553835;5524.917126243089;5818.836232753466;5874.236349274588;5894.852628684274;6040.426159514839;5981.671008094553;5985.862686089651;6018.608790428608;6030.306514750816;6040.48655864252;5782.421757824226;5820.185174075633;5863.061910094386;5962.821115366546;5973.820785376424;5721.656700597978;5872.471477567039;5874.823755287327;5913.7338819752995;5966.16473693681;5155.510226528474;5156.587473002151;5165.612579056586;5170.844874653766;5181.663191892515;26287.60568591473;26403;26520.204393868215;26819.73180268192;26831.86584067067;2489.153687746175;2508.4606809536035;2693.245891150481;2809.157252824165;3160.2573395252098;11860.762784744256;12318.322492262922;15040.924795375953;15905.284262208228;15950.202489875459;1794.9551261218444;1872.7565416495768;1902;1929.170456703617;1948.2109745553073;108488;114520;116330;116807.66384672344;117253.41373293164;8745.781355466037;10438.112760415297;11067.944660276647;11152.609658661908;11479.598214062467;13486.595402137951;13583.932080339535;13624.04631675793;13626.182429054288;13648.454061837416;7205.7838264852135;8499.490030598185;8651.913480865236;8720.520371379635;8771.517566533901;8684.652613895374;8760.737177884546;8770.868436973451;8805.16350946659;8896.466212027299;6795.490338224653;6873.656317184121;6946.16646002483;6949.722011119599;6961.721531138799;1799.6130831870948;1845.870789044754;1846.759921210234;1850.0472256787766;1853.6107417442217;969.6557722008727;980.0983095552109;984.675057231112;1019.3679918450608;1089.2593036734938;21990.120395184334;22593.2092376766;22602.886985565296;22749;22798.088076476753;978.3640633588083;1024.5645600619707;1028.3983869436313;1055.2454994678842;1055.266589720137;9205.263578913671;10153.796924061477;11493.367864767519;11717.531298748125;11912.404379780975;589434;595828.0417195859;609944;622966;629990;72183.27816721871;75350.86973695399;112314.43842780734;119855.8014419862;120689;754.3399525415261;986.659602437158;1012.316686236802;1031.4017869635593;1053.0995998421392;15353;17031.744523831905;19476.513087172934;20216.595668086262;20278.391648250577;53233.20150197828;53973;54901;55107.62230944259;55848.60378490408;81054;81603.18396816193;81970;82272.3545529098;82486.58756706178;8200.0979892213;8284.544350060805;8490.533020683923;8532.70135545253;8534.914650853412;12640.936795315965;13464.124831885896;13533.796993044914;13562.932185339405;13577.52478663242;11293.37886416255;11321.320720756781;11576.942115289707;11614.477348519167;11738.471768770596;11446.313221206754;11459.713507162387;11509.36698481558;11619.360935148648;11641.941790290994;11869.762604747684;11898.821517677416;12012.579559715718;12032.518699252281;12045.51817927273;7003.6498175092065;7437.5496778127745;7496.7750967471065;8290.58547072656;8535.31717462589;8390.370722195737;10759;11659.591914283299;11682.824757628812;11824.527018919147 05:22:54 INFO - PROCESS | 1657 | |3;mootools.html;1501.4819887138938;1533.5935976966107;1703.4974682468671;1733.523281097698;1850.740896274521;7913.525188488695;8466.111058338878;8546.40175187737;8983.146601072904;9001.549922503882;8559.887214662102;8723.127687231274;8739.825203495926;8753.037165911745;8761.518116503607;2293.140072472823;2347.835651504395;2366.597678394677;2366.645003249509;2370.1349007612184;2306.884655767213;2337.9766202338014;2366.857988520694;2366.893489792955;2373.371056669975;2308.884555772213;2341.1103780563362;2345.85924844509;2348.6007378745653;2359.5988681924114;2300.9884950575306;2333.428310064028;2347.14329269817;2349.5653304138705;2352.094443639194;2329.324495896188;2332.4402143485613;2337.0418128567208;2338.777816107467;2341.3444235614056;8845.425047371964;8851.247643950208;8899.37704360695;8910.688125915562;8946.194842464145;5157.613179011551;5252.947470525284;5290.761915713802;5343;5347.278117454132;3581.7850928944345;3650.0509867434657;3675.228202077567;3700.0379901225874;3717.8141092945516;1053.936763794167;1062.4156713807374;1077.854489643896;1091.0671375973507;1093.059968427152;9355.578998944995;9851.261155413373;10978.615748448847;11449.484773185226;11691.88308116925;3637.5089362936196;4018.457508236409;4592.380028696083;4738.1708201064675;4753.5959443447;9801.558929848174;9903.25725570585;9934.602615895283;9967.501624918725;9976.05227503386;5325.600579956519;5357.4106848246665;5370.9731451342495;5378.1663842104535;5383.865403364947;4399.714018588846;4735.739534325645;4874.6344024197615;4886.95113048865;4902.166631672624;3862.5364956205435;3930.9213815724097;3994.3409337459575;4005.3991901214467;4036.798160091984;1250.2560976219136;1260.5147018397984;1261.8233447317382;1274.8342715447118;1277.5145444730942;819.6967122164718;827.611022819274;880.8282384934876;905.6015353244551;918.9724308270762;5664.320281566238;5844.795432159854;5903.321118071477;5944.138099975479;6037.909431358533;419.9643030342455;426.04990870358654;426.5585119401405;428.3510481620348;446.5757530346184;3962.2754610666457;4046.4941882264716;4062.1469491407133;4063.8981443319703;4096.1193343431305;10326.277160598836;10636.734081648021;10829.296095753909;10843.078338341329;10871.858454862126;10780.191485638608;10791.298565593212;10802.027817496462;10806;10827.07969822574;7791.4156438267355;8184.877226841602;8201.097879233279;8244.876326855101;8258.463199891989;6065.8180254592435;6071.332153463204;6080.939190608037;6183.659898705614;6232.127502149793;7518.28576285252;10024.498775061364;10250.743731406774;10279.897201027894;10291.94854025755;10016.599336026477;10139.9860013998;10393.921215756727;10408.063274305348;10412.843807343048;6912;7346.5592064476305;7484.925150748641;7630.8092297693;7662.693492260247;8511.489310641382;8514.70198543048;8601.096884827002;8619.094995025433;8623.611937462703;7431.739889104072;7526.774196774106;7567.054118235221;7613.923860761543;7662.923370766444;7371.299726525972;7406.925930740839;7466.141393739789;7480.625968701652;7588.165301816685;7063.328983746535;7087;7115.288471152843;7130.42956563484;7139;4902.1911384621135;5040.49595040493;5082.644214904921;5093.847184584469;5096.955124199604;5031.245313203049;5058.747062646779;5111.386633603991;5151.871203219949;5250.501202385767 05:22:54 INFO - PROCESS | 1657 | |4;prototype.html;305.6179775280899;308.158726676174;309.44918045878336;309.7552933182786;314.7670723664486;4938.493759403385;5014.849554513361;5176.948230517693;5762.884742305151;5797.913031304523;4898.608111351093;5655.802046928358;5671.865626874631;5693.28833895763;5699.943000569993;3445.3626079175306;3769.1519408133227;4095.856645017425;4154.729942553739;4258.44640196774;3342.9971008697416;3534.876279330224;3969.2656858481128;4211.8525851595205;4224;4256.787160641971;4258.127083947783;4282.357646353041;4287.549807270223;4288.849890253841;4144.854930077433;4183.4818396132405;4238.512571054337;4254.319308910591;4269.5943885331;3467.843947022365;3637.1814092953523;3676.7058635309113;3699.408094704861;3706;4777.710018295041;5272.971770504753;5398.865028374283;5544.584156188302;5547.805826796042;3644.817759112034;4478.544473046273;4797.529272424669;4894.877628059291;4964.354633897607;5621.353544342412;5913.113033045035;5948.750762339914;6008.218931538916;6046.727897244635;3315.96684033159;3974.324364857981;4001.9399709004388;4004;4024.8993775155564;5274.973625131888;5473.616846820724;5804.9260886735665;6207.34822843604;6279.398753317921;3333.799972001688;3996.620321069494;4010.57888921659;4011.7191796574543;4044.6157615027114;4054.655354294859;4088.6115818997146;4098.303288440972;4109.383592461095;4110.588211784212;4095.85664501747;4100.958990410118;4133.441985332001;4588.128255631419;4842.757862106881;6031.6175110831855;6047.758089676364;6053.878922421615;6076.055662188058;6121.908171377433;1169.9119818568643;1255.0210835548287;1388.3266615691382;1417.3551034279585;1431.6277767780452;683.4156795939499;717.8944425584646;723.7539236659561;846.6020970144023;904.6064961741663;5503.862403439866;5530.50676317392;5552.694601796859;5575.69333686643;5580.665160090326;4674.041821426599;5348.304720386325;5705.315362156568;5797.593998490664;6160.229971253593;3984.2270189765277;5214.504622060898;5388.551327150627;5482.122860342326;5554.833354999276;2669.8531580763242;2691.7483370232935;3046.6953304669355;3215.276562773404;3238.3523295341024;5046.394432668103;5819.53443724501;6026.849328766728;6307.4954003679595;6341.175647165839;5955.196048533479;6151.5386346024225;6266.937330626635;6272;6275.278342990523;5266.394364648115;6283.151774510566;6288.811335659938;6331.810045698544;6334.239891212992;5486.369067557282;5960.314563825215;5972.432618901197;6116.981396139175;6118.296395914349;5216.105061690798;5310.575153987749;5842.393341831031;5952.285725712942;6079.1793107931635;5504.036793561191;5956.404359564182;6023.879522409439;6209.937900620936;6354.8093557191505;4018.8699989005872;4038.990252436891;4040.555538890661;4041.2927737645205;4050.5746896576616;5733.541316694738;5969.4627483524955;6246.281677606951;6254.687265636609;6274.23933469272;4951.282064100613;5485.862853428696;5995.730192141277;6072.332043475126;6149.907751383644;4839.516048395132;5749.8275051748515;6034.396560344106;6076;6175.3515880831865;4942.703437793743;5734.569907256889;5894.911576326444;5931.911021334769;6005.528645481885;5092.337996060636;5896.616719913192;5922.407759224043;6026.487748541423;6120.571559990758;4766.808297925519;4933.851984440473;5587.407588837162;6002.249718785152;6035.336113027475 05:22:54 INFO - PROCESS | 1657 | |5;yui.html;690.9758158464455;696.9546979446336;706.3254591864772;761.7828918758155;775.5734346109638;13874.236916969588;15007.924960375196;15565.766513502307;15595.90828641994;15627.14050727211;13998.300084995735;14101.717965640706;14114.223717695522;14130.081544699613;14134.64663383416;667.3426674725391;802.743122200896;815.975520734379;844.1684940333766;851.9233269005788;684.9006894000366;822.5352675738219;829.6805729794042;829.7966998085448;835.0897521701345;750.8549462070332;868.9739307820776;877.6840337478502;894.4052205283479;896.8699538566904;750.5609218607121;861.51324501657;888.959996800139;889.4263200235844;890.5725251879102;566.8526183192358;633.768674433833;647.9449246814027;653.0139489371084;660.7885476647475;12832.615021549369;14108.647283817883;14126.92936535321;14536.781948270784;14542.70914581713;12965.546205882843;14368.856311436857;14372.49696260626;14391.992560520768;14408;11084.944575277153;11823.290602563788;12049.457774400085;12202.023838092931;12229.082818788538;3764.4729737836724;3825.8469661213517;3904.6876249899938;4022.1352409232154;4047.959520404788;104123.4793826026;105150.47424762904;106425;106668;106922.93077069208;10719.249652524248;10987.39569323679;11156.832647510293;11164.330140191614;11201.383923884101;22486.550268994528;22493.55012899733;22498;22525.43686407853;22573.661395079085;7807.570583617842;7838.020247469067;7975.800604984922;8125.674973001013;8287.709930152416;4452.398926144929;4480.843170489017;4521.547845215452;4545.431821022372;4628.375169352094;3238.5951756030495;3463.740219483549;3476.9826150869085;3544.468329750558;3877.0695033191832;720.045939130654;723.3815088099705;731.6085894046765;733.5708610462939;739.8520295940833;557.7880405445985;668.5253470036329;668.8160755792196;696.8571442854203;698.2260879943912;9091.772705682411;9393.107654772786;9430.764230894283;9604.567794449267;9669.129937977525;585.9938515415975;639.268038096377;640.193356370976;640.9230892292954;675.601395176848;4407.2507673695545;4462.955370446319;4596.931046034312;4757.286407038902;4987.451380348159;131563.3421832904;140664;150627;154259.68610470628;156796;117863.821361787;131955;132800;136482;139697.30151349382;94029.52985235167;113592.43203784093;116073;118173.40913295551;118804.40597797128;8589.269912057545;9771.583120447638;9778.992573232556;9834.950825245827;10048.39709617396;53571.46428535665;54989.72505137449;56039.71980140073;58383;60611.09083363841;84508.73236901575;85939.14060859561;87205.69191462007;87937;95880.52059739656;13030;13080.73838523205;13103.21380717122;13128.934355328161;13658.590242292747;14526;14703.191324477257;15231.238438078273;15251.923740381228;15461.458848940232;13581.796273055714;13894.444222230997;13972.930135349257;14168.43326266979;14428;13710.451581936612;13741.656458588615;13760.449582016607;14203.147811131365;14377.928110359382;13193.472261109448;13786.241756703077;14194.574162775134;14335.856641433453;14354;11097.99879499454;11221.60724374643;11390.25963312382;11461.484233209692;12350.75298494007;10222.744431388977;11045.226834121535;11081.206127149762;11294.378809165246;11612.245204061708 05:22:54 INFO - PROCESS | 1657 | __end_tp_report 05:22:54 INFO - PROCESS | 1657 | __start_cc_report 05:22:54 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,440 05:22:54 INFO - PROCESS | 1657 | __end_cc_report 05:22:54 INFO - PROCESS | 1657 | __startTimestamp1467289374009__endTimestamp 05:22:54 INFO - PROCESS | 1657 | 05:22:54 INFO - PROCESS | 1657 | ------- Summary: start ------- 05:22:54 INFO - PROCESS | 1657 | Number of tests: 6 05:22:54 INFO - PROCESS | 1657 | 05:22:54 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5814.40 Median:6134.00 stddev:829.52 (13.5%) stddev-sans-first:797.24 05:22:54 INFO - PROCESS | 1657 | Values: 2782.7 3407.7 3471.8 3472.8 3488.3 5897.2 5912.7 5947.5 6029.2 6053.6 5750.8 5886.7 5934.9 5971.9 6040.8 5290.3 5326.1 5411.4 5439.3 5453.0 136.0 5337.0 5410.5 5424.7 5457.4 4624.4 4872.5 5383.8 5400.5 5507.8 5252.9 5373.0 5411.5 5450.8 5468.3 4384.0 4443.4 5252.6 5328.6 5333.1 4475.4 5355.8 5413.7 5905.0 5929.5 4360.3 6262.8 6323.8 6341.3 6348.0 6290.0 6392.6 6417.0 6418.2 6423.1 5605.9 5613.0 6114.5 6118.6 6141.9 6248.6 6335.4 6385.6 6490.3 6497.5 6240.9 6257.9 6258.9 6262.7 6273.8 6311.0 6325.7 6342.0 6375.9 6390.3 6157.9 6247.2 6254.2 6299.4 6331.1 6178.2 6207.8 6236.3 6248.8 6275.7 5086.3 5115.4 5125.2 5125.9 5131.7 4544.1 4560.2 4560.3 4664.2 4685.0 6057.3 6113.6 6134.0 6147.5 6148.1 6395.6 6405.9 6410.6 6411.2 6417.6 5905.4 6026.4 6049.5 6107.1 6154.7 5555.0 5628.9 5629.5 5644.4 5648.1 6263.4 6544.6 6606.5 6607.7 6610.8 6253.8 6272.0 6319.9 6405.4 6416.6 6494.7 6557.9 6560.4 6588.4 6594.5 6200.6 6228.9 6334.4 6346.2 6354.3 6238.3 6245.7 6374.5 6379.3 6389.6 5755.6 6130.8 6164.4 6290.9 6291.3 5003.0 6142.8 6191.5 6260.3 6290.7 5981.3 6069.6 6115.0 6131.0 6149.0 5256.4 6188.9 6201.8 6206.6 6242.7 6074.1 6116.9 6120.2 6144.5 6175.4 05:22:54 INFO - PROCESS | 1657 | 05:22:54 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:69440.00 Median:39859.30 stddev:155922.87 (391.2%) stddev-sans-first:156274.30 05:22:54 INFO - PROCESS | 1657 | Values: 474.4 514.5 516.2 518.1 519.1 38146.6 39830.4 40999.2 41058.8 41144.6 41525.6 41817.6 41853.4 42242.6 42334.0 9623.9 9662.7 9774.0 9780.4 9800.6 9627.2 9666.9 9708.0 9717.8 9753.1 9700.0 9721.0 9731.0 9738.3 9762.2 9631.7 9638.6 9688.3 9708.9 9713.7 9534.6 9601.6 9623.6 9647.3 9722.8 39288.8 39888.2 40183.0 40278.0 40522.6 2882.4 2895.6 3156.2 3389.1 3478.3 29141.4 29312.0 30510.8 30547.4 31707.8 3160.6 3169.5 3173.3 3184.8 3278.1 453731.0 455119.7 458494.0 459541.0 459763.0 32418.8 33118.0 33500.8 33509.3 33626.0 34437.7 34651.8 34907.7 35381.8 35852.5 16502.0 16562.0 16688.5 16693.8 16702.9 12515.7 12650.2 12666.6 12732.5 12768.6 18957.4 19364.2 19370.6 19403.3 19577.2 6529.2 6588.6 6730.0 7613.9 7747.6 866.7 973.5 1063.2 1079.4 1133.1 29001.7 30393.2 30560.0 31119.2 31219.8 1044.1 1045.7 1127.5 1134.8 1140.2 15910.1 15944.1 16067.0 16254.8 16322.9 588520.0 684395.0 690107.0 691902.2 698988.0 50035.2 59734.0 59837.0 60555.0 60591.7 1091.4 1355.9 1357.7 1358.8 1361.4 30440.7 30624.5 30659.8 31113.8 31265.4 44709.8 45835.8 45956.8 46031.4 46311.5 593627.0 596669.0 597111.0 597573.0 598225.0 27205.7 27596.0 27844.7 28866.7 28893.7 47699.3 48829.5 49073.8 49075.0 49203.0 39970.0 40567.2 41029.2 41143.0 41215.8 40663.2 40721.4 40854.2 41411.2 41751.8 38090.4 39236.8 39244.8 39376.6 39476.8 33262.0 34586.7 35344.8 35407.0 35462.8 25614.0 25842.0 25961.4 26185.5 26409.2 05:22:54 INFO - PROCESS | 1657 | 05:22:54 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:34913.65 Median:14398.03 stddev:101054.49 (701.9%) stddev-sans-first:101304.70 05:22:54 INFO - PROCESS | 1657 | Values: 374.9 377.2 384.1 394.6 400.9 17374.5 18506.5 21391.8 21402.4 21436.8 20380.5 20493.3 21381.3 21461.7 21534.9 5524.9 5818.8 5874.2 5894.9 6040.4 5981.7 5985.9 6018.6 6030.3 6040.5 5782.4 5820.2 5863.1 5962.8 5973.8 5721.7 5872.5 5874.8 5913.7 5966.2 5155.5 5156.6 5165.6 5170.8 5181.7 26287.6 26403.0 26520.2 26819.7 26831.9 2489.2 2508.5 2693.2 2809.2 3160.3 11860.8 12318.3 15040.9 15905.3 15950.2 1795.0 1872.8 1902.0 1929.2 1948.2 108488.0 114520.0 116330.0 116807.7 117253.4 8745.8 10438.1 11067.9 11152.6 11479.6 13486.6 13583.9 13624.0 13626.2 13648.5 7205.8 8499.5 8651.9 8720.5 8771.5 8684.7 8760.7 8770.9 8805.2 8896.5 6795.5 6873.7 6946.2 6949.7 6961.7 1799.6 1845.9 1846.8 1850.0 1853.6 969.7 980.1 984.7 1019.4 1089.3 21990.1 22593.2 22602.9 22749.0 22798.1 978.4 1024.6 1028.4 1055.2 1055.3 9205.3 10153.8 11493.4 11717.5 11912.4 589434.0 595828.0 609944.0 622966.0 629990.0 72183.3 75350.9 112314.4 119855.8 120689.0 754.3 986.7 1012.3 1031.4 1053.1 15353.0 17031.7 19476.5 20216.6 20278.4 53233.2 53973.0 54901.0 55107.6 55848.6 81054.0 81603.2 81970.0 82272.4 82486.6 8200.1 8284.5 8490.5 8532.7 8534.9 12640.9 13464.1 13533.8 13562.9 13577.5 11293.4 11321.3 11576.9 11614.5 11738.5 11446.3 11459.7 11509.4 11619.4 11641.9 11869.8 11898.8 12012.6 12032.5 12045.5 7003.6 7437.5 7496.8 8290.6 8535.3 8390.4 10759.0 11659.6 11682.8 11824.5 05:22:54 INFO - PROCESS | 1657 | 05:22:54 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5696.50 Median:4894.56 stddev:3191.74 (65.2%) stddev-sans-first:3185.12 05:22:54 INFO - PROCESS | 1657 | Values: 1501.5 1533.6 1703.5 1733.5 1850.7 7913.5 8466.1 8546.4 8983.1 9001.5 8559.9 8723.1 8739.8 8753.0 8761.5 2293.1 2347.8 2366.6 2366.6 2370.1 2306.9 2338.0 2366.9 2366.9 2373.4 2308.9 2341.1 2345.9 2348.6 2359.6 2301.0 2333.4 2347.1 2349.6 2352.1 2329.3 2332.4 2337.0 2338.8 2341.3 8845.4 8851.2 8899.4 8910.7 8946.2 5157.6 5252.9 5290.8 5343.0 5347.3 3581.8 3650.1 3675.2 3700.0 3717.8 1053.9 1062.4 1077.9 1091.1 1093.1 9355.6 9851.3 10978.6 11449.5 11691.9 3637.5 4018.5 4592.4 4738.2 4753.6 9801.6 9903.3 9934.6 9967.5 9976.1 5325.6 5357.4 5371.0 5378.2 5383.9 4399.7 4735.7 4874.6 4887.0 4902.2 3862.5 3930.9 3994.3 4005.4 4036.8 1250.3 1260.5 1261.8 1274.8 1277.5 819.7 827.6 880.8 905.6 919.0 5664.3 5844.8 5903.3 5944.1 6037.9 420.0 426.0 426.6 428.4 446.6 3962.3 4046.5 4062.1 4063.9 4096.1 10326.3 10636.7 10829.3 10843.1 10871.9 10780.2 10791.3 10802.0 10806.0 10827.1 7791.4 8184.9 8201.1 8244.9 8258.5 6065.8 6071.3 6080.9 6183.7 6232.1 7518.3 10024.5 10250.7 10279.9 10291.9 10016.6 10140.0 10393.9 10408.1 10412.8 6912.0 7346.6 7484.9 7630.8 7662.7 8511.5 8514.7 8601.1 8619.1 8623.6 7431.7 7526.8 7567.1 7613.9 7662.9 7371.3 7406.9 7466.1 7480.6 7588.2 7063.3 7087.0 7115.3 7130.4 7139.0 4902.2 5040.5 5082.6 5093.8 5097.0 5031.2 5058.7 5111.4 5151.9 5250.5 05:22:54 INFO - PROCESS | 1657 | 05:22:54 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4740.59 Median:5368.43 stddev:1514.47 (28.2%) stddev-sans-first:1481.69 05:22:54 INFO - PROCESS | 1657 | Values: 305.6 308.2 309.4 309.8 314.8 4938.5 5014.8 5176.9 5762.9 5797.9 4898.6 5655.8 5671.9 5693.3 5699.9 3445.4 3769.2 4095.9 4154.7 4258.4 3343.0 3534.9 3969.3 4211.9 4224.0 4256.8 4258.1 4282.4 4287.5 4288.8 4144.9 4183.5 4238.5 4254.3 4269.6 3467.8 3637.2 3676.7 3699.4 3706.0 4777.7 5273.0 5398.9 5544.6 5547.8 3644.8 4478.5 4797.5 4894.9 4964.4 5621.4 5913.1 5948.8 6008.2 6046.7 3316.0 3974.3 4001.9 4004.0 4024.9 5275.0 5473.6 5804.9 6207.3 6279.4 3333.8 3996.6 4010.6 4011.7 4044.6 4054.7 4088.6 4098.3 4109.4 4110.6 4095.9 4101.0 4133.4 4588.1 4842.8 6031.6 6047.8 6053.9 6076.1 6121.9 1169.9 1255.0 1388.3 1417.4 1431.6 683.4 717.9 723.8 846.6 904.6 5503.9 5530.5 5552.7 5575.7 5580.7 4674.0 5348.3 5705.3 5797.6 6160.2 3984.2 5214.5 5388.6 5482.1 5554.8 2669.9 2691.7 3046.7 3215.3 3238.4 5046.4 5819.5 6026.8 6307.5 6341.2 5955.2 6151.5 6266.9 6272.0 6275.3 5266.4 6283.2 6288.8 6331.8 6334.2 5486.4 5960.3 5972.4 6117.0 6118.3 5216.1 5310.6 5842.4 5952.3 6079.2 5504.0 5956.4 6023.9 6209.9 6354.8 4018.9 4039.0 4040.6 4041.3 4050.6 5733.5 5969.5 6246.3 6254.7 6274.2 4951.3 5485.9 5995.7 6072.3 6149.9 4839.5 5749.8 6034.4 6076.0 6175.4 4942.7 5734.6 5894.9 5931.9 6005.5 5092.3 5896.6 5922.4 6026.5 6120.6 4766.8 4933.9 5587.4 6002.2 6035.3 05:22:54 INFO - PROCESS | 1657 | 05:22:54 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:24650.64 Median:3351.17 stddev:39278.71 (1172.1%) stddev-sans-first:39347.70 05:22:54 INFO - PROCESS | 1657 | Values: 691.0 697.0 706.3 761.8 775.6 13874.2 15007.9 15565.8 15595.9 15627.1 13998.3 14101.7 14114.2 14130.1 14134.6 667.3 802.7 816.0 844.2 851.9 684.9 822.5 829.7 829.8 835.1 750.9 869.0 877.7 894.4 896.9 750.6 861.5 889.0 889.4 890.6 566.9 633.8 647.9 653.0 660.8 12832.6 14108.6 14126.9 14536.8 14542.7 12965.5 14368.9 14372.5 14392.0 14408.0 11084.9 11823.3 12049.5 12202.0 12229.1 3764.5 3825.8 3904.7 4022.1 4048.0 104123.5 105150.5 106425.0 106668.0 106922.9 10719.2 10987.4 11156.8 11164.3 11201.4 22486.6 22493.6 22498.0 22525.4 22573.7 7807.6 7838.0 7975.8 8125.7 8287.7 4452.4 4480.8 4521.5 4545.4 4628.4 3238.6 3463.7 3477.0 3544.5 3877.1 720.0 723.4 731.6 733.6 739.9 557.8 668.5 668.8 696.9 698.2 9091.8 9393.1 9430.8 9604.6 9669.1 586.0 639.3 640.2 640.9 675.6 4407.3 4463.0 4596.9 4757.3 4987.5 131563.3 140664.0 150627.0 154259.7 156796.0 117863.8 131955.0 132800.0 136482.0 139697.3 94029.5 113592.4 116073.0 118173.4 118804.4 8589.3 9771.6 9779.0 9835.0 10048.4 53571.5 54989.7 56039.7 58383.0 60611.1 84508.7 85939.1 87205.7 87937.0 95880.5 13030.0 13080.7 13103.2 13128.9 13658.6 14526.0 14703.2 15231.2 15251.9 15461.5 13581.8 13894.4 13972.9 14168.4 14428.0 13710.5 13741.7 13760.4 14203.1 14377.9 13193.5 13786.2 14194.6 14335.9 14354.0 11098.0 11221.6 11390.3 11461.5 12350.8 10222.7 11045.2 11081.2 11294.4 11612.2 05:22:54 INFO - PROCESS | 1657 | -------- Summary: end -------- 05:22:54 INFO - PROCESS | 1657 | 05:22:54 INFO - TEST-INFO | 1657: exit 0 05:22:54 INFO - TEST-OK | dromaeo_css | took 1112724ms 05:22:54 INFO - TEST-START | kraken 05:22:54 INFO - operating with platform_type : mac_ 05:22:54 INFO - Initialising browser for kraken test... 05:22:54 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmpbCuwqe/profile http://localhost:49266/getInfo.html) 05:22:57 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 05:22:57 INFO - PROCESS | 1665 | colorDepth:24 05:22:57 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 05:22:57 INFO - PROCESS | 1665 | __metrics 05:22:57 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:22:58 INFO - TEST-INFO | 1665: exit 0 05:22:58 INFO - Browser initialized. 05:22:58 INFO - Running cycle 1/1 for kraken test... 05:22:58 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmpbCuwqe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:23:10 INFO - PROCESS | 1667 | RSS: Main: 255746048 05:23:10 INFO - PROCESS | 1667 | 05:23:13 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 05:23:14 INFO - PROCESS | 1667 | RSS: Main: 268939264 05:23:14 INFO - PROCESS | 1667 | 05:23:16 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 05:23:17 INFO - PROCESS | 1667 | RSS: Main: 273399808 05:23:17 INFO - PROCESS | 1667 | 05:23:20 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 05:23:21 INFO - PROCESS | 1667 | RSS: Main: 273440768 05:23:21 INFO - PROCESS | 1667 | 05:23:23 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 05:23:24 INFO - PROCESS | 1667 | RSS: Main: 274341888 05:23:24 INFO - PROCESS | 1667 | 05:23:26 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:23:26 INFO - PROCESS | 1667 | RSS: Main: 274948096 05:23:26 INFO - PROCESS | 1667 | 05:23:29 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 05:23:30 INFO - PROCESS | 1667 | RSS: Main: 275460096 05:23:30 INFO - PROCESS | 1667 | 05:23:33 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 05:23:33 INFO - PROCESS | 1667 | RSS: Main: 275611648 05:23:33 INFO - PROCESS | 1667 | 05:23:36 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 05:23:37 INFO - PROCESS | 1667 | RSS: Main: 275857408 05:23:37 INFO - PROCESS | 1667 | 05:23:38 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:23:39 INFO - PROCESS | 1667 | RSS: Main: 276217856 05:23:39 INFO - PROCESS | 1667 | 05:23:41 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:23:42 INFO - PROCESS | 1667 | RSS: Main: 275361792 05:23:42 INFO - PROCESS | 1667 | 05:23:44 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:23:45 INFO - PROCESS | 1667 | RSS: Main: 275693568 05:23:45 INFO - PROCESS | 1667 | 05:23:48 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:23:48 INFO - PROCESS | 1667 | RSS: Main: 275963904 05:23:48 INFO - PROCESS | 1667 | 05:23:51 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:23:52 INFO - PROCESS | 1667 | RSS: Main: 276156416 05:23:52 INFO - PROCESS | 1667 | 05:23:54 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 05:23:54 INFO - PROCESS | 1667 | RSS: Main: 276824064 05:23:54 INFO - PROCESS | 1667 | 05:23:54 INFO - PROCESS | 1667 | __start_tp_report 05:23:54 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 05:23:54 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 05:23:54 INFO - PROCESS | 1667 | |i|pagename|runs| 05:23:54 INFO - PROCESS | 1667 | |0;ai-astar;106;166;122;116;164;96;140;167;169;116 05:23:54 INFO - PROCESS | 1667 | |1;audio-beat-detection;177;141;159;150;112;126;128;109;157;109 05:23:54 INFO - PROCESS | 1667 | |2;audio-dft;193;196;232;272;200;197;193;191;198;193 05:23:54 INFO - PROCESS | 1667 | |3;audio-fft;69;81;94;178;86;83;60;59;127;58 05:23:54 INFO - PROCESS | 1667 | |4;audio-oscillator;100;74;119;66;69;93;114;104;105;148 05:23:54 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;92;88;85;85;87;85;90;87;89;87 05:23:54 INFO - PROCESS | 1667 | |6;imaging-darkroom;99;95;95;150;123;95;97;100;96;96 05:23:54 INFO - PROCESS | 1667 | |7;imaging-desaturate;147;133;92;94;92;89;92;91;90;89 05:23:54 INFO - PROCESS | 1667 | |8;json-parse-financial;57;58;55;57;58;57;57;57;58;56 05:23:54 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;69;69;70;69;103;70;89;62;88;105 05:23:54 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;89;86;84;83;93;86;82;88;90;107 05:23:54 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;117;146;149;149;150;175;153;163;148;132 05:23:54 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;170;167;163;192;167;168;163;205;243;230 05:23:54 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;97;88;88;64;79;86;71;60;84;84 05:23:54 INFO - PROCESS | 1667 | __end_tp_report 05:23:54 INFO - PROCESS | 1667 | __start_cc_report 05:23:54 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1136 05:23:54 INFO - PROCESS | 1667 | __end_cc_report 05:23:54 INFO - PROCESS | 1667 | __startTimestamp1467289434468__endTimestamp 05:23:54 INFO - PROCESS | 1667 | 05:23:54 INFO - PROCESS | 1667 | ------- Summary: start ------- 05:23:54 INFO - PROCESS | 1667 | Number of tests: 14 05:23:54 INFO - PROCESS | 1667 | 05:23:54 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:136.20 Median:165.00 stddev:28.37 (17.2%) stddev-sans-first:27.91 05:23:54 INFO - PROCESS | 1667 | Values: 106.0 166.0 122.0 116.0 164.0 96.0 140.0 167.0 169.0 116.0 05:23:54 INFO - PROCESS | 1667 | 05:23:54 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:145.50 stddev:23.72 (16.3%) stddev-sans-first:20.21 05:23:54 INFO - PROCESS | 1667 | Values: 177.0 141.0 159.0 150.0 112.0 126.0 128.0 109.0 157.0 109.0 05:23:54 INFO - PROCESS | 1667 | 05:23:54 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:206.50 Median:197.50 stddev:25.91 (13.1%) stddev-sans-first:27.02 05:23:54 INFO - PROCESS | 1667 | Values: 193.0 196.0 232.0 272.0 200.0 197.0 193.0 191.0 198.0 193.0 05:23:54 INFO - PROCESS | 1667 | 05:23:54 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:89.50 Median:75.00 stddev:37.41 (49.9%) stddev-sans-first:38.94 05:23:54 INFO - PROCESS | 1667 | Values: 69.0 81.0 94.0 178.0 86.0 83.0 60.0 59.0 127.0 58.0 05:23:54 INFO - PROCESS | 1667 | 05:23:54 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:99.20 Median:107.00 stddev:25.25 (23.6%) stddev-sans-first:26.78 05:23:54 INFO - PROCESS | 1667 | Values: 100.0 74.0 119.0 66.0 69.0 93.0 114.0 104.0 105.0 148.0 05:23:54 INFO - PROCESS | 1667 | 05:23:54 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:87.50 stddev:2.32 (2.7%) stddev-sans-first:1.80 05:23:54 INFO - PROCESS | 1667 | Values: 92.0 88.0 85.0 85.0 87.0 85.0 90.0 87.0 89.0 87.0 05:23:54 INFO - PROCESS | 1667 | 05:23:54 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:104.60 Median:95.50 stddev:18.06 (18.9%) stddev-sans-first:19.04 05:23:54 INFO - PROCESS | 1667 | Values: 99.0 95.0 95.0 150.0 123.0 95.0 97.0 100.0 96.0 96.0 05:23:54 INFO - PROCESS | 1667 | 05:23:54 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:100.90 Median:91.50 stddev:20.93 (22.9%) stddev-sans-first:14.05 05:23:54 INFO - PROCESS | 1667 | Values: 147.0 133.0 92.0 94.0 92.0 89.0 92.0 91.0 90.0 89.0 05:23:54 INFO - PROCESS | 1667 | 05:23:54 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:0.94 (1.7%) stddev-sans-first:1.00 05:23:54 INFO - PROCESS | 1667 | Values: 57.0 58.0 55.0 57.0 58.0 57.0 57.0 57.0 58.0 56.0 05:23:54 INFO - PROCESS | 1667 | 05:23:54 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:79.40 Median:69.50 stddev:15.57 (22.4%) stddev-sans-first:16.06 05:23:54 INFO - PROCESS | 1667 | Values: 69.0 69.0 70.0 69.0 103.0 70.0 89.0 62.0 88.0 105.0 05:23:54 INFO - PROCESS | 1667 | 05:23:54 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:87.00 stddev:7.22 (8.3%) stddev-sans-first:7.66 05:23:54 INFO - PROCESS | 1667 | Values: 89.0 86.0 84.0 83.0 93.0 86.0 82.0 88.0 90.0 107.0 05:23:54 INFO - PROCESS | 1667 | 05:23:54 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:148.20 Median:149.50 stddev:15.65 (10.5%) stddev-sans-first:11.85 05:23:54 INFO - PROCESS | 1667 | Values: 117.0 146.0 149.0 149.0 150.0 175.0 153.0 163.0 148.0 132.0 05:23:54 INFO - PROCESS | 1667 | 05:23:54 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.80 Median:181.00 stddev:29.69 (16.4%) stddev-sans-first:30.87 05:23:54 INFO - PROCESS | 1667 | Values: 170.0 167.0 163.0 192.0 167.0 168.0 163.0 205.0 243.0 230.0 05:23:54 INFO - PROCESS | 1667 | 05:23:54 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.10 Median:85.00 stddev:11.66 (13.7%) stddev-sans-first:10.64 05:23:54 INFO - PROCESS | 1667 | Values: 97.0 88.0 88.0 64.0 79.0 86.0 71.0 60.0 84.0 84.0 05:23:54 INFO - PROCESS | 1667 | -------- Summary: end -------- 05:23:54 INFO - PROCESS | 1667 | 05:23:55 INFO - TEST-INFO | 1667: exit 0 05:23:55 INFO - TEST-OK | kraken | took 60702ms 05:23:55 INFO - SUITE-END | took 1173s 05:23:55 INFO - Completed test suite (00:19:33) 05:23:55 INFO - javascript benchmark 05:23:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7404.460365984449, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2782.65216847894, 3407.710344620707, 3471.756977011609, 3472.756907016508, 3488.2674638325934, 5897.233359663243, 5912.674802885845, 5947.524198064155, 6029.216201893759, 6053.6065155764845, 5750.7699692012375, 5886.705664716768, 5934.88130237395, 5971.940280597193, 6040.788572399967, 5290.259363689087, 5326.121190003664, 5411.431799661018, 5439.265699130626, 5452.963936851986, 135.95487053603037, 5337.0, 5410.513053825155, 5424.674519528841, 5457.426970168135, 4624.44506659203, 4872.537108974641, 5383.784648614051, 5400.540954018894, 5507.834764957058, 5252.921206181911, 5372.973135134299, 5411.512963833274, 5450.781968721247, 5468.28912241406, 4383.956160438419, 4443.400140980959, 5252.606054545924, 5328.6269961102735, 5333.093374126369, 4475.440569928759, 5355.839324820262, 5413.729313534347, 5905.0, 5929.495992840613, 4360.280553708634, 6262.812115636492, 6323.7786677466065, 6341.2707538633185, 6348.0477928310665, 6290.0, 6392.584482008655, 6417.005364168562, 6418.19772528434, 6423.100765892778, 5605.915911261334, 5613.0, 6114.5064001751625, 6118.556367312526, 6141.877162456771, 6248.562600618004, 6335.3981371769605, 6385.584936979081, 6490.318516555788, 6497.480201583862, 6240.937590624127, 6257.906131408033, 6258.874822503524, 6262.6868656566985, 6273.807976484453, 6310.968445157745, 6325.652089135142, 6341.968290158519, 6375.936240637534, 6390.297067322591, 6157.9384206158265, 6247.187865577536, 6254.186955695822, 6299.370062993664, 6331.081993110973, 6178.165947597106, 6207.751689932352, 6236.251649802053, 6248.843778905563, 6275.6862156891975, 5086.313347698014, 5115.437301896788, 5125.15434953236, 5125.897482050413, 5131.692098474104, 4544.136614043321, 4560.201964656172, 4560.293154561048, 4664.230401983635, 4685.0395668887795, 6057.3336932937345, 6113.602615829956, 6134.0, 6147.508199344042, 6148.1392605035335, 6395.648239346788, 6405.935940640534, 6410.55126141175, 6411.198600174978, 6417.582857114273, 5905.350411454737, 6026.397360264026, 6049.485793707584, 6107.114468402056, 6154.692265386713, 5555.0, 5628.859278517988, 5629.4652008059165, 5644.407337229614, 5648.068068768607, 6263.4362907338555, 6544.607323560602, 6606.471482281406, 6607.669616519155, 6610.843102457051, 6253.812385628438, 6271.9686401569525, 6319.873602527831, 6405.391487808651, 6416.550841441054, 6494.740210391531, 6557.868842623217, 6560.40956313934, 6588.4399826013405, 6594.505412094208, 6200.56596038273, 6228.875422491616, 6334.429901308904, 6346.238451385863, 6354.332795056453, 6238.282597501346, 6245.687715614292, 6374.458171055512, 6379.266384365857, 6389.616623002635, 5755.568332375173, 6130.816075517741, 6164.3835616438, 6290.937090629035, 6291.307956124914, 5002.974985125051, 6142.775043102407, 6191.535634827316, 6260.311365749672, 6290.685465726604, 5981.3420523743225, 6069.635821850703, 6114.969425152845, 6131.0296614402, 6148.985417406078, 5256.369235691742, 6188.876222475616, 6201.790495983396, 6206.627602343874, 6242.656653883898, 6074.058520929263, 6116.8776624468155, 6120.20334290948, 6144.477719393902, 6175.413335733098], "value": 5763.725107852186, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.3833017077798, 514.4855144855145, 516.161237988269, 518.134715025907, 519.1252739134559, 38146.61853381465, 39830.40254396179, 40999.18001639969, 41058.79470602646, 41144.58855411445, 41525.58474415263, 41817.58182418175, 41853.372199417034, 42242.57757422425, 42334.0, 9623.855642165374, 9662.661806836762, 9773.951130244339, 9780.364276322052, 9800.558974846113, 9627.229821614254, 9666.854997175013, 9708.0, 9717.757056073584, 9753.122219000288, 9700.0, 9721.0, 9730.951345243264, 9738.318317717763, 9762.170215531689, 9631.711048668587, 9638.566264518078, 9688.321817472779, 9708.854367184498, 9713.70858874235, 9534.570944307523, 9601.615935362646, 9623.56693948774, 9647.276454265959, 9722.805543889082, 39288.8213353597, 39888.20223595512, 40183.0, 40277.99305017369, 40522.59477405217, 2882.437924604703, 2895.5946167536563, 3156.2425017995515, 3389.13842384648, 3478.339115568034, 29141.41717165645, 29312.03894439168, 30510.84744576285, 30547.389052219052, 31707.84146079278, 3160.5575219469292, 3169.5087261474278, 3173.3177366866003, 3184.7611429142676, 3278.1476816027766, 453731.0, 455119.7244013792, 458493.9999999967, 459541.0, 459763.0, 32418.837905810793, 33118.006459806245, 33500.83249583736, 33509.32981340408, 33626.0, 34437.65562344395, 34651.78718744832, 34907.650923490946, 35381.82309088438, 35852.46221306682, 16502.0, 16562.0, 16688.499345019667, 16693.83306166923, 16702.91648541774, 12515.749685006249, 12650.240985540897, 12666.556670516671, 12732.490700372067, 12768.553100641433, 18957.43127706171, 19364.225430982886, 19370.56649015897, 19403.320883769, 19577.216911323387, 6529.15121034272, 6588.637624930579, 6729.966350168218, 7613.885791713129, 7747.573883436352, 866.7399780065955, 973.4791886340915, 1063.1919740996898, 1079.4440862955585, 1133.070881876853, 29001.709982900324, 30393.24016899595, 30560.0, 31119.222019449244, 31219.84390078035, 1044.1333693034762, 1045.7019749371393, 1127.4757237884423, 1134.773045390925, 1140.1676775953601, 15910.124943128008, 15944.123073231083, 16067.0, 16254.837451625568, 16322.939008964378, 588520.0, 684395.0, 690107.0, 691902.161956758, 698988.0, 50035.24947125796, 59734.0, 59837.0, 60555.0, 60591.69704151539, 1091.3670071358592, 1355.8508564057945, 1357.728454309142, 1358.7690092684268, 1361.4418088583634, 30440.695593043787, 30624.468776560636, 30659.846700766353, 31113.844430777703, 31265.374692505568, 44709.776451117534, 45835.77082114568, 45956.7702161487, 46031.38890138829, 46311.536884630725, 593627.0318648379, 596669.0, 597111.0, 597573.0, 598225.0, 27205.72794272032, 27596.0, 27844.721552784213, 28866.711332886403, 28893.711062889102, 47699.284510731675, 48829.51170488392, 49073.75463122661, 49075.0, 49203.0, 39970.0, 40567.1886562273, 41029.1794164121, 41143.0, 41215.79392103021, 40663.1867362657, 40721.38917916174, 40854.1829163421, 41411.1717765637, 41751.79124104482, 38090.42864357092, 39236.80381598074, 39244.80377598094, 39376.606233937295, 39476.81569552918, 33262.0, 34586.654133458345, 35344.82327588346, 35407.0, 35462.82268588641, 25614.0, 25841.966321346936, 25961.350966225997, 26185.476290474464, 26409.20772376832], "value": 19475.1431746067, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.9239682112338, 377.2022173103885, 384.1241968312248, 394.57583098169437, 400.85969910531315, 17374.47876563702, 18506.53733656659, 21391.786082139173, 21402.357929262107, 21436.785632143674, 20380.490487737814, 20493.282735104276, 21381.251656192035, 21461.67807482885, 21534.89232553835, 5524.917126243089, 5818.836232753466, 5874.236349274588, 5894.852628684274, 6040.426159514839, 5981.671008094553, 5985.862686089651, 6018.608790428608, 6030.306514750816, 6040.48655864252, 5782.421757824226, 5820.185174075633, 5863.061910094386, 5962.821115366546, 5973.820785376424, 5721.656700597978, 5872.471477567039, 5874.823755287327, 5913.7338819752995, 5966.16473693681, 5155.510226528474, 5156.587473002151, 5165.612579056586, 5170.844874653766, 5181.663191892515, 26287.60568591473, 26403.0, 26520.204393868215, 26819.73180268192, 26831.86584067067, 2489.153687746175, 2508.4606809536035, 2693.245891150481, 2809.157252824165, 3160.2573395252098, 11860.762784744256, 12318.322492262922, 15040.924795375953, 15905.284262208228, 15950.202489875459, 1794.9551261218444, 1872.7565416495768, 1902.0, 1929.170456703617, 1948.2109745553073, 108488.0, 114520.0, 116330.0, 116807.66384672344, 117253.41373293164, 8745.781355466037, 10438.112760415297, 11067.944660276647, 11152.609658661908, 11479.598214062467, 13486.595402137951, 13583.932080339535, 13624.04631675793, 13626.182429054288, 13648.454061837416, 7205.7838264852135, 8499.490030598185, 8651.913480865236, 8720.520371379635, 8771.517566533901, 8684.652613895374, 8760.737177884546, 8770.868436973451, 8805.16350946659, 8896.466212027299, 6795.490338224653, 6873.656317184121, 6946.16646002483, 6949.722011119599, 6961.721531138799, 1799.6130831870948, 1845.870789044754, 1846.759921210234, 1850.0472256787766, 1853.6107417442217, 969.6557722008727, 980.0983095552109, 984.675057231112, 1019.3679918450608, 1089.2593036734938, 21990.120395184334, 22593.2092376766, 22602.886985565296, 22749.0, 22798.088076476753, 978.3640633588083, 1024.5645600619707, 1028.3983869436313, 1055.2454994678842, 1055.266589720137, 9205.263578913671, 10153.796924061477, 11493.367864767519, 11717.531298748125, 11912.404379780975, 589434.0, 595828.0417195859, 609944.0, 622966.0, 629990.0, 72183.27816721871, 75350.86973695399, 112314.43842780734, 119855.8014419862, 120689.0, 754.3399525415261, 986.659602437158, 1012.316686236802, 1031.4017869635593, 1053.0995998421392, 15353.0, 17031.744523831905, 19476.513087172934, 20216.595668086262, 20278.391648250577, 53233.20150197828, 53973.0, 54901.0, 55107.62230944259, 55848.60378490408, 81054.0, 81603.18396816193, 81970.0, 82272.3545529098, 82486.58756706178, 8200.0979892213, 8284.544350060805, 8490.533020683923, 8532.70135545253, 8534.914650853412, 12640.936795315965, 13464.124831885896, 13533.796993044914, 13562.932185339405, 13577.52478663242, 11293.37886416255, 11321.320720756781, 11576.942115289707, 11614.477348519167, 11738.471768770596, 11446.313221206754, 11459.713507162387, 11509.36698481558, 11619.360935148648, 11641.941790290994, 11869.762604747684, 11898.821517677416, 12012.579559715718, 12032.518699252281, 12045.51817927273, 7003.6498175092065, 7437.5496778127745, 7496.7750967471065, 8290.58547072656, 8535.31717462589, 8390.370722195737, 10759.0, 11659.591914283299, 11682.824757628812, 11824.527018919147], "value": 9846.966054639204, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1501.4819887138938, 1533.5935976966107, 1703.4974682468671, 1733.523281097698, 1850.740896274521, 7913.525188488695, 8466.111058338878, 8546.40175187737, 8983.146601072904, 9001.549922503882, 8559.887214662102, 8723.127687231274, 8739.825203495926, 8753.037165911745, 8761.518116503607, 2293.140072472823, 2347.835651504395, 2366.597678394677, 2366.645003249509, 2370.1349007612184, 2306.884655767213, 2337.9766202338014, 2366.857988520694, 2366.893489792955, 2373.371056669975, 2308.884555772213, 2341.1103780563362, 2345.85924844509, 2348.6007378745653, 2359.5988681924114, 2300.9884950575306, 2333.428310064028, 2347.14329269817, 2349.5653304138705, 2352.094443639194, 2329.324495896188, 2332.4402143485613, 2337.0418128567208, 2338.777816107467, 2341.3444235614056, 8845.425047371964, 8851.247643950208, 8899.37704360695, 8910.688125915562, 8946.194842464145, 5157.613179011551, 5252.947470525284, 5290.761915713802, 5343.0, 5347.278117454132, 3581.7850928944345, 3650.0509867434657, 3675.228202077567, 3700.0379901225874, 3717.8141092945516, 1053.936763794167, 1062.4156713807374, 1077.854489643896, 1091.0671375973507, 1093.059968427152, 9355.578998944995, 9851.261155413373, 10978.615748448847, 11449.484773185226, 11691.88308116925, 3637.5089362936196, 4018.457508236409, 4592.380028696083, 4738.1708201064675, 4753.5959443447, 9801.558929848174, 9903.25725570585, 9934.602615895283, 9967.501624918725, 9976.05227503386, 5325.600579956519, 5357.4106848246665, 5370.9731451342495, 5378.1663842104535, 5383.865403364947, 4399.714018588846, 4735.739534325645, 4874.6344024197615, 4886.95113048865, 4902.166631672624, 3862.5364956205435, 3930.9213815724097, 3994.3409337459575, 4005.3991901214467, 4036.798160091984, 1250.2560976219136, 1260.5147018397984, 1261.8233447317382, 1274.8342715447118, 1277.5145444730942, 819.6967122164718, 827.611022819274, 880.8282384934876, 905.6015353244551, 918.9724308270762, 5664.320281566238, 5844.795432159854, 5903.321118071477, 5944.138099975479, 6037.909431358533, 419.9643030342455, 426.04990870358654, 426.5585119401405, 428.3510481620348, 446.5757530346184, 3962.2754610666457, 4046.4941882264716, 4062.1469491407133, 4063.8981443319703, 4096.1193343431305, 10326.277160598836, 10636.734081648021, 10829.296095753909, 10843.078338341329, 10871.858454862126, 10780.191485638608, 10791.298565593212, 10802.027817496462, 10806.0, 10827.07969822574, 7791.4156438267355, 8184.877226841602, 8201.097879233279, 8244.876326855101, 8258.463199891989, 6065.8180254592435, 6071.332153463204, 6080.939190608037, 6183.659898705614, 6232.127502149793, 7518.28576285252, 10024.498775061364, 10250.743731406774, 10279.897201027894, 10291.94854025755, 10016.599336026477, 10139.9860013998, 10393.921215756727, 10408.063274305348, 10412.843807343048, 6912.0, 7346.5592064476305, 7484.925150748641, 7630.8092297693, 7662.693492260247, 8511.489310641382, 8514.70198543048, 8601.096884827002, 8619.094995025433, 8623.611937462703, 7431.739889104072, 7526.774196774106, 7567.054118235221, 7613.923860761543, 7662.923370766444, 7371.299726525972, 7406.925930740839, 7466.141393739789, 7480.625968701652, 7588.165301816685, 7063.328983746535, 7087.0, 7115.288471152843, 7130.42956563484, 7139.0, 4902.1911384621135, 5040.49595040493, 5082.644214904921, 5093.847184584469, 5096.955124199604, 5031.245313203049, 5058.747062646779, 5111.386633603991, 5151.871203219949, 5250.501202385767], "value": 4497.556241896747, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.6179775280899, 308.158726676174, 309.44918045878336, 309.7552933182786, 314.7670723664486, 4938.493759403385, 5014.849554513361, 5176.948230517693, 5762.884742305151, 5797.913031304523, 4898.608111351093, 5655.802046928358, 5671.865626874631, 5693.28833895763, 5699.943000569993, 3445.3626079175306, 3769.1519408133227, 4095.856645017425, 4154.729942553739, 4258.44640196774, 3342.9971008697416, 3534.876279330224, 3969.2656858481128, 4211.8525851595205, 4224.0, 4256.787160641971, 4258.127083947783, 4282.357646353041, 4287.549807270223, 4288.849890253841, 4144.854930077433, 4183.4818396132405, 4238.512571054337, 4254.319308910591, 4269.5943885331, 3467.843947022365, 3637.1814092953523, 3676.7058635309113, 3699.408094704861, 3706.0, 4777.710018295041, 5272.971770504753, 5398.865028374283, 5544.584156188302, 5547.805826796042, 3644.817759112034, 4478.544473046273, 4797.529272424669, 4894.877628059291, 4964.354633897607, 5621.353544342412, 5913.113033045035, 5948.750762339914, 6008.218931538916, 6046.727897244635, 3315.96684033159, 3974.324364857981, 4001.9399709004388, 4004.0, 4024.8993775155564, 5274.973625131888, 5473.616846820724, 5804.9260886735665, 6207.34822843604, 6279.398753317921, 3333.799972001688, 3996.620321069494, 4010.57888921659, 4011.7191796574543, 4044.6157615027114, 4054.655354294859, 4088.6115818997146, 4098.303288440972, 4109.383592461095, 4110.588211784212, 4095.85664501747, 4100.958990410118, 4133.441985332001, 4588.128255631419, 4842.757862106881, 6031.6175110831855, 6047.758089676364, 6053.878922421615, 6076.055662188058, 6121.908171377433, 1169.9119818568643, 1255.0210835548287, 1388.3266615691382, 1417.3551034279585, 1431.6277767780452, 683.4156795939499, 717.8944425584646, 723.7539236659561, 846.6020970144023, 904.6064961741663, 5503.862403439866, 5530.50676317392, 5552.694601796859, 5575.69333686643, 5580.665160090326, 4674.041821426599, 5348.304720386325, 5705.315362156568, 5797.593998490664, 6160.229971253593, 3984.2270189765277, 5214.504622060898, 5388.551327150627, 5482.122860342326, 5554.833354999276, 2669.8531580763242, 2691.7483370232935, 3046.6953304669355, 3215.276562773404, 3238.3523295341024, 5046.394432668103, 5819.53443724501, 6026.849328766728, 6307.4954003679595, 6341.175647165839, 5955.196048533479, 6151.5386346024225, 6266.937330626635, 6272.0, 6275.278342990523, 5266.394364648115, 6283.151774510566, 6288.811335659938, 6331.810045698544, 6334.239891212992, 5486.369067557282, 5960.314563825215, 5972.432618901197, 6116.981396139175, 6118.296395914349, 5216.105061690798, 5310.575153987749, 5842.393341831031, 5952.285725712942, 6079.1793107931635, 5504.036793561191, 5956.404359564182, 6023.879522409439, 6209.937900620936, 6354.8093557191505, 4018.8699989005872, 4038.990252436891, 4040.555538890661, 4041.2927737645205, 4050.5746896576616, 5733.541316694738, 5969.4627483524955, 6246.281677606951, 6254.687265636609, 6274.23933469272, 4951.282064100613, 5485.862853428696, 5995.730192141277, 6072.332043475126, 6149.907751383644, 4839.516048395132, 5749.8275051748515, 6034.396560344106, 6076.0, 6175.3515880831865, 4942.703437793743, 5734.569907256889, 5894.911576326444, 5931.911021334769, 6005.528645481885, 5092.337996060636, 5896.616719913192, 5922.407759224043, 6026.487748541423, 6120.571559990758, 4766.808297925519, 4933.851984440473, 5587.407588837162, 6002.249718785152, 6035.336113027475], "value": 4243.234620855149, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.9758158464455, 696.9546979446336, 706.3254591864772, 761.7828918758155, 775.5734346109638, 13874.236916969588, 15007.924960375196, 15565.766513502307, 15595.90828641994, 15627.14050727211, 13998.300084995735, 14101.717965640706, 14114.223717695522, 14130.081544699613, 14134.64663383416, 667.3426674725391, 802.743122200896, 815.975520734379, 844.1684940333766, 851.9233269005788, 684.9006894000366, 822.5352675738219, 829.6805729794042, 829.7966998085448, 835.0897521701345, 750.8549462070332, 868.9739307820776, 877.6840337478502, 894.4052205283479, 896.8699538566904, 750.5609218607121, 861.51324501657, 888.959996800139, 889.4263200235844, 890.5725251879102, 566.8526183192358, 633.768674433833, 647.9449246814027, 653.0139489371084, 660.7885476647475, 12832.615021549369, 14108.647283817883, 14126.92936535321, 14536.781948270784, 14542.70914581713, 12965.546205882843, 14368.856311436857, 14372.49696260626, 14391.992560520768, 14408.0, 11084.944575277153, 11823.290602563788, 12049.457774400085, 12202.023838092931, 12229.082818788538, 3764.4729737836724, 3825.8469661213517, 3904.6876249899938, 4022.1352409232154, 4047.959520404788, 104123.4793826026, 105150.47424762904, 106425.0, 106668.0, 106922.93077069208, 10719.249652524248, 10987.39569323679, 11156.832647510293, 11164.330140191614, 11201.383923884101, 22486.550268994528, 22493.55012899733, 22498.0, 22525.43686407853, 22573.661395079085, 7807.570583617842, 7838.020247469067, 7975.800604984922, 8125.674973001013, 8287.709930152416, 4452.398926144929, 4480.843170489017, 4521.547845215452, 4545.431821022372, 4628.375169352094, 3238.5951756030495, 3463.740219483549, 3476.9826150869085, 3544.468329750558, 3877.0695033191832, 720.045939130654, 723.3815088099705, 731.6085894046765, 733.5708610462939, 739.8520295940833, 557.7880405445985, 668.5253470036329, 668.8160755792196, 696.8571442854203, 698.2260879943912, 9091.772705682411, 9393.107654772786, 9430.764230894283, 9604.567794449267, 9669.129937977525, 585.9938515415975, 639.268038096377, 640.193356370976, 640.9230892292954, 675.601395176848, 4407.2507673695545, 4462.955370446319, 4596.931046034312, 4757.286407038902, 4987.451380348159, 131563.3421832904, 140664.0, 150627.0, 154259.68610470628, 156796.0, 117863.821361787, 131955.0, 132800.0, 136482.0, 139697.30151349382, 94029.52985235167, 113592.43203784093, 116073.0, 118173.40913295551, 118804.40597797128, 8589.269912057545, 9771.583120447638, 9778.992573232556, 9834.950825245827, 10048.39709617396, 53571.46428535665, 54989.72505137449, 56039.71980140073, 58383.0, 60611.09083363841, 84508.73236901575, 85939.14060859561, 87205.69191462007, 87937.0, 95880.52059739656, 13030.0, 13080.73838523205, 13103.21380717122, 13128.934355328161, 13658.590242292747, 14526.0, 14703.191324477257, 15231.238438078273, 15251.923740381228, 15461.458848940232, 13581.796273055714, 13894.444222230997, 13972.930135349257, 14168.43326266979, 14428.0, 13710.451581936612, 13741.656458588615, 13760.449582016607, 14203.147811131365, 14377.928110359382, 13193.472261109448, 13786.241756703077, 14194.574162775134, 14335.856641433453, 14354.0, 11097.99879499454, 11221.60724374643, 11390.25963312382, 11461.484233209692, 12350.75298494007, 10222.744431388977, 11045.226834121535, 11081.206127149762, 11294.378809165246, 11612.245204061708], "value": 7811.890351772314, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1601.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 166.0, 122.0, 116.0, 164.0, 96.0, 140.0, 167.0, 169.0, 116.0], "value": 136.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 141.0, 159.0, 150.0, 112.0, 126.0, 128.0, 109.0, 157.0, 109.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 196.0, 232.0, 272.0, 200.0, 197.0, 193.0, 191.0, 198.0, 193.0], "value": 206.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 81.0, 94.0, 178.0, 86.0, 83.0, 60.0, 59.0, 127.0, 58.0], "value": 89.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 74.0, 119.0, 66.0, 69.0, 93.0, 114.0, 104.0, 105.0, 148.0], "value": 99.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 85.0, 85.0, 87.0, 85.0, 90.0, 87.0, 89.0, 87.0], "value": 87.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 95.0, 95.0, 150.0, 123.0, 95.0, 97.0, 100.0, 96.0, 96.0], "value": 104.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 133.0, 92.0, 94.0, 92.0, 89.0, 92.0, 91.0, 90.0, 89.0], "value": 100.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 55.0, 57.0, 58.0, 57.0, 57.0, 57.0, 58.0, 56.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 70.0, 69.0, 103.0, 70.0, 89.0, 62.0, 88.0, 105.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 84.0, 83.0, 93.0, 86.0, 82.0, 88.0, 90.0, 107.0], "value": 88.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 146.0, 149.0, 149.0, 150.0, 175.0, 153.0, 163.0, 148.0, 132.0], "value": 148.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 167.0, 163.0, 192.0, 167.0, 168.0, 163.0, 205.0, 243.0, 230.0], "value": 186.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 88.0, 88.0, 64.0, 79.0, 86.0, 71.0, 60.0, 84.0, 84.0], "value": 80.1, "unit": "score"}]}]} 05:23:55 INFO - Return code: 0 05:23:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:23:55 ERROR - # TBPL SUCCESS # 05:23:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:23:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:23:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:23:55 INFO - 2016-06-30 05:23:55.766 screenresolution[1672:11244] starting screenresolution argv=screenresolution get 05:23:55 INFO - 2016-06-30 05:23:55.768 screenresolution[1672:11244] Display 0: 1600x1200x32@60 05:23:55 INFO - 2016-06-30 05:23:55.775 screenresolution[1673:11247] starting screenresolution argv=screenresolution list 05:23:55 INFO - Available Modes on Display 0 05:23:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:23:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:23:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:23:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:23:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:23:56 INFO - Intel Iris: 05:23:56 INFO - Chipset Model: Intel Iris 05:23:56 INFO - Type: GPU 05:23:56 INFO - Bus: Built-In 05:23:56 INFO - VRAM (Dynamic, Max): 1536 MB 05:23:56 INFO - Vendor: Intel (0x8086) 05:23:56 INFO - Device ID: 0x0a2e 05:23:56 INFO - Revision ID: 0x0009 05:23:56 INFO - Displays: 05:23:56 INFO - Display: 05:23:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:23:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:23:56 INFO - Display Serial Number: 1600x1200 60 05:23:56 INFO - Main Display: Yes 05:23:56 INFO - Mirror: Off 05:23:56 INFO - Online: Yes 05:23:56 INFO - Rotation: Supported 05:23:56 INFO - Return code: 0 05:23:56 INFO - Running post-action listener: _resource_record_post_action 05:23:56 INFO - ##### 05:23:56 INFO - ##### Finished run-tests step (success) 05:23:56 INFO - ##### 05:23:56 INFO - Running post-run listener: _resource_record_post_run 05:23:56 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 32714240; Write bytes: 709722624; Read time: 322; Write time: 1991 05:23:56 INFO - TinderboxPrint: CPU usage
54.2% 05:23:56 INFO - TinderboxPrint: I/O read bytes / time
32,714,240 / 322 05:23:56 INFO - TinderboxPrint: I/O write bytes / time
709,722,624 / 1,991 05:23:56 INFO - TinderboxPrint: CPU idle
2,215.9 (45.8%) 05:23:56 INFO - TinderboxPrint: CPU system
979.9 (20.3%) 05:23:56 INFO - TinderboxPrint: CPU user
1,641.9 (33.9%) 05:23:56 INFO - TinderboxPrint: Swap in / out
436,371,456 / 0 05:23:56 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 385899008; Write bytes: 379917824; Read time: 29035; Write time: 777 05:23:56 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 31796736; Write bytes: 299260928; Read time: 309; Write time: 1157 05:23:56 INFO - Running post-run listener: _upload_blobber_files 05:23:56 INFO - Blob upload gear active. 05:23:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:23:56 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 05:23:56 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:23:56 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:23:56 INFO - (blobuploader) - INFO - Open directory for files ... 05:23:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:23:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:23:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:23:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:23:57 INFO - (blobuploader) - INFO - Done attempting. 05:23:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:23:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:23:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:23:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:23:59 INFO - (blobuploader) - INFO - Done attempting. 05:23:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:23:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:24:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:01 INFO - (blobuploader) - INFO - Done attempting. 05:24:01 INFO - (blobuploader) - INFO - Iteration through files over. 05:24:01 INFO - Return code: 0 05:24:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:24:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:24:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cd805844df7d2df6c4110429fdf869238f53831a62970e2e70db5e779a41c751cd6404bce12639135669b0b2ed0da867f7a6425de4291df349d655f9bb7fe72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04256e4d843a1d485ca46165c7988c8733b26239a5fbdb9fc6a3ce56dd2e04a89071ada87ce80b3efa21f8573d2a949692d7cc1d24d61740de090b56dfe1e4b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f067ddec3312e26d48f622db8cdc25011b1d3daec5ef7a4dadd58239b6067a5fa8e4f5066cf19ac603298b121d2120dbda2a76a7343b087c0062363033936de"} 05:24:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:24:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:24:01 INFO - Contents: 05:24:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cd805844df7d2df6c4110429fdf869238f53831a62970e2e70db5e779a41c751cd6404bce12639135669b0b2ed0da867f7a6425de4291df349d655f9bb7fe72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04256e4d843a1d485ca46165c7988c8733b26239a5fbdb9fc6a3ce56dd2e04a89071ada87ce80b3efa21f8573d2a949692d7cc1d24d61740de090b56dfe1e4b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f067ddec3312e26d48f622db8cdc25011b1d3daec5ef7a4dadd58239b6067a5fa8e4f5066cf19ac603298b121d2120dbda2a76a7343b087c0062363033936de"} 05:24:01 INFO - Running post-run listener: copy_logs_to_upload_dir 05:24:01 INFO - Copying logs to upload dir... 05:24:01 INFO - mkdir: /builds/slave/test/build/upload/logs 05:24:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1293.071677 ========= master_lag: 0.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-06-30 05:24:02.155109) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 05:24:02.160096) ========= 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.rdOfFhqB3h/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.Xlr8TujcwX/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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/Firefox/sha512/5cd805844df7d2df6c4110429fdf869238f53831a62970e2e70db5e779a41c751cd6404bce12639135669b0b2ed0da867f7a6425de4291df349d655f9bb7fe72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04256e4d843a1d485ca46165c7988c8733b26239a5fbdb9fc6a3ce56dd2e04a89071ada87ce80b3efa21f8573d2a949692d7cc1d24d61740de090b56dfe1e4b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f067ddec3312e26d48f622db8cdc25011b1d3daec5ef7a4dadd58239b6067a5fa8e4f5066cf19ac603298b121d2120dbda2a76a7343b087c0062363033936de"} build_url:https://queue.taskcluster.net/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010977 build_url: 'https://queue.taskcluster.net/v1/task/YEaQ9hGzQLSY1Bz8cVI9LA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cd805844df7d2df6c4110429fdf869238f53831a62970e2e70db5e779a41c751cd6404bce12639135669b0b2ed0da867f7a6425de4291df349d655f9bb7fe72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04256e4d843a1d485ca46165c7988c8733b26239a5fbdb9fc6a3ce56dd2e04a89071ada87ce80b3efa21f8573d2a949692d7cc1d24d61740de090b56dfe1e4b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f067ddec3312e26d48f622db8cdc25011b1d3daec5ef7a4dadd58239b6067a5fa8e4f5066cf19ac603298b121d2120dbda2a76a7343b087c0062363033936de"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 05:24:02.201178) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:24:02.201521) ========= 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.rdOfFhqB3h/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.Xlr8TujcwX/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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.005153 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:24:02.250553) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 05:24:02.253912) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 05:24:02.254267) ========= ========= Total master_lag: 0.59 =========