builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0357 starttime: 1468332905.89 results: success (0) buildid: 20160712050428 builduid: 0f091952f68949979462673a70043946 revision: 621f32c868bb5654a1ae2dc25cbb622b3c0efd69 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 07:15:05.891187) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 07:15:05.891638) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 07:15:05.891970) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 07:15:05.916577) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 07:15:05.916970) ========= 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.tclZngQa3i/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.14MkMVpXvY/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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-12 07:15:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-07-12 07:15:06 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132369 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 07:15:06.071970) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 07:15:06.072336) ========= 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.tclZngQa3i/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.14MkMVpXvY/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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.025236 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 07:15:06.120813) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-12 07:15:06.121163) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 621f32c868bb5654a1ae2dc25cbb622b3c0efd69 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 621f32c868bb5654a1ae2dc25cbb622b3c0efd69 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tclZngQa3i/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.14MkMVpXvY/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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-12 07:15:06,203 truncating revision to first 12 chars 2016-07-12 07:15:06,203 Setting DEBUG logging. 2016-07-12 07:15:06,203 attempt 1/10 2016-07-12 07:15:06,203 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/621f32c868bb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 07:15:08,161 unpacking tar archive at: autoland-621f32c868bb/testing/mozharness/ program finished with exit code 0 elapsedTime=2.213848 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-12 07:15:08.356723) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 07:15:08.357102) ========= script_repo_revision: 621f32c868bb5654a1ae2dc25cbb622b3c0efd69 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 07:15:08.357537) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 07:15:08.357828) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 07:15:08.375823) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-12 07:15:08.376199) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tclZngQa3i/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.14MkMVpXvY/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 07:15:08 INFO - MultiFileLogger online at 20160712 07:15:08 in /builds/slave/test 07:15:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 07:15:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:15:08 INFO - {'append_to_log': False, 07:15:08 INFO - 'base_work_dir': '/builds/slave/test', 07:15:08 INFO - 'blob_upload_branch': 'Autoland', 07:15:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:15:08 INFO - 'branch': 'Autoland', 07:15:08 INFO - 'buildbot_json_path': 'buildprops.json', 07:15:08 INFO - 'config_files': ('talos/mac_config.py',), 07:15:08 INFO - 'default_actions': ('clobber', 07:15:08 INFO - 'read-buildbot-config', 07:15:08 INFO - 'download-and-extract', 07:15:08 INFO - 'populate-webroot', 07:15:08 INFO - 'create-virtualenv', 07:15:08 INFO - 'install', 07:15:08 INFO - 'run-tests'), 07:15:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:15:08 INFO - 'download_minidump_stackwalk': True, 07:15:08 INFO - 'download_symbols': 'ondemand', 07:15:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:15:08 INFO - 'tooltool.py': '/tools/tooltool.py', 07:15:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:15:08 INFO - '/tools/misc-python/virtualenv.py')}, 07:15:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:15:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:15:08 INFO - 'installer_path': 'installer.exe', 07:15:08 INFO - 'log_level': 'info', 07:15:08 INFO - 'log_name': 'talos', 07:15:08 INFO - 'log_to_console': True, 07:15:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:15:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:15:08 INFO - 'opt_config_files': (), 07:15:08 INFO - 'pip_index': False, 07:15:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:15:08 INFO - 'cmd': ('bash', 07:15:08 INFO - '-c', 07:15:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:15:08 INFO - 'enabled': True, 07:15:08 INFO - 'halt_on_failure': False, 07:15:08 INFO - 'name': 'check_screen_resolution'},), 07:15:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:15:08 INFO - 'cmd': ('bash', 07:15:08 INFO - '-c', 07:15:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:15:08 INFO - 'enabled': True, 07:15:08 INFO - 'halt_on_failure': False, 07:15:08 INFO - 'name': 'check_screen_resolution'},), 07:15:08 INFO - 'run_cmd_checks_enabled': True, 07:15:08 INFO - 'sps_profile': False, 07:15:08 INFO - 'sps_profile_interval': 0, 07:15:08 INFO - 'suite': 'dromaeojs', 07:15:08 INFO - 'system_bits': '32', 07:15:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:15:08 INFO - 'title': 't-yosemite-r7-0357', 07:15:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:15:08 INFO - 'use_talos_json': True, 07:15:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:15:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:15:08 INFO - 'work_dir': 'build'} 07:15:08 INFO - ##### 07:15:08 INFO - ##### Running clobber step. 07:15:08 INFO - ##### 07:15:08 INFO - Running pre-action listener: _resource_record_pre_action 07:15:08 INFO - Running main action method: clobber 07:15:08 INFO - rmtree: /builds/slave/test/build 07:15:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:15:10 INFO - Running post-action listener: _resource_record_post_action 07:15:10 INFO - ##### 07:15:10 INFO - ##### Finished clobber step (success) 07:15:10 INFO - ##### 07:15:10 INFO - ##### 07:15:10 INFO - ##### Running read-buildbot-config step. 07:15:10 INFO - ##### 07:15:10 INFO - Running pre-action listener: _resource_record_pre_action 07:15:10 INFO - Running main action method: read_buildbot_config 07:15:10 INFO - Using buildbot properties: 07:15:10 INFO - { 07:15:10 INFO - "project": "", 07:15:10 INFO - "product": "firefox", 07:15:10 INFO - "script_repo_revision": "production", 07:15:10 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 07:15:10 INFO - "repository": "", 07:15:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 07:15:10 INFO - "buildid": "20160712050428", 07:15:10 INFO - "pgo_build": "False", 07:15:10 INFO - "basedir": "/builds/slave/test", 07:15:10 INFO - "buildnumber": 55, 07:15:10 INFO - "slavename": "t-yosemite-r7-0357", 07:15:10 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 07:15:10 INFO - "platform": "yosemite_r7", 07:15:10 INFO - "scheduler": "tests-autoland-macosx64-talos", 07:15:10 INFO - "branch": "autoland", 07:15:10 INFO - "repo_path": "integration/autoland", 07:15:10 INFO - "revision": "621f32c868bb5654a1ae2dc25cbb622b3c0efd69", 07:15:10 INFO - "stage_platform": "macosx64", 07:15:10 INFO - "builduid": "0f091952f68949979462673a70043946", 07:15:10 INFO - "slavebuilddir": "test" 07:15:10 INFO - } 07:15:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/ScwdEvGoTCOa5tl-2oGZuw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 07:15:10 INFO - Running post-action listener: _resource_record_post_action 07:15:10 INFO - ##### 07:15:10 INFO - ##### Finished read-buildbot-config step (success) 07:15:10 INFO - ##### 07:15:10 INFO - ##### 07:15:10 INFO - ##### Running download-and-extract step. 07:15:10 INFO - ##### 07:15:10 INFO - Running pre-action listener: _resource_record_pre_action 07:15:10 INFO - Running main action method: download_and_extract 07:15:10 INFO - mkdir: /builds/slave/test/build/tests 07:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:10 INFO - https://queue.taskcluster.net/v1/task/ScwdEvGoTCOa5tl-2oGZuw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:15:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScwdEvGoTCOa5tl-2oGZuw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 07:15:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScwdEvGoTCOa5tl-2oGZuw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 07:15:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScwdEvGoTCOa5tl-2oGZuw/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 07:15:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScwdEvGoTCOa5tl-2oGZuw/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 07:15:11 INFO - Downloaded 1199 bytes. 07:15:11 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 07:15:11 INFO - Using the following test package requirements: 07:15:11 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 07:15:11 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 07:15:11 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 07:15:11 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 07:15:11 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 07:15:11 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 07:15:11 INFO - u'jsshell-mac.zip'], 07:15:11 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 07:15:11 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 07:15:11 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 07:15:11 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 07:15:11 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 07:15:11 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 07:15:11 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 07:15:11 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 07:15:11 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 07:15:11 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 07:15:11 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 07:15:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:15: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')]} 07:15:11 INFO - https://queue.taskcluster.net/v1/task/ScwdEvGoTCOa5tl-2oGZuw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:15:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScwdEvGoTCOa5tl-2oGZuw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 07:15:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScwdEvGoTCOa5tl-2oGZuw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 07:15:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScwdEvGoTCOa5tl-2oGZuw/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 07:15:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScwdEvGoTCOa5tl-2oGZuw/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 07:15:12 INFO - Downloaded 18772491 bytes. 07:15:12 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'] 07:15:12 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 07:15:15 INFO - Return code: 0 07:15:15 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 07:15:15 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')]} 07:15:15 INFO - https://queue.taskcluster.net/v1/task/ScwdEvGoTCOa5tl-2oGZuw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:15:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScwdEvGoTCOa5tl-2oGZuw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 07:15:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScwdEvGoTCOa5tl-2oGZuw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 07:15:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScwdEvGoTCOa5tl-2oGZuw/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 07:15:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScwdEvGoTCOa5tl-2oGZuw/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 07:15:16 INFO - Downloaded 18772491 bytes. 07:15:16 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'] 07:15:16 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 07:15:20 INFO - Return code: 0 07:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:15:20 INFO - https://queue.taskcluster.net/v1/task/ScwdEvGoTCOa5tl-2oGZuw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:15:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScwdEvGoTCOa5tl-2oGZuw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 07:15:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScwdEvGoTCOa5tl-2oGZuw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 07:15:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScwdEvGoTCOa5tl-2oGZuw/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 07:15:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScwdEvGoTCOa5tl-2oGZuw/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 07:15:21 INFO - Downloaded 14403317 bytes. 07:15:21 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'] 07:15:21 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 07:15:22 INFO - Return code: 0 07:15:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:22 INFO - https://queue.taskcluster.net/v1/task/ScwdEvGoTCOa5tl-2oGZuw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:15:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScwdEvGoTCOa5tl-2oGZuw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 07:15:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScwdEvGoTCOa5tl-2oGZuw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 07:15:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScwdEvGoTCOa5tl-2oGZuw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 07:15:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScwdEvGoTCOa5tl-2oGZuw/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 07:15:25 INFO - Downloaded 112458969 bytes. 07:15:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ScwdEvGoTCOa5tl-2oGZuw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 07:15:25 INFO - mkdir: /builds/slave/test/properties 07:15:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:15:25 INFO - Writing to file /builds/slave/test/properties/build_url 07:15:25 INFO - Contents: 07:15:25 INFO - build_url:https://queue.taskcluster.net/v1/task/ScwdEvGoTCOa5tl-2oGZuw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 07:15:26 INFO - Running post-action listener: _resource_record_post_action 07:15:26 INFO - Running post-action listener: set_extra_try_arguments 07:15:26 INFO - ##### 07:15:26 INFO - ##### Finished download-and-extract step (success) 07:15:26 INFO - ##### 07:15:26 INFO - ##### 07:15:26 INFO - ##### Running populate-webroot step. 07:15:26 INFO - ##### 07:15:26 INFO - Running pre-action listener: _resource_record_pre_action 07:15:26 INFO - Running main action method: populate_webroot 07:15:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:15:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:15:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:15:26 INFO - '--tppagecycles', 07:15:26 INFO - '7'], 07:15:26 INFO - 'tests': ['tsvgm']}}, 07:15:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:15:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:15:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:15:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:15:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:15:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:15:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:26 INFO - 'talos_options': ['--disable-e10s'], 07:15:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:26 INFO - 'talos_options': ['--disable-e10s'], 07:15:26 INFO - 'tests': ['damp', 'tps']}, 07:15:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:26 INFO - 'tests': ['damp', 'tps']}, 07:15:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:15:26 INFO - 'tests': ['dromaeo_dom']}, 07:15:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:15:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:15:26 INFO - 'tests': ['basic_compositor_video']}, 07:15:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:15:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:15:26 INFO - 'tests': ['a11yr', 07:15:26 INFO - 'ts_paint', 07:15:26 INFO - 'tpaint', 07:15:26 INFO - 'sessionrestore', 07:15:26 INFO - 'sessionrestore_no_auto_restore', 07:15:26 INFO - 'tabpaint']}, 07:15:26 INFO - 'other-e10s': {'tests': ['a11yr', 07:15:26 INFO - 'ts_paint', 07:15:26 INFO - 'tpaint', 07:15:26 INFO - 'sessionrestore', 07:15:26 INFO - 'sessionrestore_no_auto_restore', 07:15:26 INFO - 'tabpaint']}, 07:15:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:15:26 INFO - 'ts_paint', 07:15:26 INFO - 'tpaint', 07:15:26 INFO - 'sessionrestore', 07:15:26 INFO - 'sessionrestore_no_auto_restore', 07:15:26 INFO - 'tabpaint']}, 07:15:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:15:26 INFO - 'ts_paint', 07:15:26 INFO - 'tpaint', 07:15:26 INFO - 'sessionrestore', 07:15:26 INFO - 'sessionrestore_no_auto_restore', 07:15:26 INFO - 'tabpaint']}, 07:15:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:15:26 INFO - 'tests': ['a11yr', 07:15:26 INFO - 'ts_paint', 07:15:26 INFO - 'tpaint', 07:15:26 INFO - 'sessionrestore', 07:15:26 INFO - 'sessionrestore_no_auto_restore', 07:15:26 INFO - 'tabpaint']}, 07:15:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:15:26 INFO - 'tests': ['a11yr', 07:15:26 INFO - 'ts_paint', 07:15:26 INFO - 'tpaint', 07:15:26 INFO - 'sessionrestore', 07:15:26 INFO - 'sessionrestore_no_auto_restore', 07:15:26 INFO - 'tabpaint']}, 07:15:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:15:26 INFO - 'tests': ['tsvgx', 07:15:26 INFO - 'tsvgr_opacity', 07:15:26 INFO - 'tart', 07:15:26 INFO - 'tscrollx', 07:15:26 INFO - 'cart']}, 07:15:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:15:26 INFO - 'tsvgr_opacity', 07:15:26 INFO - 'tart', 07:15:26 INFO - 'tscrollx', 07:15:26 INFO - 'cart']}, 07:15:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:26 INFO - 'talos_options': ['--disable-e10s'], 07:15:26 INFO - 'tests': ['tp5o']}, 07:15:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:26 INFO - 'tests': ['tp5o']}, 07:15:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:26 INFO - 'talos_options': ['--disable-e10s', 07:15:26 INFO - '--xperf_path', 07:15:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:26 INFO - 'tests': ['tp5n']}, 07:15:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:26 INFO - 'talos_options': ['--xperf_path', 07:15:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:26 INFO - 'tests': ['tp5n']}}, 07:15:26 INFO - 'talos.zip': {'path': '', 07:15:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:15:26 INFO - Running post-action listener: _resource_record_post_action 07:15:26 INFO - ##### 07:15:26 INFO - ##### Finished populate-webroot step (success) 07:15:26 INFO - ##### 07:15:26 INFO - ##### 07:15:26 INFO - ##### Running create-virtualenv step. 07:15:26 INFO - ##### 07:15:26 INFO - Running pre-action listener: _resource_record_pre_action 07:15:26 INFO - Running main action method: create_virtualenv 07:15:26 INFO - Creating virtualenv /builds/slave/test/build/venv 07:15:26 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 07:15:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:15:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:15:26 INFO - Using real prefix '/tools/python27' 07:15:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:15:27 INFO - Installing distribute.............................................................................................................................................................................................done. 07:15:30 INFO - Installing pip.................done. 07:15:30 INFO - Return code: 0 07:15:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10418fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104224618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86705652e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f3d30>, '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 0x103e58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ebb20>, '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.tclZngQa3i/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.14MkMVpXvY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 07:15:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:15:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tclZngQa3i/Render', 07:15:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:30 INFO - 'HOME': '/Users/cltbld', 07:15:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:30 INFO - 'LOGNAME': 'cltbld', 07:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:30 INFO - 'MOZ_NO_REMOTE': '1', 07:15:30 INFO - 'NO_EM_RESTART': '1', 07:15:30 INFO - 'PAGER': '/bin/cat', 07:15:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:30 INFO - 'PWD': '/builds/slave/test', 07:15:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:30 INFO - 'SHELL': '/bin/bash', 07:15:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.14MkMVpXvY/Listeners', 07:15:30 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 07:15:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:30 INFO - 'USER': 'cltbld', 07:15:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:30 INFO - 'XPC_FLAGS': '0x0', 07:15:30 INFO - 'XPC_SERVICE_NAME': '0', 07:15:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:30 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 07:15:30 INFO - Cleaning up... 07:15:30 INFO - Return code: 0 07:15:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10418fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104224618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86705652e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f3d30>, '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 0x103e58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ebb20>, '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.tclZngQa3i/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.14MkMVpXvY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 07:15:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:15:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tclZngQa3i/Render', 07:15:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:30 INFO - 'HOME': '/Users/cltbld', 07:15:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:30 INFO - 'LOGNAME': 'cltbld', 07:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:30 INFO - 'MOZ_NO_REMOTE': '1', 07:15:30 INFO - 'NO_EM_RESTART': '1', 07:15:30 INFO - 'PAGER': '/bin/cat', 07:15:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:30 INFO - 'PWD': '/builds/slave/test', 07:15:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:30 INFO - 'SHELL': '/bin/bash', 07:15:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.14MkMVpXvY/Listeners', 07:15:30 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 07:15:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:30 INFO - 'USER': 'cltbld', 07:15:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:30 INFO - 'XPC_FLAGS': '0x0', 07:15:30 INFO - 'XPC_SERVICE_NAME': '0', 07:15:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:30 INFO - Downloading/unpacking psutil>=3.1.1 07:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:15:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:33 INFO - Installing collected packages: psutil 07:15:33 INFO - Running setup.py install for psutil 07:15:33 INFO - building 'psutil._psutil_osx' extension 07:15:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:15:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:15:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:15:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:15:34 INFO - building 'psutil._psutil_posix' extension 07:15:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:15:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:15:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:15:34 INFO - ^ 07:15:34 INFO - 1 warning generated. 07:15:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:15:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:34 INFO - Successfully installed psutil 07:15:34 INFO - Cleaning up... 07:15:34 INFO - Return code: 0 07:15:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10418fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104224618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86705652e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f3d30>, '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 0x103e58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ebb20>, '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.tclZngQa3i/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.14MkMVpXvY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 07:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:15:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tclZngQa3i/Render', 07:15:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:34 INFO - 'HOME': '/Users/cltbld', 07:15:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:34 INFO - 'LOGNAME': 'cltbld', 07:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:34 INFO - 'MOZ_NO_REMOTE': '1', 07:15:34 INFO - 'NO_EM_RESTART': '1', 07:15:34 INFO - 'PAGER': '/bin/cat', 07:15:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:34 INFO - 'PWD': '/builds/slave/test', 07:15:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:34 INFO - 'SHELL': '/bin/bash', 07:15:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.14MkMVpXvY/Listeners', 07:15:34 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 07:15:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:34 INFO - 'USER': 'cltbld', 07:15:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:34 INFO - 'XPC_FLAGS': '0x0', 07:15:34 INFO - 'XPC_SERVICE_NAME': '0', 07:15:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:15:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:15:37 INFO - Installing collected packages: mozsystemmonitor 07:15:37 INFO - Running setup.py install for mozsystemmonitor 07:15:37 INFO - Successfully installed mozsystemmonitor 07:15:37 INFO - Cleaning up... 07:15:37 INFO - Return code: 0 07:15:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10418fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104224618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86705652e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f3d30>, '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 0x103e58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ebb20>, '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.tclZngQa3i/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.14MkMVpXvY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 07:15:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:15:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:15:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tclZngQa3i/Render', 07:15:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:37 INFO - 'HOME': '/Users/cltbld', 07:15:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:37 INFO - 'LOGNAME': 'cltbld', 07:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:37 INFO - 'MOZ_NO_REMOTE': '1', 07:15:37 INFO - 'NO_EM_RESTART': '1', 07:15:37 INFO - 'PAGER': '/bin/cat', 07:15:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:37 INFO - 'PWD': '/builds/slave/test', 07:15:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:37 INFO - 'SHELL': '/bin/bash', 07:15:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.14MkMVpXvY/Listeners', 07:15:37 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 07:15:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:37 INFO - 'USER': 'cltbld', 07:15:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:37 INFO - 'XPC_FLAGS': '0x0', 07:15:37 INFO - 'XPC_SERVICE_NAME': '0', 07:15:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:37 INFO - Downloading/unpacking jsonschema==2.5.1 07:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:15:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:40 INFO - Downloading functools32-3.2.3-2.tar.gz 07:15:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:15:40 INFO - warning: no files found matching '*.txt' 07:15:40 INFO - no previously-included directories found matching 'build' 07:15:40 INFO - no previously-included directories found matching 'dist' 07:15:40 INFO - no previously-included directories found matching '.git*' 07:15:40 INFO - Installing collected packages: jsonschema, functools32 07:15:40 INFO - Running setup.py install for functools32 07:15:40 INFO - warning: no files found matching '*.txt' 07:15:40 INFO - no previously-included directories found matching 'build' 07:15:40 INFO - no previously-included directories found matching 'dist' 07:15:40 INFO - no previously-included directories found matching '.git*' 07:15:40 INFO - Successfully installed jsonschema functools32 07:15:40 INFO - Cleaning up... 07:15:40 INFO - Return code: 0 07:15:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:40 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 0x10418fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104224618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86705652e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f3d30>, '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 0x103e58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ebb20>, '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.tclZngQa3i/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.14MkMVpXvY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 07:15:40 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 07:15:40 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 07:15:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tclZngQa3i/Render', 07:15:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:40 INFO - 'HOME': '/Users/cltbld', 07:15:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:40 INFO - 'LOGNAME': 'cltbld', 07:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:40 INFO - 'MOZ_NO_REMOTE': '1', 07:15:40 INFO - 'NO_EM_RESTART': '1', 07:15:40 INFO - 'PAGER': '/bin/cat', 07:15:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:40 INFO - 'PWD': '/builds/slave/test', 07:15:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:40 INFO - 'SHELL': '/bin/bash', 07:15:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.14MkMVpXvY/Listeners', 07:15:40 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 07:15:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:40 INFO - 'USER': 'cltbld', 07:15:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:40 INFO - 'XPC_FLAGS': '0x0', 07:15:40 INFO - 'XPC_SERVICE_NAME': '0', 07:15:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:41 INFO - Downloading/unpacking blobuploader==1.2.4 07:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:43 INFO - Downloading blobuploader-1.2.4.tar.gz 07:15:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:15:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:15:43 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 07:15:43 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 07:15:43 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 07:15:43 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 07:15:43 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 07:15:43 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 07:15:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:15:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:44 INFO - Downloading docopt-0.6.1.tar.gz 07:15:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:15:44 INFO - Installing collected packages: blobuploader, requests, docopt 07:15:44 INFO - Running setup.py install for blobuploader 07:15:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:15:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:15:45 INFO - Running setup.py install for requests 07:15:45 INFO - Running setup.py install for docopt 07:15:45 INFO - Successfully installed blobuploader requests docopt 07:15:45 INFO - Cleaning up... 07:15:45 INFO - Return code: 0 07:15:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:45 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 0x10418fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104224618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86705652e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f3d30>, '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 0x103e58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ebb20>, '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.tclZngQa3i/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.14MkMVpXvY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 07:15:45 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 07:15:45 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 07:15:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tclZngQa3i/Render', 07:15:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:45 INFO - 'HOME': '/Users/cltbld', 07:15:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:45 INFO - 'LOGNAME': 'cltbld', 07:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:45 INFO - 'MOZ_NO_REMOTE': '1', 07:15:45 INFO - 'NO_EM_RESTART': '1', 07:15:45 INFO - 'PAGER': '/bin/cat', 07:15:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:45 INFO - 'PWD': '/builds/slave/test', 07:15:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:45 INFO - 'SHELL': '/bin/bash', 07:15:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.14MkMVpXvY/Listeners', 07:15:45 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 07:15:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:45 INFO - 'USER': 'cltbld', 07:15:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:45 INFO - 'XPC_FLAGS': '0x0', 07:15:45 INFO - 'XPC_SERVICE_NAME': '0', 07:15:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-IPwMPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-CubfrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-qdh8Y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-kqb5X2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-lHMTW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-49r0dU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-QG06WV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-7IEC2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-3AfXbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-XNt9Ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:47 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-wNDI3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:47 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-3AlO0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:47 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-2TURcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:47 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-D_8tct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:47 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-b2EztJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:47 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-yEIk_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:47 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-zeie2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:15:47 INFO - Running setup.py install for manifestparser 07:15:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:15:47 INFO - Running setup.py install for mozcrash 07:15:48 INFO - Running setup.py install for mozdebug 07:15:48 INFO - Running setup.py install for mozdevice 07:15:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:15:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:15:48 INFO - Running setup.py install for mozfile 07:15:48 INFO - Running setup.py install for mozhttpd 07:15:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:15:48 INFO - Running setup.py install for mozinfo 07:15:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:15:48 INFO - Running setup.py install for mozInstall 07:15:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:15:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:15:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:15:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:15:48 INFO - Running setup.py install for mozleak 07:15:49 INFO - Running setup.py install for mozlog 07:15:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:15:49 INFO - Running setup.py install for moznetwork 07:15:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:15:49 INFO - Running setup.py install for mozprocess 07:15:49 INFO - Running setup.py install for mozprofile 07:15:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:15:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:15:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:15:49 INFO - Running setup.py install for mozrunner 07:15:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:15:49 INFO - Running setup.py install for mozscreenshot 07:15:50 INFO - Running setup.py install for moztest 07:15:50 INFO - Running setup.py install for mozversion 07:15:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:15:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:15:50 INFO - Cleaning up... 07:15:50 INFO - Return code: 0 07:15:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:50 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')]} 07:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:50 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')]} 07:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:50 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 0x10418fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104224618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86705652e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f3d30>, '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 0x103e58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ebb20>, '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.tclZngQa3i/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.14MkMVpXvY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 07:15:50 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 07:15:50 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 07:15:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tclZngQa3i/Render', 07:15:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:50 INFO - 'HOME': '/Users/cltbld', 07:15:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:50 INFO - 'LOGNAME': 'cltbld', 07:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:50 INFO - 'MOZ_NO_REMOTE': '1', 07:15:50 INFO - 'NO_EM_RESTART': '1', 07:15:50 INFO - 'PAGER': '/bin/cat', 07:15:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:50 INFO - 'PWD': '/builds/slave/test', 07:15:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:50 INFO - 'SHELL': '/bin/bash', 07:15:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.14MkMVpXvY/Listeners', 07:15:50 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 07:15:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:50 INFO - 'USER': 'cltbld', 07:15:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:50 INFO - 'XPC_FLAGS': '0x0', 07:15:50 INFO - 'XPC_SERVICE_NAME': '0', 07:15:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:50 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-8RJfns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:50 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)) 07:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:50 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-jCxL1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:50 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)) 07:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:50 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-kBSso6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:50 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)) 07:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:50 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-MIaapG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:51 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-1F6Rx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:51 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-tWFhII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:51 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-uJHKDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:51 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)) 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:51 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-3YYqoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:51 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)) 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:51 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-WJ0mLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:51 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)) 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:51 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-606o7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:51 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)) 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:51 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-vxGgCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:51 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)) 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:51 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-3_ANl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:51 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)) 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:51 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-Km1Xzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:51 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)) 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:52 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-wNRvEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:52 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)) 07:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:52 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-mvIhha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:52 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-EfycVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:52 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)) 07:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:52 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-t8EXgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:52 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)) 07:15:52 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)) 07:15:52 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)) 07:15:52 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)) 07:15:52 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)) 07:15:52 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)) 07:15:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:15:52 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 07:15:52 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 07:15:52 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 07:15:52 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 07:15:52 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 07:15:52 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 07:15:54 INFO - Downloading blessings-1.6.tar.gz 07:15:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:15:54 INFO - Installing collected packages: blessings 07:15:54 INFO - Running setup.py install for blessings 07:15:55 INFO - Successfully installed blessings 07:15:55 INFO - Cleaning up... 07:15:55 INFO - Return code: 0 07:15:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:15:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:15:55 INFO - Reading from file tmpfile_stdout 07:15:55 INFO - Current package versions: 07:15:55 INFO - blessings == 1.6 07:15:55 INFO - blobuploader == 1.2.4 07:15:55 INFO - docopt == 0.6.1 07:15:55 INFO - functools32 == 3.2.3-2 07:15:55 INFO - jsonschema == 2.5.1 07:15:55 INFO - manifestparser == 1.1 07:15:55 INFO - mozInstall == 1.12 07:15:55 INFO - mozcrash == 0.17 07:15:55 INFO - mozdebug == 0.1 07:15:55 INFO - mozdevice == 0.48 07:15:55 INFO - mozfile == 1.2 07:15:55 INFO - mozhttpd == 0.7 07:15:55 INFO - mozinfo == 0.9 07:15:55 INFO - mozleak == 0.1 07:15:55 INFO - mozlog == 3.2 07:15:55 INFO - moznetwork == 0.27 07:15:55 INFO - mozprocess == 0.23 07:15:55 INFO - mozprofile == 0.28 07:15:55 INFO - mozrunner == 6.12 07:15:55 INFO - mozscreenshot == 0.1 07:15:55 INFO - mozsystemmonitor == 0.3 07:15:55 INFO - moztest == 0.7 07:15:55 INFO - mozversion == 1.4 07:15:55 INFO - psutil == 3.1.1 07:15:55 INFO - requests == 1.2.3 07:15:55 INFO - wsgiref == 0.1.2 07:15:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:55 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')]} 07:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:55 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')]} 07:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:55 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 0x10418fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104224618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86705652e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f3d30>, '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 0x103e58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ebb20>, '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.tclZngQa3i/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.14MkMVpXvY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 07:15:55 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 07:15:55 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 07:15:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tclZngQa3i/Render', 07:15:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:55 INFO - 'HOME': '/Users/cltbld', 07:15:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:55 INFO - 'LOGNAME': 'cltbld', 07:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:55 INFO - 'MOZ_NO_REMOTE': '1', 07:15:55 INFO - 'NO_EM_RESTART': '1', 07:15:55 INFO - 'PAGER': '/bin/cat', 07:15:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:55 INFO - 'PWD': '/builds/slave/test', 07:15:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:55 INFO - 'SHELL': '/bin/bash', 07:15:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.14MkMVpXvY/Listeners', 07:15:55 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 07:15:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:55 INFO - 'USER': 'cltbld', 07:15:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:55 INFO - 'XPC_FLAGS': '0x0', 07:15:55 INFO - 'XPC_SERVICE_NAME': '0', 07:15:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:55 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)) 07:15:55 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)) 07:15:55 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)) 07:15:55 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)) 07:15:55 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)) 07:15:55 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)) 07:15:55 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)) 07:15:55 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)) 07:15:55 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)) 07:15:55 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)) 07:15:55 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)) 07:15:55 INFO - Cleaning up... 07:15:55 INFO - Return code: 0 07:15:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:15:55 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')]} 07:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:55 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')]} 07:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:55 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 0x10418fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104224618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86705652e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f3d30>, '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 0x103e58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ebb20>, '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.tclZngQa3i/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.14MkMVpXvY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 07:15:55 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 07:15:55 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 07:15:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tclZngQa3i/Render', 07:15:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:55 INFO - 'HOME': '/Users/cltbld', 07:15:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:55 INFO - 'LOGNAME': 'cltbld', 07:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:55 INFO - 'MOZ_NO_REMOTE': '1', 07:15:55 INFO - 'NO_EM_RESTART': '1', 07:15:55 INFO - 'PAGER': '/bin/cat', 07:15:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:55 INFO - 'PWD': '/builds/slave/test', 07:15:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:55 INFO - 'SHELL': '/bin/bash', 07:15:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.14MkMVpXvY/Listeners', 07:15:55 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 07:15:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:55 INFO - 'USER': 'cltbld', 07:15:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:55 INFO - 'XPC_FLAGS': '0x0', 07:15:55 INFO - 'XPC_SERVICE_NAME': '0', 07:15:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:15:55 INFO - Cleaning up... 07:15:55 INFO - Return code: 0 07:15:55 INFO - Running post-action listener: _resource_record_post_action 07:15:55 INFO - Running post-action listener: _start_resource_monitoring 07:15:55 INFO - Starting resource monitoring. 07:15:55 INFO - ##### 07:15:55 INFO - ##### Finished create-virtualenv step (success) 07:15:55 INFO - ##### 07:15:55 INFO - ##### 07:15:55 INFO - ##### Running install step. 07:15:55 INFO - ##### 07:15:55 INFO - Running pre-action listener: _resource_record_pre_action 07:15:55 INFO - Running main action method: install 07:15:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:15:56 INFO - Reading from file tmpfile_stdout 07:15:56 INFO - Detecting whether we're running mozinstall >=1.0... 07:15:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:15:56 INFO - Reading from file tmpfile_stdout 07:15:56 INFO - Output received: 07:15:56 INFO - Usage: mozinstall [options] installer 07:15:56 INFO - Options: 07:15:56 INFO - -h, --help show this help message and exit 07:15:56 INFO - -d DEST, --destination=DEST 07:15:56 INFO - Directory to install application into. [default: 07:15:56 INFO - "/builds/slave/test"] 07:15:56 INFO - --app=APP Application being installed. [default: firefox] 07:15:56 INFO - mkdir: /builds/slave/test/build/application 07:15:56 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'] 07:15:56 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 07:16:30 INFO - Reading from file tmpfile_stdout 07:16:30 INFO - Output received: 07:16:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:16:30 INFO - Running post-action listener: _resource_record_post_action 07:16:30 INFO - ##### 07:16:30 INFO - ##### Finished install step (success) 07:16:30 INFO - ##### 07:16:30 INFO - ##### 07:16:30 INFO - ##### Running run-tests step. 07:16:30 INFO - ##### 07:16:30 INFO - Running pre-action listener: _resource_record_pre_action 07:16:30 INFO - Running main action method: run_tests 07:16:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:16:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:16:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:16:30 INFO - 2016-07-12 07:16:30.863 screenresolution[1652:7492] starting screenresolution argv=screenresolution get 07:16:30 INFO - 2016-07-12 07:16:30.865 screenresolution[1652:7492] Display 0: 1600x1200x32@60 07:16:30 INFO - 2016-07-12 07:16:30.872 screenresolution[1653:7496] starting screenresolution argv=screenresolution list 07:16:30 INFO - Available Modes on Display 0 07:16:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:16:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:16:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:16:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:16:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:16:31 INFO - Intel Iris: 07:16:31 INFO - Chipset Model: Intel Iris 07:16:31 INFO - Type: GPU 07:16:31 INFO - Bus: Built-In 07:16:31 INFO - VRAM (Dynamic, Max): 1536 MB 07:16:31 INFO - Vendor: Intel (0x8086) 07:16:31 INFO - Device ID: 0x0a2e 07:16:31 INFO - Revision ID: 0x0009 07:16:31 INFO - Displays: 07:16:31 INFO - Display: 07:16:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:16:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:16:31 INFO - Display Serial Number: 1600x1200 60 07:16:31 INFO - Main Display: Yes 07:16:31 INFO - Mirror: Off 07:16:31 INFO - Online: Yes 07:16:31 INFO - Rotation: Supported 07:16:31 INFO - Return code: 0 07:16:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:16:31 INFO - Python 2.7.3 07:16:31 INFO - Return code: 0 07:16:31 INFO - grabbing minidump binary from tooltool 07:16:31 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')]} 07:16:31 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 0x1040f3d30>, '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 0x103e58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ebb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:16:31 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 07:16:31 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 07:16:31 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 07:16:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:16:31 INFO - Return code: 0 07:16:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:16:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:16:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:16:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:16:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:16:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ScwdEvGoTCOa5tl-2oGZuw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0357', '--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 07:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ScwdEvGoTCOa5tl-2oGZuw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0357 --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 07:16:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tclZngQa3i/Render', 07:16:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:16:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:16:31 INFO - 'HOME': '/Users/cltbld', 07:16:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:16:31 INFO - 'LOGNAME': 'cltbld', 07:16:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:16:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:31 INFO - 'MOZ_NO_REMOTE': '1', 07:16:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:16:31 INFO - 'NO_EM_RESTART': '1', 07:16:31 INFO - 'PAGER': '/bin/cat', 07:16:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:31 INFO - 'PWD': '/builds/slave/test', 07:16:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:16:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:16:31 INFO - 'SHELL': '/bin/bash', 07:16:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.14MkMVpXvY/Listeners', 07:16:31 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 07:16:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:16:31 INFO - 'USER': 'cltbld', 07:16:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:16:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:31 INFO - 'XPC_FLAGS': '0x0', 07:16:31 INFO - 'XPC_SERVICE_NAME': '0', 07:16:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:16:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ScwdEvGoTCOa5tl-2oGZuw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0357', '--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 07:16:31 INFO - mozversion application_buildid: 20160712050428 07:16:31 INFO - mozversion application_changeset: 621f32c868bb5654a1ae2dc25cbb622b3c0efd69 07:16:31 INFO - mozversion application_display_name: Nightly 07:16:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:16:31 INFO - mozversion application_name: Firefox 07:16:31 INFO - mozversion application_remotingname: firefox 07:16:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 07:16:31 INFO - mozversion application_vendor: Mozilla 07:16:31 INFO - mozversion application_version: 50.0a1 07:16:31 INFO - mozversion platform_buildid: 20160712050428 07:16:31 INFO - mozversion platform_changeset: 621f32c868bb5654a1ae2dc25cbb622b3c0efd69 07:16:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 07:16:31 INFO - mozversion platform_version: 50.0a1 07:16:31 INFO - using testdate: 1468332991 07:16:31 INFO - actual date: 1468332991 07:16:31 INFO - starting webserver on 'localhost:49266' 07:16:31 INFO - SUITE-START | Running 2 tests 07:16:31 INFO - TEST-START | dromaeo_css 07:16:31 INFO - operating with platform_type : mac_ 07:16:31 INFO - Initialising browser for dromaeo_css test... 07:16:31 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmp1fup91/profile http://localhost:49266/getInfo.html) 07:16:33 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 07:16:33 INFO - PROCESS | 1663 | colorDepth:24 07:16:33 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 07:16:33 INFO - PROCESS | 1663 | __metrics 07:16:34 INFO - PROCESS | 1663 | 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" 07:16:34 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:16:34 INFO - TEST-INFO | 1663: exit 0 07:16:34 INFO - Browser initialized. 07:16:34 INFO - Running cycle 1/1 for dromaeo_css test... 07:16:34 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmp1fup91/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:16:46 INFO - PROCESS | 1665 | RSS: Main: 243589120 07:16:46 INFO - PROCESS | 1665 | 07:17:38 INFO - PROCESS | 1665 | 1468333058278 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] 07:19:49 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 07:19:51 INFO - PROCESS | 1665 | RSS: Main: 342355968 07:19:51 INFO - PROCESS | 1665 | 07:22:54 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 07:22:54 INFO - PROCESS | 1665 | RSS: Main: 378425344 07:22:54 INFO - PROCESS | 1665 | 07:25:57 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 07:25:57 INFO - PROCESS | 1665 | RSS: Main: 370151424 07:25:57 INFO - PROCESS | 1665 | 07:29:00 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 07:29:00 INFO - PROCESS | 1665 | RSS: Main: 371593216 07:29:00 INFO - PROCESS | 1665 | 07:32:04 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 07:32:04 INFO - PROCESS | 1665 | RSS: Main: 343367680 07:32:04 INFO - PROCESS | 1665 | 07:35:07 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 07:35:07 INFO - PROCESS | 1665 | RSS: Main: 413716480 07:35:07 INFO - PROCESS | 1665 | 07:35:07 INFO - PROCESS | 1665 | __start_tp_report 07:35:07 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 07:35:07 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 07:35:07 INFO - PROCESS | 1665 | |i|pagename|runs| 07:35:07 INFO - PROCESS | 1665 | |0;dojo.html;3352.128446603883;3399.8130102844348;3405.6083550391713;3407.1311815487047;3465.237647717503;5702.401247868966;5743.282089738783;5760.7695692172365;5830.970845145774;5857.765689372425;5805.593608447411;5844.824655260349;5848.707564621774;5854.034084376073;5865;5213.817516386936;5260.289860868772;5289.047971365153;5289.968456151052;5349.893002139975;5240.423553409122;5288.788448462076;5336.626436149471;5373.570114390839;5377;5274.5780337572905;5338.866528336784;5356.437574054727;5375.381831089416;5383.730813459331;5334.199870019509;5342.439043900374;5351.117065684158;5357.276767636358;5388.595855310868;5021.146405111103;5052;5173.870653233699;5240.580753539708;5247.553957913582;5791.131330300446;5857.179994800731;5900.645961242296;5906.202662640531;5911.113333000041;6256.311805701369;6302.1177035215105;6311.242650881878;6322.051692246154;6326.398992095744;6189;6243.96878015607;6255.624662520263;6261.311255761862;6263.123162757218;5741.540676745851;5828.708564571754;5865.501432378211;5968.612040217416;5977.073553599155;6198.318184999646;6331.335209802996;6335.746570137143;6336.556441049174;6340.651264180515;6211.3478084801345;6236;6244.500439964792;6256.562040657111;6275.748970041239;6164.722587483574;6227.19046523949;6238.407351301619;6259.342769009279;6306.4639505642535;6263.091851681481;6273.7176827042895;6281.434670879643;6281.59169653971;6284.465820405226;6246.4378205960775;6260.40526150015;6274.215723034621;6289.7169627365965;6292.622442653455;4944.876378090505;4945.851624451272;4949.133901567211;4999.100161970808;5042.092423363756;4507.909841803145;4531.410916580823;4543.613792827647;4544.795484203219;4572.199865023607;5725.3988331225455;5792.797252096157;5797.623154494944;5836.270466191726;5846.94153058464;6200.162977998003;6218.098375735493;6219.595726277868;6248.218972628421;6261.592996455216;5870.589058765845;5883.441073098049;5886.23478947734;5888.558358123158;5949.048152295699;5393.352797664305;5450.91823622646;5499.340079190522;5546.278983732089;5547.805826796042;5295.999999999923;6349.714262858275;6372.87254254903;6378.3621637837705;6387.712552935222;6234.314225435289;6259.593126446766;6263.592866463665;6264.812055638338;6267.091271765477;6166.753329866755;6248.250209974832;6287.088372186099;6347.809565713036;6384.106225128578;6264.154339164337;6267.780627678009;6281.96859015702;6289.150964619717;6301.464375528131;6201.410865967726;6260.593061450991;6260.624362538262;6262.718177682106;6290.433860952537;6004.519638428827;6115.453310713017;6139.369480960641;6178.66017369049;6229.56393052482;4994.350734404504;5923.763049478145;6186.536009799193;6222.191115155182;6262.812115636538;5178.91242839008;6101.7559297627595;6126.417990290915;6141.447269745744;6146.692665366624;5351.866203344947;6052.273727152769;6073.757049717962;6185.783497577563;6194.677085453587;6098.662722011044;6111.622125543816;6117.283643067005;6135.875804921915;6138.109974053648 07:35:07 INFO - PROCESS | 1665 | |1;ext.html;493.4547325205648;514.5446280042164;518.3701802310193;518.5540435225707;546.8379693152052;22508.54982900341;40816.387754183714;42006.36990445146;42084;42142.7892860536;42512.362314565304;42944;42967;43020;43058.13883722324;8677.522736249504;9686.951565242181;9813.558389872473;9816.214702823758;9831.508424578778;8636.913630863704;11683.766324673501;11912;11917.986971107423;12179.512819487254;11729.648110556696;11805.173637845312;11817.290962542233;11818.290902545832;11838.822417663741;8627.525486098262;11571.247868888495;11821.17251792375;11872.168948173632;11886.643400697949;9853.916069232379;11409.657710268706;11646.650600481998;11729.061675065974;11745.647630571097;40894;41279.1744165118;41293.793531032454;41378.58621413808;41396.586034139575;3565.144365352297;3716.535433070866;3805.8858234253016;4072.9592704072875;4436.600705936481;32108;32357;33482;33530.664693353;33599.49600755991;3180.8568614412407;3424.5890493140732;3434.0384692286198;3437.570303712036;3438.535797667308;524271;536628;536954;537355;537359;69081.92754217381;69844.30155698479;69886.65056674786;69913.65043174752;70064;67941.66029169822;72470.91293630599;72859.63570182116;72886;73024;15463.5360939172;17141;17415.129243537773;17415.651686966445;17420.65158696819;11854.88145118555;12112.697182570506;12123.393830308625;12985.805212921814;13313.40089695966;15311.924776945305;16834.905731127437;20329.593408131754;20555.486112847;20764.68852967207;8645.524496152771;8715.651373945098;8733.34499912509;8784.824303513893;8867.689630863018;884.2130503851578;996.5415908681942;1085.1915323084195;1104.7514309280348;1115.369816053927;29174.562381564294;30779;30856.69143308583;31471.055868323987;31695.52456713151;1011.8532812742259;1048.8531605575226;1093.8632670916136;1136.431784107946;1256.7674980128706;15963.521094367188;16026.75959860603;16071.67856642884;16189.352425903067;16499.6700065998;710966;712869;721379;721394;723224;61687.38312616816;62046.37953620406;62107.68946155331;62350;62385.68807155935;1112.5994641928899;1323.8676132386684;1366.2349084512705;1422.182245209009;1434.813474248341;30563.54154687637;31942;32201.194970124998;32508;32604.184895376857;51795.96408071893;51805.481945180065;52330.73834630955;52426.95146097133;52468.47531524636;556450;558904;558969;559639;560913;43547.487146786356;44395.338489459435;45021.77489112534;45218.77390613026;45423.31865021961;48932.510674892794;49338.50661493483;50017.24974125318;50042.749786252294;50563.49436505588;40797;41728.37407438952;42592.78703606462;43338.56661433345;44362.778186108866;40710.389344159266;41259.38110928278;41393.58606413897;41782.37326440166;42221.36667949922;39142.02144946399;39623.40564891471;39808.40287395749;40079.79960100181;40107.39838902477;33335;35660.28679426345;36165.915022549365;36256.63743362533;36615.05142395206;26115.347116322246;26126;26261.16171867951;26498.668571799117;26583 07:35:07 INFO - PROCESS | 1665 | |2;jquery.html;301.7797008184027;380.1029570214294;389.12058747231265;390.1767271058068;414.46327006526565;15308.31112599933;16159.676806463878;20636.69044964327;20764.792352076493;20806.89596552019;20504.282350117748;20701.482462938435;21364.038618262217;21608.459788505294;21656.566868662616;5124.4875512448825;5402.567794576435;5591.608587398863;5595.524380427669;6201.937980620204;6146;6156.6921653917125;6179.62922224668;6192.938070619303;6203.968980155093;5440.3743569489425;5532.917006244909;5541.141123125902;5899.852503687421;6159.568830181889;5552.250446189753;5559.749811258503;5592.133219351007;5596.692181929992;5603.635763675348;4936.925946110811;4990.575801056878;5365.704886231256;5367.812126575551;5370.57035437168;13498.932505337509;13829.51596694121;13847.653808654764;24585.016599336006;25922.74077259222;2100.2754049852774;2179.4115588791096;2215.4572129828134;2234.229190929127;2296.4603318220206;10089.495525223709;10280.280380373377;10526.263161578692;10530.894691053069;10585.153187744962;1523.7017515125442;1763.6719331870263;1812.9093545322812;1831.8442932350765;1892.5079479335334;122455;127207;131803;132737;132931;9267.582958766872;10025.298229124037;11002.679678438639;11655.941720291514;11680.379082484456;14714.264286785618;14788.260586970824;14791.852081479263;14812.851871481147;14828.184449855145;8593.742187734379;8669.21977022071;8691.739247822576;8823.602937867812;8824.602892869836;8627.654893804178;8646.832677588445;8651.653933842701;8776.60505277264;8782.121787821294;4491.550844915548;4575.428071491064;4581.777837748689;4592.839250626212;4671.369365135731;1902.7431296775035;1979.8614097013358;2006.6989951507392;2010.9899450502653;2012.154894944127;905.2848249882651;915.6062892956093;995.6415690351467;1034.622362837559;1060.151878497199;18421.90789046046;21764.782352176593;22145.224917127824;22180.88909555442;22211.44471388196;907.7518412183248;919.2140719684706;934.4393363981557;961.0149596663476;1034.8085604163255;11133.665990020312;11494.942525287488;11578.36319002463;11591.95672389489;11616.128790340757;511915;552244;610222;630567;632661;70347;110720;120356.39821800835;140073;142005;959.4387283439266;962.4081190068198;968.719071469266;989.8762654668167;996.3424140067666;17492;19343.322983695503;19432.125554349805;19492.8050719491;19503.317383891495;55226.72386638041;56482.43517564936;58053.709731451076;58125.709371452875;58719.53201170005;83955.58022209849;84566.77166141791;85069;85218.29563408821;86225.56887215524;8173.100958894635;8242.546659933761;8298.253157215879;8312.6674933002;8371.916280837113;9353.485558294358;12598.87401125977;12816.807747883975;13029.804552931524;13637.386317615532;11048.944755276172;11106.444677765918;11209.943950280196;11255.66233013011;11367.886321136682;9367;10834.620788272372;11007.284526505751;11073.50169242402;11135.888641113484;11420.828687569527;11483.425828708365;11526.94236528812;11545;11691.298522088702;6689.565178263398;7501.887471688038;7603.505772124794;8164.897738805185;8385.203405676451;10787;11066.114710822954;11445.370504622326;11599.130065245308;11695.532178712756 07:35:07 INFO - PROCESS | 1665 | |3;mootools.html;1405.1709491400075;1561.4847100456848;1766.0904634113433;1930.1989674285155;1948.7466629338185;8396.874046889301;8680.175383338588;8852.424592401505;8864.335174861886;8887.333449991243;7714.421418393615;7962.084360298568;8393.160683931605;8600.22597966183;8655.264302534277;2344.3435837965353;2368.6447032945025;2378.0725517048363;2380.071772008918;2383.678203442539;2065.8037486438766;2320.431494283894;2334.043042352636;2357.3988632898586;2362.4802543440414;2114.947126321839;2138.647123224674;2141.025833245877;2147.2591955775233;2253.1663284584724;2325.104834638659;2334.7781960713705;2335.988320058406;2337.403961989699;2339.3215967369442;1937.806219378065;2308.803751681109;2345.5543446745064;2352.094443639194;2361.409647588103;6690.899636505456;8433.70482033132;8631.395802293842;8666.350023748244;8743.12568743127;4341.891452713676;5274.26160337553;5285.339332583427;5295.152775555931;5308.628396012281;3345.2305969626877;3399.9800059982153;3561.661642143992;3563.1804684922613;3670.210904655512;1086.7935092332432;1090.138790355626;1096.0519150934465;1100.6422912553453;1114.297992264876;11426;11581.189316747746;11594.130440217017;11601.361925094201;11617.767644647145;4478.820847166076;4511.142882852248;4544.272916333371;4774.689645173122;4777.689450185727;8922.776930576658;9956;9956.80086398268;9961.850572241423;9981.201503879673;5272.630915835932;5276;5280.894382112337;5282.234076059027;5286.577073834084;4624.05206932578;4716.363290955677;4825.30033145192;4828.275758636232;4832.299316599074;3375.2574433624563;3780.1305699689224;3794.79128647927;3824.4263360496147;3868.207017561393;1140.1733743036398;1181.3561608923158;1189.1854079955258;1199.5082016373244;1203.0676225924979;664.5149041199854;827.5737994932615;829.4608504472142;838.6729175621513;919.4988731141544;5735;5747.195392645033;5916.319623243296;5918.289805223315;6003.429674180946;915.697819719491;918.7092135549564;959.827231098395;996.8255555277798;1005.2309982863115;3848.5381754189116;3961.2473630010204;3979.6020397959974;4022.456968309299;4048.919021619551;10212.489375531342;10528.947355263328;10716.410597417216;10718.785624287626;10719.732006699738;10664.466776661136;10675.0392464677;10684.038436540748;10685.732856678489;10731.195160363004;7352.154502232312;7818.569978651115;8171.550564718878;8174.6730130795295;8303.95848020756;5641.548676105819;5722.113072473773;6089.208402907594;6106.053561697944;6131.693415329127;9371.484568348806;9503;9935.403875767477;9949.651762188289;10023.348482348623;9262.72211833646;9953;10300.381977081399;10301;10344.482775861026;7480;7569;7662.080550333995;7662.8084297893;7678;8169.673213071411;8179.468334558234;8256.669733210605;8359.623816928375;8377.832443350977;7356.77929662111;7446.590437525988;7468.215837337001;7504.924950750641;7572.167061623327;7311.488195826241;7312.744053958086;7359.411247100112;7462.701491940262;7473.51422157558;6707.1616047994;6868.484863635147;6927.89608155868;6944.305569443218;7068.974998625068;4905.23968784839;4915.43472500667;4936.259561065869;4942.703437793743;5036.345275114211;4993.775280112331;4995.675281106716;5027.32131162303;5113.821016264562;5149.562287205629 07:35:08 INFO - PROCESS | 1665 | |4;prototype.html;269.3898320304511;308.2724769543876;314.58631899052745;321.32201055772316;325.3752794634302;5475.713207396264;5550.417206193347;5558.416366281543;5578.191162281467;5581.2186293918885;4645.051706049856;5485.725713714318;5507.862303442416;5518.641288316257;5548.224568138197;3830.9808450957707;3977.3636218205093;4039.757614543122;4156.586760501429;4166.895827604319;3737.495438115847;3883.893090469217;4080.8777586163746;4146.0513558627545;4164.709879195432;3278.5737854078934;3612.5303710517596;4129.97935010326;4151.190517849021;4164.54190039097;3897.8635747748835;4053.3312003519386;4095.344744840826;4134.751914885116;4171.270027745132;3556.324298383299;3577.373959557067;3578.499010138583;3578.8926332210076;3588.049166970755;4966;5272.551833094191;5308.70802105884;5311.468853114697;5342.225377320306;3865.975516488133;4379.4087798147475;4711.008509596397;4734.313524538957;4753.500882407332;5117.130087885069;5323.600729945231;5657.519110875581;5700.714964251771;5727.541796656257;3639.963600363989;3937;3952.32810422226;3955.960440395588;3962.6829853611644;5005.873678422362;5879.118132280149;6017.247844019497;6083.361247069039;6083.513318934563;3794.392897136445;3845.2693988142164;3945.9013524662114;3962.484876965976;3972.7020473464604;3992.3612222044335;4013.8795836124964;4034.3948407738485;4034.8991275218355;4056.513218413809;3854.6530812227033;3909.6872250219913;3978.592951264501;4737.928931066037;4740.4311482621615;5049.26785616091;5532.948739739437;5717.313922329347;5784.65292082468;5856.326522449887;1173.6244401791346;1355.5391167003265;1381.6200544850046;1387.8681525255286;1388.9097208681403;719.521518190408;739.8520295940833;741.573595182772;846.9449485783405;849.8215374771368;4647.512011238839;4909.895273563419;5021.824236151717;5089.142463000978;5264.578833693296;4731.976340118346;5842.1236814477315;5851.795187168429;5875.50058245054;5911.881762364728;4541.84183033331;4795.760211989456;5081.669691470042;5131.87170320745;5310.840674779685;2514.497100579891;2947.9705202948126;3078.7998780079224;3081.8135018018224;3093.597832281834;5335.253064570963;5686.687232202268;5987.520998320124;6070.423309785563;6083.726232319556;5728.565359722102;5944.316403613553;6031.195494095266;6073;6092.147099406086;4953.43035550909;5073.340465739504;5994.970025149846;6032.25064731223;6123.938760612336;5484.583899069492;5787.623804452697;5897;5921.911171332519;5950.285965684146;5756.963746525666;5780.190773291826;5783.818899605284;5803.332616748959;5889.646621202742;4822.734749588666;5304.9469505306;6056.878862422815;6086;6094.847628809315;3418.726501879794;3454.930901381908;3470.7570470066853;3751.9062023449633;3938.803059846939;5808.6224395414165;5844.298684157929;5891.617044892068;5896.498797602252;5907;4609.677322587387;5102.336696229467;5528.50730302824;5619.578531610064;5768.077107662753;4249.97875010623;5268.81559145428;5818.359980402237;5822.417758224144;5886.882262354815;5030.308784800114;5676.489115979582;5728.942710573007;5760.769569217352;5813.6221145625395;5052.090623687772;5342;5474.753636086306;5716.9137863805745;5799.362070172193;5325.573954083587;5501.257330260523;5582.302212223472;5595.384507704068;5596.832095037155 07:35:08 INFO - PROCESS | 1665 | |5;yui.html;741.8145463634095;742.1947187301778;753.306957599009;785.6817988714572;860.9784755381115;13350.66623334417;16435.342586296563;16471.094089825056;16483.75274370884;16487.340506379744;14927.32827022784;14932.776008359857;15052.946293759414;15079.944403891732;15143.697126057472;732.6336831584208;883.7348795361398;907.2696479334134;909.3270979475207;911.462237280008;735.4153448008846;881.3918396306528;915.0803442540238;918.7886786039215;920.3419555018161;953.0564740906487;959.3236768078488;964.8745663063792;965.541367850269;971.6939164163266;751.744406901656;920.0661328751323;950.353759443578;954.2652157838426;954.3271993244746;714.3463730686416;714.746265075901;715.3490323805312;715.8317795318096;720.9798135638066;15296.617584560363;15400.15299158557;15401.3839446422;15403.07581545111;15405.998610090308;14153.292335383292;14367.137971721626;14395.784063238954;14405.351759170862;14478.203698796562;12914.354282285849;12942.352882355939;13247.337633118403;13296;13521.797173042412;4514.751688657123;4589.5639914208095;4639.37368455261;4656.697314674535;4830.951690483085;102090.48954755178;102172;112618;114075;116076.41961790221;10540.420276884692;10973;11283.984441400313;11284.605038823765;11818.172727908965;21571.02930368137;21663.133474661154;21811.67282490764;21906.890465547887;21927.342179734635;7850.450468467153;7855.410844186709;7934.484258523177;8067.596620168968;8090.555019473985;3500.1614465612083;4371.453568303962;4448.866534003985;4473.3960915276675;4641.675082744176;3472.2361080562237;3574.7318951078773;3601.693856022215;3607.5670919489303;3608.801515916597;570.2301892445166;665.5906617430245;668.976585819494;672.7880717573948;683.1221879884424;617.9691015449209;689.1592257445908;690.4096997067435;695.6228354817291;714.7534100735238;7933.920660793434;9288.303377246733;9435.858462123073;9625.253995618032;9772.022797720314;561.3740679142727;614.2812908896602;627.3506920337429;653.9967300163469;710.6020628448085;4415.183191109655;4552.681312308173;4679.251319788817;4722.834700785456;4815.662903596784;95370;126960;127111.20443137968;153144;162027;77993;79833.60083199547;94196;120710.3964480172;121969;111774.44112779383;113967.43016285032;116261;118227;118375.40812295883;8893.688720894737;8899.911000889908;8934.329925255763;9032.23226025769;9212.401193922373;60831.78336433335;63936;64024;64549;65741;74394;92725.5363723204;98902.5054874721;100013;100352;9772.706818795448;11888.405579720806;12013.339266340436;12327.815082773945;12491.375431228584;12497.87502124967;12539.435725392197;12601.810972835232;12616.621501354974;12694.809577856524;12425.254484730583;12510;12525.185862918881;12558.932490738389;12577.622671319876;9846.556904939152;12433.626991190278;12571.87428125707;12628.242305461701;12877.291748953898;10522.21278296949;12213.633590992284;12351.876481235073;12402.937985310016;12800.423980920694;10217.33587316822;10359.482025898826;10366.118879894992;10400.687979360631;10985.61550345734;10306.690799276033;10736.355818650905;10744.570217191225;10755.892441075803;10791.6222932197 07:35:08 INFO - PROCESS | 1665 | __end_tp_report 07:35:08 INFO - PROCESS | 1665 | __start_cc_report 07:35:08 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1309 07:35:08 INFO - PROCESS | 1665 | __end_cc_report 07:35:08 INFO - PROCESS | 1665 | __startTimestamp1468334107987__endTimestamp 07:35:08 INFO - PROCESS | 1665 | 07:35:08 INFO - PROCESS | 1665 | ------- Summary: start ------- 07:35:08 INFO - PROCESS | 1665 | Number of tests: 6 07:35:08 INFO - PROCESS | 1665 | 07:35:08 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5798.99 Median:6073.76 stddev:634.02 (10.4%) stddev-sans-first:606.21 07:35:08 INFO - PROCESS | 1665 | Values: 3352.1 3399.8 3405.6 3407.1 3465.2 5702.4 5743.3 5760.8 5831.0 5857.8 5805.6 5844.8 5848.7 5854.0 5865.0 5213.8 5260.3 5289.0 5290.0 5349.9 5240.4 5288.8 5336.6 5373.6 5377.0 5274.6 5338.9 5356.4 5375.4 5383.7 5334.2 5342.4 5351.1 5357.3 5388.6 5021.1 5052.0 5173.9 5240.6 5247.6 5791.1 5857.2 5900.6 5906.2 5911.1 6256.3 6302.1 6311.2 6322.1 6326.4 6189.0 6244.0 6255.6 6261.3 6263.1 5741.5 5828.7 5865.5 5968.6 5977.1 6198.3 6331.3 6335.7 6336.6 6340.7 6211.3 6236.0 6244.5 6256.6 6275.7 6164.7 6227.2 6238.4 6259.3 6306.5 6263.1 6273.7 6281.4 6281.6 6284.5 6246.4 6260.4 6274.2 6289.7 6292.6 4944.9 4945.9 4949.1 4999.1 5042.1 4507.9 4531.4 4543.6 4544.8 4572.2 5725.4 5792.8 5797.6 5836.3 5846.9 6200.2 6218.1 6219.6 6248.2 6261.6 5870.6 5883.4 5886.2 5888.6 5949.0 5393.4 5450.9 5499.3 5546.3 5547.8 5296.0 6349.7 6372.9 6378.4 6387.7 6234.3 6259.6 6263.6 6264.8 6267.1 6166.8 6248.3 6287.1 6347.8 6384.1 6264.2 6267.8 6282.0 6289.2 6301.5 6201.4 6260.6 6260.6 6262.7 6290.4 6004.5 6115.5 6139.4 6178.7 6229.6 4994.4 5923.8 6186.5 6222.2 6262.8 5178.9 6101.8 6126.4 6141.4 6146.7 5351.9 6052.3 6073.8 6185.8 6194.7 6098.7 6111.6 6117.3 6135.9 6138.1 07:35:08 INFO - PROCESS | 1665 | 07:35:08 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:75134.78 Median:22434.98 stddev:162771.70 (725.5%) stddev-sans-first:163131.84 07:35:08 INFO - PROCESS | 1665 | Values: 493.5 514.5 518.4 518.6 546.8 22508.5 40816.4 42006.4 42084.0 42142.8 42512.4 42944.0 42967.0 43020.0 43058.1 8677.5 9687.0 9813.6 9816.2 9831.5 8636.9 11683.8 11912.0 11918.0 12179.5 11729.6 11805.2 11817.3 11818.3 11838.8 8627.5 11571.2 11821.2 11872.2 11886.6 9853.9 11409.7 11646.7 11729.1 11745.6 40894.0 41279.2 41293.8 41378.6 41396.6 3565.1 3716.5 3805.9 4073.0 4436.6 32108.0 32357.0 33482.0 33530.7 33599.5 3180.9 3424.6 3434.0 3437.6 3438.5 524271.0 536628.0 536954.0 537355.0 537359.0 69081.9 69844.3 69886.7 69913.7 70064.0 67941.7 72470.9 72859.6 72886.0 73024.0 15463.5 17141.0 17415.1 17415.7 17420.7 11854.9 12112.7 12123.4 12985.8 13313.4 15311.9 16834.9 20329.6 20555.5 20764.7 8645.5 8715.7 8733.3 8784.8 8867.7 884.2 996.5 1085.2 1104.8 1115.4 29174.6 30779.0 30856.7 31471.1 31695.5 1011.9 1048.9 1093.9 1136.4 1256.8 15963.5 16026.8 16071.7 16189.4 16499.7 710966.0 712869.0 721379.0 721394.0 723224.0 61687.4 62046.4 62107.7 62350.0 62385.7 1112.6 1323.9 1366.2 1422.2 1434.8 30563.5 31942.0 32201.2 32508.0 32604.2 51796.0 51805.5 52330.7 52427.0 52468.5 556450.0 558904.0 558969.0 559639.0 560913.0 43547.5 44395.3 45021.8 45218.8 45423.3 48932.5 49338.5 50017.2 50042.7 50563.5 40797.0 41728.4 42592.8 43338.6 44362.8 40710.4 41259.4 41393.6 41782.4 42221.4 39142.0 39623.4 39808.4 40079.8 40107.4 33335.0 35660.3 36165.9 36256.6 36615.1 26115.3 26126.0 26261.2 26498.7 26583.0 07:35:08 INFO - PROCESS | 1665 | 07:35:08 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:34846.68 Median:2265.34 stddev:98737.64 (4358.6%) stddev-sans-first:98980.56 07:35:08 INFO - PROCESS | 1665 | Values: 301.8 380.1 389.1 390.2 414.5 15308.3 16159.7 20636.7 20764.8 20806.9 20504.3 20701.5 21364.0 21608.5 21656.6 5124.5 5402.6 5591.6 5595.5 6201.9 6146.0 6156.7 6179.6 6192.9 6204.0 5440.4 5532.9 5541.1 5899.9 6159.6 5552.3 5559.7 5592.1 5596.7 5603.6 4936.9 4990.6 5365.7 5367.8 5370.6 13498.9 13829.5 13847.7 24585.0 25922.7 2100.3 2179.4 2215.5 2234.2 2296.5 10089.5 10280.3 10526.3 10530.9 10585.2 1523.7 1763.7 1812.9 1831.8 1892.5 122455.0 127207.0 131803.0 132737.0 132931.0 9267.6 10025.3 11002.7 11655.9 11680.4 14714.3 14788.3 14791.9 14812.9 14828.2 8593.7 8669.2 8691.7 8823.6 8824.6 8627.7 8646.8 8651.7 8776.6 8782.1 4491.6 4575.4 4581.8 4592.8 4671.4 1902.7 1979.9 2006.7 2011.0 2012.2 905.3 915.6 995.6 1034.6 1060.2 18421.9 21764.8 22145.2 22180.9 22211.4 907.8 919.2 934.4 961.0 1034.8 11133.7 11494.9 11578.4 11592.0 11616.1 511915.0 552244.0 610222.0 630567.0 632661.0 70347.0 110720.0 120356.4 140073.0 142005.0 959.4 962.4 968.7 989.9 996.3 17492.0 19343.3 19432.1 19492.8 19503.3 55226.7 56482.4 58053.7 58125.7 58719.5 83955.6 84566.8 85069.0 85218.3 86225.6 8173.1 8242.5 8298.3 8312.7 8371.9 9353.5 12598.9 12816.8 13029.8 13637.4 11048.9 11106.4 11209.9 11255.7 11367.9 9367.0 10834.6 11007.3 11073.5 11135.9 11420.8 11483.4 11526.9 11545.0 11691.3 6689.6 7501.9 7603.5 8164.9 8385.2 10787.0 11066.1 11445.4 11599.1 11695.5 07:35:08 INFO - PROCESS | 1665 | 07:35:08 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5643.88 Median:4994.73 stddev:3166.17 (63.4%) stddev-sans-first:3159.03 07:35:08 INFO - PROCESS | 1665 | Values: 1405.2 1561.5 1766.1 1930.2 1948.7 8396.9 8680.2 8852.4 8864.3 8887.3 7714.4 7962.1 8393.2 8600.2 8655.3 2344.3 2368.6 2378.1 2380.1 2383.7 2065.8 2320.4 2334.0 2357.4 2362.5 2114.9 2138.6 2141.0 2147.3 2253.2 2325.1 2334.8 2336.0 2337.4 2339.3 1937.8 2308.8 2345.6 2352.1 2361.4 6690.9 8433.7 8631.4 8666.4 8743.1 4341.9 5274.3 5285.3 5295.2 5308.6 3345.2 3400.0 3561.7 3563.2 3670.2 1086.8 1090.1 1096.1 1100.6 1114.3 11426.0 11581.2 11594.1 11601.4 11617.8 4478.8 4511.1 4544.3 4774.7 4777.7 8922.8 9956.0 9956.8 9961.9 9981.2 5272.6 5276.0 5280.9 5282.2 5286.6 4624.1 4716.4 4825.3 4828.3 4832.3 3375.3 3780.1 3794.8 3824.4 3868.2 1140.2 1181.4 1189.2 1199.5 1203.1 664.5 827.6 829.5 838.7 919.5 5735.0 5747.2 5916.3 5918.3 6003.4 915.7 918.7 959.8 996.8 1005.2 3848.5 3961.2 3979.6 4022.5 4048.9 10212.5 10528.9 10716.4 10718.8 10719.7 10664.5 10675.0 10684.0 10685.7 10731.2 7352.2 7818.6 8171.6 8174.7 8304.0 5641.5 5722.1 6089.2 6106.1 6131.7 9371.5 9503.0 9935.4 9949.7 10023.3 9262.7 9953.0 10300.4 10301.0 10344.5 7480.0 7569.0 7662.1 7662.8 7678.0 8169.7 8179.5 8256.7 8359.6 8377.8 7356.8 7446.6 7468.2 7504.9 7572.2 7311.5 7312.7 7359.4 7462.7 7473.5 6707.2 6868.5 6927.9 6944.3 7069.0 4905.2 4915.4 4936.3 4942.7 5036.3 4993.8 4995.7 5027.3 5113.8 5149.6 07:35:08 INFO - PROCESS | 1665 | 07:35:08 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:4601.34 Median:5124.50 stddev:1443.59 (28.2%) stddev-sans-first:1410.54 07:35:08 INFO - PROCESS | 1665 | Values: 269.4 308.3 314.6 321.3 325.4 5475.7 5550.4 5558.4 5578.2 5581.2 4645.1 5485.7 5507.9 5518.6 5548.2 3831.0 3977.4 4039.8 4156.6 4166.9 3737.5 3883.9 4080.9 4146.1 4164.7 3278.6 3612.5 4130.0 4151.2 4164.5 3897.9 4053.3 4095.3 4134.8 4171.3 3556.3 3577.4 3578.5 3578.9 3588.0 4966.0 5272.6 5308.7 5311.5 5342.2 3866.0 4379.4 4711.0 4734.3 4753.5 5117.1 5323.6 5657.5 5700.7 5727.5 3640.0 3937.0 3952.3 3956.0 3962.7 5005.9 5879.1 6017.2 6083.4 6083.5 3794.4 3845.3 3945.9 3962.5 3972.7 3992.4 4013.9 4034.4 4034.9 4056.5 3854.7 3909.7 3978.6 4737.9 4740.4 5049.3 5532.9 5717.3 5784.7 5856.3 1173.6 1355.5 1381.6 1387.9 1388.9 719.5 739.9 741.6 846.9 849.8 4647.5 4909.9 5021.8 5089.1 5264.6 4732.0 5842.1 5851.8 5875.5 5911.9 4541.8 4795.8 5081.7 5131.9 5310.8 2514.5 2948.0 3078.8 3081.8 3093.6 5335.3 5686.7 5987.5 6070.4 6083.7 5728.6 5944.3 6031.2 6073.0 6092.1 4953.4 5073.3 5995.0 6032.3 6123.9 5484.6 5787.6 5897.0 5921.9 5950.3 5757.0 5780.2 5783.8 5803.3 5889.6 4822.7 5304.9 6056.9 6086.0 6094.8 3418.7 3454.9 3470.8 3751.9 3938.8 5808.6 5844.3 5891.6 5896.5 5907.0 4609.7 5102.3 5528.5 5619.6 5768.1 4250.0 5268.8 5818.4 5822.4 5886.9 5030.3 5676.5 5728.9 5760.8 5813.6 5052.1 5342.0 5474.8 5716.9 5799.4 5325.6 5501.3 5582.3 5595.4 5596.8 07:35:08 INFO - PROCESS | 1665 | 07:35:08 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:23702.53 Median:3608.18 stddev:37145.38 (1029.5%) stddev-sans-first:37209.58 07:35:08 INFO - PROCESS | 1665 | Values: 741.8 742.2 753.3 785.7 861.0 13350.7 16435.3 16471.1 16483.8 16487.3 14927.3 14932.8 15052.9 15079.9 15143.7 732.6 883.7 907.3 909.3 911.5 735.4 881.4 915.1 918.8 920.3 953.1 959.3 964.9 965.5 971.7 751.7 920.1 950.4 954.3 954.3 714.3 714.7 715.3 715.8 721.0 15296.6 15400.2 15401.4 15403.1 15406.0 14153.3 14367.1 14395.8 14405.4 14478.2 12914.4 12942.4 13247.3 13296.0 13521.8 4514.8 4589.6 4639.4 4656.7 4831.0 102090.5 102172.0 112618.0 114075.0 116076.4 10540.4 10973.0 11284.0 11284.6 11818.2 21571.0 21663.1 21811.7 21906.9 21927.3 7850.5 7855.4 7934.5 8067.6 8090.6 3500.2 4371.5 4448.9 4473.4 4641.7 3472.2 3574.7 3601.7 3607.6 3608.8 570.2 665.6 669.0 672.8 683.1 618.0 689.2 690.4 695.6 714.8 7933.9 9288.3 9435.9 9625.3 9772.0 561.4 614.3 627.4 654.0 710.6 4415.2 4552.7 4679.3 4722.8 4815.7 95370.0 126960.0 127111.2 153144.0 162027.0 77993.0 79833.6 94196.0 120710.4 121969.0 111774.4 113967.4 116261.0 118227.0 118375.4 8893.7 8899.9 8934.3 9032.2 9212.4 60831.8 63936.0 64024.0 64549.0 65741.0 74394.0 92725.5 98902.5 100013.0 100352.0 9772.7 11888.4 12013.3 12327.8 12491.4 12497.9 12539.4 12601.8 12616.6 12694.8 12425.3 12510.0 12525.2 12558.9 12577.6 9846.6 12433.6 12571.9 12628.2 12877.3 10522.2 12213.6 12351.9 12402.9 12800.4 10217.3 10359.5 10366.1 10400.7 10985.6 10306.7 10736.4 10744.6 10755.9 10791.6 07:35:08 INFO - PROCESS | 1665 | -------- Summary: end -------- 07:35:08 INFO - PROCESS | 1665 | 07:35:08 INFO - TEST-INFO | 1665: exit 0 07:35:08 INFO - TEST-OK | dromaeo_css | took 1117167ms 07:35:08 INFO - TEST-START | kraken 07:35:08 INFO - operating with platform_type : mac_ 07:35:08 INFO - Initialising browser for kraken test... 07:35:08 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpWUTdfR/profile http://localhost:49266/getInfo.html) 07:35:10 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 07:35:10 INFO - PROCESS | 1676 | colorDepth:24 07:35:10 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 07:35:10 INFO - PROCESS | 1676 | __metrics 07:35:11 INFO - PROCESS | 1676 | 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" 07:35:11 INFO - PROCESS | 1676 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:35:11 INFO - TEST-INFO | 1676: exit 0 07:35:11 INFO - Browser initialized. 07:35:11 INFO - Running cycle 1/1 for kraken test... 07:35:11 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpWUTdfR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:35:23 INFO - PROCESS | 1677 | RSS: Main: 243564544 07:35:23 INFO - PROCESS | 1677 | 07:35:26 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 07:35:27 INFO - PROCESS | 1677 | RSS: Main: 293928960 07:35:27 INFO - PROCESS | 1677 | 07:35:29 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 07:35:30 INFO - PROCESS | 1677 | RSS: Main: 303976448 07:35:30 INFO - PROCESS | 1677 | 07:35:33 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 07:35:34 INFO - PROCESS | 1677 | RSS: Main: 390516736 07:35:34 INFO - PROCESS | 1677 | 07:35:36 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 07:35:37 INFO - PROCESS | 1677 | RSS: Main: 289992704 07:35:37 INFO - PROCESS | 1677 | 07:35:39 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:35:39 INFO - PROCESS | 1677 | RSS: Main: 294100992 07:35:39 INFO - PROCESS | 1677 | 07:35:42 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 07:35:43 INFO - PROCESS | 1677 | RSS: Main: 329154560 07:35:43 INFO - PROCESS | 1677 | 07:35:46 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 07:35:47 INFO - PROCESS | 1677 | RSS: Main: 330706944 07:35:47 INFO - PROCESS | 1677 | 07:35:49 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 07:35:50 INFO - PROCESS | 1677 | RSS: Main: 330498048 07:35:50 INFO - PROCESS | 1677 | 07:35:52 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:35:52 INFO - PROCESS | 1677 | RSS: Main: 311422976 07:35:52 INFO - PROCESS | 1677 | 07:35:54 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:35:55 INFO - PROCESS | 1677 | RSS: Main: 318738432 07:35:55 INFO - PROCESS | 1677 | 07:35:57 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:35:58 INFO - PROCESS | 1677 | RSS: Main: 317833216 07:35:58 INFO - PROCESS | 1677 | 07:36:00 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:36:01 INFO - PROCESS | 1677 | RSS: Main: 327172096 07:36:01 INFO - PROCESS | 1677 | 07:36:04 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:36:05 INFO - PROCESS | 1677 | RSS: Main: 329764864 07:36:05 INFO - PROCESS | 1677 | 07:36:06 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 07:36:06 INFO - PROCESS | 1677 | RSS: Main: 373452800 07:36:06 INFO - PROCESS | 1677 | 07:36:06 INFO - PROCESS | 1677 | __start_tp_report 07:36:07 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 07:36:07 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 07:36:07 INFO - PROCESS | 1677 | |i|pagename|runs| 07:36:07 INFO - PROCESS | 1677 | |0;ai-astar;100;113;114;113;113;112;111;113;113;113 07:36:07 INFO - PROCESS | 1677 | |1;audio-beat-detection;141;112;93;176;137;135;141;107;159;104 07:36:07 INFO - PROCESS | 1677 | |2;audio-dft;178;181;182;184;183;180;182;181;182;183 07:36:07 INFO - PROCESS | 1677 | |3;audio-fft;79;74;58;108;57;56;62;63;97;56 07:36:07 INFO - PROCESS | 1677 | |4;audio-oscillator;82;88;92;70;70;67;97;75;94;134 07:36:07 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;87;85;125;84;88;84;87;84;87;84 07:36:07 INFO - PROCESS | 1677 | |6;imaging-darkroom;135;126;95;93;93;96;141;150;103;93 07:36:07 INFO - PROCESS | 1677 | |7;imaging-desaturate;86;86;84;84;85;86;83;84;85;85 07:36:07 INFO - PROCESS | 1677 | |8;json-parse-financial;56;56;54;54;55;55;55;55;55;54 07:36:07 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;65;68;76;77;72;73;71;69;71;71 07:36:07 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;87;86;80;86;83;82;84;79;86;87 07:36:07 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;134;135;139;141;143;127;167;142;237;127 07:36:07 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;163;164;164;161;162;165;159;204;163;163 07:36:07 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;66;67;67;66;66;64;65;65;64;65 07:36:07 INFO - PROCESS | 1677 | __end_tp_report 07:36:07 INFO - PROCESS | 1677 | __start_cc_report 07:36:07 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,2036 07:36:07 INFO - PROCESS | 1677 | __end_cc_report 07:36:07 INFO - PROCESS | 1677 | __startTimestamp1468334166998__endTimestamp 07:36:07 INFO - PROCESS | 1677 | 07:36:07 INFO - PROCESS | 1677 | ------- Summary: start ------- 07:36:07 INFO - PROCESS | 1677 | Number of tests: 14 07:36:07 INFO - PROCESS | 1677 | 07:36:07 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:111.50 Median:113.00 stddev:4.12 (3.6%) stddev-sans-first:0.83 07:36:07 INFO - PROCESS | 1677 | Values: 100.0 113.0 114.0 113.0 113.0 112.0 111.0 113.0 113.0 113.0 07:36:07 INFO - PROCESS | 1677 | 07:36:07 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:130.50 Median:141.00 stddev:26.18 (18.6%) stddev-sans-first:27.49 07:36:07 INFO - PROCESS | 1677 | Values: 141.0 112.0 93.0 176.0 137.0 135.0 141.0 107.0 159.0 104.0 07:36:07 INFO - PROCESS | 1677 | 07:36:07 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:181.60 Median:182.00 stddev:1.71 (0.9%) stddev-sans-first:1.22 07:36:07 INFO - PROCESS | 1677 | Values: 178.0 181.0 182.0 184.0 183.0 180.0 182.0 181.0 182.0 183.0 07:36:07 INFO - PROCESS | 1677 | 07:36:07 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:71.00 Median:62.50 stddev:18.49 (29.6%) stddev-sans-first:19.39 07:36:07 INFO - PROCESS | 1677 | Values: 79.0 74.0 58.0 108.0 57.0 56.0 62.0 63.0 97.0 56.0 07:36:07 INFO - PROCESS | 1677 | 07:36:07 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:86.90 Median:85.00 stddev:19.81 (23.3%) stddev-sans-first:20.93 07:36:07 INFO - PROCESS | 1677 | Values: 82.0 88.0 92.0 70.0 70.0 67.0 97.0 75.0 94.0 134.0 07:36:07 INFO - PROCESS | 1677 | 07:36:07 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:89.50 Median:86.00 stddev:12.57 (14.6%) stddev-sans-first:13.30 07:36:07 INFO - PROCESS | 1677 | Values: 87.0 85.0 125.0 84.0 88.0 84.0 87.0 84.0 87.0 84.0 07:36:07 INFO - PROCESS | 1677 | 07:36:07 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:112.50 Median:93.00 stddev:22.89 (24.6%) stddev-sans-first:22.79 07:36:07 INFO - PROCESS | 1677 | Values: 135.0 126.0 95.0 93.0 93.0 96.0 141.0 150.0 103.0 93.0 07:36:07 INFO - PROCESS | 1677 | 07:36:07 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:1.03 (1.2%) stddev-sans-first:1.00 07:36:07 INFO - PROCESS | 1677 | Values: 86.0 86.0 84.0 84.0 85.0 86.0 83.0 84.0 85.0 85.0 07:36:07 INFO - PROCESS | 1677 | 07:36:07 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:0.74 (1.3%) stddev-sans-first:0.67 07:36:07 INFO - PROCESS | 1677 | Values: 56.0 56.0 54.0 54.0 55.0 55.0 55.0 55.0 55.0 54.0 07:36:07 INFO - PROCESS | 1677 | 07:36:07 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:71.50 stddev:3.56 (5.0%) stddev-sans-first:2.96 07:36:07 INFO - PROCESS | 1677 | Values: 65.0 68.0 76.0 77.0 72.0 73.0 71.0 69.0 71.0 71.0 07:36:07 INFO - PROCESS | 1677 | 07:36:07 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:86.00 stddev:2.91 (3.4%) stddev-sans-first:2.87 07:36:07 INFO - PROCESS | 1677 | Values: 87.0 86.0 80.0 86.0 83.0 82.0 84.0 79.0 86.0 87.0 07:36:07 INFO - PROCESS | 1677 | 07:36:07 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:149.20 Median:141.50 stddev:32.84 (23.2%) stddev-sans-first:34.37 07:36:07 INFO - PROCESS | 1677 | Values: 134.0 135.0 139.0 141.0 143.0 127.0 167.0 142.0 237.0 127.0 07:36:07 INFO - PROCESS | 1677 | 07:36:07 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:163.50 stddev:13.18 (8.1%) stddev-sans-first:13.91 07:36:07 INFO - PROCESS | 1677 | Values: 163.0 164.0 164.0 161.0 162.0 165.0 159.0 204.0 163.0 163.0 07:36:07 INFO - PROCESS | 1677 | 07:36:07 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:1.08 (1.6%) stddev-sans-first:1.13 07:36:07 INFO - PROCESS | 1677 | Values: 66.0 67.0 67.0 66.0 66.0 64.0 65.0 65.0 64.0 65.0 07:36:07 INFO - PROCESS | 1677 | -------- Summary: end -------- 07:36:07 INFO - PROCESS | 1677 | 07:36:07 INFO - TEST-INFO | 1677: exit 0 07:36:07 INFO - TEST-OK | kraken | took 59191ms 07:36:07 INFO - SUITE-END | took 1176s 07:36:08 INFO - Completed test suite (00:19:36) 07:36:08 INFO - javascript benchmark 07:36:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3352.128446603883, 3399.8130102844348, 3405.6083550391713, 3407.1311815487047, 3465.237647717503, 5702.401247868966, 5743.282089738783, 5760.7695692172365, 5830.970845145774, 5857.765689372425, 5805.593608447411, 5844.824655260349, 5848.707564621774, 5854.034084376073, 5865.0, 5213.817516386936, 5260.289860868772, 5289.047971365153, 5289.968456151052, 5349.893002139975, 5240.423553409122, 5288.788448462076, 5336.626436149471, 5373.570114390839, 5377.0, 5274.5780337572905, 5338.866528336784, 5356.437574054727, 5375.381831089416, 5383.730813459331, 5334.199870019509, 5342.439043900374, 5351.117065684158, 5357.276767636358, 5388.595855310868, 5021.146405111103, 5052.0, 5173.870653233699, 5240.580753539708, 5247.553957913582, 5791.131330300446, 5857.179994800731, 5900.645961242296, 5906.202662640531, 5911.113333000041, 6256.311805701369, 6302.1177035215105, 6311.242650881878, 6322.051692246154, 6326.398992095744, 6189.0, 6243.96878015607, 6255.624662520263, 6261.311255761862, 6263.123162757218, 5741.540676745851, 5828.708564571754, 5865.501432378211, 5968.612040217416, 5977.073553599155, 6198.318184999646, 6331.335209802996, 6335.746570137143, 6336.556441049174, 6340.651264180515, 6211.3478084801345, 6236.0, 6244.500439964792, 6256.562040657111, 6275.748970041239, 6164.722587483574, 6227.19046523949, 6238.407351301619, 6259.342769009279, 6306.4639505642535, 6263.091851681481, 6273.7176827042895, 6281.434670879643, 6281.59169653971, 6284.465820405226, 6246.4378205960775, 6260.40526150015, 6274.215723034621, 6289.7169627365965, 6292.622442653455, 4944.876378090505, 4945.851624451272, 4949.133901567211, 4999.100161970808, 5042.092423363756, 4507.909841803145, 4531.410916580823, 4543.613792827647, 4544.795484203219, 4572.199865023607, 5725.3988331225455, 5792.797252096157, 5797.623154494944, 5836.270466191726, 5846.94153058464, 6200.162977998003, 6218.098375735493, 6219.595726277868, 6248.218972628421, 6261.592996455216, 5870.589058765845, 5883.441073098049, 5886.23478947734, 5888.558358123158, 5949.048152295699, 5393.352797664305, 5450.91823622646, 5499.340079190522, 5546.278983732089, 5547.805826796042, 5295.999999999923, 6349.714262858275, 6372.87254254903, 6378.3621637837705, 6387.712552935222, 6234.314225435289, 6259.593126446766, 6263.592866463665, 6264.812055638338, 6267.091271765477, 6166.753329866755, 6248.250209974832, 6287.088372186099, 6347.809565713036, 6384.106225128578, 6264.154339164337, 6267.780627678009, 6281.96859015702, 6289.150964619717, 6301.464375528131, 6201.410865967726, 6260.593061450991, 6260.624362538262, 6262.718177682106, 6290.433860952537, 6004.519638428827, 6115.453310713017, 6139.369480960641, 6178.66017369049, 6229.56393052482, 4994.350734404504, 5923.763049478145, 6186.536009799193, 6222.191115155182, 6262.812115636538, 5178.91242839008, 6101.7559297627595, 6126.417990290915, 6141.447269745744, 6146.692665366624, 5351.866203344947, 6052.273727152769, 6073.757049717962, 6185.783497577563, 6194.677085453587, 6098.662722011044, 6111.622125543816, 6117.283643067005, 6135.875804921915, 6138.109974053648], "value": 5759.764965889281, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.4547325205648, 514.5446280042164, 518.3701802310193, 518.5540435225707, 546.8379693152052, 22508.54982900341, 40816.387754183714, 42006.36990445146, 42084.0, 42142.7892860536, 42512.362314565304, 42944.0, 42967.0, 43020.0, 43058.13883722324, 8677.522736249504, 9686.951565242181, 9813.558389872473, 9816.214702823758, 9831.508424578778, 8636.913630863704, 11683.766324673501, 11912.0, 11917.986971107423, 12179.512819487254, 11729.648110556696, 11805.173637845312, 11817.290962542233, 11818.290902545832, 11838.822417663741, 8627.525486098262, 11571.247868888495, 11821.17251792375, 11872.168948173632, 11886.643400697949, 9853.916069232379, 11409.657710268706, 11646.650600481998, 11729.061675065974, 11745.647630571097, 40894.0, 41279.1744165118, 41293.793531032454, 41378.58621413808, 41396.586034139575, 3565.144365352297, 3716.535433070866, 3805.8858234253016, 4072.9592704072875, 4436.600705936481, 32108.0, 32357.0, 33482.0, 33530.664693353, 33599.49600755991, 3180.8568614412407, 3424.5890493140732, 3434.0384692286198, 3437.570303712036, 3438.535797667308, 524271.0, 536628.0, 536954.0, 537355.0, 537359.0, 69081.92754217381, 69844.30155698479, 69886.65056674786, 69913.65043174752, 70064.0, 67941.66029169822, 72470.91293630599, 72859.63570182116, 72886.0, 73024.0, 15463.5360939172, 17141.0, 17415.129243537773, 17415.651686966445, 17420.65158696819, 11854.88145118555, 12112.697182570506, 12123.393830308625, 12985.805212921814, 13313.40089695966, 15311.924776945305, 16834.905731127437, 20329.593408131754, 20555.486112847, 20764.68852967207, 8645.524496152771, 8715.651373945098, 8733.34499912509, 8784.824303513893, 8867.689630863018, 884.2130503851578, 996.5415908681942, 1085.1915323084195, 1104.7514309280348, 1115.369816053927, 29174.562381564294, 30779.0, 30856.69143308583, 31471.055868323987, 31695.52456713151, 1011.8532812742259, 1048.8531605575226, 1093.8632670916136, 1136.431784107946, 1256.7674980128706, 15963.521094367188, 16026.75959860603, 16071.67856642884, 16189.352425903067, 16499.6700065998, 710966.0, 712869.0, 721379.0, 721394.0, 723224.0, 61687.38312616816, 62046.37953620406, 62107.68946155331, 62350.0, 62385.68807155935, 1112.5994641928899, 1323.8676132386684, 1366.2349084512705, 1422.182245209009, 1434.813474248341, 30563.54154687637, 31942.0, 32201.194970124998, 32508.0, 32604.184895376857, 51795.96408071893, 51805.481945180065, 52330.73834630955, 52426.95146097133, 52468.47531524636, 556450.0, 558904.0, 558969.0, 559639.0, 560913.0, 43547.487146786356, 44395.338489459435, 45021.77489112534, 45218.77390613026, 45423.31865021961, 48932.510674892794, 49338.50661493483, 50017.24974125318, 50042.749786252294, 50563.49436505588, 40797.0, 41728.37407438952, 42592.78703606462, 43338.56661433345, 44362.778186108866, 40710.389344159266, 41259.38110928278, 41393.58606413897, 41782.37326440166, 42221.36667949922, 39142.02144946399, 39623.40564891471, 39808.40287395749, 40079.79960100181, 40107.39838902477, 33335.0, 35660.28679426345, 36165.915022549365, 36256.63743362533, 36615.05142395206, 26115.347116322246, 26126.0, 26261.16171867951, 26498.668571799117, 26583.0], "value": 21577.450037667633, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.7797008184027, 380.1029570214294, 389.12058747231265, 390.1767271058068, 414.46327006526565, 15308.31112599933, 16159.676806463878, 20636.69044964327, 20764.792352076493, 20806.89596552019, 20504.282350117748, 20701.482462938435, 21364.038618262217, 21608.459788505294, 21656.566868662616, 5124.4875512448825, 5402.567794576435, 5591.608587398863, 5595.524380427669, 6201.937980620204, 6146.0, 6156.6921653917125, 6179.62922224668, 6192.938070619303, 6203.968980155093, 5440.3743569489425, 5532.917006244909, 5541.141123125902, 5899.852503687421, 6159.568830181889, 5552.250446189753, 5559.749811258503, 5592.133219351007, 5596.692181929992, 5603.635763675348, 4936.925946110811, 4990.575801056878, 5365.704886231256, 5367.812126575551, 5370.57035437168, 13498.932505337509, 13829.51596694121, 13847.653808654764, 24585.016599336006, 25922.74077259222, 2100.2754049852774, 2179.4115588791096, 2215.4572129828134, 2234.229190929127, 2296.4603318220206, 10089.495525223709, 10280.280380373377, 10526.263161578692, 10530.894691053069, 10585.153187744962, 1523.7017515125442, 1763.6719331870263, 1812.9093545322812, 1831.8442932350765, 1892.5079479335334, 122455.0, 127207.0, 131803.0, 132737.0, 132931.0, 9267.582958766872, 10025.298229124037, 11002.679678438639, 11655.941720291514, 11680.379082484456, 14714.264286785618, 14788.260586970824, 14791.852081479263, 14812.851871481147, 14828.184449855145, 8593.742187734379, 8669.21977022071, 8691.739247822576, 8823.602937867812, 8824.602892869836, 8627.654893804178, 8646.832677588445, 8651.653933842701, 8776.60505277264, 8782.121787821294, 4491.550844915548, 4575.428071491064, 4581.777837748689, 4592.839250626212, 4671.369365135731, 1902.7431296775035, 1979.8614097013358, 2006.6989951507392, 2010.9899450502653, 2012.154894944127, 905.2848249882651, 915.6062892956093, 995.6415690351467, 1034.622362837559, 1060.151878497199, 18421.90789046046, 21764.782352176593, 22145.224917127824, 22180.88909555442, 22211.44471388196, 907.7518412183248, 919.2140719684706, 934.4393363981557, 961.0149596663476, 1034.8085604163255, 11133.665990020312, 11494.942525287488, 11578.36319002463, 11591.95672389489, 11616.128790340757, 511915.0, 552244.0, 610222.0, 630567.0, 632661.0, 70347.0, 110720.0, 120356.39821800835, 140073.0, 142005.0, 959.4387283439266, 962.4081190068198, 968.719071469266, 989.8762654668167, 996.3424140067666, 17492.0, 19343.322983695503, 19432.125554349805, 19492.8050719491, 19503.317383891495, 55226.72386638041, 56482.43517564936, 58053.709731451076, 58125.709371452875, 58719.53201170005, 83955.58022209849, 84566.77166141791, 85069.0, 85218.29563408821, 86225.56887215524, 8173.100958894635, 8242.546659933761, 8298.253157215879, 8312.6674933002, 8371.916280837113, 9353.485558294358, 12598.87401125977, 12816.807747883975, 13029.804552931524, 13637.386317615532, 11048.944755276172, 11106.444677765918, 11209.943950280196, 11255.66233013011, 11367.886321136682, 9367.0, 10834.620788272372, 11007.284526505751, 11073.50169242402, 11135.888641113484, 11420.828687569527, 11483.425828708365, 11526.94236528812, 11545.0, 11691.298522088702, 6689.565178263398, 7501.887471688038, 7603.505772124794, 8164.897738805185, 8385.203405676451, 10787.0, 11066.114710822954, 11445.370504622326, 11599.130065245308, 11695.532178712756], "value": 9496.916780615269, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1405.1709491400075, 1561.4847100456848, 1766.0904634113433, 1930.1989674285155, 1948.7466629338185, 8396.874046889301, 8680.175383338588, 8852.424592401505, 8864.335174861886, 8887.333449991243, 7714.421418393615, 7962.084360298568, 8393.160683931605, 8600.22597966183, 8655.264302534277, 2344.3435837965353, 2368.6447032945025, 2378.0725517048363, 2380.071772008918, 2383.678203442539, 2065.8037486438766, 2320.431494283894, 2334.043042352636, 2357.3988632898586, 2362.4802543440414, 2114.947126321839, 2138.647123224674, 2141.025833245877, 2147.2591955775233, 2253.1663284584724, 2325.104834638659, 2334.7781960713705, 2335.988320058406, 2337.403961989699, 2339.3215967369442, 1937.806219378065, 2308.803751681109, 2345.5543446745064, 2352.094443639194, 2361.409647588103, 6690.899636505456, 8433.70482033132, 8631.395802293842, 8666.350023748244, 8743.12568743127, 4341.891452713676, 5274.26160337553, 5285.339332583427, 5295.152775555931, 5308.628396012281, 3345.2305969626877, 3399.9800059982153, 3561.661642143992, 3563.1804684922613, 3670.210904655512, 1086.7935092332432, 1090.138790355626, 1096.0519150934465, 1100.6422912553453, 1114.297992264876, 11426.0, 11581.189316747746, 11594.130440217017, 11601.361925094201, 11617.767644647145, 4478.820847166076, 4511.142882852248, 4544.272916333371, 4774.689645173122, 4777.689450185727, 8922.776930576658, 9956.0, 9956.80086398268, 9961.850572241423, 9981.201503879673, 5272.630915835932, 5276.0, 5280.894382112337, 5282.234076059027, 5286.577073834084, 4624.05206932578, 4716.363290955677, 4825.30033145192, 4828.275758636232, 4832.299316599074, 3375.2574433624563, 3780.1305699689224, 3794.79128647927, 3824.4263360496147, 3868.207017561393, 1140.1733743036398, 1181.3561608923158, 1189.1854079955258, 1199.5082016373244, 1203.0676225924979, 664.5149041199854, 827.5737994932615, 829.4608504472142, 838.6729175621513, 919.4988731141544, 5735.0, 5747.195392645033, 5916.319623243296, 5918.289805223315, 6003.429674180946, 915.697819719491, 918.7092135549564, 959.827231098395, 996.8255555277798, 1005.2309982863115, 3848.5381754189116, 3961.2473630010204, 3979.6020397959974, 4022.456968309299, 4048.919021619551, 10212.489375531342, 10528.947355263328, 10716.410597417216, 10718.785624287626, 10719.732006699738, 10664.466776661136, 10675.0392464677, 10684.038436540748, 10685.732856678489, 10731.195160363004, 7352.154502232312, 7818.569978651115, 8171.550564718878, 8174.6730130795295, 8303.95848020756, 5641.548676105819, 5722.113072473773, 6089.208402907594, 6106.053561697944, 6131.693415329127, 9371.484568348806, 9503.0, 9935.403875767477, 9949.651762188289, 10023.348482348623, 9262.72211833646, 9953.0, 10300.381977081399, 10301.0, 10344.482775861026, 7480.0, 7569.0, 7662.080550333995, 7662.8084297893, 7678.0, 8169.673213071411, 8179.468334558234, 8256.669733210605, 8359.623816928375, 8377.832443350977, 7356.77929662111, 7446.590437525988, 7468.215837337001, 7504.924950750641, 7572.167061623327, 7311.488195826241, 7312.744053958086, 7359.411247100112, 7462.701491940262, 7473.51422157558, 6707.1616047994, 6868.484863635147, 6927.89608155868, 6944.305569443218, 7068.974998625068, 4905.23968784839, 4915.43472500667, 4936.259561065869, 4942.703437793743, 5036.345275114211, 4993.775280112331, 4995.675281106716, 5027.32131162303, 5113.821016264562, 5149.562287205629], "value": 4528.696944714688, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [269.3898320304511, 308.2724769543876, 314.58631899052745, 321.32201055772316, 325.3752794634302, 5475.713207396264, 5550.417206193347, 5558.416366281543, 5578.191162281467, 5581.2186293918885, 4645.051706049856, 5485.725713714318, 5507.862303442416, 5518.641288316257, 5548.224568138197, 3830.9808450957707, 3977.3636218205093, 4039.757614543122, 4156.586760501429, 4166.895827604319, 3737.495438115847, 3883.893090469217, 4080.8777586163746, 4146.0513558627545, 4164.709879195432, 3278.5737854078934, 3612.5303710517596, 4129.97935010326, 4151.190517849021, 4164.54190039097, 3897.8635747748835, 4053.3312003519386, 4095.344744840826, 4134.751914885116, 4171.270027745132, 3556.324298383299, 3577.373959557067, 3578.499010138583, 3578.8926332210076, 3588.049166970755, 4966.0, 5272.551833094191, 5308.70802105884, 5311.468853114697, 5342.225377320306, 3865.975516488133, 4379.4087798147475, 4711.008509596397, 4734.313524538957, 4753.500882407332, 5117.130087885069, 5323.600729945231, 5657.519110875581, 5700.714964251771, 5727.541796656257, 3639.963600363989, 3937.0, 3952.32810422226, 3955.960440395588, 3962.6829853611644, 5005.873678422362, 5879.118132280149, 6017.247844019497, 6083.361247069039, 6083.513318934563, 3794.392897136445, 3845.2693988142164, 3945.9013524662114, 3962.484876965976, 3972.7020473464604, 3992.3612222044335, 4013.8795836124964, 4034.3948407738485, 4034.8991275218355, 4056.513218413809, 3854.6530812227033, 3909.6872250219913, 3978.592951264501, 4737.928931066037, 4740.4311482621615, 5049.26785616091, 5532.948739739437, 5717.313922329347, 5784.65292082468, 5856.326522449887, 1173.6244401791346, 1355.5391167003265, 1381.6200544850046, 1387.8681525255286, 1388.9097208681403, 719.521518190408, 739.8520295940833, 741.573595182772, 846.9449485783405, 849.8215374771368, 4647.512011238839, 4909.895273563419, 5021.824236151717, 5089.142463000978, 5264.578833693296, 4731.976340118346, 5842.1236814477315, 5851.795187168429, 5875.50058245054, 5911.881762364728, 4541.84183033331, 4795.760211989456, 5081.669691470042, 5131.87170320745, 5310.840674779685, 2514.497100579891, 2947.9705202948126, 3078.7998780079224, 3081.8135018018224, 3093.597832281834, 5335.253064570963, 5686.687232202268, 5987.520998320124, 6070.423309785563, 6083.726232319556, 5728.565359722102, 5944.316403613553, 6031.195494095266, 6073.0, 6092.147099406086, 4953.43035550909, 5073.340465739504, 5994.970025149846, 6032.25064731223, 6123.938760612336, 5484.583899069492, 5787.623804452697, 5897.0, 5921.911171332519, 5950.285965684146, 5756.963746525666, 5780.190773291826, 5783.818899605284, 5803.332616748959, 5889.646621202742, 4822.734749588666, 5304.9469505306, 6056.878862422815, 6086.0, 6094.847628809315, 3418.726501879794, 3454.930901381908, 3470.7570470066853, 3751.9062023449633, 3938.803059846939, 5808.6224395414165, 5844.298684157929, 5891.617044892068, 5896.498797602252, 5907.0, 4609.677322587387, 5102.336696229467, 5528.50730302824, 5619.578531610064, 5768.077107662753, 4249.97875010623, 5268.81559145428, 5818.359980402237, 5822.417758224144, 5886.882262354815, 5030.308784800114, 5676.489115979582, 5728.942710573007, 5760.769569217352, 5813.6221145625395, 5052.090623687772, 5342.0, 5474.753636086306, 5716.9137863805745, 5799.362070172193, 5325.573954083587, 5501.257330260523, 5582.302212223472, 5595.384507704068, 5596.832095037155], "value": 4131.4790562195, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.8145463634095, 742.1947187301778, 753.306957599009, 785.6817988714572, 860.9784755381115, 13350.66623334417, 16435.342586296563, 16471.094089825056, 16483.75274370884, 16487.340506379744, 14927.32827022784, 14932.776008359857, 15052.946293759414, 15079.944403891732, 15143.697126057472, 732.6336831584208, 883.7348795361398, 907.2696479334134, 909.3270979475207, 911.462237280008, 735.4153448008846, 881.3918396306528, 915.0803442540238, 918.7886786039215, 920.3419555018161, 953.0564740906487, 959.3236768078488, 964.8745663063792, 965.541367850269, 971.6939164163266, 751.744406901656, 920.0661328751323, 950.353759443578, 954.2652157838426, 954.3271993244746, 714.3463730686416, 714.746265075901, 715.3490323805312, 715.8317795318096, 720.9798135638066, 15296.617584560363, 15400.15299158557, 15401.3839446422, 15403.07581545111, 15405.998610090308, 14153.292335383292, 14367.137971721626, 14395.784063238954, 14405.351759170862, 14478.203698796562, 12914.354282285849, 12942.352882355939, 13247.337633118403, 13296.0, 13521.797173042412, 4514.751688657123, 4589.5639914208095, 4639.37368455261, 4656.697314674535, 4830.951690483085, 102090.48954755178, 102172.0, 112618.0, 114075.0, 116076.41961790221, 10540.420276884692, 10973.0, 11283.984441400313, 11284.605038823765, 11818.172727908965, 21571.02930368137, 21663.133474661154, 21811.67282490764, 21906.890465547887, 21927.342179734635, 7850.450468467153, 7855.410844186709, 7934.484258523177, 8067.596620168968, 8090.555019473985, 3500.1614465612083, 4371.453568303962, 4448.866534003985, 4473.3960915276675, 4641.675082744176, 3472.2361080562237, 3574.7318951078773, 3601.693856022215, 3607.5670919489303, 3608.801515916597, 570.2301892445166, 665.5906617430245, 668.976585819494, 672.7880717573948, 683.1221879884424, 617.9691015449209, 689.1592257445908, 690.4096997067435, 695.6228354817291, 714.7534100735238, 7933.920660793434, 9288.303377246733, 9435.858462123073, 9625.253995618032, 9772.022797720314, 561.3740679142727, 614.2812908896602, 627.3506920337429, 653.9967300163469, 710.6020628448085, 4415.183191109655, 4552.681312308173, 4679.251319788817, 4722.834700785456, 4815.662903596784, 95370.0, 126960.0, 127111.20443137968, 153144.0, 162027.0, 77993.0, 79833.60083199547, 94196.0, 120710.3964480172, 121969.0, 111774.44112779383, 113967.43016285032, 116261.0, 118227.0, 118375.40812295883, 8893.688720894737, 8899.911000889908, 8934.329925255763, 9032.23226025769, 9212.401193922373, 60831.78336433335, 63936.0, 64024.0, 64549.0, 65741.0, 74394.0, 92725.5363723204, 98902.5054874721, 100013.0, 100352.0, 9772.706818795448, 11888.405579720806, 12013.339266340436, 12327.815082773945, 12491.375431228584, 12497.87502124967, 12539.435725392197, 12601.810972835232, 12616.621501354974, 12694.809577856524, 12425.254484730583, 12510.0, 12525.185862918881, 12558.932490738389, 12577.622671319876, 9846.556904939152, 12433.626991190278, 12571.87428125707, 12628.242305461701, 12877.291748953898, 10522.21278296949, 12213.633590992284, 12351.876481235073, 12402.937985310016, 12800.423980920694, 10217.33587316822, 10359.482025898826, 10366.118879894992, 10400.687979360631, 10985.61550345734, 10306.690799276033, 10736.355818650905, 10744.570217191225, 10755.892441075803, 10791.6222932197], "value": 7771.600958213061, "unit": "score"}], "name": "dromaeo_css", "value": 7454.827025292652, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 113.0, 114.0, 113.0, 113.0, 112.0, 111.0, 113.0, 113.0, 113.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 112.0, 93.0, 176.0, 137.0, 135.0, 141.0, 107.0, 159.0, 104.0], "value": 130.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 181.0, 182.0, 184.0, 183.0, 180.0, 182.0, 181.0, 182.0, 183.0], "value": 181.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 74.0, 58.0, 108.0, 57.0, 56.0, 62.0, 63.0, 97.0, 56.0], "value": 71.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 88.0, 92.0, 70.0, 70.0, 67.0, 97.0, 75.0, 94.0, 134.0], "value": 86.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 125.0, 84.0, 88.0, 84.0, 87.0, 84.0, 87.0, 84.0], "value": 89.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 126.0, 95.0, 93.0, 93.0, 96.0, 141.0, 150.0, 103.0, 93.0], "value": 112.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 84.0, 84.0, 85.0, 86.0, 83.0, 84.0, 85.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 54.0, 54.0, 55.0, 55.0, 55.0, 55.0, 55.0, 54.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 76.0, 77.0, 72.0, 73.0, 71.0, 69.0, 71.0, 71.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 80.0, 86.0, 83.0, 82.0, 84.0, 79.0, 86.0, 87.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 139.0, 141.0, 143.0, 127.0, 167.0, 142.0, 237.0, 127.0], "value": 149.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 161.0, 162.0, 165.0, 159.0, 204.0, 163.0, 163.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 66.0, 64.0, 65.0, 65.0, 64.0, 65.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1460.0, "alertThreshold": 2.0}]} 07:36:08 INFO - Return code: 0 07:36:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:36:08 INFO - # TBPL SUCCESS # 07:36:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:36:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:36:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:36:08 INFO - 2016-07-12 07:36:08.304 screenresolution[1681:9741] starting screenresolution argv=screenresolution get 07:36:08 INFO - 2016-07-12 07:36:08.307 screenresolution[1681:9741] Display 0: 1600x1200x32@60 07:36:08 INFO - 2016-07-12 07:36:08.312 screenresolution[1682:9744] starting screenresolution argv=screenresolution list 07:36:08 INFO - Available Modes on Display 0 07:36:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:36:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:36:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:36:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:36:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:36:08 INFO - Intel Iris: 07:36:08 INFO - Chipset Model: Intel Iris 07:36:08 INFO - Type: GPU 07:36:08 INFO - Bus: Built-In 07:36:08 INFO - VRAM (Dynamic, Max): 1536 MB 07:36:08 INFO - Vendor: Intel (0x8086) 07:36:08 INFO - Device ID: 0x0a2e 07:36:08 INFO - Revision ID: 0x0009 07:36:08 INFO - Displays: 07:36:08 INFO - Display: 07:36:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:36:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:36:08 INFO - Display Serial Number: 1600x1200 60 07:36:08 INFO - Main Display: Yes 07:36:08 INFO - Mirror: Off 07:36:08 INFO - Online: Yes 07:36:08 INFO - Rotation: Supported 07:36:08 INFO - Return code: 0 07:36:08 INFO - Running post-action listener: _resource_record_post_action 07:36:08 INFO - ##### 07:36:08 INFO - ##### Finished run-tests step (success) 07:36:08 INFO - ##### 07:36:08 INFO - Running post-run listener: _resource_record_post_run 07:36:08 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 36996608; Write bytes: 704398336; Read time: 239; Write time: 1883 07:36:08 INFO - TinderboxPrint: CPU usage
53.4% 07:36:08 INFO - TinderboxPrint: I/O read bytes / time
36,996,608 / 239 07:36:08 INFO - TinderboxPrint: I/O write bytes / time
704,398,336 / 1,883 07:36:08 INFO - TinderboxPrint: CPU idle
2,258.2 (46.6%) 07:36:08 INFO - TinderboxPrint: CPU system
966.8 (19.9%) 07:36:08 INFO - TinderboxPrint: CPU user
1,624.6 (33.5%) 07:36:08 INFO - TinderboxPrint: Swap in / out
443,068,416 / 0 07:36:08 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 387652096; Write bytes: 382658560; Read time: 29346; Write time: 754 07:36:08 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 36038144; Write bytes: 294513664; Read time: 226; Write time: 1069 07:36:09 INFO - Running post-run listener: _upload_blobber_files 07:36:09 INFO - Blob upload gear active. 07:36:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:36:09 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 07:36:09 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:36:09 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:36:09 INFO - (blobuploader) - INFO - Open directory for files ... 07:36:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:36:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:36:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:10 INFO - (blobuploader) - INFO - Done attempting. 07:36:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:36:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:36:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:11 INFO - (blobuploader) - INFO - Done attempting. 07:36:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:36:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:36:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:13 INFO - (blobuploader) - INFO - Done attempting. 07:36:13 INFO - (blobuploader) - INFO - Iteration through files over. 07:36:13 INFO - Return code: 0 07:36:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:36:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:36:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f1d5b30a6e6ff0c8b51b002df7355109e08968ee95e85c120272a721378ee142500ff8dffcc339388ea14c0468f5df045be96ddd055610581f2ac24f1bddfe66", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c236eb64e61338ad26cce2af2b8eb86404e783abe881c3816f1e3dddfdeb21638138bc81face7ed728ffc47b9a524f746f1c5edb9e6758e93b587457922f6232", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/401cd68b16954160f71b75cb0be34683c278a4418a1da6ce324a0fde6738967d1c40b55a993ff82016227d0bf97e448eccd664306ac048945d731c3e6149fc09"} 07:36:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:36:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:36:13 INFO - Contents: 07:36:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f1d5b30a6e6ff0c8b51b002df7355109e08968ee95e85c120272a721378ee142500ff8dffcc339388ea14c0468f5df045be96ddd055610581f2ac24f1bddfe66", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c236eb64e61338ad26cce2af2b8eb86404e783abe881c3816f1e3dddfdeb21638138bc81face7ed728ffc47b9a524f746f1c5edb9e6758e93b587457922f6232", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/401cd68b16954160f71b75cb0be34683c278a4418a1da6ce324a0fde6738967d1c40b55a993ff82016227d0bf97e448eccd664306ac048945d731c3e6149fc09"} 07:36:13 INFO - Running post-run listener: copy_logs_to_upload_dir 07:36:13 INFO - Copying logs to upload dir... 07:36:13 INFO - mkdir: /builds/slave/test/build/upload/logs 07:36:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.566331 ========= master_lag: 0.29 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-12 07:36:14.236807) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 07:36:14.240116) ========= 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.tclZngQa3i/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.14MkMVpXvY/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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/Autoland/sha512/f1d5b30a6e6ff0c8b51b002df7355109e08968ee95e85c120272a721378ee142500ff8dffcc339388ea14c0468f5df045be96ddd055610581f2ac24f1bddfe66", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c236eb64e61338ad26cce2af2b8eb86404e783abe881c3816f1e3dddfdeb21638138bc81face7ed728ffc47b9a524f746f1c5edb9e6758e93b587457922f6232", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/401cd68b16954160f71b75cb0be34683c278a4418a1da6ce324a0fde6738967d1c40b55a993ff82016227d0bf97e448eccd664306ac048945d731c3e6149fc09"} build_url:https://queue.taskcluster.net/v1/task/ScwdEvGoTCOa5tl-2oGZuw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010123 build_url: 'https://queue.taskcluster.net/v1/task/ScwdEvGoTCOa5tl-2oGZuw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f1d5b30a6e6ff0c8b51b002df7355109e08968ee95e85c120272a721378ee142500ff8dffcc339388ea14c0468f5df045be96ddd055610581f2ac24f1bddfe66", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c236eb64e61338ad26cce2af2b8eb86404e783abe881c3816f1e3dddfdeb21638138bc81face7ed728ffc47b9a524f746f1c5edb9e6758e93b587457922f6232", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/401cd68b16954160f71b75cb0be34683c278a4418a1da6ce324a0fde6738967d1c40b55a993ff82016227d0bf97e448eccd664306ac048945d731c3e6149fc09"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 07:36:14.277629) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-07-12 07:36:14.280998) ========= 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.tclZngQa3i/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.14MkMVpXvY/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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.004970 ========= master_lag: 3.82 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-07-12 07:36:18.107732) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 07:36:18.108101) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 07:36:18.113892) ========= ========= Total master_lag: 4.21 =========