builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0155 starttime: 1467291028.13 results: success (0) buildid: 20160630030207 builduid: 9f989df8752e4e2796a5e3c4faacb2c7 revision: d700dc054751333e0735f975fce3d3adf153c62a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 05:50:28.132450) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 05:50:28.132865) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 05:50:28.133133) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 05:50:28.263758) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:50:28.264011) ========= 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.HoNPEXiwIW/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.QjpQzfTNUn/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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:50:28-- 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% 13.2M=0.001s 2016-06-30 05:50:28 (13.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.447835 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:50:28.736052) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:50:28.736363) ========= 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.HoNPEXiwIW/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.QjpQzfTNUn/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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.028262 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:50:28.788088) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 05:50:28.788409) ========= 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.HoNPEXiwIW/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.QjpQzfTNUn/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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:50:28,873 truncating revision to first 12 chars 2016-06-30 05:50:28,873 Setting DEBUG logging. 2016-06-30 05:50:28,873 attempt 1/10 2016-06-30 05:50:28,873 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:50:29,648 unpacking tar archive at: mozilla-central-d700dc054751/testing/mozharness/ program finished with exit code 0 elapsedTime=1.047623 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 05:50:29.867541) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 05:50:29.868006) ========= script_repo_revision: d700dc054751333e0735f975fce3d3adf153c62a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 05:50:29.868560) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 05:50:29.868952) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 05:50:29.890366) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 20 secs) (at 2016-06-30 05:50:29.890678) ========= /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.HoNPEXiwIW/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.QjpQzfTNUn/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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:50:30 INFO - MultiFileLogger online at 20160630 05:50:30 in /builds/slave/test 05:50:30 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:50:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:50:30 INFO - {'append_to_log': False, 05:50:30 INFO - 'base_work_dir': '/builds/slave/test', 05:50:30 INFO - 'blob_upload_branch': 'Firefox', 05:50:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:50:30 INFO - 'branch': 'Firefox', 05:50:30 INFO - 'buildbot_json_path': 'buildprops.json', 05:50:30 INFO - 'config_files': ('talos/mac_config.py',), 05:50:30 INFO - 'default_actions': ('clobber', 05:50:30 INFO - 'read-buildbot-config', 05:50:30 INFO - 'download-and-extract', 05:50:30 INFO - 'populate-webroot', 05:50:30 INFO - 'create-virtualenv', 05:50:30 INFO - 'install', 05:50:30 INFO - 'run-tests'), 05:50:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:50:30 INFO - 'download_minidump_stackwalk': True, 05:50:30 INFO - 'download_symbols': 'ondemand', 05:50:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:50:30 INFO - 'tooltool.py': '/tools/tooltool.py', 05:50:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:50:30 INFO - '/tools/misc-python/virtualenv.py')}, 05:50:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:50:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:50:30 INFO - 'installer_path': 'installer.exe', 05:50:30 INFO - 'log_level': 'info', 05:50:30 INFO - 'log_name': 'talos', 05:50:30 INFO - 'log_to_console': True, 05:50:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:50:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:50:30 INFO - 'opt_config_files': (), 05:50:30 INFO - 'pip_index': False, 05:50:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:50:30 INFO - 'cmd': ('bash', 05:50:30 INFO - '-c', 05:50:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:50:30 INFO - 'enabled': True, 05:50:30 INFO - 'halt_on_failure': False, 05:50:30 INFO - 'name': 'check_screen_resolution'},), 05:50:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:50:30 INFO - 'cmd': ('bash', 05:50:30 INFO - '-c', 05:50:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:50:30 INFO - 'enabled': True, 05:50:30 INFO - 'halt_on_failure': False, 05:50:30 INFO - 'name': 'check_screen_resolution'},), 05:50:30 INFO - 'run_cmd_checks_enabled': True, 05:50:30 INFO - 'sps_profile': False, 05:50:30 INFO - 'sps_profile_interval': 0, 05:50:30 INFO - 'suite': 'dromaeojs-e10s', 05:50:30 INFO - 'system_bits': '32', 05:50:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:50:30 INFO - 'title': 't-yosemite-r7-0155', 05:50:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:50:30 INFO - 'use_talos_json': True, 05:50:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:50:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:50:30 INFO - 'work_dir': 'build'} 05:50:30 INFO - ##### 05:50:30 INFO - ##### Running clobber step. 05:50:30 INFO - ##### 05:50:30 INFO - Running pre-action listener: _resource_record_pre_action 05:50:30 INFO - Running main action method: clobber 05:50:30 INFO - rmtree: /builds/slave/test/build 05:50:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:50:32 INFO - Running post-action listener: _resource_record_post_action 05:50:32 INFO - ##### 05:50:32 INFO - ##### Finished clobber step (success) 05:50:32 INFO - ##### 05:50:32 INFO - ##### 05:50:32 INFO - ##### Running read-buildbot-config step. 05:50:32 INFO - ##### 05:50:32 INFO - Running pre-action listener: _resource_record_pre_action 05:50:32 INFO - Running main action method: read_buildbot_config 05:50:32 INFO - Using buildbot properties: 05:50:32 INFO - { 05:50:32 INFO - "project": "", 05:50:32 INFO - "product": "firefox", 05:50:32 INFO - "script_repo_revision": "production", 05:50:32 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:50:32 INFO - "repository": "", 05:50:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:50:32 INFO - "buildid": "20160630030207", 05:50:32 INFO - "stage_platform": "macosx64", 05:50:32 INFO - "basedir": "/builds/slave/test", 05:50:32 INFO - "nightly_build": "True", 05:50:32 INFO - "buildnumber": 31, 05:50:32 INFO - "slavename": "t-yosemite-r7-0155", 05:50:32 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 05:50:32 INFO - "platform": "yosemite_r7", 05:50:32 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:50:32 INFO - "branch": "mozilla-central", 05:50:32 INFO - "repo_path": "mozilla-central", 05:50:32 INFO - "revision": "d700dc054751333e0735f975fce3d3adf153c62a", 05:50:32 INFO - "pgo_build": "False", 05:50:32 INFO - "builduid": "9f989df8752e4e2796a5e3c4faacb2c7", 05:50:32 INFO - "slavebuilddir": "test" 05:50:32 INFO - } 05:50:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/RPHrugdRQNmFNTs9X7SJ6g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 05:50:32 INFO - Running post-action listener: _resource_record_post_action 05:50:32 INFO - ##### 05:50:32 INFO - ##### Finished read-buildbot-config step (success) 05:50:32 INFO - ##### 05:50:32 INFO - ##### 05:50:32 INFO - ##### Running download-and-extract step. 05:50:32 INFO - ##### 05:50:32 INFO - Running pre-action listener: _resource_record_pre_action 05:50:32 INFO - Running main action method: download_and_extract 05:50:32 INFO - mkdir: /builds/slave/test/build/tests 05:50:32 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:50:32 INFO - https://queue.taskcluster.net/v1/task/RPHrugdRQNmFNTs9X7SJ6g/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:50:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPHrugdRQNmFNTs9X7SJ6g/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 05:50:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPHrugdRQNmFNTs9X7SJ6g/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 05:50:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPHrugdRQNmFNTs9X7SJ6g/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:50:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPHrugdRQNmFNTs9X7SJ6g/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:51:02 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPHrugdRQNmFNTs9X7SJ6g/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json: timed out 05:51:02 INFO - retry: attempt #1 caught exception: timed out 05:51:02 INFO - retry: Failed, sleeping 30 seconds before retrying 05:51:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPHrugdRQNmFNTs9X7SJ6g/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 #2 05:51:35 INFO - Downloaded 1199 bytes. 05:51:35 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 05:51:35 INFO - Using the following test package requirements: 05:51:35 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 05:51:35 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:51:35 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 05:51:35 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:51:35 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 05:51:35 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:51:35 INFO - u'jsshell-mac.zip'], 05:51:35 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:51:35 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 05:51:35 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 05:51:35 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:51:35 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 05:51:35 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:51:35 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 05:51:35 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:51:35 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 05:51:35 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:51:35 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 05:51:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:51: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:51:35 INFO - https://queue.taskcluster.net/v1/task/RPHrugdRQNmFNTs9X7SJ6g/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:51:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPHrugdRQNmFNTs9X7SJ6g/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:51:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPHrugdRQNmFNTs9X7SJ6g/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:51:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPHrugdRQNmFNTs9X7SJ6g/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:51:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPHrugdRQNmFNTs9X7SJ6g/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:51:40 INFO - Downloaded 18788566 bytes. 05:51:40 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:51:40 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:51:43 INFO - Return code: 0 05:51:43 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:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:43 INFO - https://queue.taskcluster.net/v1/task/RPHrugdRQNmFNTs9X7SJ6g/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:51:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPHrugdRQNmFNTs9X7SJ6g/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:51:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPHrugdRQNmFNTs9X7SJ6g/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:51:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPHrugdRQNmFNTs9X7SJ6g/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:51:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPHrugdRQNmFNTs9X7SJ6g/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:51:52 INFO - Downloaded 18788566 bytes. 05:51:52 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:51:52 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:51:56 INFO - Return code: 0 05:51:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:51:56 INFO - https://queue.taskcluster.net/v1/task/RPHrugdRQNmFNTs9X7SJ6g/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:51:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPHrugdRQNmFNTs9X7SJ6g/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 05:51:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPHrugdRQNmFNTs9X7SJ6g/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 05:51:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPHrugdRQNmFNTs9X7SJ6g/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:51:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPHrugdRQNmFNTs9X7SJ6g/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:51:57 INFO - Downloaded 14405245 bytes. 05:51:57 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:51:57 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:51:57 INFO - Return code: 0 05:51:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:57 INFO - https://queue.taskcluster.net/v1/task/RPHrugdRQNmFNTs9X7SJ6g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:51:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPHrugdRQNmFNTs9X7SJ6g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:51:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPHrugdRQNmFNTs9X7SJ6g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:51:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPHrugdRQNmFNTs9X7SJ6g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 05:51:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPHrugdRQNmFNTs9X7SJ6g/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:52:03 INFO - Downloaded 112598632 bytes. 05:52:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RPHrugdRQNmFNTs9X7SJ6g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:52:03 INFO - mkdir: /builds/slave/test/properties 05:52:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:52:03 INFO - Writing to file /builds/slave/test/properties/build_url 05:52:03 INFO - Contents: 05:52:03 INFO - build_url:https://queue.taskcluster.net/v1/task/RPHrugdRQNmFNTs9X7SJ6g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:52:04 INFO - Running post-action listener: _resource_record_post_action 05:52:04 INFO - Running post-action listener: set_extra_try_arguments 05:52:04 INFO - ##### 05:52:04 INFO - ##### Finished download-and-extract step (success) 05:52:04 INFO - ##### 05:52:04 INFO - ##### 05:52:04 INFO - ##### Running populate-webroot step. 05:52:04 INFO - ##### 05:52:04 INFO - Running pre-action listener: _resource_record_pre_action 05:52:04 INFO - Running main action method: populate_webroot 05:52:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:52:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:52:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:52:04 INFO - '--tppagecycles', 05:52:04 INFO - '7'], 05:52:04 INFO - 'tests': ['tsvgm']}}, 05:52:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:52:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:52:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:52:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:52:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:52:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:52:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:04 INFO - 'talos_options': ['--disable-e10s'], 05:52:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:04 INFO - 'talos_options': ['--disable-e10s'], 05:52:04 INFO - 'tests': ['damp', 'tps']}, 05:52:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:04 INFO - 'tests': ['damp', 'tps']}, 05:52:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:52:04 INFO - 'tests': ['dromaeo_dom']}, 05:52:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:52:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:52:04 INFO - 'tests': ['basic_compositor_video']}, 05:52:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:52:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:52:04 INFO - 'tests': ['a11yr', 05:52:04 INFO - 'ts_paint', 05:52:04 INFO - 'tpaint', 05:52:04 INFO - 'sessionrestore', 05:52:04 INFO - 'sessionrestore_no_auto_restore', 05:52:04 INFO - 'tabpaint']}, 05:52:04 INFO - 'other-e10s': {'tests': ['a11yr', 05:52:04 INFO - 'ts_paint', 05:52:04 INFO - 'tpaint', 05:52:04 INFO - 'sessionrestore', 05:52:04 INFO - 'sessionrestore_no_auto_restore', 05:52:04 INFO - 'tabpaint']}, 05:52:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:52:04 INFO - 'ts_paint', 05:52:04 INFO - 'tpaint', 05:52:04 INFO - 'sessionrestore', 05:52:04 INFO - 'sessionrestore_no_auto_restore', 05:52:04 INFO - 'tabpaint']}, 05:52:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:52:04 INFO - 'ts_paint', 05:52:04 INFO - 'tpaint', 05:52:04 INFO - 'sessionrestore', 05:52:04 INFO - 'sessionrestore_no_auto_restore', 05:52:04 INFO - 'tabpaint']}, 05:52:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:52:04 INFO - 'tests': ['a11yr', 05:52:04 INFO - 'ts_paint', 05:52:04 INFO - 'tpaint', 05:52:04 INFO - 'sessionrestore', 05:52:04 INFO - 'sessionrestore_no_auto_restore', 05:52:04 INFO - 'tabpaint']}, 05:52:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:52:04 INFO - 'tests': ['a11yr', 05:52:04 INFO - 'ts_paint', 05:52:04 INFO - 'tpaint', 05:52:04 INFO - 'sessionrestore', 05:52:04 INFO - 'sessionrestore_no_auto_restore', 05:52:04 INFO - 'tabpaint']}, 05:52:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:52:04 INFO - 'tests': ['tsvgx', 05:52:04 INFO - 'tsvgr_opacity', 05:52:04 INFO - 'tart', 05:52:04 INFO - 'tscrollx', 05:52:04 INFO - 'cart']}, 05:52:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:52:04 INFO - 'tsvgr_opacity', 05:52:04 INFO - 'tart', 05:52:04 INFO - 'tscrollx', 05:52:04 INFO - 'cart']}, 05:52:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:04 INFO - 'talos_options': ['--disable-e10s'], 05:52:04 INFO - 'tests': ['tp5o']}, 05:52:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:04 INFO - 'tests': ['tp5o']}, 05:52:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:04 INFO - 'talos_options': ['--disable-e10s', 05:52:04 INFO - '--xperf_path', 05:52:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:04 INFO - 'tests': ['tp5n']}, 05:52:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:04 INFO - 'talos_options': ['--xperf_path', 05:52:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:04 INFO - 'tests': ['tp5n']}}, 05:52:04 INFO - 'talos.zip': {'path': '', 05:52:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:52:04 INFO - Running post-action listener: _resource_record_post_action 05:52:04 INFO - ##### 05:52:04 INFO - ##### Finished populate-webroot step (success) 05:52:04 INFO - ##### 05:52:04 INFO - ##### 05:52:04 INFO - ##### Running create-virtualenv step. 05:52:04 INFO - ##### 05:52:04 INFO - Running pre-action listener: _resource_record_pre_action 05:52:04 INFO - Running main action method: create_virtualenv 05:52:04 INFO - Creating virtualenv /builds/slave/test/build/venv 05:52:04 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:52:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:52:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:52:05 INFO - Using real prefix '/tools/python27' 05:52:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:52:05 INFO - Installing distribute.............................................................................................................................................................................................done. 05:52:08 INFO - Installing pip.................done. 05:52:08 INFO - Return code: 0 05:52:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:52:08 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:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:08 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:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:08 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 0x10cd38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfc0d9cd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc9cd30>, '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 0x10ca01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc94b20>, '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.HoNPEXiwIW/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.QjpQzfTNUn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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:52:08 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:52:08 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:52:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HoNPEXiwIW/Render', 05:52:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:08 INFO - 'HOME': '/Users/cltbld', 05:52:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:08 INFO - 'LOGNAME': 'cltbld', 05:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:08 INFO - 'MOZ_NO_REMOTE': '1', 05:52:08 INFO - 'NO_EM_RESTART': '1', 05:52:08 INFO - 'PAGER': '/bin/cat', 05:52:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:08 INFO - 'PWD': '/builds/slave/test', 05:52:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:08 INFO - 'SHELL': '/bin/bash', 05:52:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QjpQzfTNUn/Listeners', 05:52:08 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 05:52:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:08 INFO - 'USER': 'cltbld', 05:52:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:08 INFO - 'XPC_FLAGS': '0x0', 05:52:08 INFO - 'XPC_SERVICE_NAME': '0', 05:52:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:08 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:52:08 INFO - Cleaning up... 05:52:08 INFO - Return code: 0 05:52:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:52:08 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:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:08 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:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:08 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 0x10cd38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfc0d9cd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc9cd30>, '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 0x10ca01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc94b20>, '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.HoNPEXiwIW/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.QjpQzfTNUn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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:52:08 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:52:08 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:52:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HoNPEXiwIW/Render', 05:52:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:08 INFO - 'HOME': '/Users/cltbld', 05:52:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:08 INFO - 'LOGNAME': 'cltbld', 05:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:08 INFO - 'MOZ_NO_REMOTE': '1', 05:52:08 INFO - 'NO_EM_RESTART': '1', 05:52:08 INFO - 'PAGER': '/bin/cat', 05:52:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:08 INFO - 'PWD': '/builds/slave/test', 05:52:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:08 INFO - 'SHELL': '/bin/bash', 05:52:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QjpQzfTNUn/Listeners', 05:52:08 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 05:52:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:08 INFO - 'USER': 'cltbld', 05:52:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:08 INFO - 'XPC_FLAGS': '0x0', 05:52:08 INFO - 'XPC_SERVICE_NAME': '0', 05:52:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:09 INFO - Downloading/unpacking psutil>=3.1.1 05:52:09 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:52:09 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:52:09 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:52:09 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:52:09 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:52:09 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:52:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:52:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:12 INFO - Installing collected packages: psutil 05:52:12 INFO - Running setup.py install for psutil 05:52:12 INFO - building 'psutil._psutil_osx' extension 05:52:12 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:52:12 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:52:12 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:52:12 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:52:13 INFO - building 'psutil._psutil_posix' extension 05:52:13 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:52:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:52:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:52:13 INFO - ^ 05:52:13 INFO - 1 warning generated. 05:52:13 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:52:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:13 INFO - Successfully installed psutil 05:52:13 INFO - Cleaning up... 05:52:13 INFO - Return code: 0 05:52:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfc0d9cd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc9cd30>, '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 0x10ca01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc94b20>, '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.HoNPEXiwIW/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.QjpQzfTNUn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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:52:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:52:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:52:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HoNPEXiwIW/Render', 05:52:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:13 INFO - 'HOME': '/Users/cltbld', 05:52:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:13 INFO - 'LOGNAME': 'cltbld', 05:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:13 INFO - 'MOZ_NO_REMOTE': '1', 05:52:13 INFO - 'NO_EM_RESTART': '1', 05:52:13 INFO - 'PAGER': '/bin/cat', 05:52:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:13 INFO - 'PWD': '/builds/slave/test', 05:52:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:13 INFO - 'SHELL': '/bin/bash', 05:52:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QjpQzfTNUn/Listeners', 05:52:13 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 05:52:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:13 INFO - 'USER': 'cltbld', 05:52:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:13 INFO - 'XPC_FLAGS': '0x0', 05:52:13 INFO - 'XPC_SERVICE_NAME': '0', 05:52:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:52:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:52:16 INFO - Installing collected packages: mozsystemmonitor 05:52:16 INFO - Running setup.py install for mozsystemmonitor 05:52:16 INFO - Successfully installed mozsystemmonitor 05:52:16 INFO - Cleaning up... 05:52:16 INFO - Return code: 0 05:52:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:52:16 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:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:16 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:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:16 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 0x10cd38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfc0d9cd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc9cd30>, '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 0x10ca01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc94b20>, '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.HoNPEXiwIW/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.QjpQzfTNUn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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:52:16 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:52:16 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:52:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HoNPEXiwIW/Render', 05:52:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:16 INFO - 'HOME': '/Users/cltbld', 05:52:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:16 INFO - 'LOGNAME': 'cltbld', 05:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:16 INFO - 'MOZ_NO_REMOTE': '1', 05:52:16 INFO - 'NO_EM_RESTART': '1', 05:52:16 INFO - 'PAGER': '/bin/cat', 05:52:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:16 INFO - 'PWD': '/builds/slave/test', 05:52:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:16 INFO - 'SHELL': '/bin/bash', 05:52:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QjpQzfTNUn/Listeners', 05:52:16 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 05:52:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:16 INFO - 'USER': 'cltbld', 05:52:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:16 INFO - 'XPC_FLAGS': '0x0', 05:52:16 INFO - 'XPC_SERVICE_NAME': '0', 05:52:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:16 INFO - Downloading/unpacking jsonschema==2.5.1 05:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:52:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:52: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:52: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:52: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:52: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:52: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:52: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:52:19 INFO - Downloading functools32-3.2.3-2.tar.gz 05:52:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:52:19 INFO - warning: no files found matching '*.txt' 05:52:19 INFO - no previously-included directories found matching 'build' 05:52:19 INFO - no previously-included directories found matching 'dist' 05:52:19 INFO - no previously-included directories found matching '.git*' 05:52:19 INFO - Installing collected packages: jsonschema, functools32 05:52:19 INFO - Running setup.py install for functools32 05:52:19 INFO - warning: no files found matching '*.txt' 05:52:19 INFO - no previously-included directories found matching 'build' 05:52:19 INFO - no previously-included directories found matching 'dist' 05:52:19 INFO - no previously-included directories found matching '.git*' 05:52:19 INFO - Successfully installed jsonschema functools32 05:52:19 INFO - Cleaning up... 05:52:19 INFO - Return code: 0 05:52:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:52: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:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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:52:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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', '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 0x10cd38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfc0d9cd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc9cd30>, '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 0x10ca01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc94b20>, '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.HoNPEXiwIW/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.QjpQzfTNUn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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:52: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:52: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 blobuploader==1.2.4 05:52:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HoNPEXiwIW/Render', 05:52:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:19 INFO - 'HOME': '/Users/cltbld', 05:52:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:19 INFO - 'LOGNAME': 'cltbld', 05:52:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:19 INFO - 'MOZ_NO_REMOTE': '1', 05:52:19 INFO - 'NO_EM_RESTART': '1', 05:52:19 INFO - 'PAGER': '/bin/cat', 05:52:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:19 INFO - 'PWD': '/builds/slave/test', 05:52:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:19 INFO - 'SHELL': '/bin/bash', 05:52:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QjpQzfTNUn/Listeners', 05:52:19 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 05:52:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:19 INFO - 'USER': 'cltbld', 05:52:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:19 INFO - 'XPC_FLAGS': '0x0', 05:52:19 INFO - 'XPC_SERVICE_NAME': '0', 05:52:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:20 INFO - Downloading/unpacking blobuploader==1.2.4 05:52:20 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:52:20 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:52:20 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:52:20 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:52:20 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:52:20 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:52:22 INFO - Downloading blobuploader-1.2.4.tar.gz 05:52:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:52:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:52:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:23 INFO - Downloading docopt-0.6.1.tar.gz 05:52:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:52:23 INFO - Installing collected packages: blobuploader, requests, docopt 05:52:23 INFO - Running setup.py install for blobuploader 05:52:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:52:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:52:23 INFO - Running setup.py install for requests 05:52:24 INFO - Running setup.py install for docopt 05:52:24 INFO - Successfully installed blobuploader requests docopt 05:52:24 INFO - Cleaning up... 05:52:24 INFO - Return code: 0 05:52:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52: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:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:24 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 0x10cd38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfc0d9cd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc9cd30>, '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 0x10ca01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc94b20>, '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.HoNPEXiwIW/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.QjpQzfTNUn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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:52:24 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:52:24 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:52:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HoNPEXiwIW/Render', 05:52:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:24 INFO - 'HOME': '/Users/cltbld', 05:52:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:24 INFO - 'LOGNAME': 'cltbld', 05:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:24 INFO - 'MOZ_NO_REMOTE': '1', 05:52:24 INFO - 'NO_EM_RESTART': '1', 05:52:24 INFO - 'PAGER': '/bin/cat', 05:52:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:24 INFO - 'PWD': '/builds/slave/test', 05:52:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:24 INFO - 'SHELL': '/bin/bash', 05:52:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QjpQzfTNUn/Listeners', 05:52:24 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 05:52:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:24 INFO - 'USER': 'cltbld', 05:52:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:24 INFO - 'XPC_FLAGS': '0x0', 05:52:24 INFO - 'XPC_SERVICE_NAME': '0', 05:52:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:52:24 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-zBBI4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:52:24 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-f3YPui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:52:25 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-szQJE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:52:25 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-0im10Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:52:25 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-sYYmCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:52:25 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-gBWg6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:52:25 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-26zCJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:52:25 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-GeSvmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:52:25 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-LEnbDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:52:25 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-Qiyxq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:52:25 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-3Yjp9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:52:26 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-kGCxIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:52:26 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-1vnqIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:52:26 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-jDaBE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:26 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-Zqd3eU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:52:26 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-gSJK75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:52:26 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-PeByNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:52:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:52:26 INFO - Running setup.py install for manifestparser 05:52:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:52:26 INFO - Running setup.py install for mozcrash 05:52:26 INFO - Running setup.py install for mozdebug 05:52:27 INFO - Running setup.py install for mozdevice 05:52:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:52:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:52:27 INFO - Running setup.py install for mozfile 05:52:27 INFO - Running setup.py install for mozhttpd 05:52:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:52:27 INFO - Running setup.py install for mozinfo 05:52:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:52:27 INFO - Running setup.py install for mozInstall 05:52:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:52:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:52:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:52:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:52:27 INFO - Running setup.py install for mozleak 05:52:27 INFO - Running setup.py install for mozlog 05:52:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:52:28 INFO - Running setup.py install for moznetwork 05:52:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:52:28 INFO - Running setup.py install for mozprocess 05:52:28 INFO - Running setup.py install for mozprofile 05:52:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:52:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:52:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:52:28 INFO - Running setup.py install for mozrunner 05:52:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:52:28 INFO - Running setup.py install for mozscreenshot 05:52:28 INFO - Running setup.py install for moztest 05:52:29 INFO - Running setup.py install for mozversion 05:52:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:52:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:52:29 INFO - Cleaning up... 05:52:29 INFO - Return code: 0 05:52:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:29 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 0x10cd38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfc0d9cd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc9cd30>, '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 0x10ca01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc94b20>, '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.HoNPEXiwIW/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.QjpQzfTNUn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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:52:29 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:52:29 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:52:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HoNPEXiwIW/Render', 05:52:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:29 INFO - 'HOME': '/Users/cltbld', 05:52:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:29 INFO - 'LOGNAME': 'cltbld', 05:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:29 INFO - 'MOZ_NO_REMOTE': '1', 05:52:29 INFO - 'NO_EM_RESTART': '1', 05:52:29 INFO - 'PAGER': '/bin/cat', 05:52:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:29 INFO - 'PWD': '/builds/slave/test', 05:52:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:29 INFO - 'SHELL': '/bin/bash', 05:52:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QjpQzfTNUn/Listeners', 05:52:29 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 05:52:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:29 INFO - 'USER': 'cltbld', 05:52:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:29 INFO - 'XPC_FLAGS': '0x0', 05:52:29 INFO - 'XPC_SERVICE_NAME': '0', 05:52:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:52:29 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-84q89n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:52:29 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:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:52:29 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-UHDITg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:52:29 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:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:52:29 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-R28GCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:52:29 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:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:52:29 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-cp6gbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:52:29 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:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:52:29 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-eu6Hle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:52:30 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:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:52:30 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-2cngDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:52:30 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:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:52:30 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-5gcrOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:52:30 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:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:52:30 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-rextOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:52:30 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:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:52:30 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-rYnz7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:52:30 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:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:52:30 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-nF8_KQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:52:30 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:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:52:30 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-EZILL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:52:30 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:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:52:30 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-eTuwZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:52:30 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:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:52:30 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-K0RUiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:52:30 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:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:52:30 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-Dw75jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:52:30 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:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:30 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-QZrl5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:31 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:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:52:31 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-8C7taX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:52:31 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:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:52:31 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-QExNOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:52:31 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:52:31 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:52:31 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:52:31 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:52:31 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:52:31 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:52:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:52:31 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:52:31 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:52:31 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:52:31 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:52:31 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:52:31 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:52:34 INFO - Downloading blessings-1.6.tar.gz 05:52:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:52:34 INFO - Installing collected packages: blessings 05:52:34 INFO - Running setup.py install for blessings 05:52:34 INFO - Successfully installed blessings 05:52:34 INFO - Cleaning up... 05:52:34 INFO - Return code: 0 05:52:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:52:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:52:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:52:34 INFO - Reading from file tmpfile_stdout 05:52:34 INFO - Current package versions: 05:52:34 INFO - blessings == 1.6 05:52:34 INFO - blobuploader == 1.2.4 05:52:34 INFO - docopt == 0.6.1 05:52:34 INFO - functools32 == 3.2.3-2 05:52:34 INFO - jsonschema == 2.5.1 05:52:34 INFO - manifestparser == 1.1 05:52:34 INFO - mozInstall == 1.12 05:52:34 INFO - mozcrash == 0.17 05:52:34 INFO - mozdebug == 0.1 05:52:34 INFO - mozdevice == 0.48 05:52:34 INFO - mozfile == 1.2 05:52:34 INFO - mozhttpd == 0.7 05:52:34 INFO - mozinfo == 0.9 05:52:34 INFO - mozleak == 0.1 05:52:34 INFO - mozlog == 3.2 05:52:34 INFO - moznetwork == 0.27 05:52:34 INFO - mozprocess == 0.22 05:52:34 INFO - mozprofile == 0.28 05:52:34 INFO - mozrunner == 6.11 05:52:34 INFO - mozscreenshot == 0.1 05:52:34 INFO - mozsystemmonitor == 0.3 05:52:34 INFO - moztest == 0.7 05:52:34 INFO - mozversion == 1.4 05:52:34 INFO - psutil == 3.1.1 05:52:34 INFO - requests == 1.2.3 05:52:34 INFO - wsgiref == 0.1.2 05:52:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:34 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 0x10cd38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfc0d9cd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc9cd30>, '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 0x10ca01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc94b20>, '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.HoNPEXiwIW/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.QjpQzfTNUn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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:52:34 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:52:34 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:52:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HoNPEXiwIW/Render', 05:52:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:34 INFO - 'HOME': '/Users/cltbld', 05:52:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:34 INFO - 'LOGNAME': 'cltbld', 05:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:34 INFO - 'MOZ_NO_REMOTE': '1', 05:52:34 INFO - 'NO_EM_RESTART': '1', 05:52:34 INFO - 'PAGER': '/bin/cat', 05:52:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:34 INFO - 'PWD': '/builds/slave/test', 05:52:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:34 INFO - 'SHELL': '/bin/bash', 05:52:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QjpQzfTNUn/Listeners', 05:52:34 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 05:52:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:34 INFO - 'USER': 'cltbld', 05:52:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:34 INFO - 'XPC_FLAGS': '0x0', 05:52:34 INFO - 'XPC_SERVICE_NAME': '0', 05:52:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:35 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:52:35 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:52:35 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:52:35 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:52:35 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:52:35 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:52:35 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:52:35 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:52:35 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:52:35 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:52:35 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:52:35 INFO - Cleaning up... 05:52:35 INFO - Return code: 0 05:52:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:52: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:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:35 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 0x10cd38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfc0d9cd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc9cd30>, '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 0x10ca01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc94b20>, '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.HoNPEXiwIW/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.QjpQzfTNUn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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:52:35 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:52:35 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:52:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HoNPEXiwIW/Render', 05:52:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:35 INFO - 'HOME': '/Users/cltbld', 05:52:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:35 INFO - 'LOGNAME': 'cltbld', 05:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:35 INFO - 'MOZ_NO_REMOTE': '1', 05:52:35 INFO - 'NO_EM_RESTART': '1', 05:52:35 INFO - 'PAGER': '/bin/cat', 05:52:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:35 INFO - 'PWD': '/builds/slave/test', 05:52:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:35 INFO - 'SHELL': '/bin/bash', 05:52:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QjpQzfTNUn/Listeners', 05:52:35 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 05:52:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:35 INFO - 'USER': 'cltbld', 05:52:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:35 INFO - 'XPC_FLAGS': '0x0', 05:52:35 INFO - 'XPC_SERVICE_NAME': '0', 05:52:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:52:35 INFO - Cleaning up... 05:52:35 INFO - Return code: 0 05:52:35 INFO - Running post-action listener: _resource_record_post_action 05:52:35 INFO - Running post-action listener: _start_resource_monitoring 05:52:35 INFO - Starting resource monitoring. 05:52:35 INFO - ##### 05:52:35 INFO - ##### Finished create-virtualenv step (success) 05:52:35 INFO - ##### 05:52:35 INFO - ##### 05:52:35 INFO - ##### Running install step. 05:52:35 INFO - ##### 05:52:35 INFO - Running pre-action listener: _resource_record_pre_action 05:52:35 INFO - Running main action method: install 05:52:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:52:35 INFO - Reading from file tmpfile_stdout 05:52:35 INFO - Detecting whether we're running mozinstall >=1.0... 05:52:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:52:35 INFO - Reading from file tmpfile_stdout 05:52:35 INFO - Output received: 05:52:35 INFO - Usage: mozinstall [options] installer 05:52:35 INFO - Options: 05:52:35 INFO - -h, --help show this help message and exit 05:52:35 INFO - -d DEST, --destination=DEST 05:52:35 INFO - Directory to install application into. [default: 05:52:35 INFO - "/builds/slave/test"] 05:52:35 INFO - --app=APP Application being installed. [default: firefox] 05:52:35 INFO - mkdir: /builds/slave/test/build/application 05:52:35 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:52:35 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:53:10 INFO - Reading from file tmpfile_stdout 05:53:10 INFO - Output received: 05:53:10 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:53:10 INFO - Running post-action listener: _resource_record_post_action 05:53:10 INFO - ##### 05:53:10 INFO - ##### Finished install step (success) 05:53:10 INFO - ##### 05:53:10 INFO - ##### 05:53:10 INFO - ##### Running run-tests step. 05:53:10 INFO - ##### 05:53:10 INFO - Running pre-action listener: _resource_record_pre_action 05:53:10 INFO - Running main action method: run_tests 05:53:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:53:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:53:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:53:10 INFO - 2016-06-30 05:53:10.442 screenresolution[1638:8663] starting screenresolution argv=screenresolution get 05:53:10 INFO - 2016-06-30 05:53:10.444 screenresolution[1638:8663] Display 0: 1600x1200x32@60 05:53:10 INFO - 2016-06-30 05:53:10.450 screenresolution[1639:8665] starting screenresolution argv=screenresolution list 05:53:10 INFO - Available Modes on Display 0 05:53:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:53:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:53:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:53:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:53:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:53:10 INFO - Intel Iris: 05:53:10 INFO - Chipset Model: Intel Iris 05:53:10 INFO - Type: GPU 05:53:10 INFO - Bus: Built-In 05:53:10 INFO - VRAM (Dynamic, Max): 1536 MB 05:53:10 INFO - Vendor: Intel (0x8086) 05:53:10 INFO - Device ID: 0x0a2e 05:53:10 INFO - Revision ID: 0x0009 05:53:10 INFO - Displays: 05:53:10 INFO - Display: 05:53:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:53:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:53:10 INFO - Display Serial Number: 1600x1200 60 05:53:10 INFO - Main Display: Yes 05:53:10 INFO - Mirror: Off 05:53:10 INFO - Online: Yes 05:53:10 INFO - Rotation: Supported 05:53:10 INFO - Return code: 0 05:53:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:53:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:53:10 INFO - Python 2.7.3 05:53:10 INFO - Return code: 0 05:53:10 INFO - grabbing minidump binary from tooltool 05:53: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:53:10 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 0x10cc9cd30>, '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 0x10ca01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc94b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:53:10 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:53:10 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:53:10 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:53:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:53:10 INFO - Return code: 0 05:53:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:53:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:53:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:53:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:53:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:53:10 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RPHrugdRQNmFNTs9X7SJ6g/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0155', '--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:53:10 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RPHrugdRQNmFNTs9X7SJ6g/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0155 --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:53:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HoNPEXiwIW/Render', 05:53:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:10 INFO - 'HOME': '/Users/cltbld', 05:53:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:10 INFO - 'LOGNAME': 'cltbld', 05:53:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:53:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:10 INFO - 'MOZ_NO_REMOTE': '1', 05:53:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:53:10 INFO - 'NO_EM_RESTART': '1', 05:53:10 INFO - 'PAGER': '/bin/cat', 05:53:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:10 INFO - 'PWD': '/builds/slave/test', 05:53:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:53:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:10 INFO - 'SHELL': '/bin/bash', 05:53:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QjpQzfTNUn/Listeners', 05:53:10 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 05:53:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:10 INFO - 'USER': 'cltbld', 05:53:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:10 INFO - 'XPC_FLAGS': '0x0', 05:53:10 INFO - 'XPC_SERVICE_NAME': '0', 05:53:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:10 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RPHrugdRQNmFNTs9X7SJ6g/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0155', '--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:53:11 INFO - mozversion application_buildid: 20160630030207 05:53:11 INFO - mozversion application_changeset: d700dc054751333e0735f975fce3d3adf153c62a 05:53:11 INFO - mozversion application_display_name: Nightly 05:53:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:53:11 INFO - mozversion application_name: Firefox 05:53:11 INFO - mozversion application_remotingname: firefox 05:53:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:53:11 INFO - mozversion application_vendor: Mozilla 05:53:11 INFO - mozversion application_version: 50.0a1 05:53:11 INFO - mozversion platform_buildid: 20160630030207 05:53:11 INFO - mozversion platform_changeset: d700dc054751333e0735f975fce3d3adf153c62a 05:53:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:53:11 INFO - mozversion platform_version: 50.0a1 05:53:11 INFO - using testdate: 1467291191 05:53:11 INFO - actual date: 1467291191 05:53:11 INFO - starting webserver on 'localhost:49267' 05:53:11 INFO - SUITE-START | Running 2 tests 05:53:11 INFO - TEST-START | dromaeo_css 05:53:11 INFO - operating with platform_type : mac_ 05:53:11 INFO - Initialising browser for dromaeo_css test... 05:53:11 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmpadtG43/profile http://localhost:49267/getInfo.html) 05:53:14 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 05:53:14 INFO - PROCESS | 1649 | colorDepth:24 05:53:14 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 05:53:14 INFO - PROCESS | 1649 | __metrics 05:53:14 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:53:15 INFO - TEST-INFO | 1649: exit 0 05:53:15 INFO - Browser initialized. 05:53:15 INFO - Running cycle 1/1 for dromaeo_css test... 05:53:15 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmpadtG43/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:53:27 INFO - PROCESS | 1654 | RSS: Main: 256049152 05:53:27 INFO - PROCESS | 1654 | 05:54:16 INFO - PROCESS | 1654 | 1467291256844 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:56:27 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 05:56:29 INFO - PROCESS | 1654 | RSS: Main: 269869056 05:56:29 INFO - PROCESS | 1654 | 05:59:31 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 05:59:32 INFO - PROCESS | 1654 | RSS: Main: 278560768 05:59:32 INFO - PROCESS | 1654 | 06:02:33 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 06:02:34 INFO - PROCESS | 1654 | RSS: Main: 283377664 06:02:34 INFO - PROCESS | 1654 | 06:05:36 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 06:05:36 INFO - PROCESS | 1654 | RSS: Main: 282640384 06:05:36 INFO - PROCESS | 1654 | 06:08:39 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 06:08:40 INFO - PROCESS | 1654 | RSS: Main: 285720576 06:08:40 INFO - PROCESS | 1654 | 06:11:42 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 06:11:43 INFO - PROCESS | 1654 | RSS: Main: 286105600 06:11:43 INFO - PROCESS | 1654 | 06:11:43 INFO - PROCESS | 1654 | __start_tp_report 06:11:43 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 06:11:43 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 06:11:43 INFO - PROCESS | 1654 | |i|pagename|runs| 06:11:43 INFO - PROCESS | 1654 | |0;dojo.html;2891.797574169808;3424.6232914379416;3437;3438.2607739336036;3457.602375726792;5888.440598143175;5956.1065840124;5976.820695379135;5986.490794612257;6051.576389652726;4814.470408255098;5780.739866705998;5863.677497737623;5904.084866845635;5928.170056192126;5267;5294.655847369928;5395.21769343445;5402.702851343174;5438.6736795792185;513.5488792009418;5274;5304.124819404794;5385.35375754908;5426.484483974016;5327.881144959563;5331;5354.41101478837;5354.839354819362;5382.2464854920345;4389.429374181336;5380.139177731544;5403.243545903577;5410.702411367373;5435.374931882845;4780.784864681098;4783.7129772213775;5294.338207724035;5318.149096144637;5360.59795515334;5838.919799837001;5882.176495290662;5933.465988061095;5983.790567330166;5989.5507836911975;5227.398849132361;5457;6134.130457564626;6226.750929962796;6299.181106456177;5709.400512946164;5746.02317606008;6260;6289.654069026202;6433.581817181868;6044.848878778066;6066.96966515169;6069.635821850659;6085.756569737249;6087.05650624154;6299.622022678654;6309;6454.806355809334;6479.935200648028;6506.056621789909;6125.142480052797;6204.906926396107;6215.378462153749;6230.6573138476915;6230.7819226326865;6277.2153480814895;6294.0558916162945;6315.305316415191;6332.68336583169;6354.618722876549;6141.815745527641;6163.506919446433;6196.47329976957;6208.441240288305;6279.026750853625;6181.134641150243;6208.410201030985;6220.315765265817;6235.095911092866;6236.719347629368;5091.516305950929;5127.230915362651;5129.358830146231;5138.922916156261;5149.76826042829;4442.933355999663;4526.094781043805;4543.568361005699;4610.976945115253;4653.976730116396;5838.970805146032;5931.169636250928;6014.188084608521;6015.639061656315;6094.573379863367;6277.811665650038;6285.214348206474;6297.842553936097;6316.684165791692;6321.273053598803;5852.882942341129;5964.701764911737;6013.879722405527;6044.274687037496;6049.153118563405;4767.713937163781;5583.274174357308;5595.244641973363;5609.915851262234;5616.550675945915;6269.62382257066;6495.220573531206;6504.82913075651;6516.283208847118;6532.640704761284;6190.3190649029475;6247;6268.498520118471;6296.6851657417865;6304.5586808922935;6494.155759751202;6495.1556297681;6495.350464953467;6512.5766825156215;6523.706433210612;6107.765388666889;6166.136740856194;6241.687915604292;6262.436380725757;6284.874302514016;6156.876862462816;6209.192804935329;6274.341194174546;6319.431251187415;6346.2067241594805;6058.363871793398;6070.1198326241565;6210.192674952408;6212.1303017578475;6213.409726076015;6112.169143789106;6156.045812899008;6194.194754681863;6208.782692605737;6250.343713909974;5470.56235501151;5834.658028653349;6160.3223645398075;6160.568760186744;6203.596766210182;6184.165137706532;6197.225346831646;6201.968990155201;6206.131141640264;6228.844278893064;6081.969590152021;6083.209182806207;6127.647695153045;6135.385782596223;6157.4458298753325 06:11:43 INFO - PROCESS | 1654 | |1;ext.html;451.53040837528965;492.48535280631756;506.5162769555074;540.670191183378;565.5080080330114;39572.40641390382;41660.99999999996;41685;41702.791486042566;41774.95562610936;35291.941241762725;41799.58200417995;41881;41925.58074419255;42121.36817947733;8733;9232;9481.004494528079;9565.473898935556;9668.274879384038;9530.904690953106;9536.28477864163;9600.03999600038;9611.567479463405;9650;9595.472249026301;9662.3719458235;9688.757781055494;9695.951520242388;9750.707478775648;8372.204640559137;9541.379810312343;9593.136617704406;9607.327487075907;9652.034796520291;9589.520523973773;9653.469059201741;9654.27592930533;9676.661316853877;9724.95137524308;40014.79992600047;40033.19933601312;40174;40240;40334;3069.493533566959;3299.6700329967052;3394.253264281854;3433.4334834752235;3456.6716161964573;24644;29371.412571748446;30580;30598.235044123852;31388.843055784575;3146.496560550301;3157.542156387311;3165.7309128724087;3178.8410579471165;3264.8367581620823;396144;401071;402907;405235.97382013197;405635.97182013904;33193.502097468554;33350;33492.3301533968;33496;33503.16242093967;35685.46471802925;35751.82124089363;36286.818565907;36307.27695422854;36311;16066.518004459886;16083.437079702155;16117.516474505783;16176.43382481631;16263.674726505404;10408.947955260175;12242.75514489723;12278.815817762741;12375.009999200043;12396;19332.90333548323;19359.322423715385;19463;19464.416067517996;19510.92689902069;7861.449698521049;7906.232818513474;7925.841483170304;7967.601619918981;8103.824945382887;871.289898732531;955.1356022799239;965.4014511003223;1006.441425009127;1040.8802987656366;30614;30661.23346916345;30703.23241918925;30780.84609576938;31364.215894602363;1025.3027941000191;1045.1899777672365;1139.3448766959032;1169.417072302036;1170.1165619957048;16088.678226435406;16147.515574532783;16312.592185195464;16448.917755411385;16536.75194872078;693272;708626;711275;715703;716346;60268;60827.695861520406;60894.69552652208;61035.50680438782;61062.77874442575;1224.369449733388;1324.5892475694336;1340.7921772125337;1397.916125032481;1399.468202083202;30114.84942575273;30254.54618180773;30476.390472190877;30872.536911946787;30931.381372371976;51007.48992510027;51222;51247;51660.741696291276;51711.74144129255;591265;607752;607852;608767;612554;26847.463050739265;26907;27496.862515687295;28011.859940700982;28179.154625361272;46050.53949460597;46276.7686161567;46295.76852115718;46754.76622616865;46816;33677.49483757697;40472.3929141069;40570.79714601408;41302.38046429366;41838;39810.40284395794;40306.99232519211;41161.79419102885;41488.37767433551;41531;32159.839200803846;38459.42310865283;39153;40050.79974600108;40726.79636601917;30542.84728576343;31703.84148079245;34170.31659366848;36744.26511469809;37291.6270837299;25549.105781297567;25549.74450255548;26020;26249;26320.73679263183 06:11:43 INFO - PROCESS | 1654 | |2;jquery.html;368.129374030418;371.2426649634745;372.65901699944544;377.6480200880847;389.0992352703493;19848.503787405323;21062.262820801257;21472.033758480866;21777.564448711015;21835.781642183574;20139.093740781664;20376.47176461764;20811.27160549381;20811.959402029875;21275.468113297175;5461.672299662033;5945.31628862682;5976.9241536523405;6113.083037544359;6122.418370254819;5925.703714814264;5940.613860099102;5952.226210592617;6006.609570377911;6024.578279520435;5798;5869.647821130746;5934.080217566263;5947.226860508128;5987.6108052976415;5316.574674026068;5320.255164277004;5678.744456499426;5957.791477298296;5966.015607424792;5750.281214848144;5806.738696758656;5816.418358164192;5816.796412125555;5825;17787.46637600874;21650.458738531506;25583;25635.615465768027;26413.943442262287;2129.1483406637312;2224.1881713174575;2365.6042934668626;2369.620860662286;3018.6981301869855;8320.916790832074;11066.89331066895;11925.880741192565;12220.694482637917;12692;1797.299053369187;1867.141115087048;1902.077492416177;1923.1057558235348;1925.6918892977196;96938;109569.45215273953;123489.76510234873;124285;124685;11432.199746017699;11658.475368608433;11762.294262344116;11762.5883094093;12062.062309767212;14756.778648320284;14802.851971480148;14815.185164815823;14819.703605927822;14840.925795370955;8252;8526.872096918427;8584.699535516227;8612;8612.741617751477;7346;8383.706570270011;8395.286400656012;8477.152284771597;8487.10885357041;4155.771432571177;4245.469316335458;4552.385427967249;4585.060062687141;4627.722336659811;1604.6549991751829;1613.3385312022015;1928.469670840502;2000.0899590686204;2000.889951052706;768.4851149729694;945.3902233059638;951.6764300137986;953.032671838071;1030.7320096774893;17336.826631733773;19493.707594386095;20831.687524687142;21436.928153592256;21458.892705536684;884.8009197930414;916.3631276262934;921.318224513855;981.4994352880083;1025.497506221946;10953.890461095447;11350.262232954996;11359.886401135884;11368.886311136783;11376.488058037243;579063;592353;599704;602565;603146;74219;74763.62618186875;118553;122883;136255;978.6623614852864;988.0613417253638;1020.8315627921459;1031.1544533482472;1038.7247379444452;18516.907415462836;18739.812601874353;18852.622947541247;18946.147423366256;19207.3916843551;51938;52764.736176318875;53761;56097.71951140218;56420;59071;82097;82286;82610.86945652813;83763.5811820937;8171.101178870201;8272.462289951134;8442.494922426764;8447.070822209675;8616.35377346714;11216.270942388719;12842.935785321388;13281.269530175932;13312.933435332761;13332.533361332307;11262.605808796652;11372;11619.360935148648;11655.358955257543;11810.527578896748;9120.49837258957;10614.62009938703;11459.942700286445;11536.25014374063;11731.354775487089;8243;10576.293549370455;11661.708457288636;11675.649730508097;11983.161178717406;7077.398421134261;8215.876761848458;8260.339172866277;8327.37544684139;8476.940382452194;9211.631534738535;11640.185187036826;11698.35659038761;11743.47154378072;11853.348065856117 06:11:43 INFO - PROCESS | 1654 | |3;mootools.html;1532.1190315568547;1566.655335826118;1795.7126859702441;1883.5479484923605;1891.971620425693;7997.520148791076;8508.95745521273;8537.35969802265;9011;9019.278457723383;8642.17899299567;8805.95597022014;8812.691555795549;8818.999999999984;8820.558972051404;2327.476317828492;2332.24202134307;2333.5216280662426;2356.929292121239;2363.9645405318934;2349.1073392110975;2360.36270207044;2362.043372434167;2367.0531787285136;2402.1232250228713;2366.266457398212;2371.881405929705;2383.7377888432256;2386.3914701751114;2401.8438801477937;1980.2771988224338;2302.7466978632337;2349.823763217757;2371.134535894395;2372.715274167094;2343.4610039690965;2350.9412264693347;2359.8112151027876;2361.53949979754;2361.6103342948395;8791.208791208757;8868.955655221682;8874.955625221832;8933.106689331014;8949.507777072258;4527.4340707411575;4684.3910291662205;5134.332536770234;5273.472652734696;5364.222187782789;3581.5344005279408;3639.090227443139;3647.3434781739275;3699.9260014799825;3722.627737226283;1079.4926384599305;1100.14738577603;1105.7843720474511;1123.662901129658;1126.8985791278742;11482.827757583644;11611.187216894821;11611.303321800719;11620.825687614608;11643.18497705161;4506.639468842484;4509.12072145935;4665.393498845128;4674.579287864109;4766.6901651392545;9779.902200977898;9864.506774661239;9900.405975641484;9913;9935.403875767477;5276.287701160294;5287.762050707727;5327.840164795062;5329.440408757102;5332.733363331896;3996.680265578747;4384.539623339567;4845.466998630148;4849.030193961222;4852.611791056707;3480.89557313281;3890.533136023695;3999.6200360965663;4004.2992476316526;4054.7769872656695;1275.7639836630253;1286.3696788573718;1288.8388951381078;1302.4659889445281;1302.5180683147296;902.444996327254;919.2094798473307;919.7792529792802;932.3753085432776;940.6407740814594;5183.3261675981885;5846.801405711819;5914.467697907209;5915.37888521699;6114.419130182626;809.3323008517996;957.899420560845;983.4246965525105;994.9005099489993;996.6860438961704;4054;4200.474940632421;4206.621404073648;4218.303979843292;4275.187714334266;10778.353298802096;10813.729656758644;10861.239713220157;10900.836487452694;10974.231803773659;10646.680599582025;10658.680239592824;10679.359238445562;10684.626038088629;10868.782624347468;6988.755393561201;8131.308838748654;8387.916120838836;8391.664333426594;8409.285210757154;5997.820065398045;6021.909671354845;6056.545759068175;6179.351168127461;6193.916064688571;9815.705528834147;10033.749156271151;10051.698707284168;10158.695239142837;10168.89831101709;10249.975002499988;10258.53836577341;10258.58965641366;10264.897351026395;10281.897181028393;6640.601563906181;7309.415246780139;7527.360174385239;7634.045744281965;7640.885386719315;8504.744857654281;8511.021232558334;8540.14598540141;8541.53021583819;8566.271866891135;7487.663055162422;7637.541747495168;7707.421943354158;7750.263724946121;7753.224677532427;7438.590877501573;7440.181580026301;7490.250974902466;7526.887096693664;7619.276168763959;5498;7083.6812343443635;7111;7149.177844547944;7421.628918554159;4353.194658988097;4941.234108713155;5050;5129.974350128375;5134;5076.923846142385;5122.129238029469;5147.073526765069;5161.071007218737;5275.604329675367 06:11:43 INFO - PROCESS | 1654 | |4;prototype.html;298.86252323930995;302.59301239832416;305.16080777860884;305.97093276138776;311.29025821127806;5247.212918062292;5349.54528865046;5675.6878371689545;5692.800751973682;5729.971350143243;5642.210090587321;5646.632968857031;5688.260526131608;5693.092813907336;5711.200431939532;3905.4141878718137;4052.412400201969;4097.262492751303;4296;4299.075698724773;4246.384274280227;4282.336237883133;4305.956940430603;4306.138772245547;4325.351197320396;3672.265546890633;4149.962509372657;4184.393262976867;4267.381229721688;4287.228298906196;3571.8571257149943;4073.959260407388;4289.935650965238;4310.698251122422;4333.003409215898;3114.6573876873526;3656.945145822815;3691.575468821093;3702.8518859245596;3709.1454272863566;4937.456879743226;5084.9321642455125;5536.141898005815;5575.689712917461;5594.776208951637;4122.56713045129;4398.690687389114;4893.314935908976;4963.528464795839;5019.146745053313;5173.327467429248;5608;5644.887102257973;5675.120356344773;5942.435468630473;4126.91746165075;4127.814248358831;4132.834686612532;4137.50349958004;4159.896002599929;4920.975395123037;6009.669468179249;6119.479844213247;6214.720337584774;6419.679016049179;3355.547001154862;4030.8387664493093;4124.793760311973;4142.523609784853;4229.915401691949;4243.554426785143;4264.6801489888385;4266.935995960063;4267.466566679165;4268.829246830092;4720.763961801965;4943.530364615356;4977;5000.724960127155;5003.54968052877;4805.8558243252755;6041.577089603774;6092.238470191226;6099.4815440688035;6155.538334624832;1288.8657980976868;1414.5544153591586;1439.7480440922798;1440.827100747917;1450.2386247220293;880.7093659092484;889.6574818694849;910.526526206369;939.7838497145694;974.2595627323144;5440.211169380497;5623.268975033219;5635.196242536272;5658;5697.401772813795;6079.75680972765;6095.616932602359;6103.206583144163;6206.772478311253;6216.44052035319;5220.477952204749;5221.172589593688;5606.97196514023;5729.942700573024;5781.3523145904055;3273.6235332937017;3285.8499525166;3312.9171770705443;3315.983420082884;3353;6169.2855143736615;6187.504999600022;6383.467967687721;6396.488280937514;6525.608463492205;5388.787522807415;5454.490934170326;5575.330960284792;5721.485066343966;6167.537434692326;5280.653433374542;5395.379531353945;5975.282966044103;6220.968895155495;6450.516211284173;5205.334293026195;5872.946068044678;6206.06908963659;6238.875222495615;6248.9062664059165;5731.799387021601;6136.29432615255;6158.722857471335;6205.348438413902;6235.220597425322;5710.600257982068;6039.879202415839;6085.847853803691;6439.162908821823;6559.967200163968;3122.4551990127975;3490.5636795400574;4044.7775372353626;4076.164386300742;4126.3397856344045;6277.874442511033;6314.494840412664;6347.746090156342;6363.172787537591;6432.35676432353;5059.0519974635445;5321.871251499431;5431.131019036935;5774.585226619505;6091.9235785929595;5364.839054828361;5544.63959842609;5615.2700148980375;5926.785009073216;5993.801239752154;5629.915551266652;5641.9435805641415;5763.7118144093465;5935.851603709942;5987.311459182076;6052.213212282375;6071.51427885777;6125.019996800491;6128.938710612837;6153.292371377349;5236.6072544560075;5764;6013.428724271187;6019.668918209541;6034.09488576717 06:11:43 INFO - PROCESS | 1654 | |5;yui.html;737.8708725972957;739.8298391369981;790.920907909209;823.654065292577;866.6230189867408;15084.245787710612;16141.659459378383;16158.111303878282;16161.515154545383;16214.75677864833;11840.703982400444;14498.347574359153;14547.127172369665;14589.635259118528;14650.706985860303;654.4175683641563;819.1235378145387;831.4138532334689;855.2730179347536;863.3783675753448;840.0801122770556;849.902261239956;850.783050322167;851.93610479214;852.5438890193748;877.5436772878099;908.8636704494313;909.3225546967518;909.9272058235325;914.7667344827059;880.0495464897895;895.5746020640208;903.9920488655102;904.5477261369315;904.7602385367883;656.3207080671482;663.8572706867998;667.212689026948;668.6456178225549;668.8561959178751;14803.18582477974;14957.878159138108;14998.325075371635;15177.392904283926;15250.542483725507;14748.926255368762;14759;14775.778363324558;14805.481808136772;14821.703565928728;11883.227590206696;12162.270263784112;12378.071644626689;12388.81416778749;12497.062720296015;3796.449514820363;3807.847686092553;4012.879613611596;4039.899002524931;4041.191761647682;85799.71300430498;101017.49491252497;102036.48981755118;102271;102577;9672.613095476103;11077.169212309109;11526;11556.248843825124;11677.591284305008;19343.613127737368;23798;23878.761212387653;23889.52220955606;24157;7940.523568585903;7972.003499562555;8030;8164.836703265902;8430;4438.245498265303;4448.266036104006;4488.192125417456;4541.613962813198;4588.908221835544;3040.6959304069414;3430.1081718753303;3471.2363280078343;3492.5459690240104;3540.91147721309;659.1365311442026;668.0413606474627;677.9525433219726;680.2483256002047;682.1507223506667;534.7994502061727;537.8278950735727;551.8565173054955;575.5942060847093;604.2658170323078;8754.912450875538;8816.603252853636;8930.598123084477;8985.371024028385;8985.415947963362;516.3313509005847;524.9685018898801;567.103975718364;571.6227289988587;616.8396216983526;4280.5505421930875;4300.505441874162;4308.418363520947;4445.355423463579;4480.038297745029;148012.51987479988;151856;152874;153259;157042;101592.49203753934;126639.90361301106;126695.09957350646;129174.70825291627;131466;114299;117709;119013.40493297478;120546.79453205355;123723.76276237302;8450.154984501502;8575.22822945913;8579.957100214458;8615.03437326819;8816.691415800673;64723.02915456178;65408.01887971589;65701.67149164224;66475.66762166159;66750.66624666845;80208.59895700484;93301.06698932924;96018;98032.05903822897;99453;10771.09078476651;11491.54033838637;11623.476943537393;11670.416479176178;12073.879261207276;11803.996660283972;11915.40422978865;11921.761564768829;12228.938855305667;12265.141440099107;11905.702357441134;11909.225900316798;11927.701807454883;12185.207961482829;12259.877401225873;9965.654636624253;11607.941960290145;11639.941800290944;11872.287662740264;11942.522299107939;10555.660087741235;10785.40680262593;10810.567577297135;10823.945880270549;10940.39827809478;8086.797830054061;9622.855657165008;9776.421046351514;9849.556769945513;10094.293399462262;7595.810104747426;8522.74431767048;9413.105754953269;9854.901450985399;9994.300398972002 06:11:43 INFO - PROCESS | 1654 | __end_tp_report 06:11:43 INFO - PROCESS | 1654 | __start_cc_report 06:11:43 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,445 06:11:43 INFO - PROCESS | 1654 | __end_cc_report 06:11:43 INFO - PROCESS | 1654 | __startTimestamp1467292303209__endTimestamp 06:11:43 INFO - PROCESS | 1654 | 06:11:43 INFO - PROCESS | 1654 | ------- Summary: start ------- 06:11:43 INFO - PROCESS | 1654 | Number of tests: 6 06:11:43 INFO - PROCESS | 1654 | 06:11:43 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5798.88 Median:6085.76 stddev:780.91 (12.8%) stddev-sans-first:749.26 06:11:43 INFO - PROCESS | 1654 | Values: 2891.8 3424.6 3437.0 3438.3 3457.6 5888.4 5956.1 5976.8 5986.5 6051.6 4814.5 5780.7 5863.7 5904.1 5928.2 5267.0 5294.7 5395.2 5402.7 5438.7 513.5 5274.0 5304.1 5385.4 5426.5 5327.9 5331.0 5354.4 5354.8 5382.2 4389.4 5380.1 5403.2 5410.7 5435.4 4780.8 4783.7 5294.3 5318.1 5360.6 5838.9 5882.2 5933.5 5983.8 5989.6 5227.4 5457.0 6134.1 6226.8 6299.2 5709.4 5746.0 6260.0 6289.7 6433.6 6044.8 6067.0 6069.6 6085.8 6087.1 6299.6 6309.0 6454.8 6479.9 6506.1 6125.1 6204.9 6215.4 6230.7 6230.8 6277.2 6294.1 6315.3 6332.7 6354.6 6141.8 6163.5 6196.5 6208.4 6279.0 6181.1 6208.4 6220.3 6235.1 6236.7 5091.5 5127.2 5129.4 5138.9 5149.8 4442.9 4526.1 4543.6 4611.0 4654.0 5839.0 5931.2 6014.2 6015.6 6094.6 6277.8 6285.2 6297.8 6316.7 6321.3 5852.9 5964.7 6013.9 6044.3 6049.2 4767.7 5583.3 5595.2 5609.9 5616.6 6269.6 6495.2 6504.8 6516.3 6532.6 6190.3 6247.0 6268.5 6296.7 6304.6 6494.2 6495.2 6495.4 6512.6 6523.7 6107.8 6166.1 6241.7 6262.4 6284.9 6156.9 6209.2 6274.3 6319.4 6346.2 6058.4 6070.1 6210.2 6212.1 6213.4 6112.2 6156.0 6194.2 6208.8 6250.3 5470.6 5834.7 6160.3 6160.6 6203.6 6184.2 6197.2 6202.0 6206.1 6228.8 6082.0 6083.2 6127.6 6135.4 6157.4 06:11:43 INFO - PROCESS | 1654 | 06:11:43 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:69266.00 Median:40024.00 stddev:157338.99 (393.1%) stddev-sans-first:157695.54 06:11:43 INFO - PROCESS | 1654 | Values: 451.5 492.5 506.5 540.7 565.5 39572.4 41661.0 41685.0 41702.8 41775.0 35291.9 41799.6 41881.0 41925.6 42121.4 8733.0 9232.0 9481.0 9565.5 9668.3 9530.9 9536.3 9600.0 9611.6 9650.0 9595.5 9662.4 9688.8 9696.0 9750.7 8372.2 9541.4 9593.1 9607.3 9652.0 9589.5 9653.5 9654.3 9676.7 9725.0 40014.8 40033.2 40174.0 40240.0 40334.0 3069.5 3299.7 3394.3 3433.4 3456.7 24644.0 29371.4 30580.0 30598.2 31388.8 3146.5 3157.5 3165.7 3178.8 3264.8 396144.0 401071.0 402907.0 405236.0 405636.0 33193.5 33350.0 33492.3 33496.0 33503.2 35685.5 35751.8 36286.8 36307.3 36311.0 16066.5 16083.4 16117.5 16176.4 16263.7 10408.9 12242.8 12278.8 12375.0 12396.0 19332.9 19359.3 19463.0 19464.4 19510.9 7861.4 7906.2 7925.8 7967.6 8103.8 871.3 955.1 965.4 1006.4 1040.9 30614.0 30661.2 30703.2 30780.8 31364.2 1025.3 1045.2 1139.3 1169.4 1170.1 16088.7 16147.5 16312.6 16448.9 16536.8 693272.0 708626.0 711275.0 715703.0 716346.0 60268.0 60827.7 60894.7 61035.5 61062.8 1224.4 1324.6 1340.8 1397.9 1399.5 30114.8 30254.5 30476.4 30872.5 30931.4 51007.5 51222.0 51247.0 51660.7 51711.7 591265.0 607752.0 607852.0 608767.0 612554.0 26847.5 26907.0 27496.9 28011.9 28179.2 46050.5 46276.8 46295.8 46754.8 46816.0 33677.5 40472.4 40570.8 41302.4 41838.0 39810.4 40307.0 41161.8 41488.4 41531.0 32159.8 38459.4 39153.0 40050.8 40726.8 30542.8 31703.8 34170.3 36744.3 37291.6 25549.1 25549.7 26020.0 26249.0 26320.7 06:11:43 INFO - PROCESS | 1654 | 06:11:43 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:34321.02 Median:26024.78 stddev:98946.53 (380.2%) stddev-sans-first:99191.25 06:11:43 INFO - PROCESS | 1654 | Values: 368.1 371.2 372.7 377.6 389.1 19848.5 21062.3 21472.0 21777.6 21835.8 20139.1 20376.5 20811.3 20812.0 21275.5 5461.7 5945.3 5976.9 6113.1 6122.4 5925.7 5940.6 5952.2 6006.6 6024.6 5798.0 5869.6 5934.1 5947.2 5987.6 5316.6 5320.3 5678.7 5957.8 5966.0 5750.3 5806.7 5816.4 5816.8 5825.0 17787.5 21650.5 25583.0 25635.6 26413.9 2129.1 2224.2 2365.6 2369.6 3018.7 8320.9 11066.9 11925.9 12220.7 12692.0 1797.3 1867.1 1902.1 1923.1 1925.7 96938.0 109569.5 123489.8 124285.0 124685.0 11432.2 11658.5 11762.3 11762.6 12062.1 14756.8 14802.9 14815.2 14819.7 14840.9 8252.0 8526.9 8584.7 8612.0 8612.7 7346.0 8383.7 8395.3 8477.2 8487.1 4155.8 4245.5 4552.4 4585.1 4627.7 1604.7 1613.3 1928.5 2000.1 2000.9 768.5 945.4 951.7 953.0 1030.7 17336.8 19493.7 20831.7 21436.9 21458.9 884.8 916.4 921.3 981.5 1025.5 10953.9 11350.3 11359.9 11368.9 11376.5 579063.0 592353.0 599704.0 602565.0 603146.0 74219.0 74763.6 118553.0 122883.0 136255.0 978.7 988.1 1020.8 1031.2 1038.7 18516.9 18739.8 18852.6 18946.1 19207.4 51938.0 52764.7 53761.0 56097.7 56420.0 59071.0 82097.0 82286.0 82610.9 83763.6 8171.1 8272.5 8442.5 8447.1 8616.4 11216.3 12842.9 13281.3 13312.9 13332.5 11262.6 11372.0 11619.4 11655.4 11810.5 9120.5 10614.6 11459.9 11536.3 11731.4 8243.0 10576.3 11661.7 11675.6 11983.2 7077.4 8215.9 8260.3 8327.4 8476.9 9211.6 11640.2 11698.4 11743.5 11853.3 06:11:43 INFO - PROCESS | 1654 | 06:11:43 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5737.34 Median:4850.82 stddev:3214.67 (66.3%) stddev-sans-first:3208.15 06:11:43 INFO - PROCESS | 1654 | Values: 1532.1 1566.7 1795.7 1883.5 1892.0 7997.5 8509.0 8537.4 9011.0 9019.3 8642.2 8806.0 8812.7 8819.0 8820.6 2327.5 2332.2 2333.5 2356.9 2364.0 2349.1 2360.4 2362.0 2367.1 2402.1 2366.3 2371.9 2383.7 2386.4 2401.8 1980.3 2302.7 2349.8 2371.1 2372.7 2343.5 2350.9 2359.8 2361.5 2361.6 8791.2 8869.0 8875.0 8933.1 8949.5 4527.4 4684.4 5134.3 5273.5 5364.2 3581.5 3639.1 3647.3 3699.9 3722.6 1079.5 1100.1 1105.8 1123.7 1126.9 11482.8 11611.2 11611.3 11620.8 11643.2 4506.6 4509.1 4665.4 4674.6 4766.7 9779.9 9864.5 9900.4 9913.0 9935.4 5276.3 5287.8 5327.8 5329.4 5332.7 3996.7 4384.5 4845.5 4849.0 4852.6 3480.9 3890.5 3999.6 4004.3 4054.8 1275.8 1286.4 1288.8 1302.5 1302.5 902.4 919.2 919.8 932.4 940.6 5183.3 5846.8 5914.5 5915.4 6114.4 809.3 957.9 983.4 994.9 996.7 4054.0 4200.5 4206.6 4218.3 4275.2 10778.4 10813.7 10861.2 10900.8 10974.2 10646.7 10658.7 10679.4 10684.6 10868.8 6988.8 8131.3 8387.9 8391.7 8409.3 5997.8 6021.9 6056.5 6179.4 6193.9 9815.7 10033.7 10051.7 10158.7 10168.9 10250.0 10258.5 10258.6 10264.9 10281.9 6640.6 7309.4 7527.4 7634.0 7640.9 8504.7 8511.0 8540.1 8541.5 8566.3 7487.7 7637.5 7707.4 7750.3 7753.2 7438.6 7440.2 7490.3 7526.9 7619.3 5498.0 7083.7 7111.0 7149.2 7421.6 4353.2 4941.2 5050.0 5130.0 5134.0 5076.9 5122.1 5147.1 5161.1 5275.6 06:11:43 INFO - PROCESS | 1654 | 06:11:43 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4846.88 Median:5540.39 stddev:1504.30 (27.2%) stddev-sans-first:1469.28 06:11:43 INFO - PROCESS | 1654 | Values: 298.9 302.6 305.2 306.0 311.3 5247.2 5349.5 5675.7 5692.8 5730.0 5642.2 5646.6 5688.3 5693.1 5711.2 3905.4 4052.4 4097.3 4296.0 4299.1 4246.4 4282.3 4306.0 4306.1 4325.4 3672.3 4150.0 4184.4 4267.4 4287.2 3571.9 4074.0 4289.9 4310.7 4333.0 3114.7 3656.9 3691.6 3702.9 3709.1 4937.5 5084.9 5536.1 5575.7 5594.8 4122.6 4398.7 4893.3 4963.5 5019.1 5173.3 5608.0 5644.9 5675.1 5942.4 4126.9 4127.8 4132.8 4137.5 4159.9 4921.0 6009.7 6119.5 6214.7 6419.7 3355.5 4030.8 4124.8 4142.5 4229.9 4243.6 4264.7 4266.9 4267.5 4268.8 4720.8 4943.5 4977.0 5000.7 5003.5 4805.9 6041.6 6092.2 6099.5 6155.5 1288.9 1414.6 1439.7 1440.8 1450.2 880.7 889.7 910.5 939.8 974.3 5440.2 5623.3 5635.2 5658.0 5697.4 6079.8 6095.6 6103.2 6206.8 6216.4 5220.5 5221.2 5607.0 5729.9 5781.4 3273.6 3285.8 3312.9 3316.0 3353.0 6169.3 6187.5 6383.5 6396.5 6525.6 5388.8 5454.5 5575.3 5721.5 6167.5 5280.7 5395.4 5975.3 6221.0 6450.5 5205.3 5872.9 6206.1 6238.9 6248.9 5731.8 6136.3 6158.7 6205.3 6235.2 5710.6 6039.9 6085.8 6439.2 6560.0 3122.5 3490.6 4044.8 4076.2 4126.3 6277.9 6314.5 6347.7 6363.2 6432.4 5059.1 5321.9 5431.1 5774.6 6091.9 5364.8 5544.6 5615.3 5926.8 5993.8 5629.9 5641.9 5763.7 5935.9 5987.3 6052.2 6071.5 6125.0 6128.9 6153.3 5236.6 5764.0 6013.4 6019.7 6034.1 06:11:43 INFO - PROCESS | 1654 | 06:11:43 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:24549.05 Median:4373.33 stddev:39830.75 (910.8%) stddev-sans-first:39902.36 06:11:43 INFO - PROCESS | 1654 | Values: 737.9 739.8 790.9 823.7 866.6 15084.2 16141.7 16158.1 16161.5 16214.8 11840.7 14498.3 14547.1 14589.6 14650.7 654.4 819.1 831.4 855.3 863.4 840.1 849.9 850.8 851.9 852.5 877.5 908.9 909.3 909.9 914.8 880.0 895.6 904.0 904.5 904.8 656.3 663.9 667.2 668.6 668.9 14803.2 14957.9 14998.3 15177.4 15250.5 14748.9 14759.0 14775.8 14805.5 14821.7 11883.2 12162.3 12378.1 12388.8 12497.1 3796.4 3807.8 4012.9 4039.9 4041.2 85799.7 101017.5 102036.5 102271.0 102577.0 9672.6 11077.2 11526.0 11556.2 11677.6 19343.6 23798.0 23878.8 23889.5 24157.0 7940.5 7972.0 8030.0 8164.8 8430.0 4438.2 4448.3 4488.2 4541.6 4588.9 3040.7 3430.1 3471.2 3492.5 3540.9 659.1 668.0 678.0 680.2 682.2 534.8 537.8 551.9 575.6 604.3 8754.9 8816.6 8930.6 8985.4 8985.4 516.3 525.0 567.1 571.6 616.8 4280.6 4300.5 4308.4 4445.4 4480.0 148012.5 151856.0 152874.0 153259.0 157042.0 101592.5 126639.9 126695.1 129174.7 131466.0 114299.0 117709.0 119013.4 120546.8 123723.8 8450.2 8575.2 8580.0 8615.0 8816.7 64723.0 65408.0 65701.7 66475.7 66750.7 80208.6 93301.1 96018.0 98032.1 99453.0 10771.1 11491.5 11623.5 11670.4 12073.9 11804.0 11915.4 11921.8 12228.9 12265.1 11905.7 11909.2 11927.7 12185.2 12259.9 9965.7 11607.9 11639.9 11872.3 11942.5 10555.7 10785.4 10810.6 10823.9 10940.4 8086.8 9622.9 9776.4 9849.6 10094.3 7595.8 8522.7 9413.1 9854.9 9994.3 06:11:43 INFO - PROCESS | 1654 | -------- Summary: end -------- 06:11:43 INFO - PROCESS | 1654 | 06:11:43 INFO - TEST-INFO | 1654: exit 0 06:11:43 INFO - TEST-OK | dromaeo_css | took 1112720ms 06:11:43 INFO - TEST-START | kraken 06:11:43 INFO - operating with platform_type : mac_ 06:11:43 INFO - Initialising browser for kraken test... 06:11:43 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmprtJybq/profile http://localhost:49267/getInfo.html) 06:11:47 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 06:11:47 INFO - PROCESS | 1662 | colorDepth:24 06:11:47 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 06:11:47 INFO - PROCESS | 1662 | __metrics 06:11:47 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 06:11:47 INFO - TEST-INFO | 1662: exit 0 06:11:47 INFO - Browser initialized. 06:11:47 INFO - Running cycle 1/1 for kraken test... 06:11:47 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmprtJybq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:12:00 INFO - PROCESS | 1665 | RSS: Main: 256024576 06:12:00 INFO - PROCESS | 1665 | 06:12:02 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 06:12:03 INFO - PROCESS | 1665 | RSS: Main: 268939264 06:12:03 INFO - PROCESS | 1665 | 06:12:06 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 06:12:06 INFO - PROCESS | 1665 | RSS: Main: 272580608 06:12:06 INFO - PROCESS | 1665 | 06:12:10 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 06:12:11 INFO - PROCESS | 1665 | RSS: Main: 272973824 06:12:11 INFO - PROCESS | 1665 | 06:12:13 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 06:12:13 INFO - PROCESS | 1665 | RSS: Main: 273911808 06:12:13 INFO - PROCESS | 1665 | 06:12:15 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:12:16 INFO - PROCESS | 1665 | RSS: Main: 274448384 06:12:16 INFO - PROCESS | 1665 | 06:12:19 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 06:12:19 INFO - PROCESS | 1665 | RSS: Main: 275193856 06:12:19 INFO - PROCESS | 1665 | 06:12:22 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 06:12:23 INFO - PROCESS | 1665 | RSS: Main: 275480576 06:12:23 INFO - PROCESS | 1665 | 06:12:26 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 06:12:27 INFO - PROCESS | 1665 | RSS: Main: 275660800 06:12:27 INFO - PROCESS | 1665 | 06:12:28 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:12:29 INFO - PROCESS | 1665 | RSS: Main: 275415040 06:12:29 INFO - PROCESS | 1665 | 06:12:31 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:12:31 INFO - PROCESS | 1665 | RSS: Main: 275505152 06:12:31 INFO - PROCESS | 1665 | 06:12:33 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:12:34 INFO - PROCESS | 1665 | RSS: Main: 275935232 06:12:34 INFO - PROCESS | 1665 | 06:12:37 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:12:38 INFO - PROCESS | 1665 | RSS: Main: 275951616 06:12:38 INFO - PROCESS | 1665 | 06:12:41 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:12:41 INFO - PROCESS | 1665 | RSS: Main: 276234240 06:12:41 INFO - PROCESS | 1665 | 06:12:43 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 06:12:43 INFO - PROCESS | 1665 | RSS: Main: 277233664 06:12:43 INFO - PROCESS | 1665 | 06:12:43 INFO - PROCESS | 1665 | __start_tp_report 06:12:43 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 06:12:43 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 06:12:43 INFO - PROCESS | 1665 | |i|pagename|runs| 06:12:43 INFO - PROCESS | 1665 | |0;ai-astar;104;107;108;113;117;115;112;117;115;115 06:12:43 INFO - PROCESS | 1665 | |1;audio-beat-detection;145;110;132;153;107;129;131;109;155;109 06:12:43 INFO - PROCESS | 1665 | |2;audio-dft;196;203;205;237;274;235;219;200;270;276 06:12:43 INFO - PROCESS | 1665 | |3;audio-fft;73;81;76;143;61;62;83;87;160;84 06:12:43 INFO - PROCESS | 1665 | |4;audio-oscillator;69;72;127;71;72;95;135;71;74;115 06:12:43 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;91;89;91;88;91;89;92;90;91;88 06:12:43 INFO - PROCESS | 1665 | |6;imaging-darkroom;97;97;97;120;98;97;97;97;95;97 06:12:43 INFO - PROCESS | 1665 | |7;imaging-desaturate;92;90;129;107;89;146;142;117;92;90 06:12:43 INFO - PROCESS | 1665 | |8;json-parse-financial;57;57;59;58;56;58;59;58;56;58 06:12:43 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;68;71;68;72;77;78;75;70;70;70 06:12:43 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;94;103;84;83;84;83;87;83;83;100 06:12:43 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;136;139;137;138;136;142;150;147;173;134 06:12:43 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;163;166;213;194;173;166;161;191;154;214 06:12:43 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;66;67;76;85;69;58;84;86;88;61 06:12:43 INFO - PROCESS | 1665 | __end_tp_report 06:12:43 INFO - PROCESS | 1665 | __start_cc_report 06:12:43 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1116 06:12:43 INFO - PROCESS | 1665 | __end_cc_report 06:12:43 INFO - PROCESS | 1665 | __startTimestamp1467292363719__endTimestamp 06:12:43 INFO - PROCESS | 1665 | 06:12:43 INFO - PROCESS | 1665 | ------- Summary: start ------- 06:12:43 INFO - PROCESS | 1665 | Number of tests: 14 06:12:43 INFO - PROCESS | 1665 | 06:12:43 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:112.30 Median:115.00 stddev:4.50 (3.9%) stddev-sans-first:3.63 06:12:43 INFO - PROCESS | 1665 | Values: 104.0 107.0 108.0 113.0 117.0 115.0 112.0 117.0 115.0 115.0 06:12:43 INFO - PROCESS | 1665 | 06:12:43 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:128.00 Median:131.50 stddev:18.73 (14.2%) stddev-sans-first:18.82 06:12:43 INFO - PROCESS | 1665 | Values: 145.0 110.0 132.0 153.0 107.0 129.0 131.0 109.0 155.0 109.0 06:12:43 INFO - PROCESS | 1665 | 06:12:43 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:231.50 Median:236.00 stddev:32.03 (13.6%) stddev-sans-first:31.29 06:12:43 INFO - PROCESS | 1665 | Values: 196.0 203.0 205.0 237.0 274.0 235.0 219.0 200.0 270.0 276.0 06:12:43 INFO - PROCESS | 1665 | 06:12:43 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:91.00 Median:78.50 stddev:33.31 (42.4%) stddev-sans-first:34.68 06:12:43 INFO - PROCESS | 1665 | Values: 73.0 81.0 76.0 143.0 61.0 62.0 83.0 87.0 160.0 84.0 06:12:43 INFO - PROCESS | 1665 | 06:12:43 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:71.50 stddev:26.06 (36.4%) stddev-sans-first:26.50 06:12:43 INFO - PROCESS | 1665 | Values: 69.0 72.0 127.0 71.0 72.0 95.0 135.0 71.0 74.0 115.0 06:12:43 INFO - PROCESS | 1665 | 06:12:43 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:90.00 Median:91.00 stddev:1.41 (1.6%) stddev-sans-first:1.45 06:12:43 INFO - PROCESS | 1665 | Values: 91.0 89.0 91.0 88.0 91.0 89.0 92.0 90.0 91.0 88.0 06:12:43 INFO - PROCESS | 1665 | 06:12:43 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:99.20 Median:97.00 stddev:7.35 (7.6%) stddev-sans-first:7.75 06:12:43 INFO - PROCESS | 1665 | Values: 97.0 97.0 97.0 120.0 98.0 97.0 97.0 97.0 95.0 97.0 06:12:43 INFO - PROCESS | 1665 | 06:12:43 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:109.40 Median:89.50 stddev:22.67 (25.3%) stddev-sans-first:23.15 06:12:43 INFO - PROCESS | 1665 | Values: 92.0 90.0 129.0 107.0 89.0 146.0 142.0 117.0 92.0 90.0 06:12:43 INFO - PROCESS | 1665 | 06:12:43 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.00 stddev:1.07 (1.9%) stddev-sans-first:1.12 06:12:43 INFO - PROCESS | 1665 | Values: 57.0 57.0 59.0 58.0 56.0 58.0 59.0 58.0 56.0 58.0 06:12:43 INFO - PROCESS | 1665 | 06:12:43 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:71.50 stddev:3.57 (5.0%) stddev-sans-first:3.50 06:12:43 INFO - PROCESS | 1665 | Values: 68.0 71.0 68.0 72.0 77.0 78.0 75.0 70.0 70.0 70.0 06:12:43 INFO - PROCESS | 1665 | 06:12:43 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:83.50 stddev:7.72 (9.2%) stddev-sans-first:7.92 06:12:43 INFO - PROCESS | 1665 | Values: 94.0 103.0 84.0 83.0 84.0 83.0 87.0 83.0 83.0 100.0 06:12:43 INFO - PROCESS | 1665 | 06:12:43 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:143.20 Median:140.50 stddev:11.65 (8.3%) stddev-sans-first:12.06 06:12:43 INFO - PROCESS | 1665 | Values: 136.0 139.0 137.0 138.0 136.0 142.0 150.0 147.0 173.0 134.0 06:12:43 INFO - PROCESS | 1665 | 06:12:43 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.50 Median:182.00 stddev:21.93 (12.0%) stddev-sans-first:22.43 06:12:43 INFO - PROCESS | 1665 | Values: 163.0 166.0 213.0 194.0 173.0 166.0 161.0 191.0 154.0 214.0 06:12:43 INFO - PROCESS | 1665 | 06:12:43 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.00 Median:80.00 stddev:11.20 (14.0%) stddev-sans-first:11.49 06:12:43 INFO - PROCESS | 1665 | Values: 66.0 67.0 76.0 85.0 69.0 58.0 84.0 86.0 88.0 61.0 06:12:43 INFO - PROCESS | 1665 | -------- Summary: end -------- 06:12:43 INFO - PROCESS | 1665 | 06:12:44 INFO - TEST-INFO | 1665: exit 0 06:12:44 INFO - TEST-OK | kraken | took 60731ms 06:12:44 INFO - SUITE-END | took 1173s 06:12:44 INFO - Completed test suite (00:19:33) 06:12:44 INFO - javascript benchmark 06:12:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7386.998040590218, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2891.797574169808, 3424.6232914379416, 3437.0, 3438.2607739336036, 3457.602375726792, 5888.440598143175, 5956.1065840124, 5976.820695379135, 5986.490794612257, 6051.576389652726, 4814.470408255098, 5780.739866705998, 5863.677497737623, 5904.084866845635, 5928.170056192126, 5267.0, 5294.655847369928, 5395.21769343445, 5402.702851343174, 5438.6736795792185, 513.5488792009418, 5274.0, 5304.124819404794, 5385.35375754908, 5426.484483974016, 5327.881144959563, 5331.0, 5354.41101478837, 5354.839354819362, 5382.2464854920345, 4389.429374181336, 5380.139177731544, 5403.243545903577, 5410.702411367373, 5435.374931882845, 4780.784864681098, 4783.7129772213775, 5294.338207724035, 5318.149096144637, 5360.59795515334, 5838.919799837001, 5882.176495290662, 5933.465988061095, 5983.790567330166, 5989.5507836911975, 5227.398849132361, 5457.0, 6134.130457564626, 6226.750929962796, 6299.181106456177, 5709.400512946164, 5746.02317606008, 6260.0, 6289.654069026202, 6433.581817181868, 6044.848878778066, 6066.96966515169, 6069.635821850659, 6085.756569737249, 6087.05650624154, 6299.622022678654, 6309.0, 6454.806355809334, 6479.935200648028, 6506.056621789909, 6125.142480052797, 6204.906926396107, 6215.378462153749, 6230.6573138476915, 6230.7819226326865, 6277.2153480814895, 6294.0558916162945, 6315.305316415191, 6332.68336583169, 6354.618722876549, 6141.815745527641, 6163.506919446433, 6196.47329976957, 6208.441240288305, 6279.026750853625, 6181.134641150243, 6208.410201030985, 6220.315765265817, 6235.095911092866, 6236.719347629368, 5091.516305950929, 5127.230915362651, 5129.358830146231, 5138.922916156261, 5149.76826042829, 4442.933355999663, 4526.094781043805, 4543.568361005699, 4610.976945115253, 4653.976730116396, 5838.970805146032, 5931.169636250928, 6014.188084608521, 6015.639061656315, 6094.573379863367, 6277.811665650038, 6285.214348206474, 6297.842553936097, 6316.684165791692, 6321.273053598803, 5852.882942341129, 5964.701764911737, 6013.879722405527, 6044.274687037496, 6049.153118563405, 4767.713937163781, 5583.274174357308, 5595.244641973363, 5609.915851262234, 5616.550675945915, 6269.62382257066, 6495.220573531206, 6504.82913075651, 6516.283208847118, 6532.640704761284, 6190.3190649029475, 6247.0, 6268.498520118471, 6296.6851657417865, 6304.5586808922935, 6494.155759751202, 6495.1556297681, 6495.350464953467, 6512.5766825156215, 6523.706433210612, 6107.765388666889, 6166.136740856194, 6241.687915604292, 6262.436380725757, 6284.874302514016, 6156.876862462816, 6209.192804935329, 6274.341194174546, 6319.431251187415, 6346.2067241594805, 6058.363871793398, 6070.1198326241565, 6210.192674952408, 6212.1303017578475, 6213.409726076015, 6112.169143789106, 6156.045812899008, 6194.194754681863, 6208.782692605737, 6250.343713909974, 5470.56235501151, 5834.658028653349, 6160.3223645398075, 6160.568760186744, 6203.596766210182, 6184.165137706532, 6197.225346831646, 6201.968990155201, 6206.131141640264, 6228.844278893064, 6081.969590152021, 6083.209182806207, 6127.647695153045, 6135.385782596223, 6157.4458298753325], "value": 5750.946851096558, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [451.53040837528965, 492.48535280631756, 506.5162769555074, 540.670191183378, 565.5080080330114, 39572.40641390382, 41660.99999999996, 41685.0, 41702.791486042566, 41774.95562610936, 35291.941241762725, 41799.58200417995, 41881.0, 41925.58074419255, 42121.36817947733, 8733.0, 9232.0, 9481.004494528079, 9565.473898935556, 9668.274879384038, 9530.904690953106, 9536.28477864163, 9600.03999600038, 9611.567479463405, 9650.0, 9595.472249026301, 9662.3719458235, 9688.757781055494, 9695.951520242388, 9750.707478775648, 8372.204640559137, 9541.379810312343, 9593.136617704406, 9607.327487075907, 9652.034796520291, 9589.520523973773, 9653.469059201741, 9654.27592930533, 9676.661316853877, 9724.95137524308, 40014.79992600047, 40033.19933601312, 40174.0, 40240.0, 40334.0, 3069.493533566959, 3299.6700329967052, 3394.253264281854, 3433.4334834752235, 3456.6716161964573, 24644.0, 29371.412571748446, 30580.0, 30598.235044123852, 31388.843055784575, 3146.496560550301, 3157.542156387311, 3165.7309128724087, 3178.8410579471165, 3264.8367581620823, 396144.0, 401071.0, 402907.0, 405235.97382013197, 405635.97182013904, 33193.502097468554, 33350.0, 33492.3301533968, 33496.0, 33503.16242093967, 35685.46471802925, 35751.82124089363, 36286.818565907, 36307.27695422854, 36311.0, 16066.518004459886, 16083.437079702155, 16117.516474505783, 16176.43382481631, 16263.674726505404, 10408.947955260175, 12242.75514489723, 12278.815817762741, 12375.009999200043, 12396.0, 19332.90333548323, 19359.322423715385, 19463.0, 19464.416067517996, 19510.92689902069, 7861.449698521049, 7906.232818513474, 7925.841483170304, 7967.601619918981, 8103.824945382887, 871.289898732531, 955.1356022799239, 965.4014511003223, 1006.441425009127, 1040.8802987656366, 30614.0, 30661.23346916345, 30703.23241918925, 30780.84609576938, 31364.215894602363, 1025.3027941000191, 1045.1899777672365, 1139.3448766959032, 1169.417072302036, 1170.1165619957048, 16088.678226435406, 16147.515574532783, 16312.592185195464, 16448.917755411385, 16536.75194872078, 693272.0, 708626.0, 711275.0, 715703.0, 716346.0, 60268.0, 60827.695861520406, 60894.69552652208, 61035.50680438782, 61062.77874442575, 1224.369449733388, 1324.5892475694336, 1340.7921772125337, 1397.916125032481, 1399.468202083202, 30114.84942575273, 30254.54618180773, 30476.390472190877, 30872.536911946787, 30931.381372371976, 51007.48992510027, 51222.0, 51247.0, 51660.741696291276, 51711.74144129255, 591265.0, 607752.0, 607852.0, 608767.0, 612554.0, 26847.463050739265, 26907.0, 27496.862515687295, 28011.859940700982, 28179.154625361272, 46050.53949460597, 46276.7686161567, 46295.76852115718, 46754.76622616865, 46816.0, 33677.49483757697, 40472.3929141069, 40570.79714601408, 41302.38046429366, 41838.0, 39810.40284395794, 40306.99232519211, 41161.79419102885, 41488.37767433551, 41531.0, 32159.839200803846, 38459.42310865283, 39153.0, 40050.79974600108, 40726.79636601917, 30542.84728576343, 31703.84148079245, 34170.31659366848, 36744.26511469809, 37291.6270837299, 25549.105781297567, 25549.74450255548, 26020.0, 26249.0, 26320.73679263183], "value": 19445.40273650879, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.129374030418, 371.2426649634745, 372.65901699944544, 377.6480200880847, 389.0992352703493, 19848.503787405323, 21062.262820801257, 21472.033758480866, 21777.564448711015, 21835.781642183574, 20139.093740781664, 20376.47176461764, 20811.27160549381, 20811.959402029875, 21275.468113297175, 5461.672299662033, 5945.31628862682, 5976.9241536523405, 6113.083037544359, 6122.418370254819, 5925.703714814264, 5940.613860099102, 5952.226210592617, 6006.609570377911, 6024.578279520435, 5798.0, 5869.647821130746, 5934.080217566263, 5947.226860508128, 5987.6108052976415, 5316.574674026068, 5320.255164277004, 5678.744456499426, 5957.791477298296, 5966.015607424792, 5750.281214848144, 5806.738696758656, 5816.418358164192, 5816.796412125555, 5825.0, 17787.46637600874, 21650.458738531506, 25583.0, 25635.615465768027, 26413.943442262287, 2129.1483406637312, 2224.1881713174575, 2365.6042934668626, 2369.620860662286, 3018.6981301869855, 8320.916790832074, 11066.89331066895, 11925.880741192565, 12220.694482637917, 12692.0, 1797.299053369187, 1867.141115087048, 1902.077492416177, 1923.1057558235348, 1925.6918892977196, 96938.0, 109569.45215273953, 123489.76510234873, 124285.0, 124685.0, 11432.199746017699, 11658.475368608433, 11762.294262344116, 11762.5883094093, 12062.062309767212, 14756.778648320284, 14802.851971480148, 14815.185164815823, 14819.703605927822, 14840.925795370955, 8252.0, 8526.872096918427, 8584.699535516227, 8612.0, 8612.741617751477, 7346.0, 8383.706570270011, 8395.286400656012, 8477.152284771597, 8487.10885357041, 4155.771432571177, 4245.469316335458, 4552.385427967249, 4585.060062687141, 4627.722336659811, 1604.6549991751829, 1613.3385312022015, 1928.469670840502, 2000.0899590686204, 2000.889951052706, 768.4851149729694, 945.3902233059638, 951.6764300137986, 953.032671838071, 1030.7320096774893, 17336.826631733773, 19493.707594386095, 20831.687524687142, 21436.928153592256, 21458.892705536684, 884.8009197930414, 916.3631276262934, 921.318224513855, 981.4994352880083, 1025.497506221946, 10953.890461095447, 11350.262232954996, 11359.886401135884, 11368.886311136783, 11376.488058037243, 579063.0, 592353.0, 599704.0, 602565.0, 603146.0, 74219.0, 74763.62618186875, 118553.0, 122883.0, 136255.0, 978.6623614852864, 988.0613417253638, 1020.8315627921459, 1031.1544533482472, 1038.7247379444452, 18516.907415462836, 18739.812601874353, 18852.622947541247, 18946.147423366256, 19207.3916843551, 51938.0, 52764.736176318875, 53761.0, 56097.71951140218, 56420.0, 59071.0, 82097.0, 82286.0, 82610.86945652813, 83763.5811820937, 8171.101178870201, 8272.462289951134, 8442.494922426764, 8447.070822209675, 8616.35377346714, 11216.270942388719, 12842.935785321388, 13281.269530175932, 13312.933435332761, 13332.533361332307, 11262.605808796652, 11372.0, 11619.360935148648, 11655.358955257543, 11810.527578896748, 9120.49837258957, 10614.62009938703, 11459.942700286445, 11536.25014374063, 11731.354775487089, 8243.0, 10576.293549370455, 11661.708457288636, 11675.649730508097, 11983.161178717406, 7077.398421134261, 8215.876761848458, 8260.339172866277, 8327.37544684139, 8476.940382452194, 9211.631534738535, 11640.185187036826, 11698.35659038761, 11743.47154378072, 11853.348065856117], "value": 9573.197528607205, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1532.1190315568547, 1566.655335826118, 1795.7126859702441, 1883.5479484923605, 1891.971620425693, 7997.520148791076, 8508.95745521273, 8537.35969802265, 9011.0, 9019.278457723383, 8642.17899299567, 8805.95597022014, 8812.691555795549, 8818.999999999984, 8820.558972051404, 2327.476317828492, 2332.24202134307, 2333.5216280662426, 2356.929292121239, 2363.9645405318934, 2349.1073392110975, 2360.36270207044, 2362.043372434167, 2367.0531787285136, 2402.1232250228713, 2366.266457398212, 2371.881405929705, 2383.7377888432256, 2386.3914701751114, 2401.8438801477937, 1980.2771988224338, 2302.7466978632337, 2349.823763217757, 2371.134535894395, 2372.715274167094, 2343.4610039690965, 2350.9412264693347, 2359.8112151027876, 2361.53949979754, 2361.6103342948395, 8791.208791208757, 8868.955655221682, 8874.955625221832, 8933.106689331014, 8949.507777072258, 4527.4340707411575, 4684.3910291662205, 5134.332536770234, 5273.472652734696, 5364.222187782789, 3581.5344005279408, 3639.090227443139, 3647.3434781739275, 3699.9260014799825, 3722.627737226283, 1079.4926384599305, 1100.14738577603, 1105.7843720474511, 1123.662901129658, 1126.8985791278742, 11482.827757583644, 11611.187216894821, 11611.303321800719, 11620.825687614608, 11643.18497705161, 4506.639468842484, 4509.12072145935, 4665.393498845128, 4674.579287864109, 4766.6901651392545, 9779.902200977898, 9864.506774661239, 9900.405975641484, 9913.0, 9935.403875767477, 5276.287701160294, 5287.762050707727, 5327.840164795062, 5329.440408757102, 5332.733363331896, 3996.680265578747, 4384.539623339567, 4845.466998630148, 4849.030193961222, 4852.611791056707, 3480.89557313281, 3890.533136023695, 3999.6200360965663, 4004.2992476316526, 4054.7769872656695, 1275.7639836630253, 1286.3696788573718, 1288.8388951381078, 1302.4659889445281, 1302.5180683147296, 902.444996327254, 919.2094798473307, 919.7792529792802, 932.3753085432776, 940.6407740814594, 5183.3261675981885, 5846.801405711819, 5914.467697907209, 5915.37888521699, 6114.419130182626, 809.3323008517996, 957.899420560845, 983.4246965525105, 994.9005099489993, 996.6860438961704, 4054.0, 4200.474940632421, 4206.621404073648, 4218.303979843292, 4275.187714334266, 10778.353298802096, 10813.729656758644, 10861.239713220157, 10900.836487452694, 10974.231803773659, 10646.680599582025, 10658.680239592824, 10679.359238445562, 10684.626038088629, 10868.782624347468, 6988.755393561201, 8131.308838748654, 8387.916120838836, 8391.664333426594, 8409.285210757154, 5997.820065398045, 6021.909671354845, 6056.545759068175, 6179.351168127461, 6193.916064688571, 9815.705528834147, 10033.749156271151, 10051.698707284168, 10158.695239142837, 10168.89831101709, 10249.975002499988, 10258.53836577341, 10258.58965641366, 10264.897351026395, 10281.897181028393, 6640.601563906181, 7309.415246780139, 7527.360174385239, 7634.045744281965, 7640.885386719315, 8504.744857654281, 8511.021232558334, 8540.14598540141, 8541.53021583819, 8566.271866891135, 7487.663055162422, 7637.541747495168, 7707.421943354158, 7750.263724946121, 7753.224677532427, 7438.590877501573, 7440.181580026301, 7490.250974902466, 7526.887096693664, 7619.276168763959, 5498.0, 7083.6812343443635, 7111.0, 7149.177844547944, 7421.628918554159, 4353.194658988097, 4941.234108713155, 5050.0, 5129.974350128375, 5134.0, 5076.923846142385, 5122.129238029469, 5147.073526765069, 5161.071007218737, 5275.604329675367], "value": 4620.908413004852, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.86252323930995, 302.59301239832416, 305.16080777860884, 305.97093276138776, 311.29025821127806, 5247.212918062292, 5349.54528865046, 5675.6878371689545, 5692.800751973682, 5729.971350143243, 5642.210090587321, 5646.632968857031, 5688.260526131608, 5693.092813907336, 5711.200431939532, 3905.4141878718137, 4052.412400201969, 4097.262492751303, 4296.0, 4299.075698724773, 4246.384274280227, 4282.336237883133, 4305.956940430603, 4306.138772245547, 4325.351197320396, 3672.265546890633, 4149.962509372657, 4184.393262976867, 4267.381229721688, 4287.228298906196, 3571.8571257149943, 4073.959260407388, 4289.935650965238, 4310.698251122422, 4333.003409215898, 3114.6573876873526, 3656.945145822815, 3691.575468821093, 3702.8518859245596, 3709.1454272863566, 4937.456879743226, 5084.9321642455125, 5536.141898005815, 5575.689712917461, 5594.776208951637, 4122.56713045129, 4398.690687389114, 4893.314935908976, 4963.528464795839, 5019.146745053313, 5173.327467429248, 5608.0, 5644.887102257973, 5675.120356344773, 5942.435468630473, 4126.91746165075, 4127.814248358831, 4132.834686612532, 4137.50349958004, 4159.896002599929, 4920.975395123037, 6009.669468179249, 6119.479844213247, 6214.720337584774, 6419.679016049179, 3355.547001154862, 4030.8387664493093, 4124.793760311973, 4142.523609784853, 4229.915401691949, 4243.554426785143, 4264.6801489888385, 4266.935995960063, 4267.466566679165, 4268.829246830092, 4720.763961801965, 4943.530364615356, 4977.0, 5000.724960127155, 5003.54968052877, 4805.8558243252755, 6041.577089603774, 6092.238470191226, 6099.4815440688035, 6155.538334624832, 1288.8657980976868, 1414.5544153591586, 1439.7480440922798, 1440.827100747917, 1450.2386247220293, 880.7093659092484, 889.6574818694849, 910.526526206369, 939.7838497145694, 974.2595627323144, 5440.211169380497, 5623.268975033219, 5635.196242536272, 5658.0, 5697.401772813795, 6079.75680972765, 6095.616932602359, 6103.206583144163, 6206.772478311253, 6216.44052035319, 5220.477952204749, 5221.172589593688, 5606.97196514023, 5729.942700573024, 5781.3523145904055, 3273.6235332937017, 3285.8499525166, 3312.9171770705443, 3315.983420082884, 3353.0, 6169.2855143736615, 6187.504999600022, 6383.467967687721, 6396.488280937514, 6525.608463492205, 5388.787522807415, 5454.490934170326, 5575.330960284792, 5721.485066343966, 6167.537434692326, 5280.653433374542, 5395.379531353945, 5975.282966044103, 6220.968895155495, 6450.516211284173, 5205.334293026195, 5872.946068044678, 6206.06908963659, 6238.875222495615, 6248.9062664059165, 5731.799387021601, 6136.29432615255, 6158.722857471335, 6205.348438413902, 6235.220597425322, 5710.600257982068, 6039.879202415839, 6085.847853803691, 6439.162908821823, 6559.967200163968, 3122.4551990127975, 3490.5636795400574, 4044.7775372353626, 4076.164386300742, 4126.3397856344045, 6277.874442511033, 6314.494840412664, 6347.746090156342, 6363.172787537591, 6432.35676432353, 5059.0519974635445, 5321.871251499431, 5431.131019036935, 5774.585226619505, 6091.9235785929595, 5364.839054828361, 5544.63959842609, 5615.2700148980375, 5926.785009073216, 5993.801239752154, 5629.915551266652, 5641.9435805641415, 5763.7118144093465, 5935.851603709942, 5987.311459182076, 6052.213212282375, 6071.51427885777, 6125.019996800491, 6128.938710612837, 6153.292371377349, 5236.6072544560075, 5764.0, 6013.428724271187, 6019.668918209541, 6034.09488576717], "value": 4357.26419253429, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.8708725972957, 739.8298391369981, 790.920907909209, 823.654065292577, 866.6230189867408, 15084.245787710612, 16141.659459378383, 16158.111303878282, 16161.515154545383, 16214.75677864833, 11840.703982400444, 14498.347574359153, 14547.127172369665, 14589.635259118528, 14650.706985860303, 654.4175683641563, 819.1235378145387, 831.4138532334689, 855.2730179347536, 863.3783675753448, 840.0801122770556, 849.902261239956, 850.783050322167, 851.93610479214, 852.5438890193748, 877.5436772878099, 908.8636704494313, 909.3225546967518, 909.9272058235325, 914.7667344827059, 880.0495464897895, 895.5746020640208, 903.9920488655102, 904.5477261369315, 904.7602385367883, 656.3207080671482, 663.8572706867998, 667.212689026948, 668.6456178225549, 668.8561959178751, 14803.18582477974, 14957.878159138108, 14998.325075371635, 15177.392904283926, 15250.542483725507, 14748.926255368762, 14759.0, 14775.778363324558, 14805.481808136772, 14821.703565928728, 11883.227590206696, 12162.270263784112, 12378.071644626689, 12388.81416778749, 12497.062720296015, 3796.449514820363, 3807.847686092553, 4012.879613611596, 4039.899002524931, 4041.191761647682, 85799.71300430498, 101017.49491252497, 102036.48981755118, 102271.0, 102577.0, 9672.613095476103, 11077.169212309109, 11526.0, 11556.248843825124, 11677.591284305008, 19343.613127737368, 23798.0, 23878.761212387653, 23889.52220955606, 24157.0, 7940.523568585903, 7972.003499562555, 8030.0, 8164.836703265902, 8430.0, 4438.245498265303, 4448.266036104006, 4488.192125417456, 4541.613962813198, 4588.908221835544, 3040.6959304069414, 3430.1081718753303, 3471.2363280078343, 3492.5459690240104, 3540.91147721309, 659.1365311442026, 668.0413606474627, 677.9525433219726, 680.2483256002047, 682.1507223506667, 534.7994502061727, 537.8278950735727, 551.8565173054955, 575.5942060847093, 604.2658170323078, 8754.912450875538, 8816.603252853636, 8930.598123084477, 8985.371024028385, 8985.415947963362, 516.3313509005847, 524.9685018898801, 567.103975718364, 571.6227289988587, 616.8396216983526, 4280.5505421930875, 4300.505441874162, 4308.418363520947, 4445.355423463579, 4480.038297745029, 148012.51987479988, 151856.0, 152874.0, 153259.0, 157042.0, 101592.49203753934, 126639.90361301106, 126695.09957350646, 129174.70825291627, 131466.0, 114299.0, 117709.0, 119013.40493297478, 120546.79453205355, 123723.76276237302, 8450.154984501502, 8575.22822945913, 8579.957100214458, 8615.03437326819, 8816.691415800673, 64723.02915456178, 65408.01887971589, 65701.67149164224, 66475.66762166159, 66750.66624666845, 80208.59895700484, 93301.06698932924, 96018.0, 98032.05903822897, 99453.0, 10771.09078476651, 11491.54033838637, 11623.476943537393, 11670.416479176178, 12073.879261207276, 11803.996660283972, 11915.40422978865, 11921.761564768829, 12228.938855305667, 12265.141440099107, 11905.702357441134, 11909.225900316798, 11927.701807454883, 12185.207961482829, 12259.877401225873, 9965.654636624253, 11607.941960290145, 11639.941800290944, 11872.287662740264, 11942.522299107939, 10555.660087741235, 10785.40680262593, 10810.567577297135, 10823.945880270549, 10940.39827809478, 8086.797830054061, 9622.855657165008, 9776.421046351514, 9849.556769945513, 10094.293399462262, 7595.810104747426, 8522.74431767048, 9413.105754953269, 9854.901450985399, 9994.300398972002], "value": 7537.227108673926, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1566.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 107.0, 108.0, 113.0, 117.0, 115.0, 112.0, 117.0, 115.0, 115.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 110.0, 132.0, 153.0, 107.0, 129.0, 131.0, 109.0, 155.0, 109.0], "value": 128.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 203.0, 205.0, 237.0, 274.0, 235.0, 219.0, 200.0, 270.0, 276.0], "value": 231.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 81.0, 76.0, 143.0, 61.0, 62.0, 83.0, 87.0, 160.0, 84.0], "value": 91.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 127.0, 71.0, 72.0, 95.0, 135.0, 71.0, 74.0, 115.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 91.0, 88.0, 91.0, 89.0, 92.0, 90.0, 91.0, 88.0], "value": 90.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 97.0, 120.0, 98.0, 97.0, 97.0, 97.0, 95.0, 97.0], "value": 99.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 129.0, 107.0, 89.0, 146.0, 142.0, 117.0, 92.0, 90.0], "value": 109.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 59.0, 58.0, 56.0, 58.0, 59.0, 58.0, 56.0, 58.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 68.0, 72.0, 77.0, 78.0, 75.0, 70.0, 70.0, 70.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 103.0, 84.0, 83.0, 84.0, 83.0, 87.0, 83.0, 83.0, 100.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 139.0, 137.0, 138.0, 136.0, 142.0, 150.0, 147.0, 173.0, 134.0], "value": 143.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 213.0, 194.0, 173.0, 166.0, 161.0, 191.0, 154.0, 214.0], "value": 179.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 76.0, 85.0, 69.0, 58.0, 84.0, 86.0, 88.0, 61.0], "value": 74.0, "unit": "score"}]}]} 06:12:44 INFO - Return code: 0 06:12:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:12:45 ERROR - # TBPL SUCCESS # 06:12:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:12:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:12:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:12:45 INFO - 2016-06-30 06:12:45.050 screenresolution[1670:11415] starting screenresolution argv=screenresolution get 06:12:45 INFO - 2016-06-30 06:12:45.053 screenresolution[1670:11415] Display 0: 1600x1200x32@60 06:12:45 INFO - 2016-06-30 06:12:45.058 screenresolution[1671:11418] starting screenresolution argv=screenresolution list 06:12:45 INFO - Available Modes on Display 0 06:12:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:12:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:12:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:12:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:12:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:12:45 INFO - Intel Iris: 06:12:45 INFO - Chipset Model: Intel Iris 06:12:45 INFO - Type: GPU 06:12:45 INFO - Bus: Built-In 06:12:45 INFO - VRAM (Dynamic, Max): 1536 MB 06:12:45 INFO - Vendor: Intel (0x8086) 06:12:45 INFO - Device ID: 0x0a2e 06:12:45 INFO - Revision ID: 0x0009 06:12:45 INFO - Displays: 06:12:45 INFO - Display: 06:12:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:12:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:12:45 INFO - Display Serial Number: 1600x1200 60 06:12:45 INFO - Main Display: Yes 06:12:45 INFO - Mirror: Off 06:12:45 INFO - Online: Yes 06:12:45 INFO - Rotation: Supported 06:12:45 INFO - Return code: 0 06:12:45 INFO - Running post-action listener: _resource_record_post_action 06:12:45 INFO - ##### 06:12:45 INFO - ##### Finished run-tests step (success) 06:12:45 INFO - ##### 06:12:45 INFO - Running post-run listener: _resource_record_post_run 06:12:45 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 33246720; Write bytes: 708728832; Read time: 332; Write time: 2062 06:12:45 INFO - TinderboxPrint: CPU usage
54.4% 06:12:45 INFO - TinderboxPrint: I/O read bytes / time
33,246,720 / 332 06:12:45 INFO - TinderboxPrint: I/O write bytes / time
708,728,832 / 2,062 06:12:45 INFO - TinderboxPrint: CPU idle
2,208.1 (45.6%) 06:12:45 INFO - TinderboxPrint: CPU system
978.3 (20.2%) 06:12:45 INFO - TinderboxPrint: CPU user
1,651.2 (34.1%) 06:12:45 INFO - TinderboxPrint: Swap in / out
436,703,232 / 0 06:12:45 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 407960064; Write bytes: 409069056; Read time: 30715; Write time: 755 06:12:45 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 30121472; Write bytes: 294365696; Read time: 302; Write time: 1284 06:12:45 INFO - Running post-run listener: _upload_blobber_files 06:12:45 INFO - Blob upload gear active. 06:12:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:12:45 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 06:12:45 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'] 06:12:45 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 06:12:46 INFO - (blobuploader) - INFO - Open directory for files ... 06:12:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:12:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:12:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:47 INFO - (blobuploader) - INFO - Done attempting. 06:12:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:12:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:12:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:48 INFO - (blobuploader) - INFO - Done attempting. 06:12:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:12:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:12:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:50 INFO - (blobuploader) - INFO - Done attempting. 06:12:50 INFO - (blobuploader) - INFO - Iteration through files over. 06:12:50 INFO - Return code: 0 06:12:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:12:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:12:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30ab2a1d91d54c0f17117381a4fb8d6a2899e823d46ec26d02d5a577617515170d475398d42e0c6db050d48b197a1097210b0b12465483a1e691f75770114341", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74d20fa388279a502c9c099a1b31e4d539ba799250f42fbf74243d83c237af3cdc622436d4f805da811f44ab8a367782717b32a749d2189083e5bd870ad8f919", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21721d491e0038969ff029521b25ab2a95b5dbd52096d78629968451edc1cb9815fc00ecb00d6bfd3ce1558953cbdc1c7ca1b3aaeec2327a013a6054de662ab3"} 06:12:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:12:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:12:50 INFO - Contents: 06:12:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30ab2a1d91d54c0f17117381a4fb8d6a2899e823d46ec26d02d5a577617515170d475398d42e0c6db050d48b197a1097210b0b12465483a1e691f75770114341", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74d20fa388279a502c9c099a1b31e4d539ba799250f42fbf74243d83c237af3cdc622436d4f805da811f44ab8a367782717b32a749d2189083e5bd870ad8f919", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21721d491e0038969ff029521b25ab2a95b5dbd52096d78629968451edc1cb9815fc00ecb00d6bfd3ce1558953cbdc1c7ca1b3aaeec2327a013a6054de662ab3"} 06:12:50 INFO - Running post-run listener: copy_logs_to_upload_dir 06:12:50 INFO - Copying logs to upload dir... 06:12:50 INFO - mkdir: /builds/slave/test/build/upload/logs 06:12:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1340.721180 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 20 secs) (at 2016-06-30 06:12:50.730536) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-06-30 06:12:50.734074) ========= 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.HoNPEXiwIW/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.QjpQzfTNUn/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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/30ab2a1d91d54c0f17117381a4fb8d6a2899e823d46ec26d02d5a577617515170d475398d42e0c6db050d48b197a1097210b0b12465483a1e691f75770114341", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74d20fa388279a502c9c099a1b31e4d539ba799250f42fbf74243d83c237af3cdc622436d4f805da811f44ab8a367782717b32a749d2189083e5bd870ad8f919", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21721d491e0038969ff029521b25ab2a95b5dbd52096d78629968451edc1cb9815fc00ecb00d6bfd3ce1558953cbdc1c7ca1b3aaeec2327a013a6054de662ab3"} build_url:https://queue.taskcluster.net/v1/task/RPHrugdRQNmFNTs9X7SJ6g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011428 build_url: 'https://queue.taskcluster.net/v1/task/RPHrugdRQNmFNTs9X7SJ6g/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/30ab2a1d91d54c0f17117381a4fb8d6a2899e823d46ec26d02d5a577617515170d475398d42e0c6db050d48b197a1097210b0b12465483a1e691f75770114341", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74d20fa388279a502c9c099a1b31e4d539ba799250f42fbf74243d83c237af3cdc622436d4f805da811f44ab8a367782717b32a749d2189083e5bd870ad8f919", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21721d491e0038969ff029521b25ab2a95b5dbd52096d78629968451edc1cb9815fc00ecb00d6bfd3ce1558953cbdc1c7ca1b3aaeec2327a013a6054de662ab3"}' ========= master_lag: 1.16 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-06-30 06:12:51.906306) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 06:12:51.906654) ========= 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.HoNPEXiwIW/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.QjpQzfTNUn/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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.005452 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 06:12:51.932438) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 06:12:51.933180) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 06:12:51.933989) ========= ========= Total master_lag: 1.38 =========