builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0221 starttime: 1468499542.96 results: success (0) buildid: 20160714030208 builduid: 092f3aad2b1b4eaf98c514ea48b51436 revision: 08f8a5aacd8308a73f6040fe522be7ba38497561 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 05:32:22.963834) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 05:32:22.964297) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 05:32:22.964583) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 05:32:22.992704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 05:32:22.993139) ========= 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.qzphXmloOK/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.2g74QW7ArY/Listeners TMPDIR=/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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-07-14 05:32:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.17M=0.001s 2016-07-14 05:32:23 (8.17 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.358001 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 05:32:23.373056) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 05:32:23.373383) ========= 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.qzphXmloOK/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.2g74QW7ArY/Listeners TMPDIR=/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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.020925 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 05:32:23.421583) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 05:32:23.422001) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 08f8a5aacd8308a73f6040fe522be7ba38497561 --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 08f8a5aacd8308a73f6040fe522be7ba38497561 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qzphXmloOK/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.2g74QW7ArY/Listeners TMPDIR=/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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-07-14 05:32:23,504 truncating revision to first 12 chars 2016-07-14 05:32:23,504 Setting DEBUG logging. 2016-07-14 05:32:23,504 attempt 1/10 2016-07-14 05:32:23,504 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/08f8a5aacd83?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-14 05:32:24,152 unpacking tar archive at: mozilla-central-08f8a5aacd83/testing/mozharness/ program finished with exit code 0 elapsedTime=0.936815 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 05:32:24.380582) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 05:32:24.380965) ========= script_repo_revision: 08f8a5aacd8308a73f6040fe522be7ba38497561 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 05:32:24.381382) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 05:32:24.381685) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 05:32:24.400031) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-14 05:32:24.400326) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.qzphXmloOK/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.2g74QW7ArY/Listeners TMPDIR=/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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:32:24 INFO - MultiFileLogger online at 20160714 05:32:24 in /builds/slave/test 05:32:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:32:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:32:24 INFO - {'append_to_log': False, 05:32:24 INFO - 'base_work_dir': '/builds/slave/test', 05:32:24 INFO - 'blob_upload_branch': 'Firefox', 05:32:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:32:24 INFO - 'branch': 'Firefox', 05:32:24 INFO - 'buildbot_json_path': 'buildprops.json', 05:32:24 INFO - 'config_files': ('talos/mac_config.py',), 05:32:24 INFO - 'default_actions': ('clobber', 05:32:24 INFO - 'read-buildbot-config', 05:32:24 INFO - 'download-and-extract', 05:32:24 INFO - 'populate-webroot', 05:32:24 INFO - 'create-virtualenv', 05:32:24 INFO - 'install', 05:32:24 INFO - 'run-tests'), 05:32:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:32:24 INFO - 'download_minidump_stackwalk': True, 05:32:24 INFO - 'download_symbols': 'ondemand', 05:32:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:32:24 INFO - 'tooltool.py': '/tools/tooltool.py', 05:32:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:32:24 INFO - '/tools/misc-python/virtualenv.py')}, 05:32:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:32:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:32:24 INFO - 'installer_path': 'installer.exe', 05:32:24 INFO - 'log_level': 'info', 05:32:24 INFO - 'log_name': 'talos', 05:32:24 INFO - 'log_to_console': True, 05:32:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:32:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:32:24 INFO - 'opt_config_files': (), 05:32:24 INFO - 'pip_index': False, 05:32:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:32:24 INFO - 'cmd': ('bash', 05:32:24 INFO - '-c', 05:32:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:32:24 INFO - 'enabled': True, 05:32:24 INFO - 'halt_on_failure': False, 05:32:24 INFO - 'name': 'check_screen_resolution'},), 05:32:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:32:24 INFO - 'cmd': ('bash', 05:32:24 INFO - '-c', 05:32:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:32:24 INFO - 'enabled': True, 05:32:24 INFO - 'halt_on_failure': False, 05:32:24 INFO - 'name': 'check_screen_resolution'},), 05:32:24 INFO - 'run_cmd_checks_enabled': True, 05:32:24 INFO - 'sps_profile': False, 05:32:24 INFO - 'sps_profile_interval': 0, 05:32:24 INFO - 'suite': 'dromaeojs', 05:32:24 INFO - 'system_bits': '32', 05:32:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:32:24 INFO - 'title': 't-yosemite-r7-0221', 05:32:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:32:24 INFO - 'use_talos_json': True, 05:32:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:32:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:32:24 INFO - 'work_dir': 'build'} 05:32:24 INFO - ##### 05:32:24 INFO - ##### Running clobber step. 05:32:24 INFO - ##### 05:32:24 INFO - Running pre-action listener: _resource_record_pre_action 05:32:24 INFO - Running main action method: clobber 05:32:24 INFO - rmtree: /builds/slave/test/build 05:32:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:32:26 INFO - Running post-action listener: _resource_record_post_action 05:32:26 INFO - ##### 05:32:26 INFO - ##### Finished clobber step (success) 05:32:26 INFO - ##### 05:32:26 INFO - ##### 05:32:26 INFO - ##### Running read-buildbot-config step. 05:32:26 INFO - ##### 05:32:26 INFO - Running pre-action listener: _resource_record_pre_action 05:32:26 INFO - Running main action method: read_buildbot_config 05:32:26 INFO - Using buildbot properties: 05:32:26 INFO - { 05:32:26 INFO - "project": "", 05:32:26 INFO - "product": "firefox", 05:32:26 INFO - "script_repo_revision": "production", 05:32:26 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:32:26 INFO - "repository": "", 05:32:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:32:26 INFO - "buildid": "20160714030208", 05:32:26 INFO - "stage_platform": "macosx64", 05:32:26 INFO - "basedir": "/builds/slave/test", 05:32:26 INFO - "nightly_build": "True", 05:32:26 INFO - "buildnumber": 47, 05:32:26 INFO - "slavename": "t-yosemite-r7-0221", 05:32:26 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 05:32:26 INFO - "platform": "yosemite_r7", 05:32:26 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:32:26 INFO - "branch": "mozilla-central", 05:32:26 INFO - "repo_path": "mozilla-central", 05:32:26 INFO - "revision": "08f8a5aacd8308a73f6040fe522be7ba38497561", 05:32:26 INFO - "pgo_build": "False", 05:32:26 INFO - "builduid": "092f3aad2b1b4eaf98c514ea48b51436", 05:32:26 INFO - "slavebuilddir": "test" 05:32:26 INFO - } 05:32:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/NqAAlQERTBmG7mNWZXHclg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 05:32:26 INFO - Running post-action listener: _resource_record_post_action 05:32:26 INFO - ##### 05:32:26 INFO - ##### Finished read-buildbot-config step (success) 05:32:26 INFO - ##### 05:32:26 INFO - ##### 05:32:26 INFO - ##### Running download-and-extract step. 05:32:26 INFO - ##### 05:32:26 INFO - Running pre-action listener: _resource_record_pre_action 05:32:26 INFO - Running main action method: download_and_extract 05:32:26 INFO - mkdir: /builds/slave/test/build/tests 05:32:26 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:32:26 INFO - https://queue.taskcluster.net/v1/task/NqAAlQERTBmG7mNWZXHclg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:32:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqAAlQERTBmG7mNWZXHclg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 05:32:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqAAlQERTBmG7mNWZXHclg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 05:32:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqAAlQERTBmG7mNWZXHclg/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:32:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqAAlQERTBmG7mNWZXHclg/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:32:28 INFO - Downloaded 1199 bytes. 05:32:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 05:32:28 INFO - Using the following test package requirements: 05:32:28 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 05:32:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:32:28 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 05:32:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:32:28 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 05:32:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:32:28 INFO - u'jsshell-mac.zip'], 05:32:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:32:28 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 05:32:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 05:32:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:32:28 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 05:32:28 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:32:28 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 05:32:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:32:28 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 05:32:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:32:28 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 05:32:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:32:28 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:32:28 INFO - https://queue.taskcluster.net/v1/task/NqAAlQERTBmG7mNWZXHclg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:32:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqAAlQERTBmG7mNWZXHclg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:32:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqAAlQERTBmG7mNWZXHclg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:32:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqAAlQERTBmG7mNWZXHclg/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:32:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqAAlQERTBmG7mNWZXHclg/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:32:29 INFO - Downloaded 18828069 bytes. 05:32:29 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:32:29 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:32:32 INFO - Return code: 0 05:32:32 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:32: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:32:32 INFO - https://queue.taskcluster.net/v1/task/NqAAlQERTBmG7mNWZXHclg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:32:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqAAlQERTBmG7mNWZXHclg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:32:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqAAlQERTBmG7mNWZXHclg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:32:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqAAlQERTBmG7mNWZXHclg/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:32:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqAAlQERTBmG7mNWZXHclg/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:32:33 INFO - Downloaded 18828069 bytes. 05:32:33 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:32:33 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:32:37 INFO - Return code: 0 05:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:37 INFO - https://queue.taskcluster.net/v1/task/NqAAlQERTBmG7mNWZXHclg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:32:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqAAlQERTBmG7mNWZXHclg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 05:32:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqAAlQERTBmG7mNWZXHclg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 05:32:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqAAlQERTBmG7mNWZXHclg/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:32:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqAAlQERTBmG7mNWZXHclg/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:32:38 INFO - Downloaded 14403317 bytes. 05:32:38 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:32:38 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:32:38 INFO - Return code: 0 05:32:38 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:32:38 INFO - https://queue.taskcluster.net/v1/task/NqAAlQERTBmG7mNWZXHclg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:32:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqAAlQERTBmG7mNWZXHclg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:32:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqAAlQERTBmG7mNWZXHclg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:32:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqAAlQERTBmG7mNWZXHclg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 05:32:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqAAlQERTBmG7mNWZXHclg/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:32:41 INFO - Downloaded 112893497 bytes. 05:32:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NqAAlQERTBmG7mNWZXHclg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:32:41 INFO - mkdir: /builds/slave/test/properties 05:32:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:32:41 INFO - Writing to file /builds/slave/test/properties/build_url 05:32:41 INFO - Contents: 05:32:41 INFO - build_url:https://queue.taskcluster.net/v1/task/NqAAlQERTBmG7mNWZXHclg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:32:42 INFO - Running post-action listener: _resource_record_post_action 05:32:42 INFO - Running post-action listener: set_extra_try_arguments 05:32:42 INFO - ##### 05:32:42 INFO - ##### Finished download-and-extract step (success) 05:32:42 INFO - ##### 05:32:42 INFO - ##### 05:32:42 INFO - ##### Running populate-webroot step. 05:32:42 INFO - ##### 05:32:42 INFO - Running pre-action listener: _resource_record_pre_action 05:32:42 INFO - Running main action method: populate_webroot 05:32:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:32:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:32:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:32:42 INFO - '--tppagecycles', 05:32:42 INFO - '7'], 05:32:42 INFO - 'tests': ['tsvgm']}}, 05:32:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:32:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:32:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:32:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:32:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:32:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:32:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:42 INFO - 'talos_options': ['--disable-e10s'], 05:32:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:42 INFO - 'talos_options': ['--disable-e10s'], 05:32:42 INFO - 'tests': ['damp', 'tps']}, 05:32:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:42 INFO - 'tests': ['damp', 'tps']}, 05:32:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:32:42 INFO - 'tests': ['dromaeo_dom']}, 05:32:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:32:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:32:42 INFO - 'tests': ['basic_compositor_video']}, 05:32:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:32:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:32:42 INFO - 'tests': ['a11yr', 05:32:42 INFO - 'ts_paint', 05:32:42 INFO - 'tpaint', 05:32:42 INFO - 'sessionrestore', 05:32:42 INFO - 'sessionrestore_no_auto_restore', 05:32:42 INFO - 'tabpaint']}, 05:32:42 INFO - 'other-e10s': {'tests': ['a11yr', 05:32:42 INFO - 'ts_paint', 05:32:42 INFO - 'tpaint', 05:32:42 INFO - 'sessionrestore', 05:32:42 INFO - 'sessionrestore_no_auto_restore', 05:32:42 INFO - 'tabpaint']}, 05:32:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:32:42 INFO - 'ts_paint', 05:32:42 INFO - 'tpaint', 05:32:42 INFO - 'sessionrestore', 05:32:42 INFO - 'sessionrestore_no_auto_restore', 05:32:42 INFO - 'tabpaint']}, 05:32:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:32:42 INFO - 'ts_paint', 05:32:42 INFO - 'tpaint', 05:32:42 INFO - 'sessionrestore', 05:32:42 INFO - 'sessionrestore_no_auto_restore', 05:32:42 INFO - 'tabpaint']}, 05:32:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:32:42 INFO - 'tests': ['a11yr', 05:32:42 INFO - 'ts_paint', 05:32:42 INFO - 'tpaint', 05:32:42 INFO - 'sessionrestore', 05:32:42 INFO - 'sessionrestore_no_auto_restore', 05:32:42 INFO - 'tabpaint']}, 05:32:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:32:42 INFO - 'tests': ['a11yr', 05:32:42 INFO - 'ts_paint', 05:32:42 INFO - 'tpaint', 05:32:42 INFO - 'sessionrestore', 05:32:42 INFO - 'sessionrestore_no_auto_restore', 05:32:42 INFO - 'tabpaint']}, 05:32:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:32:42 INFO - 'tests': ['tsvgx', 05:32:42 INFO - 'tsvgr_opacity', 05:32:42 INFO - 'tart', 05:32:42 INFO - 'tscrollx', 05:32:42 INFO - 'cart']}, 05:32:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:32:42 INFO - 'tsvgr_opacity', 05:32:42 INFO - 'tart', 05:32:42 INFO - 'tscrollx', 05:32:42 INFO - 'cart']}, 05:32:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:42 INFO - 'talos_options': ['--disable-e10s'], 05:32:42 INFO - 'tests': ['tp5o']}, 05:32:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:42 INFO - 'tests': ['tp5o']}, 05:32:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:42 INFO - 'talos_options': ['--disable-e10s', 05:32:42 INFO - '--xperf_path', 05:32:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:42 INFO - 'tests': ['tp5n']}, 05:32:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:42 INFO - 'talos_options': ['--xperf_path', 05:32:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:42 INFO - 'tests': ['tp5n']}}, 05:32:42 INFO - 'talos.zip': {'path': '', 05:32:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:32:42 INFO - Running post-action listener: _resource_record_post_action 05:32:42 INFO - ##### 05:32:42 INFO - ##### Finished populate-webroot step (success) 05:32:42 INFO - ##### 05:32:42 INFO - ##### 05:32:42 INFO - ##### Running create-virtualenv step. 05:32:42 INFO - ##### 05:32:42 INFO - Running pre-action listener: _resource_record_pre_action 05:32:42 INFO - Running main action method: create_virtualenv 05:32:42 INFO - Creating virtualenv /builds/slave/test/build/venv 05:32:42 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:32:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:32:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:32:42 INFO - Using real prefix '/tools/python27' 05:32:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:32:43 INFO - Installing distribute.............................................................................................................................................................................................done. 05:32:45 INFO - Installing pip.................done. 05:32:45 INFO - Return code: 0 05:32:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:45 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 0x101ba8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c3d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf60591260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b0cd30>, '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 0x101871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b04b20>, '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.qzphXmloOK/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.2g74QW7ArY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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:32:45 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:32:45 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:32:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qzphXmloOK/Render', 05:32:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:45 INFO - 'HOME': '/Users/cltbld', 05:32:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:45 INFO - 'LOGNAME': 'cltbld', 05:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:45 INFO - 'MOZ_NO_REMOTE': '1', 05:32:45 INFO - 'NO_EM_RESTART': '1', 05:32:45 INFO - 'PAGER': '/bin/cat', 05:32:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:45 INFO - 'PWD': '/builds/slave/test', 05:32:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:45 INFO - 'SHELL': '/bin/bash', 05:32:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2g74QW7ArY/Listeners', 05:32:45 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 05:32:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:45 INFO - 'USER': 'cltbld', 05:32:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:45 INFO - 'XPC_FLAGS': '0x0', 05:32:45 INFO - 'XPC_SERVICE_NAME': '0', 05:32:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:46 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:32:46 INFO - Cleaning up... 05:32:46 INFO - Return code: 0 05:32:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101ba8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c3d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf60591260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b0cd30>, '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 0x101871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b04b20>, '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.qzphXmloOK/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.2g74QW7ArY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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:32:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:32:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qzphXmloOK/Render', 05:32:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:46 INFO - 'HOME': '/Users/cltbld', 05:32:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:46 INFO - 'LOGNAME': 'cltbld', 05:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:46 INFO - 'MOZ_NO_REMOTE': '1', 05:32:46 INFO - 'NO_EM_RESTART': '1', 05:32:46 INFO - 'PAGER': '/bin/cat', 05:32:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:46 INFO - 'PWD': '/builds/slave/test', 05:32:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:46 INFO - 'SHELL': '/bin/bash', 05:32:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2g74QW7ArY/Listeners', 05:32:46 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 05:32:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:46 INFO - 'USER': 'cltbld', 05:32:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:46 INFO - 'XPC_FLAGS': '0x0', 05:32:46 INFO - 'XPC_SERVICE_NAME': '0', 05:32:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:46 INFO - Downloading/unpacking psutil>=3.1.1 05:32:46 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:32:46 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:32:46 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:32:46 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:32:46 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:32:46 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:32:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:32:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:49 INFO - Installing collected packages: psutil 05:32:49 INFO - Running setup.py install for psutil 05:32:49 INFO - building 'psutil._psutil_osx' extension 05:32:49 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:32:49 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:32:49 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:32:49 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:32:49 INFO - building 'psutil._psutil_posix' extension 05:32:49 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:32:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:32:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:32:49 INFO - ^ 05:32:49 INFO - 1 warning generated. 05:32:49 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:32:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:49 INFO - Successfully installed psutil 05:32:49 INFO - Cleaning up... 05:32:49 INFO - Return code: 0 05:32:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:49 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 0x101ba8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c3d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf60591260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b0cd30>, '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 0x101871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b04b20>, '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.qzphXmloOK/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.2g74QW7ArY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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:32:49 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:32:49 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:32:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qzphXmloOK/Render', 05:32:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:49 INFO - 'HOME': '/Users/cltbld', 05:32:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:49 INFO - 'LOGNAME': 'cltbld', 05:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:49 INFO - 'MOZ_NO_REMOTE': '1', 05:32:49 INFO - 'NO_EM_RESTART': '1', 05:32:49 INFO - 'PAGER': '/bin/cat', 05:32:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:49 INFO - 'PWD': '/builds/slave/test', 05:32:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:49 INFO - 'SHELL': '/bin/bash', 05:32:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2g74QW7ArY/Listeners', 05:32:49 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 05:32:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:49 INFO - 'USER': 'cltbld', 05:32:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:49 INFO - 'XPC_FLAGS': '0x0', 05:32:49 INFO - 'XPC_SERVICE_NAME': '0', 05:32:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:32:50 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:32:50 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:32:50 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:32:50 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:32:50 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:32:50 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:32:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:32:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:32:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:32:52 INFO - Installing collected packages: mozsystemmonitor 05:32:52 INFO - Running setup.py install for mozsystemmonitor 05:32:52 INFO - Successfully installed mozsystemmonitor 05:32:52 INFO - Cleaning up... 05:32:53 INFO - Return code: 0 05:32:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:32:53 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:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:53 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:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:53 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 0x101ba8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c3d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf60591260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b0cd30>, '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 0x101871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b04b20>, '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.qzphXmloOK/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.2g74QW7ArY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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:32:53 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:32:53 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:32:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qzphXmloOK/Render', 05:32:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:53 INFO - 'HOME': '/Users/cltbld', 05:32:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:53 INFO - 'LOGNAME': 'cltbld', 05:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:53 INFO - 'MOZ_NO_REMOTE': '1', 05:32:53 INFO - 'NO_EM_RESTART': '1', 05:32:53 INFO - 'PAGER': '/bin/cat', 05:32:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:53 INFO - 'PWD': '/builds/slave/test', 05:32:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:53 INFO - 'SHELL': '/bin/bash', 05:32:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2g74QW7ArY/Listeners', 05:32:53 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 05:32:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:53 INFO - 'USER': 'cltbld', 05:32:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:53 INFO - 'XPC_FLAGS': '0x0', 05:32:53 INFO - 'XPC_SERVICE_NAME': '0', 05:32:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:53 INFO - Downloading/unpacking jsonschema==2.5.1 05:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:32:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:32:55 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:32:55 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:32:55 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:32:55 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:32:55 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:32:55 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:32:56 INFO - Downloading functools32-3.2.3-2.tar.gz 05:32:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:32:56 INFO - warning: no files found matching '*.txt' 05:32:56 INFO - no previously-included directories found matching 'build' 05:32:56 INFO - no previously-included directories found matching 'dist' 05:32:56 INFO - no previously-included directories found matching '.git*' 05:32:56 INFO - Installing collected packages: jsonschema, functools32 05:32:56 INFO - Running setup.py install for functools32 05:32:56 INFO - warning: no files found matching '*.txt' 05:32:56 INFO - no previously-included directories found matching 'build' 05:32:56 INFO - no previously-included directories found matching 'dist' 05:32:56 INFO - no previously-included directories found matching '.git*' 05:32:56 INFO - Successfully installed jsonschema functools32 05:32:56 INFO - Cleaning up... 05:32:56 INFO - Return code: 0 05:32:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:32: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:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101ba8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c3d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf60591260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b0cd30>, '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 0x101871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b04b20>, '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.qzphXmloOK/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.2g74QW7ArY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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:32:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:32:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qzphXmloOK/Render', 05:32:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:56 INFO - 'HOME': '/Users/cltbld', 05:32:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:56 INFO - 'LOGNAME': 'cltbld', 05:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:56 INFO - 'MOZ_NO_REMOTE': '1', 05:32:56 INFO - 'NO_EM_RESTART': '1', 05:32:56 INFO - 'PAGER': '/bin/cat', 05:32:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:56 INFO - 'PWD': '/builds/slave/test', 05:32:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:56 INFO - 'SHELL': '/bin/bash', 05:32:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2g74QW7ArY/Listeners', 05:32:56 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 05:32:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:56 INFO - 'USER': 'cltbld', 05:32:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:56 INFO - 'XPC_FLAGS': '0x0', 05:32:56 INFO - 'XPC_SERVICE_NAME': '0', 05:32:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:56 INFO - Downloading/unpacking blobuploader==1.2.4 05:32:56 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:32:56 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:32:56 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:32:56 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:32:56 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:32:56 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:32:59 INFO - Downloading blobuploader-1.2.4.tar.gz 05:32:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:32:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:32:59 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:32:59 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:32:59 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:32:59 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:32:59 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:32:59 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:32:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:32:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:32:59 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:32:59 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:32:59 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:32:59 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:32:59 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:32:59 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:33:00 INFO - Downloading docopt-0.6.1.tar.gz 05:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:33:00 INFO - Installing collected packages: blobuploader, requests, docopt 05:33:00 INFO - Running setup.py install for blobuploader 05:33:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:33:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:33:00 INFO - Running setup.py install for requests 05:33:01 INFO - Running setup.py install for docopt 05:33:01 INFO - Successfully installed blobuploader requests docopt 05:33:01 INFO - Cleaning up... 05:33:01 INFO - Return code: 0 05:33:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:01 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 0x101ba8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c3d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf60591260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b0cd30>, '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 0x101871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b04b20>, '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.qzphXmloOK/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.2g74QW7ArY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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:33:01 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:33:01 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:33:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qzphXmloOK/Render', 05:33:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:01 INFO - 'HOME': '/Users/cltbld', 05:33:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:01 INFO - 'LOGNAME': 'cltbld', 05:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:01 INFO - 'MOZ_NO_REMOTE': '1', 05:33:01 INFO - 'NO_EM_RESTART': '1', 05:33:01 INFO - 'PAGER': '/bin/cat', 05:33:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:01 INFO - 'PWD': '/builds/slave/test', 05:33:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:01 INFO - 'SHELL': '/bin/bash', 05:33:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2g74QW7ArY/Listeners', 05:33:01 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 05:33:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:01 INFO - 'USER': 'cltbld', 05:33:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:01 INFO - 'XPC_FLAGS': '0x0', 05:33:01 INFO - 'XPC_SERVICE_NAME': '0', 05:33:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:33:01 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-bY1lUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:33:01 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-uQGHNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:33:01 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-QbK2Ta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:33:01 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-xrL3vG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:33:02 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-e6YgQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:33:02 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-Qcigj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:33:02 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-gAR77g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:33:02 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-7glsNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:33:02 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-Or3vkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:33:02 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-Ovd8p6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:33:02 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-EbRplg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:33:02 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-dx_u4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:33:02 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-YsvIJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:33:02 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-d5XXmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:03 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-KQTb3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:33:03 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-ViKNvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:33:03 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-SOGoAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:33:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:33:03 INFO - Running setup.py install for manifestparser 05:33:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:33:03 INFO - Running setup.py install for mozcrash 05:33:03 INFO - Running setup.py install for mozdebug 05:33:03 INFO - Running setup.py install for mozdevice 05:33:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:33:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:33:03 INFO - Running setup.py install for mozfile 05:33:04 INFO - Running setup.py install for mozhttpd 05:33:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:33:04 INFO - Running setup.py install for mozinfo 05:33:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:33:04 INFO - Running setup.py install for mozInstall 05:33:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:33:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:33:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:33:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:33:04 INFO - Running setup.py install for mozleak 05:33:04 INFO - Running setup.py install for mozlog 05:33:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:33:04 INFO - Running setup.py install for moznetwork 05:33:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:33:05 INFO - Running setup.py install for mozprocess 05:33:05 INFO - Running setup.py install for mozprofile 05:33:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:33:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:33:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:33:05 INFO - Running setup.py install for mozrunner 05:33:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:33:05 INFO - Running setup.py install for mozscreenshot 05:33:05 INFO - Running setup.py install for moztest 05:33:05 INFO - Running setup.py install for mozversion 05:33:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:33:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:33:05 INFO - Cleaning up... 05:33:05 INFO - Return code: 0 05:33:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:05 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:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:05 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:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:05 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 0x101ba8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c3d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf60591260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b0cd30>, '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 0x101871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b04b20>, '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.qzphXmloOK/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.2g74QW7ArY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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:33:05 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:33:05 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:33:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qzphXmloOK/Render', 05:33:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:05 INFO - 'HOME': '/Users/cltbld', 05:33:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:05 INFO - 'LOGNAME': 'cltbld', 05:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:05 INFO - 'MOZ_NO_REMOTE': '1', 05:33:05 INFO - 'NO_EM_RESTART': '1', 05:33:05 INFO - 'PAGER': '/bin/cat', 05:33:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:05 INFO - 'PWD': '/builds/slave/test', 05:33:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:05 INFO - 'SHELL': '/bin/bash', 05:33:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2g74QW7ArY/Listeners', 05:33:05 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 05:33:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:05 INFO - 'USER': 'cltbld', 05:33:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:05 INFO - 'XPC_FLAGS': '0x0', 05:33:05 INFO - 'XPC_SERVICE_NAME': '0', 05:33:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:33:06 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-o4fRPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:33:06 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:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:33:06 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-OmlSax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:33:06 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:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:33:06 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-dN_NBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:33:06 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:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:33:06 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-_Bepn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:33:06 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:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:33:06 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-m0o0PB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:33:06 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:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:33:06 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-XuwMOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:33:06 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:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:33:06 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-zZcMNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:33:06 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:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:33:06 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-ahUeSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:33:07 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:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:33:07 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-yornG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:33:07 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:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:33:07 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-5jnxjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:33:07 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:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:33:07 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-hTNHUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:33:07 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:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:33:07 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-PLEOmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:33:07 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-nCW3gS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:33:07 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:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:33:07 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-SeB49B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:07 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-ilQziA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:07 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:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:33:07 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-wKhCYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:33:07 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:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:33:07 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-cfUJk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:33:08 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:33:08 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:33:08 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:33:08 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:33:08 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:33:08 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:33:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:10 INFO - Downloading blessings-1.6.tar.gz 05:33:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:33:10 INFO - Installing collected packages: blessings 05:33:10 INFO - Running setup.py install for blessings 05:33:10 INFO - Successfully installed blessings 05:33:10 INFO - Cleaning up... 05:33:10 INFO - Return code: 0 05:33:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:33:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:11 INFO - Reading from file tmpfile_stdout 05:33:11 INFO - Current package versions: 05:33:11 INFO - blessings == 1.6 05:33:11 INFO - blobuploader == 1.2.4 05:33:11 INFO - docopt == 0.6.1 05:33:11 INFO - functools32 == 3.2.3-2 05:33:11 INFO - jsonschema == 2.5.1 05:33:11 INFO - manifestparser == 1.1 05:33:11 INFO - mozInstall == 1.12 05:33:11 INFO - mozcrash == 0.17 05:33:11 INFO - mozdebug == 0.1 05:33:11 INFO - mozdevice == 0.48 05:33:11 INFO - mozfile == 1.2 05:33:11 INFO - mozhttpd == 0.7 05:33:11 INFO - mozinfo == 0.9 05:33:11 INFO - mozleak == 0.1 05:33:11 INFO - mozlog == 3.2 05:33:11 INFO - moznetwork == 0.27 05:33:11 INFO - mozprocess == 0.23 05:33:11 INFO - mozprofile == 0.28 05:33:11 INFO - mozrunner == 6.12 05:33:11 INFO - mozscreenshot == 0.1 05:33:11 INFO - mozsystemmonitor == 0.3 05:33:11 INFO - moztest == 0.7 05:33:11 INFO - mozversion == 1.4 05:33:11 INFO - psutil == 3.1.1 05:33:11 INFO - requests == 1.2.3 05:33:11 INFO - wsgiref == 0.1.2 05:33:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:11 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 0x101ba8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c3d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf60591260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b0cd30>, '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 0x101871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b04b20>, '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.qzphXmloOK/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.2g74QW7ArY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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:33:11 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:33:11 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:33:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qzphXmloOK/Render', 05:33:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:11 INFO - 'HOME': '/Users/cltbld', 05:33:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:11 INFO - 'LOGNAME': 'cltbld', 05:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:11 INFO - 'MOZ_NO_REMOTE': '1', 05:33:11 INFO - 'NO_EM_RESTART': '1', 05:33:11 INFO - 'PAGER': '/bin/cat', 05:33:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:11 INFO - 'PWD': '/builds/slave/test', 05:33:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:11 INFO - 'SHELL': '/bin/bash', 05:33:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2g74QW7ArY/Listeners', 05:33:11 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 05:33:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:11 INFO - 'USER': 'cltbld', 05:33:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:11 INFO - 'XPC_FLAGS': '0x0', 05:33:11 INFO - 'XPC_SERVICE_NAME': '0', 05:33:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:11 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:33:11 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:33:11 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:33:11 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:33:11 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:33:11 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:33:11 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:33:11 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:33:11 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:33:11 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:33:11 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:33:11 INFO - Cleaning up... 05:33:11 INFO - Return code: 0 05:33:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:11 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 0x101ba8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c3d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf60591260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b0cd30>, '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 0x101871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b04b20>, '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.qzphXmloOK/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.2g74QW7ArY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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:33:11 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:33:11 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:33:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qzphXmloOK/Render', 05:33:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:11 INFO - 'HOME': '/Users/cltbld', 05:33:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:11 INFO - 'LOGNAME': 'cltbld', 05:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:11 INFO - 'MOZ_NO_REMOTE': '1', 05:33:11 INFO - 'NO_EM_RESTART': '1', 05:33:11 INFO - 'PAGER': '/bin/cat', 05:33:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:11 INFO - 'PWD': '/builds/slave/test', 05:33:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:11 INFO - 'SHELL': '/bin/bash', 05:33:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2g74QW7ArY/Listeners', 05:33:11 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 05:33:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:11 INFO - 'USER': 'cltbld', 05:33:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:11 INFO - 'XPC_FLAGS': '0x0', 05:33:11 INFO - 'XPC_SERVICE_NAME': '0', 05:33:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:33:11 INFO - Cleaning up... 05:33:11 INFO - Return code: 0 05:33:11 INFO - Running post-action listener: _resource_record_post_action 05:33:11 INFO - Running post-action listener: _start_resource_monitoring 05:33:11 INFO - Starting resource monitoring. 05:33:11 INFO - ##### 05:33:11 INFO - ##### Finished create-virtualenv step (success) 05:33:11 INFO - ##### 05:33:11 INFO - ##### 05:33:11 INFO - ##### Running install step. 05:33:11 INFO - ##### 05:33:11 INFO - Running pre-action listener: _resource_record_pre_action 05:33:11 INFO - Running main action method: install 05:33:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:12 INFO - Reading from file tmpfile_stdout 05:33:12 INFO - Detecting whether we're running mozinstall >=1.0... 05:33:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:33:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:33:12 INFO - Reading from file tmpfile_stdout 05:33:12 INFO - Output received: 05:33:12 INFO - Usage: mozinstall [options] installer 05:33:12 INFO - Options: 05:33:12 INFO - -h, --help show this help message and exit 05:33:12 INFO - -d DEST, --destination=DEST 05:33:12 INFO - Directory to install application into. [default: 05:33:12 INFO - "/builds/slave/test"] 05:33:12 INFO - --app=APP Application being installed. [default: firefox] 05:33:12 INFO - mkdir: /builds/slave/test/build/application 05:33:12 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:33:12 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:33:46 INFO - Reading from file tmpfile_stdout 05:33:46 INFO - Output received: 05:33:46 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:33:46 INFO - Running post-action listener: _resource_record_post_action 05:33:46 INFO - ##### 05:33:46 INFO - ##### Finished install step (success) 05:33:46 INFO - ##### 05:33:46 INFO - ##### 05:33:46 INFO - ##### Running run-tests step. 05:33:46 INFO - ##### 05:33:46 INFO - Running pre-action listener: _resource_record_pre_action 05:33:46 INFO - Running main action method: run_tests 05:33:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:33:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:33:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:33:46 INFO - 2016-07-14 05:33:46.646 screenresolution[1941:64228] starting screenresolution argv=screenresolution get 05:33:46 INFO - 2016-07-14 05:33:46.649 screenresolution[1941:64228] Display 0: 1600x1200x32@60 05:33:46 INFO - 2016-07-14 05:33:46.654 screenresolution[1942:64230] starting screenresolution argv=screenresolution list 05:33:46 INFO - Available Modes on Display 0 05:33:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:33:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:33:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:33:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:33:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:33:46 INFO - Intel Iris: 05:33:46 INFO - Chipset Model: Intel Iris 05:33:46 INFO - Type: GPU 05:33:46 INFO - Bus: Built-In 05:33:46 INFO - VRAM (Dynamic, Max): 1536 MB 05:33:46 INFO - Vendor: Intel (0x8086) 05:33:46 INFO - Device ID: 0x0a2e 05:33:46 INFO - Revision ID: 0x0009 05:33:46 INFO - Displays: 05:33:46 INFO - Display: 05:33:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:33:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:33:46 INFO - Display Serial Number: 1600x1200 60 05:33:46 INFO - Main Display: Yes 05:33:46 INFO - Mirror: Off 05:33:46 INFO - Online: Yes 05:33:46 INFO - Rotation: Supported 05:33:46 INFO - Return code: 0 05:33:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:33:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:33:46 INFO - Python 2.7.3 05:33:46 INFO - Return code: 0 05:33:46 INFO - grabbing minidump binary from tooltool 05:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:46 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 0x101b0cd30>, '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 0x101871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b04b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:33:46 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:33:46 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:33:46 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:33:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:33:47 INFO - Return code: 0 05:33:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:33:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:33:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:33:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:33:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:33:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NqAAlQERTBmG7mNWZXHclg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0221', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:33:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NqAAlQERTBmG7mNWZXHclg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0221 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:33:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qzphXmloOK/Render', 05:33:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:47 INFO - 'HOME': '/Users/cltbld', 05:33:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:47 INFO - 'LOGNAME': 'cltbld', 05:33:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:33:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:33:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:47 INFO - 'MOZ_NO_REMOTE': '1', 05:33:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:33:47 INFO - 'NO_EM_RESTART': '1', 05:33:47 INFO - 'PAGER': '/bin/cat', 05:33:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:47 INFO - 'PWD': '/builds/slave/test', 05:33:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:33:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:47 INFO - 'SHELL': '/bin/bash', 05:33:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2g74QW7ArY/Listeners', 05:33:47 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 05:33:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:47 INFO - 'USER': 'cltbld', 05:33:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:47 INFO - 'XPC_FLAGS': '0x0', 05:33:47 INFO - 'XPC_SERVICE_NAME': '0', 05:33:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NqAAlQERTBmG7mNWZXHclg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0221', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:33:47 INFO - mozversion application_buildid: 20160714030208 05:33:47 INFO - mozversion application_changeset: 08f8a5aacd8308a73f6040fe522be7ba38497561 05:33:47 INFO - mozversion application_display_name: Nightly 05:33:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:33:47 INFO - mozversion application_name: Firefox 05:33:47 INFO - mozversion application_remotingname: firefox 05:33:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:33:47 INFO - mozversion application_vendor: Mozilla 05:33:47 INFO - mozversion application_version: 50.0a1 05:33:47 INFO - mozversion platform_buildid: 20160714030208 05:33:47 INFO - mozversion platform_changeset: 08f8a5aacd8308a73f6040fe522be7ba38497561 05:33:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:33:47 INFO - mozversion platform_version: 50.0a1 05:33:47 INFO - using testdate: 1468499627 05:33:47 INFO - actual date: 1468499627 05:33:47 INFO - starting webserver on 'localhost:50557' 05:33:47 INFO - SUITE-START | Running 2 tests 05:33:47 INFO - TEST-START | dromaeo_css 05:33:47 INFO - operating with platform_type : mac_ 05:33:47 INFO - Initialising browser for dromaeo_css test... 05:33:47 INFO - TEST-INFO | started process 1952 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/tmpQj_afb/profile http://localhost:50557/getInfo.html) 05:33:49 INFO - PROCESS | 1952 | __metrics Screen width/height:1600/1200 05:33:49 INFO - PROCESS | 1952 | colorDepth:24 05:33:49 INFO - PROCESS | 1952 | Browser inner width/height: 1024/689 05:33:49 INFO - PROCESS | 1952 | __metrics 05:33:49 INFO - PROCESS | 1952 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:33:49 INFO - PROCESS | 1952 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:33:50 INFO - TEST-INFO | 1952: exit 0 05:33:50 INFO - Browser initialized. 05:33:50 INFO - Running cycle 1/1 for dromaeo_css test... 05:33:50 INFO - TEST-INFO | started process 1955 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/tmpQj_afb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:02 INFO - PROCESS | 1955 | RSS: Main: 244080640 05:34:02 INFO - PROCESS | 1955 | 05:34:53 INFO - PROCESS | 1955 | 1468499693951 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:37:04 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:50557/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50557/tests/dromaeo/cssquery-ext.html) 05:37:05 INFO - PROCESS | 1955 | RSS: Main: 380895232 05:37:05 INFO - PROCESS | 1955 | 05:40:08 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:50557/tests/dromaeo/cssquery-ext.html (next: http://localhost:50557/tests/dromaeo/cssquery-jquery.html) 05:40:09 INFO - PROCESS | 1955 | RSS: Main: 376242176 05:40:09 INFO - PROCESS | 1955 | 05:43:11 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:50557/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50557/tests/dromaeo/cssquery-mootools.html) 05:43:12 INFO - PROCESS | 1955 | RSS: Main: 376832000 05:43:12 INFO - PROCESS | 1955 | 05:46:14 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:50557/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50557/tests/dromaeo/cssquery-prototype.html) 05:46:15 INFO - PROCESS | 1955 | RSS: Main: 370171904 05:46:15 INFO - PROCESS | 1955 | 05:49:18 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:50557/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50557/tests/dromaeo/cssquery-yui.html) 05:49:19 INFO - PROCESS | 1955 | RSS: Main: 334659584 05:49:19 INFO - PROCESS | 1955 | 05:52:22 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:50557/tests/dromaeo/cssquery-yui.html (next: http://localhost:50557/tests/dromaeo/cssquery-dojo.html) 05:52:22 INFO - PROCESS | 1955 | RSS: Main: 410181632 05:52:22 INFO - PROCESS | 1955 | 05:52:22 INFO - PROCESS | 1955 | __start_tp_report 05:52:22 INFO - PROCESS | 1955 | _x_x_mozilla_page_load 05:52:22 INFO - PROCESS | 1955 | _x_x_mozilla_page_load_details 05:52:22 INFO - PROCESS | 1955 | |i|pagename|runs| 05:52:22 INFO - PROCESS | 1955 | |0;dojo.html;3286.605607327121;3292.8518216680245;3308.404487192306;3313.840155945418;3335.349606826668;5498.615096943216;5587.022271102556;5664.830055098343;5683.943160568393;5689.772409103636;5665.433456654332;5687.061634830258;5694.914576281359;5717.685527295997;5722.914156287659;4660.277656963176;4987.905079866447;5122.282880396738;5172.069027575035;5201.55786758126;5262.447443018466;5280;5285.154375299952;5286.365636123652;5286.524212820846;5149.871253218681;5185.844424667247;5188.04021256067;5203.921941170866;5274.4198138204765;5265.973670131644;5279.155335146396;5291.417944026154;5295.417504074549;5341.332333458317;5084.44071152173;5090.9236361454605;5119.2321151827155;5190.273361729361;5201.141811601081;5578.693171875545;5592.356878958891;5651.4348565143155;5660.377358490563;5687.26065611472;6209.534284928648;6235.376462353774;6243.219597550306;6243.344448832898;6243.968780156116;6098.613770999311;6148.354422785588;6202.81391558254;6289.496840252768;6299.968500157515;5782.768689252467;5787.594868359174;5794.0439827428845;5794.275715535558;5799.710014499258;6229.470495007975;6246.46905013079;6262.780802671885;6277.05844123376;6279.7488100476385;5974.940250597525;6025.8192254232445;6099.2985806632805;6105.8473538161015;6119.694015299217;6198.566100373021;6251.281102673251;6258.749650013949;6258.74965001404;6266.561340706198;6129.908051379233;6179.227596550431;6192.102145188923;6206.286277078104;6224.968875155595;5818.912716309259;5868.501177399969;6222.942099843038;6237.189165408558;6257.5932564383165;4892.339534162914;4919.2129259318335;4958.975205123951;4967.5777558907175;4974;4442.289233722653;4446.6220371268155;4461.643068554507;4488.1248156609145;4489.685721999494;5508.14623733322;5577.96807590597;5650.3219613646625;5697.4587414195585;5699.145128230799;6201.348858369806;6235.345288744707;6258.906116408258;6269.467095296951;6272.655003974825;5683.588289331812;5710.400407957188;5718.628289161191;5733.397993210736;5776.393478684761;5293.311869456946;5300.655457395257;5343.519083282523;5410.242566040757;5414.648047876875;6239.78160764371;6274.1843560336865;6287.276963149114;6287.811365659038;6293.339199383999;6260.593061450991;6280.905786413299;6290.21372328459;6291.811245662638;6299.055141728777;5662.631928924607;5929.258842644669;6185.381461853779;6189.102580125947;6277.654728989767;6122.123717501779;6222.066689996536;6232.5325600581045;6239.188905442445;6253.530985176039;6263.154474145932;6271.874562508816;6285.811425657238;6294.181756371826;6329.620222786463;5888.116782482662;5900;6152.50779937595;6154.107654390178;6168.35232300602;5830.708464576839;6094.8171554853425;6100.725467353891;6123.069106197319;6138.020573254662;5938.584299099021;5940.019896716994;5952.910706339495;5977.372375900468;5980.401959803985;5968.194293770459;6017.939820601738;6086.934786412448;6113.354060514726;6136.758624822573;5932.940670593239;5947.613405128653;5965.791197308247;5981.581289309706;5983 05:52:22 INFO - PROCESS | 1955 | |1;ext.html;466.5357968821024;486.6009871905037;508.80411041748926;515.8323544847924;541.3503795445466;29335.706642933565;30644.693553064462;41869.02244286796;42479.78760106203;42594.361084583754;44351.89120271995;44599.55400445995;44760;44827.32759008618;44886.77556612212;9693.612255509772;9865.506724663774;9882.258830587734;9890.20878329732;9894.356866803635;8521.062683104854;8712.390132690714;8714.564271786418;8792.252658524001;8837.469751814879;10360.119389851872;12032.33822139782;12039.578614748485;12178.634640960785;12237.877621223763;11932;12022.879771202264;12026.819597706042;12047.39763011846;12048.674645788957;8542.57287135647;11495.540178392854;11751.177417580773;11796.705082372924;11832.763344733143;41650.79174604138;41771.7911410441;41963.160736785096;41988;41995.79002105001;3585.7848529088337;3606.6753992140834;3736.178040831013;3743.6069212732814;3893.415987601854;31186.532202016762;31493.52759708606;32652.346953061042;33095.17262068467;33253.83373083143;3257.4788033914697;3275.606927168731;3292.340370624033;3331.7334613230882;3384.6446123157207;508379;510486.9999999963;510544;512519;513215;59967;60046;60585;60672.39327606667;60764;65046;65133.02300465497;65178.67410663011;65188.67405662941;65291.673541631986;16108;16318.673626527403;16330.591735206477;16344.591385215226;16349.591260218353;12589.748205035849;12663.36683165838;12668.303243321705;12697.93651031739;12699;14786.63033424173;15015.099094054172;15093.169875656724;15304.923475382551;16948.152592370334;4911.933761804169;6366.808995730135;6453.870922581616;6518.837029074216;6588.11060506835;905.5608030105394;960.9957594313959;989.223459584223;1013.964511242103;1084.2789544952675;30629;30789.84605077005;30887;31224.375512489623;31392.529112063337;947.5688561704408;1013.7516308504464;1075.5697720911699;1084.2627013630806;1111.9444027798577;16117.919410402874;16171;16176.75734863978;16360.509184724477;16496.83503164977;685675;690943;693117;693622;693880;52458.21312680313;60189;60350.396496035355;60496;60720.39279607236;1427.6787722762294;1450.376338174574;1459.5840185547067;1464.0556840837812;1467.442371898693;30769.846150769103;31736.841315793274;31886.043418697474;32300.35399292048;32537.511937320487;52174.95650087053;52385.47614523806;52672.94654106973;52701.20948185857;52703.47296526986;626272;730999;864763;893089;894037;38641.42037869491;39742;40006;40118.59881401266;40125;44427.88930276769;45015.32477012913;47570;48555.5144448551;48618.270725939845;35327;36050.91847244587;36411;38184.427233592076;40352.19295614013;36812.63187368092;39151.021224469616;39175.21649566936;40085.79957100196;40241;37580.87257382283;37939.43090853584;38015.61984380121;38581.807090964365;38743;33185.50221746627;34059.74168453618;34269.82865085659;34530.30939381148;34574;24366.878165609058;25460;25700.100496482533;25729;26062.739372606033 05:52:22 INFO - PROCESS | 1955 | |2;jquery.html;361.8462153584726;380.20726784654;391.4500127321113;394.8223299515217;415.2110989120672;15513.922430387847;16132.032078075308;20988.58022839546;21314;21536;17494.65010699785;19734.90132549339;20906.372808815722;21537.353879383645;21564.813935233557;5071.934893672334;5506.834794956148;5638.238837756912;5679.460451257145;5681.431856814327;5591.077472217079;5607.4112218217115;5641.8589535261535;5644.633098848582;5651.361105279485;5395.406505284415;5620.662760234379;5638.718064096799;5642.125470552071;5642.153676948449;5595.300587426572;5612.07400778873;5627.5779316551425;5631.63394379364;5634.633748806335;5243.4232234454175;5467;5477.1510415885605;5480.972595137038;5482.972585137089;13881.791773123412;14004.369803358772;14051.227182504957;21582.460438489008;26638.866805665846;2174.2824867793747;2226.654868495386;2463.5442443147895;2813.240425085236;3019.290466740314;10288.43413612251;10336.689899303034;10706.625268115578;10772.08437282832;10804.621838235702;1853.3420635674277;1921.9423417297364;1928.53715108373;1993.7707163676073;2039.5614942787372;107694.92305076927;108539.45730271377;123018.76981230163;123374.76625233813;126531;11578.073754099652;11643;11672.731635142174;11711.297322160697;11903.107266955012;14724.263786810616;14803.925980370244;14844.851551484348;14855;14866.925665371604;7305.4155667546465;8311;8421.073681894986;8497.235248827636;8606.483610983361;8327.250547450758;8351.331893448509;8373.204545568162;8454.435929353089;8461.619227134794;4527.705699129546;4608.585227329557;4615.30770384445;4665.460398068629;4695.7886895089805;1786.5087101047056;1858.8419984301215;1927.3254360973547;1959.304446921351;2001.5296405344732;822.0722948776285;858.9441686290371;903.5482258870564;950.7005293332578;1000.9549570269355;20501.282455114;21203.46991325229;21465.248716294856;21471.46321341979;21513.462163445725;941.317544780029;952.1811242331589;1015.1979935850595;1032.607609108534;1042.3954106618144;10961.629796275465;11330.943345283385;11371.090312774959;11396.715082122848;11403.828942565868;530958;616202;620528;621018;640257;83309;90065;106370;125670.74329256773;127778.36110819572;947.1049857884233;982.268210183418;1024.1346062577259;1038.6728180623231;1041.807265655856;19583;19652.803471965668;20325.680407448694;20975.580488390453;21322;59473.702631486565;60819.78360432678;61709.38290617216;61834.69082654558;61983;80329;81857.59071204606;86659.1334086651;87127.56436217779;87485;5840.795572154954;8321.667133314842;8364.581770911553;8382.916170838458;8551.315894728283;12107.152499325315;13152.342382880626;13166.012549058667;13407.597772066854;13431.731365372443;11248.325100493996;11488.597899073493;11493.195476316578;11604.6518604442;11759.882401175879;11209;11268.323900565993;11275.267107637977;11385.03227225695;11557.47991340375;11553.422328883691;11731.706707332385;11786.46960886745;11794.351310677652;12019.158658893793;8245.464044837307;8311.542865142233;8381.790455238668;8384.83230335402;8559.871601925852;11056.557737690724;11452.312861228353;11613.941930290295;11743.530258789553;11771.705707357385 05:52:22 INFO - PROCESS | 1955 | |3;mootools.html;1527.8319384867666;1565.536223630905;1764.232558836906;1921.0778826163441;1926.662834004049;8300.58497075146;8514.233718965292;8707.956460217705;8710.477371357723;8711.43375680581;7763.9611801941055;7996.800079998003;8412.327013838894;8523.701670441536;8715;2342.9531409371843;2369.230000249917;2371.81025517959;2373.0507796881298;2377.892994815229;2335.065973610552;2343.16817529777;2373.1219448803968;2380.071772008909;2383.2611890314056;2080.4798800299927;2169.023939227346;2275.6927814745045;2354.2937118864356;2354.81161507079;1990.7710613279514;2358.6108292131776;2360.3980984848927;2384.940376490584;2386.0575072846214;2367.3963139399516;2367.869767162805;2369.9407514812096;2372.9288121356385;2378.750231225714;8922.86615700765;8968.551572421353;8988.685396011173;8997.865032024525;9014.729558113268;5187.896242075138;5264.92102618461;5334.03987282289;5339.786408543654;5340.332458442695;3437.6906078452807;3494.52823868777;3596.3166998270244;3603.1172362771026;3618.113562177257;1060.1624716473975;1075.1291453922347;1086.8750093739243;1100.4772732951865;1100.7358234023857;11734.88265117355;11748.118891083117;11750.58872939443;11751.647450576496;11774.94112529432;4539.296409056601;4599.4710608280475;4751.619870410359;4757.072370887644;4759.976200119047;9921.305508614329;9960.950195249123;9980.850287245697;9993.850092248622;10006;5319.015982043335;5323.095073837457;5334.093204155303;5334.493223143795;5341.893162136736;4672.95327046732;4885.267209918541;4885.731284779371;4888.706677599355;4896.436909755353;3735.813209339522;3760.9059773505883;3773.75470594416;3801.3727734923427;3821.8534439667987;1076.7308172956762;1136.5908273021705;1146.266389510714;1146.8910453506903;1154.6593754842343;806.954993283699;888.2228050455851;927.1516562345513;934.9154980222909;945.4610871803006;5792.218050563204;5850.531957443394;5914.585978981516;5920.822375328747;6018.127371531104;927.0682963621517;932.4545141092536;951.7144856543009;973.4354074636693;976.7302506741208;3819.8090095495113;3909.667678247324;3952.150287688103;3983.2630963271886;3990;10238.18094552434;10296.948515257525;10409.32339397952;10467.685969420929;10477.528511217013;10347.482625868677;10442.530086146142;10446.42544660051;10449.68650940473;10481.737956550995;7852.528848269122;8141.0230772307705;8143.226393492609;8143.79640508992;8145.429819912668;5615.943840561542;5624;5686.09022556389;5716.171155182558;5889.0283103287475;9644;9967;10006.8498972514;10108.747281318027;10147.036031576989;9288;9306.488143152192;9760.951195243979;10256.43589602579;10336.586536538454;7317.743878964211;7453.440991925736;7683.500572462772;7690.2694244046725;7690.423218258541;8308.210719981593;8317.251447369767;8399.076101628938;8408.915910840813;8423.199796019368;7283.890741638986;7486.401087913063;7525.6989720410575;7630.084389873251;7640.73257435987;7321.633918303957;7399.667014984447;7409.851802963803;7542.811429714301;7565.962170189334;7091.184513780775;7140.143182818095;7171.282871712787;7176.497645164788;7177.641117944187;4896.730679812645;4986.775595098302;5025.572826309804;5088.4148322941855;5099.413567439644;5081.611801938718;5095.847124586268;5111.284420181103;5208.401033881;5215.4002289735645 05:52:22 INFO - PROCESS | 1955 | |4;prototype.html;298.1071690287589;303.2418952618454;312.58738465225906;315.9241781972327;316.1984369623006;4865.489123642015;5188.143956247224;5414.864628384287;5448.482394172557;5450.236966824643;4243.851465198719;5153.613478989072;5281.9207711884255;5325.3077099977045;5407.621466497347;3748.5568056298384;4143.6892233082635;4156.088199428252;4156.771377574232;4156.916861662758;3512.877049303275;3527.6648718371844;3921.960780392202;4164.375343698439;4171.332586786115;3810.942835857464;3914.3737002079674;4096.242195193884;4099.282625540533;4126.46355973723;3762.5673047599603;4031.8185681644395;4062.1672557125717;4095.7747323897174;4109.712320137592;3215.26049008727;3553.7690050146657;3556.8399422025814;3560.359135355635;3563.376409128418;4363.716358436724;4750;4956.801727930914;5247.422783493813;5272;3559.4660800879815;4111.527174374955;4171.6036976487185;4495.302818309021;4722.338872557844;5177.938522602857;5281.287026251445;5646.571974051157;5648.096304591246;5684.204211410406;3012.6083609130674;3374.3251349730153;3960.7819621012327;3994.2810294147043;4010.639042486161;4860.4896485869185;5033.446320904697;5416.916616676681;5521.972390138104;5925.851853703649;3949.447077409165;3959.3862951242604;3967.781772002568;3974.1654252607277;3980.3233450313514;4004.619561141687;4005.319095753729;4019.4774679291504;4024.597540245952;4027.154297597537;4442.644588432918;4531.614812740954;4675.883102922454;4682.331071289401;4689.373950587614;4430.047539778963;5688.971555142198;5697.715114244271;5714.228579141846;5841.153032810304;1275.859655437901;1308.941097650608;1342.7113170668354;1368.8083668286447;1373.272165752153;882.6645874567623;916.5554705967601;918.9264858811413;921.5346250143634;921.6820197032014;4470.6870519064005;4832.221472653238;5276.92084618731;5287.339082614673;5307.230451584499;4741.739204343794;4894.521512815733;5851.941480585139;5861;5878.588498805043;4439.955600444019;4684.601808846218;5203.297554830126;5257.6056795739705;5266.4470230626;2340.520193360391;2694.3802925327286;2906.215321863085;2933.1347252560545;3004.1438190115714;5258.579313654898;5652.463016013472;5726.312842458931;5949.494292985059;5958.182754259992;4886.267059941038;5220.415894132429;5678.205051292823;5954.159567079209;6004.819855404257;4846.994863184777;5972.46247837688;6001.879962400728;6013.398660134127;6016.639001659827;5059.342285502861;5435.565154787687;5552.194931734956;5738.196652468574;5828.329742079715;5742.5118864895285;5749.482546570829;5752.856178595402;5754.5684073695475;5763.682997435181;4520.615747661485;5039.445660977363;5993.101034844633;6033.043808533875;6040.546958978182;3327.1349449142913;3338.5659864217496;3838.443425703313;3922.2547715933883;3961.7226794124135;5118.488151184852;5202.297689811827;5668.659880407189;5924.822255332347;5926.911096333472;4927.191679049034;5566.526845218202;5769.74036168365;5791.420857914175;5804.419558044162;5100.444364468873;5424.349078110652;5500.4048825840055;5601.355844077821;5672.376038635664;4712.835050773207;4926.7975815720065;5472.50747432733;5541.224228608079;5654.293213348332;4604.401427814362;4966.751662416937;5157.587393008625;5610.242617246783;5755.3381361144;4936.407631084149;5087.64386492942;5408.891822163456;5623.98768221724;5632.521235694848 05:52:22 INFO - PROCESS | 1955 | |5;yui.html;736.8820988641818;770.6378002338902;793.4009822583951;815.4210510537514;859.1151114352219;14837.258137093157;15950.441734539294;15955.521334359973;15956.521304360858;15986;14618.634534136625;14688.779668304984;14689.485867994623;14701.338439770208;14703;688.5214775730857;720.2257573108928;870.4168207301124;889.4485419040204;894.6376717429451;868.3313848336777;880.2078129683305;883.3992884838308;883.5626364949359;883.9602217900177;937.8452555328363;939.286142531674;940.525034857396;940.5626383731563;941.0824446165003;732.1982429239973;903.4037535226785;934.0892629686002;934.1592566689966;939.2955283537347;703.1281211298004;704.0214102397671;704.3801454719813;704.4751660013271;704.4822055788991;14857;14900.701985960328;14926.029808062442;14930.850691493055;14947.850521494755;13661;13758.65603359914;13777.517786877412;13860.514881979183;13886.375113119833;11874.0500759939;11883.346415947119;11911.761764764657;12120.09099317546;12123;4516.909661806745;4569.383133276999;4678.20470520009;4735.195016847144;4769.4515130760055;92240;111752.44123779329;112561;112844;115895;8941.687040953666;10345.327553709136;10430.947845260725;10458.947705261426;10651.040117397493;21366.78633213679;21374.358769236947;21397.572048559254;21402.678959815614;21409.464763381042;7659.961700191463;7680.846383072308;7704.30661240491;7746.49647772893;7754.302112809762;3687.539057617798;4250.53244143144;4271.829126834892;4324.805383757738;4438.289873620205;3443.7589368744448;3558.3061303045656;3559.359315323215;3563.625819288989;3568.892933212008;593.3087952535334;644.8678021005683;645.2998496631114;652.3020368206069;659.1793217444313;580.5152697497552;599.0146209485372;616.8427051101941;625.140431906129;654.4404534123352;8274.793130171673;8406.495610263404;8547.487150770974;8571.871421928676;8924.687635932842;623.5074291309814;632.550888868899;638.0206383201763;641.8619996700731;644.4007073421762;3537.345591065661;4154.709170358046;4171.541130475645;4210.915781684349;4235.7035007549175;141778;141852;152838;155016;160538.56499327507;74425;75421.62289188629;94596;127511.08733369007;127950;92691;95451.52274238723;112222;113624.94318153325;121254;7343.898415237757;7518.624068796647;8156.347492200491;8180.713675021584;8224.794380140305;55685.721571391885;64709;65938.67030664816;66484;67141.99287010796;96638;98710;98746.01253987369;99712.0115195384;100488;10611.522481488506;10613.09788667972;10632.787344253225;10759;10933.726656833644;9548.283878709264;12021.338826364634;12075.396230188631;12569.103577890517;12595.307258100525;10172.84740728875;12736.85368316856;12885.362181011224;12924.224546527239;13181.340932953122;11768.352740599006;13759.724805504035;13924.373403196678;14529.128252304896;14601.196934168298;10670.30643008202;11393.715157121138;12177.57378491784;12465;13265.933670331586;10806.35161890289;10833.458327083772;10910.727231819268;11045.83431248548;11086.22396432242;10613.893861061599;10750.301230419998;10756.515956781806;10950.39772812503;10988.835167472655 05:52:22 INFO - PROCESS | 1955 | __end_tp_report 05:52:22 INFO - PROCESS | 1955 | __start_cc_report 05:52:22 INFO - PROCESS | 1955 | _x_x_mozilla_cycle_collect,1342 05:52:22 INFO - PROCESS | 1955 | __end_cc_report 05:52:22 INFO - PROCESS | 1955 | __startTimestamp1468500742627__endTimestamp 05:52:22 INFO - PROCESS | 1955 | 05:52:22 INFO - PROCESS | 1955 | ------- Summary: start ------- 05:52:22 INFO - PROCESS | 1955 | Number of tests: 6 05:52:22 INFO - PROCESS | 1955 | 05:52:22 INFO - PROCESS | 1955 | [#0] dojo.html Cycles:165 Average:5722.57 Median:5932.94 stddev:639.32 (10.8%) stddev-sans-first:612.06 05:52:22 INFO - PROCESS | 1955 | Values: 3286.6 3292.9 3308.4 3313.8 3335.3 5498.6 5587.0 5664.8 5683.9 5689.8 5665.4 5687.1 5694.9 5717.7 5722.9 4660.3 4987.9 5122.3 5172.1 5201.6 5262.4 5280.0 5285.2 5286.4 5286.5 5149.9 5185.8 5188.0 5203.9 5274.4 5266.0 5279.2 5291.4 5295.4 5341.3 5084.4 5090.9 5119.2 5190.3 5201.1 5578.7 5592.4 5651.4 5660.4 5687.3 6209.5 6235.4 6243.2 6243.3 6244.0 6098.6 6148.4 6202.8 6289.5 6300.0 5782.8 5787.6 5794.0 5794.3 5799.7 6229.5 6246.5 6262.8 6277.1 6279.7 5974.9 6025.8 6099.3 6105.8 6119.7 6198.6 6251.3 6258.7 6258.7 6266.6 6129.9 6179.2 6192.1 6206.3 6225.0 5818.9 5868.5 6222.9 6237.2 6257.6 4892.3 4919.2 4959.0 4967.6 4974.0 4442.3 4446.6 4461.6 4488.1 4489.7 5508.1 5578.0 5650.3 5697.5 5699.1 6201.3 6235.3 6258.9 6269.5 6272.7 5683.6 5710.4 5718.6 5733.4 5776.4 5293.3 5300.7 5343.5 5410.2 5414.6 6239.8 6274.2 6287.3 6287.8 6293.3 6260.6 6280.9 6290.2 6291.8 6299.1 5662.6 5929.3 6185.4 6189.1 6277.7 6122.1 6222.1 6232.5 6239.2 6253.5 6263.2 6271.9 6285.8 6294.2 6329.6 5888.1 5900.0 6152.5 6154.1 6168.4 5830.7 6094.8 6100.7 6123.1 6138.0 5938.6 5940.0 5952.9 5977.4 5980.4 5968.2 6017.9 6086.9 6113.4 6136.8 5932.9 5947.6 5965.8 5981.6 5983.0 05:52:22 INFO - PROCESS | 1955 | 05:52:22 INFO - PROCESS | 1955 | [#1] ext.html Cycles:180 Average:79230.78 Median:38692.21 stddev:183191.03 (473.5%) stddev-sans-first:183609.48 05:52:22 INFO - PROCESS | 1955 | Values: 466.5 486.6 508.8 515.8 541.4 29335.7 30644.7 41869.0 42479.8 42594.4 44351.9 44599.6 44760.0 44827.3 44886.8 9693.6 9865.5 9882.3 9890.2 9894.4 8521.1 8712.4 8714.6 8792.3 8837.5 10360.1 12032.3 12039.6 12178.6 12237.9 11932.0 12022.9 12026.8 12047.4 12048.7 8542.6 11495.5 11751.2 11796.7 11832.8 41650.8 41771.8 41963.2 41988.0 41995.8 3585.8 3606.7 3736.2 3743.6 3893.4 31186.5 31493.5 32652.3 33095.2 33253.8 3257.5 3275.6 3292.3 3331.7 3384.6 508379.0 510487.0 510544.0 512519.0 513215.0 59967.0 60046.0 60585.0 60672.4 60764.0 65046.0 65133.0 65178.7 65188.7 65291.7 16108.0 16318.7 16330.6 16344.6 16349.6 12589.7 12663.4 12668.3 12697.9 12699.0 14786.6 15015.1 15093.2 15304.9 16948.2 4911.9 6366.8 6453.9 6518.8 6588.1 905.6 961.0 989.2 1014.0 1084.3 30629.0 30789.8 30887.0 31224.4 31392.5 947.6 1013.8 1075.6 1084.3 1111.9 16117.9 16171.0 16176.8 16360.5 16496.8 685675.0 690943.0 693117.0 693622.0 693880.0 52458.2 60189.0 60350.4 60496.0 60720.4 1427.7 1450.4 1459.6 1464.1 1467.4 30769.8 31736.8 31886.0 32300.4 32537.5 52175.0 52385.5 52672.9 52701.2 52703.5 626272.0 730999.0 864763.0 893089.0 894037.0 38641.4 39742.0 40006.0 40118.6 40125.0 44427.9 45015.3 47570.0 48555.5 48618.3 35327.0 36050.9 36411.0 38184.4 40352.2 36812.6 39151.0 39175.2 40085.8 40241.0 37580.9 37939.4 38015.6 38581.8 38743.0 33185.5 34059.7 34269.8 34530.3 34574.0 24366.9 25460.0 25700.1 25729.0 26062.7 05:52:22 INFO - PROCESS | 1955 | 05:52:22 INFO - PROCESS | 1955 | [#2] jquery.html Cycles:180 Average:34936.00 Median:21536.68 stddev:100952.45 (468.7%) stddev-sans-first:101202.27 05:52:22 INFO - PROCESS | 1955 | Values: 361.8 380.2 391.5 394.8 415.2 15513.9 16132.0 20988.6 21314.0 21536.0 17494.7 19734.9 20906.4 21537.4 21564.8 5071.9 5506.8 5638.2 5679.5 5681.4 5591.1 5607.4 5641.9 5644.6 5651.4 5395.4 5620.7 5638.7 5642.1 5642.2 5595.3 5612.1 5627.6 5631.6 5634.6 5243.4 5467.0 5477.2 5481.0 5483.0 13881.8 14004.4 14051.2 21582.5 26638.9 2174.3 2226.7 2463.5 2813.2 3019.3 10288.4 10336.7 10706.6 10772.1 10804.6 1853.3 1921.9 1928.5 1993.8 2039.6 107694.9 108539.5 123018.8 123374.8 126531.0 11578.1 11643.0 11672.7 11711.3 11903.1 14724.3 14803.9 14844.9 14855.0 14866.9 7305.4 8311.0 8421.1 8497.2 8606.5 8327.3 8351.3 8373.2 8454.4 8461.6 4527.7 4608.6 4615.3 4665.5 4695.8 1786.5 1858.8 1927.3 1959.3 2001.5 822.1 858.9 903.5 950.7 1001.0 20501.3 21203.5 21465.2 21471.5 21513.5 941.3 952.2 1015.2 1032.6 1042.4 10961.6 11330.9 11371.1 11396.7 11403.8 530958.0 616202.0 620528.0 621018.0 640257.0 83309.0 90065.0 106370.0 125670.7 127778.4 947.1 982.3 1024.1 1038.7 1041.8 19583.0 19652.8 20325.7 20975.6 21322.0 59473.7 60819.8 61709.4 61834.7 61983.0 80329.0 81857.6 86659.1 87127.6 87485.0 5840.8 8321.7 8364.6 8382.9 8551.3 12107.2 13152.3 13166.0 13407.6 13431.7 11248.3 11488.6 11493.2 11604.7 11759.9 11209.0 11268.3 11275.3 11385.0 11557.5 11553.4 11731.7 11786.5 11794.4 12019.2 8245.5 8311.5 8381.8 8384.8 8559.9 11056.6 11452.3 11613.9 11743.5 11771.7 05:52:22 INFO - PROCESS | 1955 | 05:52:22 INFO - PROCESS | 1955 | [#3] mootools.html Cycles:180 Average:5692.22 Median:5092.13 stddev:3170.44 (62.3%) stddev-sans-first:3163.89 05:52:22 INFO - PROCESS | 1955 | Values: 1527.8 1565.5 1764.2 1921.1 1926.7 8300.6 8514.2 8708.0 8710.5 8711.4 7764.0 7996.8 8412.3 8523.7 8715.0 2343.0 2369.2 2371.8 2373.1 2377.9 2335.1 2343.2 2373.1 2380.1 2383.3 2080.5 2169.0 2275.7 2354.3 2354.8 1990.8 2358.6 2360.4 2384.9 2386.1 2367.4 2367.9 2369.9 2372.9 2378.8 8922.9 8968.6 8988.7 8997.9 9014.7 5187.9 5264.9 5334.0 5339.8 5340.3 3437.7 3494.5 3596.3 3603.1 3618.1 1060.2 1075.1 1086.9 1100.5 1100.7 11734.9 11748.1 11750.6 11751.6 11774.9 4539.3 4599.5 4751.6 4757.1 4760.0 9921.3 9961.0 9980.9 9993.9 10006.0 5319.0 5323.1 5334.1 5334.5 5341.9 4673.0 4885.3 4885.7 4888.7 4896.4 3735.8 3760.9 3773.8 3801.4 3821.9 1076.7 1136.6 1146.3 1146.9 1154.7 807.0 888.2 927.2 934.9 945.5 5792.2 5850.5 5914.6 5920.8 6018.1 927.1 932.5 951.7 973.4 976.7 3819.8 3909.7 3952.2 3983.3 3990.0 10238.2 10296.9 10409.3 10467.7 10477.5 10347.5 10442.5 10446.4 10449.7 10481.7 7852.5 8141.0 8143.2 8143.8 8145.4 5615.9 5624.0 5686.1 5716.2 5889.0 9644.0 9967.0 10006.8 10108.7 10147.0 9288.0 9306.5 9761.0 10256.4 10336.6 7317.7 7453.4 7683.5 7690.3 7690.4 8308.2 8317.3 8399.1 8408.9 8423.2 7283.9 7486.4 7525.7 7630.1 7640.7 7321.6 7399.7 7409.9 7542.8 7566.0 7091.2 7140.1 7171.3 7176.5 7177.6 4896.7 4986.8 5025.6 5088.4 5099.4 5081.6 5095.8 5111.3 5208.4 5215.4 05:52:22 INFO - PROCESS | 1955 | 05:52:22 INFO - PROCESS | 1955 | [#4] prototype.html Cycles:180 Average:4505.76 Median:4961.78 stddev:1388.84 (28.0%) stddev-sans-first:1356.35 05:52:22 INFO - PROCESS | 1955 | Values: 298.1 303.2 312.6 315.9 316.2 4865.5 5188.1 5414.9 5448.5 5450.2 4243.9 5153.6 5281.9 5325.3 5407.6 3748.6 4143.7 4156.1 4156.8 4156.9 3512.9 3527.7 3922.0 4164.4 4171.3 3810.9 3914.4 4096.2 4099.3 4126.5 3762.6 4031.8 4062.2 4095.8 4109.7 3215.3 3553.8 3556.8 3560.4 3563.4 4363.7 4750.0 4956.8 5247.4 5272.0 3559.5 4111.5 4171.6 4495.3 4722.3 5177.9 5281.3 5646.6 5648.1 5684.2 3012.6 3374.3 3960.8 3994.3 4010.6 4860.5 5033.4 5416.9 5522.0 5925.9 3949.4 3959.4 3967.8 3974.2 3980.3 4004.6 4005.3 4019.5 4024.6 4027.2 4442.6 4531.6 4675.9 4682.3 4689.4 4430.0 5689.0 5697.7 5714.2 5841.2 1275.9 1308.9 1342.7 1368.8 1373.3 882.7 916.6 918.9 921.5 921.7 4470.7 4832.2 5276.9 5287.3 5307.2 4741.7 4894.5 5851.9 5861.0 5878.6 4440.0 4684.6 5203.3 5257.6 5266.4 2340.5 2694.4 2906.2 2933.1 3004.1 5258.6 5652.5 5726.3 5949.5 5958.2 4886.3 5220.4 5678.2 5954.2 6004.8 4847.0 5972.5 6001.9 6013.4 6016.6 5059.3 5435.6 5552.2 5738.2 5828.3 5742.5 5749.5 5752.9 5754.6 5763.7 4520.6 5039.4 5993.1 6033.0 6040.5 3327.1 3338.6 3838.4 3922.3 3961.7 5118.5 5202.3 5668.7 5924.8 5926.9 4927.2 5566.5 5769.7 5791.4 5804.4 5100.4 5424.3 5500.4 5601.4 5672.4 4712.8 4926.8 5472.5 5541.2 5654.3 4604.4 4966.8 5157.6 5610.2 5755.3 4936.4 5087.6 5408.9 5624.0 5632.5 05:52:22 INFO - PROCESS | 1955 | 05:52:22 INFO - PROCESS | 1955 | [#5] yui.html Cycles:180 Average:23939.18 Median:4163.13 stddev:38430.02 (923.1%) stddev-sans-first:38498.34 05:52:22 INFO - PROCESS | 1955 | Values: 736.9 770.6 793.4 815.4 859.1 14837.3 15950.4 15955.5 15956.5 15986.0 14618.6 14688.8 14689.5 14701.3 14703.0 688.5 720.2 870.4 889.4 894.6 868.3 880.2 883.4 883.6 884.0 937.8 939.3 940.5 940.6 941.1 732.2 903.4 934.1 934.2 939.3 703.1 704.0 704.4 704.5 704.5 14857.0 14900.7 14926.0 14930.9 14947.9 13661.0 13758.7 13777.5 13860.5 13886.4 11874.1 11883.3 11911.8 12120.1 12123.0 4516.9 4569.4 4678.2 4735.2 4769.5 92240.0 111752.4 112561.0 112844.0 115895.0 8941.7 10345.3 10430.9 10458.9 10651.0 21366.8 21374.4 21397.6 21402.7 21409.5 7660.0 7680.8 7704.3 7746.5 7754.3 3687.5 4250.5 4271.8 4324.8 4438.3 3443.8 3558.3 3559.4 3563.6 3568.9 593.3 644.9 645.3 652.3 659.2 580.5 599.0 616.8 625.1 654.4 8274.8 8406.5 8547.5 8571.9 8924.7 623.5 632.6 638.0 641.9 644.4 3537.3 4154.7 4171.5 4210.9 4235.7 141778.0 141852.0 152838.0 155016.0 160538.6 74425.0 75421.6 94596.0 127511.1 127950.0 92691.0 95451.5 112222.0 113624.9 121254.0 7343.9 7518.6 8156.3 8180.7 8224.8 55685.7 64709.0 65938.7 66484.0 67142.0 96638.0 98710.0 98746.0 99712.0 100488.0 10611.5 10613.1 10632.8 10759.0 10933.7 9548.3 12021.3 12075.4 12569.1 12595.3 10172.8 12736.9 12885.4 12924.2 13181.3 11768.4 13759.7 13924.4 14529.1 14601.2 10670.3 11393.7 12177.6 12465.0 13265.9 10806.4 10833.5 10910.7 11045.8 11086.2 10613.9 10750.3 10756.5 10950.4 10988.8 05:52:22 INFO - PROCESS | 1955 | -------- Summary: end -------- 05:52:22 INFO - PROCESS | 1955 | 05:52:23 INFO - TEST-INFO | 1955: exit 0 05:52:23 INFO - TEST-OK | dromaeo_css | took 1115988ms 05:52:23 INFO - TEST-START | kraken 05:52:23 INFO - operating with platform_type : mac_ 05:52:23 INFO - Initialising browser for kraken test... 05:52:23 INFO - TEST-INFO | started process 1957 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/tmpfWBO8b/profile http://localhost:50557/getInfo.html) 05:52:25 INFO - PROCESS | 1957 | __metrics Screen width/height:1600/1200 05:52:25 INFO - PROCESS | 1957 | colorDepth:24 05:52:25 INFO - PROCESS | 1957 | Browser inner width/height: 1024/689 05:52:25 INFO - PROCESS | 1957 | __metrics 05:52:25 INFO - PROCESS | 1957 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:52:25 INFO - PROCESS | 1957 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:52:26 INFO - TEST-INFO | 1957: exit 0 05:52:26 INFO - Browser initialized. 05:52:26 INFO - Running cycle 1/1 for kraken test... 05:52:26 INFO - TEST-INFO | started process 1959 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/tmpfWBO8b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:38 INFO - PROCESS | 1959 | RSS: Main: 244088832 05:52:38 INFO - PROCESS | 1959 | 05:52:40 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50557/tests/kraken/driver.html?testName=audio-beat-detection) 05:52:41 INFO - PROCESS | 1959 | RSS: Main: 294465536 05:52:41 INFO - PROCESS | 1959 | 05:52:44 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50557/tests/kraken/driver.html?testName=audio-dft) 05:52:45 INFO - PROCESS | 1959 | RSS: Main: 304504832 05:52:45 INFO - PROCESS | 1959 | 05:52:48 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50557/tests/kraken/driver.html?testName=audio-fft) 05:52:49 INFO - PROCESS | 1959 | RSS: Main: 390778880 05:52:49 INFO - PROCESS | 1959 | 05:52:51 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50557/tests/kraken/driver.html?testName=audio-oscillator) 05:52:51 INFO - PROCESS | 1959 | RSS: Main: 291835904 05:52:51 INFO - PROCESS | 1959 | 05:52:53 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50557/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:52:54 INFO - PROCESS | 1959 | RSS: Main: 296226816 05:52:54 INFO - PROCESS | 1959 | 05:52:57 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50557/tests/kraken/driver.html?testName=imaging-darkroom) 05:52:57 INFO - PROCESS | 1959 | RSS: Main: 331698176 05:52:57 INFO - PROCESS | 1959 | 05:53:00 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50557/tests/kraken/driver.html?testName=imaging-desaturate) 05:53:01 INFO - PROCESS | 1959 | RSS: Main: 333422592 05:53:01 INFO - PROCESS | 1959 | 05:53:04 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50557/tests/kraken/driver.html?testName=json-parse-financial) 05:53:05 INFO - PROCESS | 1959 | RSS: Main: 336711680 05:53:05 INFO - PROCESS | 1959 | 05:53:06 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50557/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:53:07 INFO - PROCESS | 1959 | RSS: Main: 313847808 05:53:07 INFO - PROCESS | 1959 | 05:53:09 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50557/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:53:09 INFO - PROCESS | 1959 | RSS: Main: 320999424 05:53:09 INFO - PROCESS | 1959 | 05:53:11 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50557/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:53:12 INFO - PROCESS | 1959 | RSS: Main: 320491520 05:53:12 INFO - PROCESS | 1959 | 05:53:15 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50557/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:53:16 INFO - PROCESS | 1959 | RSS: Main: 327512064 05:53:16 INFO - PROCESS | 1959 | 05:53:18 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50557/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:53:19 INFO - PROCESS | 1959 | RSS: Main: 328744960 05:53:19 INFO - PROCESS | 1959 | 05:53:21 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50557/tests/kraken/driver.html?testName=ai-astar) 05:53:21 INFO - PROCESS | 1959 | RSS: Main: 372563968 05:53:21 INFO - PROCESS | 1959 | 05:53:21 INFO - PROCESS | 1959 | __start_tp_report 05:53:21 INFO - PROCESS | 1959 | _x_x_mozilla_page_load 05:53:21 INFO - PROCESS | 1959 | _x_x_mozilla_page_load_details 05:53:21 INFO - PROCESS | 1959 | |i|pagename|runs| 05:53:21 INFO - PROCESS | 1959 | |0;ai-astar;101;111;113;111;112;111;111;112;112;114 05:53:21 INFO - PROCESS | 1959 | |1;audio-beat-detection;141;114;131;193;127;106;128;101;139;104 05:53:21 INFO - PROCESS | 1959 | |2;audio-dft;185;184;188;184;186;221;258;182;184;183 05:53:21 INFO - PROCESS | 1959 | |3;audio-fft;80;75;57;106;57;57;60;60;95;57 05:53:21 INFO - PROCESS | 1959 | |4;audio-oscillator;86;87;92;71;70;67;96;69;68;102 05:53:21 INFO - PROCESS | 1959 | |5;imaging-gaussian-blur;88;85;89;86;88;83;88;85;88;84 05:53:21 INFO - PROCESS | 1959 | |6;imaging-darkroom;94;93;93;94;93;94;95;94;94;93 05:53:21 INFO - PROCESS | 1959 | |7;imaging-desaturate;105;142;90;101;128;128;88;87;89;85 05:53:21 INFO - PROCESS | 1959 | |8;json-parse-financial;53;54;54;55;54;56;54;54;54;55 05:53:21 INFO - PROCESS | 1959 | |9;json-stringify-tinderbox;73;73;67;71;78;74;72;72;72;74 05:53:21 INFO - PROCESS | 1959 | |10;stanford-crypto-aes;82;82;82;87;84;82;81;86;83;85 05:53:21 INFO - PROCESS | 1959 | |11;stanford-crypto-ccm;135;136;136;135;133;132;132;134;181;136 05:53:21 INFO - PROCESS | 1959 | |12;stanford-crypto-pbkdf2;162;211;214;164;162;221;160;162;163;161 05:53:21 INFO - PROCESS | 1959 | |13;stanford-crypto-sha256-iterative;67;66;67;65;65;66;61;59;83;84 05:53:21 INFO - PROCESS | 1959 | __end_tp_report 05:53:21 INFO - PROCESS | 1959 | __start_cc_report 05:53:21 INFO - PROCESS | 1959 | _x_x_mozilla_cycle_collect,2131 05:53:21 INFO - PROCESS | 1959 | __end_cc_report 05:53:21 INFO - PROCESS | 1959 | __startTimestamp1468500801568__endTimestamp 05:53:21 INFO - PROCESS | 1959 | 05:53:21 INFO - PROCESS | 1959 | ------- Summary: start ------- 05:53:21 INFO - PROCESS | 1959 | Number of tests: 14 05:53:21 INFO - PROCESS | 1959 | 05:53:21 INFO - PROCESS | 1959 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:3.58 (3.2%) stddev-sans-first:1.05 05:53:21 INFO - PROCESS | 1959 | Values: 101.0 111.0 113.0 111.0 112.0 111.0 111.0 112.0 112.0 114.0 05:53:21 INFO - PROCESS | 1959 | 05:53:21 INFO - PROCESS | 1959 | [#1] audio-beat-detection Cycles:10 Average:128.40 Median:129.50 stddev:26.89 (20.8%) stddev-sans-first:28.13 05:53:21 INFO - PROCESS | 1959 | Values: 141.0 114.0 131.0 193.0 127.0 106.0 128.0 101.0 139.0 104.0 05:53:21 INFO - PROCESS | 1959 | 05:53:21 INFO - PROCESS | 1959 | [#2] audio-dft Cycles:10 Average:195.50 Median:185.50 stddev:24.83 (13.4%) stddev-sans-first:26.04 05:53:21 INFO - PROCESS | 1959 | Values: 185.0 184.0 188.0 184.0 186.0 221.0 258.0 182.0 184.0 183.0 05:53:21 INFO - PROCESS | 1959 | 05:53:21 INFO - PROCESS | 1959 | [#3] audio-fft Cycles:10 Average:70.40 Median:60.00 stddev:18.01 (30.0%) stddev-sans-first:18.77 05:53:21 INFO - PROCESS | 1959 | Values: 80.0 75.0 57.0 106.0 57.0 57.0 60.0 60.0 95.0 57.0 05:53:21 INFO - PROCESS | 1959 | 05:53:21 INFO - PROCESS | 1959 | [#4] audio-oscillator Cycles:10 Average:80.80 Median:78.50 stddev:13.24 (16.9%) stddev-sans-first:13.91 05:53:21 INFO - PROCESS | 1959 | Values: 86.0 87.0 92.0 71.0 70.0 67.0 96.0 69.0 68.0 102.0 05:53:21 INFO - PROCESS | 1959 | 05:53:21 INFO - PROCESS | 1959 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:88.00 stddev:2.07 (2.3%) stddev-sans-first:2.11 05:53:21 INFO - PROCESS | 1959 | Values: 88.0 85.0 89.0 86.0 88.0 83.0 88.0 85.0 88.0 84.0 05:53:21 INFO - PROCESS | 1959 | 05:53:21 INFO - PROCESS | 1959 | [#6] imaging-darkroom Cycles:10 Average:93.70 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 05:53:21 INFO - PROCESS | 1959 | Values: 94.0 93.0 93.0 94.0 93.0 94.0 95.0 94.0 94.0 93.0 05:53:21 INFO - PROCESS | 1959 | 05:53:21 INFO - PROCESS | 1959 | [#7] imaging-desaturate Cycles:10 Average:104.30 Median:86.00 stddev:20.90 (24.3%) stddev-sans-first:22.17 05:53:21 INFO - PROCESS | 1959 | Values: 105.0 142.0 90.0 101.0 128.0 128.0 88.0 87.0 89.0 85.0 05:53:21 INFO - PROCESS | 1959 | 05:53:21 INFO - PROCESS | 1959 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.73 05:53:21 INFO - PROCESS | 1959 | Values: 53.0 54.0 54.0 55.0 54.0 56.0 54.0 54.0 54.0 55.0 05:53:21 INFO - PROCESS | 1959 | 05:53:21 INFO - PROCESS | 1959 | [#9] json-stringify-tinderbox Cycles:10 Average:72.60 Median:73.00 stddev:2.76 (3.8%) stddev-sans-first:2.92 05:53:21 INFO - PROCESS | 1959 | Values: 73.0 73.0 67.0 71.0 78.0 74.0 72.0 72.0 72.0 74.0 05:53:21 INFO - PROCESS | 1959 | 05:53:21 INFO - PROCESS | 1959 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.50 stddev:2.01 (2.4%) stddev-sans-first:2.07 05:53:21 INFO - PROCESS | 1959 | Values: 82.0 82.0 82.0 87.0 84.0 82.0 81.0 86.0 83.0 85.0 05:53:21 INFO - PROCESS | 1959 | 05:53:21 INFO - PROCESS | 1959 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:135.50 stddev:14.84 (11.0%) stddev-sans-first:15.67 05:53:21 INFO - PROCESS | 1959 | Values: 135.0 136.0 136.0 135.0 133.0 132.0 132.0 134.0 181.0 136.0 05:53:21 INFO - PROCESS | 1959 | 05:53:21 INFO - PROCESS | 1959 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.00 Median:163.50 stddev:25.90 (15.8%) stddev-sans-first:26.81 05:53:21 INFO - PROCESS | 1959 | Values: 162.0 211.0 214.0 164.0 162.0 221.0 160.0 162.0 163.0 161.0 05:53:21 INFO - PROCESS | 1959 | 05:53:21 INFO - PROCESS | 1959 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:66.50 stddev:8.42 (12.7%) stddev-sans-first:8.92 05:53:21 INFO - PROCESS | 1959 | Values: 67.0 66.0 67.0 65.0 65.0 66.0 61.0 59.0 83.0 84.0 05:53:21 INFO - PROCESS | 1959 | -------- Summary: end -------- 05:53:21 INFO - PROCESS | 1959 | 05:53:22 INFO - TEST-INFO | 1959: exit 0 05:53:22 INFO - TEST-OK | kraken | took 59184ms 05:53:22 INFO - SUITE-END | took 1175s 05:53:22 INFO - Completed test suite (00:19:35) 05:53:22 INFO - javascript benchmark 05:53:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3286.605607327121, 3292.8518216680245, 3308.404487192306, 3313.840155945418, 3335.349606826668, 5498.615096943216, 5587.022271102556, 5664.830055098343, 5683.943160568393, 5689.772409103636, 5665.433456654332, 5687.061634830258, 5694.914576281359, 5717.685527295997, 5722.914156287659, 4660.277656963176, 4987.905079866447, 5122.282880396738, 5172.069027575035, 5201.55786758126, 5262.447443018466, 5280.0, 5285.154375299952, 5286.365636123652, 5286.524212820846, 5149.871253218681, 5185.844424667247, 5188.04021256067, 5203.921941170866, 5274.4198138204765, 5265.973670131644, 5279.155335146396, 5291.417944026154, 5295.417504074549, 5341.332333458317, 5084.44071152173, 5090.9236361454605, 5119.2321151827155, 5190.273361729361, 5201.141811601081, 5578.693171875545, 5592.356878958891, 5651.4348565143155, 5660.377358490563, 5687.26065611472, 6209.534284928648, 6235.376462353774, 6243.219597550306, 6243.344448832898, 6243.968780156116, 6098.613770999311, 6148.354422785588, 6202.81391558254, 6289.496840252768, 6299.968500157515, 5782.768689252467, 5787.594868359174, 5794.0439827428845, 5794.275715535558, 5799.710014499258, 6229.470495007975, 6246.46905013079, 6262.780802671885, 6277.05844123376, 6279.7488100476385, 5974.940250597525, 6025.8192254232445, 6099.2985806632805, 6105.8473538161015, 6119.694015299217, 6198.566100373021, 6251.281102673251, 6258.749650013949, 6258.74965001404, 6266.561340706198, 6129.908051379233, 6179.227596550431, 6192.102145188923, 6206.286277078104, 6224.968875155595, 5818.912716309259, 5868.501177399969, 6222.942099843038, 6237.189165408558, 6257.5932564383165, 4892.339534162914, 4919.2129259318335, 4958.975205123951, 4967.5777558907175, 4974.0, 4442.289233722653, 4446.6220371268155, 4461.643068554507, 4488.1248156609145, 4489.685721999494, 5508.14623733322, 5577.96807590597, 5650.3219613646625, 5697.4587414195585, 5699.145128230799, 6201.348858369806, 6235.345288744707, 6258.906116408258, 6269.467095296951, 6272.655003974825, 5683.588289331812, 5710.400407957188, 5718.628289161191, 5733.397993210736, 5776.393478684761, 5293.311869456946, 5300.655457395257, 5343.519083282523, 5410.242566040757, 5414.648047876875, 6239.78160764371, 6274.1843560336865, 6287.276963149114, 6287.811365659038, 6293.339199383999, 6260.593061450991, 6280.905786413299, 6290.21372328459, 6291.811245662638, 6299.055141728777, 5662.631928924607, 5929.258842644669, 6185.381461853779, 6189.102580125947, 6277.654728989767, 6122.123717501779, 6222.066689996536, 6232.5325600581045, 6239.188905442445, 6253.530985176039, 6263.154474145932, 6271.874562508816, 6285.811425657238, 6294.181756371826, 6329.620222786463, 5888.116782482662, 5900.0, 6152.50779937595, 6154.107654390178, 6168.35232300602, 5830.708464576839, 6094.8171554853425, 6100.725467353891, 6123.069106197319, 6138.020573254662, 5938.584299099021, 5940.019896716994, 5952.910706339495, 5977.372375900468, 5980.401959803985, 5968.194293770459, 6017.939820601738, 6086.934786412448, 6113.354060514726, 6136.758624822573, 5932.940670593239, 5947.613405128653, 5965.791197308247, 5981.581289309706, 5983.0], "value": 5680.622982702697, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.5357968821024, 486.6009871905037, 508.80411041748926, 515.8323544847924, 541.3503795445466, 29335.706642933565, 30644.693553064462, 41869.02244286796, 42479.78760106203, 42594.361084583754, 44351.89120271995, 44599.55400445995, 44760.0, 44827.32759008618, 44886.77556612212, 9693.612255509772, 9865.506724663774, 9882.258830587734, 9890.20878329732, 9894.356866803635, 8521.062683104854, 8712.390132690714, 8714.564271786418, 8792.252658524001, 8837.469751814879, 10360.119389851872, 12032.33822139782, 12039.578614748485, 12178.634640960785, 12237.877621223763, 11932.0, 12022.879771202264, 12026.819597706042, 12047.39763011846, 12048.674645788957, 8542.57287135647, 11495.540178392854, 11751.177417580773, 11796.705082372924, 11832.763344733143, 41650.79174604138, 41771.7911410441, 41963.160736785096, 41988.0, 41995.79002105001, 3585.7848529088337, 3606.6753992140834, 3736.178040831013, 3743.6069212732814, 3893.415987601854, 31186.532202016762, 31493.52759708606, 32652.346953061042, 33095.17262068467, 33253.83373083143, 3257.4788033914697, 3275.606927168731, 3292.340370624033, 3331.7334613230882, 3384.6446123157207, 508379.0, 510486.9999999963, 510544.0, 512519.0, 513215.0, 59967.0, 60046.0, 60585.0, 60672.39327606667, 60764.0, 65046.0, 65133.02300465497, 65178.67410663011, 65188.67405662941, 65291.673541631986, 16108.0, 16318.673626527403, 16330.591735206477, 16344.591385215226, 16349.591260218353, 12589.748205035849, 12663.36683165838, 12668.303243321705, 12697.93651031739, 12699.0, 14786.63033424173, 15015.099094054172, 15093.169875656724, 15304.923475382551, 16948.152592370334, 4911.933761804169, 6366.808995730135, 6453.870922581616, 6518.837029074216, 6588.11060506835, 905.5608030105394, 960.9957594313959, 989.223459584223, 1013.964511242103, 1084.2789544952675, 30629.0, 30789.84605077005, 30887.0, 31224.375512489623, 31392.529112063337, 947.5688561704408, 1013.7516308504464, 1075.5697720911699, 1084.2627013630806, 1111.9444027798577, 16117.919410402874, 16171.0, 16176.75734863978, 16360.509184724477, 16496.83503164977, 685675.0, 690943.0, 693117.0, 693622.0, 693880.0, 52458.21312680313, 60189.0, 60350.396496035355, 60496.0, 60720.39279607236, 1427.6787722762294, 1450.376338174574, 1459.5840185547067, 1464.0556840837812, 1467.442371898693, 30769.846150769103, 31736.841315793274, 31886.043418697474, 32300.35399292048, 32537.511937320487, 52174.95650087053, 52385.47614523806, 52672.94654106973, 52701.20948185857, 52703.47296526986, 626272.0, 730999.0, 864763.0, 893089.0, 894037.0, 38641.42037869491, 39742.0, 40006.0, 40118.59881401266, 40125.0, 44427.88930276769, 45015.32477012913, 47570.0, 48555.5144448551, 48618.270725939845, 35327.0, 36050.91847244587, 36411.0, 38184.427233592076, 40352.19295614013, 36812.63187368092, 39151.021224469616, 39175.21649566936, 40085.79957100196, 40241.0, 37580.87257382283, 37939.43090853584, 38015.61984380121, 38581.807090964365, 38743.0, 33185.50221746627, 34059.74168453618, 34269.82865085659, 34530.30939381148, 34574.0, 24366.878165609058, 25460.0, 25700.100496482533, 25729.0, 26062.739372606033], "value": 20792.890880515046, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.8462153584726, 380.20726784654, 391.4500127321113, 394.8223299515217, 415.2110989120672, 15513.922430387847, 16132.032078075308, 20988.58022839546, 21314.0, 21536.0, 17494.65010699785, 19734.90132549339, 20906.372808815722, 21537.353879383645, 21564.813935233557, 5071.934893672334, 5506.834794956148, 5638.238837756912, 5679.460451257145, 5681.431856814327, 5591.077472217079, 5607.4112218217115, 5641.8589535261535, 5644.633098848582, 5651.361105279485, 5395.406505284415, 5620.662760234379, 5638.718064096799, 5642.125470552071, 5642.153676948449, 5595.300587426572, 5612.07400778873, 5627.5779316551425, 5631.63394379364, 5634.633748806335, 5243.4232234454175, 5467.0, 5477.1510415885605, 5480.972595137038, 5482.972585137089, 13881.791773123412, 14004.369803358772, 14051.227182504957, 21582.460438489008, 26638.866805665846, 2174.2824867793747, 2226.654868495386, 2463.5442443147895, 2813.240425085236, 3019.290466740314, 10288.43413612251, 10336.689899303034, 10706.625268115578, 10772.08437282832, 10804.621838235702, 1853.3420635674277, 1921.9423417297364, 1928.53715108373, 1993.7707163676073, 2039.5614942787372, 107694.92305076927, 108539.45730271377, 123018.76981230163, 123374.76625233813, 126531.0, 11578.073754099652, 11643.0, 11672.731635142174, 11711.297322160697, 11903.107266955012, 14724.263786810616, 14803.925980370244, 14844.851551484348, 14855.0, 14866.925665371604, 7305.4155667546465, 8311.0, 8421.073681894986, 8497.235248827636, 8606.483610983361, 8327.250547450758, 8351.331893448509, 8373.204545568162, 8454.435929353089, 8461.619227134794, 4527.705699129546, 4608.585227329557, 4615.30770384445, 4665.460398068629, 4695.7886895089805, 1786.5087101047056, 1858.8419984301215, 1927.3254360973547, 1959.304446921351, 2001.5296405344732, 822.0722948776285, 858.9441686290371, 903.5482258870564, 950.7005293332578, 1000.9549570269355, 20501.282455114, 21203.46991325229, 21465.248716294856, 21471.46321341979, 21513.462163445725, 941.317544780029, 952.1811242331589, 1015.1979935850595, 1032.607609108534, 1042.3954106618144, 10961.629796275465, 11330.943345283385, 11371.090312774959, 11396.715082122848, 11403.828942565868, 530958.0, 616202.0, 620528.0, 621018.0, 640257.0, 83309.0, 90065.0, 106370.0, 125670.74329256773, 127778.36110819572, 947.1049857884233, 982.268210183418, 1024.1346062577259, 1038.6728180623231, 1041.807265655856, 19583.0, 19652.803471965668, 20325.680407448694, 20975.580488390453, 21322.0, 59473.702631486565, 60819.78360432678, 61709.38290617216, 61834.69082654558, 61983.0, 80329.0, 81857.59071204606, 86659.1334086651, 87127.56436217779, 87485.0, 5840.795572154954, 8321.667133314842, 8364.581770911553, 8382.916170838458, 8551.315894728283, 12107.152499325315, 13152.342382880626, 13166.012549058667, 13407.597772066854, 13431.731365372443, 11248.325100493996, 11488.597899073493, 11493.195476316578, 11604.6518604442, 11759.882401175879, 11209.0, 11268.323900565993, 11275.267107637977, 11385.03227225695, 11557.47991340375, 11553.422328883691, 11731.706707332385, 11786.46960886745, 11794.351310677652, 12019.158658893793, 8245.464044837307, 8311.542865142233, 8381.790455238668, 8384.83230335402, 8559.871601925852, 11056.557737690724, 11452.312861228353, 11613.941930290295, 11743.530258789553, 11771.705707357385], "value": 9580.628671682296, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1527.8319384867666, 1565.536223630905, 1764.232558836906, 1921.0778826163441, 1926.662834004049, 8300.58497075146, 8514.233718965292, 8707.956460217705, 8710.477371357723, 8711.43375680581, 7763.9611801941055, 7996.800079998003, 8412.327013838894, 8523.701670441536, 8715.0, 2342.9531409371843, 2369.230000249917, 2371.81025517959, 2373.0507796881298, 2377.892994815229, 2335.065973610552, 2343.16817529777, 2373.1219448803968, 2380.071772008909, 2383.2611890314056, 2080.4798800299927, 2169.023939227346, 2275.6927814745045, 2354.2937118864356, 2354.81161507079, 1990.7710613279514, 2358.6108292131776, 2360.3980984848927, 2384.940376490584, 2386.0575072846214, 2367.3963139399516, 2367.869767162805, 2369.9407514812096, 2372.9288121356385, 2378.750231225714, 8922.86615700765, 8968.551572421353, 8988.685396011173, 8997.865032024525, 9014.729558113268, 5187.896242075138, 5264.92102618461, 5334.03987282289, 5339.786408543654, 5340.332458442695, 3437.6906078452807, 3494.52823868777, 3596.3166998270244, 3603.1172362771026, 3618.113562177257, 1060.1624716473975, 1075.1291453922347, 1086.8750093739243, 1100.4772732951865, 1100.7358234023857, 11734.88265117355, 11748.118891083117, 11750.58872939443, 11751.647450576496, 11774.94112529432, 4539.296409056601, 4599.4710608280475, 4751.619870410359, 4757.072370887644, 4759.976200119047, 9921.305508614329, 9960.950195249123, 9980.850287245697, 9993.850092248622, 10006.0, 5319.015982043335, 5323.095073837457, 5334.093204155303, 5334.493223143795, 5341.893162136736, 4672.95327046732, 4885.267209918541, 4885.731284779371, 4888.706677599355, 4896.436909755353, 3735.813209339522, 3760.9059773505883, 3773.75470594416, 3801.3727734923427, 3821.8534439667987, 1076.7308172956762, 1136.5908273021705, 1146.266389510714, 1146.8910453506903, 1154.6593754842343, 806.954993283699, 888.2228050455851, 927.1516562345513, 934.9154980222909, 945.4610871803006, 5792.218050563204, 5850.531957443394, 5914.585978981516, 5920.822375328747, 6018.127371531104, 927.0682963621517, 932.4545141092536, 951.7144856543009, 973.4354074636693, 976.7302506741208, 3819.8090095495113, 3909.667678247324, 3952.150287688103, 3983.2630963271886, 3990.0, 10238.18094552434, 10296.948515257525, 10409.32339397952, 10467.685969420929, 10477.528511217013, 10347.482625868677, 10442.530086146142, 10446.42544660051, 10449.68650940473, 10481.737956550995, 7852.528848269122, 8141.0230772307705, 8143.226393492609, 8143.79640508992, 8145.429819912668, 5615.943840561542, 5624.0, 5686.09022556389, 5716.171155182558, 5889.0283103287475, 9644.0, 9967.0, 10006.8498972514, 10108.747281318027, 10147.036031576989, 9288.0, 9306.488143152192, 9760.951195243979, 10256.43589602579, 10336.586536538454, 7317.743878964211, 7453.440991925736, 7683.500572462772, 7690.2694244046725, 7690.423218258541, 8308.210719981593, 8317.251447369767, 8399.076101628938, 8408.915910840813, 8423.199796019368, 7283.890741638986, 7486.401087913063, 7525.6989720410575, 7630.084389873251, 7640.73257435987, 7321.633918303957, 7399.667014984447, 7409.851802963803, 7542.811429714301, 7565.962170189334, 7091.184513780775, 7140.143182818095, 7171.282871712787, 7176.497645164788, 7177.641117944187, 4896.730679812645, 4986.775595098302, 5025.572826309804, 5088.4148322941855, 5099.413567439644, 5081.611801938718, 5095.847124586268, 5111.284420181103, 5208.401033881, 5215.4002289735645], "value": 4575.911932027678, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.1071690287589, 303.2418952618454, 312.58738465225906, 315.9241781972327, 316.1984369623006, 4865.489123642015, 5188.143956247224, 5414.864628384287, 5448.482394172557, 5450.236966824643, 4243.851465198719, 5153.613478989072, 5281.9207711884255, 5325.3077099977045, 5407.621466497347, 3748.5568056298384, 4143.6892233082635, 4156.088199428252, 4156.771377574232, 4156.916861662758, 3512.877049303275, 3527.6648718371844, 3921.960780392202, 4164.375343698439, 4171.332586786115, 3810.942835857464, 3914.3737002079674, 4096.242195193884, 4099.282625540533, 4126.46355973723, 3762.5673047599603, 4031.8185681644395, 4062.1672557125717, 4095.7747323897174, 4109.712320137592, 3215.26049008727, 3553.7690050146657, 3556.8399422025814, 3560.359135355635, 3563.376409128418, 4363.716358436724, 4750.0, 4956.801727930914, 5247.422783493813, 5272.0, 3559.4660800879815, 4111.527174374955, 4171.6036976487185, 4495.302818309021, 4722.338872557844, 5177.938522602857, 5281.287026251445, 5646.571974051157, 5648.096304591246, 5684.204211410406, 3012.6083609130674, 3374.3251349730153, 3960.7819621012327, 3994.2810294147043, 4010.639042486161, 4860.4896485869185, 5033.446320904697, 5416.916616676681, 5521.972390138104, 5925.851853703649, 3949.447077409165, 3959.3862951242604, 3967.781772002568, 3974.1654252607277, 3980.3233450313514, 4004.619561141687, 4005.319095753729, 4019.4774679291504, 4024.597540245952, 4027.154297597537, 4442.644588432918, 4531.614812740954, 4675.883102922454, 4682.331071289401, 4689.373950587614, 4430.047539778963, 5688.971555142198, 5697.715114244271, 5714.228579141846, 5841.153032810304, 1275.859655437901, 1308.941097650608, 1342.7113170668354, 1368.8083668286447, 1373.272165752153, 882.6645874567623, 916.5554705967601, 918.9264858811413, 921.5346250143634, 921.6820197032014, 4470.6870519064005, 4832.221472653238, 5276.92084618731, 5287.339082614673, 5307.230451584499, 4741.739204343794, 4894.521512815733, 5851.941480585139, 5861.0, 5878.588498805043, 4439.955600444019, 4684.601808846218, 5203.297554830126, 5257.6056795739705, 5266.4470230626, 2340.520193360391, 2694.3802925327286, 2906.215321863085, 2933.1347252560545, 3004.1438190115714, 5258.579313654898, 5652.463016013472, 5726.312842458931, 5949.494292985059, 5958.182754259992, 4886.267059941038, 5220.415894132429, 5678.205051292823, 5954.159567079209, 6004.819855404257, 4846.994863184777, 5972.46247837688, 6001.879962400728, 6013.398660134127, 6016.639001659827, 5059.342285502861, 5435.565154787687, 5552.194931734956, 5738.196652468574, 5828.329742079715, 5742.5118864895285, 5749.482546570829, 5752.856178595402, 5754.5684073695475, 5763.682997435181, 4520.615747661485, 5039.445660977363, 5993.101034844633, 6033.043808533875, 6040.546958978182, 3327.1349449142913, 3338.5659864217496, 3838.443425703313, 3922.2547715933883, 3961.7226794124135, 5118.488151184852, 5202.297689811827, 5668.659880407189, 5924.822255332347, 5926.911096333472, 4927.191679049034, 5566.526845218202, 5769.74036168365, 5791.420857914175, 5804.419558044162, 5100.444364468873, 5424.349078110652, 5500.4048825840055, 5601.355844077821, 5672.376038635664, 4712.835050773207, 4926.7975815720065, 5472.50747432733, 5541.224228608079, 5654.293213348332, 4604.401427814362, 4966.751662416937, 5157.587393008625, 5610.242617246783, 5755.3381361144, 4936.407631084149, 5087.64386492942, 5408.891822163456, 5623.98768221724, 5632.521235694848], "value": 4070.688299853032, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.8820988641818, 770.6378002338902, 793.4009822583951, 815.4210510537514, 859.1151114352219, 14837.258137093157, 15950.441734539294, 15955.521334359973, 15956.521304360858, 15986.0, 14618.634534136625, 14688.779668304984, 14689.485867994623, 14701.338439770208, 14703.0, 688.5214775730857, 720.2257573108928, 870.4168207301124, 889.4485419040204, 894.6376717429451, 868.3313848336777, 880.2078129683305, 883.3992884838308, 883.5626364949359, 883.9602217900177, 937.8452555328363, 939.286142531674, 940.525034857396, 940.5626383731563, 941.0824446165003, 732.1982429239973, 903.4037535226785, 934.0892629686002, 934.1592566689966, 939.2955283537347, 703.1281211298004, 704.0214102397671, 704.3801454719813, 704.4751660013271, 704.4822055788991, 14857.0, 14900.701985960328, 14926.029808062442, 14930.850691493055, 14947.850521494755, 13661.0, 13758.65603359914, 13777.517786877412, 13860.514881979183, 13886.375113119833, 11874.0500759939, 11883.346415947119, 11911.761764764657, 12120.09099317546, 12123.0, 4516.909661806745, 4569.383133276999, 4678.20470520009, 4735.195016847144, 4769.4515130760055, 92240.0, 111752.44123779329, 112561.0, 112844.0, 115895.0, 8941.687040953666, 10345.327553709136, 10430.947845260725, 10458.947705261426, 10651.040117397493, 21366.78633213679, 21374.358769236947, 21397.572048559254, 21402.678959815614, 21409.464763381042, 7659.961700191463, 7680.846383072308, 7704.30661240491, 7746.49647772893, 7754.302112809762, 3687.539057617798, 4250.53244143144, 4271.829126834892, 4324.805383757738, 4438.289873620205, 3443.7589368744448, 3558.3061303045656, 3559.359315323215, 3563.625819288989, 3568.892933212008, 593.3087952535334, 644.8678021005683, 645.2998496631114, 652.3020368206069, 659.1793217444313, 580.5152697497552, 599.0146209485372, 616.8427051101941, 625.140431906129, 654.4404534123352, 8274.793130171673, 8406.495610263404, 8547.487150770974, 8571.871421928676, 8924.687635932842, 623.5074291309814, 632.550888868899, 638.0206383201763, 641.8619996700731, 644.4007073421762, 3537.345591065661, 4154.709170358046, 4171.541130475645, 4210.915781684349, 4235.7035007549175, 141778.0, 141852.0, 152838.0, 155016.0, 160538.56499327507, 74425.0, 75421.62289188629, 94596.0, 127511.08733369007, 127950.0, 92691.0, 95451.52274238723, 112222.0, 113624.94318153325, 121254.0, 7343.898415237757, 7518.624068796647, 8156.347492200491, 8180.713675021584, 8224.794380140305, 55685.721571391885, 64709.0, 65938.67030664816, 66484.0, 67141.99287010796, 96638.0, 98710.0, 98746.01253987369, 99712.0115195384, 100488.0, 10611.522481488506, 10613.09788667972, 10632.787344253225, 10759.0, 10933.726656833644, 9548.283878709264, 12021.338826364634, 12075.396230188631, 12569.103577890517, 12595.307258100525, 10172.84740728875, 12736.85368316856, 12885.362181011224, 12924.224546527239, 13181.340932953122, 11768.352740599006, 13759.724805504035, 13924.373403196678, 14529.128252304896, 14601.196934168298, 10670.30643008202, 11393.715157121138, 12177.57378491784, 12465.0, 13265.933670331586, 10806.35161890289, 10833.458327083772, 10910.727231819268, 11045.83431248548, 11086.22396432242, 10613.893861061599, 10750.301230419998, 10756.515956781806, 10950.39772812503, 10988.835167472655], "value": 7600.45637277363, "unit": "score"}], "name": "dromaeo_css", "value": 7369.810275494873, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 113.0, 111.0, 112.0, 111.0, 111.0, 112.0, 112.0, 114.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 114.0, 131.0, 193.0, 127.0, 106.0, 128.0, 101.0, 139.0, 104.0], "value": 128.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 188.0, 184.0, 186.0, 221.0, 258.0, 182.0, 184.0, 183.0], "value": 195.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 75.0, 57.0, 106.0, 57.0, 57.0, 60.0, 60.0, 95.0, 57.0], "value": 70.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 92.0, 71.0, 70.0, 67.0, 96.0, 69.0, 68.0, 102.0], "value": 80.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 89.0, 86.0, 88.0, 83.0, 88.0, 85.0, 88.0, 84.0], "value": 86.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 94.0, 93.0, 94.0, 95.0, 94.0, 94.0, 93.0], "value": 93.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 142.0, 90.0, 101.0, 128.0, 128.0, 88.0, 87.0, 89.0, 85.0], "value": 104.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 55.0, 54.0, 56.0, 54.0, 54.0, 54.0, 55.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 67.0, 71.0, 78.0, 74.0, 72.0, 72.0, 72.0, 74.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 87.0, 84.0, 82.0, 81.0, 86.0, 83.0, 85.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 136.0, 136.0, 135.0, 133.0, 132.0, 132.0, 134.0, 181.0, 136.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 211.0, 214.0, 164.0, 162.0, 221.0, 160.0, 162.0, 163.0, 161.0], "value": 178.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 65.0, 65.0, 66.0, 61.0, 59.0, 83.0, 84.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1465.8999999999999, "alertThreshold": 2.0}]} 05:53:22 INFO - Return code: 0 05:53:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:53:22 INFO - # TBPL SUCCESS # 05:53:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:53:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:53:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:53:22 INFO - 2016-07-14 05:53:22.889 screenresolution[1963:66046] starting screenresolution argv=screenresolution get 05:53:22 INFO - 2016-07-14 05:53:22.892 screenresolution[1963:66046] Display 0: 1600x1200x32@60 05:53:22 INFO - 2016-07-14 05:53:22.898 screenresolution[1964:66049] starting screenresolution argv=screenresolution list 05:53:22 INFO - Available Modes on Display 0 05:53:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:53:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:53:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:53:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:53:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:53:23 INFO - Intel Iris: 05:53:23 INFO - Chipset Model: Intel Iris 05:53:23 INFO - Type: GPU 05:53:23 INFO - Bus: Built-In 05:53:23 INFO - VRAM (Dynamic, Max): 1536 MB 05:53:23 INFO - Vendor: Intel (0x8086) 05:53:23 INFO - Device ID: 0x0a2e 05:53:23 INFO - Revision ID: 0x0009 05:53:23 INFO - Displays: 05:53:23 INFO - Display: 05:53:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:53:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:53:23 INFO - Display Serial Number: 1600x1200 60 05:53:23 INFO - Main Display: Yes 05:53:23 INFO - Mirror: Off 05:53:23 INFO - Online: Yes 05:53:23 INFO - Rotation: Supported 05:53:23 INFO - Return code: 0 05:53:23 INFO - Running post-action listener: _resource_record_post_action 05:53:23 INFO - ##### 05:53:23 INFO - ##### Finished run-tests step (success) 05:53:23 INFO - ##### 05:53:23 INFO - Running post-run listener: _resource_record_post_run 05:53:23 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 49152; Write bytes: 701493760; Read time: 1; Write time: 1903 05:53:23 INFO - TinderboxPrint: CPU usage
53.5% 05:53:23 INFO - TinderboxPrint: I/O read bytes / time
49,152 / 1 05:53:23 INFO - TinderboxPrint: I/O write bytes / time
701,493,760 / 1,903 05:53:23 INFO - TinderboxPrint: CPU idle
2,250.5 (46.5%) 05:53:23 INFO - TinderboxPrint: CPU system
967.1 (20.0%) 05:53:23 INFO - TinderboxPrint: CPU user
1,624.1 (33.5%) 05:53:23 INFO - TinderboxPrint: Swap in / out
406,548,480 / 0 05:53:23 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 388229632; Write bytes: 383263232; Read time: 28935; Write time: 778 05:53:23 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 49152; Write bytes: 290918400; Read time: 1; Write time: 1066 05:53:23 INFO - Running post-run listener: _upload_blobber_files 05:53:23 INFO - Blob upload gear active. 05:53:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:53:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:53:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:53:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:53:24 INFO - (blobuploader) - INFO - Open directory for files ... 05:53:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:53:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:53:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:24 INFO - (blobuploader) - INFO - Done attempting. 05:53:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:53:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:53:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:25 INFO - (blobuploader) - INFO - Done attempting. 05:53:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:53:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:53:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:29 INFO - (blobuploader) - INFO - Done attempting. 05:53:29 INFO - (blobuploader) - INFO - Iteration through files over. 05:53:29 INFO - Return code: 0 05:53:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:53:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:53:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2c3a0ce9351fde07cbfcb3d500d749b78dc50275723d6af859a7523ebe0cac519ae92b8c550a032c8a9d69bf0a9c83e21e9d3738f90d710134e1e5331d4283b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/443ae55a9de43ee80ca3c85454b2e20a626ce3b2923a25dd4d3f1a99d00e3d5b5c757fab110d9c06a8f8f3779a596d7ad101724afc884c049d01cbe2112edfbc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/712a1940796860451b40c0952ce392f8ce203e4968231436f74537d3e4c2ba61f6fc4be190a2770df78fe012312a2ed6f4db7d3a5015ced6fc19ceace9bdd35e"} 05:53:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:53:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:53:29 INFO - Contents: 05:53:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2c3a0ce9351fde07cbfcb3d500d749b78dc50275723d6af859a7523ebe0cac519ae92b8c550a032c8a9d69bf0a9c83e21e9d3738f90d710134e1e5331d4283b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/443ae55a9de43ee80ca3c85454b2e20a626ce3b2923a25dd4d3f1a99d00e3d5b5c757fab110d9c06a8f8f3779a596d7ad101724afc884c049d01cbe2112edfbc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/712a1940796860451b40c0952ce392f8ce203e4968231436f74537d3e4c2ba61f6fc4be190a2770df78fe012312a2ed6f4db7d3a5015ced6fc19ceace9bdd35e"} 05:53:29 INFO - Running post-run listener: copy_logs_to_upload_dir 05:53:29 INFO - Copying logs to upload dir... 05:53:29 INFO - mkdir: /builds/slave/test/build/upload/logs 05:53:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.924712 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-14 05:53:29.362437) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 05:53:29.366228) ========= 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.qzphXmloOK/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.2g74QW7ArY/Listeners TMPDIR=/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2c3a0ce9351fde07cbfcb3d500d749b78dc50275723d6af859a7523ebe0cac519ae92b8c550a032c8a9d69bf0a9c83e21e9d3738f90d710134e1e5331d4283b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/443ae55a9de43ee80ca3c85454b2e20a626ce3b2923a25dd4d3f1a99d00e3d5b5c757fab110d9c06a8f8f3779a596d7ad101724afc884c049d01cbe2112edfbc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/712a1940796860451b40c0952ce392f8ce203e4968231436f74537d3e4c2ba61f6fc4be190a2770df78fe012312a2ed6f4db7d3a5015ced6fc19ceace9bdd35e"} build_url:https://queue.taskcluster.net/v1/task/NqAAlQERTBmG7mNWZXHclg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011525 build_url: 'https://queue.taskcluster.net/v1/task/NqAAlQERTBmG7mNWZXHclg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2c3a0ce9351fde07cbfcb3d500d749b78dc50275723d6af859a7523ebe0cac519ae92b8c550a032c8a9d69bf0a9c83e21e9d3738f90d710134e1e5331d4283b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/443ae55a9de43ee80ca3c85454b2e20a626ce3b2923a25dd4d3f1a99d00e3d5b5c757fab110d9c06a8f8f3779a596d7ad101724afc884c049d01cbe2112edfbc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/712a1940796860451b40c0952ce392f8ce203e4968231436f74537d3e4c2ba61f6fc4be190a2770df78fe012312a2ed6f4db7d3a5015ced6fc19ceace9bdd35e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 05:53:29.399647) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 05:53:29.400089) ========= 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.qzphXmloOK/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.2g74QW7ArY/Listeners TMPDIR=/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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.005373 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 05:53:29.448722) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 05:53:29.449053) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 05:53:29.449434) ========= ========= Total master_lag: 0.17 =========